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/03/23 22:43:07 UTC

Build failed in Jenkins: Mesos-Buildbot » cmake,gcc,--verbose --enable-libevent --enable-ssl,GLOG_v=1 MESOS_VERBOSE=1,ubuntu:14.04,(docker||Hadoop)&&(!ubuntu-us1)&&(!ubuntu-eu2) #3405

See <https://builds.apache.org/job/Mesos-Buildbot/BUILDTOOL=cmake,COMPILER=gcc,CONFIGURATION=--verbose%20--enable-libevent%20--enable-ssl,ENVIRONMENT=GLOG_v=1%20MESOS_VERBOSE=1,OS=ubuntu%3A14.04,label_exp=(docker%7C%7CHadoop)&&(!ubuntu-us1)&&(!ubuntu-eu2)/3405/display/redirect?page=changes>

Changes:

[toenshoff] Fixed flags logging in Docker executor.

------------------------------------------
[...truncated 12.13 MB...]
I0323 22:42:28.394698 27164 status_update_manager.cpp:323] Received status update TASK_RUNNING (UUID: 610592cd-df86-4291-bad2-2871c893db94) for task 1 of framework 1fb2b9f4-336d-4900-9095-e2a623caeb59-0000
I0323 22:42:28.394719 27164 status_update_manager.cpp:500] Creating StatusUpdate stream for task 1 of framework 1fb2b9f4-336d-4900-9095-e2a623caeb59-0000
I0323 22:42:28.394881 27164 status_update_manager.cpp:377] Forwarding update TASK_RUNNING (UUID: 610592cd-df86-4291-bad2-2871c893db94) for task 1 of framework 1fb2b9f4-336d-4900-9095-e2a623caeb59-0000 to the agent
I0323 22:42:28.395015 27164 slave.cpp:4256] Forwarding the update TASK_RUNNING (UUID: 610592cd-df86-4291-bad2-2871c893db94) for task 1 of framework 1fb2b9f4-336d-4900-9095-e2a623caeb59-0000 to master@172.17.0.3:44984
I0323 22:42:28.395192 27171 master.cpp:6154] Status update TASK_RUNNING (UUID: 610592cd-df86-4291-bad2-2871c893db94) for task 1 of framework 1fb2b9f4-336d-4900-9095-e2a623caeb59-0000 from agent 1fb2b9f4-336d-4900-9095-e2a623caeb59-S0 at slave(286)@172.17.0.3:44984 (16c34212bed6)
I0323 22:42:28.395228 27171 master.cpp:6222] Forwarding status update TASK_RUNNING (UUID: 610592cd-df86-4291-bad2-2871c893db94) for task 1 of framework 1fb2b9f4-336d-4900-9095-e2a623caeb59-0000
I0323 22:42:28.395298 27171 master.cpp:8302] Updating the state of task 1 of framework 1fb2b9f4-336d-4900-9095-e2a623caeb59-0000 (latest state: TASK_RUNNING, status update state: TASK_RUNNING)
I0323 22:42:28.395325 27164 slave.cpp:4150] Status update manager successfully handled status update TASK_RUNNING (UUID: 610592cd-df86-4291-bad2-2871c893db94) for task 1 of framework 1fb2b9f4-336d-4900-9095-e2a623caeb59-0000
I0323 22:42:28.395349 27164 slave.cpp:4166] Sending acknowledgement for status update TASK_RUNNING (UUID: 610592cd-df86-4291-bad2-2871c893db94) for task 1 of framework 1fb2b9f4-336d-4900-9095-e2a623caeb59-0000 to executor(120)@172.17.0.3:44984
I0323 22:42:28.395438 27162 exec.cpp:374] Executor received status update acknowledgement 610592cd-df86-4291-bad2-2871c893db94 for task 1 of framework 1fb2b9f4-336d-4900-9095-e2a623caeb59-0000
I0323 22:42:28.395542 27171 sched.cpp:1041] Scheduler::statusUpdate took 144944ns
I0323 22:42:28.395900 27164 master.cpp:5092] Processing ACKNOWLEDGE call 610592cd-df86-4291-bad2-2871c893db94 for task 1 of framework 1fb2b9f4-336d-4900-9095-e2a623caeb59-0000 (default) at scheduler-c24d85fa-3fda-4e21-a55b-6d8a7fc9450f@172.17.0.3:44984 on agent 1fb2b9f4-336d-4900-9095-e2a623caeb59-S0
I0323 22:42:28.395978 27164 status_update_manager.cpp:395] Received status update acknowledgement (UUID: 610592cd-df86-4291-bad2-2871c893db94) for task 1 of framework 1fb2b9f4-336d-4900-9095-e2a623caeb59-0000
I0323 22:42:28.396035 27164 slave.cpp:3105] Status update manager successfully handled status update acknowledgement (UUID: 610592cd-df86-4291-bad2-2871c893db94) for task 1 of framework 1fb2b9f4-336d-4900-9095-e2a623caeb59-0000
I0323 22:42:28.396232 27164 exec.cpp:396] Executor received framework message
I0323 22:42:28.396271 27164 exec.cpp:405] Executor::frameworkMessage took 26124ns
I0323 22:42:28.396512 27168 slave.cpp:4324] Sending message for framework 1fb2b9f4-336d-4900-9095-e2a623caeb59-0000 to scheduler-c24d85fa-3fda-4e21-a55b-6d8a7fc9450f@172.17.0.3:44984
I0323 22:42:28.396654 27167 sched.cpp:1177] Scheduler::frameworkMessage took 25810ns
I0323 22:42:28.396791 27157 sched.cpp:2021] Asked to stop the driver
I0323 22:42:28.396859 27158 sched.cpp:1203] Stopping framework 1fb2b9f4-336d-4900-9095-e2a623caeb59-0000
I0323 22:42:28.396936 27158 master.cpp:7705] Processing TEARDOWN call for framework 1fb2b9f4-336d-4900-9095-e2a623caeb59-0000 (default) at scheduler-c24d85fa-3fda-4e21-a55b-6d8a7fc9450f@172.17.0.3:44984
I0323 22:42:28.396952 27158 master.cpp:7717] Removing framework 1fb2b9f4-336d-4900-9095-e2a623caeb59-0000 (default) at scheduler-c24d85fa-3fda-4e21-a55b-6d8a7fc9450f@172.17.0.3:44984
I0323 22:42:28.396965 27158 master.cpp:3081] Deactivating framework 1fb2b9f4-336d-4900-9095-e2a623caeb59-0000 (default) at scheduler-c24d85fa-3fda-4e21-a55b-6d8a7fc9450f@172.17.0.3:44984
I0323 22:42:28.397017 27158 master.cpp:8302] Updating the state of task 1 of framework 1fb2b9f4-336d-4900-9095-e2a623caeb59-0000 (latest state: TASK_KILLED, status update state: TASK_KILLED)
I0323 22:42:28.397176 27158 master.cpp:8396] Removing task 1 with resources cpus(*)(allocated: *):2; mem(*)(allocated: *):1024; disk(*)(allocated: *):1024; ports(*)(allocated: *):[31000-32000] of framework 1fb2b9f4-336d-4900-9095-e2a623caeb59-0000 on agent 1fb2b9f4-336d-4900-9095-e2a623caeb59-S0 at slave(286)@172.17.0.3:44984 (16c34212bed6)
I0323 22:42:28.397253 27158 master.cpp:8425] Removing executor 'default' with resources {} of framework 1fb2b9f4-336d-4900-9095-e2a623caeb59-0000 on agent 1fb2b9f4-336d-4900-9095-e2a623caeb59-S0 at slave(286)@172.17.0.3:44984 (16c34212bed6)
I0323 22:42:28.397373 27158 hierarchical.cpp:415] Deactivated framework 1fb2b9f4-336d-4900-9095-e2a623caeb59-0000
I0323 22:42:28.397583 27158 hierarchical.cpp:1064] Recovered cpus(*)(allocated: *):2; mem(*)(allocated: *):1024; disk(*)(allocated: *):1024; ports(*)(allocated: *):[31000-32000] (total: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000], allocated: {}) on agent 1fb2b9f4-336d-4900-9095-e2a623caeb59-S0 from framework 1fb2b9f4-336d-4900-9095-e2a623caeb59-0000
I0323 22:42:28.397660 27158 hierarchical.cpp:362] Removed framework 1fb2b9f4-336d-4900-9095-e2a623caeb59-0000
I0323 22:42:28.397694 27158 slave.cpp:2658] Asked to shut down framework 1fb2b9f4-336d-4900-9095-e2a623caeb59-0000 by master@172.17.0.3:44984
I0323 22:42:28.397709 27158 slave.cpp:2683] Shutting down framework 1fb2b9f4-336d-4900-9095-e2a623caeb59-0000
I0323 22:42:28.397720 27158 slave.cpp:5075] Shutting down executor 'default' of framework 1fb2b9f4-336d-4900-9095-e2a623caeb59-0000 at executor(120)@172.17.0.3:44984
I0323 22:42:28.397941 27158 exec.cpp:415] Executor asked to shutdown
I0323 22:42:28.397961 27158 exec.cpp:430] Executor::shutdown took 7972ns
I0323 22:42:28.398048 27158 slave.cpp:4388] Got exited event for executor(120)@172.17.0.3:44984
I0323 22:42:28.398319 27163 slave.cpp:4761] Executor 'default' of framework 1fb2b9f4-336d-4900-9095-e2a623caeb59-0000 exited with status 0
I0323 22:42:28.398363 27163 slave.cpp:4861] Cleaning up executor 'default' of framework 1fb2b9f4-336d-4900-9095-e2a623caeb59-0000 at executor(120)@172.17.0.3:44984
W0323 22:42:28.398398 27168 master.cpp:6278] Ignoring unknown exited executor 'default' of framework 1fb2b9f4-336d-4900-9095-e2a623caeb59-0000 on agent 1fb2b9f4-336d-4900-9095-e2a623caeb59-S0 at slave(286)@172.17.0.3:44984 (16c34212bed6)
I0323 22:42:28.398522 27164 gc.cpp:55] Scheduling '/tmp/MasterTest_FrameworkMessage_M5esmE/slaves/1fb2b9f4-336d-4900-9095-e2a623caeb59-S0/frameworks/1fb2b9f4-336d-4900-9095-e2a623caeb59-0000/executors/default/runs/b7db8490-d879-4c8e-ac95-b5fe7745319e' for gc 6.99999538798519days in the future
I0323 22:42:28.398583 27163 slave.cpp:4949] Cleaning up framework 1fb2b9f4-336d-4900-9095-e2a623caeb59-0000
I0323 22:42:28.398625 27169 gc.cpp:55] Scheduling '/tmp/MasterTest_FrameworkMessage_M5esmE/slaves/1fb2b9f4-336d-4900-9095-e2a623caeb59-S0/frameworks/1fb2b9f4-336d-4900-9095-e2a623caeb59-0000/executors/default' for gc 6.99999538702519days in the future
I0323 22:42:28.398754 27163 gc.cpp:55] Scheduling '/tmp/MasterTest_FrameworkMessage_M5esmE/slaves/1fb2b9f4-336d-4900-9095-e2a623caeb59-S0/frameworks/1fb2b9f4-336d-4900-9095-e2a623caeb59-0000' for gc 6.99999538514963days in the future
I0323 22:42:28.398818 27166 status_update_manager.cpp:285] Closing status update streams for framework 1fb2b9f4-336d-4900-9095-e2a623caeb59-0000
I0323 22:42:28.398835 27166 status_update_manager.cpp:531] Cleaning up status update stream for task 1 of framework 1fb2b9f4-336d-4900-9095-e2a623caeb59-0000
I0323 22:42:28.399034 27157 slave.cpp:803] Agent terminating
I0323 22:42:28.399152 27173 master.cpp:1264] Agent 1fb2b9f4-336d-4900-9095-e2a623caeb59-S0 at slave(286)@172.17.0.3:44984 (16c34212bed6) disconnected
I0323 22:42:28.399178 27173 master.cpp:3118] Disconnecting agent 1fb2b9f4-336d-4900-9095-e2a623caeb59-S0 at slave(286)@172.17.0.3:44984 (16c34212bed6)
I0323 22:42:28.399204 27173 master.cpp:3137] Deactivating agent 1fb2b9f4-336d-4900-9095-e2a623caeb59-S0 at slave(286)@172.17.0.3:44984 (16c34212bed6)
I0323 22:42:28.399296 27164 hierarchical.cpp:618] Agent 1fb2b9f4-336d-4900-9095-e2a623caeb59-S0 deactivated
I0323 22:42:28.400312 27157 master.cpp:1103] Master terminating
I0323 22:42:28.400563 27167 hierarchical.cpp:549] Removed agent 1fb2b9f4-336d-4900-9095-e2a623caeb59-S0
[       OK ] MasterTest.FrameworkMessage (64 ms)
[ RUN      ] MasterTest.MultipleExecutors
I0323 22:42:28.414582 27157 cluster.cpp:160] Creating default 'local' authorizer
I0323 22:42:28.416651 27170 master.cpp:383] Master 8ca42720-fce2-477a-8f20-fd8a12eb9d55 (16c34212bed6) started on 172.17.0.3:44984
I0323 22:42:28.416748 27170 master.cpp:385] 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/EG4Zn9/credentials" --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" --quiet="false" --recovery_agent_removal_limit="100%" --registry="in_memory" --registry_fetch_timeout="1mins" --registry_gc_interval="15mins" --registry_max_agent_age="2weeks" --registry_max_agent_count="102400" --registry_store_timeout="100secs" --registry_strict="false" --root_submissions="true" --user_sorter="drf" --version="false" --webui_dir="/usr/local/share/mesos/webui" --work_dir="/tmp/EG4Zn9/master" --zk_session_timeout="10secs"
I0323 22:42:28.417250 27170 master.cpp:435] Master only allowing authenticated frameworks to register
I0323 22:42:28.417313 27170 master.cpp:449] Master only allowing authenticated agents to register
I0323 22:42:28.417378 27170 master.cpp:462] Master only allowing authenticated HTTP frameworks to register
I0323 22:42:28.417433 27170 credentials.hpp:37] Loading credentials for authentication from '/tmp/EG4Zn9/credentials'
I0323 22:42:28.417695 27170 master.cpp:507] Using default 'crammd5' authenticator
I0323 22:42:28.417810 27170 http.cpp:919] Using default 'basic' HTTP authenticator for realm 'mesos-master-readonly'
I0323 22:42:28.417960 27170 http.cpp:919] Using default 'basic' HTTP authenticator for realm 'mesos-master-readwrite'
I0323 22:42:28.418118 27170 http.cpp:919] Using default 'basic' HTTP authenticator for realm 'mesos-master-scheduler'
I0323 22:42:28.418283 27170 master.cpp:587] Authorization enabled
I0323 22:42:28.419039 27167 hierarchical.cpp:161] Initialized hierarchical allocator process
I0323 22:42:28.419476 27171 whitelist_watcher.cpp:77] No whitelist given
I0323 22:42:28.420997 27171 master.cpp:2124] Elected as the leading master!
I0323 22:42:28.421118 27171 master.cpp:1646] Recovering from registrar
I0323 22:42:28.421308 27171 registrar.cpp:329] Recovering registrar
I0323 22:42:28.421834 27171 registrar.cpp:362] Successfully fetched the registry (0B) in 374016ns
I0323 22:42:28.421998 27171 registrar.cpp:461] Applied 1 operations in 7914ns; attempting to update the registry
I0323 22:42:28.422538 27171 registrar.cpp:506] Successfully updated the registry in 421120ns
I0323 22:42:28.422694 27171 registrar.cpp:392] Successfully recovered registrar
I0323 22:42:28.422921 27171 master.cpp:1762] Recovered 0 agents from the registry (129B); allowing 10mins for agents to re-register
I0323 22:42:28.423096 27171 hierarchical.cpp:188] Skipping recovery of hierarchical allocator: nothing to recover
I0323 22:42:28.429224 27157 cluster.cpp:446] Creating default 'local' authorizer
I0323 22:42:28.430655 27157 sched.cpp:232] Version: 1.2.1
I0323 22:42:28.431426 27171 slave.cpp:211] Mesos agent started on (287)@172.17.0.3:44984
I0323 22:42:28.431766 27171 slave.cpp:212] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/mesos/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/MasterTest_MultipleExecutors_6Hwk8T/credential" --default_role="*" --disk_watch_interval="1mins" --docker="docker" --docker_kill_orphans="true" --docker_registry="https://registry-1.docker.io" --docker_remove_delay="6hrs" --docker_socket="/var/run/docker.sock" --docker_stop_timeout="0ns" --docker_store_dir="/tmp/mesos/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/MasterTest_MultipleExecutors_6Hwk8T/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_authenticators="basic" --http_command_executor="false" --http_credentials="/tmp/MasterTest_MultipleExecutors_6Hwk8T/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --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/MasterTest_MultipleExecutors_6Hwk8T" --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/MasterTest_MultipleExecutors_dcYUK1"
I0323 22:42:28.432361 27171 credentials.hpp:86] Loading credential for authentication from '/tmp/MasterTest_MultipleExecutors_6Hwk8T/credential'
I0323 22:42:28.432533 27171 slave.cpp:354] Agent using credential for: test-principal
I0323 22:42:28.432610 27171 credentials.hpp:37] Loading credentials for authentication from '/tmp/MasterTest_MultipleExecutors_6Hwk8T/http_credentials'
I0323 22:42:28.432829 27171 http.cpp:919] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0323 22:42:28.432943 27171 http.cpp:919] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0323 22:42:28.433825 27171 slave.cpp:541] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0323 22:42:28.433981 27171 slave.cpp:549] Agent attributes: [  ]
I0323 22:42:28.434029 27171 slave.cpp:554] Agent hostname: 16c34212bed6
I0323 22:42:28.434250 27173 status_update_manager.cpp:177] Pausing sending status updates
I0323 22:42:28.435067 27171 state.cpp:62] Recovering state from '/tmp/MasterTest_MultipleExecutors_dcYUK1/meta'
I0323 22:42:28.435362 27170 status_update_manager.cpp:203] Recovering status update manager
I0323 22:42:28.435665 27170 slave.cpp:5550] Finished recovery
I0323 22:42:28.436286 27170 slave.cpp:5724] Querying resource estimator for oversubscribable resources
I0323 22:42:28.436632 27170 slave.cpp:931] New master detected at master@172.17.0.3:44984
I0323 22:42:28.436658 27169 status_update_manager.cpp:177] Pausing sending status updates
I0323 22:42:28.436801 27170 slave.cpp:966] Detecting new master
I0323 22:42:28.436921 27170 slave.cpp:5738] Received oversubscribable resources {} from the resource estimator
I0323 22:42:28.437211 27160 sched.cpp:336] New master detected at master@172.17.0.3:44984
I0323 22:42:28.437243 27160 sched.cpp:407] Authenticating with master master@172.17.0.3:44984
I0323 22:42:28.437255 27160 sched.cpp:414] Using default CRAM-MD5 authenticatee
I0323 22:42:28.437340 27160 authenticatee.cpp:121] Creating new client SASL connection
I0323 22:42:28.437499 27160 master.cpp:7163] Authenticating scheduler-3fd08d13-be71-4522-a655-3322c0128d1f@172.17.0.3:44984
I0323 22:42:28.437549 27160 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(636)@172.17.0.3:44984
I0323 22:42:28.437615 27160 authenticator.cpp:98] Creating new server SASL connection
I0323 22:42:28.437767 27160 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5
I0323 22:42:28.437788 27160 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5'
I0323 22:42:28.437821 27160 authenticator.cpp:204] Received SASL authentication start
I0323 22:42:28.437865 27160 authenticator.cpp:326] Authentication requires more steps
I0323 22:42:28.437898 27160 authenticatee.cpp:259] Received SASL authentication step
I0323 22:42:28.437938 27160 authenticator.cpp:232] Received SASL authentication step
I0323 22:42:28.437957 27160 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '16c34212bed6' server FQDN: '16c34212bed6' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false 
I0323 22:42:28.437970 27160 auxprop.cpp:181] Looking up auxiliary property '*userPassword'
I0323 22:42:28.437983 27160 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
I0323 22:42:28.437994 27160 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '16c34212bed6' server FQDN: '16c34212bed6' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true 
I0323 22:42:28.438004 27160 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true
I0323 22:42:28.438010 27160 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
I0323 22:42:28.438025 27160 authenticator.cpp:318] Authentication success
I0323 22:42:28.438066 27160 authenticatee.cpp:299] Authentication success
I0323 22:42:28.438096 27160 master.cpp:7193] Successfully authenticated principal 'test-principal' at scheduler-3fd08d13-be71-4522-a655-3322c0128d1f@172.17.0.3:44984
I0323 22:42:28.438122 27160 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(636)@172.17.0.3:44984
I0323 22:42:28.438187 27160 sched.cpp:513] Successfully authenticated with master master@172.17.0.3:44984
I0323 22:42:28.438199 27160 sched.cpp:836] Sending SUBSCRIBE call to master@172.17.0.3:44984
I0323 22:42:28.438232 27160 sched.cpp:869] Will retry registration in 175.925572ms if necessary
I0323 22:42:28.438315 27160 master.cpp:2737] Received SUBSCRIBE call for framework 'default' at scheduler-3fd08d13-be71-4522-a655-3322c0128d1f@172.17.0.3:44984
I0323 22:42:28.438336 27160 master.cpp:2160] Authorizing framework principal 'test-principal' to receive offers for role '*'
I0323 22:42:28.438447 27160 master.cpp:2813] Subscribing framework default with checkpointing disabled and capabilities [  ]
I0323 22:42:28.438637 27160 hierarchical.cpp:286] Added framework 8ca42720-fce2-477a-8f20-fd8a12eb9d55-0000
I0323 22:42:28.438681 27160 hierarchical.cpp:1810] No allocations performed
I0323 22:42:28.438694 27160 hierarchical.cpp:1900] No inverse offers to send out!
I0323 22:42:28.438704 27160 hierarchical.cpp:1394] Performed allocation for 0 agents in 30301ns
I0323 22:42:28.438791 27160 sched.cpp:759] Framework registered with 8ca42720-fce2-477a-8f20-fd8a12eb9d55-0000
I0323 22:42:28.438818 27160 sched.cpp:773] Scheduler::registered took 13573ns
I0323 22:42:28.445040 27160 slave.cpp:993] Authenticating with master master@172.17.0.3:44984
I0323 22:42:28.445065 27160 slave.cpp:1004] Using default CRAM-MD5 authenticatee
I0323 22:42:28.445184 27158 authenticatee.cpp:121] Creating new client SASL connection
I0323 22:42:28.445307 27160 master.cpp:7163] Authenticating slave(287)@172.17.0.3:44984
I0323 22:42:28.445358 27158 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(637)@172.17.0.3:44984
I0323 22:42:28.445418 27160 authenticator.cpp:98] Creating new server SASL connection
I0323 22:42:28.445554 27162 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5
I0323 22:42:28.445576 27162 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5'
I0323 22:42:28.445655 27167 authenticator.cpp:204] Received SASL authentication start
I0323 22:42:28.445698 27167 authenticator.cpp:326] Authentication requires more steps
I0323 22:42:28.445765 27163 authenticatee.cpp:259] Received SASL authentication step
I0323 22:42:28.445817 27163 authenticator.cpp:232] Received SASL authentication step
I0323 22:42:28.445833 27163 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '16c34212bed6' server FQDN: '16c34212bed6' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false 
I0323 22:42:28.445842 27163 auxprop.cpp:181] Looking up auxiliary property '*userPassword'
I0323 22:42:28.445849 27163 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
I0323 22:42:28.445859 27163 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '16c34212bed6' server FQDN: '16c34212bed6' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true 
I0323 22:42:28.445865 27163 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true
I0323 22:42:28.445878 27163 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
I0323 22:42:28.445894 27163 authenticator.cpp:318] Authentication success
I0323 22:42:28.445946 27167 authenticatee.cpp:299] Authentication success
I0323 22:42:28.445950 27163 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(637)@172.17.0.3:44984
I0323 22:42:28.446091 27162 master.cpp:7193] Successfully authenticated principal 'test-principal' at slave(287)@172.17.0.3:44984
I0323 22:42:28.446166 27167 slave.cpp:1088] Successfully authenticated with master master@172.17.0.3:44984
I0323 22:42:28.446257 27167 slave.cpp:1515] Will retry registration in 6.36767ms if necessary
I0323 22:42:28.446378 27164 master.cpp:5378] Registering agent at slave(287)@172.17.0.3:44984 (16c34212bed6) with id 8ca42720-fce2-477a-8f20-fd8a12eb9d55-S0
I0323 22:42:28.446521 27171 registrar.cpp:461] Applied 1 operations in 16318ns; attempting to update the registry
I0323 22:42:28.446897 27172 registrar.cpp:506] Successfully updated the registry in 306176ns
I0323 22:42:28.447135 27172 slave.cpp:4346] Received ping from slave-observer(282)@172.17.0.3:44984
I0323 22:42:28.447158 27170 master.cpp:5452] Registered agent 8ca42720-fce2-477a-8f20-fd8a12eb9d55-S0 at slave(287)@172.17.0.3:44984 (16c34212bed6) with cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0323 22:42:28.447206 27172 slave.cpp:1134] Registered with master master@172.17.0.3:44984; given agent ID 8ca42720-fce2-477a-8f20-fd8a12eb9d55-S0
I0323 22:42:28.447250 27166 hierarchical.cpp:516] Added agent 8ca42720-fce2-477a-8f20-fd8a12eb9d55-S0 (16c34212bed6) with cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] (allocated: {})
I0323 22:42:28.447299 27172 fetcher.cpp:94] Clearing fetcher cache
I0323 22:42:28.447432 27167 status_update_manager.cpp:184] Resuming sending status updates
I0323 22:42:28.447526 27166 hierarchical.cpp:1900] No inverse offers to send out!
I0323 22:42:28.447543 27166 hierarchical.cpp:1394] Performed allocation for 1 agents in 215984ns
I0323 22:42:28.447679 27172 slave.cpp:1162] Checkpointing SlaveInfo to '/tmp/MasterTest_MultipleExecutors_dcYUK1/meta/slaves/8ca42720-fce2-477a-8f20-fd8a12eb9d55-S0/slave.info'
I0323 22:42:28.447774 27173 master.cpp:6992] Sending 1 offers to framework 8ca42720-fce2-477a-8f20-fd8a12eb9d55-0000 (default) at scheduler-3fd08d13-be71-4522-a655-3322c0128d1f@172.17.0.3:44984
I0323 22:42:28.448001 27172 slave.cpp:1200] Forwarding total oversubscribed resources {}
I0323 22:42:28.448007 27162 sched.cpp:933] Scheduler::resourceOffers took 49596ns
I0323 22:42:28.448158 27168 master.cpp:6009] Received update of agent 8ca42720-fce2-477a-8f20-fd8a12eb9d55-S0 at slave(287)@172.17.0.3:44984 (16c34212bed6) with total oversubscribed resources {}
I0323 22:42:28.448285 27168 hierarchical.cpp:589] Agent 8ca42720-fce2-477a-8f20-fd8a12eb9d55-S0 (16c34212bed6) updated with oversubscribed resources {} (total: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000], allocated: cpus(*)(allocated: *):2; mem(*)(allocated: *):1024; disk(*)(allocated: *):1024; ports(*)(allocated: *):[31000-32000])
I0323 22:42:28.448382 27168 hierarchical.cpp:1810] No allocations performed
I0323 22:42:28.448400 27168 hierarchical.cpp:1900] No inverse offers to send out!
I0323 22:42:28.448415 27168 hierarchical.cpp:1394] Performed allocation for 1 agents in 57969ns
I0323 22:42:28.448807 27158 master.cpp:3776] Processing ACCEPT call for offers: [ 8ca42720-fce2-477a-8f20-fd8a12eb9d55-O0 ] on agent 8ca42720-fce2-477a-8f20-fd8a12eb9d55-S0 at slave(287)@172.17.0.3:44984 (16c34212bed6) for framework 8ca42720-fce2-477a-8f20-fd8a12eb9d55-0000 (default) at scheduler-3fd08d13-be71-4522-a655-3322c0128d1f@172.17.0.3:44984
I0323 22:42:28.448853 27158 master.cpp:3352] Authorizing framework principal 'test-principal' to launch task 1
I0323 22:42:28.448949 27158 master.cpp:3352] Authorizing framework principal 'test-principal' to launch task 2
W0323 22:42:28.449492 27162 validation.cpp:1064] 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.
W0323 22:42:28.449513 27162 validation.cpp:1076] 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.
I0323 22:42:28.449589 27162 master.cpp:9053] Adding task 1 with resources cpus(*)(allocated: *):1; mem(*)(allocated: *):512 on agent 8ca42720-fce2-477a-8f20-fd8a12eb9d55-S0 at slave(287)@172.17.0.3:44984 (16c34212bed6)
I0323 22:42:28.449648 27162 master.cpp:4426] Launching task 1 of framework 8ca42720-fce2-477a-8f20-fd8a12eb9d55-0000 (default) at scheduler-3fd08d13-be71-4522-a655-3322c0128d1f@172.17.0.3:44984 with resources cpus(*)(allocated: *):1; mem(*)(allocated: *):512 on agent 8ca42720-fce2-477a-8f20-fd8a12eb9d55-S0 at slave(287)@172.17.0.3:44984 (16c34212bed6)
I0323 22:42:28.449786 27169 slave.cpp:1625] Got assigned task '1' for framework 8ca42720-fce2-477a-8f20-fd8a12eb9d55-0000
W0323 22:42:28.449918 27162 validation.cpp:1064] 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.
W0323 22:42:28.449942 27162 validation.cpp:1076] 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.
I0323 22:42:28.450049 27169 slave.cpp:1785] Launching task '1' for framework 8ca42720-fce2-477a-8f20-fd8a12eb9d55-0000
I0323 22:42:28.450037 27162 master.cpp:9053] Adding task 2 with resources cpus(*)(allocated: *):1; mem(*)(allocated: *):512 on agent 8ca42720-fce2-477a-8f20-fd8a12eb9d55-S0 at slave(287)@172.17.0.3:44984 (16c34212bed6)
I0323 22:42:28.450098 27162 master.cpp:4426] Launching task 2 of framework 8ca42720-fce2-477a-8f20-fd8a12eb9d55-0000 (default) at scheduler-3fd08d13-be71-4522-a655-3322c0128d1f@172.17.0.3:44984 with resources cpus(*)(allocated: *):1; mem(*)(allocated: *):512 on agent 8ca42720-fce2-477a-8f20-fd8a12eb9d55-S0 at slave(287)@172.17.0.3:44984 (16c34212bed6)
I0323 22:42:28.450661 27169 paths.cpp:547] Trying to chown '/tmp/MasterTest_MultipleExecutors_dcYUK1/slaves/8ca42720-fce2-477a-8f20-fd8a12eb9d55-S0/frameworks/8ca42720-fce2-477a-8f20-fd8a12eb9d55-0000/executors/executor-1/runs/5d290407-f3d4-41dd-9c0b-a32a7b139860' to user 'mesos'
I0323 22:42:28.450837 27166 hierarchical.cpp:807] Updated allocation of framework 8ca42720-fce2-477a-8f20-fd8a12eb9d55-0000 on agent 8ca42720-fce2-477a-8f20-fd8a12eb9d55-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]
I0323 22:42:28.450888 27169 slave.cpp:6472] Launching executor 'executor-1' of framework 8ca42720-fce2-477a-8f20-fd8a12eb9d55-0000 with resources {} in work directory '/tmp/MasterTest_MultipleExecutors_dcYUK1/slaves/8ca42720-fce2-477a-8f20-fd8a12eb9d55-S0/frameworks/8ca42720-fce2-477a-8f20-fd8a12eb9d55-0000/executors/executor-1/runs/5d290407-f3d4-41dd-9c0b-a32a7b139860'
I0323 22:42:28.451027 27166 hierarchical.cpp:1064] 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 8ca42720-fce2-477a-8f20-fd8a12eb9d55-S0 from framework 8ca42720-fce2-477a-8f20-fd8a12eb9d55-0000
I0323 22:42:28.451062 27166 hierarchical.cpp:1101] Framework 8ca42720-fce2-477a-8f20-fd8a12eb9d55-0000 filtered agent 8ca42720-fce2-477a-8f20-fd8a12eb9d55-S0 for 5secs
I0323 22:42:28.451095 27169 slave.cpp:2118] Queued task '1' for executor 'executor-1' of framework 8ca42720-fce2-477a-8f20-fd8a12eb9d55-0000
I0323 22:42:28.451185 27169 slave.cpp:1625] Got assigned task '2' for framework 8ca42720-fce2-477a-8f20-fd8a12eb9d55-0000
I0323 22:42:28.451393 27169 slave.cpp:884] Successfully attached file '/tmp/MasterTest_MultipleExecutors_dcYUK1/slaves/8ca42720-fce2-477a-8f20-fd8a12eb9d55-S0/frameworks/8ca42720-fce2-477a-8f20-fd8a12eb9d55-0000/executors/executor-1/runs/5d290407-f3d4-41dd-9c0b-a32a7b139860'
I0323 22:42:28.451431 27169 slave.cpp:1785] Launching task '2' for framework 8ca42720-fce2-477a-8f20-fd8a12eb9d55-0000
I0323 22:42:28.451896 27169 paths.cpp:547] Trying to chown '/tmp/MasterTest_MultipleExecutors_dcYUK1/slaves/8ca42720-fce2-477a-8f20-fd8a12eb9d55-S0/frameworks/8ca42720-fce2-477a-8f20-fd8a12eb9d55-0000/executors/executor-2/runs/717f7332-3b78-45cc-bd60-02686eeb0237' to user 'mesos'
I0323 22:42:28.452060 27169 slave.cpp:6472] Launching executor 'executor-2' of framework 8ca42720-fce2-477a-8f20-fd8a12eb9d55-0000 with resources {} in work directory '/tmp/MasterTest_MultipleExecutors_dcYUK1/slaves/8ca42720-fce2-477a-8f20-fd8a12eb9d55-S0/frameworks/8ca42720-fce2-477a-8f20-fd8a12eb9d55-0000/executors/executor-2/runs/717f7332-3b78-45cc-bd60-02686eeb0237'
*** Aborted at 1490308948 (unix time) try "date -d @1490308948" if you are using GNU date ***
I0323 22:42:28.452301 27166 exec.cpp:162] Version: 1.2.1
PC: @     0x2abba8f1482d (unknown)
*** SIGSEGV (@0xb0) received by PID 27157 (TID 0x2abbb2468700) from PID 176; stack trace: ***
I0323 22:42:28.452589 27166 exec.cpp:212] Executor started at: executor(121)@172.17.0.3:44984 with pid 27157
    @     0x2abba84ab330 (unknown)
    @     0x2abba8f1482d (unknown)
    @     0x2abba5a09644 mesos::internal::slave::executorEnvironment()
    @     0x2abba5a348d7 mesos::internal::slave::Framework::launchExecutor()
    @     0x2abba5a37837 mesos::internal::slave::Slave::_run()
    @     0x2abba6cd0ec1 process::ProcessManager::resume()
    @     0x2abba6cd9d67 _ZNSt6thread5_ImplISt12_Bind_simpleIFZN7process14ProcessManager12init_threadsEvEUt_vEEE6_M_runEv
    @     0x2abba876aa60 (unknown)
    @     0x2abba84a3184 start_thread
    @     0x2abba8fd6bed (unknown)
