You are viewing a plain text version of this content. The canonical link for it is here.
Posted to builds@mesos.apache.org by Apache Jenkins Server <je...@builds.apache.org> on 2017/09/05 16:43:13 UTC

Build failed in Jenkins: Mesos-Reviewbot #19208

See <https://builds.apache.org/job/Mesos-Reviewbot/19208/display/redirect>

------------------------------------------
[...truncated 22.37 MB...]
I0905 16:43:07.101840  5818 slave.cpp:253] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/SlaveTest_ContainersEndpointNoExecutor_gCMyXD/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/SlaveTest_ContainersEndpointNoExecutor_gCMyXD/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/SlaveTest_ContainersEndpointNoExecutor_gCMyXD/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/SlaveTest_ContainersEndpointNoExecutor_gCMyXD/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/SlaveTest_ContainersEndpointNoExecutor_gCMyXD/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.5.0/_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" --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/SlaveTest_ContainersEndpointNoExecutor_gCMyXD" --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/SlaveTest_ContainersEndpointNoExecutor_Vpq8fh" --zk_session_timeout="10secs"
I0905 16:43:07.102365  5818 credentials.hpp:86] Loading credential for authentication from '/tmp/SlaveTest_ContainersEndpointNoExecutor_gCMyXD/credential'
I0905 16:43:07.102588  5818 slave.cpp:285] Agent using credential for: test-principal
I0905 16:43:07.102628  5818 credentials.hpp:37] Loading credentials for authentication from '/tmp/SlaveTest_ContainersEndpointNoExecutor_gCMyXD/http_credentials'
I0905 16:43:07.102989  5818 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0905 16:43:07.103219  5818 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0905 16:43:07.105248  5818 slave.cpp:581] 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"}]
I0905 16:43:07.105592  5818 slave.cpp:589] Agent attributes: [  ]
I0905 16:43:07.105625  5818 slave.cpp:598] Agent hostname: e17d3ee52427
I0905 16:43:07.105857  5815 status_update_manager.cpp:177] Pausing sending status updates
I0905 16:43:07.108022  5798 state.cpp:64] Recovering state from '/tmp/SlaveTest_ContainersEndpointNoExecutor_Vpq8fh/meta'
I0905 16:43:07.108038  5818 process.cpp:3954] Handling HTTP event for process 'slave(531)' with path: '/slave(531)/containers'
I0905 16:43:07.109066  5801 status_update_manager.cpp:203] Recovering status update manager
I0905 16:43:07.109654  5816 containerizer.cpp:646] Recovering containerizer
I0905 16:43:07.110489  5815 http.cpp:1185] HTTP GET for /slave(531)/containers from 172.17.0.7:57950
I0905 16:43:07.110590  5815 http.cpp:976] Authorizing principal 'test-principal' to GET the '/containers' endpoint
I0905 16:43:07.111747  5818 provisioner.cpp:416] Provisioner recovery complete
I0905 16:43:07.113023  5817 slave.cpp:6296] Finished recovery
I0905 16:43:07.113705  5817 slave.cpp:6478] Querying resource estimator for oversubscribable resources
I0905 16:43:07.114111  5796 status_update_manager.cpp:177] Pausing sending status updates
I0905 16:43:07.114199  5812 slave.cpp:987] New master detected at master@172.17.0.7:44013
I0905 16:43:07.114378  5812 slave.cpp:1022] Detecting new master
I0905 16:43:07.114564  5812 slave.cpp:6492] Received oversubscribable resources {} from the resource estimator
I0905 16:43:07.116308  5777 slave.cpp:859] Agent terminating
I0905 16:43:07.124044  5777 master.cpp:1163] Master terminating
[       OK ] SlaveTest.ContainersEndpointNoExecutor (61 ms)
[ RUN      ] SlaveTest.ContainersEndpoint
I0905 16:43:07.131194  5777 cluster.cpp:162] Creating default 'local' authorizer
I0905 16:43:07.134443  5813 master.cpp:445] Master 26df403f-bd4f-4795-b22d-0ea3493b38f1 (e17d3ee52427) started on 172.17.0.7:44013
I0905 16:43:07.134472  5813 master.cpp:447] 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/fISmvn/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="/mesos/mesos-1.5.0/_inst/share/mesos/webui" --work_dir="/tmp/fISmvn/master" --zk_session_timeout="10secs"
I0905 16:43:07.134872  5813 master.cpp:497] Master only allowing authenticated frameworks to register
I0905 16:43:07.134886  5813 master.cpp:511] Master only allowing authenticated agents to register
I0905 16:43:07.134894  5813 master.cpp:524] Master only allowing authenticated HTTP frameworks to register
I0905 16:43:07.134907  5813 credentials.hpp:37] Loading credentials for authentication from '/tmp/fISmvn/credentials'
I0905 16:43:07.135274  5813 master.cpp:569] Using default 'crammd5' authenticator
I0905 16:43:07.135459  5813 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readonly'
I0905 16:43:07.135691  5813 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readwrite'
I0905 16:43:07.135877  5813 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-master-scheduler'
I0905 16:43:07.136060  5813 master.cpp:649] Authorization enabled
I0905 16:43:07.136270  5797 hierarchical.cpp:171] Initialized hierarchical allocator process
I0905 16:43:07.136276  5802 whitelist_watcher.cpp:77] No whitelist given
I0905 16:43:07.139735  5813 master.cpp:2166] Elected as the leading master!
I0905 16:43:07.139775  5813 master.cpp:1705] Recovering from registrar
I0905 16:43:07.139919  5815 registrar.cpp:347] Recovering registrar
I0905 16:43:07.140602  5815 registrar.cpp:391] Successfully fetched the registry (0B) in 617984ns
I0905 16:43:07.140743  5815 registrar.cpp:495] Applied 1 operations in 42767ns; attempting to update the registry
I0905 16:43:07.141439  5815 registrar.cpp:552] Successfully updated the registry in 614144ns
I0905 16:43:07.141578  5815 registrar.cpp:424] Successfully recovered registrar
I0905 16:43:07.142093  5804 master.cpp:1804] Recovered 0 agents from the registry (129B); allowing 10mins for agents to re-register
I0905 16:43:07.142119  5797 hierarchical.cpp:209] Skipping recovery of hierarchical allocator: nothing to recover
W0905 16:43:07.147248  5777 process.cpp:3238] Attempted to spawn already running process files@172.17.0.7:44013
I0905 16:43:07.147609  5777 cluster.cpp:448] Creating default 'local' authorizer
I0905 16:43:07.149945  5819 slave.cpp:252] Mesos agent started on (532)@172.17.0.7:44013
I0905 16:43:07.149986  5819 slave.cpp:253] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/SlaveTest_ContainersEndpoint_9RSia7/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/SlaveTest_ContainersEndpoint_9RSia7/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/SlaveTest_ContainersEndpoint_9RSia7/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/SlaveTest_ContainersEndpoint_9RSia7/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/SlaveTest_ContainersEndpoint_9RSia7/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.5.0/_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" --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/SlaveTest_ContainersEndpoint_9RSia7" --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/SlaveTest_ContainersEndpoint_yWrPkK" --zk_session_timeout="10secs"
I0905 16:43:07.150439  5819 credentials.hpp:86] Loading credential for authentication from '/tmp/SlaveTest_ContainersEndpoint_9RSia7/credential'
W0905 16:43:07.150552  5777 process.cpp:3238] Attempted to spawn already running process version@172.17.0.7:44013
I0905 16:43:07.150615  5819 slave.cpp:285] Agent using credential for: test-principal
I0905 16:43:07.150640  5819 credentials.hpp:37] Loading credentials for authentication from '/tmp/SlaveTest_ContainersEndpoint_9RSia7/http_credentials'
I0905 16:43:07.150950  5819 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0905 16:43:07.151151  5819 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0905 16:43:07.151705  5777 sched.cpp:232] Version: 1.5.0
I0905 16:43:07.152235  5797 sched.cpp:336] New master detected at master@172.17.0.7:44013
I0905 16:43:07.152353  5797 sched.cpp:407] Authenticating with master master@172.17.0.7:44013
I0905 16:43:07.152375  5797 sched.cpp:414] Using default CRAM-MD5 authenticatee
I0905 16:43:07.152650  5806 authenticatee.cpp:121] Creating new client SASL connection
I0905 16:43:07.152595  5819 slave.cpp:581] 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"}]
I0905 16:43:07.152899  5819 slave.cpp:589] Agent attributes: [  ]
I0905 16:43:07.152914  5819 slave.cpp:598] Agent hostname: e17d3ee52427
I0905 16:43:07.153002  5807 master.cpp:7834] Authenticating scheduler-378e5c69-6a7e-4393-bf2c-0b07c916bd6c@172.17.0.7:44013
I0905 16:43:07.153061  5809 status_update_manager.cpp:177] Pausing sending status updates
I0905 16:43:07.153156  5805 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(1069)@172.17.0.7:44013
I0905 16:43:07.153478  5818 authenticator.cpp:98] Creating new server SASL connection
I0905 16:43:07.153749  5808 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5
I0905 16:43:07.153792  5808 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5'
I0905 16:43:07.153946  5800 authenticator.cpp:204] Received SASL authentication start
I0905 16:43:07.154032  5800 authenticator.cpp:326] Authentication requires more steps
I0905 16:43:07.154196  5798 authenticatee.cpp:259] Received SASL authentication step
I0905 16:43:07.154332  5815 authenticator.cpp:232] Received SASL authentication step
I0905 16:43:07.154381  5815 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: 'e17d3ee52427' server FQDN: 'e17d3ee52427' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false 
I0905 16:43:07.154398  5815 auxprop.cpp:181] Looking up auxiliary property '*userPassword'
I0905 16:43:07.154443  5815 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
I0905 16:43:07.154466  5815 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: 'e17d3ee52427' server FQDN: 'e17d3ee52427' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true 
I0905 16:43:07.154482  5815 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true
I0905 16:43:07.154498  5815 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
I0905 16:43:07.154516  5815 authenticator.cpp:318] Authentication success
I0905 16:43:07.154603  5816 authenticatee.cpp:299] Authentication success
I0905 16:43:07.154738  5803 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(1069)@172.17.0.7:44013
I0905 16:43:07.154848  5801 state.cpp:64] Recovering state from '/tmp/SlaveTest_ContainersEndpoint_yWrPkK/meta'
I0905 16:43:07.154852  5812 master.cpp:7864] Successfully authenticated principal 'test-principal' at scheduler-378e5c69-6a7e-4393-bf2c-0b07c916bd6c@172.17.0.7:44013
I0905 16:43:07.154881  5802 sched.cpp:513] Successfully authenticated with master master@172.17.0.7:44013
I0905 16:43:07.154914  5802 sched.cpp:836] Sending SUBSCRIBE call to master@172.17.0.7:44013
I0905 16:43:07.155061  5802 sched.cpp:869] Will retry registration in 1.965578017secs if necessary
I0905 16:43:07.155216  5809 status_update_manager.cpp:203] Recovering status update manager
I0905 16:43:07.155272  5811 master.cpp:2897] Received SUBSCRIBE call for framework 'default' at scheduler-378e5c69-6a7e-4393-bf2c-0b07c916bd6c@172.17.0.7:44013
I0905 16:43:07.155351  5811 master.cpp:2231] Authorizing framework principal 'test-principal' to receive offers for roles '{ * }'
I0905 16:43:07.155534  5818 slave.cpp:6296] Finished recovery
I0905 16:43:07.155776  5814 master.cpp:2977] Subscribing framework default with checkpointing disabled and capabilities [ RESERVATION_REFINEMENT ]
I0905 16:43:07.155943  5818 slave.cpp:6478] Querying resource estimator for oversubscribable resources
I0905 16:43:07.156190  5815 status_update_manager.cpp:177] Pausing sending status updates
I0905 16:43:07.156208  5816 slave.cpp:987] New master detected at master@172.17.0.7:44013
I0905 16:43:07.156316  5816 slave.cpp:1022] Detecting new master
I0905 16:43:07.156399  5819 sched.cpp:759] Framework registered with 26df403f-bd4f-4795-b22d-0ea3493b38f1-0000
I0905 16:43:07.156437  5816 slave.cpp:6492] Received oversubscribable resources {} from the resource estimator
I0905 16:43:07.156451  5819 sched.cpp:773] Scheduler::registered took 25309ns
I0905 16:43:07.156505  5798 hierarchical.cpp:303] Added framework 26df403f-bd4f-4795-b22d-0ea3493b38f1-0000
I0905 16:43:07.156682  5798 hierarchical.cpp:1943] No allocations performed
I0905 16:43:07.156735  5798 hierarchical.cpp:2033] No inverse offers to send out!
I0905 16:43:07.156802  5798 hierarchical.cpp:1486] Performed allocation for 0 agents in 169920ns
I0905 16:43:07.163586  5804 slave.cpp:1049] Authenticating with master master@172.17.0.7:44013
I0905 16:43:07.163653  5804 slave.cpp:1060] Using default CRAM-MD5 authenticatee
I0905 16:43:07.163880  5803 authenticatee.cpp:121] Creating new client SASL connection
I0905 16:43:07.164171  5812 master.cpp:7834] Authenticating slave(532)@172.17.0.7:44013
I0905 16:43:07.164271  5801 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(1070)@172.17.0.7:44013
I0905 16:43:07.164506  5802 authenticator.cpp:98] Creating new server SASL connection
I0905 16:43:07.164829  5797 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5
I0905 16:43:07.164857  5797 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5'
I0905 16:43:07.164968  5806 authenticator.cpp:204] Received SASL authentication start
I0905 16:43:07.165096  5806 authenticator.cpp:326] Authentication requires more steps
I0905 16:43:07.165244  5817 authenticatee.cpp:259] Received SASL authentication step
I0905 16:43:07.165369  5809 authenticator.cpp:232] Received SASL authentication step
I0905 16:43:07.165401  5809 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: 'e17d3ee52427' server FQDN: 'e17d3ee52427' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false 
I0905 16:43:07.165416  5809 auxprop.cpp:181] Looking up auxiliary property '*userPassword'
I0905 16:43:07.165442  5809 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
I0905 16:43:07.165463  5809 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: 'e17d3ee52427' server FQDN: 'e17d3ee52427' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true 
I0905 16:43:07.165475  5809 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true
I0905 16:43:07.165482  5809 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
I0905 16:43:07.165498  5809 authenticator.cpp:318] Authentication success
I0905 16:43:07.165567  5807 authenticatee.cpp:299] Authentication success
I0905 16:43:07.165614  5805 master.cpp:7864] Successfully authenticated principal 'test-principal' at slave(532)@172.17.0.7:44013
I0905 16:43:07.165657  5809 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(1070)@172.17.0.7:44013
I0905 16:43:07.165850  5808 slave.cpp:1144] Successfully authenticated with master master@172.17.0.7:44013
I0905 16:43:07.166060  5808 slave.cpp:1623] Will retry registration in 14.185224ms if necessary
I0905 16:43:07.166206  5814 master.cpp:5717] Received register agent message from slave(532)@172.17.0.7:44013 (e17d3ee52427)
I0905 16:43:07.166332  5814 master.cpp:3806] Authorizing agent with principal 'test-principal'
I0905 16:43:07.166676  5810 master.cpp:5777] Authorized registration of agent at slave(532)@172.17.0.7:44013 (e17d3ee52427)
I0905 16:43:07.166774  5810 master.cpp:5870] Registering agent at slave(532)@172.17.0.7:44013 (e17d3ee52427) with id 26df403f-bd4f-4795-b22d-0ea3493b38f1-S0
I0905 16:43:07.167158  5819 registrar.cpp:495] Applied 1 operations in 48559ns; attempting to update the registry
I0905 16:43:07.167702  5819 registrar.cpp:552] Successfully updated the registry in 485120ns
I0905 16:43:07.167878  5801 master.cpp:5917] Admitted agent 26df403f-bd4f-4795-b22d-0ea3493b38f1-S0 at slave(532)@172.17.0.7:44013 (e17d3ee52427)
I0905 16:43:07.168563  5797 slave.cpp:4963] Received ping from slave-observer(506)@172.17.0.7:44013
I0905 16:43:07.168717  5797 slave.cpp:1190] Registered with master master@172.17.0.7:44013; given agent ID 26df403f-bd4f-4795-b22d-0ea3493b38f1-S0
I0905 16:43:07.168609  5801 master.cpp:5948] Registered agent 26df403f-bd4f-4795-b22d-0ea3493b38f1-S0 at slave(532)@172.17.0.7:44013 (e17d3ee52427) with [{"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"}]
I0905 16:43:07.168846  5811 status_update_manager.cpp:184] Resuming sending status updates
I0905 16:43:07.169013  5797 slave.cpp:1210] Checkpointing SlaveInfo to '/tmp/SlaveTest_ContainersEndpoint_yWrPkK/meta/slaves/26df403f-bd4f-4795-b22d-0ea3493b38f1-S0/slave.info'
I0905 16:43:07.169006  5806 hierarchical.cpp:593] Added agent 26df403f-bd4f-4795-b22d-0ea3493b38f1-S0 (e17d3ee52427) with cpus:2; mem:1024; disk:1024; ports:[31000-32000] (allocated: {})
I0905 16:43:07.169347  5797 slave.cpp:1259] Forwarding total oversubscribed resources {}
I0905 16:43:07.169482  5805 master.cpp:6685] Received update of agent 26df403f-bd4f-4795-b22d-0ea3493b38f1-S0 at slave(532)@172.17.0.7:44013 (e17d3ee52427) with total oversubscribed resources {}
I0905 16:43:07.170178  5806 hierarchical.cpp:2033] No inverse offers to send out!
I0905 16:43:07.170235  5806 hierarchical.cpp:1486] Performed allocation for 1 agents in 1.04445ms
I0905 16:43:07.170424  5806 hierarchical.cpp:660] Agent 26df403f-bd4f-4795-b22d-0ea3493b38f1-S0 (e17d3ee52427) updated with total resources cpus:2; mem:1024; disk:1024; ports:[31000-32000]
I0905 16:43:07.170583  5807 master.cpp:7664] Sending 1 offers to framework 26df403f-bd4f-4795-b22d-0ea3493b38f1-0000 (default) at scheduler-378e5c69-6a7e-4393-bf2c-0b07c916bd6c@172.17.0.7:44013
I0905 16:43:07.171056  5818 sched.cpp:933] Scheduler::resourceOffers took 97503ns
I0905 16:43:07.173028  5816 master.cpp:9162] Removing offer 26df403f-bd4f-4795-b22d-0ea3493b38f1-O0
I0905 16:43:07.173169  5816 master.cpp:4156] Processing ACCEPT call for offers: [ 26df403f-bd4f-4795-b22d-0ea3493b38f1-O0 ] on agent 26df403f-bd4f-4795-b22d-0ea3493b38f1-S0 at slave(532)@172.17.0.7:44013 (e17d3ee52427) for framework 26df403f-bd4f-4795-b22d-0ea3493b38f1-0000 (default) at scheduler-378e5c69-6a7e-4393-bf2c-0b07c916bd6c@172.17.0.7:44013
I0905 16:43:07.173256  5816 master.cpp:3533] Authorizing framework principal 'test-principal' to launch task 1
I0905 16:43:07.173436  5816 master.cpp:3533] Authorizing framework principal 'test-principal' to launch task 2
W0905 16:43:07.175125  5812 validation.cpp:1332] Executor 'executor-1' for task '1' uses less CPUs (None) than the minimum required (0.01). Please update your executor, as this will be mandatory in future releases.
W0905 16:43:07.175158  5812 validation.cpp:1344] Executor 'executor-1' for task '1' uses less memory (None) than the minimum required (32MB). Please update your executor, as this will be mandatory in future releases.
I0905 16:43:07.175495  5812 master.cpp:9908] Adding task 1 with resources [{"allocation_info":{"role":"*"},"name":"cpus","scalar":{"value":1.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"mem","scalar":{"value":512.0},"type":"SCALAR"}] on agent 26df403f-bd4f-4795-b22d-0ea3493b38f1-S0 at slave(532)@172.17.0.7:44013 (e17d3ee52427)
I0905 16:43:07.175802  5812 master.cpp:4819] Launching task 1 of framework 26df403f-bd4f-4795-b22d-0ea3493b38f1-0000 (default) at scheduler-378e5c69-6a7e-4393-bf2c-0b07c916bd6c@172.17.0.7:44013 with resources [{"allocation_info":{"role":"*"},"name":"cpus","scalar":{"value":1.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"mem","scalar":{"value":512.0},"type":"SCALAR"}] on agent 26df403f-bd4f-4795-b22d-0ea3493b38f1-S0 at slave(532)@172.17.0.7:44013 (e17d3ee52427)
I0905 16:43:07.176236  5817 slave.cpp:1744] Got assigned task '1' for framework 26df403f-bd4f-4795-b22d-0ea3493b38f1-0000
W0905 16:43:07.176754  5812 validation.cpp:1332] Executor 'executor-2' for task '2' uses less CPUs (None) than the minimum required (0.01). Please update your executor, as this will be mandatory in future releases.
W0905 16:43:07.176800  5812 validation.cpp:1344] Executor 'executor-2' for task '2' uses less memory (None) than the minimum required (32MB). Please update your executor, as this will be mandatory in future releases.
I0905 16:43:07.176926  5817 slave.cpp:2012] Authorizing task '1' for framework 26df403f-bd4f-4795-b22d-0ea3493b38f1-0000
I0905 16:43:07.176985  5817 slave.cpp:6795] Authorizing framework principal 'test-principal' to launch task 1
I0905 16:43:07.177129  5812 master.cpp:9908] Adding task 2 with resources [{"allocation_info":{"role":"*"},"name":"cpus","scalar":{"value":1.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"mem","scalar":{"value":512.0},"type":"SCALAR"}] on agent 26df403f-bd4f-4795-b22d-0ea3493b38f1-S0 at slave(532)@172.17.0.7:44013 (e17d3ee52427)
I0905 16:43:07.177426  5812 master.cpp:4819] Launching task 2 of framework 26df403f-bd4f-4795-b22d-0ea3493b38f1-0000 (default) at scheduler-378e5c69-6a7e-4393-bf2c-0b07c916bd6c@172.17.0.7:44013 with resources [{"allocation_info":{"role":"*"},"name":"cpus","scalar":{"value":1.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"mem","scalar":{"value":512.0},"type":"SCALAR"}] on agent 26df403f-bd4f-4795-b22d-0ea3493b38f1-S0 at slave(532)@172.17.0.7:44013 (e17d3ee52427)
I0905 16:43:07.177625  5805 slave.cpp:2180] Launching task '1' for framework 26df403f-bd4f-4795-b22d-0ea3493b38f1-0000
I0905 16:43:07.178156  5805 paths.cpp:578] Trying to chown '/tmp/SlaveTest_ContainersEndpoint_yWrPkK/slaves/26df403f-bd4f-4795-b22d-0ea3493b38f1-S0/frameworks/26df403f-bd4f-4795-b22d-0ea3493b38f1-0000/executors/executor-1/runs/46e85f4e-d483-41af-9404-846c983d2d6c' to user 'mesos'
I0905 16:43:07.178400  5805 slave.cpp:7257] Launching executor 'executor-1' of framework 26df403f-bd4f-4795-b22d-0ea3493b38f1-0000 with resources [] in work directory '/tmp/SlaveTest_ContainersEndpoint_yWrPkK/slaves/26df403f-bd4f-4795-b22d-0ea3493b38f1-S0/frameworks/26df403f-bd4f-4795-b22d-0ea3493b38f1-0000/executors/executor-1/runs/46e85f4e-d483-41af-9404-846c983d2d6c'
I0905 16:43:07.178784  5805 slave.cpp:2871] Launching container 46e85f4e-d483-41af-9404-846c983d2d6c for executor 'executor-1' of framework 26df403f-bd4f-4795-b22d-0ea3493b38f1-0000
I0905 16:43:07.179090  5805 slave.cpp:2408] Queued task '1' for executor 'executor-1' of framework 26df403f-bd4f-4795-b22d-0ea3493b38f1-0000
I0905 16:43:07.179195  5818 hierarchical.cpp:887] Updated allocation of framework 26df403f-bd4f-4795-b22d-0ea3493b38f1-0000 on agent 26df403f-bd4f-4795-b22d-0ea3493b38f1-S0 from cpus(allocated: *):2; mem(allocated: *):1024; disk(allocated: *):1024; ports(allocated: *):[31000-32000] to cpus(allocated: *):2; mem(allocated: *):1024; disk(allocated: *):1024; ports(allocated: *):[31000-32000]
I0905 16:43:07.179347  5805 slave.cpp:1744] Got assigned task '2' for framework 26df403f-bd4f-4795-b22d-0ea3493b38f1-0000
I0905 16:43:07.179787  5805 slave.cpp:940] Successfully attached file '/tmp/SlaveTest_ContainersEndpoint_yWrPkK/slaves/26df403f-bd4f-4795-b22d-0ea3493b38f1-S0/frameworks/26df403f-bd4f-4795-b22d-0ea3493b38f1-0000/executors/executor-1/runs/46e85f4e-d483-41af-9404-846c983d2d6c'
I0905 16:43:07.179841  5818 hierarchical.cpp:1161] Recovered ports(allocated: *):[31000-32000]; disk(allocated: *):1024 (total: cpus:2; mem:1024; disk:1024; ports:[31000-32000], allocated: cpus(allocated: *):2; mem(allocated: *):1024) on agent 26df403f-bd4f-4795-b22d-0ea3493b38f1-S0 from framework 26df403f-bd4f-4795-b22d-0ea3493b38f1-0000
I0905 16:43:07.179858  5805 slave.cpp:940] Successfully attached file '/tmp/SlaveTest_ContainersEndpoint_yWrPkK/slaves/26df403f-bd4f-4795-b22d-0ea3493b38f1-S0/frameworks/26df403f-bd4f-4795-b22d-0ea3493b38f1-0000/executors/executor-1/runs/46e85f4e-d483-41af-9404-846c983d2d6c'
I0905 16:43:07.179901  5818 hierarchical.cpp:1207] Framework 26df403f-bd4f-4795-b22d-0ea3493b38f1-0000 filtered agent 26df403f-bd4f-4795-b22d-0ea3493b38f1-S0 for 5secs
I0905 16:43:07.179985  5805 slave.cpp:2012] Authorizing task '2' for framework 26df403f-bd4f-4795-b22d-0ea3493b38f1-0000
I0905 16:43:07.180055  5805 slave.cpp:6795] Authorizing framework principal 'test-principal' to launch task 2
I0905 16:43:07.180660  5810 slave.cpp:2180] Launching task '2' for framework 26df403f-bd4f-4795-b22d-0ea3493b38f1-0000
I0905 16:43:07.181068  5810 paths.cpp:578] Trying to chown '/tmp/SlaveTest_ContainersEndpoint_yWrPkK/slaves/26df403f-bd4f-4795-b22d-0ea3493b38f1-S0/frameworks/26df403f-bd4f-4795-b22d-0ea3493b38f1-0000/executors/executor-2/runs/7c15091d-c371-4140-981c-3f3ae8e86999' to user 'mesos'
I0905 16:43:07.181303  5810 slave.cpp:7257] Launching executor 'executor-2' of framework 26df403f-bd4f-4795-b22d-0ea3493b38f1-0000 with resources [] in work directory '/tmp/SlaveTest_ContainersEndpoint_yWrPkK/slaves/26df403f-bd4f-4795-b22d-0ea3493b38f1-S0/frameworks/26df403f-bd4f-4795-b22d-0ea3493b38f1-0000/executors/executor-2/runs/7c15091d-c371-4140-981c-3f3ae8e86999'
*** Aborted at 1504629787 (unix time) try "date -d @1504629787" if you are using GNU date ***
PC: @     0x2abdbf8dd82d (unknown)
*** SIGSEGV (@0xd0) received by PID 5777 (TID 0x2abdc980c700) from PID 208; stack trace: ***
W0905 16:43:07.182287  5800 process.cpp:3238] Attempted to spawn already running process version@172.17.0.7:44013
I0905 16:43:07.182654  5800 exec.cpp:162] Version: 1.5.0
    @     0x2abe31596af7 (unknown)
