See <https://builds.apache.org/job/Mesos-Buildbot/BUILDTOOL=cmake,COMPILER=gcc,CONFIGURATION=--verbose%20--disable-libtool-wrappers,ENVIRONMENT=GLOG_v=1%20MESOS_VERBOSE=1,OS=ubuntu%3A14.04,label_exp=(ubuntu)&&(!ubuntu-us1)&&(!ubuntu-eu2)&&(!qnode3)&&(!H23)/4585/display/redirect?page=changes>
Changes: [xujyan] Added a new reason to task status. [xujyan] Send status updates when an unreachable agent re-registers. ------------------------------------------ [...truncated 29.44 MB...] 3: I1212 19:55:26.096896 17439 master.cpp:1147] Master terminating 3: I1212 19:55:26.097940 17461 hierarchical.cpp:609] Removed agent 2babaaf8-407c-4b95-aa2b-ffc59db63999-S0 3: W1212 19:55:26.100021 17438 master.hpp:2728] Failed to close HTTP pipe for 2babaaf8-407c-4b95-aa2b-ffc59db63999-0000 (default) 3: [ OK ] ContentTypeAndSSLConfig/SchedulerSSLTest.RunTaskAndTeardown/0 (147 ms) 3: [ RUN ] ContentTypeAndSSLConfig/SchedulerSSLTest.RunTaskAndTeardown/1 3: I1212 19:55:26.108686 17438 cluster.cpp:172] Creating default 'local' authorizer 3: I1212 19:55:26.113742 17451 master.cpp:456] Master f4d3d47f-46a7-4426-8b55-f48f8ce01a53 (67b98930ca58) started on 172.17.0.3:42333 3: I1212 19:55:26.113772 17451 master.cpp:458] 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="/tmp/jgvNK1/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" --root_submissions="true" --user_sorter="drf" --version="false" --webui_dir="/usr/local/share/mesos/webui" --work_dir="/tmp/jgvNK1/master" --zk_session_timeout="10secs" 3: I1212 19:55:26.114213 17451 master.cpp:507] Master only allowing authenticated frameworks to register 3: I1212 19:55:26.114223 17451 master.cpp:513] Master only allowing authenticated agents to register 3: I1212 19:55:26.114228 17451 master.cpp:519] Master only allowing authenticated HTTP frameworks to register 3: I1212 19:55:26.114235 17451 credentials.hpp:37] Loading credentials for authentication from '/tmp/jgvNK1/credentials' 3: I1212 19:55:26.114625 17451 master.cpp:563] Using default 'crammd5' authenticator 3: I1212 19:55:26.114817 17451 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readonly' 3: I1212 19:55:26.115003 17451 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readwrite' 3: I1212 19:55:26.115171 17451 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-master-scheduler' 3: I1212 19:55:26.115330 17451 master.cpp:642] Authorization enabled 3: I1212 19:55:26.115542 17457 whitelist_watcher.cpp:77] No whitelist given 3: I1212 19:55:26.115602 17450 hierarchical.cpp:175] Initialized hierarchical allocator process 3: I1212 19:55:26.119102 17440 master.cpp:2209] Elected as the leading master! 3: I1212 19:55:26.119146 17440 master.cpp:1689] Recovering from registrar 3: I1212 19:55:26.119376 17447 registrar.cpp:347] Recovering registrar 3: I1212 19:55:26.120162 17447 registrar.cpp:391] Successfully fetched the registry (0B) in 739840ns 3: I1212 19:55:26.120287 17447 registrar.cpp:495] Applied 1 operations in 36999ns; attempting to update the registry 3: I1212 19:55:26.120954 17447 registrar.cpp:552] Successfully updated the registry in 605952ns 3: I1212 19:55:26.121095 17447 registrar.cpp:424] Successfully recovered registrar 3: I1212 19:55:26.121613 17441 master.cpp:1802] Recovered 0 agents from the registry (135B); allowing 10mins for agents to re-register 3: I1212 19:55:26.121646 17442 hierarchical.cpp:213] Skipping recovery of hierarchical allocator: nothing to recover 3: W1212 19:55:26.128785 17438 process.cpp:2756] Attempted to spawn already running process [email protected]:42333 3: I1212 19:55:26.129266 17438 cluster.cpp:460] Creating default 'local' authorizer 3: I1212 19:55:26.132129 17461 slave.cpp:258] Mesos agent started on (838)@172.17.0.3:42333 3: I1212 19:55:26.132156 17461 slave.cpp:259] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://"; --appc_store_dir="/tmp/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_1_PPq3og/store/appc" --authenticate_http_readonly="true" --authenticate_http_readwrite="true" --authenticatee="crammd5" --authentication_backoff_factor="1secs" --authorizer="local" --cgroups_cpu_enable_pids_and_tids_count="false" --cgroups_enable_cfs="false" --cgroups_hierarchy="/sys/fs/cgroup" --cgroups_limit_swap="false" --cgroups_root="mesos" --container_disk_watch_interval="15secs" --containerizers="mesos" --credential="/tmp/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_1_PPq3og/credential" --default_role="*" --disallow_sharing_agent_pid_namespace="false" --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="/tmp/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_1_PPq3og/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="/tmp/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_1_PPq3og/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_command_executor="false" --http_credentials="/tmp/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_1_PPq3og/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --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]" --revocable_cpu_low_priority="true" --runtime_dir="/tmp/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_1_PPq3og" --sandbox_directory="/mnt/mesos/sandbox" --strict="true" --switch_user="true" --systemd_enable_support="true" --systemd_runtime_directory="/run/systemd/system" --version="false" --work_dir="/tmp/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_1_7OJU48" --zk_session_timeout="10secs" 3: I1212 19:55:26.132810 17438 scheduler.cpp:188] Version: 1.5.0 3: I1212 19:55:26.132827 17461 credentials.hpp:86] Loading credential for authentication from '/tmp/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_1_PPq3og/credential' 3: I1212 19:55:26.133056 17461 slave.cpp:291] Agent using credential for: test-principal 3: I1212 19:55:26.133081 17461 credentials.hpp:37] Loading credentials for authentication from '/tmp/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_1_PPq3og/http_credentials' 3: I1212 19:55:26.133211 17454 scheduler.cpp:311] Using default 'basic' HTTP authenticatee 3: I1212 19:55:26.133443 17461 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly' 3: I1212 19:55:26.133647 17461 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite' 3: I1212 19:55:26.133728 17445 scheduler.cpp:494] New master detected at [email protected]:42333 3: I1212 19:55:26.133764 17445 scheduler.cpp:503] Waiting for 0ns before initiating a re-(connection) attempt with the master 3: I1212 19:55:26.135707 17461 slave.cpp:590] 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"}] 3: I1212 19:55:26.136014 17461 slave.cpp:598] Agent attributes: [ ] 3: I1212 19:55:26.136029 17461 slave.cpp:607] Agent hostname: 67b98930ca58 3: I1212 19:55:26.136173 17451 task_status_update_manager.cpp:181] Pausing sending task status updates 3: I1212 19:55:26.138533 17443 scheduler.cpp:385] Connected with the master at http://172.17.0.3:42333/master/api/v1/scheduler 3: I1212 19:55:26.138823 17446 state.cpp:66] Recovering state from '/tmp/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_1_7OJU48/meta' 3: I1212 19:55:26.139226 17442 task_status_update_manager.cpp:207] Recovering task status update manager 3: I1212 19:55:26.139673 17445 slave.cpp:6724] Finished recovery 3: I1212 19:55:26.140106 17439 scheduler.cpp:247] Sending SUBSCRIBE call to http://172.17.0.3:42333/master/api/v1/scheduler 3: I1212 19:55:26.140722 17447 task_status_update_manager.cpp:181] Pausing sending task status updates 3: I1212 19:55:26.140728 17462 slave.cpp:1033] New master detected at [email protected]:42333 3: I1212 19:55:26.140898 17462 slave.cpp:1088] Detecting new master 3: I1212 19:55:26.142458 17449 process.cpp:3503] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler' 3: I1212 19:55:26.144439 17448 http.cpp:1185] HTTP POST for /master/api/v1/scheduler from 172.17.0.3:53040 3: I1212 19:55:26.145004 17448 master.cpp:2609] Received subscription request for HTTP framework 'default' 3: I1212 19:55:26.145118 17448 master.cpp:2274] Authorizing framework principal 'test-principal' to receive offers for roles '{ * }' 3: I1212 19:55:26.145941 17458 master.cpp:2744] Subscribing framework 'default' with checkpointing disabled and capabilities [ MULTI_ROLE, RESERVATION_REFINEMENT ] 3: I1212 19:55:26.146241 17458 master.cpp:9141] Adding framework f4d3d47f-46a7-4426-8b55-f48f8ce01a53-0000 (default) with roles { } suppressed 3: I1212 19:55:26.147073 17445 hierarchical.cpp:297] Added framework f4d3d47f-46a7-4426-8b55-f48f8ce01a53-0000 3: I1212 19:55:26.147397 17445 hierarchical.cpp:1517] Performed allocation for 0 agents in 116947ns 3: I1212 19:55:26.148895 17459 scheduler.cpp:739] Enqueuing event SUBSCRIBED received from http://172.17.0.3:42333/master/api/v1/scheduler 3: I1212 19:55:26.149626 17459 scheduler.cpp:739] Enqueuing event HEARTBEAT received from http://172.17.0.3:42333/master/api/v1/scheduler 3: I1212 19:55:26.149713 17442 slave.cpp:1115] Authenticating with master [email protected]:42333 3: I1212 19:55:26.149818 17442 slave.cpp:1124] Using default CRAM-MD5 authenticatee 3: I1212 19:55:26.150228 17453 authenticatee.cpp:121] Creating new client SASL connection 3: I1212 19:55:26.150614 17462 master.cpp:8920] Authenticating slave(838)@172.17.0.3:42333 3: I1212 19:55:26.150768 17458 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(1469)@172.17.0.3:42333 3: I1212 19:55:26.151065 17445 authenticator.cpp:98] Creating new server SASL connection 3: I1212 19:55:26.151403 17461 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5 3: I1212 19:55:26.151445 17461 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5' 3: I1212 19:55:26.151599 17461 authenticator.cpp:204] Received SASL authentication start 3: I1212 19:55:26.151679 17461 authenticator.cpp:326] Authentication requires more steps 3: I1212 19:55:26.151895 17456 authenticatee.cpp:259] Received SASL authentication step 3: I1212 19:55:26.152070 17456 authenticator.cpp:232] Received SASL authentication step 3: I1212 19:55:26.152107 17456 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '67b98930ca58' server FQDN: '67b98930ca58' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false 3: I1212 19:55:26.152122 17456 auxprop.cpp:181] Looking up auxiliary property '*userPassword' 3: I1212 19:55:26.152163 17456 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5' 3: I1212 19:55:26.152187 17456 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '67b98930ca58' server FQDN: '67b98930ca58' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true 3: I1212 19:55:26.152199 17456 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true 3: I1212 19:55:26.152206 17456 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true 3: I1212 19:55:26.152225 17456 authenticator.cpp:318] Authentication success 3: I1212 19:55:26.152330 17443 authenticatee.cpp:299] Authentication success 3: I1212 19:55:26.152483 17446 master.cpp:8950] Successfully authenticated principal 'test-principal' at slave(838)@172.17.0.3:42333 3: I1212 19:55:26.152530 17441 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(1469)@172.17.0.3:42333 3: I1212 19:55:26.152808 17457 slave.cpp:1207] Successfully authenticated with master [email protected]:42333 3: I1212 19:55:26.153076 17457 slave.cpp:1684] Will retry registration in 8.893706ms if necessary 3: I1212 19:55:26.153343 17440 master.cpp:6077] Received register agent message from slave(838)@172.17.0.3:42333 (67b98930ca58) 3: I1212 19:55:26.153463 17440 master.cpp:3866] Authorizing agent with principal 'test-principal' 3: I1212 19:55:26.153949 17459 master.cpp:6147] Authorized registration of agent at slave(838)@172.17.0.3:42333 (67b98930ca58) 3: I1212 19:55:26.154052 17459 master.cpp:6240] Registering agent at slave(838)@172.17.0.3:42333 (67b98930ca58) with id f4d3d47f-46a7-4426-8b55-f48f8ce01a53-S0 3: I1212 19:55:26.154664 17442 registrar.cpp:495] Applied 1 operations in 110711ns; attempting to update the registry 3: I1212 19:55:26.155400 17442 registrar.cpp:552] Successfully updated the registry in 663040ns 3: I1212 19:55:26.155596 17453 master.cpp:6288] Admitted agent f4d3d47f-46a7-4426-8b55-f48f8ce01a53-S0 at slave(838)@172.17.0.3:42333 (67b98930ca58) 3: I1212 19:55:26.156483 17453 master.cpp:6337] Registered agent f4d3d47f-46a7-4426-8b55-f48f8ce01a53-S0 at slave(838)@172.17.0.3:42333 (67b98930ca58) with cpus:2; mem:1024; disk:1024; ports:[31000-32000] 3: I1212 19:55:26.156533 17458 slave.cpp:1253] Registered with master [email protected]:42333; given agent ID f4d3d47f-46a7-4426-8b55-f48f8ce01a53-S0 3: I1212 19:55:26.156689 17461 task_status_update_manager.cpp:188] Resuming sending task status updates 3: I1212 19:55:26.156901 17458 slave.cpp:1273] Checkpointing SlaveInfo to '/tmp/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_1_7OJU48/meta/slaves/f4d3d47f-46a7-4426-8b55-f48f8ce01a53-S0/slave.info' 3: I1212 19:55:26.157004 17445 hierarchical.cpp:574] Added agent f4d3d47f-46a7-4426-8b55-f48f8ce01a53-S0 (67b98930ca58) with cpus:2; mem:1024; disk:1024; ports:[31000-32000] (allocated: {}) 3: I1212 19:55:26.157582 17458 slave.cpp:1330] Forwarding agent update {"offer_operations":{},"resource_categories":{"oversubscribed":true},"resource_version_uuid":"GtatsaGLSPO3EUS0tLpwgA==","slave_id":{"value":"f4d3d47f-46a7-4426-8b55-f48f8ce01a53-S0"}} 3: I1212 19:55:26.157888 17443 master.cpp:7270] Received update of agent f4d3d47f-46a7-4426-8b55-f48f8ce01a53-S0 at slave(838)@172.17.0.3:42333 (67b98930ca58) with total oversubscribed resources {} 3: I1212 19:55:26.158217 17443 master.cpp:7368] Ignoring update on agent f4d3d47f-46a7-4426-8b55-f48f8ce01a53-S0 at slave(838)@172.17.0.3:42333 (67b98930ca58) as it reports no changes 3: I1212 19:55:26.159164 17445 hierarchical.cpp:1517] Performed allocation for 1 agents in 1.87915ms 3: I1212 19:55:26.159708 17451 master.cpp:8750] Sending 1 offers to framework f4d3d47f-46a7-4426-8b55-f48f8ce01a53-0000 (default) 3: I1212 19:55:26.164085 17450 scheduler.cpp:739] Enqueuing event OFFERS received from http://172.17.0.3:42333/master/api/v1/scheduler 3: I1212 19:55:26.166565 17454 scheduler.cpp:247] Sending ACCEPT call to http://172.17.0.3:42333/master/api/v1/scheduler 3: I1212 19:55:26.169705 17460 process.cpp:3503] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler' 3: I1212 19:55:26.171653 17446 http.cpp:1185] HTTP POST for /master/api/v1/scheduler from 172.17.0.3:53038 3: I1212 19:55:26.174357 17446 master.cpp:10671] Removing offer f4d3d47f-46a7-4426-8b55-f48f8ce01a53-O0 3: I1212 19:55:26.174553 17446 master.cpp:4273] Processing ACCEPT call for offers: [ f4d3d47f-46a7-4426-8b55-f48f8ce01a53-O0 ] on agent f4d3d47f-46a7-4426-8b55-f48f8ce01a53-S0 at slave(838)@172.17.0.3:42333 (67b98930ca58) for framework f4d3d47f-46a7-4426-8b55-f48f8ce01a53-0000 (default) 3: I1212 19:55:26.174674 17446 master.cpp:3593] Authorizing framework principal 'test-principal' to launch task 9a3124bf-5b2d-4fde-99f1-b7a88391f817 3: W1212 19:55:26.177340 17450 validation.cpp:1387] Executor 'default' for task '9a3124bf-5b2d-4fde-99f1-b7a88391f817' uses less CPUs (None) than the minimum required (0.01). Please update your executor, as this will be mandatory in future releases. 3: W1212 19:55:26.177378 17450 validation.cpp:1399] Executor 'default' for task '9a3124bf-5b2d-4fde-99f1-b7a88391f817' uses less memory (None) than the minimum required (32MB). Please update your executor, as this will be mandatory in future releases. 3: I1212 19:55:26.177963 17450 master.cpp:11426] Adding task 9a3124bf-5b2d-4fde-99f1-b7a88391f817 with resources cpus(allocated: *):2; mem(allocated: *):1024; disk(allocated: *):1024; ports(allocated: *):[31000-32000] on agent f4d3d47f-46a7-4426-8b55-f48f8ce01a53-S0 at slave(838)@172.17.0.3:42333 (67b98930ca58) 3: I1212 19:55:26.178360 17450 master.cpp:5024] Launching task 9a3124bf-5b2d-4fde-99f1-b7a88391f817 of framework f4d3d47f-46a7-4426-8b55-f48f8ce01a53-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 f4d3d47f-46a7-4426-8b55-f48f8ce01a53-S0 at slave(838)@172.17.0.3:42333 (67b98930ca58) 3: I1212 19:55:26.179255 17439 slave.cpp:1807] Got assigned task '9a3124bf-5b2d-4fde-99f1-b7a88391f817' for framework f4d3d47f-46a7-4426-8b55-f48f8ce01a53-0000 3: I1212 19:55:26.179993 17439 slave.cpp:2077] Authorizing task '9a3124bf-5b2d-4fde-99f1-b7a88391f817' for framework f4d3d47f-46a7-4426-8b55-f48f8ce01a53-0000 3: I1212 19:55:26.180059 17439 slave.cpp:7732] Authorizing framework principal 'test-principal' to launch task 9a3124bf-5b2d-4fde-99f1-b7a88391f817 3: I1212 19:55:26.181284 17454 slave.cpp:2471] Launching task '9a3124bf-5b2d-4fde-99f1-b7a88391f817' for framework f4d3d47f-46a7-4426-8b55-f48f8ce01a53-0000 3: I1212 19:55:26.181886 17454 paths.cpp:702] Trying to chown '/tmp/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_1_7OJU48/slaves/f4d3d47f-46a7-4426-8b55-f48f8ce01a53-S0/frameworks/f4d3d47f-46a7-4426-8b55-f48f8ce01a53-0000/executors/default/runs/0c357412-4464-47bd-9b3c-89b8989e0317' to user 'mesos' 3: I1212 19:55:26.182157 17454 slave.cpp:8206] Launching executor 'default' of framework f4d3d47f-46a7-4426-8b55-f48f8ce01a53-0000 with resources [] in work directory '/tmp/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_1_7OJU48/slaves/f4d3d47f-46a7-4426-8b55-f48f8ce01a53-S0/frameworks/f4d3d47f-46a7-4426-8b55-f48f8ce01a53-0000/executors/default/runs/0c357412-4464-47bd-9b3c-89b8989e0317' 3: I1212 19:55:26.182802 17454 slave.cpp:3023] Launching container 0c357412-4464-47bd-9b3c-89b8989e0317 for executor 'default' of framework f4d3d47f-46a7-4426-8b55-f48f8ce01a53-0000 3: I1212 19:55:26.183418 17454 slave.cpp:2557] Queued task '9a3124bf-5b2d-4fde-99f1-b7a88391f817' for executor 'default' of framework f4d3d47f-46a7-4426-8b55-f48f8ce01a53-0000 3: I1212 19:55:26.183538 17454 slave.cpp:984] Successfully attached '/tmp/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_1_7OJU48/slaves/f4d3d47f-46a7-4426-8b55-f48f8ce01a53-S0/frameworks/f4d3d47f-46a7-4426-8b55-f48f8ce01a53-0000/executors/default/runs/0c357412-4464-47bd-9b3c-89b8989e0317' to virtual path '/tmp/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_1_7OJU48/slaves/f4d3d47f-46a7-4426-8b55-f48f8ce01a53-S0/frameworks/f4d3d47f-46a7-4426-8b55-f48f8ce01a53-0000/executors/default/runs/latest' 3: I1212 19:55:26.183593 17454 slave.cpp:984] Successfully attached '/tmp/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_1_7OJU48/slaves/f4d3d47f-46a7-4426-8b55-f48f8ce01a53-S0/frameworks/f4d3d47f-46a7-4426-8b55-f48f8ce01a53-0000/executors/default/runs/0c357412-4464-47bd-9b3c-89b8989e0317' to virtual path '/frameworks/f4d3d47f-46a7-4426-8b55-f48f8ce01a53-0000/executors/default/runs/latest' 3: I1212 19:55:26.183636 17454 slave.cpp:984] Successfully attached '/tmp/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_1_7OJU48/slaves/f4d3d47f-46a7-4426-8b55-f48f8ce01a53-S0/frameworks/f4d3d47f-46a7-4426-8b55-f48f8ce01a53-0000/executors/default/runs/0c357412-4464-47bd-9b3c-89b8989e0317' to virtual path '/tmp/ContentTypeAndSSLConfig_SchedulerSSLTest_RunTaskAndTeardown_1_7OJU48/slaves/f4d3d47f-46a7-4426-8b55-f48f8ce01a53-S0/frameworks/f4d3d47f-46a7-4426-8b55-f48f8ce01a53-0000/executors/default/runs/0c357412-4464-47bd-9b3c-89b8989e0317' 3: I1212 19:55:26.186702 17453 executor.cpp:192] Version: 1.5.0 3: W1212 19:55:26.186769 17453 process.cpp:2756] Attempted to spawn already running process [email protected]:42333 3: I1212 19:55:26.189206 17449 executor.cpp:410] Connected with the agent 3: I1212 19:55:26.190042 17452 executor.cpp:307] Sending SUBSCRIBE call to http://172.17.0.3:42333/slave(838)/api/v1/executor 3: I1212 19:55:26.190865 17450 process.cpp:3503] Handling HTTP event for process 'slave(838)' with path: '/slave(838)/api/v1/executor' 3: I1212 19:55:26.192961 17455 http.cpp:1185] HTTP POST for /slave(838)/api/v1/executor from 172.17.0.3:53042 3: I1212 19:55:26.193287 17455 slave.cpp:4074] Received Subscribe request for HTTP executor 'default' of framework f4d3d47f-46a7-4426-8b55-f48f8ce01a53-0000 3: I1212 19:55:26.194840 17461 slave.cpp:2762] Sending queued task '9a3124bf-5b2d-4fde-99f1-b7a88391f817' to executor 'default' of framework f4d3d47f-46a7-4426-8b55-f48f8ce01a53-0000 (via HTTP) 3: I1212 19:55:26.196208 17446 executor.cpp:725] Enqueuing event SUBSCRIBED received from http://172.17.0.3:42333/slave(838)/api/v1/executor 3: I1212 19:55:26.196907 17446 executor.cpp:725] Enqueuing event LAUNCH received from http://172.17.0.3:42333/slave(838)/api/v1/executor 3: I1212 19:55:26.197692 17447 executor.cpp:307] Sending UPDATE call to http://172.17.0.3:42333/slave(838)/api/v1/executor 3: I1212 19:55:26.198480 17442 process.cpp:3503] Handling HTTP event for process 'slave(838)' with path: '/slave(838)/api/v1/executor' 3: I1212 19:55:26.199594 17458 http.cpp:1185] HTTP POST for /slave(838)/api/v1/executor from 172.17.0.3:53044 3: I1212 19:55:26.199757 17458 slave.cpp:4732] Handling status update TASK_RUNNING (Status UUID: 65bb94f2-78f4-44cc-b3b2-ce2f532afe49) for task 9a3124bf-5b2d-4fde-99f1-b7a88391f817 of framework f4d3d47f-46a7-4426-8b55-f48f8ce01a53-0000 3: I1212 19:55:26.200423 17461 task_status_update_manager.cpp:328] Received task status update TASK_RUNNING (Status UUID: 65bb94f2-78f4-44cc-b3b2-ce2f532afe49) for task 9a3124bf-5b2d-4fde-99f1-b7a88391f817 of framework f4d3d47f-46a7-4426-8b55-f48f8ce01a53-0000 3: I1212 19:55:26.200462 17461 task_status_update_manager.cpp:507] Creating StatusUpdate stream for task 9a3124bf-5b2d-4fde-99f1-b7a88391f817 of framework f4d3d47f-46a7-4426-8b55-f48f8ce01a53-0000 3: I1212 19:55:26.200861 17461 task_status_update_manager.cpp:383] Forwarding task status update TASK_RUNNING (Status UUID: 65bb94f2-78f4-44cc-b3b2-ce2f532afe49) for task 9a3124bf-5b2d-4fde-99f1-b7a88391f817 of framework f4d3d47f-46a7-4426-8b55-f48f8ce01a53-0000 to the agent 3: I1212 19:55:26.201086 17451 slave.cpp:5215] Forwarding the update TASK_RUNNING (Status UUID: 65bb94f2-78f4-44cc-b3b2-ce2f532afe49) for task 9a3124bf-5b2d-4fde-99f1-b7a88391f817 of framework f4d3d47f-46a7-4426-8b55-f48f8ce01a53-0000 to [email protected]:42333 3: I1212 19:55:26.201357 17451 slave.cpp:5108] Task status update manager successfully handled status update TASK_RUNNING (Status UUID: 65bb94f2-78f4-44cc-b3b2-ce2f532afe49) for task 9a3124bf-5b2d-4fde-99f1-b7a88391f817 of framework f4d3d47f-46a7-4426-8b55-f48f8ce01a53-0000 3: I1212 19:55:26.201498 17448 master.cpp:7843] Status update TASK_RUNNING (Status UUID: 65bb94f2-78f4-44cc-b3b2-ce2f532afe49) for task 9a3124bf-5b2d-4fde-99f1-b7a88391f817 of framework f4d3d47f-46a7-4426-8b55-f48f8ce01a53-0000 from agent f4d3d47f-46a7-4426-8b55-f48f8ce01a53-S0 at slave(838)@172.17.0.3:42333 (67b98930ca58) 3: I1212 19:55:26.201552 17448 master.cpp:7899] Forwarding status update TASK_RUNNING (Status UUID: 65bb94f2-78f4-44cc-b3b2-ce2f532afe49) for task 9a3124bf-5b2d-4fde-99f1-b7a88391f817 of framework f4d3d47f-46a7-4426-8b55-f48f8ce01a53-0000 3: I1212 19:55:26.202139 17457 executor.cpp:725] Enqueuing event ACKNOWLEDGED received from http://172.17.0.3:42333/slave(838)/api/v1/executor 3: I1212 19:55:26.202284 17448 master.cpp:10146] Updating the state of task 9a3124bf-5b2d-4fde-99f1-b7a88391f817 of framework f4d3d47f-46a7-4426-8b55-f48f8ce01a53-0000 (latest state: TASK_RUNNING, status update state: TASK_RUNNING) 3: I1212 19:55:26.203450 17453 scheduler.cpp:739] Enqueuing event UPDATE received from http://172.17.0.3:42333/master/api/v1/scheduler 3: I1212 19:55:26.204439 17459 scheduler.cpp:247] Sending TEARDOWN call to http://172.17.0.3:42333/master/api/v1/scheduler 3: I1212 19:55:26.205754 17444 process.cpp:3503] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler' 3: I1212 19:55:26.243219 17454 http.cpp:1185] HTTP POST for /master/api/v1/scheduler from 172.17.0.3:53038 3: I1212 19:55:26.243391 17454 master.cpp:9442] Removing framework f4d3d47f-46a7-4426-8b55-f48f8ce01a53-0000 (default) 3: I1212 19:55:26.243412 17454 master.cpp:3327] Deactivating framework f4d3d47f-46a7-4426-8b55-f48f8ce01a53-0000 (default) 3: I1212 19:55:26.243535 17447 hierarchical.cpp:405] Deactivated framework f4d3d47f-46a7-4426-8b55-f48f8ce01a53-0000 3: I1212 19:55:26.243590 17460 slave.cpp:3375] Asked to shut down framework f4d3d47f-46a7-4426-8b55-f48f8ce01a53-0000 by [email protected]:42333 3: I1212 19:55:26.243607 17454 master.cpp:10146] Updating the state of task 9a3124bf-5b2d-4fde-99f1-b7a88391f817 of framework f4d3d47f-46a7-4426-8b55-f48f8ce01a53-0000 (latest state: TASK_KILLED, status update state: TASK_KILLED) 3: I1212 19:55:26.243621 17460 slave.cpp:3400] Shutting down framework f4d3d47f-46a7-4426-8b55-f48f8ce01a53-0000 3: I1212 19:55:26.243654 17460 slave.cpp:6091] Shutting down executor 'default' of framework f4d3d47f-46a7-4426-8b55-f48f8ce01a53-0000 (via HTTP) 3: I1212 19:55:26.244374 17461 executor.cpp:725] Enqueuing event SHUTDOWN received from http://172.17.0.3:42333/slave(838)/api/v1/executor 3: I1212 19:55:26.244460 17454 master.cpp:10252] Removing task 9a3124bf-5b2d-4fde-99f1-b7a88391f817 with resources cpus(allocated: *):2; mem(allocated: *):1024; disk(allocated: *):1024; ports(allocated: *):[31000-32000] of framework f4d3d47f-46a7-4426-8b55-f48f8ce01a53-0000 on agent f4d3d47f-46a7-4426-8b55-f48f8ce01a53-S0 at slave(838)@172.17.0.3:42333 (67b98930ca58) 3: I1212 19:55:26.244730 17454 master.cpp:10281] Removing executor 'default' with resources [] of framework f4d3d47f-46a7-4426-8b55-f48f8ce01a53-0000 on agent f4d3d47f-46a7-4426-8b55-f48f8ce01a53-S0 at slave(838)@172.17.0.3:42333 (67b98930ca58) 3: I1212 19:55:26.244729 17453 hierarchical.cpp:1192] Recovered cpus(allocated: *):2; mem(allocated: *):1024; disk(allocated: *):1024; ports(allocated: *):[31000-32000] (total: cpus:2; mem:1024; disk:1024; ports:[31000-32000], allocated: {}) on agent f4d3d47f-46a7-4426-8b55-f48f8ce01a53-S0 from framework f4d3d47f-46a7-4426-8b55-f48f8ce01a53-0000 3: I1212 19:55:26.245607 17446 hierarchical.cpp:344] Removed framework f4d3d47f-46a7-4426-8b55-f48f8ce01a53-0000 3: E1212 19:55:26.245729 17460 scheduler.cpp:712] End-Of-File received from master. The master closed the event stream 3: I1212 19:55:26.246417 17443 scheduler.cpp:468] Re-detecting master 3: I1212 19:55:26.247126 17443 scheduler.cpp:419] Ignoring disconnection attempt from stale connection 3: I1212 19:55:26.247375 17443 scheduler.cpp:494] New master detected at [email protected]:42333 3: I1212 19:55:26.247421 17443 scheduler.cpp:503] Waiting for 0ns before initiating a re-(connection) attempt with the master 3: I1212 19:55:26.250041 17438 slave.cpp:909] Agent terminating 3: I1212 19:55:26.250128 17438 slave.cpp:3375] Asked to shut down framework f4d3d47f-46a7-4426-8b55-f48f8ce01a53-0000 by @0.0.0.0:0 3: W1212 19:55:26.250166 17438 slave.cpp:3396] Ignoring shutdown framework f4d3d47f-46a7-4426-8b55-f48f8ce01a53-0000 because it is terminating 3: I1212 19:55:26.250442 17453 master.cpp:1305] Agent f4d3d47f-46a7-4426-8b55-f48f8ce01a53-S0 at slave(838)@172.17.0.3:42333 (67b98930ca58) disconnected 3: I1212 19:55:26.250486 17453 master.cpp:3364] Disconnecting agent f4d3d47f-46a7-4426-8b55-f48f8ce01a53-S0 at slave(838)@172.17.0.3:42333 (67b98930ca58) 3: I1212 19:55:26.250562 17453 master.cpp:3383] Deactivating agent f4d3d47f-46a7-4426-8b55-f48f8ce01a53-S0 at slave(838)@172.17.0.3:42333 (67b98930ca58) 3: I1212 19:55:26.250699 17450 hierarchical.cpp:766] Agent f4d3d47f-46a7-4426-8b55-f48f8ce01a53-S0 deactivated 3: I1212 19:55:26.259032 17438 master.cpp:1147] Master terminating 3: I1212 19:55:26.260058 17462 hierarchical.cpp:609] Removed agent f4d3d47f-46a7-4426-8b55-f48f8ce01a53-S0 3: W1212 19:55:26.261607 17438 master.hpp:2728] Failed to close HTTP pipe for f4d3d47f-46a7-4426-8b55-f48f8ce01a53-0000 (default) 3: [ OK ] ContentTypeAndSSLConfig/SchedulerSSLTest.RunTaskAndTeardown/1 (159 ms) 3: [----------] 2 tests from ContentTypeAndSSLConfig/SchedulerSSLTest (310 ms total) 3: 3: [----------] 9 tests from Endpoint/SlaveEndpointTest 3: [ RUN ] Endpoint/SlaveEndpointTest.AuthorizedRequest/0 3: I1212 19:55:26.275012 17438 containerizer.cpp:304] Using isolation { environment_secret, posix/cpu, posix/mem, filesystem/posix, network/cni } 3: W1212 19:55:26.275836 17438 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges 3: W1212 19:55:26.276026 17438 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges 3: I1212 19:55:26.276072 17438 provisioner.cpp:299] Using default backend 'copy' 3: I1212 19:55:26.282908 17457 slave.cpp:258] Mesos agent started on (839)@172.17.0.3:42333 3: I1212 19:55:26.282934 17457 slave.cpp:259] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://"; --appc_store_dir="/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_0_vPsf7R/store/appc" --authenticate_http_readonly="true" --authenticate_http_readwrite="true" --authenticatee="crammd5" --authentication_backoff_factor="1secs" --authorizer="local" --cgroups_cpu_enable_pids_and_tids_count="false" --cgroups_enable_cfs="false" --cgroups_hierarchy="/sys/fs/cgroup" --cgroups_limit_swap="false" --cgroups_root="mesos" --container_disk_watch_interval="15secs" --containerizers="mesos" --credential="/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_0_vPsf7R/credential" --default_role="*" --disallow_sharing_agent_pid_namespace="false" --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="/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_0_vPsf7R/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="/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_0_vPsf7R/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_command_executor="false" --http_credentials="/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_0_vPsf7R/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --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]" --revocable_cpu_low_priority="true" --runtime_dir="/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_0_vPsf7R" --sandbox_directory="/mnt/mesos/sandbox" --strict="true" --switch_user="true" --systemd_enable_support="true" --systemd_runtime_directory="/run/systemd/system" --version="false" --work_dir="/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_0_q3sBsK" --zk_session_timeout="10secs" 3: I1212 19:55:26.283552 17457 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_0_vPsf7R/credential' 3: I1212 19:55:26.283772 17457 slave.cpp:291] Agent using credential for: test-principal 3: I1212 19:55:26.283799 17457 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_0_vPsf7R/http_credentials' 3: I1212 19:55:26.284139 17457 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly' 3: I1212 19:55:26.284375 17457 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite' 3: I1212 19:55:26.286703 17457 slave.cpp:590] 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"}] 3: I1212 19:55:26.287050 17457 slave.cpp:598] Agent attributes: [ ] 3: I1212 19:55:26.287068 17457 slave.cpp:607] Agent hostname: 67b98930ca58 3: I1212 19:55:26.287277 17441 task_status_update_manager.cpp:181] Pausing sending task status updates 3: I1212 19:55:26.289669 17443 state.cpp:66] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_0_q3sBsK/meta' 3: I1212 19:55:26.290143 17448 task_status_update_manager.cpp:207] Recovering task status update manager 3: I1212 19:55:26.290467 17455 containerizer.cpp:674] Recovering containerizer 3: I1212 19:55:26.292662 17462 provisioner.cpp:495] Provisioner recovery complete 3: I1212 19:55:26.293177 17441 slave.cpp:6724] Finished recovery 3: I1212 19:55:26.296844 17447 process.cpp:3503] Handling HTTP event for process 'slave(839)' with path: '/slave(839)/monitor/statistics' 3: I1212 19:55:26.299216 17446 http.cpp:1185] HTTP GET for /slave(839)/monitor/statistics from 172.17.0.3:53046 3: I1212 19:55:26.299335 17446 http.cpp:976] Authorizing principal 'test-principal' to GET the '/monitor/statistics' endpoint 3: I1212 19:55:26.303511 17438 slave.cpp:909] Agent terminating 3: [ OK ] Endpoint/SlaveEndpointTest.AuthorizedRequest/0 (46 ms) 3: [ RUN ] Endpoint/SlaveEndpointTest.AuthorizedRequest/1 3: I1212 19:55:26.321640 17438 containerizer.cpp:304] Using isolation { environment_secret, posix/cpu, posix/mem, filesystem/posix, network/cni } 3: W1212 19:55:26.322327 17438 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges 3: W1212 19:55:26.322479 17438 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges 3: I1212 19:55:26.322520 17438 provisioner.cpp:299] Using default backend 'copy' 3: I1212 19:55:26.328274 17458 slave.cpp:258] Mesos agent started on (840)@172.17.0.3:42333 3: I1212 19:55:26.328308 17458 slave.cpp:259] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://"; --appc_store_dir="/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_1_TnjL6m/store/appc" --authenticate_http_readonly="true" --authenticate_http_readwrite="true" --authenticatee="crammd5" --authentication_backoff_factor="1secs" --authorizer="local" --cgroups_cpu_enable_pids_and_tids_count="false" --cgroups_enable_cfs="false" --cgroups_hierarchy="/sys/fs/cgroup" --cgroups_limit_swap="false" --cgroups_root="mesos" --container_disk_watch_interval="15secs" --containerizers="mesos" --credential="/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_1_TnjL6m/credential" --default_role="*" --disallow_sharing_agent_pid_namespace="false" --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="/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_1_TnjL6m/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="/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_1_TnjL6m/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_command_executor="false" --http_credentials="/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_1_TnjL6m/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --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]" --revocable_cpu_low_priority="true" --runtime_dir="/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_1_TnjL6m" --sandbox_directory="/mnt/mesos/sandbox" --strict="true" --switch_user="true" --systemd_enable_support="true" --systemd_runtime_directory="/run/systemd/system" --version="false" --work_dir="/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_1_nFdqlf" --zk_session_timeout="10secs" 3: I1212 19:55:26.328985 17458 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_1_TnjL6m/credential' 3: I1212 19:55:26.329277 17458 slave.cpp:291] Agent using credential for: test-principal 3: I1212 19:55:26.329304 17458 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_1_TnjL6m/http_credentials' 3: I1212 19:55:26.329654 17458 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly' 3: I1212 19:55:26.329887 17458 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite' 3: I1212 19:55:26.332217 17458 slave.cpp:590] 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"}] 3: I1212 19:55:26.332566 17458 slave.cpp:598] Agent attributes: [ ] 3: I1212 19:55:26.332579 17458 slave.cpp:607] Agent hostname: 67b98930ca58 3: I1212 19:55:26.332775 17443 task_status_update_manager.cpp:181] Pausing sending task status updates 3: I1212 19:55:26.335161 17452 state.cpp:66] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_1_nFdqlf/meta' 3: I1212 19:55:26.335665 17439 task_status_update_manager.cpp:207] Recovering task status update manager 3: I1212 19:55:26.335986 17454 containerizer.cpp:674] Recovering containerizer 3: I1212 19:55:26.338212 17459 provisioner.cpp:495] Provisioner recovery complete 3: I1212 19:55:26.338763 17443 slave.cpp:6724] Finished recovery 3: I1212 19:55:26.342353 17444 process.cpp:3503] Handling HTTP event for process 'slave(840)' with path: '/slave(840)/monitor/statistics.json' 3: I1212 19:55:26.344283 17447 http.cpp:1185] HTTP GET for /slave(840)/monitor/statistics.json from 172.17.0.3:53048 3: I1212 19:55:26.344478 17447 http.cpp:976] Authorizing principal 'test-principal' to GET the '/monitor/statistics.json' endpoint 3: I1212 19:55:26.347748 17438 slave.cpp:909] Agent terminating 3: [ OK ] Endpoint/SlaveEndpointTest.AuthorizedRequest/1 (46 ms) 3: [ RUN ] Endpoint/SlaveEndpointTest.AuthorizedRequest/2 3: I1212 19:55:26.368608 17438 containerizer.cpp:304] Using isolation { environment_secret, posix/cpu, posix/mem, filesystem/posix, network/cni } 3: W1212 19:55:26.369403 17438 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges 3: W1212 19:55:26.369570 17438 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges 3: I1212 19:55:26.369613 17438 provisioner.cpp:299] Using default backend 'copy' 3: I1212 19:55:26.376046 17446 slave.cpp:258] Mesos agent started on (841)@172.17.0.3:42333 write /dev/stdout: resource temporarily unavailable + docker rmi mesos-1513105354-18423 Error response from daemon: conflict: unable to remove repository reference "mesos-1513105354-18423" (must force) - container 67b98930ca58 is using its referenced image 6131c0e5e212 Build step 'Execute shell' marked build as failure Not sending mail to unregistered user [email protected] Not sending mail to unregistered user [email protected] Not sending mail to unregistered user [email protected]