make[3]: *** [CMakeFiles/check] Segmentation fault
make[3]: Leaving directory `/mesos/build'
make[2]: *** [CMakeFiles/check.dir/all] Error 2
make[2]: Leaving directory `/mesos/build'
make[1]: *** [CMakeFiles/check.dir/rule] Error 2
make[1]: Leaving directory `/mesos/build'
make: *** [check] Error 2
+ docker rmi mesos-1490304130-8075
Untagged: mesos-1490304130-8075:latest
Deleted: sha256:b683535c8919119814700d1c099c0a0bedc60877fafb4ea51049e95174724181
Deleted: sha256:d152d211500714aaeae1958f6b842a57081380b6d4262c2c8cd2bcd7192eda33
Deleted: sha256:c19b3aed9a55502de0c0e96a02cdba18ab8726eb635bf969882328655d7300db
Deleted: sha256:ff81a46efa76a07c6ed01a61bb0e065308642bf403c496b88fb0234dd77c945d
Deleted: sha256:3521cca2a6a7b33fcdd443b29d5d75d351471da47b099caf205eb5614a90d227
Deleted: sha256:d6a5708de757bdd0843a2db66b50d7f7ffc53b9df42d06321221d7b0d7294e51
Deleted: sha256:20165caff5baef0421aaf19af9535b225c88f8c6fae8137723875d31d9fa4e94
Deleted: sha256:8bd20a77bc07d8ba6363e1f663eab37a055c4b5fa7e7f29b69562412ef8559d1
Deleted: sha256:e06f51d7afce67c0b44cd42611ea903fb69d6c06e62bf17e0101e6a5843a144b
Deleted: sha256:d4d8c4e80f604486d717c9c9b29bea98bbf4a789f46541d4e0a54c3ce859ad7a
Deleted: sha256:1af1d42f84726a4bb59931e105389142bc32caf8fd0b89d813f669228acd38e8
Deleted: sha256:641647c5a6f3ffa3a8d2e5e9a5877ac6bc13caf49ec8e7a23cadeb3281d4143a
Deleted: sha256:70196dc002bce07f56fe9dbb00dfee4331f91a5bc7d8ea0b74b814777d2424f2
Deleted: sha256:a34d168dcb8df45c6531ed3b96788574a64c164dd7f87baf35ba1107cb6ac1fa
Deleted: sha256:179b0aca07634224ce6c62da8d6186d6d97d21d65772793f4b36a48d13cf449d
Deleted: sha256:378c687d833cc58a4ae8b6f4d732a0af8673312aa525bcde64b42614327f38ec
Deleted: sha256:1a00a81c9c757a21329150281b65bace4bf7134ede7e74e7d04c8f2de870df58
Deleted: sha256:cc8f864fbbd90e4cb9c2ce352cc5468e7130bd8860f831ae4d79d393f73248b8
Deleted: sha256:9bea169cb0bc0f855afe75e13ee933938e783785fe222af349a5cc42c8871f1f
Deleted: sha256:4bbbd9669218d9fe47fea0ccd189dc2c70ef49985a7f6be62e5b4134d0a342f4
Deleted: sha256:423d74247b8aee6ddf3fde9ccfd1efbd5a9926f3308bef174ec48e919c93f2fb
Deleted: sha256:05ca526ab6642b7350f8acbfdbd83fdc229f7b2178a3e1f71ea7c5967579ea32
Deleted: sha256:889731ac58141d04101a7c5193845b8ab378761df3edf09701849a2cf7cd5441
Deleted: sha256:747128479da0aaa9211e2c9c0c77ac457a71859eb5cb9e9fe6914e197b83bed1
Build step 'Execute shell' marked build as failure

Jenkins build is back to normal : Mesos-Buildbot » cmake,gcc,--verbose --enable-libevent --enable-ssl,GLOG_v=1 MESOS_VERBOSE=1,ubuntu:14.04,(docker||Hadoop)&&(!ubuntu-us1)&&(!ubuntu-eu2) #3408

Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/Mesos-Buildbot/BUILDTOOL=cmake,COMPILER=gcc,CONFIGURATION=--verbose%20--enable-libevent%20--enable-ssl,ENVIRONMENT=GLOG_v=1%20MESOS_VERBOSE=1,OS=ubuntu%3A14.04,label_exp=(docker%7C%7CHadoop)&&(!ubuntu-us1)&&(!ubuntu-eu2)/3408/display/redirect?page=changes>


Build failed in Jenkins: Mesos-Buildbot » cmake,gcc,--verbose --enable-libevent --enable-ssl,GLOG_v=1 MESOS_VERBOSE=1,ubuntu:14.04,(docker||Hadoop)&&(!ubuntu-us1)&&(!ubuntu-eu2) #3407

Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/Mesos-Buildbot/BUILDTOOL=cmake,COMPILER=gcc,CONFIGURATION=--verbose%20--enable-libevent%20--enable-ssl,ENVIRONMENT=GLOG_v=1%20MESOS_VERBOSE=1,OS=ubuntu%3A14.04,label_exp=(docker%7C%7CHadoop)&&(!ubuntu-us1)&&(!ubuntu-eu2)/3407/display/redirect?page=changes>

Changes:

[neil.conway] Fixed crash with tasks that use very small resource values.

[neil.conway] Added MESOS-7197 to CHANGELOG for 1.2.1.

------------------------------------------
[...truncated 26.40 MB...]
I0324 01:47:49.559010 27159 status_update_manager.cpp:177] Pausing sending status updates
I0324 01:47:49.559289 27159 state.cpp:62] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_1_3qz4mY/meta'
I0324 01:47:49.559432 27159 status_update_manager.cpp:203] Recovering status update manager
I0324 01:47:49.559499 27159 containerizer.cpp:600] Recovering containerizer
I0324 01:47:49.560127 27159 provisioner.cpp:410] Provisioner recovery complete
I0324 01:47:49.560292 27159 slave.cpp:5550] Finished recovery
I0324 01:47:49.560719 27159 slave.cpp:5724] Querying resource estimator for oversubscribable resources
I0324 01:47:49.560895 27159 slave.cpp:5738] Received oversubscribable resources {} from the resource estimator
I0324 01:47:49.571728 27160 process.cpp:3704] Handling HTTP event for process 'slave(694)' with path: '/slave(694)/monitor/statistics.json'
I0324 01:47:49.572170 27160 http.cpp:871] Authorizing principal 'test-principal' to GET the '/monitor/statistics.json' endpoint
I0324 01:47:49.573704 27166 slave.cpp:803] Agent terminating
[       OK ] Endpoint/SlaveEndpointTest.AuthorizedRequest/1 (74 ms)
[ RUN      ] Endpoint/SlaveEndpointTest.AuthorizedRequest/2
I0324 01:47:49.629712 27154 containerizer.cpp:221] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni
W0324 01:47:49.629976 27154 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0324 01:47:49.630012 27154 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0324 01:47:49.630031 27154 provisioner.cpp:249] Using default backend 'copy'
I0324 01:47:49.631273 27166 slave.cpp:211] Mesos agent started on (695)@172.17.0.3:42600
I0324 01:47:49.631301 27166 slave.cpp:212] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/mesos/store/appc" --authenticate_http_readonly="true" --authenticate_http_readwrite="true" --authenticatee="crammd5" --authentication_backoff_factor="1secs" --authorizer="local" --cgroups_cpu_enable_pids_and_tids_count="false" --cgroups_enable_cfs="false" --cgroups_hierarchy="/sys/fs/cgroup" --cgroups_limit_swap="false" --cgroups_root="mesos" --container_disk_watch_interval="15secs" --containerizers="mesos" --credential="/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_rMG5fW/credential" --default_role="*" --disk_watch_interval="1mins" --docker="docker" --docker_kill_orphans="true" --docker_registry="https://registry-1.docker.io" --docker_remove_delay="6hrs" --docker_socket="/var/run/docker.sock" --docker_stop_timeout="0ns" --docker_store_dir="/tmp/mesos/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_rMG5fW/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_authenticators="basic" --http_command_executor="false" --http_credentials="/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_rMG5fW/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --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_AuthorizedRequest_2_rMG5fW" --sandbox_directory="/mnt/mesos/sandbox" --strict="true" --switch_user="true" --systemd_enable_support="true" --systemd_runtime_directory="/run/systemd/system" --version="false" --work_dir="/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_nH8p08"
I0324 01:47:49.631672 27166 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_rMG5fW/credential'
I0324 01:47:49.631759 27166 slave.cpp:354] Agent using credential for: test-principal
I0324 01:47:49.631777 27166 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_rMG5fW/http_credentials'
I0324 01:47:49.631880 27166 http.cpp:919] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0324 01:47:49.631932 27166 http.cpp:919] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0324 01:47:49.632347 27166 slave.cpp:541] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0324 01:47:49.632390 27166 slave.cpp:549] Agent attributes: [  ]
I0324 01:47:49.632401 27166 slave.cpp:554] Agent hostname: 0b68c2b9f456
I0324 01:47:49.632488 27156 status_update_manager.cpp:177] Pausing sending status updates
I0324 01:47:49.632798 27166 state.cpp:62] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_nH8p08/meta'
I0324 01:47:49.632911 27165 status_update_manager.cpp:203] Recovering status update manager
I0324 01:47:49.633019 27158 containerizer.cpp:600] Recovering containerizer
I0324 01:47:49.633569 27167 provisioner.cpp:410] Provisioner recovery complete
I0324 01:47:49.633723 27167 slave.cpp:5550] Finished recovery
I0324 01:47:49.634058 27167 slave.cpp:5724] Querying resource estimator for oversubscribable resources
I0324 01:47:49.634169 27156 slave.cpp:5738] Received oversubscribable resources {} from the resource estimator
I0324 01:47:49.634878 27168 process.cpp:3704] Handling HTTP event for process 'slave(695)' with path: '/slave(695)/containers'
I0324 01:47:49.635295 27159 http.cpp:871] Authorizing principal 'test-principal' to GET the '/containers' endpoint
I0324 01:47:49.637379 27156 slave.cpp:803] Agent terminating
[       OK ] Endpoint/SlaveEndpointTest.AuthorizedRequest/2 (18 ms)
[ RUN      ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/0
I0324 01:47:49.690814 27154 containerizer.cpp:221] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni
W0324 01:47:49.691220 27154 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0324 01:47:49.691284 27154 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0324 01:47:49.691308 27154 provisioner.cpp:249] Using default backend 'copy'
I0324 01:47:49.692661 27157 slave.cpp:211] Mesos agent started on (696)@172.17.0.3:42600
I0324 01:47:49.692677 27157 slave.cpp:212] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/mesos/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_NKmSK7/credential" --default_role="*" --disk_watch_interval="1mins" --docker="docker" --docker_kill_orphans="true" --docker_registry="https://registry-1.docker.io" --docker_remove_delay="6hrs" --docker_socket="/var/run/docker.sock" --docker_stop_timeout="0ns" --docker_store_dir="/tmp/mesos/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_NKmSK7/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_authenticators="basic" --http_command_executor="false" --http_credentials="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_NKmSK7/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --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_NKmSK7" --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_9ZEnlk"
I0324 01:47:49.693023 27157 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_NKmSK7/credential'
I0324 01:47:49.693115 27157 slave.cpp:354] Agent using credential for: test-principal
I0324 01:47:49.693131 27157 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_NKmSK7/http_credentials'
I0324 01:47:49.693258 27157 http.cpp:919] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0324 01:47:49.693312 27157 http.cpp:919] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0324 01:47:49.693754 27157 slave.cpp:541] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0324 01:47:49.693789 27157 slave.cpp:549] Agent attributes: [  ]
I0324 01:47:49.693794 27157 slave.cpp:554] Agent hostname: 0b68c2b9f456
I0324 01:47:49.693874 27155 status_update_manager.cpp:177] Pausing sending status updates
I0324 01:47:49.694200 27157 state.cpp:62] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_9ZEnlk/meta'
I0324 01:47:49.694476 27169 status_update_manager.cpp:203] Recovering status update manager
I0324 01:47:49.694550 27169 containerizer.cpp:600] Recovering containerizer
I0324 01:47:49.695104 27157 provisioner.cpp:410] Provisioner recovery complete
I0324 01:47:49.695314 27159 slave.cpp:5550] Finished recovery
I0324 01:47:49.695786 27159 slave.cpp:5724] Querying resource estimator for oversubscribable resources
I0324 01:47:49.695914 27159 slave.cpp:5738] Received oversubscribable resources {} from the resource estimator
I0324 01:47:49.697346 27159 process.cpp:3704] Handling HTTP event for process 'slave(696)' with path: '/slave(696)/monitor/statistics'
I0324 01:47:49.697768 27165 http.cpp:871] Authorizing principal 'test-principal' to GET the '/monitor/statistics' endpoint
I0324 01:47:49.698765 27170 slave.cpp:803] Agent terminating
[       OK ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/0 (13 ms)
[ RUN      ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/1
I0324 01:47:49.739141 27154 containerizer.cpp:221] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni
W0324 01:47:49.739413 27154 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0324 01:47:49.739449 27154 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0324 01:47:49.739461 27154 provisioner.cpp:249] Using default backend 'copy'
I0324 01:47:49.740576 27167 slave.cpp:211] Mesos agent started on (697)@172.17.0.3:42600
I0324 01:47:49.740597 27167 slave.cpp:212] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/mesos/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_BOoANj/credential" --default_role="*" --disk_watch_interval="1mins" --docker="docker" --docker_kill_orphans="true" --docker_registry="https://registry-1.docker.io" --docker_remove_delay="6hrs" --docker_socket="/var/run/docker.sock" --docker_stop_timeout="0ns" --docker_store_dir="/tmp/mesos/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_BOoANj/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_authenticators="basic" --http_command_executor="false" --http_credentials="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_BOoANj/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --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_BOoANj" --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_Pxx9fw"
I0324 01:47:49.740980 27167 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_BOoANj/credential'
I0324 01:47:49.741070 27167 slave.cpp:354] Agent using credential for: test-principal
I0324 01:47:49.741080 27167 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_BOoANj/http_credentials'
I0324 01:47:49.741165 27167 http.cpp:919] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0324 01:47:49.741205 27167 http.cpp:919] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0324 01:47:49.741608 27167 slave.cpp:541] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0324 01:47:49.741647 27167 slave.cpp:549] Agent attributes: [  ]
I0324 01:47:49.741655 27167 slave.cpp:554] Agent hostname: 0b68c2b9f456
I0324 01:47:49.741744 27170 status_update_manager.cpp:177] Pausing sending status updates
I0324 01:47:49.742100 27166 state.cpp:62] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_Pxx9fw/meta'
I0324 01:47:49.742228 27167 status_update_manager.cpp:203] Recovering status update manager
I0324 01:47:49.742393 27158 containerizer.cpp:600] Recovering containerizer
I0324 01:47:49.742880 27158 provisioner.cpp:410] Provisioner recovery complete
I0324 01:47:49.743126 27164 slave.cpp:5550] Finished recovery
I0324 01:47:49.743515 27164 slave.cpp:5724] Querying resource estimator for oversubscribable resources
I0324 01:47:49.743607 27166 slave.cpp:5738] Received oversubscribable resources {} from the resource estimator
I0324 01:47:49.744359 27156 process.cpp:3704] Handling HTTP event for process 'slave(697)' with path: '/slave(697)/monitor/statistics.json'
I0324 01:47:49.744699 27156 http.cpp:871] Authorizing principal 'test-principal' to GET the '/monitor/statistics.json' endpoint
I0324 01:47:49.746013 27154 slave.cpp:803] Agent terminating
[       OK ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/1 (12 ms)
[ RUN      ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/2
I0324 01:47:49.757758 27154 containerizer.cpp:221] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni
W0324 01:47:49.758154 27154 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0324 01:47:49.758209 27154 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0324 01:47:49.758231 27154 provisioner.cpp:249] Using default backend 'copy'
I0324 01:47:49.760711 27156 slave.cpp:211] Mesos agent started on (698)@172.17.0.3:42600
I0324 01:47:49.760738 27156 slave.cpp:212] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/mesos/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_UxUM6v/credential" --default_role="*" --disk_watch_interval="1mins" --docker="docker" --docker_kill_orphans="true" --docker_registry="https://registry-1.docker.io" --docker_remove_delay="6hrs" --docker_socket="/var/run/docker.sock" --docker_stop_timeout="0ns" --docker_store_dir="/tmp/mesos/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_UxUM6v/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_authenticators="basic" --http_command_executor="false" --http_credentials="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_UxUM6v/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --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_UxUM6v" --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_2GDpwI"
I0324 01:47:49.761173 27156 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_UxUM6v/credential'
I0324 01:47:49.761308 27156 slave.cpp:354] Agent using credential for: test-principal
I0324 01:47:49.761323 27156 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_UxUM6v/http_credentials'
I0324 01:47:49.761451 27156 http.cpp:919] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0324 01:47:49.761508 27156 http.cpp:919] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0324 01:47:49.761981 27156 slave.cpp:541] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0324 01:47:49.762024 27156 slave.cpp:549] Agent attributes: [  ]
I0324 01:47:49.762032 27156 slave.cpp:554] Agent hostname: 0b68c2b9f456
I0324 01:47:49.762892 27162 state.cpp:62] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_2GDpwI/meta'
I0324 01:47:49.763090 27169 status_update_manager.cpp:177] Pausing sending status updates
I0324 01:47:49.763124 27169 status_update_manager.cpp:203] Recovering status update manager
I0324 01:47:49.763213 27169 containerizer.cpp:600] Recovering containerizer
I0324 01:47:49.763847 27168 provisioner.cpp:410] Provisioner recovery complete
I0324 01:47:49.764050 27168 slave.cpp:5550] Finished recovery
I0324 01:47:49.788301 27168 slave.cpp:5724] Querying resource estimator for oversubscribable resources
I0324 01:47:49.788935 27156 slave.cpp:5738] Received oversubscribable resources {} from the resource estimator
I0324 01:47:49.789983 27155 process.cpp:3704] Handling HTTP event for process 'slave(698)' with path: '/slave(698)/containers'
I0324 01:47:49.790359 27155 http.cpp:871] Authorizing principal 'test-principal' to GET the '/containers' endpoint
I0324 01:47:49.791426 27154 slave.cpp:803] Agent terminating
[       OK ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/2 (40 ms)
[ RUN      ] Endpoint/SlaveEndpointTest.NoAuthorizer/0
I0324 01:47:49.804119 27154 containerizer.cpp:221] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni
W0324 01:47:49.804425 27154 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0324 01:47:49.804461 27154 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0324 01:47:49.804476 27154 provisioner.cpp:249] Using default backend 'copy'
I0324 01:47:49.805006 27154 cluster.cpp:446] Creating default 'local' authorizer
I0324 01:47:49.805531 27170 slave.cpp:211] Mesos agent started on (699)@172.17.0.3:42600
I0324 01:47:49.805543 27170 slave.cpp:212] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/mesos/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_WuHbUI/credential" --default_role="*" --disk_watch_interval="1mins" --docker="docker" --docker_kill_orphans="true" --docker_registry="https://registry-1.docker.io" --docker_remove_delay="6hrs" --docker_socket="/var/run/docker.sock" --docker_stop_timeout="0ns" --docker_store_dir="/tmp/mesos/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_WuHbUI/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_authenticators="basic" --http_command_executor="false" --http_credentials="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_WuHbUI/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --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_WuHbUI" --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_KglccV"
I0324 01:47:49.805909 27170 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_WuHbUI/credential'
I0324 01:47:49.805994 27170 slave.cpp:354] Agent using credential for: test-principal
I0324 01:47:49.806006 27170 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_WuHbUI/http_credentials'
I0324 01:47:49.806109 27170 http.cpp:919] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0324 01:47:49.806152 27170 http.cpp:919] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0324 01:47:49.806545 27170 slave.cpp:541] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0324 01:47:49.806581 27170 slave.cpp:549] Agent attributes: [  ]
I0324 01:47:49.806591 27170 slave.cpp:554] Agent hostname: 0b68c2b9f456
I0324 01:47:49.806648 27168 status_update_manager.cpp:177] Pausing sending status updates
I0324 01:47:49.807085 27169 state.cpp:62] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_KglccV/meta'
I0324 01:47:49.807214 27170 status_update_manager.cpp:203] Recovering status update manager
I0324 01:47:49.807279 27169 containerizer.cpp:600] Recovering containerizer
I0324 01:47:49.807801 27157 provisioner.cpp:410] Provisioner recovery complete
I0324 01:47:49.808007 27166 slave.cpp:5550] Finished recovery
I0324 01:47:49.808393 27166 slave.cpp:5724] Querying resource estimator for oversubscribable resources
I0324 01:47:49.808482 27162 slave.cpp:5738] Received oversubscribable resources {} from the resource estimator
I0324 01:47:49.809132 27158 process.cpp:3704] Handling HTTP event for process 'slave(699)' with path: '/slave(699)/monitor/statistics'
I0324 01:47:49.809468 27158 http.cpp:871] Authorizing principal 'test-principal' to GET the '/monitor/statistics' endpoint
I0324 01:47:49.810792 27163 slave.cpp:803] Agent terminating
[       OK ] Endpoint/SlaveEndpointTest.NoAuthorizer/0 (41 ms)
[ RUN      ] Endpoint/SlaveEndpointTest.NoAuthorizer/1
I0324 01:47:49.846153 27154 containerizer.cpp:221] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni
W0324 01:47:49.846498 27154 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0324 01:47:49.846566 27154 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0324 01:47:49.846588 27154 provisioner.cpp:249] Using default backend 'copy'
I0324 01:47:49.847285 27154 cluster.cpp:446] Creating default 'local' authorizer
I0324 01:47:49.847980 27169 slave.cpp:211] Mesos agent started on (700)@172.17.0.3:42600
I0324 01:47:49.848000 27169 slave.cpp:212] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/mesos/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_txqf5V/credential" --default_role="*" --disk_watch_interval="1mins" --docker="docker" --docker_kill_orphans="true" --docker_registry="https://registry-1.docker.io" --docker_remove_delay="6hrs" --docker_socket="/var/run/docker.sock" --docker_stop_timeout="0ns" --docker_store_dir="/tmp/mesos/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_txqf5V/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_authenticators="basic" --http_command_executor="false" --http_credentials="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_txqf5V/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --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_txqf5V" --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_iYhsg8"
I0324 01:47:49.848359 27169 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_txqf5V/credential'
I0324 01:47:49.848455 27169 slave.cpp:354] Agent using credential for: test-principal
I0324 01:47:49.848469 27169 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_txqf5V/http_credentials'
I0324 01:47:49.848577 27169 http.cpp:919] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0324 01:47:49.848811 27169 http.cpp:919] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0324 01:47:49.849413 27169 slave.cpp:541] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0324 01:47:49.849472 27169 slave.cpp:549] Agent attributes: [  ]
I0324 01:47:49.849484 27169 slave.cpp:554] Agent hostname: 0b68c2b9f456
I0324 01:47:49.849907 27169 status_update_manager.cpp:177] Pausing sending status updates
I0324 01:47:49.850230 27169 state.cpp:62] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_iYhsg8/meta'
I0324 01:47:49.850391 27169 status_update_manager.cpp:203] Recovering status update manager
I0324 01:47:49.850459 27169 containerizer.cpp:600] Recovering containerizer
I0324 01:47:49.851021 27169 provisioner.cpp:410] Provisioner recovery complete
I0324 01:47:49.851182 27169 slave.cpp:5550] Finished recovery
I0324 01:47:49.851963 27169 slave.cpp:5724] Querying resource estimator for oversubscribable resources
I0324 01:47:49.852061 27169 slave.cpp:5738] Received oversubscribable resources {} from the resource estimator
I0324 01:47:49.853044 27162 process.cpp:3704] Handling HTTP event for process 'slave(700)' with path: '/slave(700)/monitor/statistics.json'
I0324 01:47:49.853742 27156 http.cpp:871] Authorizing principal 'test-principal' to GET the '/monitor/statistics.json' endpoint
I0324 01:47:49.855510 27158 slave.cpp:803] Agent terminating
[       OK ] Endpoint/SlaveEndpointTest.NoAuthorizer/1 (14 ms)
[ RUN      ] Endpoint/SlaveEndpointTest.NoAuthorizer/2
I0324 01:47:49.869945 27154 containerizer.cpp:221] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni
W0324 01:47:49.870337 27154 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0324 01:47:49.870390 27154 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0324 01:47:49.870414 27154 provisioner.cpp:249] Using default backend 'copy'
I0324 01:47:49.871139 27154 cluster.cpp:446] Creating default 'local' authorizer
I0324 01:47:49.871902 27162 slave.cpp:211] Mesos agent started on (701)@172.17.0.3:42600
I0324 01:47:49.871927 27162 slave.cpp:212] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/mesos/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_elsyy9/credential" --default_role="*" --disk_watch_interval="1mins" --docker="docker" --docker_kill_orphans="true" --docker_registry="https://registry-1.docker.io" --docker_remove_delay="6hrs" --docker_socket="/var/run/docker.sock" --docker_stop_timeout="0ns" --docker_store_dir="/tmp/mesos/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_elsyy9/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_authenticators="basic" --http_command_executor="false" --http_credentials="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_elsyy9/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --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_elsyy9" --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_V4fZFl"
I0324 01:47:49.872297 27162 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_elsyy9/credential'
I0324 01:47:49.879662 27162 slave.cpp:354] Agent using credential for: test-principal
I0324 01:47:49.879676 27162 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_elsyy9/http_credentials'
I0324 01:47:49.879762 27162 http.cpp:919] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0324 01:47:49.879823 27162 http.cpp:919] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0324 01:47:49.880342 27162 slave.cpp:541] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0324 01:47:49.880375 27162 slave.cpp:549] Agent attributes: [  ]
I0324 01:47:49.880383 27162 slave.cpp:554] Agent hostname: 0b68c2b9f456
I0324 01:47:49.880458 27161 status_update_manager.cpp:177] Pausing sending status updates
I0324 01:47:49.880755 27160 state.cpp:62] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_V4fZFl/meta'
I0324 01:47:49.880872 27156 status_update_manager.cpp:203] Recovering status update manager
I0324 01:47:49.881026 27160 containerizer.cpp:600] Recovering containerizer
I0324 01:47:49.881508 27155 provisioner.cpp:410] Provisioner recovery complete
I0324 01:47:49.881685 27155 slave.cpp:5550] Finished recovery
I0324 01:47:49.882035 27155 slave.cpp:5724] Querying resource estimator for oversubscribable resources
I0324 01:47:49.882189 27162 slave.cpp:5738] Received oversubscribable resources {} from the resource estimator
I0324 01:47:49.883092 27155 process.cpp:3704] Handling HTTP event for process 'slave(701)' with path: '/slave(701)/containers'
I0324 01:47:49.883421 27155 http.cpp:871] Authorizing principal 'test-principal' to GET the '/containers' endpoint
I0324 01:47:49.884994 27154 slave.cpp:803] Agent terminating
[       OK ] Endpoint/SlaveEndpointTest.NoAuthorizer/2 (20 ms)
[----------] 9 tests from Endpoint/SlaveEndpointTest (454 ms total)

[----------] Global test environment tear-down
[==========] 1446 tests from 160 test cases ran. (500233 ms total)
[  PASSED  ] 1445 tests.
[  FAILED  ] 1 test, listed below:
[  FAILED  ] ContentType/AgentAPIStreamingTest.AttachInputToNestedContainerSession/0, where GetParam() = application/x-protobuf

 1 FAILED TEST
  YOU HAVE 11 DISABLED TESTS

make[3]: *** [CMakeFiles/check] Error 1
make[3]: Leaving directory `/mesos/build'
make[2]: *** [CMakeFiles/check.dir/all] Error 2
make[2]: Leaving directory `/mesos/build'
make[1]: *** [CMakeFiles/check.dir/rule] Error 2
make[1]: Leaving directory `/mesos/build'
make: *** [check] Error 2
+ docker rmi mesos-1490314899-8960
Untagged: mesos-1490314899-8960:latest
Deleted: sha256:46f62d1c2d28ac8a4cfcb41b71c7c0280c937ba068b2944efc46a4cf1cf667b3
Deleted: sha256:14ed1212abbc0170a67db155d4258e971686302691180bf21ee2356f5755f93c
Deleted: sha256:8a3143162c02fd4169a371e76063de195d86de44f2aa1fdeb83a5e78dd5a7f08
Deleted: sha256:e43f6747134dcec6c9a73d173b06becca0a77d07aea4d218acae8cfcbda6d691
Deleted: sha256:f85b7632ee8592610f369b14835bd96a13590149e96f1f4472c86cf9fd364820
Deleted: sha256:d3f287b991141a41006c82c45b44f4d5b85d1719d8071b984d1c062a5ec3f936
Deleted: sha256:060c90373d92f3ec33fdf530ba21bcb38b5893f014ea9ba2d87f2eb1080c0e9e
Deleted: sha256:8a6e2b56a08da18b77acbb79b71eb5b5a21ef60422be9cff69a8a5e95b34c875
Deleted: sha256:61ef9209e1113cb54957c7d2f078e26abcaea0106a95d8d1a2a8738a548b301c
Deleted: sha256:876bd9cf06a7f113a6bb6f5b64da8801ec9c261043080fa9ee0612f56ecb2286
Deleted: sha256:d54a6fa333de0291164a08dd0efc3e869f370b5371ea65a1c22e9e8a8558565e
Deleted: sha256:75efaa6fa45f3be919332046d2a2cd7bba15e516a06809a2a520ff508731a41d
Deleted: sha256:261ce9323355b28063d136ff2dab45127e0ae99971914e7d1362eb5da17d6869
Deleted: sha256:967e9eef53ddd514328d3bf3c17e03c09a968634b4dbd17fd9fd2532506aebaa
Deleted: sha256:b08ff4b64e833a9dc822739ae95efb8e13204a66e28fbf0728f227e0a48be719
Deleted: sha256:11337fc012b9b9ef69ed093392f0445ab291e28d7f863cfc5d5a5b2898ea4654
Deleted: sha256:2d7255ca2a1ef4258708c8ee46147f3696aec1fc4cbcce5fd7aab7e16c277d47
Deleted: sha256:a8dd1ab37ddca6577c0db6dbb75ff7888f5702d6d1f909f507a77c191b0eb189
Deleted: sha256:42568bc99185da4354a143d6188c0914db2c9592553b086cb8a889bf9625a5d9
Deleted: sha256:96af9402fa6d80d917e294f569dbf5e81e5a1d6805402d0bf35543726835f2fc
Deleted: sha256:136ebb76a96b6e8c9309873fac58d6b6d076b715c79481e2f6944a804862b001
Deleted: sha256:c3b1591189bc1fc3a34fd37bde46270add9fe195bc43dce4bb74487257bbe811
Deleted: sha256:0544e7e5b9afeb7014fef84b80302616784d5dba67242c9b2ad98037ac6fd18d
Deleted: sha256:59740871491d9986a3862b73f907f07c6d7e80b31bb79acc7086b3676a2a021a
Build step 'Execute shell' marked build as failure