I0905 16:43:07.183249  5816 exec.cpp:212] Executor started at: executor(135)@172.17.0.7:44013 with pid 5777
    @     0x2abe3159b449 (unknown)
    @     0x2abdbf694330 (unknown)
    @     0x2abdbf8dd82d (unknown)
    @     0x55f91b5ea00d os::getenv()
    @     0x2abdbc096808 mesos::internal::slave::executorEnvironment()
    @     0x2abdbc06bfb7 mesos::internal::slave::Slave::launchExecutor()
    @     0x2abdbc067560 mesos::internal::slave::Slave::__run()
    @     0x2abdbc0cd498 _ZZN7process8dispatchIN5mesos8internal5slave5SlaveERKNS_6FutureISt4listIbSaIbEEEERKNS1_13FrameworkInfoERKNS1_12ExecutorInfoERK6OptionINS1_8TaskInfoEERKSI_INS1_13TaskGroupInfoEESB_SE_SH_SM_SQ_EEvRKNS_3PIDIT_EEMSS_FvT0_T1_T2_T3_T4_EOT5_OT6_OT7_OT8_OT9_ENKUlRS9_RSC_RSF_RSK_RSO_PNS_11ProcessBaseEE_clES1D_S1E_S1F_S1G_S1H_S1J_
    @     0x2abdbc139ec1 _ZNSt5_BindIFZN7process8dispatchIN5mesos8internal5slave5SlaveERKNS0_6FutureISt4listIbSaIbEEEERKNS2_13FrameworkInfoERKNS2_12ExecutorInfoERK6OptionINS2_8TaskInfoEERKSJ_INS2_13TaskGroupInfoEESC_SF_SI_SN_SR_EEvRKNS0_3PIDIT_EEMST_FvT0_T1_T2_T3_T4_EOT5_OT6_OT7_OT8_OT9_EUlRSA_RSD_RSG_RSL_RSP_PNS0_11ProcessBaseEE_SA_SD_SG_SL_SP_St12_PlaceholderILi1EEEE6__callIvJOS1K_EJLm0ELm1ELm2ELm3ELm4ELm5EEEET_OSt5tupleIJDpT0_EESt12_Index_tupleIJXspT1_EEE
    @     0x2abdbc126097 _ZNSt5_BindIFZN7process8dispatchIN5mesos8internal5slave5SlaveERKNS0_6FutureISt4listIbSaIbEEEERKNS2_13FrameworkInfoERKNS2_12ExecutorInfoERK6OptionINS2_8TaskInfoEERKSJ_INS2_13TaskGroupInfoEESC_SF_SI_SN_SR_EEvRKNS0_3PIDIT_EEMST_FvT0_T1_T2_T3_T4_EOT5_OT6_OT7_OT8_OT9_EUlRSA_RSD_RSG_RSL_RSP_PNS0_11ProcessBaseEE_SA_SD_SG_SL_SP_St12_PlaceholderILi1EEEEclIIS1K_EvEET0_DpOT_
    @     0x2abdbc10db69 _ZNSt17_Function_handlerIFvPN7process11ProcessBaseEESt5_BindIFZNS0_8dispatchIN5mesos8internal5slave5SlaveERKNS0_6FutureISt4listIbSaIbEEEERKNS6_13FrameworkInfoERKNS6_12ExecutorInfoERK6OptionINS6_8TaskInfoEERKSN_INS6_13TaskGroupInfoEESG_SJ_SM_SR_SV_EEvRKNS0_3PIDIT_EEMSX_FvT0_T1_T2_T3_T4_EOT5_OT6_OT7_OT8_OT9_EUlRSE_RSH_RSK_RSP_RST_S2_E_SE_SH_SK_SP_ST_St12_PlaceholderILi1EEEEE9_M_invokeERKSt9_Any_dataS2_
    @     0x2abdbcfaf481 std::function<>::operator()()
    @     0x2abdbcf8fb53 process::ProcessBase::visit()
    @     0x2abdbcf9be82 process::DispatchEvent::visit()
    @     0x55f91b5bd686 process::ProcessBase::serve()
    @     0x2abdbcf8d273 process::ProcessManager::resume()
    @     0x2abdbcf895ea _ZZN7process14ProcessManager12init_threadsEvENKUlvE_clEv
    @     0x2abdbcf9ae8c _ZNSt12_Bind_simpleIFZN7process14ProcessManager12init_threadsEvEUlvE_vEE9_M_invokeIIEEEvSt12_Index_tupleIIXspT_EEE
    @     0x2abdbcf9ade3 _ZNSt12_Bind_simpleIFZN7process14ProcessManager12init_threadsEvEUlvE_vEEclEv
    @     0x2abdbcf9ad7c _ZNSt6thread5_ImplISt12_Bind_simpleIFZN7process14ProcessManager12init_threadsEvEUlvE_vEEE6_M_runEv
    @     0x2abdbef15a60 (unknown)
    @     0x2abdbf68c184 start_thread
    @     0x2abdbf99fffd (unknown)
