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/06/20 05:53:37 UTC
Build failed in Jenkins: Mesos-Buildbot » autotools,gcc,--verbose,GLOG_v=1 MESOS_VERBOSE=1,ubuntu:14.04,(ubuntu)&&(!ubuntu-us1)&&(!ubuntu-eu2) #3818
See <https://builds.apache.org/job/Mesos-Buildbot/BUILDTOOL=autotools,COMPILER=gcc,CONFIGURATION=--verbose,ENVIRONMENT=GLOG_v=1%20MESOS_VERBOSE=1,OS=ubuntu%3A14.04,label_exp=(ubuntu)&&(!ubuntu-us1)&&(!ubuntu-eu2)/3818/display/redirect?page=changes>
Changes:
[mpark] Added a couple of missing validation logic + minor improvements.
[mpark] Introduced `downgradeResources` to facilitate out-bound resources.
------------------------------------------
[...truncated 11.10 MB...]
I0620 05:53:21.641785 4540 slave.cpp:1019] Using default CRAM-MD5 authenticatee
I0620 05:53:21.642037 4546 authenticatee.cpp:121] Creating new client SASL connection
I0620 05:53:21.642462 4546 master.cpp:7478] Authenticating slave(179)@172.17.0.3:41476
I0620 05:53:21.642712 4545 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(396)@172.17.0.3:41476
I0620 05:53:21.643169 4543 authenticator.cpp:98] Creating new server SASL connection
I0620 05:53:21.643628 4541 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5
I0620 05:53:21.643731 4541 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5'
I0620 05:53:21.644824 4545 authenticator.cpp:204] Received SASL authentication start
I0620 05:53:21.644896 4545 authenticator.cpp:326] Authentication requires more steps
I0620 05:53:21.645134 4545 authenticatee.cpp:259] Received SASL authentication step
I0620 05:53:21.645234 4545 authenticator.cpp:232] Received SASL authentication step
I0620 05:53:21.645262 4545 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: 'bc8c247336ea' server FQDN: 'bc8c247336ea' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false
I0620 05:53:21.645272 4545 auxprop.cpp:181] Looking up auxiliary property '*userPassword'
I0620 05:53:21.645314 4545 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
I0620 05:53:21.645346 4545 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: 'bc8c247336ea' server FQDN: 'bc8c247336ea' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true
I0620 05:53:21.645366 4545 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true
I0620 05:53:21.645383 4545 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
I0620 05:53:21.645400 4545 authenticator.cpp:318] Authentication success
I0620 05:53:21.645546 4541 authenticatee.cpp:299] Authentication success
I0620 05:53:21.645651 4540 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(396)@172.17.0.3:41476
I0620 05:53:21.645572 4545 master.cpp:7508] Successfully authenticated principal 'test-principal' at slave(179)@172.17.0.3:41476
I0620 05:53:21.646425 4541 slave.cpp:1103] Successfully authenticated with master master@172.17.0.3:41476
I0620 05:53:21.646956 4541 slave.cpp:1523] Will retry registration in 4.861689ms if necessary
I0620 05:53:21.647368 4543 master.cpp:5480] Received register agent message from slave(179)@172.17.0.3:41476 (maintenance-host)
I0620 05:53:21.647687 4543 master.cpp:3702] Authorizing agent with principal 'test-principal'
I0620 05:53:21.648313 4543 master.cpp:5540] Authorized registration of agent at slave(179)@172.17.0.3:41476 (maintenance-host)
I0620 05:53:21.648633 4543 master.cpp:5619] Registering agent at slave(179)@172.17.0.3:41476 (maintenance-host) with id 6b37a39d-053e-4f21-95ca-bb409db09d12-S0
I0620 05:53:21.649376 4544 registrar.cpp:493] Applied 1 operations in 51402ns; attempting to update the registry
I0620 05:53:21.650203 4541 registrar.cpp:550] Successfully updated the registry in 700928ns
I0620 05:53:21.650398 4546 master.cpp:5666] Admitted agent 6b37a39d-053e-4f21-95ca-bb409db09d12-S0 at slave(179)@172.17.0.3:41476 (maintenance-host)
I0620 05:53:21.651001 4541 slave.cpp:4826] Received ping from slave-observer(177)@172.17.0.3:41476
I0620 05:53:21.651051 4546 master.cpp:5697] Registered agent 6b37a39d-053e-4f21-95ca-bb409db09d12-S0 at slave(179)@172.17.0.3:41476 (maintenance-host) with cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0620 05:53:21.652093 4541 slave.cpp:1149] Registered with master master@172.17.0.3:41476; given agent ID 6b37a39d-053e-4f21-95ca-bb409db09d12-S0
I0620 05:53:21.652312 4544 status_update_manager.cpp:184] Resuming sending status updates
I0620 05:53:21.652375 4546 hierarchical.cpp:587] Added agent 6b37a39d-053e-4f21-95ca-bb409db09d12-S0 (maintenance-host) with cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] (allocated: {})
I0620 05:53:21.652658 4546 hierarchical.cpp:1908] No allocations performed
I0620 05:53:21.652773 4546 hierarchical.cpp:1493] Performed allocation for 1 agents in 230456ns
I0620 05:53:21.652668 4541 slave.cpp:1169] Checkpointing SlaveInfo to '/tmp/MasterMaintenanceTest_InverseOffersFilters_Bn8Uts/meta/slaves/6b37a39d-053e-4f21-95ca-bb409db09d12-S0/slave.info'
I0620 05:53:21.653817 4541 slave.cpp:1207] Forwarding total oversubscribed resources {}
I0620 05:53:21.654008 4541 master.cpp:6351] Received update of agent 6b37a39d-053e-4f21-95ca-bb409db09d12-S0 at slave(179)@172.17.0.3:41476 (maintenance-host) with total oversubscribed resources {}
I0620 05:53:21.658191 4521 cluster.cpp:448] Creating default 'local' authorizer
I0620 05:53:21.660015 4540 slave.cpp:249] Mesos agent started on (180)@172.17.0.3:41476
I0620 05:53:21.660043 4540 slave.cpp:250] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/MasterMaintenanceTest_InverseOffersFilters_CWMGz7/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/MasterMaintenanceTest_InverseOffersFilters_CWMGz7/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/MasterMaintenanceTest_InverseOffersFilters_CWMGz7/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_reregistration_timeout="2secs" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/MasterMaintenanceTest_InverseOffersFilters_CWMGz7/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname="maintenance-host-2" --hostname_lookup="true" --http_command_executor="false" --http_credentials="/tmp/MasterMaintenanceTest_InverseOffersFilters_CWMGz7/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.4.0/_build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --port="5051" --qos_correction_interval_min="0ns" --quiet="false" --recover="reconnect" --recovery_timeout="15mins" --registration_backoff_factor="10ms" --resources="cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true" --runtime_dir="/tmp/MasterMaintenanceTest_InverseOffersFilters_CWMGz7" --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/MasterMaintenanceTest_InverseOffersFilters_nso4Ib"
I0620 05:53:21.660485 4540 credentials.hpp:86] Loading credential for authentication from '/tmp/MasterMaintenanceTest_InverseOffersFilters_CWMGz7/credential'
I0620 05:53:21.660637 4540 slave.cpp:282] Agent using credential for: test-principal
I0620 05:53:21.660667 4540 credentials.hpp:37] Loading credentials for authentication from '/tmp/MasterMaintenanceTest_InverseOffersFilters_CWMGz7/http_credentials'
I0620 05:53:21.660971 4540 http.cpp:1019] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0620 05:53:21.661195 4540 http.cpp:1019] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0620 05:53:21.662221 4540 slave.cpp:553] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0620 05:53:21.662300 4540 slave.cpp:561] Agent attributes: [ ]
I0620 05:53:21.662318 4540 slave.cpp:566] Agent hostname: maintenance-host-2
I0620 05:53:21.662942 4541 status_update_manager.cpp:177] Pausing sending status updates
I0620 05:53:21.664569 4543 state.cpp:62] Recovering state from '/tmp/MasterMaintenanceTest_InverseOffersFilters_nso4Ib/meta'
I0620 05:53:21.665158 4542 status_update_manager.cpp:203] Recovering status update manager
I0620 05:53:21.665539 4542 slave.cpp:6128] Finished recovery
I0620 05:53:21.665997 4542 slave.cpp:6310] Querying resource estimator for oversubscribable resources
I0620 05:53:21.666568 4543 status_update_manager.cpp:177] Pausing sending status updates
I0620 05:53:21.666577 4541 slave.cpp:946] New master detected at master@172.17.0.3:41476
I0620 05:53:21.667301 4541 slave.cpp:981] Detecting new master
I0620 05:53:21.667496 4541 slave.cpp:6324] Received oversubscribable resources {} from the resource estimator
I0620 05:53:21.673698 4544 slave.cpp:1008] Authenticating with master master@172.17.0.3:41476
I0620 05:53:21.673804 4544 slave.cpp:1019] Using default CRAM-MD5 authenticatee
I0620 05:53:21.674089 4544 authenticatee.cpp:121] Creating new client SASL connection
I0620 05:53:21.674441 4544 master.cpp:7478] Authenticating slave(180)@172.17.0.3:41476
I0620 05:53:21.674674 4544 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(397)@172.17.0.3:41476
I0620 05:53:21.675005 4544 authenticator.cpp:98] Creating new server SASL connection
I0620 05:53:21.675237 4544 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5
I0620 05:53:21.675261 4544 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5'
I0620 05:53:21.675817 4544 authenticator.cpp:204] Received SASL authentication start
I0620 05:53:21.675873 4544 authenticator.cpp:326] Authentication requires more steps
I0620 05:53:21.675956 4544 authenticatee.cpp:259] Received SASL authentication step
I0620 05:53:21.676046 4544 authenticator.cpp:232] Received SASL authentication step
I0620 05:53:21.676072 4544 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: 'bc8c247336ea' server FQDN: 'bc8c247336ea' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false
I0620 05:53:21.676087 4544 auxprop.cpp:181] Looking up auxiliary property '*userPassword'
I0620 05:53:21.676131 4544 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
I0620 05:53:21.676151 4544 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: 'bc8c247336ea' server FQDN: 'bc8c247336ea' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true
I0620 05:53:21.676165 4544 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true
I0620 05:53:21.676172 4544 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
I0620 05:53:21.676185 4544 authenticator.cpp:318] Authentication success
I0620 05:53:21.676345 4544 authenticatee.cpp:299] Authentication success
I0620 05:53:21.676419 4544 master.cpp:7508] Successfully authenticated principal 'test-principal' at slave(180)@172.17.0.3:41476
I0620 05:53:21.676501 4544 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(397)@172.17.0.3:41476
I0620 05:53:21.676807 4544 slave.cpp:1103] Successfully authenticated with master master@172.17.0.3:41476
I0620 05:53:21.677007 4544 slave.cpp:1523] Will retry registration in 18.414739ms if necessary
I0620 05:53:21.677319 4544 master.cpp:5480] Received register agent message from slave(180)@172.17.0.3:41476 (maintenance-host-2)
I0620 05:53:21.677439 4544 master.cpp:3702] Authorizing agent with principal 'test-principal'
I0620 05:53:21.677973 4544 master.cpp:5540] Authorized registration of agent at slave(180)@172.17.0.3:41476 (maintenance-host-2)
I0620 05:53:21.678079 4544 master.cpp:5619] Registering agent at slave(180)@172.17.0.3:41476 (maintenance-host-2) with id 6b37a39d-053e-4f21-95ca-bb409db09d12-S1
I0620 05:53:21.678650 4544 registrar.cpp:493] Applied 1 operations in 133127ns; attempting to update the registry
I0620 05:53:21.679412 4540 registrar.cpp:550] Successfully updated the registry in 667904ns
I0620 05:53:21.679869 4540 master.cpp:5666] Admitted agent 6b37a39d-053e-4f21-95ca-bb409db09d12-S1 at slave(180)@172.17.0.3:41476 (maintenance-host-2)
I0620 05:53:21.680686 4542 slave.cpp:4826] Received ping from slave-observer(178)@172.17.0.3:41476
I0620 05:53:21.680824 4540 master.cpp:5697] Registered agent 6b37a39d-053e-4f21-95ca-bb409db09d12-S1 at slave(180)@172.17.0.3:41476 (maintenance-host-2) with cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0620 05:53:21.681151 4542 slave.cpp:1149] Registered with master master@172.17.0.3:41476; given agent ID 6b37a39d-053e-4f21-95ca-bb409db09d12-S1
I0620 05:53:21.681228 4545 hierarchical.cpp:587] Added agent 6b37a39d-053e-4f21-95ca-bb409db09d12-S1 (maintenance-host-2) with cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] (allocated: {})
I0620 05:53:21.681558 4545 hierarchical.cpp:1908] No allocations performed
I0620 05:53:21.681634 4545 hierarchical.cpp:1493] Performed allocation for 1 agents in 185097ns
I0620 05:53:21.681691 4545 status_update_manager.cpp:184] Resuming sending status updates
I0620 05:53:21.682179 4542 slave.cpp:1169] Checkpointing SlaveInfo to '/tmp/MasterMaintenanceTest_InverseOffersFilters_nso4Ib/meta/slaves/6b37a39d-053e-4f21-95ca-bb409db09d12-S1/slave.info'
I0620 05:53:21.682736 4542 slave.cpp:1207] Forwarding total oversubscribed resources {}
I0620 05:53:21.683019 4546 master.cpp:6351] Received update of agent 6b37a39d-053e-4f21-95ca-bb409db09d12-S1 at slave(180)@172.17.0.3:41476 (maintenance-host-2) with total oversubscribed resources {}
I0620 05:53:21.687839 4540 process.cpp:3779] Handling HTTP event for process 'master' with path: '/master/maintenance/schedule'
I0620 05:53:21.689841 4546 http.cpp:1159] HTTP POST for /master/maintenance/schedule from 172.17.0.3:60374
I0620 05:53:21.691542 4542 registrar.cpp:493] Applied 1 operations in 170212ns; attempting to update the registry
I0620 05:53:21.692340 4542 registrar.cpp:550] Successfully updated the registry in 688128ns
I0620 05:53:21.692674 4546 master.cpp:6413] Updating unavailability of agent 6b37a39d-053e-4f21-95ca-bb409db09d12-S0 at slave(179)@172.17.0.3:41476 (maintenance-host), starting at 2481.75023962073weeks
I0620 05:53:21.692858 4546 master.cpp:6413] Updating unavailability of agent 6b37a39d-053e-4f21-95ca-bb409db09d12-S1 at slave(180)@172.17.0.3:41476 (maintenance-host-2), starting at 2481.75023962073weeks
I0620 05:53:21.693234 4542 hierarchical.cpp:1908] No allocations performed
I0620 05:53:21.693294 4542 hierarchical.cpp:1493] Performed allocation for 2 agents in 203346ns
I0620 05:53:21.696094 4521 scheduler.cpp:184] Version: 1.4.0
I0620 05:53:21.696920 4540 scheduler.cpp:470] New master detected at master@172.17.0.3:41476
I0620 05:53:21.697120 4540 scheduler.cpp:479] Waiting for 0ns before initiating a re-(connection) attempt with the master
I0620 05:53:21.701596 4540 scheduler.cpp:361] Connected with the master at http://172.17.0.3:41476/master/api/v1/scheduler
I0620 05:53:21.703471 4546 scheduler.cpp:243] Sending SUBSCRIBE call to http://172.17.0.3:41476/master/api/v1/scheduler
I0620 05:53:21.705657 4546 process.cpp:3779] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I0620 05:53:21.708943 4547 http.cpp:1159] HTTP POST for /master/api/v1/scheduler from 172.17.0.3:60380
I0620 05:53:21.709461 4547 master.cpp:2514] Received subscription request for HTTP framework 'default'
I0620 05:53:21.709842 4547 master.cpp:2197] Authorizing framework principal 'test-principal' to receive offers for roles '{ * }'
I0620 05:53:21.710800 4545 master.cpp:2650] Subscribing framework 'default' with checkpointing disabled and capabilities [ ]
I0620 05:53:21.711679 4547 hierarchical.cpp:301] Added framework 6b37a39d-053e-4f21-95ca-bb409db09d12-0000
I0620 05:53:21.712189 4540 master.hpp:2216] Sending heartbeat to 6b37a39d-053e-4f21-95ca-bb409db09d12-0000
I0620 05:53:21.714931 4547 hierarchical.cpp:1493] Performed allocation for 2 agents in 2.095477ms
I0620 05:53:21.716199 4547 scheduler.cpp:676] Enqueuing event SUBSCRIBED received from http://172.17.0.3:41476/master/api/v1/scheduler
I0620 05:53:21.716469 4544 master.cpp:7308] Sending 2 offers to framework 6b37a39d-053e-4f21-95ca-bb409db09d12-0000 (default)
I0620 05:53:21.717156 4547 scheduler.cpp:676] Enqueuing event HEARTBEAT received from http://172.17.0.3:41476/master/api/v1/scheduler
I0620 05:53:21.719810 4540 hierarchical.cpp:1908] No allocations performed
I0620 05:53:21.720341 4540 hierarchical.cpp:1493] Performed allocation for 2 agents in 696726ns
I0620 05:53:21.720731 4545 scheduler.cpp:676] Enqueuing event OFFERS received from http://172.17.0.3:41476/master/api/v1/scheduler
I0620 05:53:21.721786 4544 master.cpp:7397] Sending 2 inverse offers to framework 6b37a39d-053e-4f21-95ca-bb409db09d12-0000 (default)
I0620 05:53:21.724972 4540 scheduler.cpp:243] Sending ACCEPT call to http://172.17.0.3:41476/master/api/v1/scheduler
I0620 05:53:21.725857 4540 scheduler.cpp:243] Sending ACCEPT call to http://172.17.0.3:41476/master/api/v1/scheduler
I0620 05:53:21.726717 4540 scheduler.cpp:676] Enqueuing event INVERSE_OFFERS received from http://172.17.0.3:41476/master/api/v1/scheduler
I0620 05:53:21.727041 4541 process.cpp:3779] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I0620 05:53:21.729202 4546 process.cpp:3779] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I0620 05:53:21.729882 4546 http.cpp:1159] HTTP POST for /master/api/v1/scheduler from 172.17.0.3:60378
I0620 05:53:21.731470 4546 master.cpp:3917] Processing ACCEPT call for offers: [ 6b37a39d-053e-4f21-95ca-bb409db09d12-O0 ] on agent 6b37a39d-053e-4f21-95ca-bb409db09d12-S0 at slave(179)@172.17.0.3:41476 (maintenance-host) for framework 6b37a39d-053e-4f21-95ca-bb409db09d12-0000 (default)
I0620 05:53:21.731577 4546 master.cpp:3469] Authorizing framework principal 'test-principal' to launch task 69e9a876-b82b-4952-8223-7919e5461ee8
W0620 05:53:21.738960 4546 validation.cpp:1332] Executor 'executor-1' for task '69e9a876-b82b-4952-8223-7919e5461ee8' uses less CPUs (None) than the minimum required (0.01). Please update your executor, as this will be mandatory in future releases.
W0620 05:53:21.738999 4546 validation.cpp:1344] Executor 'executor-1' for task '69e9a876-b82b-4952-8223-7919e5461ee8' uses less memory (None) than the minimum required (32MB). Please update your executor, as this will be mandatory in future releases.
I0620 05:53:21.739778 4546 master.cpp:9327] Adding task 69e9a876-b82b-4952-8223-7919e5461ee8 with resources cpus(*)(allocated: *):2; mem(*)(allocated: *):1024; disk(*)(allocated: *):1024; ports(*)(allocated: *):[31000-32000] on agent 6b37a39d-053e-4f21-95ca-bb409db09d12-S0 at slave(179)@172.17.0.3:41476 (maintenance-host)
I0620 05:53:21.740259 4546 master.cpp:4582] Launching task 69e9a876-b82b-4952-8223-7919e5461ee8 of framework 6b37a39d-053e-4f21-95ca-bb409db09d12-0000 (default) with resources cpus(*)(allocated: *):2; mem(*)(allocated: *):1024; disk(*)(allocated: *):1024; ports(*)(allocated: *):[31000-32000] on agent 6b37a39d-053e-4f21-95ca-bb409db09d12-S0 at slave(179)@172.17.0.3:41476 (maintenance-host)
I0620 05:53:21.741178 4547 slave.cpp:1633] Got assigned task '69e9a876-b82b-4952-8223-7919e5461ee8' for framework 6b37a39d-053e-4f21-95ca-bb409db09d12-0000
I0620 05:53:21.742028 4544 http.cpp:1159] HTTP POST for /master/api/v1/scheduler from 172.17.0.3:60378
I0620 05:53:21.742979 4547 slave.cpp:1914] Authorizing task '69e9a876-b82b-4952-8223-7919e5461ee8' for framework 6b37a39d-053e-4f21-95ca-bb409db09d12-0000
I0620 05:53:21.743263 4544 master.cpp:3917] Processing ACCEPT call for offers: [ 6b37a39d-053e-4f21-95ca-bb409db09d12-O1 ] on agent 6b37a39d-053e-4f21-95ca-bb409db09d12-S1 at slave(180)@172.17.0.3:41476 (maintenance-host-2) for framework 6b37a39d-053e-4f21-95ca-bb409db09d12-0000 (default)
I0620 05:53:21.743422 4547 slave.cpp:6627] Authorizing framework principal 'test-principal' to launch task 69e9a876-b82b-4952-8223-7919e5461ee8
I0620 05:53:21.743562 4544 master.cpp:3469] Authorizing framework principal 'test-principal' to launch task 58075bd4-1086-4c7a-af42-3bb8b16014b3
I0620 05:53:21.744221 4546 hierarchical.cpp:912] Updated allocation of framework 6b37a39d-053e-4f21-95ca-bb409db09d12-0000 on agent 6b37a39d-053e-4f21-95ca-bb409db09d12-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]
I0620 05:53:21.745605 4547 slave.cpp:2101] Launching task '69e9a876-b82b-4952-8223-7919e5461ee8' for framework 6b37a39d-053e-4f21-95ca-bb409db09d12-0000
W0620 05:53:21.746461 4544 validation.cpp:1332] Executor 'executor-2' for task '58075bd4-1086-4c7a-af42-3bb8b16014b3' uses less CPUs (None) than the minimum required (0.01). Please update your executor, as this will be mandatory in future releases.
W0620 05:53:21.746640 4544 validation.cpp:1344] Executor 'executor-2' for task '58075bd4-1086-4c7a-af42-3bb8b16014b3' uses less memory (None) than the minimum required (32MB). Please update your executor, as this will be mandatory in future releases.
I0620 05:53:21.747803 4544 master.cpp:9327] Adding task 58075bd4-1086-4c7a-af42-3bb8b16014b3 with resources cpus(*)(allocated: *):2; mem(*)(allocated: *):1024; disk(*)(allocated: *):1024; ports(*)(allocated: *):[31000-32000] on agent 6b37a39d-053e-4f21-95ca-bb409db09d12-S1 at slave(180)@172.17.0.3:41476 (maintenance-host-2)
I0620 05:53:21.748250 4547 paths.cpp:573] Trying to chown '/tmp/MasterMaintenanceTest_InverseOffersFilters_Bn8Uts/slaves/6b37a39d-053e-4f21-95ca-bb409db09d12-S0/frameworks/6b37a39d-053e-4f21-95ca-bb409db09d12-0000/executors/executor-1/runs/f8b6ab41-bc9c-471c-ab9f-5142a505d190' to user 'mesos'
I0620 05:53:21.748478 4544 master.cpp:4582] Launching task 58075bd4-1086-4c7a-af42-3bb8b16014b3 of framework 6b37a39d-053e-4f21-95ca-bb409db09d12-0000 (default) with resources cpus(*)(allocated: *):2; mem(*)(allocated: *):1024; disk(*)(allocated: *):1024; ports(*)(allocated: *):[31000-32000] on agent 6b37a39d-053e-4f21-95ca-bb409db09d12-S1 at slave(180)@172.17.0.3:41476 (maintenance-host-2)
I0620 05:53:21.749071 4547 slave.cpp:7087] Launching executor 'executor-1' of framework 6b37a39d-053e-4f21-95ca-bb409db09d12-0000 with resources {} in work directory '/tmp/MasterMaintenanceTest_InverseOffersFilters_Bn8Uts/slaves/6b37a39d-053e-4f21-95ca-bb409db09d12-S0/frameworks/6b37a39d-053e-4f21-95ca-bb409db09d12-0000/executors/executor-1/runs/f8b6ab41-bc9c-471c-ab9f-5142a505d190'
I0620 05:53:21.749426 4543 slave.cpp:1633] Got assigned task '58075bd4-1086-4c7a-af42-3bb8b16014b3' for framework 6b37a39d-053e-4f21-95ca-bb409db09d12-0000
I0620 05:53:21.750051 4547 slave.cpp:2796] Launching container f8b6ab41-bc9c-471c-ab9f-5142a505d190 for executor 'executor-1' of framework 6b37a39d-053e-4f21-95ca-bb409db09d12-0000
I0620 05:53:21.750113 4543 slave.cpp:1914] Authorizing task '58075bd4-1086-4c7a-af42-3bb8b16014b3' for framework 6b37a39d-053e-4f21-95ca-bb409db09d12-0000
I0620 05:53:21.750268 4543 slave.cpp:6627] Authorizing framework principal 'test-principal' to launch task 58075bd4-1086-4c7a-af42-3bb8b16014b3
I0620 05:53:21.751257 4547 slave.cpp:2330] Queued task '69e9a876-b82b-4952-8223-7919e5461ee8' for executor 'executor-1' of framework 6b37a39d-053e-4f21-95ca-bb409db09d12-0000
I0620 05:53:21.752207 4541 slave.cpp:2101] Launching task '58075bd4-1086-4c7a-af42-3bb8b16014b3' for framework 6b37a39d-053e-4f21-95ca-bb409db09d12-0000
I0620 05:53:21.752456 4547 slave.cpp:899] Successfully attached file '/tmp/MasterMaintenanceTest_InverseOffersFilters_Bn8Uts/slaves/6b37a39d-053e-4f21-95ca-bb409db09d12-S0/frameworks/6b37a39d-053e-4f21-95ca-bb409db09d12-0000/executors/executor-1/runs/f8b6ab41-bc9c-471c-ab9f-5142a505d190'
I0620 05:53:21.752626 4547 slave.cpp:899] Successfully attached file '/tmp/MasterMaintenanceTest_InverseOffersFilters_Bn8Uts/slaves/6b37a39d-053e-4f21-95ca-bb409db09d12-S0/frameworks/6b37a39d-053e-4f21-95ca-bb409db09d12-0000/executors/executor-1/runs/f8b6ab41-bc9c-471c-ab9f-5142a505d190'
I0620 05:53:21.753196 4541 paths.cpp:573] Trying to chown '/tmp/MasterMaintenanceTest_InverseOffersFilters_nso4Ib/slaves/6b37a39d-053e-4f21-95ca-bb409db09d12-S1/frameworks/6b37a39d-053e-4f21-95ca-bb409db09d12-0000/executors/executor-2/runs/cd8b31fb-0f0b-4678-ae02-78719222eab6' to user 'mesos'
I0620 05:53:21.753684 4541 slave.cpp:7087] Launching executor 'executor-2' of framework 6b37a39d-053e-4f21-95ca-bb409db09d12-0000 with resources {} in work directory '/tmp/MasterMaintenanceTest_InverseOffersFilters_nso4Ib/slaves/6b37a39d-053e-4f21-95ca-bb409db09d12-S1/frameworks/6b37a39d-053e-4f21-95ca-bb409db09d12-0000/executors/executor-2/runs/cd8b31fb-0f0b-4678-ae02-78719222eab6'
*** Aborted at 1497938001 (unix time) try "date -d @1497938001" if you are using GNU date ***
I0620 05:53:21.754706 4543 exec.cpp:162] Version: 1.4.0
PC: @ 0x2ab09a61282d (unknown)
I0620 05:53:21.755223 4545 exec.cpp:212] Executor started at: executor(65)@172.17.0.3:41476 with pid 4521
I0620 05:53:21.755964 4542 slave.cpp:3826] Got registration for executor 'executor-1' of framework 6b37a39d-053e-4f21-95ca-bb409db09d12-0000 from executor(65)@172.17.0.3:41476
I0620 05:53:21.756602 4545 exec.cpp:237] Executor registered on agent 6b37a39d-053e-4f21-95ca-bb409db09d12-S0
I0620 05:53:21.756706 4545 exec.cpp:249] Executor::registered took 53487ns
I0620 05:53:21.757493 4542 slave.cpp:2543] Sending queued task '69e9a876-b82b-4952-8223-7919e5461ee8' to executor 'executor-1' of framework 6b37a39d-053e-4f21-95ca-bb409db09d12-0000 at executor(65)@172.17.0.3:41476
I0620 05:53:21.758119 4545 exec.cpp:331] Executor asked to run task '69e9a876-b82b-4952-8223-7919e5461ee8'
I0620 05:53:21.758381 4545 exec.cpp:340] Executor::launchTask took 70525ns
I0620 05:53:21.758644 4545 exec.cpp:571] Executor sending status update TASK_RUNNING (UUID: fbc2cfa9-a308-4465-8592-db3cbf3c883c) for task 69e9a876-b82b-4952-8223-7919e5461ee8 of framework 6b37a39d-053e-4f21-95ca-bb409db09d12-0000
I0620 05:53:21.759115 4542 slave.cpp:4296] Handling status update TASK_RUNNING (UUID: fbc2cfa9-a308-4465-8592-db3cbf3c883c) for task 69e9a876-b82b-4952-8223-7919e5461ee8 of framework 6b37a39d-053e-4f21-95ca-bb409db09d12-0000 from executor(65)@172.17.0.3:41476
I0620 05:53:21.759636 4544 hierarchical.cpp:912] Updated allocation of framework 6b37a39d-053e-4f21-95ca-bb409db09d12-0000 on agent 6b37a39d-053e-4f21-95ca-bb409db09d12-S1 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]
I0620 05:53:21.760741 4540 status_update_manager.cpp:323] Received status update TASK_RUNNING (UUID: fbc2cfa9-a308-4465-8592-db3cbf3c883c) for task 69e9a876-b82b-4952-8223-7919e5461ee8 of framework 6b37a39d-053e-4f21-95ca-bb409db09d12-0000
I0620 05:53:21.760851 4540 status_update_manager.cpp:500] Creating StatusUpdate stream for task 69e9a876-b82b-4952-8223-7919e5461ee8 of framework 6b37a39d-053e-4f21-95ca-bb409db09d12-0000
I0620 05:53:21.761570 4540 status_update_manager.cpp:377] Forwarding update TASK_RUNNING (UUID: fbc2cfa9-a308-4465-8592-db3cbf3c883c) for task 69e9a876-b82b-4952-8223-7919e5461ee8 of framework 6b37a39d-053e-4f21-95ca-bb409db09d12-0000 to the agent
I0620 05:53:21.762187 4546 slave.cpp:4736] Forwarding the update TASK_RUNNING (UUID: fbc2cfa9-a308-4465-8592-db3cbf3c883c) for task 69e9a876-b82b-4952-8223-7919e5461ee8 of framework 6b37a39d-053e-4f21-95ca-bb409db09d12-0000 to master@172.17.0.3:41476
I0620 05:53:21.762482 4546 slave.cpp:4630] Status update manager successfully handled status update TASK_RUNNING (UUID: fbc2cfa9-a308-4465-8592-db3cbf3c883c) for task 69e9a876-b82b-4952-8223-7919e5461ee8 of framework 6b37a39d-053e-4f21-95ca-bb409db09d12-0000
I0620 05:53:21.762555 4546 slave.cpp:4646] Sending acknowledgement for status update TASK_RUNNING (UUID: fbc2cfa9-a308-4465-8592-db3cbf3c883c) for task 69e9a876-b82b-4952-8223-7919e5461ee8 of framework 6b37a39d-053e-4f21-95ca-bb409db09d12-0000 to executor(65)@172.17.0.3:41476
I0620 05:53:21.762778 4546 exec.cpp:388] Executor received status update acknowledgement fbc2cfa9-a308-4465-8592-db3cbf3c883c for task 69e9a876-b82b-4952-8223-7919e5461ee8 of framework 6b37a39d-053e-4f21-95ca-bb409db09d12-0000
*** SIGSEGV (@0x1021) received by PID 4521 (TID 0x2ab0a2a72700) from PID 4129; stack trace: ***
@ 0x2ab0ca197417 (unknown)
@ 0x2ab0ca19b6f9 (unknown)
@ 0x2ab09a3c9330 (unknown)
@ 0x2ab09a61282d (unknown)
I0620 05:53:21.766577 4540 master.cpp:6496] Status update TASK_RUNNING (UUID: fbc2cfa9-a308-4465-8592-db3cbf3c883c) for task 69e9a876-b82b-4952-8223-7919e5461ee8 of framework 6b37a39d-053e-4f21-95ca-bb409db09d12-0000 from agent 6b37a39d-053e-4f21-95ca-bb409db09d12-S0 at slave(179)@172.17.0.3:41476 (maintenance-host)
I0620 05:53:21.766898 4540 master.cpp:6558] Forwarding status update TASK_RUNNING (UUID: fbc2cfa9-a308-4465-8592-db3cbf3c883c) for task 69e9a876-b82b-4952-8223-7919e5461ee8 of framework 6b37a39d-053e-4f21-95ca-bb409db09d12-0000
I0620 05:53:21.768476 4540 master.cpp:8569] Updating the state of task 69e9a876-b82b-4952-8223-7919e5461ee8 of framework 6b37a39d-053e-4f21-95ca-bb409db09d12-0000 (latest state: TASK_RUNNING, status update state: TASK_RUNNING)
I0620 05:53:21.770678 4547 scheduler.cpp:676] Enqueuing event UPDATE received from http://172.17.0.3:41476/master/api/v1/scheduler
@ 0x55590a0645bd os::getenv()
@ 0x2ab0970b98d3 mesos::internal::slave::executorEnvironment()
@ 0x2ab0970900e9 mesos::internal::slave::Slave::launchExecutor()
@ 0x2ab09708b806 mesos::internal::slave::Slave::__run()
@ 0x2ab0970f13fd _ZZN7process8dispatchIN5mesos8internal5slave5SlaveERKNS_6FutureISt4listIbSaIbEEEERKNS1_13FrameworkInfoERKNS1_12ExecutorInfoERK6OptionINS1_8TaskInfoEERKSI_INS1_13TaskGroupInfoEES9_SC_SF_SK_SO_EEvRKNS_3PIDIT_EEMSS_FvT0_T1_T2_T3_T4_ET5_T6_T7_T8_T9_ENKUlPNS_11ProcessBaseEE_clES19_
@ 0x2ab09712b3f0 _ZNSt17_Function_handlerIFvPN7process11ProcessBaseEEZNS0_8dispatchIN5mesos8internal5slave5SlaveERKNS0_6FutureISt4listIbSaIbEEEERKNS5_13FrameworkInfoERKNS5_12ExecutorInfoERK6OptionINS5_8TaskInfoEERKSM_INS5_13TaskGroupInfoEESD_SG_SJ_SO_SS_EEvRKNS0_3PIDIT_EEMSW_FvT0_T1_T2_T3_T4_ET5_T6_T7_T8_T9_EUlS2_E_E9_M_invokeERKSt9_Any_dataS2_
@ 0x2ab097f2de8d std::function<>::operator()()
@ 0x2ab097f132e9 process::ProcessBase::visit()
@ 0x2ab097f1dcca process::DispatchEvent::visit()
@ 0x55590a038212 process::ProcessBase::serve()
@ 0x2ab097f0f5aa process::ProcessManager::resume()
@ 0x2ab097f0b77e _ZZN7process14ProcessManager12init_threadsEvENKUt_clEv
@ 0x2ab097f1d3d6 _ZNSt12_Bind_simpleIFZN7process14ProcessManager12init_threadsEvEUt_vEE9_M_invokeIIEEEvSt12_Index_tupleIIXspT_EEE
@ 0x2ab097f1d32d _ZNSt12_Bind_simpleIFZN7process14ProcessManager12init_threadsEvEUt_vEEclEv
@ 0x2ab097f1d2c6 _ZNSt6thread5_ImplISt12_Bind_simpleIFZN7process14ProcessManager12init_threadsEvEUt_vEEE6_M_runEv
@ 0x2ab099c4aa60 (unknown)
@ 0x2ab09a3c1184 start_thread
@ 0x2ab09a6d4ffd (unknown)
make[4]: *** [check-local] Segmentation fault (core dumped)
make[4]: Leaving directory `/mesos/mesos-1.4.0/_build/src'
make[3]: *** [check-am] Error 2
make[3]: Leaving directory `/mesos/mesos-1.4.0/_build/src'
make[2]: *** [check] Error 2
make[2]: Leaving directory `/mesos/mesos-1.4.0/_build/src'
make[1]: *** [check-recursive] Error 1
make[1]: Leaving directory `/mesos/mesos-1.4.0/_build'
make: *** [distcheck] Error 1
+ docker rmi mesos-1497934129-11232
Untagged: mesos-1497934129-11232:latest
Deleted: sha256:9f3adb5e44412d7447c761af36f437fc790a2855d886ebb86bc7039f32591800
Deleted: sha256:ccc393f3e2d45bd6397f22d145a36a21a36cdff74033f60cced4adc5f0d1450d
Deleted: sha256:dfbac6049d212c9f0f305ec50221702a3d2f4078bcdc8ef3157a6cf78ef99553
Deleted: sha256:09600e986460f52ec9fcf8f3b2eb0497f1f0e06aaeddc65b768f09335dc9dca6
Deleted: sha256:5593f27abd6d9add9a2a3fdd0e8553601561f7593c3c0c5fe0b3d65ba4ddf732
Deleted: sha256:71f2940915be958a2ff8c6920434e91bb1cc31c50c31bfd05b86ddbd4beab615
Deleted: sha256:ef91466929420b5bfe0a7de03475efa32bb6c987833295f73f2f23d750da6e91
Deleted: sha256:6a120f817f6307faa4de634ef8253babd42088d72c0367fce648d98635126c60
Deleted: sha256:88fe59e013c0fc8c176ee3513b7276aeff62d71fe39cf86e34116561f2b8bc94
Deleted: sha256:82b8dcd6827b8189e31f008a65e4c1ffb8dca6e8b1ffbc629fe5fd3a36d7db07
Deleted: sha256:23730731a3e3e28bc817f0a5dce8fb0b1bf748b42eb7a569b1844c0884c1cbf8
Deleted: sha256:ddfafd63ad78aeb0479c89237183b16fb88de44d8f16def26a679eedf87f66f3
Deleted: sha256:8dc09a7859a21846cab65ccdbfcbf611058676e75effda1eef59d64d26169053
Deleted: sha256:3aaa87f6615bbbc69c373005e1848f98210abc36cb4718cdf0f72ae40c54d00e
Deleted: sha256:c75e35c8ff181dc6ef39b610ca765553f5ebf45ed40c5c865e4c0ef90e6667ec
Deleted: sha256:bf2be2d789e24fbb82e848ac031bc96737fbe5eb3baa8c6982c6500e91a5cbc7
Deleted: sha256:547d117125994826771710d90e88bc7770067ea98585fd4a99e7e53b228b44cb
Deleted: sha256:a48125e7425148ca4859928ec82a6812fa0bb4b5223317b4b7fe6e68132167a6
Deleted: sha256:1108a5b7b86e4876d477084cb1a67f43b81cee691b9b21530b7baa790ec899a3
Deleted: sha256:219c3b0ee1257475c0e057b0a62938de1dc9bf7f17f2d15f4636dc4f6da6b9e1
Deleted: sha256:79380511d01fa213419fd0aa93c1eb64593f995afd9f9ddfc0cb2322ee96e317
Deleted: sha256:46b52e697cccaa399be74d760d1dc91d8f284ce0280551fec1230844c4c0cafd
Deleted: sha256:33e592bd671e001832a00bf30e8a5a46572b396dc6c6960d3ff18ad91c90d17e
Deleted: sha256:2b9d738b14f1910b72e120e9a153224a612fe17d1a5f3589fe228a801e8bb4e6
Build step 'Execute shell' marked build as failure
Not sending mail to unregistered user yujie.jay@gmail.com
Build failed in Jenkins: Mesos-Buildbot » autotools,gcc,--verbose,GLOG_v=1 MESOS_VERBOSE=1,ubuntu:14.04,(ubuntu)&&(!ubuntu-us1)&&(!ubuntu-eu2) #3819
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/Mesos-Buildbot/BUILDTOOL=autotools,COMPILER=gcc,CONFIGURATION=--verbose,ENVIRONMENT=GLOG_v=1%20MESOS_VERBOSE=1,OS=ubuntu%3A14.04,label_exp=(ubuntu)&&(!ubuntu-us1)&&(!ubuntu-eu2)/3819/display/redirect?page=changes>
Changes:
[neil.conway] Tweaked a parameter to pass by const ref instead of value.
------------------------------------------
[...truncated 28.56 MB...]
W0620 07:11:29.940098 4516 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0620 07:11:29.940279 4516 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0620 07:11:29.940362 4516 provisioner.cpp:255] Using default backend 'copy'
I0620 07:11:29.945001 4540 slave.cpp:249] Mesos agent started on (764)@172.17.0.3:35259
I0620 07:11:29.945089 4540 slave.cpp:250] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_Qc4deP/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_Qc4deP/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/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_Qc4deP/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_reregistration_timeout="2secs" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_Qc4deP/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_command_executor="false" --http_credentials="/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_Qc4deP/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.4.0/_build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --port="5051" --qos_correction_interval_min="0ns" --quiet="false" --recover="reconnect" --recovery_timeout="15mins" --registration_backoff_factor="10ms" --resources="cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true" --runtime_dir="/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_Qc4deP" --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_s1wTcO"
I0620 07:11:29.945912 4540 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_Qc4deP/credential'
I0620 07:11:29.946241 4540 slave.cpp:282] Agent using credential for: test-principal
I0620 07:11:29.946310 4540 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_Qc4deP/http_credentials'
I0620 07:11:29.946645 4540 http.cpp:1019] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0620 07:11:29.946905 4540 http.cpp:1019] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0620 07:11:29.949236 4540 slave.cpp:553] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0620 07:11:29.949321 4540 slave.cpp:561] Agent attributes: [ ]
I0620 07:11:29.949347 4540 slave.cpp:566] Agent hostname: ca810ce5b491
I0620 07:11:29.949708 4536 status_update_manager.cpp:177] Pausing sending status updates
I0620 07:11:29.952049 4540 state.cpp:62] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_s1wTcO/meta'
I0620 07:11:29.952599 4540 status_update_manager.cpp:203] Recovering status update manager
I0620 07:11:29.953318 4540 containerizer.cpp:582] Recovering containerizer
I0620 07:11:29.955185 4537 provisioner.cpp:416] Provisioner recovery complete
I0620 07:11:29.956070 4537 slave.cpp:6128] Finished recovery
I0620 07:11:29.956812 4537 slave.cpp:6310] Querying resource estimator for oversubscribable resources
I0620 07:11:29.957379 4539 slave.cpp:6324] Received oversubscribable resources {} from the resource estimator
I0620 07:11:29.962713 4535 process.cpp:3779] Handling HTTP event for process 'slave(764)' with path: '/slave(764)/containers'
I0620 07:11:29.965659 4535 http.cpp:1159] HTTP GET for /slave(764)/containers from 172.17.0.3:57152
I0620 07:11:29.965836 4535 http.cpp:980] Authorizing principal 'test-principal' to GET the '/containers' endpoint
I0620 07:11:29.973256 4540 slave.cpp:818] Agent terminating
[ OK ] Endpoint/SlaveEndpointTest.AuthorizedRequest/2 (62 ms)
[ RUN ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/0
I0620 07:11:30.003046 4516 containerizer.cpp:230] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni,environment_secret
W0620 07:11:30.004043 4516 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0620 07:11:30.004259 4516 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0620 07:11:30.004345 4516 provisioner.cpp:255] Using default backend 'copy'
I0620 07:11:30.008934 4536 slave.cpp:249] Mesos agent started on (765)@172.17.0.3:35259
I0620 07:11:30.008996 4536 slave.cpp:250] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_Hzm4TT/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_Hzm4TT/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/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_Hzm4TT/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_reregistration_timeout="2secs" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_Hzm4TT/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_Hzm4TT/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.4.0/_build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --port="5051" --qos_correction_interval_min="0ns" --quiet="false" --recover="reconnect" --recovery_timeout="15mins" --registration_backoff_factor="10ms" --resources="cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true" --runtime_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_Hzm4TT" --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_JQuyHS"
I0620 07:11:30.010366 4536 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_Hzm4TT/credential'
I0620 07:11:30.011725 4536 slave.cpp:282] Agent using credential for: test-principal
I0620 07:11:30.011767 4536 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_Hzm4TT/http_credentials'
I0620 07:11:30.012465 4536 http.cpp:1019] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0620 07:11:30.013922 4536 http.cpp:1019] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0620 07:11:30.017510 4536 slave.cpp:553] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0620 07:11:30.017616 4536 slave.cpp:561] Agent attributes: [ ]
I0620 07:11:30.017640 4536 slave.cpp:566] Agent hostname: ca810ce5b491
I0620 07:11:30.018961 4542 status_update_manager.cpp:177] Pausing sending status updates
I0620 07:11:30.022219 4541 state.cpp:62] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_JQuyHS/meta'
I0620 07:11:30.023056 4541 status_update_manager.cpp:203] Recovering status update manager
I0620 07:11:30.023457 4541 containerizer.cpp:582] Recovering containerizer
I0620 07:11:30.025475 4535 provisioner.cpp:416] Provisioner recovery complete
I0620 07:11:30.025867 4540 slave.cpp:6128] Finished recovery
I0620 07:11:30.026741 4540 slave.cpp:6310] Querying resource estimator for oversubscribable resources
I0620 07:11:30.027429 4540 slave.cpp:6324] Received oversubscribable resources {} from the resource estimator
I0620 07:11:30.032877 4535 process.cpp:3779] Handling HTTP event for process 'slave(765)' with path: '/slave(765)/monitor/statistics'
I0620 07:11:30.035349 4535 http.cpp:1159] HTTP GET for /slave(765)/monitor/statistics from 172.17.0.3:57154
I0620 07:11:30.035863 4535 http.cpp:980] Authorizing principal 'test-principal' to GET the '/monitor/statistics' endpoint
I0620 07:11:30.039973 4539 slave.cpp:818] Agent terminating
[ OK ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/0 (49 ms)
[ RUN ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/1
I0620 07:11:30.052490 4516 containerizer.cpp:230] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni,environment_secret
W0620 07:11:30.053162 4516 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0620 07:11:30.053323 4516 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0620 07:11:30.053433 4516 provisioner.cpp:255] Using default backend 'copy'
I0620 07:11:30.057888 4539 slave.cpp:249] Mesos agent started on (766)@172.17.0.3:35259
I0620 07:11:30.057935 4539 slave.cpp:250] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_b7EbcZ/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_b7EbcZ/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/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_b7EbcZ/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_reregistration_timeout="2secs" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_b7EbcZ/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_b7EbcZ/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.4.0/_build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --port="5051" --qos_correction_interval_min="0ns" --quiet="false" --recover="reconnect" --recovery_timeout="15mins" --registration_backoff_factor="10ms" --resources="cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true" --runtime_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_b7EbcZ" --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_ORZ3QX"
I0620 07:11:30.058734 4539 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_b7EbcZ/credential'
I0620 07:11:30.059685 4539 slave.cpp:282] Agent using credential for: test-principal
I0620 07:11:30.059717 4539 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_b7EbcZ/http_credentials'
I0620 07:11:30.062026 4539 http.cpp:1019] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0620 07:11:30.062443 4539 http.cpp:1019] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0620 07:11:30.066315 4539 slave.cpp:553] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0620 07:11:30.066457 4539 slave.cpp:561] Agent attributes: [ ]
I0620 07:11:30.066473 4539 slave.cpp:566] Agent hostname: ca810ce5b491
I0620 07:11:30.067050 4541 status_update_manager.cpp:177] Pausing sending status updates
I0620 07:11:30.069658 4538 state.cpp:62] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_ORZ3QX/meta'
I0620 07:11:30.070621 4540 status_update_manager.cpp:203] Recovering status update manager
I0620 07:11:30.071082 4538 containerizer.cpp:582] Recovering containerizer
I0620 07:11:30.073473 4537 provisioner.cpp:416] Provisioner recovery complete
I0620 07:11:30.074057 4537 slave.cpp:6128] Finished recovery
I0620 07:11:30.076472 4537 slave.cpp:6310] Querying resource estimator for oversubscribable resources
I0620 07:11:30.076817 4540 slave.cpp:6324] Received oversubscribable resources {} from the resource estimator
I0620 07:11:30.081305 4539 process.cpp:3779] Handling HTTP event for process 'slave(766)' with path: '/slave(766)/monitor/statistics.json'
I0620 07:11:30.083683 4538 http.cpp:1159] HTTP GET for /slave(766)/monitor/statistics.json from 172.17.0.3:57156
I0620 07:11:30.083843 4538 http.cpp:980] Authorizing principal 'test-principal' to GET the '/monitor/statistics.json' endpoint
I0620 07:11:30.087883 4539 slave.cpp:818] Agent terminating
[ OK ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/1 (48 ms)
[ RUN ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/2
I0620 07:11:30.100643 4516 containerizer.cpp:230] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni,environment_secret
W0620 07:11:30.101210 4516 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0620 07:11:30.101358 4516 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0620 07:11:30.101452 4516 provisioner.cpp:255] Using default backend 'copy'
I0620 07:11:30.105350 4541 slave.cpp:249] Mesos agent started on (767)@172.17.0.3:35259
I0620 07:11:30.105382 4541 slave.cpp:250] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_I1Am24/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_I1Am24/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/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_I1Am24/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_reregistration_timeout="2secs" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_I1Am24/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_I1Am24/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.4.0/_build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --port="5051" --qos_correction_interval_min="0ns" --quiet="false" --recover="reconnect" --recovery_timeout="15mins" --registration_backoff_factor="10ms" --resources="cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true" --runtime_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_I1Am24" --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_UnQFy3"
I0620 07:11:30.105931 4541 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_I1Am24/credential'
I0620 07:11:30.106611 4541 slave.cpp:282] Agent using credential for: test-principal
I0620 07:11:30.106642 4541 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_I1Am24/http_credentials'
I0620 07:11:30.107290 4541 http.cpp:1019] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0620 07:11:30.107722 4541 http.cpp:1019] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0620 07:11:30.109410 4541 slave.cpp:553] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0620 07:11:30.109494 4541 slave.cpp:561] Agent attributes: [ ]
I0620 07:11:30.109625 4541 slave.cpp:566] Agent hostname: ca810ce5b491
I0620 07:11:30.109953 4535 status_update_manager.cpp:177] Pausing sending status updates
I0620 07:11:30.112464 4535 state.cpp:62] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_UnQFy3/meta'
I0620 07:11:30.112936 4535 status_update_manager.cpp:203] Recovering status update manager
I0620 07:11:30.113346 4537 containerizer.cpp:582] Recovering containerizer
I0620 07:11:30.115268 4538 provisioner.cpp:416] Provisioner recovery complete
I0620 07:11:30.116513 4542 slave.cpp:6128] Finished recovery
I0620 07:11:30.117941 4542 slave.cpp:6310] Querying resource estimator for oversubscribable resources
I0620 07:11:30.118317 4542 slave.cpp:6324] Received oversubscribable resources {} from the resource estimator
I0620 07:11:30.122140 4538 process.cpp:3779] Handling HTTP event for process 'slave(767)' with path: '/slave(767)/containers'
I0620 07:11:30.124160 4537 http.cpp:1159] HTTP GET for /slave(767)/containers from 172.17.0.3:57158
I0620 07:11:30.124325 4537 http.cpp:980] Authorizing principal 'test-principal' to GET the '/containers' endpoint
I0620 07:11:30.127701 4516 slave.cpp:818] Agent terminating
[ OK ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/2 (42 ms)
[ RUN ] Endpoint/SlaveEndpointTest.NoAuthorizer/0
I0620 07:11:30.143621 4516 containerizer.cpp:230] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni,environment_secret
W0620 07:11:30.144300 4516 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0620 07:11:30.144433 4516 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0620 07:11:30.144553 4516 provisioner.cpp:255] Using default backend 'copy'
I0620 07:11:30.146394 4516 cluster.cpp:448] Creating default 'local' authorizer
I0620 07:11:30.148526 4537 slave.cpp:249] Mesos agent started on (768)@172.17.0.3:35259
I0620 07:11:30.148617 4537 slave.cpp:250] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_IufJmb/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_IufJmb/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/Endpoint_SlaveEndpointTest_NoAuthorizer_0_IufJmb/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_reregistration_timeout="2secs" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_IufJmb/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_IufJmb/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.4.0/_build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --port="5051" --qos_correction_interval_min="0ns" --quiet="false" --recover="reconnect" --recovery_timeout="15mins" --registration_backoff_factor="10ms" --resources="cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true" --runtime_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_IufJmb" --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_iSMvL9"
I0620 07:11:30.149142 4537 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_IufJmb/credential'
I0620 07:11:30.149502 4537 slave.cpp:282] Agent using credential for: test-principal
I0620 07:11:30.149556 4537 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_IufJmb/http_credentials'
I0620 07:11:30.149951 4537 http.cpp:1019] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0620 07:11:30.150238 4537 http.cpp:1019] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0620 07:11:30.151765 4537 slave.cpp:553] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0620 07:11:30.151957 4537 slave.cpp:561] Agent attributes: [ ]
I0620 07:11:30.152068 4537 slave.cpp:566] Agent hostname: ca810ce5b491
I0620 07:11:30.152868 4542 status_update_manager.cpp:177] Pausing sending status updates
I0620 07:11:30.154099 4541 state.cpp:62] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_iSMvL9/meta'
I0620 07:11:30.154661 4541 status_update_manager.cpp:203] Recovering status update manager
I0620 07:11:30.155092 4537 containerizer.cpp:582] Recovering containerizer
I0620 07:11:30.157052 4537 provisioner.cpp:416] Provisioner recovery complete
I0620 07:11:30.157645 4537 slave.cpp:6128] Finished recovery
I0620 07:11:30.158239 4537 slave.cpp:6310] Querying resource estimator for oversubscribable resources
I0620 07:11:30.158619 4538 slave.cpp:6324] Received oversubscribable resources {} from the resource estimator
I0620 07:11:30.162305 4536 process.cpp:3779] Handling HTTP event for process 'slave(768)' with path: '/slave(768)/monitor/statistics'
I0620 07:11:30.163827 4538 http.cpp:1159] HTTP GET for /slave(768)/monitor/statistics from 172.17.0.3:57160
I0620 07:11:30.163969 4538 http.cpp:980] Authorizing principal 'test-principal' to GET the '/monitor/statistics' endpoint
I0620 07:11:30.168414 4542 slave.cpp:818] Agent terminating
[ OK ] Endpoint/SlaveEndpointTest.NoAuthorizer/0 (36 ms)
[ RUN ] Endpoint/SlaveEndpointTest.NoAuthorizer/1
I0620 07:11:30.346240 4516 containerizer.cpp:230] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni,environment_secret
W0620 07:11:30.347314 4516 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0620 07:11:30.347646 4516 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0620 07:11:30.347698 4516 provisioner.cpp:255] Using default backend 'copy'
I0620 07:11:30.350806 4516 cluster.cpp:448] Creating default 'local' authorizer
I0620 07:11:30.354471 4540 slave.cpp:249] Mesos agent started on (769)@172.17.0.3:35259
I0620 07:11:30.354502 4540 slave.cpp:250] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_Xh0Avj/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_Xh0Avj/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/Endpoint_SlaveEndpointTest_NoAuthorizer_1_Xh0Avj/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_reregistration_timeout="2secs" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_Xh0Avj/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_Xh0Avj/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.4.0/_build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --port="5051" --qos_correction_interval_min="0ns" --quiet="false" --recover="reconnect" --recovery_timeout="15mins" --registration_backoff_factor="10ms" --resources="cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true" --runtime_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_Xh0Avj" --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_hOy8kh"
I0620 07:11:30.356720 4540 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_Xh0Avj/credential'
I0620 07:11:30.356907 4540 slave.cpp:282] Agent using credential for: test-principal
I0620 07:11:30.356938 4540 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_Xh0Avj/http_credentials'
I0620 07:11:30.357277 4540 http.cpp:1019] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0620 07:11:30.357648 4540 http.cpp:1019] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0620 07:11:30.359793 4540 slave.cpp:553] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0620 07:11:30.359884 4540 slave.cpp:561] Agent attributes: [ ]
I0620 07:11:30.359899 4540 slave.cpp:566] Agent hostname: ca810ce5b491
I0620 07:11:30.360283 4536 status_update_manager.cpp:177] Pausing sending status updates
I0620 07:11:30.362462 4542 state.cpp:62] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_hOy8kh/meta'
I0620 07:11:30.363661 4542 status_update_manager.cpp:203] Recovering status update manager
I0620 07:11:30.364017 4541 containerizer.cpp:582] Recovering containerizer
I0620 07:11:30.365803 4541 provisioner.cpp:416] Provisioner recovery complete
I0620 07:11:30.366191 4540 slave.cpp:6128] Finished recovery
I0620 07:11:30.367086 4540 slave.cpp:6310] Querying resource estimator for oversubscribable resources
I0620 07:11:30.368716 4540 slave.cpp:6324] Received oversubscribable resources {} from the resource estimator
I0620 07:11:30.373342 4536 process.cpp:3779] Handling HTTP event for process 'slave(769)' with path: '/slave(769)/monitor/statistics.json'
I0620 07:11:30.375198 4536 http.cpp:1159] HTTP GET for /slave(769)/monitor/statistics.json from 172.17.0.3:57162
I0620 07:11:30.375869 4536 http.cpp:980] Authorizing principal 'test-principal' to GET the '/monitor/statistics.json' endpoint
I0620 07:11:30.388418 4516 slave.cpp:818] Agent terminating
[ OK ] Endpoint/SlaveEndpointTest.NoAuthorizer/1 (77 ms)
[ RUN ] Endpoint/SlaveEndpointTest.NoAuthorizer/2
I0620 07:11:30.425684 4516 containerizer.cpp:230] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni,environment_secret
W0620 07:11:30.426923 4516 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0620 07:11:30.427112 4516 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0620 07:11:30.427304 4516 provisioner.cpp:255] Using default backend 'copy'
I0620 07:11:30.431792 4516 cluster.cpp:448] Creating default 'local' authorizer
I0620 07:11:30.434695 4541 slave.cpp:249] Mesos agent started on (770)@172.17.0.3:35259
I0620 07:11:30.434852 4541 slave.cpp:250] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_sPmqUs/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_sPmqUs/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/Endpoint_SlaveEndpointTest_NoAuthorizer_2_sPmqUs/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_reregistration_timeout="2secs" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_sPmqUs/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_sPmqUs/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.4.0/_build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --port="5051" --qos_correction_interval_min="0ns" --quiet="false" --recover="reconnect" --recovery_timeout="15mins" --registration_backoff_factor="10ms" --resources="cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true" --runtime_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_sPmqUs" --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_03I7vq"
I0620 07:11:30.436125 4541 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_sPmqUs/credential'
I0620 07:11:30.436506 4541 slave.cpp:282] Agent using credential for: test-principal
I0620 07:11:30.436666 4541 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_sPmqUs/http_credentials'
I0620 07:11:30.437500 4541 http.cpp:1019] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0620 07:11:30.437939 4541 http.cpp:1019] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0620 07:11:30.439939 4541 slave.cpp:553] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0620 07:11:30.440049 4541 slave.cpp:561] Agent attributes: [ ]
I0620 07:11:30.440222 4541 slave.cpp:566] Agent hostname: ca810ce5b491
I0620 07:11:30.441123 4542 status_update_manager.cpp:177] Pausing sending status updates
I0620 07:11:30.443341 4536 state.cpp:62] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_03I7vq/meta'
I0620 07:11:30.444228 4536 status_update_manager.cpp:203] Recovering status update manager
I0620 07:11:30.444767 4536 containerizer.cpp:582] Recovering containerizer
I0620 07:11:30.447185 4536 provisioner.cpp:416] Provisioner recovery complete
I0620 07:11:30.448369 4539 slave.cpp:6128] Finished recovery
I0620 07:11:30.448945 4539 slave.cpp:6310] Querying resource estimator for oversubscribable resources
I0620 07:11:30.449790 4539 slave.cpp:6324] Received oversubscribable resources {} from the resource estimator
I0620 07:11:30.454725 4537 process.cpp:3779] Handling HTTP event for process 'slave(770)' with path: '/slave(770)/containers'
I0620 07:11:30.456885 4538 http.cpp:1159] HTTP GET for /slave(770)/containers from 172.17.0.3:57168
I0620 07:11:30.457193 4538 http.cpp:980] Authorizing principal 'test-principal' to GET the '/containers' endpoint
I0620 07:11:30.463945 4537 slave.cpp:818] Agent terminating
[ OK ] Endpoint/SlaveEndpointTest.NoAuthorizer/2 (59 ms)
[----------] 9 tests from Endpoint/SlaveEndpointTest (641 ms total)
[----------] Global test environment tear-down
[==========] 1613 tests from 177 test cases ran. (649373 ms total)
[ PASSED ] 1610 tests.
[ FAILED ] 3 tests, listed below:
[ FAILED ] DefaultExecutorCheckTest.CommandCheckDeliveredAndReconciled
[ FAILED ] DefaultExecutorCheckTest.CommandCheckStatusChange
[ FAILED ] DefaultExecutorCheckTest.CommandCheckSeesParentsEnv
3 FAILED TESTS
YOU HAVE 20 DISABLED TESTS
E0620 07:11:30.533150 4543 process.cpp:968] Failed to accept socket: future discarded
make[4]: *** [check-local] Error 1
make[4]: Leaving directory `/mesos/mesos-1.4.0/_build/src'
make[3]: *** [check-am] Error 2
make[3]: Leaving directory `/mesos/mesos-1.4.0/_build/src'
make[2]: *** [check] Error 2
make[2]: Leaving directory `/mesos/mesos-1.4.0/_build/src'
make[1]: *** [check-recursive] Error 1
make[1]: Leaving directory `/mesos/mesos-1.4.0/_build'
make: *** [distcheck] Error 1
+ docker rmi mesos-1497938374-30827
Untagged: mesos-1497938374-30827:latest
Deleted: sha256:9c926a064a2ebca61d034e6f60e671bb2cf9cb5d99ae92bf0ba23c47d8452f9d
Deleted: sha256:e7a085682b4fcbea2a5830f7cdb1b4c5fce3455487f0809c8936b65dda73db44
Deleted: sha256:117254e3a0cb104f486abdf1d75cc2fb04a535249d8b9f3b316973ae09536a2e
Deleted: sha256:af66b78b8de250ecf5eb493afbd6fe478c07cfaaa9762e3286f88076d7885582
Deleted: sha256:b54f52271e4c10ffed95259211967764a1fc0525b28e3a8aa611ae79b5dc7a54
Deleted: sha256:80d94837a14845824ad7b16b8549e8fe3360a829e617297294de39eb2d3c8f43
Deleted: sha256:f08ca9dc3b28bface92d3d8c8530fe97007f2b986f2aab376936ac00368845d5
Deleted: sha256:608468da2fc6c8424e4647f927c000c39d4e48ca37e98baeb74d57d5bf3e4fe4
Deleted: sha256:cdc97a2a0a60a6577119fca7712f3f5e76735f91cd270cb8ed0ea55b220264ba
Deleted: sha256:2613f07a56390f9c59db4897fdfba3fd5fb615abc65a31e31ad51227c243f7ef
Deleted: sha256:90956c11094c8519bf3439013ced5d6725cd0ed1d166bd93b2bfc0aae0f4d11d
Deleted: sha256:3995a33889d5fc50131b9d2b4a318fb7339ae6a00941959dc4ee3132512bd310
Deleted: sha256:47cdb0c819959aae00b38f44b7f7b48adce010471477fdb64a87be935988fd52
Deleted: sha256:ddca350f9771de66c98ee4fc276f1a49ea7d2aa0d13cb188da7f1693780d00da
Deleted: sha256:aa869789b7155ab112e40045290e158ef30a8d9f4e1ebae9046e72726ea0e2f9
Deleted: sha256:da1b42e0acb496f1596e75165efa8f01b69c35e43e34d1f2486cad88f1634235
Deleted: sha256:12d5bd227c223bd578efbbf155792c0ea689f5d87d93fbd79d5fa2b5bc1b52df
Deleted: sha256:be44446af222126402a72d8b344d66eb3be890f32550fafbd14f18c81e85d228
Deleted: sha256:85252ab0193b5a22ae3e0f716397e3541dfd1bd2ad72f7984e97b050d3e500fc
Deleted: sha256:539f54c84373ee4e6c1bb79fbaa09cc309994ac43617a3a0416e8d5762a74219
Deleted: sha256:e7f4484b9f01ba5ca28a1e2748672bc47cb462b86cfce64bf9cb0ebfb8d36694
Deleted: sha256:b886071d14734dc672b3f352a185e1fe7ceb3683813566826a567834ac4e8fad
Deleted: sha256:95a70d7d9d1406d09c4cdb2da4f37c21bf815310026ccfd98c592ce1841e310e
Deleted: sha256:ee963f9884e764202846e154be8716fe88bba9e3ebef97d8a3b6ea91207d61ef
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