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/05/05 18:49:15 UTC
Build failed in Jenkins: Mesos-Buildbot » cmake,clang,--verbose --enable-libevent --enable-ssl,GLOG_v=1 MESOS_VERBOSE=1,ubuntu:14.04,(docker||Hadoop)&&(!ubuntu-us1)&&(!ubuntu-eu2) #3610
See <https://builds.apache.org/job/Mesos-Buildbot/BUILDTOOL=cmake,COMPILER=clang,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)/3610/display/redirect?page=changes>
Changes:
[neil.conway] Fixed flakiness in HierarchicalAllocatorTest.NestedRoleQuota.
------------------------------------------
[...truncated 18.49 MB...]
I0505 18:49:04.975390 26011 slave.cpp:3082] Shutting down framework 8abed104-fbf2-4d48-bc86-94702e599ff7-0000
I0505 18:49:04.975419 26011 slave.cpp:5475] Shutting down executor 'default' of framework 8abed104-fbf2-4d48-bc86-94702e599ff7-0000
W0505 18:49:04.975445 26011 slave.hpp:986] Unable to send event to executor 'default' of framework 8abed104-fbf2-4d48-bc86-94702e599ff7-0000: unknown connection type
I0505 18:49:04.975639 26011 master.cpp:1313] Agent 8abed104-fbf2-4d48-bc86-94702e599ff7-S0 at (577)@172.17.0.3:39728 (e18141c804f7) disconnected
I0505 18:49:04.975675 26011 master.cpp:3197] Disconnecting agent 8abed104-fbf2-4d48-bc86-94702e599ff7-S0 at (577)@172.17.0.3:39728 (e18141c804f7)
I0505 18:49:04.975710 26011 master.cpp:3216] Deactivating agent 8abed104-fbf2-4d48-bc86-94702e599ff7-S0 at (577)@172.17.0.3:39728 (e18141c804f7)
I0505 18:49:04.975746 26011 master.cpp:1340] Removing framework 8abed104-fbf2-4d48-bc86-94702e599ff7-0000 (default) from disconnected agent 8abed104-fbf2-4d48-bc86-94702e599ff7-S0 at (577)@172.17.0.3:39728 (e18141c804f7) because the framework is not checkpointing
I0505 18:49:04.975833 26011 master.cpp:8164] Removing framework 8abed104-fbf2-4d48-bc86-94702e599ff7-0000 (default) from agent 8abed104-fbf2-4d48-bc86-94702e599ff7-S0 at (577)@172.17.0.3:39728 (e18141c804f7)
I0505 18:49:04.975915 26011 master.cpp:8568] Updating the state of task d3dc176f-869b-4a0d-961c-1cdcd14c14e2 of framework 8abed104-fbf2-4d48-bc86-94702e599ff7-0000 (latest state: TASK_LOST, status update state: TASK_LOST)
I0505 18:49:04.976073 26011 master.cpp:8662] Removing task d3dc176f-869b-4a0d-961c-1cdcd14c14e2 with resources cpus(*)(allocated: *):0.1; mem(*)(allocated: *):32; disk(*)(allocated: *):32 of framework 8abed104-fbf2-4d48-bc86-94702e599ff7-0000 on agent 8abed104-fbf2-4d48-bc86-94702e599ff7-S0 at (577)@172.17.0.3:39728 (e18141c804f7)
I0505 18:49:04.976223 26011 master.cpp:6532] Sending status update TASK_LOST for task d3dc176f-869b-4a0d-961c-1cdcd14c14e2 of framework 8abed104-fbf2-4d48-bc86-94702e599ff7-0000 'Agent e18141c804f7 disconnected'
I0505 18:49:04.976434 26011 master.cpp:8691] Removing executor 'default' with resources cpus(*)(allocated: *):0.1; mem(*)(allocated: *):32; disk(*)(allocated: *):32 of framework 8abed104-fbf2-4d48-bc86-94702e599ff7-0000 on agent 8abed104-fbf2-4d48-bc86-94702e599ff7-S0 at (577)@172.17.0.3:39728 (e18141c804f7)
I0505 18:49:04.976855 26007 hierarchical.cpp:653] Agent 8abed104-fbf2-4d48-bc86-94702e599ff7-S0 deactivated
I0505 18:49:04.977031 26007 hierarchical.cpp:1114] Recovered cpus(*)(allocated: *):0.1; mem(*)(allocated: *):32; disk(*)(allocated: *):32 (total: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000], allocated: cpus(*)(allocated: *):0.1; mem(*)(allocated: *):32; disk(*)(allocated: *):32) on agent 8abed104-fbf2-4d48-bc86-94702e599ff7-S0 from framework 8abed104-fbf2-4d48-bc86-94702e599ff7-0000
I0505 18:49:04.977232 26007 hierarchical.cpp:1114] Recovered cpus(*)(allocated: *):0.1; mem(*)(allocated: *):32; disk(*)(allocated: *):32 (total: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000], allocated: {}) on agent 8abed104-fbf2-4d48-bc86-94702e599ff7-S0 from framework 8abed104-fbf2-4d48-bc86-94702e599ff7-0000
I0505 18:49:04.977519 26007 master.cpp:1430] Framework 8abed104-fbf2-4d48-bc86-94702e599ff7-0000 (default) disconnected
I0505 18:49:04.977537 26007 master.cpp:3160] Deactivating framework 8abed104-fbf2-4d48-bc86-94702e599ff7-0000 (default)
I0505 18:49:04.977809 26011 hierarchical.cpp:374] Deactivated framework 8abed104-fbf2-4d48-bc86-94702e599ff7-0000
I0505 18:49:04.977916 26007 master.cpp:3137] Disconnecting framework 8abed104-fbf2-4d48-bc86-94702e599ff7-0000 (default)
I0505 18:49:04.978027 26007 master.cpp:1445] Giving framework 8abed104-fbf2-4d48-bc86-94702e599ff7-0000 (default) 0ns to failover
I0505 18:49:04.978245 26010 master.cpp:7146] Framework failover timeout, removing framework 8abed104-fbf2-4d48-bc86-94702e599ff7-0000 (default)
I0505 18:49:04.978328 26010 master.cpp:8000] Removing framework 8abed104-fbf2-4d48-bc86-94702e599ff7-0000 (default)
I0505 18:49:04.978711 26003 hierarchical.cpp:325] Removed framework 8abed104-fbf2-4d48-bc86-94702e599ff7-0000
I0505 18:49:04.980418 25995 master.cpp:1155] Master terminating
I0505 18:49:04.980677 26003 hierarchical.cpp:558] Removed agent 8abed104-fbf2-4d48-bc86-94702e599ff7-S0
[ OK ] ExecutorAuthorizationTest.FailedSubscribe (38 ms)
[ RUN ] ExecutorAuthorizationTest.FailedApiCalls
I0505 18:49:04.984840 25995 cluster.cpp:162] Creating default 'local' authorizer
I0505 18:49:04.985858 26005 master.cpp:436] Master 19dd7b54-251c-4b31-93c1-73da0661009f (e18141c804f7) started on 172.17.0.3:39728
I0505 18:49:04.985887 26005 master.cpp:438] 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/adOaaA/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" --port="5050" --quiet="false" --recovery_agent_removal_limit="100%" --registry="in_memory" --registry_fetch_timeout="1mins" --registry_gc_interval="15mins" --registry_max_agent_age="2weeks" --registry_max_agent_count="102400" --registry_store_timeout="100secs" --registry_strict="false" --root_submissions="true" --user_sorter="drf" --version="false" --webui_dir="/usr/local/share/mesos/webui" --work_dir="/tmp/adOaaA/master" --zk_session_timeout="10secs"
I0505 18:49:04.986130 26005 master.cpp:488] Master only allowing authenticated frameworks to register
I0505 18:49:04.986142 26005 master.cpp:502] Master only allowing authenticated agents to register
I0505 18:49:04.986152 26005 master.cpp:515] Master only allowing authenticated HTTP frameworks to register
I0505 18:49:04.986158 26005 credentials.hpp:37] Loading credentials for authentication from '/tmp/adOaaA/credentials'
I0505 18:49:04.986392 26005 master.cpp:560] Using default 'crammd5' authenticator
I0505 18:49:04.986457 26005 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readonly'
I0505 18:49:04.986589 26005 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readwrite'
I0505 18:49:04.986655 26005 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-master-scheduler'
I0505 18:49:04.986726 26005 master.cpp:640] Authorization enabled
I0505 18:49:04.986806 26011 hierarchical.cpp:158] Initialized hierarchical allocator process
I0505 18:49:04.986832 26011 whitelist_watcher.cpp:77] No whitelist given
I0505 18:49:04.987797 26005 master.cpp:2161] Elected as the leading master!
I0505 18:49:04.987812 26005 master.cpp:1700] Recovering from registrar
I0505 18:49:04.987900 25996 registrar.cpp:345] Recovering registrar
I0505 18:49:04.988070 25996 registrar.cpp:389] Successfully fetched the registry (0B) in 145920ns
I0505 18:49:04.988113 25996 registrar.cpp:493] Applied 1 operations in 12799ns; attempting to update the registry
I0505 18:49:04.988265 25996 registrar.cpp:550] Successfully updated the registry in 130048ns
I0505 18:49:04.988306 25996 registrar.cpp:422] Successfully recovered registrar
I0505 18:49:04.988402 25996 master.cpp:1799] Recovered 0 agents from the registry (129B); allowing 10mins for agents to re-register
I0505 18:49:04.988473 25998 hierarchical.cpp:185] Skipping recovery of hierarchical allocator: nothing to recover
I0505 18:49:04.991511 25995 cluster.cpp:448] Creating default 'local' authorizer
I0505 18:49:04.992162 26004 slave.cpp:225] Mesos agent started on (512)@172.17.0.3:39728
I0505 18:49:04.992184 26004 slave.cpp:226] Flags at startup: --acls="permissive: true
" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/mesos/store/appc" --authenticate_http_executors="true" --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/ExecutorAuthorizationTest_FailedApiCalls_kGjmkt/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_secret_key="/tmp/ExecutorAuthorizationTest_FailedApiCalls_kGjmkt/executor_secret_key" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/ExecutorAuthorizationTest_FailedApiCalls_kGjmkt/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_command_executor="false" --http_credentials="/tmp/ExecutorAuthorizationTest_FailedApiCalls_kGjmkt/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --port="5051" --qos_correction_interval_min="0ns" --quiet="false" --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/ExecutorAuthorizationTest_FailedApiCalls_kGjmkt" --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/ExecutorAuthorizationTest_FailedApiCalls_RbVfK1"
I0505 18:49:04.992398 26004 credentials.hpp:86] Loading credential for authentication from '/tmp/ExecutorAuthorizationTest_FailedApiCalls_kGjmkt/credential'
I0505 18:49:04.992496 25995 scheduler.cpp:184] Version: 1.4.0
I0505 18:49:04.992504 26004 slave.cpp:258] Agent using credential for: test-principal
I0505 18:49:04.992517 26004 credentials.hpp:37] Loading credentials for authentication from '/tmp/ExecutorAuthorizationTest_FailedApiCalls_kGjmkt/http_credentials'
I0505 18:49:04.992708 26004 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-executor'
I0505 18:49:04.992753 26004 http.cpp:996] Creating default 'jwt' HTTP authenticator for realm 'mesos-agent-executor'
I0505 18:49:04.992763 25999 scheduler.cpp:470] New master detected at master@172.17.0.3:39728
I0505 18:49:04.992781 25999 scheduler.cpp:479] Waiting for 0ns before initiating a re-(connection) attempt with the master
I0505 18:49:04.992808 26004 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0505 18:49:04.992841 26004 http.cpp:996] Creating default 'jwt' HTTP authenticator for realm 'mesos-agent-readonly'
I0505 18:49:04.992946 26004 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0505 18:49:04.992983 26004 http.cpp:996] Creating default 'jwt' HTTP authenticator for realm 'mesos-agent-readwrite'
I0505 18:49:04.993453 26004 slave.cpp:525] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0505 18:49:04.993494 26004 slave.cpp:533] Agent attributes: [ ]
I0505 18:49:04.993505 26004 slave.cpp:538] Agent hostname: e18141c804f7
I0505 18:49:04.993718 26006 status_update_manager.cpp:177] Pausing sending status updates
I0505 18:49:04.993934 26004 state.cpp:62] Recovering state from '/tmp/ExecutorAuthorizationTest_FailedApiCalls_RbVfK1/meta'
I0505 18:49:04.994063 26004 status_update_manager.cpp:203] Recovering status update manager
I0505 18:49:04.994171 26004 slave.cpp:5963] Finished recovery
I0505 18:49:04.994832 26011 scheduler.cpp:361] Connected with the master at http://172.17.0.3:39728/master/api/v1/scheduler
I0505 18:49:04.995100 26004 slave.cpp:6145] Querying resource estimator for oversubscribable resources
I0505 18:49:04.995306 26002 slave.cpp:6159] Received oversubscribable resources {} from the resource estimator
I0505 18:49:04.995455 26003 slave.cpp:918] New master detected at master@172.17.0.3:39728
I0505 18:49:04.995520 26003 slave.cpp:953] Detecting new master
I0505 18:49:04.995538 26000 status_update_manager.cpp:177] Pausing sending status updates
I0505 18:49:04.996212 25996 scheduler.cpp:243] Sending SUBSCRIBE call to http://172.17.0.3:39728/master/api/v1/scheduler
I0505 18:49:04.996774 25996 process.cpp:3730] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I0505 18:49:04.997114 25996 http.cpp:1115] HTTP POST for /master/api/v1/scheduler from 172.17.0.3:46797
I0505 18:49:04.997195 25996 master.cpp:2513] Received subscription request for HTTP framework 'default'
I0505 18:49:04.997238 25996 master.cpp:2197] Authorizing framework principal 'test-principal' to receive offers for roles '{ * }'
I0505 18:49:04.997393 25998 master.cpp:2628] Subscribing framework 'default' with checkpointing disabled and capabilities [ ]
I0505 18:49:04.997721 25996 hierarchical.cpp:273] Added framework 19dd7b54-251c-4b31-93c1-73da0661009f-0000
I0505 18:49:04.997778 26006 master.hpp:2194] Sending heartbeat to 19dd7b54-251c-4b31-93c1-73da0661009f-0000
I0505 18:49:04.997817 25996 hierarchical.cpp:1850] No allocations performed
I0505 18:49:04.998011 25996 hierarchical.cpp:1940] No inverse offers to send out!
I0505 18:49:04.998030 25996 hierarchical.cpp:1434] Performed allocation for 0 agents in 227557ns
I0505 18:49:04.998183 25998 scheduler.cpp:676] Enqueuing event SUBSCRIBED received from http://172.17.0.3:39728/master/api/v1/scheduler
I0505 18:49:04.998524 25997 scheduler.cpp:676] Enqueuing event HEARTBEAT received from http://172.17.0.3:39728/master/api/v1/scheduler
I0505 18:49:05.002674 26005 slave.cpp:980] Authenticating with master master@172.17.0.3:39728
I0505 18:49:05.002708 26005 slave.cpp:991] Using default CRAM-MD5 authenticatee
I0505 18:49:05.002799 25998 authenticatee.cpp:121] Creating new client SASL connection
I0505 18:49:05.003031 26004 master.cpp:7475] Authenticating slave(512)@172.17.0.3:39728
I0505 18:49:05.003098 25998 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(1042)@172.17.0.3:39728
I0505 18:49:05.003201 26004 authenticator.cpp:98] Creating new server SASL connection
I0505 18:49:05.003389 25998 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5
I0505 18:49:05.003408 25998 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5'
I0505 18:49:05.003510 25998 authenticator.cpp:204] Received SASL authentication start
I0505 18:49:05.003577 25998 authenticator.cpp:326] Authentication requires more steps
I0505 18:49:05.003656 25998 authenticatee.cpp:259] Received SASL authentication step
I0505 18:49:05.003711 25998 authenticator.cpp:232] Received SASL authentication step
I0505 18:49:05.003736 25998 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: 'e18141c804f7' server FQDN: 'e18141c804f7' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false
I0505 18:49:05.003749 25998 auxprop.cpp:181] Looking up auxiliary property '*userPassword'
I0505 18:49:05.003784 25998 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
I0505 18:49:05.003799 25998 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: 'e18141c804f7' server FQDN: 'e18141c804f7' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true
I0505 18:49:05.003844 25998 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true
I0505 18:49:05.003857 25998 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
I0505 18:49:05.003875 25998 authenticator.cpp:318] Authentication success
I0505 18:49:05.003959 25998 authenticatee.cpp:299] Authentication success
I0505 18:49:05.004010 25998 master.cpp:7505] Successfully authenticated principal 'test-principal' at slave(512)@172.17.0.3:39728
I0505 18:49:05.004055 25998 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(1042)@172.17.0.3:39728
I0505 18:49:05.004165 25998 slave.cpp:1075] Successfully authenticated with master master@172.17.0.3:39728
I0505 18:49:05.004254 25998 slave.cpp:1503] Will retry registration in 13.573433ms if necessary
I0505 18:49:05.004379 25998 master.cpp:5429] Received register agent message from slave(512)@172.17.0.3:39728 (e18141c804f7)
I0505 18:49:05.004400 25998 master.cpp:3659] Authorizing agent with principal 'test-principal'
I0505 18:49:05.004591 25998 master.cpp:5564] Registering agent at slave(512)@172.17.0.3:39728 (e18141c804f7) with id 19dd7b54-251c-4b31-93c1-73da0661009f-S0
I0505 18:49:05.004734 25998 registrar.cpp:493] Applied 1 operations in 29672ns; attempting to update the registry
I0505 18:49:05.004986 25998 registrar.cpp:550] Successfully updated the registry in 185088ns
I0505 18:49:05.005213 25998 master.cpp:5639] Registered agent 19dd7b54-251c-4b31-93c1-73da0661009f-S0 at slave(512)@172.17.0.3:39728 (e18141c804f7) with cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0505 18:49:05.005359 25998 hierarchical.cpp:525] Added agent 19dd7b54-251c-4b31-93c1-73da0661009f-S0 (e18141c804f7) with cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] (allocated: {})
I0505 18:49:05.005626 25998 hierarchical.cpp:1940] No inverse offers to send out!
I0505 18:49:05.005645 25998 hierarchical.cpp:1434] Performed allocation for 1 agents in 230143ns
I0505 18:49:05.005704 26001 slave.cpp:1121] Registered with master master@172.17.0.3:39728; given agent ID 19dd7b54-251c-4b31-93c1-73da0661009f-S0
I0505 18:49:05.005895 26001 fetcher.cpp:94] Clearing fetcher cache
I0505 18:49:05.006230 26001 slave.cpp:1149] Checkpointing SlaveInfo to '/tmp/ExecutorAuthorizationTest_FailedApiCalls_RbVfK1/meta/slaves/19dd7b54-251c-4b31-93c1-73da0661009f-S0/slave.info'
I0505 18:49:05.005859 26011 master.cpp:7305] Sending 1 offers to framework 19dd7b54-251c-4b31-93c1-73da0661009f-0000 (default)
I0505 18:49:05.006659 26011 status_update_manager.cpp:184] Resuming sending status updates
I0505 18:49:05.006837 26001 slave.cpp:1187] Forwarding total oversubscribed resources {}
I0505 18:49:05.006886 26001 slave.cpp:4745] Received ping from slave-observer(500)@172.17.0.3:39728
I0505 18:49:05.006942 26001 master.cpp:6324] Received update of agent 19dd7b54-251c-4b31-93c1-73da0661009f-S0 at slave(512)@172.17.0.3:39728 (e18141c804f7) with total oversubscribed resources {}
I0505 18:49:05.007426 26011 scheduler.cpp:676] Enqueuing event OFFERS received from http://172.17.0.3:39728/master/api/v1/scheduler
I0505 18:49:05.008110 26003 scheduler.cpp:243] Sending ACCEPT call to http://172.17.0.3:39728/master/api/v1/scheduler
I0505 18:49:05.008685 26003 process.cpp:3730] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I0505 18:49:05.009130 26004 http.cpp:1115] HTTP POST for /master/api/v1/scheduler from 172.17.0.3:46798
I0505 18:49:05.009425 26004 master.cpp:3875] Processing ACCEPT call for offers: [ 19dd7b54-251c-4b31-93c1-73da0661009f-O0 ] on agent 19dd7b54-251c-4b31-93c1-73da0661009f-S0 at slave(512)@172.17.0.3:39728 (e18141c804f7) for framework 19dd7b54-251c-4b31-93c1-73da0661009f-0000 (default)
I0505 18:49:05.009474 26004 master.cpp:3426] Authorizing framework principal 'test-principal' to launch task e20100bc-e7c6-47ec-b03e-f95fd4207088
I0505 18:49:05.010251 26004 master.cpp:9326] Adding task e20100bc-e7c6-47ec-b03e-f95fd4207088 with resources cpus(*)(allocated: *):0.1; mem(*)(allocated: *):32; disk(*)(allocated: *):32 on agent 19dd7b54-251c-4b31-93c1-73da0661009f-S0 at slave(512)@172.17.0.3:39728 (e18141c804f7)
I0505 18:49:05.010327 26004 master.cpp:4736] Launching task group { e20100bc-e7c6-47ec-b03e-f95fd4207088 } of framework 19dd7b54-251c-4b31-93c1-73da0661009f-0000 (default) with resources cpus(*)(allocated: *):0.1; mem(*)(allocated: *):32; disk(*)(allocated: *):32 on agent 19dd7b54-251c-4b31-93c1-73da0661009f-S0 at slave(512)@172.17.0.3:39728 (e18141c804f7)
I0505 18:49:05.010658 26005 slave.cpp:1613] Got assigned task group containing tasks [ e20100bc-e7c6-47ec-b03e-f95fd4207088 ] for framework 19dd7b54-251c-4b31-93c1-73da0661009f-0000
I0505 18:49:05.010774 26004 hierarchical.cpp:1114] Recovered cpus(*)(allocated: *):1.8; mem(*)(allocated: *):960; disk(*)(allocated: *):960; ports(*)(allocated: *):[31000-32000] (total: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000], allocated: cpus(*)(allocated: *):0.2; mem(*)(allocated: *):64; disk(*)(allocated: *):64) on agent 19dd7b54-251c-4b31-93c1-73da0661009f-S0 from framework 19dd7b54-251c-4b31-93c1-73da0661009f-0000
I0505 18:49:05.010834 26004 hierarchical.cpp:1151] Framework 19dd7b54-251c-4b31-93c1-73da0661009f-0000 filtered agent 19dd7b54-251c-4b31-93c1-73da0661009f-S0 for 5secs
I0505 18:49:05.011235 26005 slave.cpp:1894] Authorizing task group containing tasks [ e20100bc-e7c6-47ec-b03e-f95fd4207088 ] for framework 19dd7b54-251c-4b31-93c1-73da0661009f-0000
I0505 18:49:05.011265 26005 slave.cpp:6582] Authorizing framework principal 'test-principal' to launch task e20100bc-e7c6-47ec-b03e-f95fd4207088
I0505 18:49:05.011651 26005 slave.cpp:2081] Launching task group containing tasks [ e20100bc-e7c6-47ec-b03e-f95fd4207088 ] for framework 19dd7b54-251c-4b31-93c1-73da0661009f-0000
I0505 18:49:05.012171 26005 paths.cpp:573] Trying to chown '/tmp/ExecutorAuthorizationTest_FailedApiCalls_RbVfK1/slaves/19dd7b54-251c-4b31-93c1-73da0661009f-S0/frameworks/19dd7b54-251c-4b31-93c1-73da0661009f-0000/executors/default/runs/6b9073cf-c24f-40d4-bbab-22436a570f13' to user 'mesos'
I0505 18:49:05.012424 26005 slave.cpp:6922] Launching executor 'default' of framework 19dd7b54-251c-4b31-93c1-73da0661009f-0000 with resources cpus(*)(allocated: *):0.1; mem(*)(allocated: *):32; disk(*)(allocated: *):32 in work directory '/tmp/ExecutorAuthorizationTest_FailedApiCalls_RbVfK1/slaves/19dd7b54-251c-4b31-93c1-73da0661009f-S0/frameworks/19dd7b54-251c-4b31-93c1-73da0661009f-0000/executors/default/runs/6b9073cf-c24f-40d4-bbab-22436a570f13'
I0505 18:49:05.012678 26005 slave.cpp:2310] Queued task group containing tasks [ e20100bc-e7c6-47ec-b03e-f95fd4207088 ] for executor 'default' of framework 19dd7b54-251c-4b31-93c1-73da0661009f-0000
I0505 18:49:05.013864 26005 executor.cpp:192] Version: 1.4.0
I0505 18:49:05.013952 26010 slave.cpp:871] Successfully attached file '/tmp/ExecutorAuthorizationTest_FailedApiCalls_RbVfK1/slaves/19dd7b54-251c-4b31-93c1-73da0661009f-S0/frameworks/19dd7b54-251c-4b31-93c1-73da0661009f-0000/executors/default/runs/6b9073cf-c24f-40d4-bbab-22436a570f13'
I0505 18:49:05.014683 26008 executor.cpp:410] Connected with the agent
I0505 18:49:05.015206 25996 executor.cpp:307] Sending SUBSCRIBE call to http://172.17.0.3:39728/slave(512)/api/v1/executor
I0505 18:49:05.015663 25996 process.cpp:3730] Handling HTTP event for process 'slave(512)' with path: '/slave(512)/api/v1/executor'
I0505 18:49:05.016433 25996 http.cpp:1115] HTTP POST for /slave(512)/api/v1/executor from 172.17.0.3:46799
I0505 18:49:05.016556 25996 slave.cpp:3568] Received Subscribe request for HTTP executor 'default' of framework 19dd7b54-251c-4b31-93c1-73da0661009f-0000
I0505 18:49:05.016938 25996 slave.cpp:2552] Sending queued task group task group containing tasks [ e20100bc-e7c6-47ec-b03e-f95fd4207088 ] to executor 'default' of framework 19dd7b54-251c-4b31-93c1-73da0661009f-0000 (via HTTP)
I0505 18:49:05.017681 25998 executor.cpp:725] Enqueuing event SUBSCRIBED received from http://172.17.0.3:39728/slave(512)/api/v1/executor
I0505 18:49:05.018229 26007 executor.cpp:725] Enqueuing event LAUNCH_GROUP received from http://172.17.0.3:39728/slave(512)/api/v1/executor
I0505 18:49:05.019883 26010 process.cpp:3730] Handling HTTP event for process 'slave(512)' with path: '/slave(512)/api/v1'
I0505 18:49:05.020665 26000 http.cpp:1115] HTTP POST for /slave(512)/api/v1 from 172.17.0.3:46801
I0505 18:49:05.020800 26000 http.cpp:527] Processing call LAUNCH_NESTED_CONTAINER
I0505 18:49:05.021980 26001 process.cpp:3730] Handling HTTP event for process 'slave(512)' with path: '/slave(512)/api/v1'
I0505 18:49:05.022541 26006 http.cpp:1115] HTTP POST for /slave(512)/api/v1 from 172.17.0.3:46802
I0505 18:49:05.022657 26006 http.cpp:527] Processing call LAUNCH_NESTED_CONTAINER_SESSION
I0505 18:49:05.023669 26011 process.cpp:3730] Handling HTTP event for process 'slave(512)' with path: '/slave(512)/api/v1'
I0505 18:49:05.024072 26011 http.cpp:1115] HTTP POST for /slave(512)/api/v1 from 172.17.0.3:46803
I0505 18:49:05.024152 26011 http.cpp:527] Processing call WAIT_NESTED_CONTAINER
I0505 18:49:05.025106 26004 process.cpp:3730] Handling HTTP event for process 'slave(512)' with path: '/slave(512)/api/v1'
I0505 18:49:05.025715 26005 http.cpp:1115] HTTP POST for /slave(512)/api/v1 from 172.17.0.3:46804
I0505 18:49:05.025816 26005 http.cpp:527] Processing call KILL_NESTED_CONTAINER
I0505 18:49:05.026850 26010 process.cpp:3730] Handling HTTP event for process 'slave(512)' with path: '/slave(512)/api/v1'
I0505 18:49:05.027479 26004 http.cpp:1115] HTTP POST for /slave(512)/api/v1 from 172.17.0.3:46805
I0505 18:49:05.027590 26004 http.cpp:527] Processing call REMOVE_NESTED_CONTAINER
I0505 18:49:05.028600 25999 process.cpp:3730] Handling HTTP event for process 'slave(512)' with path: '/slave(512)/api/v1'
I0505 18:49:05.029203 26008 http.cpp:1115] HTTP POST for /slave(512)/api/v1 from 172.17.0.3:46806
I0505 18:49:05.029322 26008 http.cpp:527] Processing call ATTACH_CONTAINER_OUTPUT
I0505 18:49:05.030310 26003 process.cpp:3730] Handling HTTP event for process 'slave(512)' with path: '/slave(512)/api/v1/executor'
I0505 18:49:05.030967 26007 http.cpp:1115] HTTP POST for /slave(512)/api/v1/executor from 172.17.0.3:46807
I0505 18:49:05.031903 25996 process.cpp:3730] Handling HTTP event for process 'slave(512)' with path: '/slave(512)/api/v1/executor'
I0505 18:49:05.032557 26010 http.cpp:1115] HTTP POST for /slave(512)/api/v1/executor from 172.17.0.3:46808
I0505 18:49:05.033572 25996 master.cpp:1430] Framework 19dd7b54-251c-4b31-93c1-73da0661009f-0000 (default) disconnected
I0505 18:49:05.033591 25996 master.cpp:3160] Deactivating framework 19dd7b54-251c-4b31-93c1-73da0661009f-0000 (default)
I0505 18:49:05.033612 25996 master.cpp:3137] Disconnecting framework 19dd7b54-251c-4b31-93c1-73da0661009f-0000 (default)
I0505 18:49:05.033643 25996 master.cpp:1445] Giving framework 19dd7b54-251c-4b31-93c1-73da0661009f-0000 (default) 0ns to failover
I0505 18:49:05.033762 25996 hierarchical.cpp:374] Deactivated framework 19dd7b54-251c-4b31-93c1-73da0661009f-0000
I0505 18:49:05.035634 25996 master.cpp:7146] Framework failover timeout, removing framework 19dd7b54-251c-4b31-93c1-73da0661009f-0000 (default)
I0505 18:49:05.035650 25996 master.cpp:8000] Removing framework 19dd7b54-251c-4b31-93c1-73da0661009f-0000 (default)
I0505 18:49:05.035703 25996 master.cpp:8568] Updating the state of task e20100bc-e7c6-47ec-b03e-f95fd4207088 of framework 19dd7b54-251c-4b31-93c1-73da0661009f-0000 (latest state: TASK_KILLED, status update state: TASK_KILLED)
I0505 18:49:05.035845 25996 master.cpp:8662] Removing task e20100bc-e7c6-47ec-b03e-f95fd4207088 with resources cpus(*)(allocated: *):0.1; mem(*)(allocated: *):32; disk(*)(allocated: *):32 of framework 19dd7b54-251c-4b31-93c1-73da0661009f-0000 on agent 19dd7b54-251c-4b31-93c1-73da0661009f-S0 at slave(512)@172.17.0.3:39728 (e18141c804f7)
I0505 18:49:05.035953 25996 master.cpp:8691] Removing executor 'default' with resources cpus(*)(allocated: *):0.1; mem(*)(allocated: *):32; disk(*)(allocated: *):32 of framework 19dd7b54-251c-4b31-93c1-73da0661009f-0000 on agent 19dd7b54-251c-4b31-93c1-73da0661009f-S0 at slave(512)@172.17.0.3:39728 (e18141c804f7)
I0505 18:49:05.036118 25996 slave.cpp:3057] Asked to shut down framework 19dd7b54-251c-4b31-93c1-73da0661009f-0000 by master@172.17.0.3:39728
I0505 18:49:05.036134 25996 slave.cpp:3082] Shutting down framework 19dd7b54-251c-4b31-93c1-73da0661009f-0000
I0505 18:49:05.036149 25996 slave.cpp:5475] Shutting down executor 'default' of framework 19dd7b54-251c-4b31-93c1-73da0661009f-0000 (via HTTP)
I0505 18:49:05.036311 25996 hierarchical.cpp:1114] Recovered cpus(*)(allocated: *):0.1; mem(*)(allocated: *):32; disk(*)(allocated: *):32 (total: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000], allocated: cpus(*)(allocated: *):0.1; mem(*)(allocated: *):32; disk(*)(allocated: *):32) on agent 19dd7b54-251c-4b31-93c1-73da0661009f-S0 from framework 19dd7b54-251c-4b31-93c1-73da0661009f-0000
I0505 18:49:05.036460 25996 hierarchical.cpp:1114] Recovered cpus(*)(allocated: *):0.1; mem(*)(allocated: *):32; disk(*)(allocated: *):32 (total: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000], allocated: {}) on agent 19dd7b54-251c-4b31-93c1-73da0661009f-S0 from framework 19dd7b54-251c-4b31-93c1-73da0661009f-0000
I0505 18:49:05.036547 25996 hierarchical.cpp:325] Removed framework 19dd7b54-251c-4b31-93c1-73da0661009f-0000
I0505 18:49:05.037020 26005 executor.cpp:725] Enqueuing event SHUTDOWN received from http://172.17.0.3:39728/slave(512)/api/v1/executor
*** Aborted at 1494010145 (unix time) try "date -d @1494010145" if you are using GNU date ***
PC: @ 0x2b73d41 testing::internal::UntypedFunctionMockerBase::SetOwnerAndName()
*** SIGSEGV (@0x0) received by PID 25995 (TID 0x2b1bc879d700) from PID 0; stack trace: ***
@ 0x2b1bbf19d330 (unknown)
@ 0x2b73d41 testing::internal::UntypedFunctionMockerBase::SetOwnerAndName()
@ 0xc4cd8f mesos::internal::tests::executor::MockHTTPExecutor<>::event()
@ 0xc4c2c1 mesos::internal::tests::executor::TestMesos<>::events()
@ 0xc4c47a std::_Function_handler<>::_M_invoke()
@ 0x2b1bbaad61ba process::AsyncExecutorProcess::execute<>()
@ 0x2b1bbaad6d21 _ZZN7process8dispatchI7NothingNS_20AsyncExecutorProcessERKSt8functionIFvRKSt5queueIN5mesos2v18executor5EventESt5dequeIS8_SaIS8_EEEEESC_SG_SC_EENS_6FutureIT_EERKNS_3PIDIT0_EEMSN_FSK_T1_T2_ET3_T4_ENKUlPNS_11ProcessBaseEE_clESY_
@ 0x2b1bbbee4ae7 process::ProcessManager::resume()
@ 0x2b1bbbef9c9f std::thread::_Impl<>::_M_run()
@ 0x2b1bbf45ca60 (unknown)
@ 0x2b1bbf195184 start_thread
@ 0x2b1bbfcc8bed (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-1494007334-9663
Untagged: mesos-1494007334-9663:latest
Deleted: sha256:a6a7f226204cc24ce6b27169d4d058d42627d982225f5e170fab7716a6fd519b
Deleted: sha256:5548b68fb4a1fdbeb4a6a79da70a7400f686c85c1720e4605c91665a1a9f547d
Deleted: sha256:808e25a74604e68ccc15a72d3dfeb8724d4e6cee8e29c8f68addc2b64a21321f
Deleted: sha256:cfcf00770eae2b9f79987926e6b9782aa64dc364f9591566fe6a949babe5ab4e
Deleted: sha256:1dd1adeec6b00b4d6fd998e2531e3f6a1f3131213995e0bd3db8b7d4bdf39ab0
Deleted: sha256:356992d6f7d12fc1e0c59ec4df56f44bbee4823b0a4c748abc7767597711c4e7
Deleted: sha256:eedd908efaa5a9771c0ee486ba49bbcea09937f0b49840b861b960c929c7c572
Deleted: sha256:5ec619ecf70ec092d00b0e64dc58960186bbc5eb76e1c5bd0b54e1db0f26bd5c
Deleted: sha256:4f04534ca35da86f10c2d06e49e67ab1662f95343a5d02307c9ef9e2a6b48381
Deleted: sha256:fc56dd8cf444b9943a6dfa8788b68296962dae26853c2306e7b5d628fe92fc2a
Deleted: sha256:31a27c4a8eb73955b7abc0f9fb79c653ea522778b539778c5d2eb1fbe51a0e2e
Deleted: sha256:9910af707bd9c7629256dd51d186eb7b15fdc03f66787fd8dab879b0b7ed9489
Deleted: sha256:3ac370d240c6655108ad32df12a9787c8159a2bc7fb9aef3dd26020d3f13f90b
Deleted: sha256:f7826d06011bb693118a7ed923174d4db24fed7424cefa2ee4e0a5cf3f6a29ed
Deleted: sha256:27fe3bbf6751cff5860ec429f421ab38dce488cc1399507f12967833c9358e2a
Deleted: sha256:1d3f72fe08364ceeb148c2b57d18cc3b151563c6b623029c98a1e914bd3b52fa
Deleted: sha256:37874c4381adef6aeaae41dbd603705b54ae48db0ef5de91e381d5dec8186181
Deleted: sha256:bc013147e41fd0d731d12ea3278c0bcc12db478642a820a53543bc5b438617fb
Deleted: sha256:dc6c9d54bd4aec49c29b34b52b01f7765a8b09a2ee0d4ec5e0bfd279d41f6183
Deleted: sha256:be272e2a73aaa9dfd681808713314e0d534c929f0a099b346598f4b74f518166
Deleted: sha256:7f5d7e4115778f29346500dcffa9441d42566a6483ab4c4aadfa5872aacddb02
Deleted: sha256:6603b8da1611c6075219bd11c3a2d63580f6b2373d22b5ec6e1d12a9ce285583
Deleted: sha256:b3320a5ab4d16a7088208393c5191ece52595ec9953a3d580568528fe0fe88ea
Deleted: sha256:95376435ed101440e3008122c18430008c427d0e6f211cf5be1cf316d803b608
Build step 'Execute shell' marked build as failure
Not sending mail to unregistered user neil.conway@gmail.com
Jenkins build is back to normal : Mesos-Buildbot » cmake,clang,--verbose --enable-libevent --enable-ssl,GLOG_v=1 MESOS_VERBOSE=1,ubuntu:14.04,(docker||Hadoop)&&(!ubuntu-us1)&&(!ubuntu-eu2) #3612
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/Mesos-Buildbot/BUILDTOOL=cmake,COMPILER=clang,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)/3612/display/redirect?page=changes>
Build failed in Jenkins: Mesos-Buildbot » cmake,clang,--verbose --enable-libevent --enable-ssl,GLOG_v=1 MESOS_VERBOSE=1,ubuntu:14.04,(docker||Hadoop)&&(!ubuntu-us1)&&(!ubuntu-eu2) #3611
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/Mesos-Buildbot/BUILDTOOL=cmake,COMPILER=clang,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)/3611/display/redirect?page=changes>
Changes:
[yujie.jay] Add IPv6 support to stout.
------------------------------------------
[...truncated 26.69 MB...]
I0505 22:57:34.780812 31688 slave.cpp:6159] Received oversubscribable resources {} from the resource estimator
I0505 22:57:34.784312 31676 process.cpp:3730] Handling HTTP event for process 'slave(750)' with path: '/slave(750)/containers'
I0505 22:57:34.784776 31676 http.cpp:1115] HTTP GET for /slave(750)/containers from 172.17.0.2:41859
I0505 22:57:34.784813 31676 http.cpp:936] Authorizing principal 'test-principal' to GET the '/containers' endpoint
I0505 22:57:34.785972 31680 slave.cpp:790] Agent terminating
[ OK ] Endpoint/SlaveEndpointTest.AuthorizedRequest/2 (27 ms)
[ RUN ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/0
I0505 22:57:34.824218 25995 containerizer.cpp:221] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni
W0505 22:57:34.824584 25995 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0505 22:57:34.824632 25995 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0505 22:57:34.824651 25995 provisioner.cpp:249] Using default backend 'copy'
I0505 22:57:34.827244 31683 slave.cpp:225] Mesos agent started on (751)@172.17.0.2:37738
I0505 22:57:34.827275 31683 slave.cpp:226] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/mesos/store/appc" --authenticate_http_executors="true" --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_nyNWZ9/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_secret_key="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_nyNWZ9/executor_secret_key" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_nyNWZ9/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_command_executor="false" --http_credentials="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_nyNWZ9/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --port="5051" --qos_correction_interval_min="0ns" --quiet="false" --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_nyNWZ9" --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_gEJcbc"
I0505 22:57:34.827528 31683 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_nyNWZ9/credential'
I0505 22:57:34.827667 31683 slave.cpp:258] Agent using credential for: test-principal
I0505 22:57:34.827682 31683 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_nyNWZ9/http_credentials'
I0505 22:57:34.827855 31683 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-executor'
I0505 22:57:34.827905 31683 http.cpp:996] Creating default 'jwt' HTTP authenticator for realm 'mesos-agent-executor'
I0505 22:57:34.827985 31683 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0505 22:57:34.828009 31683 http.cpp:996] Creating default 'jwt' HTTP authenticator for realm 'mesos-agent-readonly'
I0505 22:57:34.828074 31683 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0505 22:57:34.828109 31683 http.cpp:996] Creating default 'jwt' HTTP authenticator for realm 'mesos-agent-readwrite'
I0505 22:57:34.828482 31683 slave.cpp:525] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0505 22:57:34.828511 31683 slave.cpp:533] Agent attributes: [ ]
I0505 22:57:34.828516 31683 slave.cpp:538] Agent hostname: dddbe4881e1f
I0505 22:57:34.828805 31684 status_update_manager.cpp:177] Pausing sending status updates
I0505 22:57:34.829059 31683 state.cpp:62] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_gEJcbc/meta'
I0505 22:57:34.829188 31680 status_update_manager.cpp:203] Recovering status update manager
I0505 22:57:34.829326 31690 containerizer.cpp:608] Recovering containerizer
I0505 22:57:34.829840 31680 provisioner.cpp:410] Provisioner recovery complete
I0505 22:57:34.830000 31680 slave.cpp:5963] Finished recovery
I0505 22:57:34.830482 31680 slave.cpp:6145] Querying resource estimator for oversubscribable resources
I0505 22:57:34.830669 31680 slave.cpp:6159] Received oversubscribable resources {} from the resource estimator
I0505 22:57:34.832451 31680 process.cpp:3730] Handling HTTP event for process 'slave(751)' with path: '/slave(751)/monitor/statistics'
I0505 22:57:34.833067 31689 http.cpp:1115] HTTP GET for /slave(751)/monitor/statistics from 172.17.0.2:41863
I0505 22:57:34.833122 31689 http.cpp:936] Authorizing principal 'test-principal' to GET the '/monitor/statistics' endpoint
I0505 22:57:34.834501 25995 slave.cpp:790] Agent terminating
[ OK ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/0 (16 ms)
[ RUN ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/1
I0505 22:57:34.849336 25995 containerizer.cpp:221] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni
W0505 22:57:34.849630 25995 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0505 22:57:34.849668 25995 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0505 22:57:34.849685 25995 provisioner.cpp:249] Using default backend 'copy'
I0505 22:57:34.850790 31689 slave.cpp:225] Mesos agent started on (752)@172.17.0.2:37738
I0505 22:57:34.850821 31689 slave.cpp:226] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/mesos/store/appc" --authenticate_http_executors="true" --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_fqUnu1/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_secret_key="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_fqUnu1/executor_secret_key" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_fqUnu1/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_command_executor="false" --http_credentials="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_fqUnu1/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --port="5051" --qos_correction_interval_min="0ns" --quiet="false" --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_fqUnu1" --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_GXkuB3"
I0505 22:57:34.851052 31689 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_fqUnu1/credential'
I0505 22:57:34.851162 31689 slave.cpp:258] Agent using credential for: test-principal
I0505 22:57:34.851174 31689 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_fqUnu1/http_credentials'
I0505 22:57:34.851322 31689 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-executor'
I0505 22:57:34.851369 31689 http.cpp:996] Creating default 'jwt' HTTP authenticator for realm 'mesos-agent-executor'
I0505 22:57:34.851451 31689 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0505 22:57:34.851490 31689 http.cpp:996] Creating default 'jwt' HTTP authenticator for realm 'mesos-agent-readonly'
I0505 22:57:34.851562 31689 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0505 22:57:34.851630 31689 http.cpp:996] Creating default 'jwt' HTTP authenticator for realm 'mesos-agent-readwrite'
I0505 22:57:34.852331 31689 slave.cpp:525] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0505 22:57:34.852391 31689 slave.cpp:533] Agent attributes: [ ]
I0505 22:57:34.852401 31689 slave.cpp:538] Agent hostname: dddbe4881e1f
I0505 22:57:34.852468 31681 status_update_manager.cpp:177] Pausing sending status updates
I0505 22:57:34.852893 31690 state.cpp:62] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_GXkuB3/meta'
I0505 22:57:34.853075 31689 status_update_manager.cpp:203] Recovering status update manager
I0505 22:57:34.853235 31683 containerizer.cpp:608] Recovering containerizer
I0505 22:57:34.853847 31683 provisioner.cpp:410] Provisioner recovery complete
I0505 22:57:34.854008 31683 slave.cpp:5963] Finished recovery
I0505 22:57:34.854488 31683 slave.cpp:6145] Querying resource estimator for oversubscribable resources
I0505 22:57:34.854662 31683 slave.cpp:6159] Received oversubscribable resources {} from the resource estimator
I0505 22:57:34.855834 31686 process.cpp:3730] Handling HTTP event for process 'slave(752)' with path: '/slave(752)/monitor/statistics.json'
I0505 22:57:34.856353 31677 http.cpp:1115] HTTP GET for /slave(752)/monitor/statistics.json from 172.17.0.2:41864
I0505 22:57:34.856396 31677 http.cpp:936] Authorizing principal 'test-principal' to GET the '/monitor/statistics.json' endpoint
I0505 22:57:34.857553 31689 slave.cpp:790] Agent terminating
[ OK ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/1 (20 ms)
[ RUN ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/2
I0505 22:57:34.870540 25995 containerizer.cpp:221] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni
W0505 22:57:34.870906 25995 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0505 22:57:34.870954 25995 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0505 22:57:34.870973 25995 provisioner.cpp:249] Using default backend 'copy'
I0505 22:57:34.873997 31691 slave.cpp:225] Mesos agent started on (753)@172.17.0.2:37738
I0505 22:57:34.874042 31691 slave.cpp:226] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/mesos/store/appc" --authenticate_http_executors="true" --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_7wJWcT/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_secret_key="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_7wJWcT/executor_secret_key" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_7wJWcT/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_command_executor="false" --http_credentials="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_7wJWcT/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --port="5051" --qos_correction_interval_min="0ns" --quiet="false" --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_7wJWcT" --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_C4wEgV"
I0505 22:57:34.874397 31691 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_7wJWcT/credential'
I0505 22:57:34.874544 31691 slave.cpp:258] Agent using credential for: test-principal
I0505 22:57:34.874560 31691 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_7wJWcT/http_credentials'
I0505 22:57:34.874742 31691 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-executor'
I0505 22:57:34.874812 31691 http.cpp:996] Creating default 'jwt' HTTP authenticator for realm 'mesos-agent-executor'
I0505 22:57:34.874877 31691 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0505 22:57:34.874905 31691 http.cpp:996] Creating default 'jwt' HTTP authenticator for realm 'mesos-agent-readonly'
I0505 22:57:34.874943 31691 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0505 22:57:34.874974 31691 http.cpp:996] Creating default 'jwt' HTTP authenticator for realm 'mesos-agent-readwrite'
I0505 22:57:34.875478 31691 slave.cpp:525] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0505 22:57:34.875517 31691 slave.cpp:533] Agent attributes: [ ]
I0505 22:57:34.875524 31691 slave.cpp:538] Agent hostname: dddbe4881e1f
I0505 22:57:34.875834 31689 status_update_manager.cpp:177] Pausing sending status updates
I0505 22:57:34.876138 31686 state.cpp:62] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_C4wEgV/meta'
I0505 22:57:34.876338 31677 status_update_manager.cpp:203] Recovering status update manager
I0505 22:57:34.876503 31676 containerizer.cpp:608] Recovering containerizer
I0505 22:57:34.877126 31676 provisioner.cpp:410] Provisioner recovery complete
I0505 22:57:34.877287 31676 slave.cpp:5963] Finished recovery
I0505 22:57:34.877787 31676 slave.cpp:6145] Querying resource estimator for oversubscribable resources
I0505 22:57:34.877964 31676 slave.cpp:6159] Received oversubscribable resources {} from the resource estimator
I0505 22:57:34.880467 31682 process.cpp:3730] Handling HTTP event for process 'slave(753)' with path: '/slave(753)/containers'
I0505 22:57:34.881096 31682 http.cpp:1115] HTTP GET for /slave(753)/containers from 172.17.0.2:41865
I0505 22:57:34.881151 31682 http.cpp:936] Authorizing principal 'test-principal' to GET the '/containers' endpoint
I0505 22:57:34.882762 25995 slave.cpp:790] Agent terminating
[ OK ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/2 (27 ms)
[ RUN ] Endpoint/SlaveEndpointTest.NoAuthorizer/0
I0505 22:57:34.898602 25995 containerizer.cpp:221] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni
W0505 22:57:34.899242 25995 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0505 22:57:34.899492 25995 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0505 22:57:34.899574 25995 provisioner.cpp:249] Using default backend 'copy'
I0505 22:57:34.900470 25995 cluster.cpp:448] Creating default 'local' authorizer
I0505 22:57:34.901219 31690 slave.cpp:225] Mesos agent started on (754)@172.17.0.2:37738
I0505 22:57:34.901259 31690 slave.cpp:226] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/mesos/store/appc" --authenticate_http_executors="true" --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_BeQCcL/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_secret_key="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_BeQCcL/executor_secret_key" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_BeQCcL/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_command_executor="false" --http_credentials="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_BeQCcL/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --port="5051" --qos_correction_interval_min="0ns" --quiet="false" --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_BeQCcL" --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_SsrSbN"
I0505 22:57:34.901500 31690 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_BeQCcL/credential'
I0505 22:57:34.901628 31690 slave.cpp:258] Agent using credential for: test-principal
I0505 22:57:34.901640 31690 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_BeQCcL/http_credentials'
I0505 22:57:34.901768 31690 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-executor'
I0505 22:57:34.901819 31690 http.cpp:996] Creating default 'jwt' HTTP authenticator for realm 'mesos-agent-executor'
I0505 22:57:34.901876 31690 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0505 22:57:34.901906 31690 http.cpp:996] Creating default 'jwt' HTTP authenticator for realm 'mesos-agent-readonly'
I0505 22:57:34.901952 31690 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0505 22:57:34.901985 31690 http.cpp:996] Creating default 'jwt' HTTP authenticator for realm 'mesos-agent-readwrite'
I0505 22:57:34.902451 31690 slave.cpp:525] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0505 22:57:34.902494 31690 slave.cpp:533] Agent attributes: [ ]
I0505 22:57:34.902503 31690 slave.cpp:538] Agent hostname: dddbe4881e1f
I0505 22:57:34.902941 31690 status_update_manager.cpp:177] Pausing sending status updates
I0505 22:57:34.903228 31690 state.cpp:62] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_SsrSbN/meta'
I0505 22:57:34.903373 31690 status_update_manager.cpp:203] Recovering status update manager
I0505 22:57:34.903437 31690 containerizer.cpp:608] Recovering containerizer
I0505 22:57:34.903872 31690 provisioner.cpp:410] Provisioner recovery complete
I0505 22:57:34.903988 31690 slave.cpp:5963] Finished recovery
I0505 22:57:34.904376 31690 slave.cpp:6145] Querying resource estimator for oversubscribable resources
I0505 22:57:34.904533 31690 slave.cpp:6159] Received oversubscribable resources {} from the resource estimator
I0505 22:57:34.906352 31686 process.cpp:3730] Handling HTTP event for process 'slave(754)' with path: '/slave(754)/monitor/statistics'
I0505 22:57:34.907179 31689 http.cpp:1115] HTTP GET for /slave(754)/monitor/statistics from 172.17.0.2:41866
I0505 22:57:34.907227 31689 http.cpp:936] Authorizing principal 'test-principal' to GET the '/monitor/statistics' endpoint
I0505 22:57:34.915572 31688 slave.cpp:790] Agent terminating
[ OK ] Endpoint/SlaveEndpointTest.NoAuthorizer/0 (24 ms)
[ RUN ] Endpoint/SlaveEndpointTest.NoAuthorizer/1
I0505 22:57:34.949915 25995 containerizer.cpp:221] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni
W0505 22:57:34.950361 25995 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0505 22:57:34.950471 25995 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0505 22:57:34.950494 25995 provisioner.cpp:249] Using default backend 'copy'
I0505 22:57:34.951519 25995 cluster.cpp:448] Creating default 'local' authorizer
I0505 22:57:34.952637 31678 slave.cpp:225] Mesos agent started on (755)@172.17.0.2:37738
I0505 22:57:34.952669 31678 slave.cpp:226] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/mesos/store/appc" --authenticate_http_executors="true" --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_JhyiwD/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_secret_key="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_JhyiwD/executor_secret_key" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_JhyiwD/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_command_executor="false" --http_credentials="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_JhyiwD/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --port="5051" --qos_correction_interval_min="0ns" --quiet="false" --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_JhyiwD" --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_wOeFnF"
I0505 22:57:34.952890 31678 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_JhyiwD/credential'
I0505 22:57:34.953032 31678 slave.cpp:258] Agent using credential for: test-principal
I0505 22:57:34.953042 31678 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_JhyiwD/http_credentials'
I0505 22:57:34.953203 31678 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-executor'
I0505 22:57:34.953243 31678 http.cpp:996] Creating default 'jwt' HTTP authenticator for realm 'mesos-agent-executor'
I0505 22:57:34.953289 31678 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0505 22:57:34.953310 31678 http.cpp:996] Creating default 'jwt' HTTP authenticator for realm 'mesos-agent-readonly'
I0505 22:57:34.953339 31678 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0505 22:57:34.953358 31678 http.cpp:996] Creating default 'jwt' HTTP authenticator for realm 'mesos-agent-readwrite'
I0505 22:57:34.953810 31678 slave.cpp:525] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0505 22:57:34.953845 31678 slave.cpp:533] Agent attributes: [ ]
I0505 22:57:34.953851 31678 slave.cpp:538] Agent hostname: dddbe4881e1f
I0505 22:57:34.954444 31676 status_update_manager.cpp:177] Pausing sending status updates
I0505 22:57:34.955176 31678 state.cpp:62] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_wOeFnF/meta'
I0505 22:57:34.955471 31678 status_update_manager.cpp:203] Recovering status update manager
I0505 22:57:34.955662 31678 containerizer.cpp:608] Recovering containerizer
I0505 22:57:34.956360 31678 provisioner.cpp:410] Provisioner recovery complete
I0505 22:57:34.956643 31678 slave.cpp:5963] Finished recovery
I0505 22:57:34.957350 31678 slave.cpp:6145] Querying resource estimator for oversubscribable resources
I0505 22:57:34.957593 31678 slave.cpp:6159] Received oversubscribable resources {} from the resource estimator
I0505 22:57:34.963209 31682 process.cpp:3730] Handling HTTP event for process 'slave(755)' with path: '/slave(755)/monitor/statistics.json'
I0505 22:57:34.963879 31682 http.cpp:1115] HTTP GET for /slave(755)/monitor/statistics.json from 172.17.0.2:41867
I0505 22:57:34.963945 31682 http.cpp:936] Authorizing principal 'test-principal' to GET the '/monitor/statistics.json' endpoint
I0505 22:57:34.967983 25995 slave.cpp:790] Agent terminating
[ OK ] Endpoint/SlaveEndpointTest.NoAuthorizer/1 (77 ms)
[ RUN ] Endpoint/SlaveEndpointTest.NoAuthorizer/2
I0505 22:57:34.999930 25995 containerizer.cpp:221] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni
W0505 22:57:35.000283 25995 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0505 22:57:35.000325 25995 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0505 22:57:35.000345 25995 provisioner.cpp:249] Using default backend 'copy'
I0505 22:57:35.001001 25995 cluster.cpp:448] Creating default 'local' authorizer
I0505 22:57:35.003053 31688 slave.cpp:225] Mesos agent started on (756)@172.17.0.2:37738
I0505 22:57:35.003101 31688 slave.cpp:226] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/mesos/store/appc" --authenticate_http_executors="true" --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_jKKuww/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_secret_key="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_jKKuww/executor_secret_key" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_jKKuww/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_command_executor="false" --http_credentials="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_jKKuww/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --port="5051" --qos_correction_interval_min="0ns" --quiet="false" --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_jKKuww" --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_8ncefy"
I0505 22:57:35.003407 31688 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_jKKuww/credential'
I0505 22:57:35.003584 31688 slave.cpp:258] Agent using credential for: test-principal
I0505 22:57:35.003602 31688 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_jKKuww/http_credentials'
I0505 22:57:35.003784 31688 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-executor'
I0505 22:57:35.003836 31688 http.cpp:996] Creating default 'jwt' HTTP authenticator for realm 'mesos-agent-executor'
I0505 22:57:35.003898 31688 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0505 22:57:35.003931 31688 http.cpp:996] Creating default 'jwt' HTTP authenticator for realm 'mesos-agent-readonly'
I0505 22:57:35.003973 31688 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0505 22:57:35.004003 31688 http.cpp:996] Creating default 'jwt' HTTP authenticator for realm 'mesos-agent-readwrite'
I0505 22:57:35.004518 31688 slave.cpp:525] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0505 22:57:35.004561 31688 slave.cpp:533] Agent attributes: [ ]
I0505 22:57:35.004572 31688 slave.cpp:538] Agent hostname: dddbe4881e1f
I0505 22:57:35.005602 31688 status_update_manager.cpp:177] Pausing sending status updates
I0505 22:57:35.005637 31688 state.cpp:62] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_8ncefy/meta'
I0505 22:57:35.005805 31688 status_update_manager.cpp:203] Recovering status update manager
I0505 22:57:35.005873 31688 containerizer.cpp:608] Recovering containerizer
I0505 22:57:35.006503 31688 provisioner.cpp:410] Provisioner recovery complete
I0505 22:57:35.006685 31688 slave.cpp:5963] Finished recovery
I0505 22:57:35.007148 31688 slave.cpp:6145] Querying resource estimator for oversubscribable resources
I0505 22:57:35.007261 31688 slave.cpp:6159] Received oversubscribable resources {} from the resource estimator
I0505 22:57:35.014544 31690 process.cpp:3730] Handling HTTP event for process 'slave(756)' with path: '/slave(756)/containers'
I0505 22:57:35.015152 31690 http.cpp:1115] HTTP GET for /slave(756)/containers from 172.17.0.2:41868
I0505 22:57:35.015204 31690 http.cpp:936] Authorizing principal 'test-principal' to GET the '/containers' endpoint
I0505 22:57:35.020918 25995 slave.cpp:790] Agent terminating
[ OK ] Endpoint/SlaveEndpointTest.NoAuthorizer/2 (48 ms)
[----------] 9 tests from Endpoint/SlaveEndpointTest (314 ms total)
[----------] Global test environment tear-down
[==========] 1531 tests from 169 test cases ran. (421073 ms total)
[ PASSED ] 1530 tests.
[ FAILED ] 1 test, listed below:
[ FAILED ] HierarchicalAllocatorTest.NestedRoleDRF
1 FAILED TEST
YOU HAVE 19 DISABLED TESTS
E0505 22:57:35.105761 31692 process.cpp:950] Failed to accept socket: future discarded
make[3]: *** [CMakeFiles/check] Error 1
make[3]: Leaving directory `/mesos/build'
make[2]: Leaving directory `/mesos/build'
make[2]: *** [CMakeFiles/check.dir/all] Error 2
make[1]: *** [CMakeFiles/check.dir/rule] Error 2
make[1]: Leaving directory `/mesos/build'
make: *** [check] Error 2
+ docker rmi mesos-1494022030-5336
Untagged: mesos-1494022030-5336:latest
Deleted: sha256:e3bab69b45584519a5406c220a8e0e7b572eab3a869b2f384ddc1d783d049599
Deleted: sha256:be13733464bb962f6a633f9a04c0c2731a635e21b8176b737670d44df0cf00d4
Deleted: sha256:f04c73807f6e5bd10fa98c211049968ebdeac80869852a0e2e0814fd0106dccf
Deleted: sha256:dcc079fc7abafa5af8e754deda1a3d2968357f19ca66f2b0c85e99e440e4ffcc
Deleted: sha256:da488666ef2573a5f9a11b528aa048acad7fb5c8bbebef45080af50758d8866f
Deleted: sha256:d4d29ddbd0bead49710d01c16ef473f0345d39c0d3f7506803bc5ad4a1c40f8a
Deleted: sha256:2f6c9987b55445b3d6f9ae4d11be0b68c9ca33386efeb57f72a3d7abab2e546e
Deleted: sha256:25d53c056def409861781c090bebfaada57ade44275d53dffd6ba4c832fc9bf9
Deleted: sha256:54fb78c266aa3a8d14f0deb6a3f7fa5b611de03924dfcb273174670a43f5b742
Deleted: sha256:2a3974eb4702e12eb2056d8a45344e61ce4742d3adaf0faecefb315f7bbf795e
Deleted: sha256:08bffdd89c410002aeb7e7b8e526017a797ce3248468ac064823def830365a23
Deleted: sha256:0b3397798eb62822684aa18f5ac5723ee0c00bb499858cadcd13057aaa509a7a
Deleted: sha256:21f19eafabb817528ffa7410915e8f3e882e7d88e49fdf81dc6d920587c99f4a
Deleted: sha256:a0c85e9fc7c7a021665fe782d45e9cde22a5826e0d689c0aa9c3209782ee794c
Deleted: sha256:114db0bf0932482fdd8bc675b3f8702381cd2c9b605e265168368fa263dd974b
Deleted: sha256:83c57a1b2577bb705e7c7d9ea20399a91ed10e66c77a48a281cbbbd298d9fec4
Deleted: sha256:9decff822f229aaf386e17b5702ae40532b303933e7741a82809139568505361
Deleted: sha256:05dbbb4f2bb526c7bb135f828a3cdcbf9d71654ab07b6581a39cd09693f6f548
Deleted: sha256:d17e6d46ed6eaca01d48eec8a9cfa26617779abba66dbbeb03975a14075b7030
Deleted: sha256:d798646ae5048292d0066e0b1c26c72d09ac8b5719330522b14b138bc2c6707b
Deleted: sha256:e54dc1de001e4ebe6a5a2967cc29b34699d31c886523b8735ed7de4bd65f1298
Deleted: sha256:033d0a4779224cafdf25d699bdcba4e5a1ad95f34a92068dc7a7c213235cd8d6
Deleted: sha256:7ea2ac1c3f871a81b1b8c2c5d060fd6a87c1f9dc2e7f7e81be2598f9cc5213f2
Deleted: sha256:370cda6ba57cc4b60cd251819530220994c8484d660f003f28e869d9a06f1257
Build step 'Execute shell' marked build as failure
Not sending mail to unregistered user neil.conway@gmail.com
Not sending mail to unregistered user yujie.jay@gmail.com