make[4]: *** [check-local] Segmentation fault (core dumped)
make[4]: Leaving directory `/mesos/mesos-1.5.0/_build/src'
make[3]: *** [check-am] Error 2
make[3]: Leaving directory `/mesos/mesos-1.5.0/_build/src'
make[2]: *** [check] Error 2
make[2]: Leaving directory `/mesos/mesos-1.5.0/_build/src'
make[1]: *** [check-recursive] Error 1
make[1]: Leaving directory `/mesos/mesos-1.5.0/_build'
make: *** [distcheck] Error 1
+ docker rmi mesos-1504626689-1688
Untagged: mesos-1504626689-1688:latest
Deleted: sha256:37a431f9d4d2d8385e0b36091bc0d84c0dc47e042b1b37305eb6e28c8628b902
Deleted: sha256:c638ec69a0850ba93f8f66db17b8857c65a92cfbbee14a0d2ddcfe3f81058b96
Deleted: sha256:a5d7090a83c48ab71cf031a0fcd01fef2a6b9a4a63cadedda412b224d261b5a3
Deleted: sha256:3f0abaa570787025b0d0cd6cbb1083f44f37f11b7dc177ffdadfc35e4a01a9a0
Deleted: sha256:813f19dbf074022ab3ad107c42efeab60e78039fd0aef0eaef473bcd2f062932
Deleted: sha256:8745ad7f4f6a2cfbd7f5d2b10d5a24d73e257b8588900af8934a55b962303e3e
Deleted: sha256:284c4f1e5f850709db2759768fe91a463325e1fad0673479621cc7e78588f266
Deleted: sha256:6181af2271e514b1aa3c4489117d4f90d12eff3314210999f85752bf457f2d1f
Deleted: sha256:9cd9633307503d51ef9a194dfa9d85c7c5abfbd8621adbd115f47937d8bbf20a
Deleted: sha256:6a553dfd843ae6e114fc9f9bd5b009f243ec8ec59d2dd418b81c8b8da5ee93a4
Deleted: sha256:f6e04c4a39450129eb1db0123cc25ad88d9ded7e8f9504c9f8f3ff7be0e1cf67
Deleted: sha256:1de488cd8ff8ba95e51bed16095fbf1c40d72fac91e9c2f2afc75bf1358fbec5
Deleted: sha256:6ae46765ff011e209018e4acf4c1aa8bbe17ee1729d3d4ba3a7a89d8ce133d63
Deleted: sha256:e0a0bac10d4f90f2ddc8388e90d644c521eca57da1c6054675c74f3043197c2c
Deleted: sha256:dc5ae8a775e8d56154f9fe4747811866f9fb835dc091714e5f6369eec579b605
Deleted: sha256:33e3fb83a06797f22d4d27fd849a69bfdb85c1284b2b5bd658fda21dfa32b5af
Deleted: sha256:d5e5b2f8947215174ffaebb919e8dc1a649f5d90d7d339391c981984da071820
Deleted: sha256:6bb69c2c623ce08abbf7092346fe102c9538ae813043ba78107d0045cc7c6eec
Deleted: sha256:d2682074103b081071c3ef982f27f059da0def9e699f35825cd9023af862dcfe
Deleted: sha256:c6d16760227196bfc59966a191a82bc95746d7b1b8dca9e8a6d45a8e14aa7b43
Deleted: sha256:fee3642369356200e82f8136947ba0af5ace4d2e1e413d32b630db466a023e88
Deleted: sha256:2d1c729cf6a5189e5e475a7a9a3a9b4436740b764997dcf5ee13b010ddf9c454
Deleted: sha256:e9efac5b96939bc172d00ee2d7fcfbd502014f6a29d6851b8c78b3d444c57e72
Deleted: sha256:296724d9121bca1355567cde27c5d6a4385d8b962f95e4c1b33655cde7060881
Build step 'Execute shell' marked build as failure

