----------------------------------------------------------- This is an automatically generated e-mail. To reply, visit: https://reviews.apache.org/r/65202/#review196837 -----------------------------------------------------------
FAIL: Some of the unit tests failed. Please check the relevant logs. Reviews applied: `['65201', '65343', '65298', '65202']` Failed command: `Start-MesosCITesting` All the build artifacts available at: http://dcos-win.westus.cloudapp.azure.com/mesos-build/review/65202 Relevant logs: - [libprocess-tests-stdout.log](http://dcos-win.westus.cloudapp.azure.com/mesos-build/review/65202/logs/libprocess-tests-stdout.log): ``` [ RUN ] SSLVerifyIPAdd/SSLTest.RequireCertificate/0 D:\DCOS\mesos\mesos\3rdparty\libprocess\src\tests\ssl_tests.cpp(446): error: (await_subprocess(client.get(), 0)).failure(): [++++++++++] Subprocess output. [==========] Running 1 test from 1 test case. [----------] Global test environment set-up. [----------] 1 test from SSLClientTest [ RUN ] SSLClientTest.client [ OK ] SSLClientTest.client (19 ms) [----------] 1 test from SSLClientTest (19 ms total) [----------] Global test environment tear-down [==========] 1 test from 1 test case ran. (19 ms total) [ PASSED ] 1 test. [++++++++++] [ FAILED ] SSLVerifyIPAdd/SSLTest.RequireCertificate/0, where GetParam() = "false" (836 ms) [ RUN ] SSLVerifyIPAdd/SSLTest.RequireCertificate/1 [ OK ] SSLVerifyIPAdd/SSLTest.RequireCertificate/1 (984 ms) [----------] 4 tests from SSLVerifyIPAdd/SSLTest (2507 ms total) [----------] Global test environment tear-down [==========] 225 tests from 35 test cases ran. (35846 ms total) [ PASSED ] 224 tests. [ FAILED ] 1 test, listed below: [ FAILED ] SSLVerifyIPAdd/SSLTest.RequireCertificate/0, where GetParam() = "false" 1 FAILED TEST YOU HAVE 19 DISABLED TESTS ``` - [libprocess-tests-stderr.log](http://dcos-win.westus.cloudapp.azure.com/mesos-build/review/65202/logs/libprocess-tests-stderr.log): ``` I0205 22:03:09.713762 4068 process.cpp:928] Stopped the socket accept loop I0205 22:03:09.744773 9672 process.cpp:928] Stopped the socket accept loop I0205 22:03:10.116739 4068 openssl.cpp:514] Will not verify peer certificate! NOTE: Set LIBPROCESS_SSL_VERIFY_CERT=1 to enable peer certificate verification I0205 22:03:10.116739 4068 openssl.cpp:534] LIBPROCESS_SSL_REQUIRE_CERT implies peer certificate verification. LIBPROCESS_SSL_VERIFY_CERT set to true I0205 22:03:10.116739 4068 openssl.cpp:563] Using CA file: C:\Users\mesos\AppData\Local\Temp\EZjysm\cert.pem I0205 22:03:10.116739 4068 openssl.cpp:566] Using CA dir: C:\Users\mesos\AppData\Local\Temp\EZjysm I0205 22:03:10.423722 4068 openssl.cpp:514] Will not verify peer certificate! NOTE: Set LIBPROCESS_SSL_VERIFY_CERT=1 to enable peer certificate verification I0205 22:03:10.424722 4068 openssl.cpp:526] Will use IP address verification in subject alternative name certificate extension. I0205 22:03:10.424722 4068 openssl.cpp:534] LIBPROCESS_SSL_REQUIRE_CERT implies peer certificate verification. LIBPROCESS_SSL_VERIFY_CERT set to true I0205 22:03:10.424722 4068 openssl.cpp:563] Using CA file: C:\Users\mesos\AppData\Local\Temp\jkXkpQ\cert.pem I0205 22:03:10.424722 4068 openssl.cpp:566] Using CA dir: C:\Users\mesos\AppData\Local\Temp\jkXkpQ I0205 22:03:10.642709 4068 openssl.cpp:509] CA directory path unspecified! NOTE: Set CA directory path with LIBPROCESS_SSL_CA_DIR=<dirpath> I0205 22:03:10.642709 4068 openssl.cpp:514] Will not verify peer certificate! NOTE: Set LIBPROCESS_SSL_VERIFY_CERT=1 to enable peer certificate verification I0205 22:03:10.642709 4068 openssl.cpp:534] LIBPROCESS_SSL_REQUIRE_CERT implies peer certificate verification. LIBPROCESS_SSL_VERIFY_CERT set to true I0205 22:03:10.642709 4068 openssl.cpp:563] Using CA file: C:\Users\mesos\AppData\Local\Temp\I0EGQb\cert.pem I0205 22:03:11.583654 4068 openssl.cpp:509] CA directory path unspecified! NOTE: Set CA directory path with LIBPROCESS_SSL_CA_DIR=<dirpath> I0205 22:03:11.583654 4068 openssl.cpp:514] Will not verify peer certificate! NOTE: Set LIBPROCESS_SSL_VERIFY_CERT=1 to enable peer certificate verification I0205 22:03:11.583654 4068 openssl.cpp:526] Will use IP address verification in subject alternative name certificate extension. I0205 22:03:11.583654 4068 openssl.cpp:534] LIBPROCESS_SSL_REQUIRE_CERT implies peer certificate verification. LIBPROCESS_SSL_VERIFY_CERT set to true I0205 22:03:11.584656 4068 openssl.cpp:563] Using CA file: C:\Users\mesos\AppData\Local\Temp\edriCk\cert.pem I0205 22:03:12.282660 7588 process.cpp:928] Stopped the socket accept loop ``` - [mesos-tests-stdout.log](http://dcos-win.westus.cloudapp.azure.com/mesos-build/review/65202/logs/mesos-tests-stdout.log): ``` Actual: never called - unsatisfied and active [ FAILED ] ExceptionTest.DisallowSchedulerActionsOnAbort (133 ms) [ RUN ] ExceptionTest.DisallowSchedulerCallbacksOnAbort D:\DCOS\mesos\mesos\src\tests\exception_tests.cpp(163): error: Failed to wait 0ns for offers D:\DCOS\mesos\mesos\src\tests\exception_tests.cpp(154): error: Actual function call count doesn't match EXPECT_CALL(sched, resourceOffers(&driver, _))... Expected: to be called at least once Actual: never called - unsatisfied and active D:\DCOS\mesos\mesos\src\tests\exception_tests.cpp(151): error: Actual function call count doesn't match EXPECT_CALL(sched, registered(&driver, _, _))... Expected: to be called once Actual: never called - unsatisfied and active D:\DCOS\mesos\mesos\3rdparty\libprocess\include\process/gmock.hpp(467): error: Actual function call count doesn't match EXPECT_CALL(filter->mock, filter(testing::A<const MessageEvent&>()))... Expected args: message matcher (40-byte object <C0-DF 95-0F 94-01 00-00 F0-8F 37-11 94-01 00-00 CC-CC CC-CC CC-CC CC-CC 29-00 00-00 00-00 00-00 2F-00 00-00 00-00 00-00>, 1-byte object <CC>, 1-byte object <CC>) Expected: to be called once Actual: never called - unsatisfied and active [ FAILED ] ExceptionTest.DisallowSchedulerCallbacksOnAbort (132 ms) [----------] 3 tests from ExceptionTest (415 ms total) [----------] 4 tests from ExecutorHttpApiTest [ RUN ] ExecutorHttpApiTest.NoContentType D:\DCOS\mesos\mesos\src\tests\executor_http_api_tests.cpp(138): error: Failed to wait 0ns for __recover [ FAILED ] ExecutorHttpApiTest.NoContentType (128 ms) [ RUN ] ExecutorHttpApiTest.ValidJsonButInvalidProtobuf D:\DCOS\mesos\mesos\src\tests\executor_http_api_tests.cpp(178): error: Failed to wait 0ns for __recover [ FAILED ] ExecutorHttpApiTest.ValidJsonButInvalidProtobuf (133 ms) [ RUN ] ExecutorHttpApiTest.GetRequest D:\DCOS\mesos\mesos\src\tests\executor_http_api_tests.cpp(346): error: Failed to wait 0ns for __recover [ FAILED ] ExecutorHttpApiTest.GetRequest (133 ms) [ RUN ] ExecutorHttpApiTest.SubscribeBeforeContainerizerRecovery D:\DCOS\mesos\mesos\src\tests\executor_http_api_tests.cpp(815): error: Failed to wait 0ns for recover ``` - [mesos-tests-stderr.log](http://dcos-win.westus.cloudapp.azure.com/mesos-build/review/65202/logs/mesos-tests-stderr.log): ``` I0205 22:31:45.236721 7656 provisioner.cpp:495] Provisioner recovery complete I0205 22:31:45.237722 3768 slave.cpp:6824] Finished recovery I0205 22:31:45.242915 3768 slave.cpp:1146] New master detected at master@10.3.1.5:53550 I0205 22:31:45.242915 8820 task_status_update_manager.cpp:181] Pausing sending task status updates I0205 22:31:45.242915 3768 slave.cpp:1201] Detecting new master I0205 22:31:45.243696 3768 slave.cpp:931] Agent terminating I0205 22:31:45.263701 8812 master.cpp:1149] Master terminating I0205 22:31:45.290693 8812 cluster.cpp:172] Creating default 'local' authorizer I0205 22:31:45.297724 4272 master.cpp:458] Master 4b3f3a39-1ebe-471c-a1d4-2adf85a39bfc (build-srv-04.zq4gs31qjdiunm1ryi1452nvnh.dx.internal.cloudapp.net) started on 10.3.1.5:53550 I0205 22:31:45.297724 4272 master.cpp:460] Flags at startup: --acls="" --agent_ping_timeout="15secs" --agent_reregister_timeout="10mins" --allocation_interval="1secs" --allocator="HierarchicalDRF" --authenticate_agents="true" --authenticate_frameworks="true" --authenticate_http_frameworks="true" --authenticate_http_readonly="true" --authenticate_http_readwrite="true" --authenticators="crammd5" --authorizers="local" --credentials="C:\Users\mesos\AppData\Local\Temp\08pIBI\credentials" --filter_gpu_resources="true" --framework_sorter="drf" --help="false" --hostname_lookup="true" --http_authenticators="basic" --http_framework_authenticators="basic" --initialize_driver_logging="true" --log_auto_initialize="true" --logbufsecs="0" --logging_level="INFO" --max_agent_ping_timeouts="5" --max_completed_frameworks="50" --max_completed_tasks_per_framework="1000" --max_unreachable_tasks_per_framework="1000" --port="5050" --quiet="false" --recovery_agent_removal_limit="100%" --registry="in_memory" --registry_fetch_timeout="1mins" --registry_gc_interval="15mins" --registry_max_agent_age="2weeks" --registry_max_agent_count="102400" --registry_store_timeout="100secs" --registry_strict="false" --require_agent_domain="false" --root_submissions="true" --user_sorter="drf" --version="false" --webui_dir="/webui" --work_dir="C:\Users\mesos\AppData\Local\Temp\08pIBI\master" --zk_session_timeout="10secs" I0205 22:31:45.299716 4272 master.cpp:509] Master only allowing authenticated frameworks to register I0205 22:31:45.299716 4272 master.cpp:515] Master only allowing authenticated agents to register I0205 22:31:45.299716 4272 master.cpp:521] Master only allowing authenticated HTTP frameworks to register I0205 22:31:45.299716 4272 credentials.hpp:37] Loading credentials for authentication from 'C:\Users\mesos\AppData\Local\Temp\08pIBI\credentials' I0205 22:31:45.300724 4272 master.cpp:565] Using default 'crammd5' authenticator I0205 22:31:45.301724 4272 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readonly' I0205 22:31:45.301724 4272 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readwrite' I0205 22:31:45.302692 4272 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-master-scheduler' I0205 22:31:45.302692 4272 master.cpp:644] Authorization enabled I0205 22:31:45.311740 8820 master.cpp:2133] Elected as the leading master! I0205 22:31:45.311740 8820 master.cpp:1692] Recovering from registrar I0205 22:31:45.312700 8496 registrar.cpp:391] Successfully fetched the registry (0B) in 958976ns I0205 22:31:45.313719 8496 registrar.cpp:495] Applied 1 operations in 1.0185ms; attempting to update the registry I0205 22:31:45.314720 7656 registrar.cpp:552] Successfully updated the registry in 0ns I0205 22:31:45.314720 7656 registrar.cpp:424] Successfully recovered registrar I0205 22:31:45.315817 4272 master.cpp:1806] Recovered 0 agents from the registry (235B); allowing 10mins for agents to re-register W0205 22:31:45.340689 8812 process.cpp:2795] Attempted to spawn already running process files@10.3.1.5:53550 I0205 22:31:45.341691 8812 cluster.cpp:460] Creating default 'local' authorizer I0205 22:31:45.346688 7656 slave.cpp:262] Mesos agent started on (28)@10.3.1.5:53550 I0205 22:31:45.346688 7656 slave.cpp:263] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="C:\Users\mesos\AppData\Local\Temp\tb6tNc\store\appc" --authenticate_http_executors="false" --authenticate_http_readonly="true" --authenticate_http_readwrite="true" --authenticatee="crammd5" --authentication_backoff_factor="1secs" --authorizer="local" --container_disk_watch_interval="15secs" --containerizers="mesos" --credential="C:\Users\mesos\AppData\Local\Temp\tb6tNc\credential" --default_role="*" --disk_watch_interval="1mins" --docker="docker" --docker_kill_orphans="true" --docker_registry="https://registry-1.docker.io" --docker_remove_delay="6hrs" --docker_socket="//./pipe/docker_engine" --docker_stop_timeout="0ns" --docker_store_dir="C:\Users\mesos\AppData\Local\Temp\tb6tNc\store\docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_ reregistration_timeout="2secs" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="C:\Users\mesos\AppData\Local\Temp\tb6tNc\fetch" --fetcher_cache_size``` - Mesos Reviewbot Windows On Jan. 25, 2018, 7:29 p.m., James Peach wrote: > > ----------------------------------------------------------- > This is an automatically generated e-mail. To reply, visit: > https://reviews.apache.org/r/65202/ > ----------------------------------------------------------- > > (Updated Jan. 25, 2018, 7:29 p.m.) > > > Review request for mesos, Benjamin Bannier and Gaston Kleiman. > > > Bugs: MESOS-7016 > https://issues.apache.org/jira/browse/MESOS-7016 > > > Repository: mesos > > > Description > ------- > > Rather than hard-coding a 15sec test timeout, use the libprocess > `DEFAULT_TEST_TIMEOUT` variable so that this can be globally tuned. > Added a test flag `--default_await_timeout` that can be used to set > the `DEFAULT_TEST_TIMEOUT` on a test run. > > > Diffs > ----- > > src/tests/agent_container_api_tests.cpp > 618569277545205017320aaf1f3a70e540d35e30 > src/tests/containerizer/cgroups_isolator_tests.cpp > 5412a7eccaa836a7f182772f1eb33b10298c96a1 > src/tests/containerizer/xfs_quota_tests.cpp > d761ea46fd4f12c6bed74090bf5ead7587f16811 > src/tests/disk_quota_tests.cpp 31cf4c44b1494afd3501046abffd303c7a1307f8 > src/tests/fetcher_cache_tests.cpp 7db7b7dcef27b1686ccae5a7408ff2811a3b9255 > src/tests/flags.hpp df4d4588f405ea884bb89021264e70218e054fae > src/tests/flags.cpp 4542f3443830474edd97e8b695af0c61685e947c > src/tests/gc_tests.cpp 0e34c017f2c629b527915218f517b88d8392aa4b > src/tests/main.cpp f945ac9e8858998174b4c2785f6a5612bae66a41 > src/tests/master_contender_detector_tests.cpp > 015d310b72a152829641d436f7cb558f72dfd77c > src/tests/registrar_tests.cpp cbb58c1cd72dc13ed16b5465452d17526255c763 > src/tests/slave_recovery_tests.cpp 77aa60c953bd0769eaba05f001755e4cec9ba028 > src/tests/slave_tests.cpp f393a8433a984267adc4db307ef07fcbafd1e62f > > > Diff: https://reviews.apache.org/r/65202/diff/7/ > > > Testing > ------- > > make check (Fedora 27). > > > Thanks, > > James Peach > >