Build failed in Jenkins: Mesos-Buildbot » cmake,gcc,--verbose --enable-libevent --enable-ssl,GLOG_v=1 MESOS_VERBOSE=1,ubuntu:14.04,(docker||Hadoop)&&(!ubuntu-us1)&&(!ubuntu-eu2) #3406

Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/Mesos-Buildbot/BUILDTOOL=cmake,COMPILER=gcc,CONFIGURATION=--verbose%20--enable-libevent%20--enable-ssl,ENVIRONMENT=GLOG_v=1%20MESOS_VERBOSE=1,OS=ubuntu%3A14.04,label_exp=(docker%7C%7CHadoop)&&(!ubuntu-us1)&&(!ubuntu-eu2)/3406/display/redirect?page=changes>

Changes:

[toenshoff] Fixed flags logging in Docker executor.

[josephwu] Windows: Fixed usage of WindowsError in stat.hpp.

[josephwu] Fixed 'all be it' typo.

------------------------------------------
[...truncated 24.72 MB...]
I0324 00:16:07.137848 32764 status_update_manager.cpp:177] Pausing sending status updates
I0324 00:16:07.138212   300 state.cpp:62] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_1_zsahew/meta'
I0324 00:16:07.138417   305 status_update_manager.cpp:203] Recovering status update manager
I0324 00:16:07.138525   306 containerizer.cpp:608] Recovering containerizer
I0324 00:16:07.139042   301 provisioner.cpp:410] Provisioner recovery complete
I0324 00:16:07.139211   306 slave.cpp:5638] Finished recovery
I0324 00:16:07.139567   306 slave.cpp:5820] Querying resource estimator for oversubscribable resources
I0324 00:16:07.139775   302 slave.cpp:5834] Received oversubscribable resources {} from the resource estimator
I0324 00:16:07.140558   309 process.cpp:3705] Handling HTTP event for process 'slave(710)' with path: '/slave(710)/monitor/statistics.json'
I0324 00:16:07.140997 32767 http.cpp:918] Authorizing principal 'test-principal' to GET the '/monitor/statistics.json' endpoint
I0324 00:16:07.142199   307 slave.cpp:693] Agent terminating
[       OK ] Endpoint/SlaveEndpointTest.AuthorizedRequest/1 (12 ms)
[ RUN      ] Endpoint/SlaveEndpointTest.AuthorizedRequest/2
I0324 00:16:07.177551 27771 containerizer.cpp:221] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni
W0324 00:16:07.177875 27771 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0324 00:16:07.177912 27771 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0324 00:16:07.177947 27771 provisioner.cpp:249] Using default backend 'copy'
I0324 00:16:07.179199   300 slave.cpp:210] Mesos agent started on (711)@172.17.0.3:42873
I0324 00:16:07.179258   300 slave.cpp:211] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/mesos/store/appc" --authenticate_http_readonly="true" --authenticate_http_readwrite="true" --authenticatee="crammd5" --authentication_backoff_factor="1secs" --authorizer="local" --cgroups_cpu_enable_pids_and_tids_count="false" --cgroups_enable_cfs="false" --cgroups_hierarchy="/sys/fs/cgroup" --cgroups_limit_swap="false" --cgroups_root="mesos" --container_disk_watch_interval="15secs" --containerizers="mesos" --credential="/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_C2ImLY/credential" --default_role="*" --disk_watch_interval="1mins" --docker="docker" --docker_kill_orphans="true" --docker_registry="https://registry-1.docker.io" --docker_remove_delay="6hrs" --docker_socket="/var/run/docker.sock" --docker_stop_timeout="0ns" --docker_store_dir="/tmp/mesos/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_C2ImLY/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_authenticators="basic" --http_command_executor="false" --http_credentials="/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_C2ImLY/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --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_AuthorizedRequest_2_C2ImLY" --sandbox_directory="/mnt/mesos/sandbox" --strict="true" --switch_user="true" --systemd_enable_support="true" --systemd_runtime_directory="/run/systemd/system" --version="false" --work_dir="/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_3my7BG"
I0324 00:16:07.179571   300 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_C2ImLY/credential'
I0324 00:16:07.179733   300 slave.cpp:243] Agent using credential for: test-principal
I0324 00:16:07.179749   300 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_C2ImLY/http_credentials'
I0324 00:16:07.179859   300 http.cpp:957] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0324 00:16:07.179921   300 http.cpp:957] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0324 00:16:07.180394   300 slave.cpp:430] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0324 00:16:07.180431   300 slave.cpp:438] Agent attributes: [  ]
I0324 00:16:07.180438   300 slave.cpp:443] Agent hostname: 3ceea25bb88d
I0324 00:16:07.180500   306 status_update_manager.cpp:177] Pausing sending status updates
I0324 00:16:07.180810   309 state.cpp:62] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_3my7BG/meta'
I0324 00:16:07.180970   301 status_update_manager.cpp:203] Recovering status update manager
I0324 00:16:07.181057   301 containerizer.cpp:608] Recovering containerizer
I0324 00:16:07.181535   301 provisioner.cpp:410] Provisioner recovery complete
I0324 00:16:07.181762   303 slave.cpp:5638] Finished recovery
I0324 00:16:07.182139   303 slave.cpp:5820] Querying resource estimator for oversubscribable resources
I0324 00:16:07.182251 32765 slave.cpp:5834] Received oversubscribable resources {} from the resource estimator
I0324 00:16:07.182958   304 process.cpp:3705] Handling HTTP event for process 'slave(711)' with path: '/slave(711)/containers'
I0324 00:16:07.183370   311 http.cpp:918] Authorizing principal 'test-principal' to GET the '/containers' endpoint
I0324 00:16:07.184664 32765 slave.cpp:693] Agent terminating
[       OK ] Endpoint/SlaveEndpointTest.AuthorizedRequest/2 (11 ms)
[ RUN      ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/0
I0324 00:16:07.195121 27771 containerizer.cpp:221] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni
W0324 00:16:07.195389 27771 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0324 00:16:07.195423 27771 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0324 00:16:07.195439 27771 provisioner.cpp:249] Using default backend 'copy'
I0324 00:16:07.196447   306 slave.cpp:210] Mesos agent started on (712)@172.17.0.3:42873
I0324 00:16:07.196465   306 slave.cpp:211] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/mesos/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_CQhNv9/credential" --default_role="*" --disk_watch_interval="1mins" --docker="docker" --docker_kill_orphans="true" --docker_registry="https://registry-1.docker.io" --docker_remove_delay="6hrs" --docker_socket="/var/run/docker.sock" --docker_stop_timeout="0ns" --docker_store_dir="/tmp/mesos/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_CQhNv9/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_authenticators="basic" --http_command_executor="false" --http_credentials="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_CQhNv9/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --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_CQhNv9" --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_1JLEjR"
I0324 00:16:07.196832   306 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_CQhNv9/credential'
I0324 00:16:07.231281   306 slave.cpp:243] Agent using credential for: test-principal
I0324 00:16:07.231750   306 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_CQhNv9/http_credentials'
I0324 00:16:07.232333   306 http.cpp:957] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0324 00:16:07.232825   306 http.cpp:957] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0324 00:16:07.233902   306 slave.cpp:430] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0324 00:16:07.234380   306 slave.cpp:438] Agent attributes: [  ]
I0324 00:16:07.234787   306 slave.cpp:443] Agent hostname: 3ceea25bb88d
I0324 00:16:07.235297 32767 status_update_manager.cpp:177] Pausing sending status updates
I0324 00:16:07.235913   309 state.cpp:62] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_1JLEjR/meta'
I0324 00:16:07.236090 32764 status_update_manager.cpp:203] Recovering status update manager
I0324 00:16:07.236228   309 containerizer.cpp:608] Recovering containerizer
I0324 00:16:07.236888   309 provisioner.cpp:410] Provisioner recovery complete
I0324 00:16:07.237037 32764 slave.cpp:5638] Finished recovery
I0324 00:16:07.237459 32764 slave.cpp:5820] Querying resource estimator for oversubscribable resources
I0324 00:16:07.237591   309 slave.cpp:5834] Received oversubscribable resources {} from the resource estimator
I0324 00:16:07.238626 32767 process.cpp:3705] Handling HTTP event for process 'slave(712)' with path: '/slave(712)/monitor/statistics'
I0324 00:16:07.238983 32767 http.cpp:918] Authorizing principal 'test-principal' to GET the '/monitor/statistics' endpoint
I0324 00:16:07.240254   304 slave.cpp:693] Agent terminating
[       OK ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/0 (81 ms)
[ RUN      ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/1
I0324 00:16:07.276141 27771 containerizer.cpp:221] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni
W0324 00:16:07.276429 27771 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0324 00:16:07.276468 27771 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0324 00:16:07.276490 27771 provisioner.cpp:249] Using default backend 'copy'
I0324 00:16:07.279021   307 slave.cpp:210] Mesos agent started on (713)@172.17.0.3:42873
I0324 00:16:07.279052   307 slave.cpp:211] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/mesos/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_Kn6C2k/credential" --default_role="*" --disk_watch_interval="1mins" --docker="docker" --docker_kill_orphans="true" --docker_registry="https://registry-1.docker.io" --docker_remove_delay="6hrs" --docker_socket="/var/run/docker.sock" --docker_stop_timeout="0ns" --docker_store_dir="/tmp/mesos/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_Kn6C2k/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_authenticators="basic" --http_command_executor="false" --http_credentials="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_Kn6C2k/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --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_Kn6C2k" --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_7JUlD2"
I0324 00:16:07.279422   307 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_Kn6C2k/credential'
I0324 00:16:07.279541   307 slave.cpp:243] Agent using credential for: test-principal
I0324 00:16:07.279551   307 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_Kn6C2k/http_credentials'
I0324 00:16:07.279665   307 http.cpp:957] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0324 00:16:07.279726   307 http.cpp:957] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0324 00:16:07.280135   307 slave.cpp:430] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0324 00:16:07.280166   307 slave.cpp:438] Agent attributes: [  ]
I0324 00:16:07.280171   307 slave.cpp:443] Agent hostname: 3ceea25bb88d
I0324 00:16:07.280246 32766 status_update_manager.cpp:177] Pausing sending status updates
I0324 00:16:07.280685   308 state.cpp:62] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_7JUlD2/meta'
I0324 00:16:07.280905   307 status_update_manager.cpp:203] Recovering status update manager
I0324 00:16:07.281009 32765 containerizer.cpp:608] Recovering containerizer
I0324 00:16:07.281538   305 provisioner.cpp:410] Provisioner recovery complete
I0324 00:16:07.281694 32766 slave.cpp:5638] Finished recovery
I0324 00:16:07.282117 32766 slave.cpp:5820] Querying resource estimator for oversubscribable resources
I0324 00:16:07.282198 32766 slave.cpp:5834] Received oversubscribable resources {} from the resource estimator
I0324 00:16:07.288704 32766 process.cpp:3705] Handling HTTP event for process 'slave(713)' with path: '/slave(713)/monitor/statistics.json'
I0324 00:16:07.289170 32766 http.cpp:918] Authorizing principal 'test-principal' to GET the '/monitor/statistics.json' endpoint
I0324 00:16:07.290088   305 slave.cpp:693] Agent terminating
[       OK ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/1 (19 ms)
[ RUN      ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/2
I0324 00:16:07.297639 27771 containerizer.cpp:221] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni
W0324 00:16:07.297998 27771 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0324 00:16:07.298045 27771 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0324 00:16:07.298179 27771 provisioner.cpp:249] Using default backend 'copy'
I0324 00:16:07.299214   302 slave.cpp:210] Mesos agent started on (714)@172.17.0.3:42873
I0324 00:16:07.299244   302 slave.cpp:211] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/mesos/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_MK59Qw/credential" --default_role="*" --disk_watch_interval="1mins" --docker="docker" --docker_kill_orphans="true" --docker_registry="https://registry-1.docker.io" --docker_remove_delay="6hrs" --docker_socket="/var/run/docker.sock" --docker_stop_timeout="0ns" --docker_store_dir="/tmp/mesos/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_MK59Qw/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_authenticators="basic" --http_command_executor="false" --http_credentials="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_MK59Qw/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --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_MK59Qw" --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_Ragooe"
I0324 00:16:07.299770   302 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_MK59Qw/credential'
I0324 00:16:07.310544   302 slave.cpp:243] Agent using credential for: test-principal
I0324 00:16:07.310575   302 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_MK59Qw/http_credentials'
I0324 00:16:07.310693   302 http.cpp:957] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0324 00:16:07.310783   302 http.cpp:957] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0324 00:16:07.311247   302 slave.cpp:430] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0324 00:16:07.311290   302 slave.cpp:438] Agent attributes: [  ]
I0324 00:16:07.311298   302 slave.cpp:443] Agent hostname: 3ceea25bb88d
I0324 00:16:07.311391   300 status_update_manager.cpp:177] Pausing sending status updates
I0324 00:16:07.311750   307 state.cpp:62] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_Ragooe/meta'
I0324 00:16:07.311925   308 status_update_manager.cpp:203] Recovering status update manager
I0324 00:16:07.312077   309 containerizer.cpp:608] Recovering containerizer
I0324 00:16:07.312646 32764 provisioner.cpp:410] Provisioner recovery complete
I0324 00:16:07.312811   308 slave.cpp:5638] Finished recovery
I0324 00:16:07.313184   308 slave.cpp:5820] Querying resource estimator for oversubscribable resources
I0324 00:16:07.313329   301 slave.cpp:5834] Received oversubscribable resources {} from the resource estimator
I0324 00:16:07.314039 32767 process.cpp:3705] Handling HTTP event for process 'slave(714)' with path: '/slave(714)/containers'
I0324 00:16:07.314427   301 http.cpp:918] Authorizing principal 'test-principal' to GET the '/containers' endpoint
I0324 00:16:07.315132   311 slave.cpp:693] Agent terminating
[       OK ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/2 (22 ms)
[ RUN      ] Endpoint/SlaveEndpointTest.NoAuthorizer/0
I0324 00:16:07.345340 27771 containerizer.cpp:221] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni
W0324 00:16:07.345587 27771 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0324 00:16:07.345618 27771 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0324 00:16:07.345628 27771 provisioner.cpp:249] Using default backend 'copy'
I0324 00:16:07.346092 27771 cluster.cpp:446] Creating default 'local' authorizer
I0324 00:16:07.346452   311 slave.cpp:210] Mesos agent started on (715)@172.17.0.3:42873
I0324 00:16:07.346468   311 slave.cpp:211] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/mesos/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_QgdU7I/credential" --default_role="*" --disk_watch_interval="1mins" --docker="docker" --docker_kill_orphans="true" --docker_registry="https://registry-1.docker.io" --docker_remove_delay="6hrs" --docker_socket="/var/run/docker.sock" --docker_stop_timeout="0ns" --docker_store_dir="/tmp/mesos/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_QgdU7I/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_authenticators="basic" --http_command_executor="false" --http_credentials="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_QgdU7I/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --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_QgdU7I" --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_r7Tpxq"
I0324 00:16:07.346846   311 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_QgdU7I/credential'
I0324 00:16:07.346936   311 slave.cpp:243] Agent using credential for: test-principal
I0324 00:16:07.346951   311 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_QgdU7I/http_credentials'
I0324 00:16:07.347053   311 http.cpp:957] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0324 00:16:07.347091   311 http.cpp:957] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0324 00:16:07.347424   311 slave.cpp:430] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0324 00:16:07.347455   311 slave.cpp:438] Agent attributes: [  ]
I0324 00:16:07.347460   311 slave.cpp:443] Agent hostname: 3ceea25bb88d
I0324 00:16:07.347518 32767 status_update_manager.cpp:177] Pausing sending status updates
I0324 00:16:07.347759   311 state.cpp:62] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_r7Tpxq/meta'
I0324 00:16:07.348000   307 status_update_manager.cpp:203] Recovering status update manager
I0324 00:16:07.348191   301 containerizer.cpp:608] Recovering containerizer
I0324 00:16:07.348683   301 provisioner.cpp:410] Provisioner recovery complete
I0324 00:16:07.348875 32766 slave.cpp:5638] Finished recovery
I0324 00:16:07.349283 32766 slave.cpp:5820] Querying resource estimator for oversubscribable resources
I0324 00:16:07.349375   301 slave.cpp:5834] Received oversubscribable resources {} from the resource estimator
I0324 00:16:07.350045 32766 process.cpp:3705] Handling HTTP event for process 'slave(715)' with path: '/slave(715)/monitor/statistics'
I0324 00:16:07.350466   302 http.cpp:918] Authorizing principal 'test-principal' to GET the '/monitor/statistics' endpoint
I0324 00:16:07.351840   308 slave.cpp:693] Agent terminating
[       OK ] Endpoint/SlaveEndpointTest.NoAuthorizer/0 (19 ms)
[ RUN      ] Endpoint/SlaveEndpointTest.NoAuthorizer/1
I0324 00:16:07.364048 27771 containerizer.cpp:221] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni
W0324 00:16:07.364301 27771 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0324 00:16:07.364336 27771 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0324 00:16:07.364409 27771 provisioner.cpp:249] Using default backend 'copy'
I0324 00:16:07.365172 27771 cluster.cpp:446] Creating default 'local' authorizer
I0324 00:16:07.365747 32767 slave.cpp:210] Mesos agent started on (716)@172.17.0.3:42873
I0324 00:16:07.365764 32767 slave.cpp:211] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/mesos/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_w5eMDV/credential" --default_role="*" --disk_watch_interval="1mins" --docker="docker" --docker_kill_orphans="true" --docker_registry="https://registry-1.docker.io" --docker_remove_delay="6hrs" --docker_socket="/var/run/docker.sock" --docker_stop_timeout="0ns" --docker_store_dir="/tmp/mesos/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_w5eMDV/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_authenticators="basic" --http_command_executor="false" --http_credentials="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_w5eMDV/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --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_w5eMDV" --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_jGgd0C"
I0324 00:16:07.366066 32767 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_w5eMDV/credential'
I0324 00:16:07.366184 32767 slave.cpp:243] Agent using credential for: test-principal
I0324 00:16:07.366195 32767 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_w5eMDV/http_credentials'
I0324 00:16:07.366286 32767 http.cpp:957] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0324 00:16:07.366335 32767 http.cpp:957] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0324 00:16:07.366711 32767 slave.cpp:430] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0324 00:16:07.366744 32767 slave.cpp:438] Agent attributes: [  ]
I0324 00:16:07.366750 32767 slave.cpp:443] Agent hostname: 3ceea25bb88d
I0324 00:16:07.366822 32765 status_update_manager.cpp:177] Pausing sending status updates
I0324 00:16:07.367069 32764 state.cpp:62] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_jGgd0C/meta'
I0324 00:16:07.367336   309 status_update_manager.cpp:203] Recovering status update manager
I0324 00:16:07.367406 32764 containerizer.cpp:608] Recovering containerizer
I0324 00:16:07.367882   310 provisioner.cpp:410] Provisioner recovery complete
I0324 00:16:07.368046   307 slave.cpp:5638] Finished recovery
I0324 00:16:07.368458   307 slave.cpp:5820] Querying resource estimator for oversubscribable resources
I0324 00:16:07.368623   305 slave.cpp:5834] Received oversubscribable resources {} from the resource estimator
I0324 00:16:07.369384   304 process.cpp:3705] Handling HTTP event for process 'slave(716)' with path: '/slave(716)/monitor/statistics.json'
I0324 00:16:07.369807   304 http.cpp:918] Authorizing principal 'test-principal' to GET the '/monitor/statistics.json' endpoint
I0324 00:16:07.370894   302 slave.cpp:693] Agent terminating
[       OK ] Endpoint/SlaveEndpointTest.NoAuthorizer/1 (29 ms)
[ RUN      ] Endpoint/SlaveEndpointTest.NoAuthorizer/2
I0324 00:16:07.393129 27771 containerizer.cpp:221] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni
W0324 00:16:07.393393 27771 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0324 00:16:07.393425 27771 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0324 00:16:07.393435 27771 provisioner.cpp:249] Using default backend 'copy'
I0324 00:16:07.394342 27771 cluster.cpp:446] Creating default 'local' authorizer
I0324 00:16:07.394915   301 slave.cpp:210] Mesos agent started on (717)@172.17.0.3:42873
I0324 00:16:07.394956   301 slave.cpp:211] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/mesos/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_obBTq8/credential" --default_role="*" --disk_watch_interval="1mins" --docker="docker" --docker_kill_orphans="true" --docker_registry="https://registry-1.docker.io" --docker_remove_delay="6hrs" --docker_socket="/var/run/docker.sock" --docker_stop_timeout="0ns" --docker_store_dir="/tmp/mesos/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_obBTq8/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_authenticators="basic" --http_command_executor="false" --http_credentials="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_obBTq8/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --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_obBTq8" --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_jijCIP"
I0324 00:16:07.395306   301 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_obBTq8/credential'
I0324 00:16:07.395417   301 slave.cpp:243] Agent using credential for: test-principal
I0324 00:16:07.395428   301 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_obBTq8/http_credentials'
I0324 00:16:07.395516   301 http.cpp:957] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0324 00:16:07.395560   301 http.cpp:957] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0324 00:16:07.395936   301 slave.cpp:430] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0324 00:16:07.395972   301 slave.cpp:438] Agent attributes: [  ]
I0324 00:16:07.395977   301 slave.cpp:443] Agent hostname: 3ceea25bb88d
I0324 00:16:07.396046   309 status_update_manager.cpp:177] Pausing sending status updates
I0324 00:16:07.396374   304 state.cpp:62] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_jijCIP/meta'
I0324 00:16:07.396497   301 status_update_manager.cpp:203] Recovering status update manager
I0324 00:16:07.396633   302 containerizer.cpp:608] Recovering containerizer
I0324 00:16:07.397156   309 provisioner.cpp:410] Provisioner recovery complete
I0324 00:16:07.397415   307 slave.cpp:5638] Finished recovery
I0324 00:16:07.397842   307 slave.cpp:5820] Querying resource estimator for oversubscribable resources
I0324 00:16:07.398041   301 slave.cpp:5834] Received oversubscribable resources {} from the resource estimator
I0324 00:16:07.398761 32764 process.cpp:3705] Handling HTTP event for process 'slave(717)' with path: '/slave(717)/containers'
I0324 00:16:07.399214   301 http.cpp:918] Authorizing principal 'test-principal' to GET the '/containers' endpoint
I0324 00:16:07.400341   303 slave.cpp:693] Agent terminating
[       OK ] Endpoint/SlaveEndpointTest.NoAuthorizer/2 (34 ms)
[----------] 9 tests from Endpoint/SlaveEndpointTest (354 ms total)