Jenkins build is back to normal : Mesos-Reviewbot #19211

Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/Mesos-Reviewbot/19211/display/redirect>


Build failed in Jenkins: Mesos-Reviewbot #19210

Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/Mesos-Reviewbot/19210/display/redirect>

------------------------------------------
[...truncated 31.38 MB...]
I0905 18:46:35.051800  5805 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_6jVZ16/http_credentials'
I0905 18:46:35.052047  5805 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0905 18:46:35.052227  5805 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0905 18:46:35.053781  5805 slave.cpp:581] 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"}]
I0905 18:46:35.054143  5805 slave.cpp:589] Agent attributes: [  ]
I0905 18:46:35.054157  5805 slave.cpp:598] Agent hostname: 0d2379ae54e3
I0905 18:46:35.054428  5799 status_update_manager.cpp:177] Pausing sending status updates
I0905 18:46:35.056241  5796 state.cpp:64] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_MbH81O/meta'
I0905 18:46:35.056566  5818 status_update_manager.cpp:203] Recovering status update manager
I0905 18:46:35.056797  5798 containerizer.cpp:646] Recovering containerizer
I0905 18:46:35.058437  5807 provisioner.cpp:416] Provisioner recovery complete
I0905 18:46:35.059026  5809 slave.cpp:6296] Finished recovery
I0905 18:46:35.059550  5809 slave.cpp:6478] Querying resource estimator for oversubscribable resources
I0905 18:46:35.059792  5802 slave.cpp:6492] Received oversubscribable resources {} from the resource estimator
I0905 18:46:35.063380  5813 process.cpp:3954] Handling HTTP event for process 'slave(810)' with path: '/slave(810)/containers'
I0905 18:46:35.064658  5810 http.cpp:1185] HTTP GET for /slave(810)/containers from 172.17.0.7:55638
I0905 18:46:35.064735  5810 http.cpp:976] Authorizing principal 'test-principal' to GET the '/containers' endpoint
I0905 18:46:35.068837  5776 slave.cpp:859] Agent terminating
[       OK ] Endpoint/SlaveEndpointTest.AuthorizedRequest/2 (35 ms)
[ RUN      ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/0
I0905 18:46:35.081053  5776 containerizer.cpp:290] Using isolation { environment_secret, posix/cpu, posix/mem, filesystem/posix, network/cni }
W0905 18:46:35.081625  5776 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0905 18:46:35.081773  5776 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0905 18:46:35.081810  5776 provisioner.cpp:255] Using default backend 'copy'
I0905 18:46:35.086252  5815 slave.cpp:252] Mesos agent started on (811)@172.17.0.7:36914
I0905 18:46:35.086287  5815 slave.cpp:253] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_ySm3ih/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_UnauthorizedRequest_0_ySm3ih/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_UnauthorizedRequest_0_ySm3ih/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_UnauthorizedRequest_0_ySm3ih/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_UnauthorizedRequest_0_ySm3ih/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.5.0/_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" --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_UnauthorizedRequest_0_ySm3ih" --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_UnauthorizedRequest_0_ydo0dZ" --zk_session_timeout="10secs"
I0905 18:46:35.086715  5815 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_ySm3ih/credential'
I0905 18:46:35.086895  5815 slave.cpp:285] Agent using credential for: test-principal
I0905 18:46:35.086917  5815 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_ySm3ih/http_credentials'
I0905 18:46:35.087154  5815 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0905 18:46:35.087329  5815 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0905 18:46:35.088726  5815 slave.cpp:581] 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"}]
I0905 18:46:35.088973  5815 slave.cpp:589] Agent attributes: [  ]
I0905 18:46:35.088989  5815 slave.cpp:598] Agent hostname: 0d2379ae54e3
I0905 18:46:35.089177  5800 status_update_manager.cpp:177] Pausing sending status updates
I0905 18:46:35.090690  5807 state.cpp:64] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_ydo0dZ/meta'
I0905 18:46:35.091187  5813 status_update_manager.cpp:203] Recovering status update manager
I0905 18:46:35.091387  5809 containerizer.cpp:646] Recovering containerizer
I0905 18:46:35.092891  5801 provisioner.cpp:416] Provisioner recovery complete
I0905 18:46:35.093333  5796 slave.cpp:6296] Finished recovery
I0905 18:46:35.093883  5796 slave.cpp:6478] Querying resource estimator for oversubscribable resources
I0905 18:46:35.094147  5812 slave.cpp:6492] Received oversubscribable resources {} from the resource estimator
I0905 18:46:35.096982  5808 process.cpp:3954] Handling HTTP event for process 'slave(811)' with path: '/slave(811)/monitor/statistics'
I0905 18:46:35.098600  5807 http.cpp:1185] HTTP GET for /slave(811)/monitor/statistics from 172.17.0.7:55650
I0905 18:46:35.098733  5807 http.cpp:976] Authorizing principal 'test-principal' to GET the '/monitor/statistics' endpoint
I0905 18:46:35.100952  5795 slave.cpp:859] Agent terminating
[       OK ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/0 (32 ms)
[ RUN      ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/1
I0905 18:46:35.113698  5776 containerizer.cpp:290] Using isolation { environment_secret, posix/cpu, posix/mem, filesystem/posix, network/cni }
W0905 18:46:35.114248  5776 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0905 18:46:35.114383  5776 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0905 18:46:35.114423  5776 provisioner.cpp:255] Using default backend 'copy'
I0905 18:46:35.118639  5802 slave.cpp:252] Mesos agent started on (812)@172.17.0.7:36914
I0905 18:46:35.118664  5802 slave.cpp:253] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_GMlMTr/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_UnauthorizedRequest_1_GMlMTr/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_UnauthorizedRequest_1_GMlMTr/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_UnauthorizedRequest_1_GMlMTr/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_UnauthorizedRequest_1_GMlMTr/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.5.0/_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" --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_UnauthorizedRequest_1_GMlMTr" --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_UnauthorizedRequest_1_4DdSJ9" --zk_session_timeout="10secs"
I0905 18:46:35.119063  5802 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_GMlMTr/credential'
I0905 18:46:35.119225  5802 slave.cpp:285] Agent using credential for: test-principal
I0905 18:46:35.119246  5802 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_GMlMTr/http_credentials'
I0905 18:46:35.119477  5802 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0905 18:46:35.119639  5802 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0905 18:46:35.121140  5802 slave.cpp:581] 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"}]
I0905 18:46:35.121376  5802 slave.cpp:589] Agent attributes: [  ]
I0905 18:46:35.121390  5802 slave.cpp:598] Agent hostname: 0d2379ae54e3
I0905 18:46:35.121536  5799 status_update_manager.cpp:177] Pausing sending status updates
I0905 18:46:35.123033  5813 state.cpp:64] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_4DdSJ9/meta'
I0905 18:46:35.123327  5812 status_update_manager.cpp:203] Recovering status update manager
I0905 18:46:35.123529  5817 containerizer.cpp:646] Recovering containerizer
I0905 18:46:35.125213  5805 provisioner.cpp:416] Provisioner recovery complete
I0905 18:46:35.125628  5803 slave.cpp:6296] Finished recovery
I0905 18:46:35.126379  5803 slave.cpp:6478] Querying resource estimator for oversubscribable resources
I0905 18:46:35.126696  5801 slave.cpp:6492] Received oversubscribable resources {} from the resource estimator
I0905 18:46:35.129835  5815 process.cpp:3954] Handling HTTP event for process 'slave(812)' with path: '/slave(812)/monitor/statistics.json'
I0905 18:46:35.131530  5812 http.cpp:1185] HTTP GET for /slave(812)/monitor/statistics.json from 172.17.0.7:55656
I0905 18:46:35.131605  5812 http.cpp:976] Authorizing principal 'test-principal' to GET the '/monitor/statistics.json' endpoint
I0905 18:46:35.133821  5805 slave.cpp:859] Agent terminating
[       OK ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/1 (32 ms)
[ RUN      ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/2
I0905 18:46:35.145306  5776 containerizer.cpp:290] Using isolation { environment_secret, posix/cpu, posix/mem, filesystem/posix, network/cni }
W0905 18:46:35.145763  5776 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0905 18:46:35.145870  5776 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0905 18:46:35.145900  5776 provisioner.cpp:255] Using default backend 'copy'
I0905 18:46:35.149315  5811 slave.cpp:252] Mesos agent started on (813)@172.17.0.7:36914
I0905 18:46:35.149349  5811 slave.cpp:253] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_EKHCNC/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_UnauthorizedRequest_2_EKHCNC/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_UnauthorizedRequest_2_EKHCNC/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_UnauthorizedRequest_2_EKHCNC/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_UnauthorizedRequest_2_EKHCNC/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.5.0/_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" --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_UnauthorizedRequest_2_EKHCNC" --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_UnauthorizedRequest_2_6u9Xyk" --zk_session_timeout="10secs"
I0905 18:46:35.149950  5811 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_EKHCNC/credential'
I0905 18:46:35.150146  5811 slave.cpp:285] Agent using credential for: test-principal
I0905 18:46:35.150177  5811 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_EKHCNC/http_credentials'
I0905 18:46:35.150516  5811 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0905 18:46:35.150710  5811 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0905 18:46:35.152117  5811 slave.cpp:581] 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"}]
I0905 18:46:35.152345  5811 slave.cpp:589] Agent attributes: [  ]
I0905 18:46:35.152359  5811 slave.cpp:598] Agent hostname: 0d2379ae54e3
I0905 18:46:35.152487  5816 status_update_manager.cpp:177] Pausing sending status updates
I0905 18:46:35.153916  5798 state.cpp:64] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_6u9Xyk/meta'
I0905 18:46:35.154320  5814 status_update_manager.cpp:203] Recovering status update manager
I0905 18:46:35.154521  5800 containerizer.cpp:646] Recovering containerizer
I0905 18:46:35.156172  5816 provisioner.cpp:416] Provisioner recovery complete
I0905 18:46:35.156544  5805 slave.cpp:6296] Finished recovery
I0905 18:46:35.157006  5805 slave.cpp:6478] Querying resource estimator for oversubscribable resources
I0905 18:46:35.157306  5818 slave.cpp:6492] Received oversubscribable resources {} from the resource estimator
I0905 18:46:35.160277  5807 process.cpp:3954] Handling HTTP event for process 'slave(813)' with path: '/slave(813)/containers'
I0905 18:46:35.161731  5804 http.cpp:1185] HTTP GET for /slave(813)/containers from 172.17.0.7:55662
I0905 18:46:35.161824  5804 http.cpp:976] Authorizing principal 'test-principal' to GET the '/containers' endpoint
I0905 18:46:35.164165  5798 slave.cpp:859] Agent terminating
[       OK ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/2 (30 ms)
[ RUN      ] Endpoint/SlaveEndpointTest.NoAuthorizer/0
I0905 18:46:35.175788  5776 containerizer.cpp:290] Using isolation { environment_secret, posix/cpu, posix/mem, filesystem/posix, network/cni }
W0905 18:46:35.176261  5776 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0905 18:46:35.176373  5776 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0905 18:46:35.176404  5776 provisioner.cpp:255] Using default backend 'copy'
I0905 18:46:35.178186  5776 cluster.cpp:448] Creating default 'local' authorizer
I0905 18:46:35.180308  5816 slave.cpp:252] Mesos agent started on (814)@172.17.0.7:36914
I0905 18:46:35.180331  5816 slave.cpp:253] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_g6JuZN/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_NoAuthorizer_0_g6JuZN/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_NoAuthorizer_0_g6JuZN/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_NoAuthorizer_0_g6JuZN/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_NoAuthorizer_0_g6JuZN/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.5.0/_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" --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_NoAuthorizer_0_g6JuZN" --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_NoAuthorizer_0_Sh0lGv" --zk_session_timeout="10secs"
I0905 18:46:35.180810  5816 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_g6JuZN/credential'
I0905 18:46:35.181046  5816 slave.cpp:285] Agent using credential for: test-principal
I0905 18:46:35.181071  5816 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_g6JuZN/http_credentials'
I0905 18:46:35.181331  5816 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0905 18:46:35.181532  5816 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0905 18:46:35.183039  5816 slave.cpp:581] 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"}]
I0905 18:46:35.183313  5816 slave.cpp:589] Agent attributes: [  ]
I0905 18:46:35.183328  5816 slave.cpp:598] Agent hostname: 0d2379ae54e3
I0905 18:46:35.183560  5803 status_update_manager.cpp:177] Pausing sending status updates
I0905 18:46:35.185331  5814 state.cpp:64] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_Sh0lGv/meta'
I0905 18:46:35.185760  5796 status_update_manager.cpp:203] Recovering status update manager
I0905 18:46:35.185999  5802 containerizer.cpp:646] Recovering containerizer
I0905 18:46:35.187613  5818 provisioner.cpp:416] Provisioner recovery complete
I0905 18:46:35.188129  5800 slave.cpp:6296] Finished recovery
I0905 18:46:35.188663  5800 slave.cpp:6478] Querying resource estimator for oversubscribable resources
I0905 18:46:35.189002  5811 slave.cpp:6492] Received oversubscribable resources {} from the resource estimator
I0905 18:46:35.192003  5808 process.cpp:3954] Handling HTTP event for process 'slave(814)' with path: '/slave(814)/monitor/statistics'
I0905 18:46:35.193315  5814 http.cpp:1185] HTTP GET for /slave(814)/monitor/statistics from 172.17.0.7:55666
I0905 18:46:35.193411  5814 http.cpp:976] Authorizing principal 'test-principal' to GET the '/monitor/statistics' endpoint
I0905 18:46:35.196754  5814 slave.cpp:859] Agent terminating
[       OK ] Endpoint/SlaveEndpointTest.NoAuthorizer/0 (33 ms)
[ RUN      ] Endpoint/SlaveEndpointTest.NoAuthorizer/1
I0905 18:46:35.208731  5776 containerizer.cpp:290] Using isolation { environment_secret, posix/cpu, posix/mem, filesystem/posix, network/cni }
W0905 18:46:35.209197  5776 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0905 18:46:35.209303  5776 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0905 18:46:35.209334  5776 provisioner.cpp:255] Using default backend 'copy'
I0905 18:46:35.210929  5776 cluster.cpp:448] Creating default 'local' authorizer
I0905 18:46:35.212795  5809 slave.cpp:252] Mesos agent started on (815)@172.17.0.7:36914
I0905 18:46:35.212823  5809 slave.cpp:253] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_cdpOuZ/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_NoAuthorizer_1_cdpOuZ/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_NoAuthorizer_1_cdpOuZ/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_NoAuthorizer_1_cdpOuZ/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_NoAuthorizer_1_cdpOuZ/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.5.0/_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" --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_NoAuthorizer_1_cdpOuZ" --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_NoAuthorizer_1_WE9K6G" --zk_session_timeout="10secs"
I0905 18:46:35.213168  5809 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_cdpOuZ/credential'
I0905 18:46:35.213332  5809 slave.cpp:285] Agent using credential for: test-principal
I0905 18:46:35.213356  5809 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_cdpOuZ/http_credentials'
I0905 18:46:35.213587  5809 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0905 18:46:35.213742  5809 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0905 18:46:35.215102  5809 slave.cpp:581] 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"}]
I0905 18:46:35.215332  5809 slave.cpp:589] Agent attributes: [  ]
I0905 18:46:35.215344  5809 slave.cpp:598] Agent hostname: 0d2379ae54e3
I0905 18:46:35.215497  5796 status_update_manager.cpp:177] Pausing sending status updates
I0905 18:46:35.216867  5804 state.cpp:64] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_WE9K6G/meta'
I0905 18:46:35.217300  5798 status_update_manager.cpp:203] Recovering status update manager
I0905 18:46:35.217521  5815 containerizer.cpp:646] Recovering containerizer
I0905 18:46:35.219131  5806 provisioner.cpp:416] Provisioner recovery complete
I0905 18:46:35.219506  5809 slave.cpp:6296] Finished recovery
I0905 18:46:35.219988  5809 slave.cpp:6478] Querying resource estimator for oversubscribable resources
I0905 18:46:35.220218  5805 slave.cpp:6492] Received oversubscribable resources {} from the resource estimator
I0905 18:46:35.223356  5796 process.cpp:3954] Handling HTTP event for process 'slave(815)' with path: '/slave(815)/monitor/statistics.json'
I0905 18:46:35.224596  5810 http.cpp:1185] HTTP GET for /slave(815)/monitor/statistics.json from 172.17.0.7:55670
I0905 18:46:35.224692  5810 http.cpp:976] Authorizing principal 'test-principal' to GET the '/monitor/statistics.json' endpoint
I0905 18:46:35.227917  5776 slave.cpp:859] Agent terminating
[       OK ] Endpoint/SlaveEndpointTest.NoAuthorizer/1 (30 ms)
[ RUN      ] Endpoint/SlaveEndpointTest.NoAuthorizer/2
I0905 18:46:35.239176  5776 containerizer.cpp:290] Using isolation { environment_secret, posix/cpu, posix/mem, filesystem/posix, network/cni }
W0905 18:46:35.239619  5776 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0905 18:46:35.239722  5776 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0905 18:46:35.239750  5776 provisioner.cpp:255] Using default backend 'copy'
I0905 18:46:35.241334  5776 cluster.cpp:448] Creating default 'local' authorizer
I0905 18:46:35.243314  5814 slave.cpp:252] Mesos agent started on (816)@172.17.0.7:36914
I0905 18:46:35.243341  5814 slave.cpp:253] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_y4Fqib/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_NoAuthorizer_2_y4Fqib/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_NoAuthorizer_2_y4Fqib/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_NoAuthorizer_2_y4Fqib/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_NoAuthorizer_2_y4Fqib/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.5.0/_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" --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_NoAuthorizer_2_y4Fqib" --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_NoAuthorizer_2_Q39PPS" --zk_session_timeout="10secs"
I0905 18:46:35.243705  5814 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_y4Fqib/credential'
I0905 18:46:35.243847  5814 slave.cpp:285] Agent using credential for: test-principal
I0905 18:46:35.243871  5814 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_y4Fqib/http_credentials'
I0905 18:46:35.244091  5814 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0905 18:46:35.244243  5814 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0905 18:46:35.245630  5814 slave.cpp:581] 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"}]
I0905 18:46:35.245852  5814 slave.cpp:589] Agent attributes: [  ]
I0905 18:46:35.245865  5814 slave.cpp:598] Agent hostname: 0d2379ae54e3
I0905 18:46:35.246008  5805 status_update_manager.cpp:177] Pausing sending status updates
I0905 18:46:35.247645  5800 state.cpp:64] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_Q39PPS/meta'
I0905 18:46:35.247982  5799 status_update_manager.cpp:203] Recovering status update manager
I0905 18:46:35.248204  5799 containerizer.cpp:646] Recovering containerizer
I0905 18:46:35.249589  5796 provisioner.cpp:416] Provisioner recovery complete
I0905 18:46:35.249999  5814 slave.cpp:6296] Finished recovery
I0905 18:46:35.250402  5814 slave.cpp:6478] Querying resource estimator for oversubscribable resources
I0905 18:46:35.250699  5806 slave.cpp:6492] Received oversubscribable resources {} from the resource estimator
I0905 18:46:35.253062  5803 process.cpp:3954] Handling HTTP event for process 'slave(816)' with path: '/slave(816)/containers'
I0905 18:46:35.254175  5796 http.cpp:1185] HTTP GET for /slave(816)/containers from 172.17.0.7:55672
I0905 18:46:35.254251  5796 http.cpp:976] Authorizing principal 'test-principal' to GET the '/containers' endpoint
I0905 18:46:35.258209  5818 slave.cpp:859] Agent terminating
[       OK ] Endpoint/SlaveEndpointTest.NoAuthorizer/2 (31 ms)
[----------] 9 tests from Endpoint/SlaveEndpointTest (292 ms total)

