Till Toenshoff created MESOS-9205:
-------------------------------------
Summary:
ContentTypeAndSSLConfig/SchedulerSSLTest.RunTaskAndTeardown fails.
Key: MESOS-9205
URL: https://issues.apache.org/jira/browse/MESOS-9205
Project: Mesos
Issue Type: Bug
Components: test
Affects Versions: 1.8.0
Environment: macOS 10.14, Apple LLVM version 10.0.0
(clang-1000.10.43.1), libevent 2.0.22-stable, lbssl 1.0.2p.
Reporter: Till Toenshoff
ContentTypeAndSSLConfig/SchedulerSSLTest.RunTaskAndTeardown/0 and
ContentTypeAndSSLConfig/SchedulerSSLTest.RunTaskAndTeardown/2 fail consistently
on macOS.
See logs;
{noformat}
[==========] Running 4 tests from 1 test case.
[----------] Global test environment set-up.
[----------] 4 tests from ContentTypeAndSSLConfig/SchedulerSSLTest
[ RUN ] ContentTypeAndSSLConfig/SchedulerSSLTest.RunTaskAndTeardown/0
I0903 22:48:28.795420 229418368 openssl.cpp:509] CA directory path unspecified!
NOTE: Set CA directory path with LIBPROCESS_SSL_CA_DIR=<dirpath>
I0903 22:48:28.795441 229418368 openssl.cpp:514] Will not verify peer
certificate!
NOTE: Set LIBPROCESS_SSL_VERIFY_CERT=1 to enable peer certificate verification
I0903 22:48:28.795447 229418368 openssl.cpp:534] LIBPROCESS_SSL_REQUIRE_CERT
implies peer certificate verification.
LIBPROCESS_SSL_VERIFY_CERT set to true
I0903 22:48:28.795559 229418368 openssl.cpp:561] Using CA file:
/private/var/folders/66/mgr662nx7t90lspb7wjg8ctr0000gn/T/8hbPai/cert.pem
I0903 22:48:28.795965 28344320 process.cpp:926] Stopped the socket accept loop
I0903 22:48:28.800592 229418368 cluster.cpp:173] Creating default 'local'
authorizer
I0903 22:48:28.804749 27271168 master.cpp:413] Master
4c4592b1-ce05-42d9-a2fe-27159146ae42 (lobomacpro4.fritz.box) started on
192.168.178.20:58409
I0903 22:48:28.804769 27271168 master.cpp:416] Flags at startup: --acls=""
--agent_ping_timeout="15secs" --agent_reregister_timeout="10mins"
--allocation_interval="1secs" --allocator="hierarchical"
--authenticate_agents="true" --authenticate_frameworks="true"
--authenticate_http_frameworks="true" --authenticate_http_readonly="true"
--authenticate_http_readwrite="true" --authentication_v0_timeout="15secs"
--authenticators="crammd5" --authorizers="local"
--credentials="/private/var/folders/66/mgr662nx7t90lspb7wjg8ctr0000gn/T/8hbPai/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" --memory_profiling="false"
--min_allocatable_resources="cpus:0.01|mem:32" --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" --role_sorter="drf" --root_submissions="true"
--version="false" --webui_dir="/usr/local/share/mesos/webui"
--work_dir="/private/var/folders/66/mgr662nx7t90lspb7wjg8ctr0000gn/T/8hbPai/master"
--zk_session_timeout="10secs"
I0903 22:48:28.806269 27271168 master.cpp:465] Master only allowing
authenticated frameworks to register
I0903 22:48:28.806282 27271168 master.cpp:471] Master only allowing
authenticated agents to register
I0903 22:48:28.806288 27271168 master.cpp:477] Master only allowing
authenticated HTTP frameworks to register
I0903 22:48:28.806293 27271168 credentials.hpp:37] Loading credentials for
authentication from
'/private/var/folders/66/mgr662nx7t90lspb7wjg8ctr0000gn/T/8hbPai/credentials'
I0903 22:48:28.806504 27271168 master.cpp:521] Using default 'crammd5'
authenticator
I0903 22:48:28.806540 27271168 authenticator.cpp:520] Initializing server SASL
I0903 22:48:28.832607 27271168 http.cpp:977] Creating default 'basic' HTTP
authenticator for realm 'mesos-master-readonly'
I0903 22:48:28.832725 27271168 http.cpp:977] Creating default 'basic' HTTP
authenticator for realm 'mesos-master-readwrite'
I0903 22:48:28.832794 27271168 http.cpp:977] Creating default 'basic' HTTP
authenticator for realm 'mesos-master-scheduler'
I0903 22:48:28.832818 27271168 master.cpp:602] Authorization enabled
I0903 22:48:28.836750 22978560 master.cpp:2083] Elected as the leading master!
I0903 22:48:28.836772 22978560 master.cpp:1638] Recovering from registrar
I0903 22:48:28.838846 26198016 registrar.cpp:383] Successfully fetched the
registry (0B) in 1.900032ms
I0903 22:48:28.839041 26198016 registrar.cpp:487] Applied 1 operations in
38876ns; attempting to update the registry
I0903 22:48:28.840880 26198016 registrar.cpp:544] Successfully updated the
registry in 1.807872ms
I0903 22:48:28.840922 26198016 registrar.cpp:416] Successfully recovered
registrar
I0903 22:48:28.841146 22441984 master.cpp:1752] Recovered 0 agents from the
registry (162B); allowing 10mins for agents to reregister
W0903 22:48:28.846161 229418368 process.cpp:2810] Attempted to spawn already
running process [email protected]:58409
I0903 22:48:28.846390 229418368 cluster.cpp:479] Creating default 'local'
authorizer
I0903 22:48:28.847246 25124864 slave.cpp:267] Mesos agent started on
(1)@192.168.178.20:58409
I0903 22:48:28.847267 25124864 slave.cpp:268] Flags at startup: --acls=""
--appc_simple_discovery_uri_prefix="http://";
--appc_store_dir="/var/folders/66/mgr662nx7t90lspb7wjg8ctr0000gn/T/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_0_xFHSKo/store/appc"
--authenticate_http_executors="true" --authenticate_http_readonly="true"
--authenticate_http_readwrite="true" --authenticatee="crammd5"
--authentication_backoff_factor="1secs" --authentication_timeout_max="1mins"
--authentication_timeout_min="5secs" --authorizer="local"
--container_disk_watch_interval="15secs" --containerizers="mesos"
--credential="/var/folders/66/mgr662nx7t90lspb7wjg8ctr0000gn/T/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_0_xFHSKo/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="/var/run/docker.sock"
--docker_stop_timeout="0ns"
--docker_store_dir="/var/folders/66/mgr662nx7t90lspb7wjg8ctr0000gn/T/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_0_xFHSKo/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="/var/folders/66/mgr662nx7t90lspb7wjg8ctr0000gn/T/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_0_xFHSKo/fetch"
--fetcher_cache_size="2GB" --fetcher_stall_timeout="1mins"
--frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1"
--help="false" --hostname_lookup="true" --http_command_executor="false"
--http_credentials="/var/folders/66/mgr662nx7t90lspb7wjg8ctr0000gn/T/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_0_xFHSKo/http_credentials"
--http_heartbeat_interval="30secs" --initialize_driver_logging="true"
--isolation="posix/cpu,posix/mem"
--jwt_secret_key="/var/folders/66/mgr662nx7t90lspb7wjg8ctr0000gn/T/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_0_xFHSKo/jwt_secret_key"
--launcher="posix"
--launcher_dir="/Users/till/Development/mesos-private/build/src"
--logbufsecs="0" --logging_level="INFO"
--max_completed_executors_per_framework="150" --memory_profiling="false"
--network_cni_metrics="true" --oversubscribed_resources_interval="15secs"
--port="5051" --qos_correction_interval_min="0ns" --quiet="false"
--reconfiguration_policy="equal" --recover="reconnect"
--recovery_timeout="15mins" --registration_backoff_factor="10ms"
--resources="cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]"
--runtime_dir="/var/folders/66/mgr662nx7t90lspb7wjg8ctr0000gn/T/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_0_xFHSKo"
--sandbox_directory="/mnt/mesos/sandbox" --strict="true" --switch_user="true"
--version="false"
--work_dir="/var/folders/66/mgr662nx7t90lspb7wjg8ctr0000gn/T/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_0_3Qtnt3"
--zk_session_timeout="10secs"
I0903 22:48:28.847503 25124864 credentials.hpp:86] Loading credential for
authentication from
'/var/folders/66/mgr662nx7t90lspb7wjg8ctr0000gn/T/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_0_xFHSKo/credential'
I0903 22:48:28.847609 25124864 slave.cpp:300] Agent using credential for:
test-principal
I0903 22:48:28.847620 25124864 credentials.hpp:37] Loading credentials for
authentication from
'/var/folders/66/mgr662nx7t90lspb7wjg8ctr0000gn/T/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_0_xFHSKo/http_credentials'
I0903 22:48:28.847734 25124864 http.cpp:977] Creating default 'basic' HTTP
authenticator for realm 'mesos-agent-executor'
I0903 22:48:28.847776 25124864 http.cpp:998] Creating default 'jwt' HTTP
authenticator for realm 'mesos-agent-executor'
I0903 22:48:28.847796 229418368 scheduler.cpp:189] Version: 1.8.0
I0903 22:48:28.847847 25124864 http.cpp:977] Creating default 'basic' HTTP
authenticator for realm 'mesos-agent-readonly'
I0903 22:48:28.847869 25124864 http.cpp:998] Creating default 'jwt' HTTP
authenticator for realm 'mesos-agent-readonly'
I0903 22:48:28.847903 25124864 http.cpp:977] Creating default 'basic' HTTP
authenticator for realm 'mesos-agent-readwrite'
I0903 22:48:28.847929 25124864 http.cpp:998] Creating default 'jwt' HTTP
authenticator for realm 'mesos-agent-readwrite'
I0903 22:48:28.848178 25124864 disk_profile_adaptor.cpp:80] Creating default
disk profile adaptor module
I0903 22:48:28.850414 27271168 scheduler.cpp:355] Using default 'basic' HTTP
authenticatee
I0903 22:48:28.850666 22441984 scheduler.cpp:538] New master detected at
[email protected]:58409
I0903 22:48:28.851290 25124864 slave.cpp:615] Agent resources:
[{"name":"cpus","scalar":{"value":2.0},"type":"SCALAR"},{"name":"mem","scalar":{"value":1024.0},"type":"SCALAR"},{"name":"disk","scalar":{"value":1024.0},"type":"SCALAR"},{"name":"ports","ranges":{"range":[{"begin":31000,"end":32000}]},"type":"RANGES"}]
I0903 22:48:28.851511 25124864 slave.cpp:623] Agent attributes: [ ]
I0903 22:48:28.851522 25124864 slave.cpp:632] Agent hostname:
lobomacpro4.fritz.box
I0903 22:48:28.851634 24051712 task_status_update_manager.cpp:181] Pausing
sending task status updates
I0903 22:48:28.852563 26198016 state.cpp:66] Recovering state from
'/var/folders/66/mgr662nx7t90lspb7wjg8ctr0000gn/T/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_0_3Qtnt3/meta'
I0903 22:48:28.852846 21905408 slave.cpp:6909] Finished recovering checkpointed
state from
'/var/folders/66/mgr662nx7t90lspb7wjg8ctr0000gn/T/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_0_3Qtnt3/meta',
beginning agent recovery
I0903 22:48:28.853024 27807744 task_status_update_manager.cpp:207] Recovering
task status update manager
I0903 22:48:28.853812 22978560 composing.cpp:339] Finished recovering all
containerizers
I0903 22:48:28.853942 26734592 slave.cpp:7138] Recovering executors
I0903 22:48:28.854076 26734592 slave.cpp:7291] Finished recovery
I0903 22:48:28.855670 26734592 slave.cpp:1254] New master detected at
[email protected]:58409
I0903 22:48:28.855715 23515136 task_status_update_manager.cpp:181] Pausing
sending task status updates
I0903 22:48:28.855739 26734592 slave.cpp:1319] Detecting new master
I0903 22:48:28.861707 26198016 slave.cpp:1346] Authenticating with master
[email protected]:58409
I0903 22:48:28.861760 26198016 slave.cpp:1355] Using default CRAM-MD5
authenticatee
I0903 22:48:28.861897 22978560 authenticatee.cpp:97] Initializing client SASL
I0903 22:48:28.865258 22978560 authenticatee.cpp:121] Creating new client SASL
connection
I0903 22:48:28.865463 24588288 master.cpp:9600] Authenticating
slave(1)@192.168.178.20:58409
I0903 22:48:28.865669 23515136 authenticator.cpp:98] Creating new server SASL
connection
I0903 22:48:28.865767 26734592 authenticatee.cpp:213] Received SASL
authentication mechanisms: CRAM-MD5
I0903 22:48:28.865792 26734592 authenticatee.cpp:239] Attempting to
authenticate with mechanism 'CRAM-MD5'
I0903 22:48:28.865842 25661440 authenticator.cpp:204] Received SASL
authentication start
I0903 22:48:28.865906 25661440 authenticator.cpp:326] Authentication requires
more steps
I0903 22:48:28.865960 25124864 authenticatee.cpp:259] Received SASL
authentication step
I0903 22:48:28.866029 21905408 authenticator.cpp:232] Received SASL
authentication step
I0903 22:48:28.866075 21905408 authenticator.cpp:318] Authentication success
I0903 22:48:28.866119 27271168 authenticatee.cpp:299] Authentication success
I0903 22:48:28.866158 27807744 master.cpp:9632] Successfully authenticated
principal 'test-principal' at slave(1)@192.168.178.20:58409
I0903 22:48:28.866288 26198016 slave.cpp:1446] Successfully authenticated with
master [email protected]:58409
I0903 22:48:28.866614 25661440 master.cpp:6562] Received register agent message
from slave(1)@192.168.178.20:58409 (lobomacpro4.fritz.box)
I0903 22:48:28.866791 25661440 master.cpp:3921] Authorizing agent providing
resources 'cpus:2; mem:1024; disk:1024; ports:[31000-32000]' with principal
'test-principal'
I0903 22:48:28.867249 24051712 master.cpp:6744] Registering agent at
slave(1)@192.168.178.20:58409 (lobomacpro4.fritz.box) with id
4c4592b1-ce05-42d9-a2fe-27159146ae42-S0
I0903 22:48:28.867527 25661440 registrar.cpp:487] Applied 1 operations in
106724ns; attempting to update the registry
I0903 22:48:28.870077 24588288 registrar.cpp:544] Successfully updated the
registry in 2.503936ms
I0903 22:48:28.870400 26198016 master.cpp:6837] Registered agent
4c4592b1-ce05-42d9-a2fe-27159146ae42-S0 at slave(1)@192.168.178.20:58409
(lobomacpro4.fritz.box) with cpus:2; mem:1024; disk:1024; ports:[31000-32000]
I0903 22:48:28.870527 22978560 slave.cpp:1479] Registered with master
[email protected]:58409; given agent ID
4c4592b1-ce05-42d9-a2fe-27159146ae42-S0
I0903 22:48:28.870582 25124864 task_status_update_manager.cpp:188] Resuming
sending task status updates
I0903 22:48:28.870596 26734592 hierarchical.cpp:601] Added agent
4c4592b1-ce05-42d9-a2fe-27159146ae42-S0 (lobomacpro4.fritz.box) with cpus:2;
mem:1024; disk:1024; ports:[31000-32000] (allocated: {})
I0903 22:48:28.871805 22978560 slave.cpp:1548] Forwarding agent update
{"operations":{},"resource_version_uuid":{"value":"ZlHHy1GARkyItHOLUlG9XA=="},"slave_id":{"value":"4c4592b1-ce05-42d9-a2fe-27159146ae42-S0"},"update_oversubscribed_resources":false}
I0903 22:48:28.872153 24051712 master.cpp:7896] Ignoring update on agent
4c4592b1-ce05-42d9-a2fe-27159146ae42-S0 at slave(1)@192.168.178.20:58409
(lobomacpro4.fritz.box) as it reports no changes
../../src/tests/scheduler_tests.cpp:2405: Failure
Failed to wait 15secs for subscribed
I0903 22:48:43.868207 229418368 slave.cpp:909] Agent terminating
I0903 22:48:43.868882 21905408 master.cpp:1251] Agent
4c4592b1-ce05-42d9-a2fe-27159146ae42-S0 at slave(1)@192.168.178.20:58409
(lobomacpro4.fritz.box) disconnected
I0903 22:48:43.868911 21905408 master.cpp:3267] Disconnecting agent
4c4592b1-ce05-42d9-a2fe-27159146ae42-S0 at slave(1)@192.168.178.20:58409
(lobomacpro4.fritz.box)
I0903 22:48:43.868959 21905408 master.cpp:3286] Deactivating agent
4c4592b1-ce05-42d9-a2fe-27159146ae42-S0 at slave(1)@192.168.178.20:58409
(lobomacpro4.fritz.box)
I0903 22:48:43.869052 26734592 hierarchical.cpp:795] Agent
4c4592b1-ce05-42d9-a2fe-27159146ae42-S0 deactivated
../../src/tests/scheduler_tests.cpp:2392: Failure
Actual function call count doesn't match EXPECT_CALL(*scheduler, offers(_,
_))...
Expected: to be called once
Actual: never called - unsatisfied and active
../../src/tests/scheduler_tests.cpp:2385: Failure
Actual function call count doesn't match EXPECT_CALL(*scheduler, subscribed(_,
_))...
Expected: to be called once
Actual: never called - unsatisfied and active
I0903 22:48:43.871264 229418368 master.cpp:1093] Master terminating
I0903 22:48:43.871608 26734592 hierarchical.cpp:637] Removed agent
4c4592b1-ce05-42d9-a2fe-27159146ae42-S0
[ FAILED ] ContentTypeAndSSLConfig/SchedulerSSLTest.RunTaskAndTeardown/0,
where GetParam() = (application/x-protobuf, "https") (15246 ms)
[ RUN ] ContentTypeAndSSLConfig/SchedulerSSLTest.RunTaskAndTeardown/1
I0903 22:48:43.875795 229418368 process.cpp:926] Stopped the socket accept loop
I0903 22:48:43.881314 229418368 cluster.cpp:173] Creating default 'local'
authorizer
I0903 22:48:43.884857 27271168 master.cpp:413] Master
a3fdfde8-0e7f-4f52-a32a-0ae0f4e388c4 (lobomacpro4.fritz.box) started on
192.168.178.20:58414
I0903 22:48:43.884884 27271168 master.cpp:416] Flags at startup: --acls=""
--agent_ping_timeout="15secs" --agent_reregister_timeout="10mins"
--allocation_interval="1secs" --allocator="hierarchical"
--authenticate_agents="true" --authenticate_frameworks="true"
--authenticate_http_frameworks="true" --authenticate_http_readonly="true"
--authenticate_http_readwrite="true" --authentication_v0_timeout="15secs"
--authenticators="crammd5" --authorizers="local"
--credentials="/private/var/folders/66/mgr662nx7t90lspb7wjg8ctr0000gn/T/8iJLXt/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" --memory_profiling="false"
--min_allocatable_resources="cpus:0.01|mem:32" --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" --role_sorter="drf" --root_submissions="true"
--version="false" --webui_dir="/usr/local/share/mesos/webui"
--work_dir="/private/var/folders/66/mgr662nx7t90lspb7wjg8ctr0000gn/T/8iJLXt/master"
--zk_session_timeout="10secs"
I0903 22:48:43.885104 27271168 master.cpp:465] Master only allowing
authenticated frameworks to register
I0903 22:48:43.885118 27271168 master.cpp:471] Master only allowing
authenticated agents to register
I0903 22:48:43.885125 27271168 master.cpp:477] Master only allowing
authenticated HTTP frameworks to register
I0903 22:48:43.885138 27271168 credentials.hpp:37] Loading credentials for
authentication from
'/private/var/folders/66/mgr662nx7t90lspb7wjg8ctr0000gn/T/8iJLXt/credentials'
I0903 22:48:43.885272 27271168 master.cpp:521] Using default 'crammd5'
authenticator
I0903 22:48:43.885326 27271168 http.cpp:977] Creating default 'basic' HTTP
authenticator for realm 'mesos-master-readonly'
I0903 22:48:43.885414 27271168 http.cpp:977] Creating default 'basic' HTTP
authenticator for realm 'mesos-master-readwrite'
I0903 22:48:43.885473 27271168 http.cpp:977] Creating default 'basic' HTTP
authenticator for realm 'mesos-master-scheduler'
I0903 22:48:43.885525 27271168 master.cpp:602] Authorization enabled
I0903 22:48:43.887151 27807744 master.cpp:2083] Elected as the leading master!
I0903 22:48:43.887168 27807744 master.cpp:1638] Recovering from registrar
I0903 22:48:43.889513 26198016 registrar.cpp:383] Successfully fetched the
registry (0B) in 2.261248ms
I0903 22:48:43.889580 26198016 registrar.cpp:487] Applied 1 operations in
30109ns; attempting to update the registry
I0903 22:48:43.891985 27807744 registrar.cpp:544] Successfully updated the
registry in 2.370048ms
I0903 22:48:43.892045 27807744 registrar.cpp:416] Successfully recovered
registrar
I0903 22:48:43.892307 23515136 master.cpp:1752] Recovered 0 agents from the
registry (162B); allowing 10mins for agents to reregister
W0903 22:48:43.896706 229418368 process.cpp:2810] Attempted to spawn already
running process [email protected]:58414
I0903 22:48:43.896996 229418368 cluster.cpp:479] Creating default 'local'
authorizer
I0903 22:48:43.897907 25124864 slave.cpp:267] Mesos agent started on
(2)@192.168.178.20:58414
I0903 22:48:43.897929 25124864 slave.cpp:268] Flags at startup: --acls=""
--appc_simple_discovery_uri_prefix="http://";
--appc_store_dir="/var/folders/66/mgr662nx7t90lspb7wjg8ctr0000gn/T/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_1_8oHPFB/store/appc"
--authenticate_http_executors="true" --authenticate_http_readonly="true"
--authenticate_http_readwrite="true" --authenticatee="crammd5"
--authentication_backoff_factor="1secs" --authentication_timeout_max="1mins"
--authentication_timeout_min="5secs" --authorizer="local"
--container_disk_watch_interval="15secs" --containerizers="mesos"
--credential="/var/folders/66/mgr662nx7t90lspb7wjg8ctr0000gn/T/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_1_8oHPFB/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="/var/run/docker.sock"
--docker_stop_timeout="0ns"
--docker_store_dir="/var/folders/66/mgr662nx7t90lspb7wjg8ctr0000gn/T/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_1_8oHPFB/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="/var/folders/66/mgr662nx7t90lspb7wjg8ctr0000gn/T/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_1_8oHPFB/fetch"
--fetcher_cache_size="2GB" --fetcher_stall_timeout="1mins"
--frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1"
--help="false" --hostname_lookup="true" --http_command_executor="false"
--http_credentials="/var/folders/66/mgr662nx7t90lspb7wjg8ctr0000gn/T/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_1_8oHPFB/http_credentials"
--http_heartbeat_interval="30secs" --initialize_driver_logging="true"
--isolation="posix/cpu,posix/mem"
--jwt_secret_key="/var/folders/66/mgr662nx7t90lspb7wjg8ctr0000gn/T/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_1_8oHPFB/jwt_secret_key"
--launcher="posix"
--launcher_dir="/Users/till/Development/mesos-private/build/src"
--logbufsecs="0" --logging_level="INFO"
--max_completed_executors_per_framework="150" --memory_profiling="false"
--network_cni_metrics="true" --oversubscribed_resources_interval="15secs"
--port="5051" --qos_correction_interval_min="0ns" --quiet="false"
--reconfiguration_policy="equal" --recover="reconnect"
--recovery_timeout="15mins" --registration_backoff_factor="10ms"
--resources="cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]"
--runtime_dir="/var/folders/66/mgr662nx7t90lspb7wjg8ctr0000gn/T/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_1_8oHPFB"
--sandbox_directory="/mnt/mesos/sandbox" --strict="true" --switch_user="true"
--version="false"
--work_dir="/var/folders/66/mgr662nx7t90lspb7wjg8ctr0000gn/T/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_1_dcMACj"
--zk_session_timeout="10secs"
I0903 22:48:43.898171 25124864 credentials.hpp:86] Loading credential for
authentication from
'/var/folders/66/mgr662nx7t90lspb7wjg8ctr0000gn/T/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_1_8oHPFB/credential'
I0903 22:48:43.898353 25124864 slave.cpp:300] Agent using credential for:
test-principal
I0903 22:48:43.898360 229418368 scheduler.cpp:189] Version: 1.8.0
I0903 22:48:43.898375 25124864 credentials.hpp:37] Loading credentials for
authentication from
'/var/folders/66/mgr662nx7t90lspb7wjg8ctr0000gn/T/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_1_8oHPFB/http_credentials'
I0903 22:48:43.898633 25124864 http.cpp:977] Creating default 'basic' HTTP
authenticator for realm 'mesos-agent-executor'
I0903 22:48:43.898680 25124864 http.cpp:998] Creating default 'jwt' HTTP
authenticator for realm 'mesos-agent-executor'
I0903 22:48:43.898751 25124864 http.cpp:977] Creating default 'basic' HTTP
authenticator for realm 'mesos-agent-readonly'
I0903 22:48:43.898792 25124864 http.cpp:998] Creating default 'jwt' HTTP
authenticator for realm 'mesos-agent-readonly'
I0903 22:48:43.898864 25124864 http.cpp:977] Creating default 'basic' HTTP
authenticator for realm 'mesos-agent-readwrite'
I0903 22:48:43.898900 25124864 http.cpp:998] Creating default 'jwt' HTTP
authenticator for realm 'mesos-agent-readwrite'
I0903 22:48:43.899020 25124864 disk_profile_adaptor.cpp:80] Creating default
disk profile adaptor module
I0903 22:48:43.901124 24051712 scheduler.cpp:355] Using default 'basic' HTTP
authenticatee
I0903 22:48:43.901232 25124864 slave.cpp:615] Agent resources:
[{"name":"cpus","scalar":{"value":2.0},"type":"SCALAR"},{"name":"mem","scalar":{"value":1024.0},"type":"SCALAR"},{"name":"disk","scalar":{"value":1024.0},"type":"SCALAR"},{"name":"ports","ranges":{"range":[{"begin":31000,"end":32000}]},"type":"RANGES"}]
I0903 22:48:43.901345 25124864 slave.cpp:623] Agent attributes: [ ]
I0903 22:48:43.901355 25124864 slave.cpp:632] Agent hostname:
lobomacpro4.fritz.box
I0903 22:48:43.901356 25661440 scheduler.cpp:538] New master detected at
[email protected]:58414
I0903 22:48:43.901437 23515136 task_status_update_manager.cpp:181] Pausing
sending task status updates
I0903 22:48:43.901801 26734592 state.cpp:66] Recovering state from
'/var/folders/66/mgr662nx7t90lspb7wjg8ctr0000gn/T/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_1_dcMACj/meta'
I0903 22:48:43.901918 27271168 slave.cpp:6909] Finished recovering checkpointed
state from
'/var/folders/66/mgr662nx7t90lspb7wjg8ctr0000gn/T/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_1_dcMACj/meta',
beginning agent recovery
I0903 22:48:43.901985 22441984 task_status_update_manager.cpp:207] Recovering
task status update manager
I0903 22:48:43.902375 27271168 composing.cpp:339] Finished recovering all
containerizers
I0903 22:48:43.902456 22441984 slave.cpp:7138] Recovering executors
I0903 22:48:43.902528 22441984 slave.cpp:7291] Finished recovery
I0903 22:48:43.903163 22441984 slave.cpp:1254] New master detected at
[email protected]:58414
I0903 22:48:43.903178 26198016 task_status_update_manager.cpp:181] Pausing
sending task status updates
I0903 22:48:43.903205 22441984 slave.cpp:1319] Detecting new master
I0903 22:48:43.906497 27807744 http.cpp:1117] HTTP POST for
/master/api/v1/scheduler from 192.168.178.20:58415
I0903 22:48:43.908561 27807744 master.cpp:2502] Received subscription request
for HTTP framework 'default'
I0903 22:48:43.908615 27807744 master.cpp:2155] Authorizing framework principal
'test-principal' to receive offers for roles '{ * }'
I0903 22:48:43.908879 27807744 master.cpp:2637] Subscribing framework 'default'
with checkpointing disabled and capabilities [ MULTI_ROLE,
RESERVATION_REFINEMENT ]
I0903 22:48:43.909579 27807744 master.cpp:9830] Adding framework
a3fdfde8-0e7f-4f52-a32a-0ae0f4e388c4-0000 (default) with roles { } suppressed
I0903 22:48:43.909904 25661440 hierarchical.cpp:306] Added framework
a3fdfde8-0e7f-4f52-a32a-0ae0f4e388c4-0000
I0903 22:48:43.912398 26198016 slave.cpp:1346] Authenticating with master
[email protected]:58414
I0903 22:48:43.912426 26198016 slave.cpp:1355] Using default CRAM-MD5
authenticatee
I0903 22:48:43.912516 27807744 authenticatee.cpp:121] Creating new client SASL
connection
I0903 22:48:43.912617 27271168 master.cpp:9600] Authenticating
slave(2)@192.168.178.20:58414
I0903 22:48:43.912744 25661440 authenticator.cpp:98] Creating new server SASL
connection
I0903 22:48:43.912827 22441984 authenticatee.cpp:213] Received SASL
authentication mechanisms: CRAM-MD5
I0903 22:48:43.912845 22441984 authenticatee.cpp:239] Attempting to
authenticate with mechanism 'CRAM-MD5'
I0903 22:48:43.912886 23515136 authenticator.cpp:204] Received SASL
authentication start
I0903 22:48:43.912940 23515136 authenticator.cpp:326] Authentication requires
more steps
I0903 22:48:43.912992 24051712 authenticatee.cpp:259] Received SASL
authentication step
I0903 22:48:43.913040 22978560 authenticator.cpp:232] Received SASL
authentication step
I0903 22:48:43.913069 22978560 authenticator.cpp:318] Authentication success
I0903 22:48:43.913130 25124864 authenticatee.cpp:299] Authentication success
I0903 22:48:43.913192 24588288 master.cpp:9632] Successfully authenticated
principal 'test-principal' at slave(2)@192.168.178.20:58414
I0903 22:48:43.913267 26734592 slave.cpp:1446] Successfully authenticated with
master [email protected]:58414
I0903 22:48:43.913475 23515136 master.cpp:6562] Received register agent message
from slave(2)@192.168.178.20:58414 (lobomacpro4.fritz.box)
I0903 22:48:43.913564 23515136 master.cpp:3921] Authorizing agent providing
resources 'cpus:2; mem:1024; disk:1024; ports:[31000-32000]' with principal
'test-principal'
I0903 22:48:43.913812 26198016 master.cpp:6744] Registering agent at
slave(2)@192.168.178.20:58414 (lobomacpro4.fritz.box) with id
a3fdfde8-0e7f-4f52-a32a-0ae0f4e388c4-S0
I0903 22:48:43.914018 24588288 registrar.cpp:487] Applied 1 operations in
92583ns; attempting to update the registry
I0903 22:48:43.916023 26734592 registrar.cpp:544] Successfully updated the
registry in 1.976832ms
I0903 22:48:43.916216 23515136 master.cpp:6837] Registered agent
a3fdfde8-0e7f-4f52-a32a-0ae0f4e388c4-S0 at slave(2)@192.168.178.20:58414
(lobomacpro4.fritz.box) with cpus:2; mem:1024; disk:1024; ports:[31000-32000]
I0903 22:48:43.916271 21905408 slave.cpp:1479] Registered with master
[email protected]:58414; given agent ID
a3fdfde8-0e7f-4f52-a32a-0ae0f4e388c4-S0
I0903 22:48:43.916335 24051712 hierarchical.cpp:601] Added agent
a3fdfde8-0e7f-4f52-a32a-0ae0f4e388c4-S0 (lobomacpro4.fritz.box) with cpus:2;
mem:1024; disk:1024; ports:[31000-32000] (allocated: {})
I0903 22:48:43.916350 25124864 task_status_update_manager.cpp:188] Resuming
sending task status updates
I0903 22:48:43.916980 26198016 master.cpp:9415] Sending offers [
a3fdfde8-0e7f-4f52-a32a-0ae0f4e388c4-O0 ] to framework
a3fdfde8-0e7f-4f52-a32a-0ae0f4e388c4-0000 (default)
I0903 22:48:43.917039 21905408 slave.cpp:1548] Forwarding agent update
{"operations":{},"resource_version_uuid":{"value":"p7xQDrFvTEuFoHq6DdhlUg=="},"slave_id":{"value":"a3fdfde8-0e7f-4f52-a32a-0ae0f4e388c4-S0"},"update_oversubscribed_resources":false}
I0903 22:48:43.917573 26198016 master.cpp:7896] Ignoring update on agent
a3fdfde8-0e7f-4f52-a32a-0ae0f4e388c4-S0 at slave(2)@192.168.178.20:58414
(lobomacpro4.fritz.box) as it reports no changes
I0903 22:48:43.921583 27271168 http.cpp:1117] HTTP POST for
/master/api/v1/scheduler from 192.168.178.20:58416
I0903 22:48:43.921914 27271168 master.cpp:11409] Removing offer
a3fdfde8-0e7f-4f52-a32a-0ae0f4e388c4-O0
I0903 22:48:43.922085 27271168 master.cpp:4424] Processing ACCEPT call for
offers: [ a3fdfde8-0e7f-4f52-a32a-0ae0f4e388c4-O0 ] on agent
a3fdfde8-0e7f-4f52-a32a-0ae0f4e388c4-S0 at slave(2)@192.168.178.20:58414
(lobomacpro4.fritz.box) for framework a3fdfde8-0e7f-4f52-a32a-0ae0f4e388c4-0000
(default)
I0903 22:48:43.922132 27271168 master.cpp:3498] Authorizing framework principal
'test-principal' to launch task edde8c3c-1378-4f8b-b29c-a4e468440929
W0903 22:48:43.922906 27271168 validation.cpp:1444] Executor 'default' for task
'edde8c3c-1378-4f8b-b29c-a4e468440929' uses less CPUs (None) than the minimum
required (0.01). Please update your executor, as this will be mandatory in
future releases.
W0903 22:48:43.922931 27271168 validation.cpp:1456] Executor 'default' for task
'edde8c3c-1378-4f8b-b29c-a4e468440929' uses less memory (None) than the minimum
required (32MB). Please update your executor, as this will be mandatory in
future releases.
I0903 22:48:43.923105 27271168 master.cpp:12158] Adding task
edde8c3c-1378-4f8b-b29c-a4e468440929 with resources cpus(allocated: *):2;
mem(allocated: *):1024; disk(allocated: *):1024; ports(allocated:
*):[31000-32000] on agent a3fdfde8-0e7f-4f52-a32a-0ae0f4e388c4-S0 at
slave(2)@192.168.178.20:58414 (lobomacpro4.fritz.box)
I0903 22:48:43.923236 27271168 master.cpp:5396] Launching task
edde8c3c-1378-4f8b-b29c-a4e468440929 of framework
a3fdfde8-0e7f-4f52-a32a-0ae0f4e388c4-0000 (default) with resources
[{"allocation_info":{"role":"*"},"name":"cpus","scalar":{"value":2.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"mem","scalar":{"value":1024.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"disk","scalar":{"value":1024.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"ports","ranges":{"range":[{"begin":31000,"end":32000}]},"type":"RANGES"}]
on agent a3fdfde8-0e7f-4f52-a32a-0ae0f4e388c4-S0 at
slave(2)@192.168.178.20:58414 (lobomacpro4.fritz.box) on new executor
I0903 22:48:43.923686 21905408 slave.cpp:2014] Got assigned task
'edde8c3c-1378-4f8b-b29c-a4e468440929' for framework
a3fdfde8-0e7f-4f52-a32a-0ae0f4e388c4-0000
I0903 22:48:43.924232 21905408 slave.cpp:2388] Authorizing task
'edde8c3c-1378-4f8b-b29c-a4e468440929' for framework
a3fdfde8-0e7f-4f52-a32a-0ae0f4e388c4-0000
I0903 22:48:43.924266 21905408 slave.cpp:8448] Authorizing framework principal
'test-principal' to launch task edde8c3c-1378-4f8b-b29c-a4e468440929
I0903 22:48:43.925074 21905408 slave.cpp:2831] Launching task
'edde8c3c-1378-4f8b-b29c-a4e468440929' for framework
a3fdfde8-0e7f-4f52-a32a-0ae0f4e388c4-0000
I0903 22:48:43.927042 21905408 paths.cpp:745] Creating sandbox
'/var/folders/66/mgr662nx7t90lspb7wjg8ctr0000gn/T/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_1_dcMACj/slaves/a3fdfde8-0e7f-4f52-a32a-0ae0f4e388c4-S0/frameworks/a3fdfde8-0e7f-4f52-a32a-0ae0f4e388c4-0000/executors/default/runs/9a3dd462-8f81-4bfa-aca0-630472d5c3f1'
for user 'till'
I0903 22:48:43.928393 21905408 slave.cpp:8976] Launching executor 'default' of
framework a3fdfde8-0e7f-4f52-a32a-0ae0f4e388c4-0000 with resources [] in work
directory
'/var/folders/66/mgr662nx7t90lspb7wjg8ctr0000gn/T/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_1_dcMACj/slaves/a3fdfde8-0e7f-4f52-a32a-0ae0f4e388c4-S0/frameworks/a3fdfde8-0e7f-4f52-a32a-0ae0f4e388c4-0000/executors/default/runs/9a3dd462-8f81-4bfa-aca0-630472d5c3f1'
I0903 22:48:43.928814 21905408 slave.cpp:3028] Queued task
'edde8c3c-1378-4f8b-b29c-a4e468440929' for executor 'default' of framework
a3fdfde8-0e7f-4f52-a32a-0ae0f4e388c4-0000
I0903 22:48:43.928998 21905408 slave.cpp:3509] Launching container
9a3dd462-8f81-4bfa-aca0-630472d5c3f1 for executor 'default' of framework
a3fdfde8-0e7f-4f52-a32a-0ae0f4e388c4-0000
I0903 22:48:43.929780 22978560 executor.cpp:201] Version: 1.8.0
I0903 22:48:43.932051 25124864 http.cpp:1117] HTTP POST for
/slave(2)/api/v1/executor from 192.168.178.20:58417
I0903 22:48:43.932147 25124864 slave.cpp:4607] Received Subscribe request for
HTTP executor 'default' of framework a3fdfde8-0e7f-4f52-a32a-0ae0f4e388c4-0000
I0903 22:48:43.932786 27271168 slave.cpp:3241] Sending queued task
'edde8c3c-1378-4f8b-b29c-a4e468440929' to executor 'default' of framework
a3fdfde8-0e7f-4f52-a32a-0ae0f4e388c4-0000 (via HTTP)
I0903 22:48:43.936838 27271168 http.cpp:1117] HTTP POST for
/slave(2)/api/v1/executor from 192.168.178.20:58418
I0903 22:48:43.936924 27271168 slave.cpp:5269] Handling status update
TASK_RUNNING (Status UUID: dfeaf989-40f0-4f85-b50c-d219955158a8) for task
edde8c3c-1378-4f8b-b29c-a4e468440929 of framework
a3fdfde8-0e7f-4f52-a32a-0ae0f4e388c4-0000
I0903 22:48:43.937330 26734592 task_status_update_manager.cpp:328] Received
task status update TASK_RUNNING (Status UUID:
dfeaf989-40f0-4f85-b50c-d219955158a8) for task
edde8c3c-1378-4f8b-b29c-a4e468440929 of framework
a3fdfde8-0e7f-4f52-a32a-0ae0f4e388c4-0000
I0903 22:48:43.937655 22441984 slave.cpp:5761] Forwarding the update
TASK_RUNNING (Status UUID: dfeaf989-40f0-4f85-b50c-d219955158a8) for task
edde8c3c-1378-4f8b-b29c-a4e468440929 of framework
a3fdfde8-0e7f-4f52-a32a-0ae0f4e388c4-0000 to [email protected]:58414
I0903 22:48:43.937851 22978560 master.cpp:8332] Status update TASK_RUNNING
(Status UUID: dfeaf989-40f0-4f85-b50c-d219955158a8) for task
edde8c3c-1378-4f8b-b29c-a4e468440929 of framework
a3fdfde8-0e7f-4f52-a32a-0ae0f4e388c4-0000 from agent
a3fdfde8-0e7f-4f52-a32a-0ae0f4e388c4-S0 at slave(2)@192.168.178.20:58414
(lobomacpro4.fritz.box)
I0903 22:48:43.937901 22978560 master.cpp:8389] Forwarding status update
TASK_RUNNING (Status UUID: dfeaf989-40f0-4f85-b50c-d219955158a8) for task
edde8c3c-1378-4f8b-b29c-a4e468440929 of framework
a3fdfde8-0e7f-4f52-a32a-0ae0f4e388c4-0000
I0903 22:48:43.938143 22978560 master.cpp:10879] Updating the state of task
edde8c3c-1378-4f8b-b29c-a4e468440929 of framework
a3fdfde8-0e7f-4f52-a32a-0ae0f4e388c4-0000 (latest state: TASK_RUNNING, status
update state: TASK_RUNNING)
I0903 22:48:43.939955 26734592 http.cpp:1117] HTTP POST for
/master/api/v1/scheduler from 192.168.178.20:58416
I0903 22:48:43.940034 26734592 master.cpp:10144] Removing framework
a3fdfde8-0e7f-4f52-a32a-0ae0f4e388c4-0000 (default)
I0903 22:48:43.940052 26734592 master.cpp:3230] Deactivating framework
a3fdfde8-0e7f-4f52-a32a-0ae0f4e388c4-0000 (default)
I0903 22:48:43.940140 26734592 master.cpp:10879] Updating the state of task
edde8c3c-1378-4f8b-b29c-a4e468440929 of framework
a3fdfde8-0e7f-4f52-a32a-0ae0f4e388c4-0000 (latest state: TASK_KILLED, status
update state: TASK_KILLED)
I0903 22:48:43.940145 22441984 hierarchical.cpp:420] Deactivated framework
a3fdfde8-0e7f-4f52-a32a-0ae0f4e388c4-0000
I0903 22:48:43.940210 22978560 slave.cpp:3921] Shutting down framework
a3fdfde8-0e7f-4f52-a32a-0ae0f4e388c4-0000
I0903 22:48:43.940243 22978560 slave.cpp:6640] Shutting down executor 'default'
of framework a3fdfde8-0e7f-4f52-a32a-0ae0f4e388c4-0000 (via HTTP)
I0903 22:48:43.940443 26734592 master.cpp:10977] Removing task
edde8c3c-1378-4f8b-b29c-a4e468440929 with resources cpus(allocated: *):2;
mem(allocated: *):1024; disk(allocated: *):1024; ports(allocated:
*):[31000-32000] of framework a3fdfde8-0e7f-4f52-a32a-0ae0f4e388c4-0000 on
agent a3fdfde8-0e7f-4f52-a32a-0ae0f4e388c4-S0 at slave(2)@192.168.178.20:58414
(lobomacpro4.fritz.box)
I0903 22:48:43.940623 26734592 master.cpp:11008] Removing executor 'default'
with resources [] of framework a3fdfde8-0e7f-4f52-a32a-0ae0f4e388c4-0000 on
agent a3fdfde8-0e7f-4f52-a32a-0ae0f4e388c4-S0 at slave(2)@192.168.178.20:58414
(lobomacpro4.fritz.box)
I0903 22:48:43.940975 27807744 hierarchical.cpp:359] Removed framework
a3fdfde8-0e7f-4f52-a32a-0ae0f4e388c4-0000
E0903 22:48:43.941113 24051712 scheduler.cpp:818] End-Of-File received from
master. The master closed the event stream
I0903 22:48:43.941282 21905408 scheduler.cpp:512] Re-detecting master
I0903 22:48:43.941639 21905408 scheduler.cpp:538] New master detected at
[email protected]:58414
I0903 22:48:43.942170 229418368 slave.cpp:909] Agent terminating
W0903 22:48:43.942196 229418368 slave.cpp:3917] Ignoring shutdown framework
a3fdfde8-0e7f-4f52-a32a-0ae0f4e388c4-0000 because it is terminating
I0903 22:48:43.942703 23515136 master.cpp:1251] Agent
a3fdfde8-0e7f-4f52-a32a-0ae0f4e388c4-S0 at slave(2)@192.168.178.20:58414
(lobomacpro4.fritz.box) disconnected
I0903 22:48:43.942720 23515136 master.cpp:3267] Disconnecting agent
a3fdfde8-0e7f-4f52-a32a-0ae0f4e388c4-S0 at slave(2)@192.168.178.20:58414
(lobomacpro4.fritz.box)
I0903 22:48:43.942749 23515136 master.cpp:3286] Deactivating agent
a3fdfde8-0e7f-4f52-a32a-0ae0f4e388c4-S0 at slave(2)@192.168.178.20:58414
(lobomacpro4.fritz.box)
I0903 22:48:43.942824 21905408 hierarchical.cpp:795] Agent
a3fdfde8-0e7f-4f52-a32a-0ae0f4e388c4-S0 deactivated
I0903 22:48:43.944887 229418368 master.cpp:1093] Master terminating
I0903 22:48:43.945186 24588288 hierarchical.cpp:637] Removed agent
a3fdfde8-0e7f-4f52-a32a-0ae0f4e388c4-S0
W0903 22:48:43.945446 229418368 framework.cpp:652] Failed to close HTTP pipe
for a3fdfde8-0e7f-4f52-a32a-0ae0f4e388c4-0000 (default)
[ OK ] ContentTypeAndSSLConfig/SchedulerSSLTest.RunTaskAndTeardown/1 (71
ms)
[ RUN ] ContentTypeAndSSLConfig/SchedulerSSLTest.RunTaskAndTeardown/2
I0903 22:48:44.081962 229418368 openssl.cpp:509] CA directory path unspecified!
NOTE: Set CA directory path with LIBPROCESS_SSL_CA_DIR=<dirpath>
I0903 22:48:44.081977 229418368 openssl.cpp:514] Will not verify peer
certificate!
NOTE: Set LIBPROCESS_SSL_VERIFY_CERT=1 to enable peer certificate verification
I0903 22:48:44.081982 229418368 openssl.cpp:534] LIBPROCESS_SSL_REQUIRE_CERT
implies peer certificate verification.
LIBPROCESS_SSL_VERIFY_CERT set to true
I0903 22:48:44.082093 229418368 openssl.cpp:561] Using CA file:
/private/var/folders/66/mgr662nx7t90lspb7wjg8ctr0000gn/T/aAD2Y0/cert.pem
I0903 22:48:44.082442 28344320 process.cpp:926] Stopped the socket accept loop
I0903 22:48:44.087383 229418368 cluster.cpp:173] Creating default 'local'
authorizer
I0903 22:48:44.091522 27807744 master.cpp:413] Master
69fc6ff7-1b79-44cd-9e4f-e177b4ea4691 (lobomacpro4.fritz.box) started on
192.168.178.20:58421
I0903 22:48:44.091572 27807744 master.cpp:416] Flags at startup: --acls=""
--agent_ping_timeout="15secs" --agent_reregister_timeout="10mins"
--allocation_interval="1secs" --allocator="hierarchical"
--authenticate_agents="true" --authenticate_frameworks="true"
--authenticate_http_frameworks="true" --authenticate_http_readonly="true"
--authenticate_http_readwrite="true" --authentication_v0_timeout="15secs"
--authenticators="crammd5" --authorizers="local"
--credentials="/private/var/folders/66/mgr662nx7t90lspb7wjg8ctr0000gn/T/aAD2Y0/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" --memory_profiling="false"
--min_allocatable_resources="cpus:0.01|mem:32" --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" --role_sorter="drf" --root_submissions="true"
--version="false" --webui_dir="/usr/local/share/mesos/webui"
--work_dir="/private/var/folders/66/mgr662nx7t90lspb7wjg8ctr0000gn/T/aAD2Y0/master"
--zk_session_timeout="10secs"
I0903 22:48:44.091868 27807744 master.cpp:465] Master only allowing
authenticated frameworks to register
I0903 22:48:44.091876 27807744 master.cpp:471] Master only allowing
authenticated agents to register
I0903 22:48:44.091897 27807744 master.cpp:477] Master only allowing
authenticated HTTP frameworks to register
I0903 22:48:44.091902 27807744 credentials.hpp:37] Loading credentials for
authentication from
'/private/var/folders/66/mgr662nx7t90lspb7wjg8ctr0000gn/T/aAD2Y0/credentials'
I0903 22:48:44.092211 27807744 master.cpp:521] Using default 'crammd5'
authenticator
I0903 22:48:44.092263 27807744 http.cpp:977] Creating default 'basic' HTTP
authenticator for realm 'mesos-master-readonly'
I0903 22:48:44.092329 27807744 http.cpp:977] Creating default 'basic' HTTP
authenticator for realm 'mesos-master-readwrite'
I0903 22:48:44.092356 27807744 http.cpp:977] Creating default 'basic' HTTP
authenticator for realm 'mesos-master-scheduler'
I0903 22:48:44.092430 27807744 master.cpp:602] Authorization enabled
I0903 22:48:44.094688 25124864 master.cpp:2083] Elected as the leading master!
I0903 22:48:44.094755 25124864 master.cpp:1638] Recovering from registrar
I0903 22:48:44.097470 26734592 registrar.cpp:383] Successfully fetched the
registry (0B) in 2.60608ms
I0903 22:48:44.097532 26734592 registrar.cpp:487] Applied 1 operations in
21973ns; attempting to update the registry
I0903 22:48:44.099369 26734592 registrar.cpp:544] Successfully updated the
registry in 1.812992ms
I0903 22:48:44.099424 26734592 registrar.cpp:416] Successfully recovered
registrar
I0903 22:48:44.099555 25124864 master.cpp:1752] Recovered 0 agents from the
registry (162B); allowing 10mins for agents to reregister
W0903 22:48:44.103137 229418368 process.cpp:2810] Attempted to spawn already
running process [email protected]:58421
I0903 22:48:44.103390 229418368 cluster.cpp:479] Creating default 'local'
authorizer
I0903 22:48:44.104203 24588288 slave.cpp:267] Mesos agent started on
(3)@192.168.178.20:58421
I0903 22:48:44.104220 24588288 slave.cpp:268] Flags at startup: --acls=""
--appc_simple_discovery_uri_prefix="http://";
--appc_store_dir="/var/folders/66/mgr662nx7t90lspb7wjg8ctr0000gn/T/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_2_D4XsIL/store/appc"
--authenticate_http_executors="true" --authenticate_http_readonly="true"
--authenticate_http_readwrite="true" --authenticatee="crammd5"
--authentication_backoff_factor="1secs" --authentication_timeout_max="1mins"
--authentication_timeout_min="5secs" --authorizer="local"
--container_disk_watch_interval="15secs" --containerizers="mesos"
--credential="/var/folders/66/mgr662nx7t90lspb7wjg8ctr0000gn/T/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_2_D4XsIL/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="/var/run/docker.sock"
--docker_stop_timeout="0ns"
--docker_store_dir="/var/folders/66/mgr662nx7t90lspb7wjg8ctr0000gn/T/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_2_D4XsIL/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="/var/folders/66/mgr662nx7t90lspb7wjg8ctr0000gn/T/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_2_D4XsIL/fetch"
--fetcher_cache_size="2GB" --fetcher_stall_timeout="1mins"
--frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1"
--help="false" --hostname_lookup="true" --http_command_executor="false"
--http_credentials="/var/folders/66/mgr662nx7t90lspb7wjg8ctr0000gn/T/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_2_D4XsIL/http_credentials"
--http_heartbeat_interval="30secs" --initialize_driver_logging="true"
--isolation="posix/cpu,posix/mem"
--jwt_secret_key="/var/folders/66/mgr662nx7t90lspb7wjg8ctr0000gn/T/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_2_D4XsIL/jwt_secret_key"
--launcher="posix"
--launcher_dir="/Users/till/Development/mesos-private/build/src"
--logbufsecs="0" --logging_level="INFO"
--max_completed_executors_per_framework="150" --memory_profiling="false"
--network_cni_metrics="true" --oversubscribed_resources_interval="15secs"
--port="5051" --qos_correction_interval_min="0ns" --quiet="false"
--reconfiguration_policy="equal" --recover="reconnect"
--recovery_timeout="15mins" --registration_backoff_factor="10ms"
--resources="cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]"
--runtime_dir="/var/folders/66/mgr662nx7t90lspb7wjg8ctr0000gn/T/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_2_D4XsIL"
--sandbox_directory="/mnt/mesos/sandbox" --strict="true" --switch_user="true"
--version="false"
--work_dir="/var/folders/66/mgr662nx7t90lspb7wjg8ctr0000gn/T/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_2_4hpHHU"
--zk_session_timeout="10secs"
I0903 22:48:44.104616 24588288 credentials.hpp:86] Loading credential for
authentication from
'/var/folders/66/mgr662nx7t90lspb7wjg8ctr0000gn/T/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_2_D4XsIL/credential'
I0903 22:48:44.104789 24588288 slave.cpp:300] Agent using credential for:
test-principal
I0903 22:48:44.104822 24588288 credentials.hpp:37] Loading credentials for
authentication from
'/var/folders/66/mgr662nx7t90lspb7wjg8ctr0000gn/T/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_2_D4XsIL/http_credentials'
I0903 22:48:44.104856 229418368 scheduler.cpp:189] Version: 1.8.0
I0903 22:48:44.105029 24588288 http.cpp:977] Creating default 'basic' HTTP
authenticator for realm 'mesos-agent-executor'
I0903 22:48:44.105078 24588288 http.cpp:998] Creating default 'jwt' HTTP
authenticator for realm 'mesos-agent-executor'
I0903 22:48:44.105182 24588288 http.cpp:977] Creating default 'basic' HTTP
authenticator for realm 'mesos-agent-readonly'
I0903 22:48:44.105211 24588288 http.cpp:998] Creating default 'jwt' HTTP
authenticator for realm 'mesos-agent-readonly'
I0903 22:48:44.105252 24588288 http.cpp:977] Creating default 'basic' HTTP
authenticator for realm 'mesos-agent-readwrite'
I0903 22:48:44.105273 24588288 http.cpp:998] Creating default 'jwt' HTTP
authenticator for realm 'mesos-agent-readwrite'
I0903 22:48:44.105350 24588288 disk_profile_adaptor.cpp:80] Creating default
disk profile adaptor module
I0903 22:48:44.107151 26734592 scheduler.cpp:355] Using default 'basic' HTTP
authenticatee
I0903 22:48:44.107282 27271168 scheduler.cpp:538] New master detected at
[email protected]:58421
I0903 22:48:44.107664 24588288 slave.cpp:615] Agent resources:
[{"name":"cpus","scalar":{"value":2.0},"type":"SCALAR"},{"name":"mem","scalar":{"value":1024.0},"type":"SCALAR"},{"name":"disk","scalar":{"value":1024.0},"type":"SCALAR"},{"name":"ports","ranges":{"range":[{"begin":31000,"end":32000}]},"type":"RANGES"}]
I0903 22:48:44.107750 24588288 slave.cpp:623] Agent attributes: [ ]
I0903 22:48:44.107758 24588288 slave.cpp:632] Agent hostname:
lobomacpro4.fritz.box
I0903 22:48:44.107836 25661440 task_status_update_manager.cpp:181] Pausing
sending task status updates
I0903 22:48:44.108158 26198016 state.cpp:66] Recovering state from
'/var/folders/66/mgr662nx7t90lspb7wjg8ctr0000gn/T/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_2_4hpHHU/meta'
I0903 22:48:44.108234 22978560 slave.cpp:6909] Finished recovering checkpointed
state from
'/var/folders/66/mgr662nx7t90lspb7wjg8ctr0000gn/T/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_2_4hpHHU/meta',
beginning agent recovery
I0903 22:48:44.108281 24051712 task_status_update_manager.cpp:207] Recovering
task status update manager
I0903 22:48:44.108553 22978560 composing.cpp:339] Finished recovering all
containerizers
I0903 22:48:44.108606 26734592 slave.cpp:7138] Recovering executors
I0903 22:48:44.108650 26734592 slave.cpp:7291] Finished recovery
I0903 22:48:44.109697 26734592 slave.cpp:1254] New master detected at
[email protected]:58421
I0903 22:48:44.109709 23515136 task_status_update_manager.cpp:181] Pausing
sending task status updates
I0903 22:48:44.109725 26734592 slave.cpp:1319] Detecting new master
I0903 22:48:44.114650 22978560 slave.cpp:1346] Authenticating with master
[email protected]:58421
I0903 22:48:44.114673 22978560 slave.cpp:1355] Using default CRAM-MD5
authenticatee
I0903 22:48:44.114737 27271168 authenticatee.cpp:121] Creating new client SASL
connection
I0903 22:48:44.114846 25124864 master.cpp:9600] Authenticating
slave(3)@192.168.178.20:58421
I0903 22:48:44.114964 23515136 authenticator.cpp:98] Creating new server SASL
connection
I0903 22:48:44.115021 26734592 authenticatee.cpp:213] Received SASL
authentication mechanisms: CRAM-MD5
I0903 22:48:44.115037 26734592 authenticatee.cpp:239] Attempting to
authenticate with mechanism 'CRAM-MD5'
I0903 22:48:44.115080 26198016 authenticator.cpp:204] Received SASL
authentication start
I0903 22:48:44.115128 26198016 authenticator.cpp:326] Authentication requires
more steps
I0903 22:48:44.115169 22441984 authenticatee.cpp:259] Received SASL
authentication step
I0903 22:48:44.115207 27807744 authenticator.cpp:232] Received SASL
authentication step
I0903 22:48:44.115231 27807744 authenticator.cpp:318] Authentication success
I0903 22:48:44.115278 24051712 authenticatee.cpp:299] Authentication success
I0903 22:48:44.115303 21905408 master.cpp:9632] Successfully authenticated
principal 'test-principal' at slave(3)@192.168.178.20:58421
I0903 22:48:44.115407 22978560 slave.cpp:1446] Successfully authenticated with
master [email protected]:58421
I0903 22:48:44.115567 23515136 master.cpp:6562] Received register agent message
from slave(3)@192.168.178.20:58421 (lobomacpro4.fritz.box)
I0903 22:48:44.115643 23515136 master.cpp:3921] Authorizing agent providing
resources 'cpus:2; mem:1024; disk:1024; ports:[31000-32000]' with principal
'test-principal'
I0903 22:48:44.115819 27807744 master.cpp:6744] Registering agent at
slave(3)@192.168.178.20:58421 (lobomacpro4.fritz.box) with id
69fc6ff7-1b79-44cd-9e4f-e177b4ea4691-S0
I0903 22:48:44.115969 24588288 registrar.cpp:487] Applied 1 operations in
72518ns; attempting to update the registry
I0903 22:48:44.117759 22978560 registrar.cpp:544] Successfully updated the
registry in 1.747968ms
I0903 22:48:44.117987 23515136 master.cpp:6837] Registered agent
69fc6ff7-1b79-44cd-9e4f-e177b4ea4691-S0 at slave(3)@192.168.178.20:58421
(lobomacpro4.fritz.box) with cpus:2; mem:1024; disk:1024; ports:[31000-32000]
I0903 22:48:44.118043 26734592 slave.cpp:1479] Registered with master
[email protected]:58421; given agent ID
69fc6ff7-1b79-44cd-9e4f-e177b4ea4691-S0
I0903 22:48:44.118083 27807744 task_status_update_manager.cpp:188] Resuming
sending task status updates
I0903 22:48:44.118095 22441984 hierarchical.cpp:601] Added agent
69fc6ff7-1b79-44cd-9e4f-e177b4ea4691-S0 (lobomacpro4.fritz.box) with cpus:2;
mem:1024; disk:1024; ports:[31000-32000] (allocated: {})
I0903 22:48:44.138898 26734592 slave.cpp:1548] Forwarding agent update
{"operations":{},"resource_version_uuid":{"value":"AJ27NlDkT5ibEApmePlRCg=="},"slave_id":{"value":"69fc6ff7-1b79-44cd-9e4f-e177b4ea4691-S0"},"update_oversubscribed_resources":false}
I0903 22:48:44.139292 25124864 master.cpp:7896] Ignoring update on agent
69fc6ff7-1b79-44cd-9e4f-e177b4ea4691-S0 at slave(3)@192.168.178.20:58421
(lobomacpro4.fritz.box) as it reports no changes
../../src/tests/scheduler_tests.cpp:2405: Failure
Failed to wait 15secs for subscribed
I0903 22:48:59.120170 229418368 slave.cpp:909] Agent terminating
I0903 22:48:59.120787 21905408 master.cpp:1251] Agent
69fc6ff7-1b79-44cd-9e4f-e177b4ea4691-S0 at slave(3)@192.168.178.20:58421
(lobomacpro4.fritz.box) disconnected
I0903 22:48:59.120826 21905408 master.cpp:3267] Disconnecting agent
69fc6ff7-1b79-44cd-9e4f-e177b4ea4691-S0 at slave(3)@192.168.178.20:58421
(lobomacpro4.fritz.box)
I0903 22:48:59.120856 21905408 master.cpp:3286] Deactivating agent
69fc6ff7-1b79-44cd-9e4f-e177b4ea4691-S0 at slave(3)@192.168.178.20:58421
(lobomacpro4.fritz.box)
I0903 22:48:59.121039 27271168 hierarchical.cpp:795] Agent
69fc6ff7-1b79-44cd-9e4f-e177b4ea4691-S0 deactivated
../../src/tests/scheduler_tests.cpp:2392: Failure
Actual function call count doesn't match EXPECT_CALL(*scheduler, offers(_,
_))...
Expected: to be called once
Actual: never called - unsatisfied and active
../../src/tests/scheduler_tests.cpp:2385: Failure
Actual function call count doesn't match EXPECT_CALL(*scheduler, subscribed(_,
_))...
Expected: to be called once
Actual: never called - unsatisfied and active
I0903 22:48:59.123317 229418368 master.cpp:1093] Master terminating
I0903 22:48:59.123592 23515136 hierarchical.cpp:637] Removed agent
69fc6ff7-1b79-44cd-9e4f-e177b4ea4691-S0
[ FAILED ] ContentTypeAndSSLConfig/SchedulerSSLTest.RunTaskAndTeardown/2,
where GetParam() = (application/json, "https") (15177 ms)
[ RUN ] ContentTypeAndSSLConfig/SchedulerSSLTest.RunTaskAndTeardown/3
I0903 22:48:59.127475 229418368 process.cpp:926] Stopped the socket accept loop
I0903 22:48:59.132865 229418368 cluster.cpp:173] Creating default 'local'
authorizer
I0903 22:48:59.136422 24051712 master.cpp:413] Master
b78c4d49-74b3-4c64-9c3e-98a1f27d6354 (lobomacpro4.fritz.box) started on
192.168.178.20:58436
I0903 22:48:59.136453 24051712 master.cpp:416] Flags at startup: --acls=""
--agent_ping_timeout="15secs" --agent_reregister_timeout="10mins"
--allocation_interval="1secs" --allocator="hierarchical"
--authenticate_agents="true" --authenticate_frameworks="true"
--authenticate_http_frameworks="true" --authenticate_http_readonly="true"
--authenticate_http_readwrite="true" --authentication_v0_timeout="15secs"
--authenticators="crammd5" --authorizers="local"
--credentials="/private/var/folders/66/mgr662nx7t90lspb7wjg8ctr0000gn/T/Og4RjX/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" --memory_profiling="false"
--min_allocatable_resources="cpus:0.01|mem:32" --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" --role_sorter="drf" --root_submissions="true"
--version="false" --webui_dir="/usr/local/share/mesos/webui"
--work_dir="/private/var/folders/66/mgr662nx7t90lspb7wjg8ctr0000gn/T/Og4RjX/master"
--zk_session_timeout="10secs"
I0903 22:48:59.136613 24051712 master.cpp:465] Master only allowing
authenticated frameworks to register
I0903 22:48:59.136626 24051712 master.cpp:471] Master only allowing
authenticated agents to register
I0903 22:48:59.136634 24051712 master.cpp:477] Master only allowing
authenticated HTTP frameworks to register
I0903 22:48:59.136641 24051712 credentials.hpp:37] Loading credentials for
authentication from
'/private/var/folders/66/mgr662nx7t90lspb7wjg8ctr0000gn/T/Og4RjX/credentials'
I0903 22:48:59.136772 24051712 master.cpp:521] Using default 'crammd5'
authenticator
I0903 22:48:59.136816 24051712 http.cpp:977] Creating default 'basic' HTTP
authenticator for realm 'mesos-master-readonly'
I0903 22:48:59.136860 24051712 http.cpp:977] Creating default 'basic' HTTP
authenticator for realm 'mesos-master-readwrite'
I0903 22:48:59.136893 24051712 http.cpp:977] Creating default 'basic' HTTP
authenticator for realm 'mesos-master-scheduler'
I0903 22:48:59.136921 24051712 master.cpp:602] Authorization enabled
I0903 22:48:59.138377 22441984 master.cpp:2083] Elected as the leading master!
I0903 22:48:59.138394 22441984 master.cpp:1638] Recovering from registrar
I0903 22:48:59.140529 26734592 registrar.cpp:383] Successfully fetched the
registry (0B) in 2.08512ms
I0903 22:48:59.140591 26734592 registrar.cpp:487] Applied 1 operations in
23844ns; attempting to update the registry
I0903 22:48:59.142766 26734592 registrar.cpp:544] Successfully updated the
registry in 2.146048ms
I0903 22:48:59.142814 26734592 registrar.cpp:416] Successfully recovered
registrar
I0903 22:48:59.142957 22441984 master.cpp:1752] Recovered 0 agents from the
registry (162B); allowing 10mins for agents to reregister
W0903 22:48:59.147231 229418368 process.cpp:2810] Attempted to spawn already
running process [email protected]:58436
I0903 22:48:59.147526 229418368 cluster.cpp:479] Creating default 'local'
authorizer
I0903 22:48:59.148412 23515136 slave.cpp:267] Mesos agent started on
(4)@192.168.178.20:58436
I0903 22:48:59.148437 23515136 slave.cpp:268] Flags at startup: --acls=""
--appc_simple_discovery_uri_prefix="http://";
--appc_store_dir="/var/folders/66/mgr662nx7t90lspb7wjg8ctr0000gn/T/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_3_QyRHMP/store/appc"
--authenticate_http_executors="true" --authenticate_http_readonly="true"
--authenticate_http_readwrite="true" --authenticatee="crammd5"
--authentication_backoff_factor="1secs" --authentication_timeout_max="1mins"
--authentication_timeout_min="5secs" --authorizer="local"
--container_disk_watch_interval="15secs" --containerizers="mesos"
--credential="/var/folders/66/mgr662nx7t90lspb7wjg8ctr0000gn/T/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_3_QyRHMP/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="/var/run/docker.sock"
--docker_stop_timeout="0ns"
--docker_store_dir="/var/folders/66/mgr662nx7t90lspb7wjg8ctr0000gn/T/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_3_QyRHMP/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="/var/folders/66/mgr662nx7t90lspb7wjg8ctr0000gn/T/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_3_QyRHMP/fetch"
--fetcher_cache_size="2GB" --fetcher_stall_timeout="1mins"
--frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1"
--help="false" --hostname_lookup="true" --http_command_executor="false"
--http_credentials="/var/folders/66/mgr662nx7t90lspb7wjg8ctr0000gn/T/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_3_QyRHMP/http_credentials"
--http_heartbeat_interval="30secs" --initialize_driver_logging="true"
--isolation="posix/cpu,posix/mem"
--jwt_secret_key="/var/folders/66/mgr662nx7t90lspb7wjg8ctr0000gn/T/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_3_QyRHMP/jwt_secret_key"
--launcher="posix"
--launcher_dir="/Users/till/Development/mesos-private/build/src"
--logbufsecs="0" --logging_level="INFO"
--max_completed_executors_per_framework="150" --memory_profiling="false"
--network_cni_metrics="true" --oversubscribed_resources_interval="15secs"
--port="5051" --qos_correction_interval_min="0ns" --quiet="false"
--reconfiguration_policy="equal" --recover="reconnect"
--recovery_timeout="15mins" --registration_backoff_factor="10ms"
--resources="cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]"
--runtime_dir="/var/folders/66/mgr662nx7t90lspb7wjg8ctr0000gn/T/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_3_QyRHMP"
--sandbox_directory="/mnt/mesos/sandbox" --strict="true" --switch_user="true"
--version="false"
--work_dir="/var/folders/66/mgr662nx7t90lspb7wjg8ctr0000gn/T/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_3_9GoTWZ"
--zk_session_timeout="10secs"
I0903 22:48:59.148780 23515136 credentials.hpp:86] Loading credential for
authentication from
'/var/folders/66/mgr662nx7t90lspb7wjg8ctr0000gn/T/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_3_QyRHMP/credential'
I0903 22:48:59.148883 229418368 scheduler.cpp:189] Version: 1.8.0
I0903 22:48:59.148950 23515136 slave.cpp:300] Agent using credential for:
test-principal
I0903 22:48:59.148965 23515136 credentials.hpp:37] Loading credentials for
authentication from
'/var/folders/66/mgr662nx7t90lspb7wjg8ctr0000gn/T/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_3_QyRHMP/http_credentials'
I0903 22:48:59.149142 23515136 http.cpp:977] Creating default 'basic' HTTP
authenticator for realm 'mesos-agent-executor'
I0903 22:48:59.149190 23515136 http.cpp:998] Creating default 'jwt' HTTP
authenticator for realm 'mesos-agent-executor'
I0903 22:48:59.149272 23515136 http.cpp:977] Creating default 'basic' HTTP
authenticator for realm 'mesos-agent-readonly'
I0903 22:48:59.149315 23515136 http.cpp:998] Creating default 'jwt' HTTP
authenticator for realm 'mesos-agent-readonly'
I0903 22:48:59.149384 23515136 http.cpp:977] Creating default 'basic' HTTP
authenticator for realm 'mesos-agent-readwrite'
I0903 22:48:59.149415 23515136 http.cpp:998] Creating default 'jwt' HTTP
authenticator for realm 'mesos-agent-readwrite'
I0903 22:48:59.149538 23515136 disk_profile_adaptor.cpp:80] Creating default
disk profile adaptor module
I0903 22:48:59.151396 26734592 scheduler.cpp:355] Using default 'basic' HTTP
authenticatee
I0903 22:48:59.151614 22978560 scheduler.cpp:538] New master detected at
[email protected]:58436
I0903 22:48:59.152135 23515136 slave.cpp:615] Agent resources:
[{"name":"cpus","scalar":{"value":2.0},"type":"SCALAR"},{"name":"mem","scalar":{"value":1024.0},"type":"SCALAR"},{"name":"disk","scalar":{"value":1024.0},"type":"SCALAR"},{"name":"ports","ranges":{"range":[{"begin":31000,"end":32000}]},"type":"RANGES"}]
I0903 22:48:59.152264 23515136 slave.cpp:623] Agent attributes: [ ]
I0903 22:48:59.152274 23515136 slave.cpp:632] Agent hostname:
lobomacpro4.fritz.box
I0903 22:48:59.152328 27271168 task_status_update_manager.cpp:181] Pausing
sending task status updates
I0903 22:48:59.152719 24051712 state.cpp:66] Recovering state from
'/var/folders/66/mgr662nx7t90lspb7wjg8ctr0000gn/T/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_3_9GoTWZ/meta'
I0903 22:48:59.152810 27807744 slave.cpp:6909] Finished recovering checkpointed
state from
'/var/folders/66/mgr662nx7t90lspb7wjg8ctr0000gn/T/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_3_9GoTWZ/meta',
beginning agent recovery
I0903 22:48:59.152871 25124864 task_status_update_manager.cpp:207] Recovering
task status update manager
I0903 22:48:59.153223 25661440 composing.cpp:339] Finished recovering all
containerizers
I0903 22:48:59.153323 25124864 slave.cpp:7138] Recovering executors
I0903 22:48:59.153372 25124864 slave.cpp:7291] Finished recovery
I0903 22:48:59.153908 23515136 task_status_update_manager.cpp:181] Pausing
sending task status updates
I0903 22:48:59.153916 26198016 slave.cpp:1254] New master detected at
[email protected]:58436
I0903 22:48:59.153949 26198016 slave.cpp:1319] Detecting new master
I0903 22:48:59.155570 26734592 http.cpp:1117] HTTP POST for
/master/api/v1/scheduler from 192.168.178.20:58437
I0903 22:48:59.155820 26734592 master.cpp:2502] Received subscription request
for HTTP framework 'default'
I0903 22:48:59.155846 26734592 master.cpp:2155] Authorizing framework principal
'test-principal' to receive offers for roles '{ * }'
I0903 22:48:59.156100 26734592 master.cpp:2637] Subscribing framework 'default'
with checkpointing disabled and capabilities [ MULTI_ROLE,
RESERVATION_REFINEMENT ]
I0903 22:48:59.156688 26734592 master.cpp:9830] Adding framework
b78c4d49-74b3-4c64-9c3e-98a1f27d6354-0000 (default) with roles { } suppressed
I0903 22:48:59.156882 24588288 hierarchical.cpp:306] Added framework
b78c4d49-74b3-4c64-9c3e-98a1f27d6354-0000
I0903 22:48:59.163992 25124864 slave.cpp:1346] Authenticating with master
[email protected]:58436
I0903 22:48:59.164039 25124864 slave.cpp:1355] Using default CRAM-MD5
authenticatee
I0903 22:48:59.164155 27807744 authenticatee.cpp:121] Creating new client SASL
connection
I0903 22:48:59.164274 25661440 master.cpp:9600] Authenticating
slave(4)@192.168.178.20:58436
I0903 22:48:59.164413 22441984 authenticator.cpp:98] Creating new server SASL
connection
I0903 22:48:59.164487 24051712 authenticatee.cpp:213] Received SASL
authentication mechanisms: CRAM-MD5
I0903 22:48:59.164510 24051712 authenticatee.cpp:239] Attempting to
authenticate with mechanism 'CRAM-MD5'
I0903 22:48:59.164556 24588288 authenticator.cpp:204] Received SASL
authentication start
I0903 22:48:59.164621 24588288 authenticator.cpp:326] Authentication requires
more steps
I0903 22:48:59.164690 26198016 authenticatee.cpp:259] Received SASL
authentication step
I0903 22:48:59.164752 23515136 authenticator.cpp:232] Received SASL
authentication step
I0903 22:48:59.164782 23515136 authenticator.cpp:318] Authentication success
I0903 22:48:59.164829 21905408 authenticatee.cpp:299] Authentication success
I0903 22:48:59.164855 22978560 master.cpp:9632] Successfully authenticated
principal 'test-principal' at slave(4)@192.168.178.20:58436
I0903 22:48:59.164973 25124864 slave.cpp:1446] Successfully authenticated with
master [email protected]:58436
I0903 22:48:59.165184 24588288 master.cpp:6562] Received register agent message
from slave(4)@192.168.178.20:58436 (lobomacpro4.fritz.box)
I0903 22:48:59.165275 24588288 master.cpp:3921] Authorizing agent providing
resources 'cpus:2; mem:1024; disk:1024; ports:[31000-32000]' with principal
'test-principal'
I0903 22:48:59.165585 21905408 master.cpp:6744] Registering agent at
slave(4)@192.168.178.20:58436 (lobomacpro4.fritz.box) with id
b78c4d49-74b3-4c64-9c3e-98a1f27d6354-S0
I0903 22:48:59.165822 27271168 registrar.cpp:487] Applied 1 operations in
98538ns; attempting to update the registry
I0903 22:48:59.167999 24051712 registrar.cpp:544] Successfully updated the
registry in 2.145024ms
I0903 22:48:59.168190 24588288 master.cpp:6837] Registered agent
b78c4d49-74b3-4c64-9c3e-98a1f27d6354-S0 at slave(4)@192.168.178.20:58436
(lobomacpro4.fritz.box) with cpus:2; mem:1024; disk:1024; ports:[31000-32000]
I0903 22:48:59.168231 26198016 slave.cpp:1479] Registered with master
[email protected]:58436; given agent ID
b78c4d49-74b3-4c64-9c3e-98a1f27d6354-S0
I0903 22:48:59.168274 21905408 task_status_update_manager.cpp:188] Resuming
sending task status updates
I0903 22:48:59.168304 22978560 hierarchical.cpp:601] Added agent
b78c4d49-74b3-4c64-9c3e-98a1f27d6354-S0 (lobomacpro4.fritz.box) with cpus:2;
mem:1024; disk:1024; ports:[31000-32000] (allocated: {})
I0903 22:48:59.168859 22441984 master.cpp:9415] Sending offers [
b78c4d49-74b3-4c64-9c3e-98a1f27d6354-O0 ] to framework
b78c4d49-74b3-4c64-9c3e-98a1f27d6354-0000 (default)
I0903 22:48:59.169030 26198016 slave.cpp:1548] Forwarding agent update
{"operations":{},"resource_version_uuid":{"value":"s1ei5a96QVy4WCrhbRMDUQ=="},"slave_id":{"value":"b78c4d49-74b3-4c64-9c3e-98a1f27d6354-S0"},"update_oversubscribed_resources":false}
I0903 22:48:59.169425 22441984 master.cpp:7896] Ignoring update on agent
b78c4d49-74b3-4c64-9c3e-98a1f27d6354-S0 at slave(4)@192.168.178.20:58436
(lobomacpro4.fritz.box) as it reports no changes
I0903 22:48:59.171329 21905408 http.cpp:1117] HTTP POST for
/master/api/v1/scheduler from 192.168.178.20:58438
I0903 22:48:59.171771 21905408 master.cpp:11409] Removing offer
b78c4d49-74b3-4c64-9c3e-98a1f27d6354-O0
I0903 22:48:59.171944 21905408 master.cpp:4424] Processing ACCEPT call for
offers: [ b78c4d49-74b3-4c64-9c3e-98a1f27d6354-O0 ] on agent
b78c4d49-74b3-4c64-9c3e-98a1f27d6354-S0 at slave(4)@192.168.178.20:58436
(lobomacpro4.fritz.box) for framework b78c4d49-74b3-4c64-9c3e-98a1f27d6354-0000
(default)
I0903 22:48:59.171986 21905408 master.cpp:3498] Authorizing framework principal
'test-principal' to launch task 8b5f0ace-09db-4b4b-9bac-f924a7f65f2c
W0903 22:48:59.172612 21905408 validation.cpp:1444] Executor 'default' for task
'8b5f0ace-09db-4b4b-9bac-f924a7f65f2c' uses less CPUs (None) than the minimum
required (0.01). Please update your executor, as this will be mandatory in
future releases.
W0903 22:48:59.172633 21905408 validation.cpp:1456] Executor 'default' for task
'8b5f0ace-09db-4b4b-9bac-f924a7f65f2c' uses less memory (None) than the minimum
required (32MB). Please update your executor, as this will be mandatory in
future releases.
I0903 22:48:59.172768 21905408 master.cpp:12158] Adding task
8b5f0ace-09db-4b4b-9bac-f924a7f65f2c with resources cpus(allocated: *):2;
mem(allocated: *):1024; disk(allocated: *):1024; ports(allocated:
*):[31000-32000] on agent b78c4d49-74b3-4c64-9c3e-98a1f27d6354-S0 at
slave(4)@192.168.178.20:58436 (lobomacpro4.fritz.box)
I0903 22:48:59.172938 21905408 master.cpp:5396] Launching task
8b5f0ace-09db-4b4b-9bac-f924a7f65f2c of framework
b78c4d49-74b3-4c64-9c3e-98a1f27d6354-0000 (default) with resources
[{"allocation_info":{"role":"*"},"name":"cpus","scalar":{"value":2.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"mem","scalar":{"value":1024.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"disk","scalar":{"value":1024.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"ports","ranges":{"range":[{"begin":31000,"end":32000}]},"type":"RANGES"}]
on agent b78c4d49-74b3-4c64-9c3e-98a1f27d6354-S0 at
slave(4)@192.168.178.20:58436 (lobomacpro4.fritz.box) on new executor
I0903 22:48:59.173362 27807744 slave.cpp:2014] Got assigned task
'8b5f0ace-09db-4b4b-9bac-f924a7f65f2c' for framework
b78c4d49-74b3-4c64-9c3e-98a1f27d6354-0000
I0903 22:48:59.174015 27807744 slave.cpp:2388] Authorizing task
'8b5f0ace-09db-4b4b-9bac-f924a7f65f2c' for framework
b78c4d49-74b3-4c64-9c3e-98a1f27d6354-0000
I0903 22:48:59.174047 27807744 slave.cpp:8448] Authorizing framework principal
'test-principal' to launch task 8b5f0ace-09db-4b4b-9bac-f924a7f65f2c
I0903 22:48:59.174760 27807744 slave.cpp:2831] Launching task
'8b5f0ace-09db-4b4b-9bac-f924a7f65f2c' for framework
b78c4d49-74b3-4c64-9c3e-98a1f27d6354-0000
I0903 22:48:59.176790 27807744 paths.cpp:745] Creating sandbox
'/var/folders/66/mgr662nx7t90lspb7wjg8ctr0000gn/T/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_3_9GoTWZ/slaves/b78c4d49-74b3-4c64-9c3e-98a1f27d6354-S0/frameworks/b78c4d49-74b3-4c64-9c3e-98a1f27d6354-0000/executors/default/runs/dc097d3d-95af-409a-afd2-2e78d8dd88bf'
for user 'till'
I0903 22:48:59.177698 27807744 slave.cpp:8976] Launching executor 'default' of
framework b78c4d49-74b3-4c64-9c3e-98a1f27d6354-0000 with resources [] in work
directory
'/var/folders/66/mgr662nx7t90lspb7wjg8ctr0000gn/T/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_3_9GoTWZ/slaves/b78c4d49-74b3-4c64-9c3e-98a1f27d6354-S0/frameworks/b78c4d49-74b3-4c64-9c3e-98a1f27d6354-0000/executors/default/runs/dc097d3d-95af-409a-afd2-2e78d8dd88bf'
I0903 22:48:59.178153 27807744 slave.cpp:3028] Queued task
'8b5f0ace-09db-4b4b-9bac-f924a7f65f2c' for executor 'default' of framework
b78c4d49-74b3-4c64-9c3e-98a1f27d6354-0000
I0903 22:48:59.178385 27807744 slave.cpp:3509] Launching container
dc097d3d-95af-409a-afd2-2e78d8dd88bf for executor 'default' of framework
b78c4d49-74b3-4c64-9c3e-98a1f27d6354-0000
I0903 22:48:59.179036 22441984 executor.cpp:201] Version: 1.8.0
I0903 22:48:59.181591 23515136 http.cpp:1117] HTTP POST for
/slave(4)/api/v1/executor from 192.168.178.20:58439
I0903 22:48:59.181695 23515136 slave.cpp:4607] Received Subscribe request for
HTTP executor 'default' of framework b78c4d49-74b3-4c64-9c3e-98a1f27d6354-0000
I0903 22:48:59.182586 27807744 slave.cpp:3241] Sending queued task
'8b5f0ace-09db-4b4b-9bac-f924a7f65f2c' to executor 'default' of framework
b78c4d49-74b3-4c64-9c3e-98a1f27d6354-0000 (via HTTP)
I0903 22:48:59.188128 26198016 http.cpp:1117] HTTP POST for
/slave(4)/api/v1/executor from 192.168.178.20:58440
I0903 22:48:59.188452 26198016 slave.cpp:5269] Handling status update
TASK_RUNNING (Status UUID: e942d167-6bea-4bdb-8d60-2fb4dd602daf) for task
8b5f0ace-09db-4b4b-9bac-f924a7f65f2c of framework
b78c4d49-74b3-4c64-9c3e-98a1f27d6354-0000
I0903 22:48:59.189379 24588288 task_status_update_manager.cpp:328] Received
task status update TASK_RUNNING (Status UUID:
e942d167-6bea-4bdb-8d60-2fb4dd602daf) for task
8b5f0ace-09db-4b4b-9bac-f924a7f65f2c of framework
b78c4d49-74b3-4c64-9c3e-98a1f27d6354-0000
I0903 22:48:59.190445 25661440 slave.cpp:5761] Forwarding the update
TASK_RUNNING (Status UUID: e942d167-6bea-4bdb-8d60-2fb4dd602daf) for task
8b5f0ace-09db-4b4b-9bac-f924a7f65f2c of framework
b78c4d49-74b3-4c64-9c3e-98a1f27d6354-0000 to [email protected]:58436
I0903 22:48:59.190623 27807744 master.cpp:8332] Status update TASK_RUNNING
(Status UUID: e942d167-6bea-4bdb-8d60-2fb4dd602daf) for task
8b5f0ace-09db-4b4b-9bac-f924a7f65f2c of framework
b78c4d49-74b3-4c64-9c3e-98a1f27d6354-0000 from agent
b78c4d49-74b3-4c64-9c3e-98a1f27d6354-S0 at slave(4)@192.168.178.20:58436
(lobomacpro4.fritz.box)
I0903 22:48:59.190657 27807744 master.cpp:8389] Forwarding status update
TASK_RUNNING (Status UUID: e942d167-6bea-4bdb-8d60-2fb4dd602daf) for task
8b5f0ace-09db-4b4b-9bac-f924a7f65f2c of framework
b78c4d49-74b3-4c64-9c3e-98a1f27d6354-0000
I0903 22:48:59.190937 27807744 master.cpp:10879] Updating the state of task
8b5f0ace-09db-4b4b-9bac-f924a7f65f2c of framework
b78c4d49-74b3-4c64-9c3e-98a1f27d6354-0000 (latest state: TASK_RUNNING, status
update state: TASK_RUNNING)
I0903 22:48:59.192713 23515136 http.cpp:1117] HTTP POST for
/master/api/v1/scheduler from 192.168.178.20:58438
I0903 22:48:59.192782 23515136 master.cpp:10144] Removing framework
b78c4d49-74b3-4c64-9c3e-98a1f27d6354-0000 (default)
I0903 22:48:59.192795 23515136 master.cpp:3230] Deactivating framework
b78c4d49-74b3-4c64-9c3e-98a1f27d6354-0000 (default)
I0903 22:48:59.192849 23515136 master.cpp:10879] Updating the state of task
8b5f0ace-09db-4b4b-9bac-f924a7f65f2c of framework
b78c4d49-74b3-4c64-9c3e-98a1f27d6354-0000 (latest state: TASK_KILLED, status
update state: TASK_KILLED)
I0903 22:48:59.192863 26198016 hierarchical.cpp:420] Deactivated framework
b78c4d49-74b3-4c64-9c3e-98a1f27d6354-0000
I0903 22:48:59.192878 25661440 slave.cpp:3921] Shutting down framework
b78c4d49-74b3-4c64-9c3e-98a1f27d6354-0000
I0903 22:48:59.192904 25661440 slave.cpp:6640] Shutting down executor 'default'
of framework b78c4d49-74b3-4c64-9c3e-98a1f27d6354-0000 (via HTTP)
I0903 22:48:59.193089 23515136 master.cpp:10977] Removing task
8b5f0ace-09db-4b4b-9bac-f924a7f65f2c with resources cpus(allocated: *):2;
mem(allocated: *):1024; disk(allocated: *):1024; ports(allocated:
*):[31000-32000] of framework b78c4d49-74b3-4c64-9c3e-98a1f27d6354-0000 on
agent b78c4d49-74b3-4c64-9c3e-98a1f27d6354-S0 at slave(4)@192.168.178.20:58436
(lobomacpro4.fritz.box)
I0903 22:48:59.193251 23515136 master.cpp:11008] Removing executor 'default'
with resources [] of framework b78c4d49-74b3-4c64-9c3e-98a1f27d6354-0000 on
agent b78c4d49-74b3-4c64-9c3e-98a1f27d6354-S0 at slave(4)@192.168.178.20:58436
(lobomacpro4.fritz.box)
E0903 22:48:59.193738 27271168 scheduler.cpp:818] End-Of-File received from
master. The master closed the event stream
I0903 22:48:59.193773 25124864 hierarchical.cpp:359] Removed framework
b78c4d49-74b3-4c64-9c3e-98a1f27d6354-0000
I0903 22:48:59.193989 22441984 scheduler.cpp:512] Re-detecting master
I0903 22:48:59.194365 22441984 scheduler.cpp:538] New master detected at
[email protected]:58436
I0903 22:48:59.196487 229418368 slave.cpp:909] Agent terminating
W0903 22:48:59.196511 229418368 slave.cpp:3917] Ignoring shutdown framework
b78c4d49-74b3-4c64-9c3e-98a1f27d6354-0000 because it is terminating
I0903 22:48:59.196971 21905408 master.cpp:1251] Agent
b78c4d49-74b3-4c64-9c3e-98a1f27d6354-S0 at slave(4)@192.168.178.20:58436
(lobomacpro4.fritz.box) disconnected
I0903 22:48:59.196990 21905408 master.cpp:3267] Disconnecting agent
b78c4d49-74b3-4c64-9c3e-98a1f27d6354-S0 at slave(4)@192.168.178.20:58436
(lobomacpro4.fritz.box)
I0903 22:48:59.197015 21905408 master.cpp:3286] Deactivating agent
b78c4d49-74b3-4c64-9c3e-98a1f27d6354-S0 at slave(4)@192.168.178.20:58436
(lobomacpro4.fritz.box)
I0903 22:48:59.197072 23515136 hierarchical.cpp:795] Agent
b78c4d49-74b3-4c64-9c3e-98a1f27d6354-S0 deactivated
I0903 22:48:59.199163 229418368 master.cpp:1093] Master terminating
I0903 22:48:59.199419 22978560 hierarchical.cpp:637] Removed agent
b78c4d49-74b3-4c64-9c3e-98a1f27d6354-S0
W0903 22:48:59.199663 229418368 framework.cpp:652] Failed to close HTTP pipe
for b78c4d49-74b3-4c64-9c3e-98a1f27d6354-0000 (default)
[ OK ] ContentTypeAndSSLConfig/SchedulerSSLTest.RunTaskAndTeardown/3 (74
ms)
I0903 22:48:59.202957 28344320 process.cpp:926] Stopped the socket accept loop
[----------] 4 tests from ContentTypeAndSSLConfig/SchedulerSSLTest (30575 ms
total)
[----------] Global test environment tear-down
[==========] 4 tests from 1 test case ran. (30619 ms total)
[ PASSED ] 2 tests.
[ FAILED ] 2 tests, listed below:
[ FAILED ] ContentTypeAndSSLConfig/SchedulerSSLTest.RunTaskAndTeardown/0,
where GetParam() = (application/x-protobuf, "https")
[ FAILED ] ContentTypeAndSSLConfig/SchedulerSSLTest.RunTaskAndTeardown/2,
where GetParam() = (application/json, "https")
{noformat}
--
This message was sent by Atlassian JIRA
(v7.6.3#76005)