[----------] Global test environment tear-down
[==========] 1476 tests from 164 test cases ran. (493041 ms total)
[  PASSED  ] 1475 tests.
[  FAILED  ] 1 test, listed below:
[  FAILED  ] ContentType/AgentAPITest.LaunchNestedContainerSessionWithTTY/1, where GetParam() = application/json

 1 FAILED TEST
  YOU HAVE 12 DISABLED TESTS

make[3]: *** [CMakeFiles/check] Error 1
make[3]: Leaving directory `/mesos/build'
make[2]: *** [CMakeFiles/check.dir/all] Error 2
make[2]: Leaving directory `/mesos/build'
make[1]: *** [CMakeFiles/check.dir/rule] Error 2
make[1]: Leaving directory `/mesos/build'
make: *** [check] Error 2
+ docker rmi mesos-1490309337-8665
Untagged: mesos-1490309337-8665:latest
Deleted: sha256:e03b98991c1a3819e2c93965e97cef96b0769120885a6ab6de84dee0f8433ecc
Deleted: sha256:b735f1cd97d3077328e22a9fd72bd3b4a9ef7f19d7ceadf02aad5a360971fb72
Deleted: sha256:8b07507f33afbd3fc51e7053b0e87cde05469f5d9321c1471710119bf98ce380
Deleted: sha256:2d6b8f942dc6b8d13a10d17856443f41a2bf9d461423177911c1f599022eab87
Deleted: sha256:6ae1ae9ffc807cc3f66a49bf2d5e4e6e682580bb001f478ba44dde48729c1977
Deleted: sha256:e723f314ba1eac432baa9caff68d37170045ab3a9a7bb2dddce4cfbb5097ad85
Deleted: sha256:598fa3ece7fc6d358a261214377ce2cb61efd0dbc1b6f690755e3c4803382ea3
Deleted: sha256:38ab75b7486e42bc877fd5a6994744342a2640bf9fa2a3457bd9c88b41707d73
Deleted: sha256:215bbb11a724086c3472856984b74e272ce647fdf1816c9ad45c311ebaff1bc3
Deleted: sha256:00c286c1cc6aa86386253467f72d071245336051eb9974a02c99a43f48080012
Deleted: sha256:cebc37e0af3286448abf1de195126d7192ea02a3fe594ccc125c1092d20f7c55
Deleted: sha256:2d22801d9ca32d448f70d0963187fb2614c49f1f43e47b184b88d6a6048ddf28
Deleted: sha256:d1cd4e2b6bb63e7e8a64b91b7354a73c6db490c70197b2b9154170d0017127aa
Deleted: sha256:e93178dedbe3cce1166433d1f292a0b1f6043855a8b1466502bb5e9889d6557e
Deleted: sha256:498e3b6ab0d21d398c87b665cee0993a6425a5468fd70c0c86b1406ff27a08c6
Deleted: sha256:f79bdfbf0276d24ec70ac162d2e2d1dbf22a4804fc08cbb84ba03d2d8557bdb5
Deleted: sha256:b3faeba5c8ff85720e7c81bb9904b403e6d0eeb60bb63633b08fc866353e80c5
Deleted: sha256:69a6e8676ecc1994bb84a9c1fcae5c90608fdfdf6d9e2365ba27d005000fbcce
Deleted: sha256:5987af3f42d8b9a3fd57c278d05ec2b2086dbb82eea1fa0d9cb28378bd80b79a
Deleted: sha256:9e6c62621ba6d05156abd7688bf007e22d67e5e81b58c683ee0913611173c09f
Deleted: sha256:b627dfaf6c949b12dc538b68d190c0d88ce7ef441cea783a8c08465de1e68f8c
Deleted: sha256:53c5abcd099a372c17dcbe1c6a6fc1a68470f72a4f21f1c880649fd5cd6071aa
Deleted: sha256:bb3fd27d26e9e8dcbbdc6969af8b069e0be5bbbec88088d0e252c04aa5c65910
Deleted: sha256:eb5f9923593be410b47b7231248725d443095c2ccbaf778abd7994fc36186502
Build step 'Execute shell' marked build as failure