[----------] 2 tests from ContainerizerType/DefaultContainerDNSFlagTest
[ RUN      ] ContainerizerType/DefaultContainerDNSFlagTest.ValidateFlag/0
[       OK ] ContainerizerType/DefaultContainerDNSFlagTest.ValidateFlag/0 (11 ms)
[ RUN      ] ContainerizerType/DefaultContainerDNSFlagTest.ValidateFlag/1
[       OK ] ContainerizerType/DefaultContainerDNSFlagTest.ValidateFlag/1 (9 ms)
[----------] 2 tests from ContainerizerType/DefaultContainerDNSFlagTest (20 ms total)

[----------] Global test environment tear-down
[==========] 1667 tests from 183 test cases ran. (636360 ms total)
[  PASSED  ] 1662 tests.
[  FAILED  ] 5 tests, listed below:
[  FAILED  ] DefaultExecutorCheckTest.CommandCheckDeliveredAndReconciled
[  FAILED  ] DefaultExecutorCheckTest.CommandCheckStatusChange
[  FAILED  ] DefaultExecutorCheckTest.CommandCheckSeesParentsEnv
[  FAILED  ] DefaultExecutorCheckTest.CommandCheckSharesWorkDirWithTask
[  FAILED  ] MasterTest.IgnoreOldAgentReregistration

 5 FAILED TESTS
  YOU HAVE 20 DISABLED TESTS

I0905 18:46:35.344225  5819 process.cpp:1072] Failed to accept socket: future discarded
make[4]: *** [check-local] Error 1
make[4]: Leaving directory `/mesos/mesos-1.5.0/_build/src'
make[3]: *** [check-am] Error 2
make[3]: Leaving directory `/mesos/mesos-1.5.0/_build/src'
make[2]: *** [check] Error 2
make[2]: Leaving directory `/mesos/mesos-1.5.0/_build/src'
make[1]: *** [check-recursive] Error 1
make[1]: Leaving directory `/mesos/mesos-1.5.0/_build'
make: *** [distcheck] Error 1
+ docker rmi mesos-1504633889-14421
Untagged: mesos-1504633889-14421:latest
Deleted: sha256:3a2ed0d916b029c64d87958676aee9c4398cf1418ccfe4b57d0f8299167e37d3
Deleted: sha256:9ec89b8e5e3be0047c48b43f13354a9a9e109062cd2061839c4dd42f86468432
Deleted: sha256:1eeb29e5b26a67a7eeffebcf15cf15fe7072d243b91f50a1f3d1d7996da5653a
Deleted: sha256:a20c0610f5f4e681d5e0762aff470d9080cfd08045ab9bdd64eedf2947a76679
Deleted: sha256:29020f00306ab91b875040e57af9e883a4339d92614ff03d245602724927a790
Deleted: sha256:9d22746c0386257de63be3d37a5a52410e1397acc6148f0b999b3e2fe94f7244
Deleted: sha256:ded8dfc59fa87766413d97dec227413645a238a2073ecbf2ab2c2b67e63c9ab5
Deleted: sha256:fa2745424611b5ff69c64a845f94eeb2053b785c122cab7e9baa7f2ca418106b
Deleted: sha256:18b1d8ba05e28881ecb47c97c72dd5d356002c684a3dabe75fdacdfc0c7de9b2
Deleted: sha256:5fa61308fbebb0232980657a7d8b671ebdbd63feaf6fe58b54a3659d633f66b7
Deleted: sha256:bac3afa79229d342e88e05ecdf83e335920b585ffcbc831af2011fff5c0226c8
Deleted: sha256:a9ac297c7bdf1bf983479dfea7ab2fd5aa1c836a0b473573a6e2615315da4641
Deleted: sha256:c4f603ce444e8031ba8f23a4eabdbe721776c73d82340da60110d7ebca7fef9b
Deleted: sha256:634605fabb5d299bef6011fa40e3738cf0fbc7740de8076e3257025c5214d6e3
Deleted: sha256:9faf7d49449b455c1961be4acf634984a5a577b1fad94a3b485a6820050ccbd9
Deleted: sha256:88bab1fd98b5154d121f8b8afeac22961532d963c7c6ddb4dae293940d690485
Deleted: sha256:033df3ad9d1e8d1155be7e14a9dc324b8ae91a1e8687a109b3432378f901a874
Deleted: sha256:5c6fcd26df3552d77da6e58dbc419cca0c656e24c72eb10dc88374c2e7eabfac
Deleted: sha256:30ab7c8116ce73df3743e125318da8ba4a8c5b1ddceabc0bc9fa24cc505d5d08
Deleted: sha256:20189a41f122321ddcf065e5cb29020549c9e509ae2e690cbbe85fcf3b65faba
Deleted: sha256:556e5bd2d57cfac0a4cf0a32b54538f1ac81647288baff73905cdd6af11388c9
Deleted: sha256:65e66bbde67dac5e28e428014cec4cbf1b378c5b7e580fd05a3030927bbd51e7
Deleted: sha256:6bacf0bd867693f06965d15113663a109e9ba48db535761c09df52cb8e72a443
Deleted: sha256:605cf1d190e3e62c48b9440f98f57fb700f119944948f8fc22df55393879d3c4
Build step 'Execute shell' marked build as failure

Build failed in Jenkins: Mesos-Reviewbot #19209

Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/Mesos-Reviewbot/19209/display/redirect?page=changes>

Changes:

[anand] Fixed Attributes comparison.

------------------------------------------
[...truncated 31.38 MB...]
I0905 17:46:40.352378  5801 slave.cpp:285] Agent using credential for: test-principal
I0905 17:46:40.352412  5801 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_3ljPwE/http_credentials'
I0905 17:46:40.352665  5801 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0905 17:46:40.352895  5801 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0905 17:46:40.354389  5801 slave.cpp:581] 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"}]
I0905 17:46:40.354645  5801 slave.cpp:589] Agent attributes: [  ]
I0905 17:46:40.354660  5801 slave.cpp:598] Agent hostname: c7b6aab9db8d
I0905 17:46:40.354796  5797 status_update_manager.cpp:177] Pausing sending status updates
I0905 17:46:40.356230  5815 state.cpp:64] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_2LblLA/meta'
I0905 17:46:40.356606  5817 status_update_manager.cpp:203] Recovering status update manager
I0905 17:46:40.356845  5816 containerizer.cpp:646] Recovering containerizer
I0905 17:46:40.358471  5798 provisioner.cpp:416] Provisioner recovery complete
I0905 17:46:40.358912  5812 slave.cpp:6296] Finished recovery
I0905 17:46:40.359380  5812 slave.cpp:6478] Querying resource estimator for oversubscribable resources
I0905 17:46:40.359663  5802 slave.cpp:6492] Received oversubscribable resources {} from the resource estimator
I0905 17:46:40.362418  5814 process.cpp:3954] Handling HTTP event for process 'slave(810)' with path: '/slave(810)/containers'
I0905 17:46:40.364151  5804 http.cpp:1185] HTTP GET for /slave(810)/containers from 172.17.0.7:40562
I0905 17:46:40.364235  5804 http.cpp:976] Authorizing principal 'test-principal' to GET the '/containers' endpoint
I0905 17:46:40.368832  5810 slave.cpp:859] Agent terminating
[       OK ] Endpoint/SlaveEndpointTest.AuthorizedRequest/2 (33 ms)
[ RUN      ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/0
I0905 17:46:40.381233  5777 containerizer.cpp:290] Using isolation { environment_secret, posix/cpu, posix/mem, filesystem/posix, network/cni }
W0905 17:46:40.381731  5777 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0905 17:46:40.381842  5777 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0905 17:46:40.381884  5777 provisioner.cpp:255] Using default backend 'copy'
I0905 17:46:40.385561  5806 slave.cpp:252] Mesos agent started on (811)@172.17.0.7:44054
I0905 17:46:40.385589  5806 slave.cpp:253] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_3iFERT/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_UnauthorizedRequest_0_3iFERT/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_UnauthorizedRequest_0_3iFERT/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_UnauthorizedRequest_0_3iFERT/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_UnauthorizedRequest_0_3iFERT/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.5.0/_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" --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_UnauthorizedRequest_0_3iFERT" --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_UnauthorizedRequest_0_egX80P" --zk_session_timeout="10secs"
I0905 17:46:40.386065  5806 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_3iFERT/credential'
I0905 17:46:40.386287  5806 slave.cpp:285] Agent using credential for: test-principal
I0905 17:46:40.386312  5806 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_3iFERT/http_credentials'
I0905 17:46:40.386544  5806 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0905 17:46:40.386703  5806 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0905 17:46:40.388924  5806 slave.cpp:581] 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"}]
I0905 17:46:40.389354  5806 slave.cpp:589] Agent attributes: [  ]
I0905 17:46:40.389400  5806 slave.cpp:598] Agent hostname: c7b6aab9db8d
I0905 17:46:40.389652  5799 status_update_manager.cpp:177] Pausing sending status updates
I0905 17:46:40.391942  5814 state.cpp:64] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_egX80P/meta'
I0905 17:46:40.392345  5812 status_update_manager.cpp:203] Recovering status update manager
I0905 17:46:40.392648  5819 containerizer.cpp:646] Recovering containerizer
I0905 17:46:40.394486  5810 provisioner.cpp:416] Provisioner recovery complete
I0905 17:46:40.394944  5805 slave.cpp:6296] Finished recovery
I0905 17:46:40.395514  5805 slave.cpp:6478] Querying resource estimator for oversubscribable resources
I0905 17:46:40.395787  5807 slave.cpp:6492] Received oversubscribable resources {} from the resource estimator
I0905 17:46:40.398756  5813 process.cpp:3954] Handling HTTP event for process 'slave(811)' with path: '/slave(811)/monitor/statistics'
I0905 17:46:40.399998  5810 http.cpp:1185] HTTP GET for /slave(811)/monitor/statistics from 172.17.0.7:40564
I0905 17:46:40.400068  5810 http.cpp:976] Authorizing principal 'test-principal' to GET the '/monitor/statistics' endpoint
I0905 17:46:40.402386  5777 slave.cpp:859] Agent terminating
[       OK ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/0 (34 ms)
[ RUN      ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/1
I0905 17:46:40.415930  5777 containerizer.cpp:290] Using isolation { environment_secret, posix/cpu, posix/mem, filesystem/posix, network/cni }
W0905 17:46:40.416425  5777 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0905 17:46:40.416534  5777 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0905 17:46:40.416568  5777 provisioner.cpp:255] Using default backend 'copy'
I0905 17:46:40.420553  5802 slave.cpp:252] Mesos agent started on (812)@172.17.0.7:44054
I0905 17:46:40.420577  5802 slave.cpp:253] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_vyefx9/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_UnauthorizedRequest_1_vyefx9/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_UnauthorizedRequest_1_vyefx9/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_UnauthorizedRequest_1_vyefx9/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_UnauthorizedRequest_1_vyefx9/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.5.0/_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" --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_UnauthorizedRequest_1_vyefx9" --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_UnauthorizedRequest_1_ee6AB5" --zk_session_timeout="10secs"
I0905 17:46:40.421098  5802 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_vyefx9/credential'
I0905 17:46:40.421346  5802 slave.cpp:285] Agent using credential for: test-principal
I0905 17:46:40.421370  5802 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_vyefx9/http_credentials'
I0905 17:46:40.421625  5802 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0905 17:46:40.421790  5802 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0905 17:46:40.424052  5802 slave.cpp:581] 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"}]
I0905 17:46:40.424465  5802 slave.cpp:589] Agent attributes: [  ]
I0905 17:46:40.424489  5802 slave.cpp:598] Agent hostname: c7b6aab9db8d
I0905 17:46:40.424743  5798 status_update_manager.cpp:177] Pausing sending status updates
I0905 17:46:40.426295  5797 state.cpp:64] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_ee6AB5/meta'
I0905 17:46:40.426789  5819 status_update_manager.cpp:203] Recovering status update manager
I0905 17:46:40.427047  5811 containerizer.cpp:646] Recovering containerizer
I0905 17:46:40.429096  5810 provisioner.cpp:416] Provisioner recovery complete
I0905 17:46:40.429647  5807 slave.cpp:6296] Finished recovery
I0905 17:46:40.430280  5807 slave.cpp:6478] Querying resource estimator for oversubscribable resources
I0905 17:46:40.430538  5804 slave.cpp:6492] Received oversubscribable resources {} from the resource estimator
I0905 17:46:40.433125  5814 process.cpp:3954] Handling HTTP event for process 'slave(812)' with path: '/slave(812)/monitor/statistics.json'
I0905 17:46:40.434551  5797 http.cpp:1185] HTTP GET for /slave(812)/monitor/statistics.json from 172.17.0.7:40566
I0905 17:46:40.434619  5797 http.cpp:976] Authorizing principal 'test-principal' to GET the '/monitor/statistics.json' endpoint
I0905 17:46:40.437808  5819 slave.cpp:859] Agent terminating
[       OK ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/1 (35 ms)
[ RUN      ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/2
I0905 17:46:40.450978  5777 containerizer.cpp:290] Using isolation { environment_secret, posix/cpu, posix/mem, filesystem/posix, network/cni }
W0905 17:46:40.451627  5777 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0905 17:46:40.451768  5777 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0905 17:46:40.451800  5777 provisioner.cpp:255] Using default backend 'copy'
I0905 17:46:40.458268  5798 slave.cpp:252] Mesos agent started on (813)@172.17.0.7:44054
I0905 17:46:40.458293  5798 slave.cpp:253] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_rrtCxp/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_UnauthorizedRequest_2_rrtCxp/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_UnauthorizedRequest_2_rrtCxp/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_UnauthorizedRequest_2_rrtCxp/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_UnauthorizedRequest_2_rrtCxp/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.5.0/_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" --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_UnauthorizedRequest_2_rrtCxp" --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_UnauthorizedRequest_2_Q4PLwl" --zk_session_timeout="10secs"
I0905 17:46:40.458919  5798 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_rrtCxp/credential'
I0905 17:46:40.459107  5798 slave.cpp:285] Agent using credential for: test-principal
I0905 17:46:40.459131  5798 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_rrtCxp/http_credentials'
I0905 17:46:40.459429  5798 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0905 17:46:40.459640  5798 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0905 17:46:40.461323  5798 slave.cpp:581] 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"}]
I0905 17:46:40.461614  5798 slave.cpp:589] Agent attributes: [  ]
I0905 17:46:40.461629  5798 slave.cpp:598] Agent hostname: c7b6aab9db8d
I0905 17:46:40.461827  5804 status_update_manager.cpp:177] Pausing sending status updates
I0905 17:46:40.463572  5808 state.cpp:64] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_Q4PLwl/meta'
I0905 17:46:40.464040  5809 status_update_manager.cpp:203] Recovering status update manager
I0905 17:46:40.464223  5809 containerizer.cpp:646] Recovering containerizer
I0905 17:46:40.466011  5819 provisioner.cpp:416] Provisioner recovery complete
I0905 17:46:40.466603  5796 slave.cpp:6296] Finished recovery
I0905 17:46:40.467245  5796 slave.cpp:6478] Querying resource estimator for oversubscribable resources
I0905 17:46:40.467538  5799 slave.cpp:6492] Received oversubscribable resources {} from the resource estimator
I0905 17:46:40.470162  5804 process.cpp:3954] Handling HTTP event for process 'slave(813)' with path: '/slave(813)/containers'
I0905 17:46:40.471462  5808 http.cpp:1185] HTTP GET for /slave(813)/containers from 172.17.0.7:40568
I0905 17:46:40.471530  5808 http.cpp:976] Authorizing principal 'test-principal' to GET the '/containers' endpoint
I0905 17:46:40.474397  5777 slave.cpp:859] Agent terminating
[       OK ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/2 (36 ms)
[ RUN      ] Endpoint/SlaveEndpointTest.NoAuthorizer/0
I0905 17:46:40.487300  5777 containerizer.cpp:290] Using isolation { environment_secret, posix/cpu, posix/mem, filesystem/posix, network/cni }
W0905 17:46:40.487830  5777 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0905 17:46:40.487949  5777 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0905 17:46:40.487998  5777 provisioner.cpp:255] Using default backend 'copy'
I0905 17:46:40.489902  5777 cluster.cpp:448] Creating default 'local' authorizer
I0905 17:46:40.492077  5813 slave.cpp:252] Mesos agent started on (814)@172.17.0.7:44054
I0905 17:46:40.492122  5813 slave.cpp:253] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_ZCNCTF/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_NoAuthorizer_0_ZCNCTF/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_NoAuthorizer_0_ZCNCTF/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_NoAuthorizer_0_ZCNCTF/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_NoAuthorizer_0_ZCNCTF/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.5.0/_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" --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_NoAuthorizer_0_ZCNCTF" --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_NoAuthorizer_0_QSmpNB" --zk_session_timeout="10secs"
I0905 17:46:40.492741  5813 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_ZCNCTF/credential'
I0905 17:46:40.492981  5813 slave.cpp:285] Agent using credential for: test-principal
I0905 17:46:40.493022  5813 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_ZCNCTF/http_credentials'
I0905 17:46:40.493329  5813 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0905 17:46:40.493549  5813 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0905 17:46:40.495220  5813 slave.cpp:581] 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"}]
I0905 17:46:40.495507  5813 slave.cpp:589] Agent attributes: [  ]
I0905 17:46:40.495522  5813 slave.cpp:598] Agent hostname: c7b6aab9db8d
I0905 17:46:40.495713  5797 status_update_manager.cpp:177] Pausing sending status updates
I0905 17:46:40.497489  5799 state.cpp:64] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_QSmpNB/meta'
I0905 17:46:40.497828  5796 status_update_manager.cpp:203] Recovering status update manager
I0905 17:46:40.498052  5817 containerizer.cpp:646] Recovering containerizer
I0905 17:46:40.499678  5816 provisioner.cpp:416] Provisioner recovery complete
I0905 17:46:40.500115  5818 slave.cpp:6296] Finished recovery
I0905 17:46:40.500655  5818 slave.cpp:6478] Querying resource estimator for oversubscribable resources
I0905 17:46:40.500952  5803 slave.cpp:6492] Received oversubscribable resources {} from the resource estimator
I0905 17:46:40.503276  5797 process.cpp:3954] Handling HTTP event for process 'slave(814)' with path: '/slave(814)/monitor/statistics'
I0905 17:46:40.504837  5796 http.cpp:1185] HTTP GET for /slave(814)/monitor/statistics from 172.17.0.7:40570
I0905 17:46:40.504971  5796 http.cpp:976] Authorizing principal 'test-principal' to GET the '/monitor/statistics' endpoint
I0905 17:46:40.509230  5777 slave.cpp:859] Agent terminating
[       OK ] Endpoint/SlaveEndpointTest.NoAuthorizer/0 (35 ms)
[ RUN      ] Endpoint/SlaveEndpointTest.NoAuthorizer/1
I0905 17:46:40.522537  5777 containerizer.cpp:290] Using isolation { environment_secret, posix/cpu, posix/mem, filesystem/posix, network/cni }
W0905 17:46:40.523021  5777 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0905 17:46:40.523139  5777 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0905 17:46:40.523171  5777 provisioner.cpp:255] Using default backend 'copy'
I0905 17:46:40.524924  5777 cluster.cpp:448] Creating default 'local' authorizer
I0905 17:46:40.526913  5801 slave.cpp:252] Mesos agent started on (815)@172.17.0.7:44054
I0905 17:46:40.526947  5801 slave.cpp:253] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_396fAW/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_NoAuthorizer_1_396fAW/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_NoAuthorizer_1_396fAW/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_NoAuthorizer_1_396fAW/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_NoAuthorizer_1_396fAW/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.5.0/_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" --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_NoAuthorizer_1_396fAW" --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_NoAuthorizer_1_8WTOoS" --zk_session_timeout="10secs"
I0905 17:46:40.527318  5801 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_396fAW/credential'
I0905 17:46:40.527460  5801 slave.cpp:285] Agent using credential for: test-principal
I0905 17:46:40.527483  5801 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_396fAW/http_credentials'
I0905 17:46:40.527706  5801 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0905 17:46:40.527892  5801 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0905 17:46:40.529414  5801 slave.cpp:581] 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"}]
I0905 17:46:40.529673  5801 slave.cpp:589] Agent attributes: [  ]
I0905 17:46:40.529687  5801 slave.cpp:598] Agent hostname: c7b6aab9db8d
I0905 17:46:40.529822  5804 status_update_manager.cpp:177] Pausing sending status updates
I0905 17:46:40.531194  5817 state.cpp:64] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_8WTOoS/meta'
I0905 17:46:40.531493  5806 status_update_manager.cpp:203] Recovering status update manager
I0905 17:46:40.531690  5813 containerizer.cpp:646] Recovering containerizer
I0905 17:46:40.533017  5805 provisioner.cpp:416] Provisioner recovery complete
I0905 17:46:40.533562  5811 slave.cpp:6296] Finished recovery
I0905 17:46:40.533999  5811 slave.cpp:6478] Querying resource estimator for oversubscribable resources
I0905 17:46:40.534271  5802 slave.cpp:6492] Received oversubscribable resources {} from the resource estimator
I0905 17:46:40.537003  5819 process.cpp:3954] Handling HTTP event for process 'slave(815)' with path: '/slave(815)/monitor/statistics.json'
I0905 17:46:40.538156  5805 http.cpp:1185] HTTP GET for /slave(815)/monitor/statistics.json from 172.17.0.7:40572
I0905 17:46:40.538261  5805 http.cpp:976] Authorizing principal 'test-principal' to GET the '/monitor/statistics.json' endpoint
I0905 17:46:40.542526  5777 slave.cpp:859] Agent terminating
[       OK ] Endpoint/SlaveEndpointTest.NoAuthorizer/1 (34 ms)
[ RUN      ] Endpoint/SlaveEndpointTest.NoAuthorizer/2
I0905 17:46:40.559696  5777 containerizer.cpp:290] Using isolation { environment_secret, posix/cpu, posix/mem, filesystem/posix, network/cni }
W0905 17:46:40.560195  5777 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0905 17:46:40.560304  5777 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0905 17:46:40.560336  5777 provisioner.cpp:255] Using default backend 'copy'
I0905 17:46:40.562340  5777 cluster.cpp:448] Creating default 'local' authorizer
I0905 17:46:40.564620  5810 slave.cpp:252] Mesos agent started on (816)@172.17.0.7:44054
I0905 17:46:40.564648  5810 slave.cpp:253] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_spdEBd/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_NoAuthorizer_2_spdEBd/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_NoAuthorizer_2_spdEBd/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_NoAuthorizer_2_spdEBd/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_NoAuthorizer_2_spdEBd/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.5.0/_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" --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_NoAuthorizer_2_spdEBd" --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_NoAuthorizer_2_EF5Sk9" --zk_session_timeout="10secs"
I0905 17:46:40.565033  5810 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_spdEBd/credential'
I0905 17:46:40.565186  5810 slave.cpp:285] Agent using credential for: test-principal
I0905 17:46:40.565208  5810 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_spdEBd/http_credentials'
I0905 17:46:40.565429  5810 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0905 17:46:40.565572  5810 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0905 17:46:40.567004  5810 slave.cpp:581] 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"}]
I0905 17:46:40.567245  5810 slave.cpp:589] Agent attributes: [  ]
I0905 17:46:40.567256  5810 slave.cpp:598] Agent hostname: c7b6aab9db8d
I0905 17:46:40.567430  5802 status_update_manager.cpp:177] Pausing sending status updates
I0905 17:46:40.568845  5808 state.cpp:64] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_EF5Sk9/meta'
I0905 17:46:40.569213  5807 status_update_manager.cpp:203] Recovering status update manager
I0905 17:46:40.569388  5808 containerizer.cpp:646] Recovering containerizer
I0905 17:46:40.571086  5814 provisioner.cpp:416] Provisioner recovery complete
I0905 17:46:40.571486  5801 slave.cpp:6296] Finished recovery
I0905 17:46:40.571993  5801 slave.cpp:6478] Querying resource estimator for oversubscribable resources
I0905 17:46:40.572224  5806 slave.cpp:6492] Received oversubscribable resources {} from the resource estimator
I0905 17:46:40.575232  5809 process.cpp:3954] Handling HTTP event for process 'slave(816)' with path: '/slave(816)/containers'
I0905 17:46:40.576479  5814 http.cpp:1185] HTTP GET for /slave(816)/containers from 172.17.0.7:40574
I0905 17:46:40.576542  5814 http.cpp:976] Authorizing principal 'test-principal' to GET the '/containers' endpoint
I0905 17:46:40.580374  5777 slave.cpp:859] Agent terminating
[       OK ] Endpoint/SlaveEndpointTest.NoAuthorizer/2 (36 ms)
[----------] 9 tests from Endpoint/SlaveEndpointTest (316 ms total)

[----------] 2 tests from ContainerizerType/DefaultContainerDNSFlagTest
[ RUN      ] ContainerizerType/DefaultContainerDNSFlagTest.ValidateFlag/0
[       OK ] ContainerizerType/DefaultContainerDNSFlagTest.ValidateFlag/0 (11 ms)
[ RUN      ] ContainerizerType/DefaultContainerDNSFlagTest.ValidateFlag/1
[       OK ] ContainerizerType/DefaultContainerDNSFlagTest.ValidateFlag/1 (9 ms)
[----------] 2 tests from ContainerizerType/DefaultContainerDNSFlagTest (20 ms total)

[----------] Global test environment tear-down
[==========] 1667 tests from 183 test cases ran. (622423 ms total)
[  PASSED  ] 1663 tests.
[  FAILED  ] 4 tests, listed below:
[  FAILED  ] DefaultExecutorCheckTest.CommandCheckDeliveredAndReconciled
[  FAILED  ] DefaultExecutorCheckTest.CommandCheckStatusChange
[  FAILED  ] DefaultExecutorCheckTest.CommandCheckSeesParentsEnv
[  FAILED  ] DefaultExecutorCheckTest.CommandCheckSharesWorkDirWithTask

 4 FAILED TESTS
  YOU HAVE 20 DISABLED TESTS

I0905 17:46:40.665262  5820 process.cpp:1072] Failed to accept socket: future discarded
make[4]: *** [check-local] Error 1
make[4]: Leaving directory `/mesos/mesos-1.5.0/_build/src'
make[3]: *** [check-am] Error 2
make[3]: Leaving directory `/mesos/mesos-1.5.0/_build/src'
make[2]: *** [check] Error 2
make[2]: Leaving directory `/mesos/mesos-1.5.0/_build/src'
make[1]: *** [check-recursive] Error 1
make[1]: Leaving directory `/mesos/mesos-1.5.0/_build'
make: *** [distcheck] Error 1
+ docker rmi mesos-1504630271-30976
Untagged: mesos-1504630271-30976:latest
Deleted: sha256:ebb5743b285b1f6bcb83fe8390f067e3cf57aa4d167c59a56cd47460ab6d3702
Deleted: sha256:dc502ea933a6fa22f7615c747c2605cc2de9b60cdc1ff8f5b703a82925c22901
Deleted: sha256:e0c59353d86c99e755bc278d66acf4dec006478ce9e02ef3af7b3a656d16d594
Deleted: sha256:666e1e232759776ba3e9d6dce4897b9d860970a95e6220de7b1d1c41fdc58ba6
Deleted: sha256:ebc73eee07315aa8672b6d95a37111e883f611f348e1d6bdddf7c8455a0bfa96
Deleted: sha256:149cfa73ea0ec0fdbb66a1c27bce2355268ba5ed61f0bcdf8ec0e70042ec7abe
Deleted: sha256:de24dabd6271023201f127e57b5d823a880c15a8c27f76fc38cfc58ccf1535a5
Deleted: sha256:ee619faad147ac9bb96df8eca1e7a380b1a09241de415d8989d4987bab0d12ae
Deleted: sha256:1862463b6c3ff7a4e05bff579e5c1325e269252fecc10fe66022f729bae18f3a
Deleted: sha256:a57ee6c73a5630a8c3786e1d8e4aba8d0dae3640164aa6b039b5b0a4d8132980
Deleted: sha256:43713ec82fd4dc1bc62d1b23de3a73dac9980fe3f2ad535143b7c67641300539
Deleted: sha256:58f2a9cf91008e07bf0502d285d7add1719d9529ce643487517f90a94221b6dd
Deleted: sha256:a70f3922746ff2da3c4d9c61ebacddbaa1d4a52798dd877ae15b6aee68a266d9
Deleted: sha256:3d57caaa44b463abc259e7faa6518f28a0bb8f936286d737a6fa3087061b8403
Deleted: sha256:73874c038a1d645871c3e9624604e9bb1b4d95a14e3e4fc615694247a0db690a
Deleted: sha256:2494ad0225eea1dd2286c4d7c53687e7d0054c8989407dd72136d08814105e82
Deleted: sha256:a4541d8440234f105a11641c150955abf0bb7ac20a50a07e9ad95615a1a17d61
Deleted: sha256:532073e3a1e275933c95d4ae8545bf20bd6dfa589f4c47a1e052568dce340e62
Deleted: sha256:6bf42007010d6e3b78c04365e755cb2969355ad7d799158dae7b709ac85df41a
Deleted: sha256:1ac99fd8896dc4ba6a271038cc5f7e4a13f1371b9efabd246de6ec81f5c1b246
Deleted: sha256:cae1377b001256b2e0df8c3a42dbf6bc36e4eff6e1fa113786893e6d0cbc6130
Deleted: sha256:0e7ce05ae78bcc3192ee7303135955d36b0b95a054e5fa01b8efc0e5d0b0d656
Deleted: sha256:7114387180a0feb5a413d717964a8aa7ceeefe39f783c8257f2c27706ef5f51f
Deleted: sha256:5da48781a3d06502d1b184af0586ae1c53ad2007f66d23184c11af421d1a9808
Build step 'Execute shell' marked build as failure