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/23 08:48:32 UTC

Build failed in Jenkins: Mesos-Buildbot » autotools,gcc,--verbose,GLOG_v=1 MESOS_VERBOSE=1,centos:7,(docker||Hadoop)&&(!ubuntu-us1)&&(!ubuntu-eu2) #3710

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

Changes:

[xujyan] Stop storing agent flags in the XFS disk isolator.

[xujyan] Extract a BasicBlocks class for disk block arithmetic.

[xujyan] Add support for not enforcing XFS quotas.

[xujyan] Update XFS disk isolator documentation.

------------------------------------------
[...truncated 10.39 MB...]
I0523 08:48:23.887367 32004 slave.cpp:1191] Forwarding total oversubscribed resources {}
I0523 08:48:23.887532 32004 master.cpp:6326] Received update of agent 5e2449d9-ab5b-4f6e-8b3a-b37eebda5bd5-S0 at slave(171)@172.17.0.2:32980 (maintenance-host) with total oversubscribed resources {}
I0523 08:48:23.892787 31975 cluster.cpp:448] Creating default 'local' authorizer
I0523 08:48:23.894682 32006 slave.cpp:225] Mesos agent started on (172)@172.17.0.2:32980
I0523 08:48:23.894703 32006 slave.cpp:226] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/mesos/store/appc" --authenticate_http_readonly="true" --authenticate_http_readwrite="true" --authenticatee="crammd5" --authentication_backoff_factor="1secs" --authorizer="local" --cgroups_cpu_enable_pids_and_tids_count="false" --cgroups_enable_cfs="false" --cgroups_hierarchy="/sys/fs/cgroup" --cgroups_limit_swap="false" --cgroups_root="mesos" --container_disk_watch_interval="15secs" --containerizers="mesos" --credential="/tmp/MasterMaintenanceTest_InverseOffersFilters_XF1p7d/credential" --default_role="*" --disk_watch_interval="1mins" --docker="docker" --docker_kill_orphans="true" --docker_registry="https://registry-1.docker.io" --docker_remove_delay="6hrs" --docker_socket="/var/run/docker.sock" --docker_stop_timeout="0ns" --docker_store_dir="/tmp/mesos/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/MasterMaintenanceTest_InverseOffersFilters_XF1p7d/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_XF1p7d/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_XF1p7d" --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_S8llhZ"
I0523 08:48:23.895182 32006 credentials.hpp:86] Loading credential for authentication from '/tmp/MasterMaintenanceTest_InverseOffersFilters_XF1p7d/credential'
I0523 08:48:23.895337 32006 slave.cpp:258] Agent using credential for: test-principal
I0523 08:48:23.895360 32006 credentials.hpp:37] Loading credentials for authentication from '/tmp/MasterMaintenanceTest_InverseOffersFilters_XF1p7d/http_credentials'
I0523 08:48:23.895648 32006 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0523 08:48:23.895808 32006 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0523 08:48:23.897204 32006 slave.cpp:529] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0523 08:48:23.897276 32006 slave.cpp:537] Agent attributes: [  ]
I0523 08:48:23.897289 32006 slave.cpp:542] Agent hostname: maintenance-host-2
I0523 08:48:23.897435 32002 status_update_manager.cpp:177] Pausing sending status updates
I0523 08:48:23.898802 32002 state.cpp:62] Recovering state from '/tmp/MasterMaintenanceTest_InverseOffersFilters_S8llhZ/meta'
I0523 08:48:23.899153 32001 status_update_manager.cpp:203] Recovering status update manager
I0523 08:48:23.899698 31996 slave.cpp:5974] Finished recovery
I0523 08:48:23.900144 31996 slave.cpp:6156] Querying resource estimator for oversubscribable resources
I0523 08:48:23.900485 31999 status_update_manager.cpp:177] Pausing sending status updates
I0523 08:48:23.900498 32003 slave.cpp:922] New master detected at master@172.17.0.2:32980
I0523 08:48:23.900652 32003 slave.cpp:957] Detecting new master
I0523 08:48:23.900894 32003 slave.cpp:6170] Received oversubscribable resources {} from the resource estimator
I0523 08:48:23.904999 32005 slave.cpp:984] Authenticating with master master@172.17.0.2:32980
I0523 08:48:23.905081 32005 slave.cpp:995] Using default CRAM-MD5 authenticatee
I0523 08:48:23.905329 31994 authenticatee.cpp:121] Creating new client SASL connection
I0523 08:48:23.905653 32000 master.cpp:7477] Authenticating slave(172)@172.17.0.2:32980
I0523 08:48:23.905788 32007 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(375)@172.17.0.2:32980
I0523 08:48:23.906082 31998 authenticator.cpp:98] Creating new server SASL connection
I0523 08:48:23.906319 31994 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5
I0523 08:48:23.906355 31994 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5'
I0523 08:48:23.906510 32006 authenticator.cpp:204] Received SASL authentication start
I0523 08:48:23.906580 32006 authenticator.cpp:326] Authentication requires more steps
I0523 08:48:23.906702 32000 authenticatee.cpp:259] Received SASL authentication step
I0523 08:48:23.906852 31994 authenticator.cpp:232] Received SASL authentication step
I0523 08:48:23.906890 31994 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '5a7429750c2c' server FQDN: '5a7429750c2c' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false 
I0523 08:48:23.906908 31994 auxprop.cpp:181] Looking up auxiliary property '*userPassword'
I0523 08:48:23.906954 31994 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
I0523 08:48:23.906980 31994 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '5a7429750c2c' server FQDN: '5a7429750c2c' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true 
I0523 08:48:23.906996 31994 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true
I0523 08:48:23.907006 31994 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
I0523 08:48:23.907028 31994 authenticator.cpp:318] Authentication success
I0523 08:48:23.907131 32000 authenticatee.cpp:299] Authentication success
I0523 08:48:23.907207 31998 master.cpp:7507] Successfully authenticated principal 'test-principal' at slave(172)@172.17.0.2:32980
I0523 08:48:23.907299 32001 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(375)@172.17.0.2:32980
I0523 08:48:23.907579 31995 slave.cpp:1079] Successfully authenticated with master master@172.17.0.2:32980
I0523 08:48:23.907805 31995 slave.cpp:1507] Will retry registration in 8.710467ms if necessary
I0523 08:48:23.907987 32000 master.cpp:5429] Received register agent message from slave(172)@172.17.0.2:32980 (maintenance-host-2)
I0523 08:48:23.908141 32000 master.cpp:3659] Authorizing agent with principal 'test-principal'
I0523 08:48:23.908713 31997 master.cpp:5565] Registering agent at slave(172)@172.17.0.2:32980 (maintenance-host-2) with id 5e2449d9-ab5b-4f6e-8b3a-b37eebda5bd5-S1
I0523 08:48:23.909278 32007 registrar.cpp:493] Applied 1 operations in 108847ns; attempting to update the registry
I0523 08:48:23.910238 32007 registrar.cpp:550] Successfully updated the registry in 869888ns
I0523 08:48:23.910841 31999 slave.cpp:4749] Received ping from slave-observer(168)@172.17.0.2:32980
I0523 08:48:23.911008 32004 master.cpp:5640] Registered agent 5e2449d9-ab5b-4f6e-8b3a-b37eebda5bd5-S1 at slave(172)@172.17.0.2:32980 (maintenance-host-2) with cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0523 08:48:23.911226 32006 slave.cpp:1125] Registered with master master@172.17.0.2:32980; given agent ID 5e2449d9-ab5b-4f6e-8b3a-b37eebda5bd5-S1
I0523 08:48:23.911253 32006 fetcher.cpp:94] Clearing fetcher cache
I0523 08:48:23.911468 31997 status_update_manager.cpp:184] Resuming sending status updates
I0523 08:48:23.911456 32009 hierarchical.cpp:525] Added agent 5e2449d9-ab5b-4f6e-8b3a-b37eebda5bd5-S1 (maintenance-host-2) with cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] (allocated: {})
I0523 08:48:23.911686 32006 slave.cpp:1153] Checkpointing SlaveInfo to '/tmp/MasterMaintenanceTest_InverseOffersFilters_S8llhZ/meta/slaves/5e2449d9-ab5b-4f6e-8b3a-b37eebda5bd5-S1/slave.info'
I0523 08:48:23.911756 32009 hierarchical.cpp:1850] No allocations performed
I0523 08:48:23.911824 32009 hierarchical.cpp:1434] Performed allocation for 1 agents in 222785ns
I0523 08:48:23.912025 32006 slave.cpp:1191] Forwarding total oversubscribed resources {}
I0523 08:48:23.912163 31998 master.cpp:6326] Received update of agent 5e2449d9-ab5b-4f6e-8b3a-b37eebda5bd5-S1 at slave(172)@172.17.0.2:32980 (maintenance-host-2) with total oversubscribed resources {}
I0523 08:48:23.914142 32006 process.cpp:3730] Handling HTTP event for process 'master' with path: '/master/maintenance/schedule'
I0523 08:48:23.916038 31997 http.cpp:1115] HTTP POST for /master/maintenance/schedule from 172.17.0.2:40240
I0523 08:48:23.916997 32004 registrar.cpp:493] Applied 1 operations in 172968ns; attempting to update the registry
I0523 08:48:23.918184 32004 registrar.cpp:550] Successfully updated the registry in 1.122048ms
I0523 08:48:23.918576 32003 master.cpp:6388] Updating unavailability of agent 5e2449d9-ab5b-4f6e-8b3a-b37eebda5bd5-S0 at slave(171)@172.17.0.2:32980 (maintenance-host), starting at 2477.76758097143weeks
I0523 08:48:23.918756 32003 master.cpp:6388] Updating unavailability of agent 5e2449d9-ab5b-4f6e-8b3a-b37eebda5bd5-S1 at slave(172)@172.17.0.2:32980 (maintenance-host-2), starting at 2477.76758097143weeks
I0523 08:48:23.918962 31999 hierarchical.cpp:1850] No allocations performed
I0523 08:48:23.919026 31999 hierarchical.cpp:1434] Performed allocation for 1 agents in 175490ns
I0523 08:48:23.919325 31999 hierarchical.cpp:1850] No allocations performed
I0523 08:48:23.919374 31999 hierarchical.cpp:1434] Performed allocation for 1 agents in 132248ns
I0523 08:48:23.921213 31975 scheduler.cpp:184] Version: 1.4.0
I0523 08:48:23.921844 32003 scheduler.cpp:470] New master detected at master@172.17.0.2:32980
I0523 08:48:23.921876 32003 scheduler.cpp:479] Waiting for 0ns before initiating a re-(connection) attempt with the master
I0523 08:48:23.925324 32004 scheduler.cpp:361] Connected with the master at http://172.17.0.2:32980/master/api/v1/scheduler
I0523 08:48:23.926681 31994 scheduler.cpp:243] Sending SUBSCRIBE call to http://172.17.0.2:32980/master/api/v1/scheduler
I0523 08:48:23.928192 31995 process.cpp:3730] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I0523 08:48:23.929888 32005 http.cpp:1115] HTTP POST for /master/api/v1/scheduler from 172.17.0.2:40242
I0523 08:48:23.930130 32005 master.cpp:2513] Received subscription request for HTTP framework 'default'
I0523 08:48:23.930233 32005 master.cpp:2197] Authorizing framework principal 'test-principal' to receive offers for roles '{ * }'
I0523 08:48:23.930794 32008 master.cpp:2628] Subscribing framework 'default' with checkpointing disabled and capabilities [  ]
I0523 08:48:23.931546 31998 master.hpp:2194] Sending heartbeat to 5e2449d9-ab5b-4f6e-8b3a-b37eebda5bd5-0000
I0523 08:48:23.931860 32002 hierarchical.cpp:273] Added framework 5e2449d9-ab5b-4f6e-8b3a-b37eebda5bd5-0000
I0523 08:48:23.932744 31995 scheduler.cpp:676] Enqueuing event SUBSCRIBED received from http://172.17.0.2:32980/master/api/v1/scheduler
I0523 08:48:23.933385 31995 scheduler.cpp:676] Enqueuing event HEARTBEAT received from http://172.17.0.2:32980/master/api/v1/scheduler
I0523 08:48:23.934849 32002 hierarchical.cpp:1434] Performed allocation for 2 agents in 2.821925ms
I0523 08:48:23.935745 31996 master.cpp:7307] Sending 2 offers to framework 5e2449d9-ab5b-4f6e-8b3a-b37eebda5bd5-0000 (default)
I0523 08:48:23.936906 31996 master.cpp:7396] Sending 2 inverse offers to framework 5e2449d9-ab5b-4f6e-8b3a-b37eebda5bd5-0000 (default)
I0523 08:48:23.938010 31998 hierarchical.cpp:1850] No allocations performed
I0523 08:48:23.938382 31998 hierarchical.cpp:1434] Performed allocation for 2 agents in 475022ns
I0523 08:48:23.939584 32000 scheduler.cpp:676] Enqueuing event OFFERS received from http://172.17.0.2:32980/master/api/v1/scheduler
I0523 08:48:23.940852 32006 scheduler.cpp:676] Enqueuing event INVERSE_OFFERS received from http://172.17.0.2:32980/master/api/v1/scheduler
I0523 08:48:23.944011 32004 scheduler.cpp:243] Sending ACCEPT call to http://172.17.0.2:32980/master/api/v1/scheduler
I0523 08:48:23.944960 32004 scheduler.cpp:243] Sending ACCEPT call to http://172.17.0.2:32980/master/api/v1/scheduler
I0523 08:48:23.945729 32003 process.cpp:3730] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I0523 08:48:23.947798 31997 http.cpp:1115] HTTP POST for /master/api/v1/scheduler from 172.17.0.2:40241
I0523 08:48:23.948948 31997 master.cpp:3875] Processing ACCEPT call for offers: [ 5e2449d9-ab5b-4f6e-8b3a-b37eebda5bd5-O0 ] on agent 5e2449d9-ab5b-4f6e-8b3a-b37eebda5bd5-S1 at slave(172)@172.17.0.2:32980 (maintenance-host-2) for framework 5e2449d9-ab5b-4f6e-8b3a-b37eebda5bd5-0000 (default)
I0523 08:48:23.949085 31997 master.cpp:3426] Authorizing framework principal 'test-principal' to launch task 30101fdc-66ec-4cb5-b333-dbfd199ace31
I0523 08:48:23.950654 31997 process.cpp:3730] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
W0523 08:48:23.952783 31997 validation.cpp:1284] Executor 'executor-1' for task '30101fdc-66ec-4cb5-b333-dbfd199ace31' uses less CPUs (None) than the minimum required (0.01). Please update your executor, as this will be mandatory in future releases.
W0523 08:48:23.952826 31997 validation.cpp:1296] Executor 'executor-1' for task '30101fdc-66ec-4cb5-b333-dbfd199ace31' uses less memory (None) than the minimum required (32MB). Please update your executor, as this will be mandatory in future releases.
I0523 08:48:23.953558 31997 master.cpp:9328] Adding task 30101fdc-66ec-4cb5-b333-dbfd199ace31 with resources cpus(*)(allocated: *):2; mem(*)(allocated: *):1024; disk(*)(allocated: *):1024; ports(*)(allocated: *):[31000-32000] on agent 5e2449d9-ab5b-4f6e-8b3a-b37eebda5bd5-S1 at slave(172)@172.17.0.2:32980 (maintenance-host-2)
I0523 08:48:23.954087 31997 master.cpp:4531] Launching task 30101fdc-66ec-4cb5-b333-dbfd199ace31 of framework 5e2449d9-ab5b-4f6e-8b3a-b37eebda5bd5-0000 (default) with resources cpus(*)(allocated: *):2; mem(*)(allocated: *):1024; disk(*)(allocated: *):1024; ports(*)(allocated: *):[31000-32000] on agent 5e2449d9-ab5b-4f6e-8b3a-b37eebda5bd5-S1 at slave(172)@172.17.0.2:32980 (maintenance-host-2)
I0523 08:48:23.954715 32004 slave.cpp:1617] Got assigned task '30101fdc-66ec-4cb5-b333-dbfd199ace31' for framework 5e2449d9-ab5b-4f6e-8b3a-b37eebda5bd5-0000
I0523 08:48:23.955699 32004 slave.cpp:1898] Authorizing task '30101fdc-66ec-4cb5-b333-dbfd199ace31' for framework 5e2449d9-ab5b-4f6e-8b3a-b37eebda5bd5-0000
I0523 08:48:23.955797 32004 slave.cpp:6593] Authorizing framework principal 'test-principal' to launch task 30101fdc-66ec-4cb5-b333-dbfd199ace31
I0523 08:48:23.955884 32002 http.cpp:1115] HTTP POST for /master/api/v1/scheduler from 172.17.0.2:40241
I0523 08:48:23.957183 31996 slave.cpp:2085] Launching task '30101fdc-66ec-4cb5-b333-dbfd199ace31' for framework 5e2449d9-ab5b-4f6e-8b3a-b37eebda5bd5-0000
I0523 08:48:23.957435 32002 master.cpp:3875] Processing ACCEPT call for offers: [ 5e2449d9-ab5b-4f6e-8b3a-b37eebda5bd5-O1 ] on agent 5e2449d9-ab5b-4f6e-8b3a-b37eebda5bd5-S0 at slave(171)@172.17.0.2:32980 (maintenance-host) for framework 5e2449d9-ab5b-4f6e-8b3a-b37eebda5bd5-0000 (default)
I0523 08:48:23.957545 32002 master.cpp:3426] Authorizing framework principal 'test-principal' to launch task 8f67a792-1250-46dc-9b6d-e93ed1372636
I0523 08:48:23.957738 31996 paths.cpp:573] Trying to chown '/tmp/MasterMaintenanceTest_InverseOffersFilters_S8llhZ/slaves/5e2449d9-ab5b-4f6e-8b3a-b37eebda5bd5-S1/frameworks/5e2449d9-ab5b-4f6e-8b3a-b37eebda5bd5-0000/executors/executor-1/runs/1a84d9a2-d9b9-4ad5-82ad-6498353aebe2' to user 'mesos'
I0523 08:48:23.958001 31996 slave.cpp:6933] Launching executor 'executor-1' of framework 5e2449d9-ab5b-4f6e-8b3a-b37eebda5bd5-0000 with resources {} in work directory '/tmp/MasterMaintenanceTest_InverseOffersFilters_S8llhZ/slaves/5e2449d9-ab5b-4f6e-8b3a-b37eebda5bd5-S1/frameworks/5e2449d9-ab5b-4f6e-8b3a-b37eebda5bd5-0000/executors/executor-1/runs/1a84d9a2-d9b9-4ad5-82ad-6498353aebe2'
I0523 08:48:23.958705 32005 hierarchical.cpp:850] Updated allocation of framework 5e2449d9-ab5b-4f6e-8b3a-b37eebda5bd5-0000 on agent 5e2449d9-ab5b-4f6e-8b3a-b37eebda5bd5-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]
I0523 08:48:23.959054 31996 slave.cpp:2314] Queued task '30101fdc-66ec-4cb5-b333-dbfd199ace31' for executor 'executor-1' of framework 5e2449d9-ab5b-4f6e-8b3a-b37eebda5bd5-0000
I0523 08:48:23.959167 31996 slave.cpp:875] Successfully attached file '/tmp/MasterMaintenanceTest_InverseOffersFilters_S8llhZ/slaves/5e2449d9-ab5b-4f6e-8b3a-b37eebda5bd5-S1/frameworks/5e2449d9-ab5b-4f6e-8b3a-b37eebda5bd5-0000/executors/executor-1/runs/1a84d9a2-d9b9-4ad5-82ad-6498353aebe2'
W0523 08:48:23.960887 32002 validation.cpp:1284] Executor 'executor-2' for task '8f67a792-1250-46dc-9b6d-e93ed1372636' uses less CPUs (None) than the minimum required (0.01). Please update your executor, as this will be mandatory in future releases.
W0523 08:48:23.960925 32002 validation.cpp:1296] Executor 'executor-2' for task '8f67a792-1250-46dc-9b6d-e93ed1372636' uses less memory (None) than the minimum required (32MB). Please update your executor, as this will be mandatory in future releases.
I0523 08:48:23.961604 32002 master.cpp:9328] Adding task 8f67a792-1250-46dc-9b6d-e93ed1372636 with resources cpus(*)(allocated: *):2; mem(*)(allocated: *):1024; disk(*)(allocated: *):1024; ports(*)(allocated: *):[31000-32000] on agent 5e2449d9-ab5b-4f6e-8b3a-b37eebda5bd5-S0 at slave(171)@172.17.0.2:32980 (maintenance-host)
I0523 08:48:23.961740 32000 exec.cpp:162] Version: 1.4.0
I0523 08:48:23.962085 31996 exec.cpp:212] Executor started at: executor(61)@172.17.0.2:32980 with pid 31975
I0523 08:48:23.962095 32002 master.cpp:4531] Launching task 8f67a792-1250-46dc-9b6d-e93ed1372636 of framework 5e2449d9-ab5b-4f6e-8b3a-b37eebda5bd5-0000 (default) with resources cpus(*)(allocated: *):2; mem(*)(allocated: *):1024; disk(*)(allocated: *):1024; ports(*)(allocated: *):[31000-32000] on agent 5e2449d9-ab5b-4f6e-8b3a-b37eebda5bd5-S0 at slave(171)@172.17.0.2:32980 (maintenance-host)
I0523 08:48:23.962347 31994 slave.cpp:3788] Got registration for executor 'executor-1' of framework 5e2449d9-ab5b-4f6e-8b3a-b37eebda5bd5-0000 from executor(61)@172.17.0.2:32980
I0523 08:48:23.962664 31996 exec.cpp:237] Executor registered on agent 5e2449d9-ab5b-4f6e-8b3a-b37eebda5bd5-S1
I0523 08:48:23.962678 31998 slave.cpp:1617] Got assigned task '8f67a792-1250-46dc-9b6d-e93ed1372636' for framework 5e2449d9-ab5b-4f6e-8b3a-b37eebda5bd5-0000
I0523 08:48:23.962713 31996 exec.cpp:249] Executor::registered took 25345ns
I0523 08:48:23.963636 31998 slave.cpp:1898] Authorizing task '8f67a792-1250-46dc-9b6d-e93ed1372636' for framework 5e2449d9-ab5b-4f6e-8b3a-b37eebda5bd5-0000
I0523 08:48:23.963707 31998 slave.cpp:6593] Authorizing framework principal 'test-principal' to launch task 8f67a792-1250-46dc-9b6d-e93ed1372636
I0523 08:48:23.963939 31994 slave.cpp:2527] Sending queued task '30101fdc-66ec-4cb5-b333-dbfd199ace31' to executor 'executor-1' of framework 5e2449d9-ab5b-4f6e-8b3a-b37eebda5bd5-0000 at executor(61)@172.17.0.2:32980
I0523 08:48:23.964334 32007 exec.cpp:325] Executor asked to run task '30101fdc-66ec-4cb5-b333-dbfd199ace31'
I0523 08:48:23.964452 32007 exec.cpp:334] Executor::launchTask took 85405ns
I0523 08:48:23.964592 32007 exec.cpp:551] Executor sending status update TASK_RUNNING (UUID: 33d722c2-f521-472b-add9-de5d9269e73e) for task 30101fdc-66ec-4cb5-b333-dbfd199ace31 of framework 5e2449d9-ab5b-4f6e-8b3a-b37eebda5bd5-0000
I0523 08:48:23.964797 32003 slave.cpp:2085] Launching task '8f67a792-1250-46dc-9b6d-e93ed1372636' for framework 5e2449d9-ab5b-4f6e-8b3a-b37eebda5bd5-0000
I0523 08:48:23.965034 31994 slave.cpp:4219] Handling status update TASK_RUNNING (UUID: 33d722c2-f521-472b-add9-de5d9269e73e) for task 30101fdc-66ec-4cb5-b333-dbfd199ace31 of framework 5e2449d9-ab5b-4f6e-8b3a-b37eebda5bd5-0000 from executor(61)@172.17.0.2:32980
I0523 08:48:23.965536 32003 paths.cpp:573] Trying to chown '/tmp/MasterMaintenanceTest_InverseOffersFilters_sgVp11/slaves/5e2449d9-ab5b-4f6e-8b3a-b37eebda5bd5-S0/frameworks/5e2449d9-ab5b-4f6e-8b3a-b37eebda5bd5-0000/executors/executor-2/runs/b5fd0c37-520d-477f-a8a6-bda21671893d' to user 'mesos'
I0523 08:48:23.965736 32003 slave.cpp:6933] Launching executor 'executor-2' of framework 5e2449d9-ab5b-4f6e-8b3a-b37eebda5bd5-0000 with resources {} in work directory '/tmp/MasterMaintenanceTest_InverseOffersFilters_sgVp11/slaves/5e2449d9-ab5b-4f6e-8b3a-b37eebda5bd5-S0/frameworks/5e2449d9-ab5b-4f6e-8b3a-b37eebda5bd5-0000/executors/executor-2/runs/b5fd0c37-520d-477f-a8a6-bda21671893d'
I0523 08:48:23.965903 31996 status_update_manager.cpp:323] Received status update TASK_RUNNING (UUID: 33d722c2-f521-472b-add9-de5d9269e73e) for task 30101fdc-66ec-4cb5-b333-dbfd199ace31 of framework 5e2449d9-ab5b-4f6e-8b3a-b37eebda5bd5-0000
I0523 08:48:23.965957 31996 status_update_manager.cpp:500] Creating StatusUpdate stream for task 30101fdc-66ec-4cb5-b333-dbfd199ace31 of framework 5e2449d9-ab5b-4f6e-8b3a-b37eebda5bd5-0000
I0523 08:48:23.966063 32006 hierarchical.cpp:850] Updated allocation of framework 5e2449d9-ab5b-4f6e-8b3a-b37eebda5bd5-0000 on agent 5e2449d9-ab5b-4f6e-8b3a-b37eebda5bd5-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]
I0523 08:48:23.966493 31996 status_update_manager.cpp:377] Forwarding update TASK_RUNNING (UUID: 33d722c2-f521-472b-add9-de5d9269e73e) for task 30101fdc-66ec-4cb5-b333-dbfd199ace31 of framework 5e2449d9-ab5b-4f6e-8b3a-b37eebda5bd5-0000 to the agent
I0523 08:48:23.966588 32003 slave.cpp:2314] Queued task '8f67a792-1250-46dc-9b6d-e93ed1372636' for executor 'executor-2' of framework 5e2449d9-ab5b-4f6e-8b3a-b37eebda5bd5-0000
I0523 08:48:23.966704 32003 slave.cpp:875] Successfully attached file '/tmp/MasterMaintenanceTest_InverseOffersFilters_sgVp11/slaves/5e2449d9-ab5b-4f6e-8b3a-b37eebda5bd5-S0/frameworks/5e2449d9-ab5b-4f6e-8b3a-b37eebda5bd5-0000/executors/executor-2/runs/b5fd0c37-520d-477f-a8a6-bda21671893d'
I0523 08:48:23.966832 31994 slave.cpp:4659] Forwarding the update TASK_RUNNING (UUID: 33d722c2-f521-472b-add9-de5d9269e73e) for task 30101fdc-66ec-4cb5-b333-dbfd199ace31 of framework 5e2449d9-ab5b-4f6e-8b3a-b37eebda5bd5-0000 to master@172.17.0.2:32980
I0523 08:48:23.967113 31994 slave.cpp:4553] Status update manager successfully handled status update TASK_RUNNING (UUID: 33d722c2-f521-472b-add9-de5d9269e73e) for task 30101fdc-66ec-4cb5-b333-dbfd199ace31 of framework 5e2449d9-ab5b-4f6e-8b3a-b37eebda5bd5-0000
I0523 08:48:23.967188 31994 slave.cpp:4569] Sending acknowledgement for status update TASK_RUNNING (UUID: 33d722c2-f521-472b-add9-de5d9269e73e) for task 30101fdc-66ec-4cb5-b333-dbfd199ace31 of framework 5e2449d9-ab5b-4f6e-8b3a-b37eebda5bd5-0000 to executor(61)@172.17.0.2:32980
I0523 08:48:23.967239 31998 master.cpp:6471] Status update TASK_RUNNING (UUID: 33d722c2-f521-472b-add9-de5d9269e73e) for task 30101fdc-66ec-4cb5-b333-dbfd199ace31 of framework 5e2449d9-ab5b-4f6e-8b3a-b37eebda5bd5-0000 from agent 5e2449d9-ab5b-4f6e-8b3a-b37eebda5bd5-S1 at slave(172)@172.17.0.2:32980 (maintenance-host-2)
I0523 08:48:23.967314 31998 master.cpp:6539] Forwarding status update TASK_RUNNING (UUID: 33d722c2-f521-472b-add9-de5d9269e73e) for task 30101fdc-66ec-4cb5-b333-dbfd199ace31 of framework 5e2449d9-ab5b-4f6e-8b3a-b37eebda5bd5-0000
I0523 08:48:23.967391 32003 exec.cpp:374] Executor received status update acknowledgement 33d722c2-f521-472b-add9-de5d9269e73e for task 30101fdc-66ec-4cb5-b333-dbfd199ace31 of framework 5e2449d9-ab5b-4f6e-8b3a-b37eebda5bd5-0000
I0523 08:48:23.967774 31998 master.cpp:8570] Updating the state of task 30101fdc-66ec-4cb5-b333-dbfd199ace31 of framework 5e2449d9-ab5b-4f6e-8b3a-b37eebda5bd5-0000 (latest state: TASK_RUNNING, status update state: TASK_RUNNING)
*** Aborted at 1495529303 (unix time) try "date -d @1495529303" if you are using GNU date ***
I0523 08:48:23.968971 32004 exec.cpp:162] Version: 1.4.0
I0523 08:48:23.969082 31998 scheduler.cpp:676] Enqueuing event UPDATE received from http://172.17.0.2:32980/master/api/v1/scheduler
I0523 08:48:23.969146 32007 exec.cpp:212] Executor started at: executor(62)@172.17.0.2:32980 with pid 31975
I0523 08:48:23.969441 31994 slave.cpp:3788] Got registration for executor 'executor-2' of framework 5e2449d9-ab5b-4f6e-8b3a-b37eebda5bd5-0000 from executor(62)@172.17.0.2:32980
I0523 08:48:23.969792 32001 exec.cpp:237] Executor registered on agent 5e2449d9-ab5b-4f6e-8b3a-b37eebda5bd5-S0
I0523 08:48:23.969854 32001 exec.cpp:249] Executor::registered took 29577ns
PC: @     0x7f5ce1eec0cd __GI_getenv
*** SIGSEGV (@0xc0) received by PID 31975 (TID 0x7f5cd7eb6700) from PID 192; stack trace: ***
I0523 08:48:23.970479 31994 slave.cpp:2527] Sending queued task '8f67a792-1250-46dc-9b6d-e93ed1372636' to executor 'executor-2' of framework 5e2449d9-ab5b-4f6e-8b3a-b37eebda5bd5-0000 at executor(62)@172.17.0.2:32980
I0523 08:48:23.970806 31999 exec.cpp:325] Executor asked to run task '8f67a792-1250-46dc-9b6d-e93ed1372636'
I0523 08:48:23.970880 31999 exec.cpp:334] Executor::launchTask took 51967ns
I0523 08:48:23.970958 31999 exec.cpp:551] Executor sending status update TASK_RUNNING (UUID: 73e0f4f3-c1d3-4b14-943f-0e997763d481) for task 8f67a792-1250-46dc-9b6d-e93ed1372636 of framework 5e2449d9-ab5b-4f6e-8b3a-b37eebda5bd5-0000
I0523 08:48:23.971156 31999 slave.cpp:4219] Handling status update TASK_RUNNING (UUID: 73e0f4f3-c1d3-4b14-943f-0e997763d481) for task 8f67a792-1250-46dc-9b6d-e93ed1372636 of framework 5e2449d9-ab5b-4f6e-8b3a-b37eebda5bd5-0000 from executor(62)@172.17.0.2:32980
    @     0x7f5cd0de4fc5 (unknown)
I0523 08:48:23.971794 32002 status_update_manager.cpp:323] Received status update TASK_RUNNING (UUID: 73e0f4f3-c1d3-4b14-943f-0e997763d481) for task 8f67a792-1250-46dc-9b6d-e93ed1372636 of framework 5e2449d9-ab5b-4f6e-8b3a-b37eebda5bd5-0000
I0523 08:48:23.971840 32002 status_update_manager.cpp:500] Creating StatusUpdate stream for task 8f67a792-1250-46dc-9b6d-e93ed1372636 of framework 5e2449d9-ab5b-4f6e-8b3a-b37eebda5bd5-0000
    @     0x7f5cd0dea2c1 (unknown)
I0523 08:48:23.972173 32002 status_update_manager.cpp:377] Forwarding update TASK_RUNNING (UUID: 73e0f4f3-c1d3-4b14-943f-0e997763d481) for task 8f67a792-1250-46dc-9b6d-e93ed1372636 of framework 5e2449d9-ab5b-4f6e-8b3a-b37eebda5bd5-0000 to the agent
I0523 08:48:23.972415 31994 slave.cpp:4659] Forwarding the update TASK_RUNNING (UUID: 73e0f4f3-c1d3-4b14-943f-0e997763d481) for task 8f67a792-1250-46dc-9b6d-e93ed1372636 of framework 5e2449d9-ab5b-4f6e-8b3a-b37eebda5bd5-0000 to master@172.17.0.2:32980
    @     0x7f5cd0dde0a8 (unknown)
I0523 08:48:23.972626 31994 slave.cpp:4553] Status update manager successfully handled status update TASK_RUNNING (UUID: 73e0f4f3-c1d3-4b14-943f-0e997763d481) for task 8f67a792-1250-46dc-9b6d-e93ed1372636 of framework 5e2449d9-ab5b-4f6e-8b3a-b37eebda5bd5-0000
I0523 08:48:23.972666 31994 slave.cpp:4569] Sending acknowledgement for status update TASK_RUNNING (UUID: 73e0f4f3-c1d3-4b14-943f-0e997763d481) for task 8f67a792-1250-46dc-9b6d-e93ed1372636 of framework 5e2449d9-ab5b-4f6e-8b3a-b37eebda5bd5-0000 to executor(62)@172.17.0.2:32980
I0523 08:48:23.972723 31996 master.cpp:6471] Status update TASK_RUNNING (UUID: 73e0f4f3-c1d3-4b14-943f-0e997763d481) for task 8f67a792-1250-46dc-9b6d-e93ed1372636 of framework 5e2449d9-ab5b-4f6e-8b3a-b37eebda5bd5-0000 from agent 5e2449d9-ab5b-4f6e-8b3a-b37eebda5bd5-S0 at slave(171)@172.17.0.2:32980 (maintenance-host)
I0523 08:48:23.972776 31996 master.cpp:6539] Forwarding status update TASK_RUNNING (UUID: 73e0f4f3-c1d3-4b14-943f-0e997763d481) for task 8f67a792-1250-46dc-9b6d-e93ed1372636 of framework 5e2449d9-ab5b-4f6e-8b3a-b37eebda5bd5-0000
I0523 08:48:23.972797 32003 exec.cpp:374] Executor received status update acknowledgement 73e0f4f3-c1d3-4b14-943f-0e997763d481 for task 8f67a792-1250-46dc-9b6d-e93ed1372636 of framework 5e2449d9-ab5b-4f6e-8b3a-b37eebda5bd5-0000
I0523 08:48:23.973065 31996 master.cpp:8570] Updating the state of task 8f67a792-1250-46dc-9b6d-e93ed1372636 of framework 5e2449d9-ab5b-4f6e-8b3a-b37eebda5bd5-0000 (latest state: TASK_RUNNING, status update state: TASK_RUNNING)
    @     0x7f5ce2eb1370 (unknown)
    @     0x7f5ce1eec0cd __GI_getenv
I0523 08:48:23.976495 31994 scheduler.cpp:243] Sending ACKNOWLEDGE call to http://172.17.0.2:32980/master/api/v1/scheduler
    @     0x7f5ce1ee3c41 __dcigettext
I0523 08:48:23.977905 31999 process.cpp:3730] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
    @     0x7f5ce1f3a9de __GI___strerror_r
    @     0x7f5ceb28dd72 os::strerror()
    @     0x7f5ceb2a97f8 ErrnoError::ErrnoError()
    @     0x7f5ceb2a97c5 ErrnoError::ErrnoError()
    @     0x7f5ce8f6366b _ZZN7process2io8internal4readEiPvmENKUlvE_clEv
    @     0x7f5ce8f67516 _ZN7process8internal4LoopIZNS_2io8internal4readEiPvmEUlvE_ZNS3_4readEiS4_mEUlRK6OptionImEE0_S7_mE5startEv
    @     0x7f5ce8f6684b _ZN7process4loopIZNS_2io8internal4readEiPvmEUlvE_ZNS2_4readEiS3_mEUlRK6OptionImEE0_S6_NS_11ControlFlowImEEmEENS_6FutureIT3_EERKS5_INS_4UPIDEEOT_OT0_
I0523 08:48:24.015578 32002 http.cpp:1115] HTTP POST for /master/api/v1/scheduler from 172.17.0.2:40241
I0523 08:48:24.015755 32002 master.cpp:5194] Processing ACKNOWLEDGE call 33d722c2-f521-472b-add9-de5d9269e73e for task 30101fdc-66ec-4cb5-b333-dbfd199ace31 of framework 5e2449d9-ab5b-4f6e-8b3a-b37eebda5bd5-0000 (default) on agent 5e2449d9-ab5b-4f6e-8b3a-b37eebda5bd5-S1
I0523 08:48:24.016227 31998 status_update_manager.cpp:395] Received status update acknowledgement (UUID: 33d722c2-f521-472b-add9-de5d9269e73e) for task 30101fdc-66ec-4cb5-b333-dbfd199ace31 of framework 5e2449d9-ab5b-4f6e-8b3a-b37eebda5bd5-0000
I0523 08:48:24.016577 32004 slave.cpp:3508] Status update manager successfully handled status update acknowledgement (UUID: 33d722c2-f521-472b-add9-de5d9269e73e) for task 30101fdc-66ec-4cb5-b333-dbfd199ace31 of framework 5e2449d9-ab5b-4f6e-8b3a-b37eebda5bd5-0000
    @     0x7f5ce8f639df process::io::internal::read()
    @     0x7f5ce8f6402b process::io::read()
    @     0x7f5ce8fc498e process::network::internal::PollSocketImpl::recv()
    @     0x7f5ce9072b82 process::network::internal::SocketImpl::recv()
    @     0x7f5ce8f316ff process::network::internal::Socket<>::recv()
    @     0x7f5ce8f2d9fc process::http::internal::ConnectionProcess::read()
    @     0x7f5ce8f2e3e9 process::http::internal::ConnectionProcess::_read()
    @     0x7f5ce8f36b30 _ZZN7process8dispatchINS_4http8internal17ConnectionProcessERKNS_6FutureISsEES5_EEvRKNS_3PIDIT_EEMS9_FvT0_ET1_ENKUlPNS_11ProcessBaseEE_clESI_
    @     0x7f5ce8f40c24 _ZNSt17_Function_handlerIFvPN7process11ProcessBaseEEZNS0_8dispatchINS0_4http8internal17ConnectionProcessERKNS0_6FutureISsEES9_EEvRKNS0_3PIDIT_EEMSD_FvT0_ET1_EUlS2_E_E9_M_invokeERKSt9_Any_dataS2_
    @     0x7f5ce900813d std::function<>::operator()()
    @     0x7f5ce8fec037 process::ProcessBase::visit()
    @     0x7f5ce8ff7420 process::DispatchEvent::visit()
    @     0x7f5ceb28ef12 process::ProcessBase::serve()
    @     0x7f5ce8fe8063 process::ProcessManager::resume()
    @     0x7f5ce8fe4814 _ZZN7process14ProcessManager12init_threadsEvENKUt_clEv
    @     0x7f5ce8ff6a7e _ZNSt12_Bind_simpleIFZN7process14ProcessManager12init_threadsEvEUt_vEE9_M_invokeIIEEEvSt12_Index_tupleIIXspT_EEE
    @     0x7f5ce8ff69c2 _ZNSt12_Bind_simpleIFZN7process14ProcessManager12init_threadsEvEUt_vEEclEv
    @     0x7f5ce8ff694c _ZNSt6thread5_ImplISt12_Bind_simpleIFZN7process14ProcessManager12init_threadsEvEUt_vEEE6_M_runEv
    @     0x7f5ce2842230 (unknown)
make[4]: *** [check-local] Segmentation fault
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-1495526731-26923
Untagged: mesos-1495526731-26923:latest
Deleted: sha256:5e57ec539c2c9279c5f71d9baa896f703f9aea2f234840acead5e452ec35dfe9
Deleted: sha256:6036b84314b1b6a89503e42e453806594e68d6399e26d91ad4e03908f8f5d8c4
Deleted: sha256:1a3997fe3c030005013a5974492bb2d38914d384f6dd19bff1d6d18639a2804e
Deleted: sha256:921b770d175ccea4cc8262f26b5be014ab5325fe4df4f7c980f2fd147c493061
Deleted: sha256:f88216e475a7926ecdae0304d01a327f693b25ed584faf969ec3d1be80a1ecd2
Deleted: sha256:cedca7711718a147408adf05b44f54f6794154c2ea292a55e0f60327472ff2ea
Deleted: sha256:440417e6eb32c97d8012fd674e3f75e9f9e1a33172d6388fc638c5112a437b4d
Deleted: sha256:f500041109c543ad2f5466142e3ccd345d1d991f3b4809a84d2917f0048e30ff
Deleted: sha256:1827b22e13812576947ccc026d8e536836e1d35b6e2a4976ccb57966886563d2
Deleted: sha256:b403a90a17095aa0833ec7cb50cdc8e7a38b8f3503b978d9d2d6e42abba2f198
Deleted: sha256:d5d04d5a3aa5327c3bfdd73020f4909400b8c8bd8fbcbfa6634abd328375cc4a
Deleted: sha256:b943d61eb5401abcbf325a732e9da8c7ffd0c14178e3662f32918a1647763bdc
Deleted: sha256:79da85a10a700251bfbf31a422adb23029c529163c5e3e00a8580e85bacc4a5e
Deleted: sha256:579c8723c6ff69e231e9ddd6bd91a24b5268c59982e3c17f995015daddb4f49e
Deleted: sha256:949fed40eaa9f25671fc673fbd52ee6e8cd9a5a27bb0c0fdd0d1d947df30c799
Deleted: sha256:85dcc5e5a4a3d0a452a2b479b898a54c12415cc0cc1f0d053cbfec36a392c737
Deleted: sha256:cf88ba6ba3adb8a5f77a9c1213eda7c745ff2b0ab04d5cdb464764215f3f389b
Deleted: sha256:f77935d18404e400cbf16831a8af8f5228e8d7d7bf839d5b489cec9e92df2188
Deleted: sha256:00d567295a44bfe07b9a20904cc088e733a624c055e47798e93bf16a6e4e5a3c
Deleted: sha256:37c3e2d01a17f1617f35c297cad0139c98f8055267f6b9af5fd16c4ad9206bcc
Deleted: sha256:30f9b54ede3069b0611389d662480b1e87bb14c0a59431fd06881ab06547810d
Deleted: sha256:7ec28827b106bccdb21c86b0576c7eadb44a6c044824c8aa49703738351fb3dd
Deleted: sha256:bb2e00f1845e04590fe38b70167f1f4709a1a4d9e4c917ac51901908ca3c9520
Deleted: sha256:3bb97ee8756ace5bb64a2b8b2a3c603ae0d4fa0fd7c171804f5faa31799835f2
Deleted: sha256:ae914226108846ebbab4d295c4b44e085e7ceb3c4f8cd57016c18154d52b6119
Build step 'Execute shell' marked build as failure
Not sending mail to unregistered user xujyan@apple.com

Jenkins build is back to normal : Mesos-Buildbot » autotools,gcc,--verbose,GLOG_v=1 MESOS_VERBOSE=1,centos:7,(docker||Hadoop)&&(!ubuntu-us1)&&(!ubuntu-eu2) #3712

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=centos%3A7,label_exp=(docker%7C%7CHadoop)&&(!ubuntu-us1)&&(!ubuntu-eu2)/3712/display/redirect>


Build failed in Jenkins: Mesos-Buildbot » autotools,gcc,--verbose,GLOG_v=1 MESOS_VERBOSE=1,centos:7,(docker||Hadoop)&&(!ubuntu-us1)&&(!ubuntu-eu2) #3711

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=centos%3A7,label_exp=(docker%7C%7CHadoop)&&(!ubuntu-us1)&&(!ubuntu-eu2)/3711/display/redirect?page=changes>

Changes:

[xujyan] Removed an obsolete using declaration.

------------------------------------------
[...truncated 27.02 MB...]
[ RUN      ] Endpoint/SlaveEndpointTest.AuthorizedRequest/2
I0523 10:27:44.827913 31984 containerizer.cpp:230] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni,environment_secret
W0523 10:27:44.828419 31984 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0523 10:27:44.828529 31984 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0523 10:27:44.828570 31984 provisioner.cpp:249] Using default backend 'copy'
I0523 10:27:44.831770 32014 slave.cpp:225] Mesos agent started on (744)@172.17.0.2:44498
I0523 10:27:44.831961 32014 slave.cpp:226] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/mesos/store/appc" --authenticate_http_readonly="true" --authenticate_http_readwrite="true" --authenticatee="crammd5" --authentication_backoff_factor="1secs" --authorizer="local" --cgroups_cpu_enable_pids_and_tids_count="false" --cgroups_enable_cfs="false" --cgroups_hierarchy="/sys/fs/cgroup" --cgroups_limit_swap="false" --cgroups_root="mesos" --container_disk_watch_interval="15secs" --containerizers="mesos" --credential="/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_28DiHq/credential" --default_role="*" --disk_watch_interval="1mins" --docker="docker" --docker_kill_orphans="true" --docker_registry="https://registry-1.docker.io" --docker_remove_delay="6hrs" --docker_socket="/var/run/docker.sock" --docker_stop_timeout="0ns" --docker_store_dir="/tmp/mesos/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_28DiHq/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_28DiHq/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_28DiHq" --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_uUIOq0"
I0523 10:27:44.832458 32014 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_28DiHq/credential'
I0523 10:27:44.832708 32014 slave.cpp:258] Agent using credential for: test-principal
I0523 10:27:44.832734 32014 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_28DiHq/http_credentials'
I0523 10:27:44.833061 32014 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0523 10:27:44.833215 32014 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0523 10:27:44.835059 32014 slave.cpp:529] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0523 10:27:44.835170 32014 slave.cpp:537] Agent attributes: [  ]
I0523 10:27:44.835188 32014 slave.cpp:542] Agent hostname: 94a8843c5bf8
I0523 10:27:44.835386 32016 status_update_manager.cpp:177] Pausing sending status updates
I0523 10:27:44.837076 32011 state.cpp:62] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_uUIOq0/meta'
I0523 10:27:44.837453 32008 status_update_manager.cpp:203] Recovering status update manager
I0523 10:27:44.837692 32010 containerizer.cpp:627] Recovering containerizer
I0523 10:27:44.839253 32016 provisioner.cpp:410] Provisioner recovery complete
I0523 10:27:44.839658 32014 slave.cpp:5974] Finished recovery
I0523 10:27:44.840162 32014 slave.cpp:6156] Querying resource estimator for oversubscribable resources
I0523 10:27:44.840581 32003 slave.cpp:6170] Received oversubscribable resources {} from the resource estimator
I0523 10:27:44.843307 32014 process.cpp:3730] Handling HTTP event for process 'slave(744)' with path: '/slave(744)/containers'
I0523 10:27:44.844727 32016 http.cpp:1115] HTTP GET for /slave(744)/containers from 172.17.0.2:49943
I0523 10:27:44.844808 32016 http.cpp:936] Authorizing principal 'test-principal' to GET the '/containers' endpoint
I0523 10:27:44.848959 32015 slave.cpp:794] Agent terminating
[       OK ] Endpoint/SlaveEndpointTest.AuthorizedRequest/2 (31 ms)
[ RUN      ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/0
I0523 10:27:44.861781 31984 containerizer.cpp:230] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni,environment_secret
W0523 10:27:44.862571 31984 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0523 10:27:44.862700 31984 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0523 10:27:44.862748 31984 provisioner.cpp:249] Using default backend 'copy'
I0523 10:27:44.867481 32003 slave.cpp:225] Mesos agent started on (745)@172.17.0.2:44498
I0523 10:27:44.867506 32003 slave.cpp:226] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/mesos/store/appc" --authenticate_http_readonly="true" --authenticate_http_readwrite="true" --authenticatee="crammd5" --authentication_backoff_factor="1secs" --authorizer="local" --cgroups_cpu_enable_pids_and_tids_count="false" --cgroups_enable_cfs="false" --cgroups_hierarchy="/sys/fs/cgroup" --cgroups_limit_swap="false" --cgroups_root="mesos" --container_disk_watch_interval="15secs" --containerizers="mesos" --credential="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_iatW27/credential" --default_role="*" --disk_watch_interval="1mins" --docker="docker" --docker_kill_orphans="true" --docker_registry="https://registry-1.docker.io" --docker_remove_delay="6hrs" --docker_socket="/var/run/docker.sock" --docker_stop_timeout="0ns" --docker_store_dir="/tmp/mesos/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_iatW27/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_iatW27/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_iatW27" --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_eZm9GH"
I0523 10:27:44.867928 32003 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_iatW27/credential'
I0523 10:27:44.868116 32003 slave.cpp:258] Agent using credential for: test-principal
I0523 10:27:44.868139 32003 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_iatW27/http_credentials'
I0523 10:27:44.868378 32003 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0523 10:27:44.868546 32003 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0523 10:27:44.869854 32003 slave.cpp:529] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0523 10:27:44.869930 32003 slave.cpp:537] Agent attributes: [  ]
I0523 10:27:44.869942 32003 slave.cpp:542] Agent hostname: 94a8843c5bf8
I0523 10:27:44.870077 32015 status_update_manager.cpp:177] Pausing sending status updates
I0523 10:27:44.871587 32003 state.cpp:62] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_eZm9GH/meta'
I0523 10:27:44.871944 32016 status_update_manager.cpp:203] Recovering status update manager
I0523 10:27:44.872306 32014 containerizer.cpp:627] Recovering containerizer
I0523 10:27:44.873951 32008 provisioner.cpp:410] Provisioner recovery complete
I0523 10:27:44.874431 32009 slave.cpp:5974] Finished recovery
I0523 10:27:44.875166 32009 slave.cpp:6156] Querying resource estimator for oversubscribable resources
I0523 10:27:44.875458 32006 slave.cpp:6170] Received oversubscribable resources {} from the resource estimator
I0523 10:27:44.877919 32004 process.cpp:3730] Handling HTTP event for process 'slave(745)' with path: '/slave(745)/monitor/statistics'
I0523 10:27:44.879331 32013 http.cpp:1115] HTTP GET for /slave(745)/monitor/statistics from 172.17.0.2:49945
I0523 10:27:44.879434 32013 http.cpp:936] Authorizing principal 'test-principal' to GET the '/monitor/statistics' endpoint
I0523 10:27:44.881611 32006 slave.cpp:794] Agent terminating
[       OK ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/0 (31 ms)
[ RUN      ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/1
I0523 10:27:44.891361 31984 containerizer.cpp:230] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni,environment_secret
W0523 10:27:44.891815 31984 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0523 10:27:44.891913 31984 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0523 10:27:44.891952 31984 provisioner.cpp:249] Using default backend 'copy'
I0523 10:27:44.895109 32018 slave.cpp:225] Mesos agent started on (746)@172.17.0.2:44498
I0523 10:27:44.895187 32018 slave.cpp:226] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/mesos/store/appc" --authenticate_http_readonly="true" --authenticate_http_readwrite="true" --authenticatee="crammd5" --authentication_backoff_factor="1secs" --authorizer="local" --cgroups_cpu_enable_pids_and_tids_count="false" --cgroups_enable_cfs="false" --cgroups_hierarchy="/sys/fs/cgroup" --cgroups_limit_swap="false" --cgroups_root="mesos" --container_disk_watch_interval="15secs" --containerizers="mesos" --credential="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_RIPtJP/credential" --default_role="*" --disk_watch_interval="1mins" --docker="docker" --docker_kill_orphans="true" --docker_registry="https://registry-1.docker.io" --docker_remove_delay="6hrs" --docker_socket="/var/run/docker.sock" --docker_stop_timeout="0ns" --docker_store_dir="/tmp/mesos/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_RIPtJP/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_RIPtJP/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_RIPtJP" --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_paDGip"
I0523 10:27:44.895658 32018 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_RIPtJP/credential'
I0523 10:27:44.895923 32018 slave.cpp:258] Agent using credential for: test-principal
I0523 10:27:44.895948 32018 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_RIPtJP/http_credentials'
I0523 10:27:44.896246 32018 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0523 10:27:44.896488 32018 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0523 10:27:44.897871 32018 slave.cpp:529] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0523 10:27:44.897949 32018 slave.cpp:537] Agent attributes: [  ]
I0523 10:27:44.897972 32018 slave.cpp:542] Agent hostname: 94a8843c5bf8
I0523 10:27:44.898182 32007 status_update_manager.cpp:177] Pausing sending status updates
I0523 10:27:44.899760 32012 state.cpp:62] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_paDGip/meta'
I0523 10:27:44.900424 32012 status_update_manager.cpp:203] Recovering status update manager
I0523 10:27:44.900698 32003 containerizer.cpp:627] Recovering containerizer
I0523 10:27:44.903043 32004 provisioner.cpp:410] Provisioner recovery complete
I0523 10:27:44.903463 32006 slave.cpp:5974] Finished recovery
I0523 10:27:44.904039 32006 slave.cpp:6156] Querying resource estimator for oversubscribable resources
I0523 10:27:44.904444 32012 slave.cpp:6170] Received oversubscribable resources {} from the resource estimator
I0523 10:27:44.907064 32007 process.cpp:3730] Handling HTTP event for process 'slave(746)' with path: '/slave(746)/monitor/statistics.json'
I0523 10:27:44.908270 32004 http.cpp:1115] HTTP GET for /slave(746)/monitor/statistics.json from 172.17.0.2:49947
I0523 10:27:44.908355 32004 http.cpp:936] Authorizing principal 'test-principal' to GET the '/monitor/statistics.json' endpoint
I0523 10:27:44.910552 32011 slave.cpp:794] Agent terminating
[       OK ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/1 (29 ms)
[ RUN      ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/2
I0523 10:27:44.921267 31984 containerizer.cpp:230] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni,environment_secret
W0523 10:27:44.922024 31984 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0523 10:27:44.922248 31984 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0523 10:27:44.922365 31984 provisioner.cpp:249] Using default backend 'copy'
I0523 10:27:44.925828 32018 slave.cpp:225] Mesos agent started on (747)@172.17.0.2:44498
I0523 10:27:44.925961 32018 slave.cpp:226] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/mesos/store/appc" --authenticate_http_readonly="true" --authenticate_http_readwrite="true" --authenticatee="crammd5" --authentication_backoff_factor="1secs" --authorizer="local" --cgroups_cpu_enable_pids_and_tids_count="false" --cgroups_enable_cfs="false" --cgroups_hierarchy="/sys/fs/cgroup" --cgroups_limit_swap="false" --cgroups_root="mesos" --container_disk_watch_interval="15secs" --containerizers="mesos" --credential="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_RfS7Ix/credential" --default_role="*" --disk_watch_interval="1mins" --docker="docker" --docker_kill_orphans="true" --docker_registry="https://registry-1.docker.io" --docker_remove_delay="6hrs" --docker_socket="/var/run/docker.sock" --docker_stop_timeout="0ns" --docker_store_dir="/tmp/mesos/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_RfS7Ix/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_RfS7Ix/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_RfS7Ix" --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_08bwd7"
I0523 10:27:44.926357 32018 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_RfS7Ix/credential'
I0523 10:27:44.926605 32018 slave.cpp:258] Agent using credential for: test-principal
I0523 10:27:44.926689 32018 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_RfS7Ix/http_credentials'
I0523 10:27:44.927027 32018 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0523 10:27:44.927209 32018 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0523 10:27:44.928743 32018 slave.cpp:529] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0523 10:27:44.928818 32018 slave.cpp:537] Agent attributes: [  ]
I0523 10:27:44.928833 32018 slave.cpp:542] Agent hostname: 94a8843c5bf8
I0523 10:27:44.928984 32009 status_update_manager.cpp:177] Pausing sending status updates
I0523 10:27:44.930356 32012 state.cpp:62] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_08bwd7/meta'
I0523 10:27:44.930743 32015 status_update_manager.cpp:203] Recovering status update manager
I0523 10:27:44.930987 32004 containerizer.cpp:627] Recovering containerizer
I0523 10:27:44.932337 32014 provisioner.cpp:410] Provisioner recovery complete
I0523 10:27:44.932776 32007 slave.cpp:5974] Finished recovery
I0523 10:27:44.933351 32007 slave.cpp:6156] Querying resource estimator for oversubscribable resources
I0523 10:27:44.933823 32015 slave.cpp:6170] Received oversubscribable resources {} from the resource estimator
I0523 10:27:44.936820 32007 process.cpp:3730] Handling HTTP event for process 'slave(747)' with path: '/slave(747)/containers'
I0523 10:27:44.938381 32007 http.cpp:1115] HTTP GET for /slave(747)/containers from 172.17.0.2:49950
I0523 10:27:44.938459 32007 http.cpp:936] Authorizing principal 'test-principal' to GET the '/containers' endpoint
I0523 10:27:44.940943 32003 slave.cpp:794] Agent terminating
[       OK ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/2 (29 ms)
[ RUN      ] Endpoint/SlaveEndpointTest.NoAuthorizer/0
I0523 10:27:44.951561 31984 containerizer.cpp:230] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni,environment_secret
W0523 10:27:44.952047 31984 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0523 10:27:44.952154 31984 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0523 10:27:44.952195 31984 provisioner.cpp:249] Using default backend 'copy'
I0523 10:27:44.953853 31984 cluster.cpp:448] Creating default 'local' authorizer
I0523 10:27:44.955389 32006 slave.cpp:225] Mesos agent started on (748)@172.17.0.2:44498
I0523 10:27:44.955415 32006 slave.cpp:226] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/mesos/store/appc" --authenticate_http_readonly="true" --authenticate_http_readwrite="true" --authenticatee="crammd5" --authentication_backoff_factor="1secs" --authorizer="local" --cgroups_cpu_enable_pids_and_tids_count="false" --cgroups_enable_cfs="false" --cgroups_hierarchy="/sys/fs/cgroup" --cgroups_limit_swap="false" --cgroups_root="mesos" --container_disk_watch_interval="15secs" --containerizers="mesos" --credential="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_Jid41f/credential" --default_role="*" --disk_watch_interval="1mins" --docker="docker" --docker_kill_orphans="true" --docker_registry="https://registry-1.docker.io" --docker_remove_delay="6hrs" --docker_socket="/var/run/docker.sock" --docker_stop_timeout="0ns" --docker_store_dir="/tmp/mesos/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_Jid41f/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_Jid41f/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_Jid41f" --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_RJnCrP"
I0523 10:27:44.955956 32006 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_Jid41f/credential'
I0523 10:27:44.956174 32006 slave.cpp:258] Agent using credential for: test-principal
I0523 10:27:44.956202 32006 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_Jid41f/http_credentials'
I0523 10:27:44.956511 32006 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0523 10:27:44.956677 32006 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0523 10:27:44.958003 32006 slave.cpp:529] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0523 10:27:44.958077 32006 slave.cpp:537] Agent attributes: [  ]
I0523 10:27:44.958091 32006 slave.cpp:542] Agent hostname: 94a8843c5bf8
I0523 10:27:44.958271 32004 status_update_manager.cpp:177] Pausing sending status updates
I0523 10:27:44.959667 32010 state.cpp:62] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_RJnCrP/meta'
I0523 10:27:44.960093 32018 status_update_manager.cpp:203] Recovering status update manager
I0523 10:27:44.960307 32003 containerizer.cpp:627] Recovering containerizer
I0523 10:27:44.962011 32012 provisioner.cpp:410] Provisioner recovery complete
I0523 10:27:44.962364 32004 slave.cpp:5974] Finished recovery
I0523 10:27:44.963032 32004 slave.cpp:6156] Querying resource estimator for oversubscribable resources
I0523 10:27:44.963361 32014 slave.cpp:6170] Received oversubscribable resources {} from the resource estimator
I0523 10:27:44.965955 32011 process.cpp:3730] Handling HTTP event for process 'slave(748)' with path: '/slave(748)/monitor/statistics'
I0523 10:27:44.967464 32011 http.cpp:1115] HTTP GET for /slave(748)/monitor/statistics from 172.17.0.2:49953
I0523 10:27:44.967547 32011 http.cpp:936] Authorizing principal 'test-principal' to GET the '/monitor/statistics' endpoint
I0523 10:27:44.971109 32008 slave.cpp:794] Agent terminating
[       OK ] Endpoint/SlaveEndpointTest.NoAuthorizer/0 (31 ms)
[ RUN      ] Endpoint/SlaveEndpointTest.NoAuthorizer/1
I0523 10:27:44.982048 31984 containerizer.cpp:230] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni,environment_secret
W0523 10:27:44.982549 31984 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0523 10:27:44.982651 31984 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0523 10:27:44.982786 31984 provisioner.cpp:249] Using default backend 'copy'
I0523 10:27:44.984750 31984 cluster.cpp:448] Creating default 'local' authorizer
I0523 10:27:44.986856 32010 slave.cpp:225] Mesos agent started on (749)@172.17.0.2:44498
I0523 10:27:44.987152 32010 slave.cpp:226] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/mesos/store/appc" --authenticate_http_readonly="true" --authenticate_http_readwrite="true" --authenticatee="crammd5" --authentication_backoff_factor="1secs" --authorizer="local" --cgroups_cpu_enable_pids_and_tids_count="false" --cgroups_enable_cfs="false" --cgroups_hierarchy="/sys/fs/cgroup" --cgroups_limit_swap="false" --cgroups_root="mesos" --container_disk_watch_interval="15secs" --containerizers="mesos" --credential="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_egGUEY/credential" --default_role="*" --disk_watch_interval="1mins" --docker="docker" --docker_kill_orphans="true" --docker_registry="https://registry-1.docker.io" --docker_remove_delay="6hrs" --docker_socket="/var/run/docker.sock" --docker_stop_timeout="0ns" --docker_store_dir="/tmp/mesos/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_egGUEY/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_egGUEY/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_egGUEY" --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_q7zrZx"
I0523 10:27:44.987824 32010 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_egGUEY/credential'
I0523 10:27:44.988168 32010 slave.cpp:258] Agent using credential for: test-principal
I0523 10:27:44.988193 32010 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_egGUEY/http_credentials'
I0523 10:27:44.988513 32010 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0523 10:27:44.988816 32010 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0523 10:27:44.990337 32010 slave.cpp:529] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0523 10:27:44.990416 32010 slave.cpp:537] Agent attributes: [  ]
I0523 10:27:44.990468 32010 slave.cpp:542] Agent hostname: 94a8843c5bf8
I0523 10:27:44.990653 32005 status_update_manager.cpp:177] Pausing sending status updates
I0523 10:27:44.992244 32009 state.cpp:62] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_q7zrZx/meta'
I0523 10:27:44.992763 32013 status_update_manager.cpp:203] Recovering status update manager
I0523 10:27:44.992967 32006 containerizer.cpp:627] Recovering containerizer
I0523 10:27:44.994827 32008 provisioner.cpp:410] Provisioner recovery complete
I0523 10:27:44.995270 32005 slave.cpp:5974] Finished recovery
I0523 10:27:44.995918 32005 slave.cpp:6156] Querying resource estimator for oversubscribable resources
I0523 10:27:44.996330 32006 slave.cpp:6170] Received oversubscribable resources {} from the resource estimator
I0523 10:27:44.998965 32013 process.cpp:3730] Handling HTTP event for process 'slave(749)' with path: '/slave(749)/monitor/statistics.json'
I0523 10:27:45.000201 32003 http.cpp:1115] HTTP GET for /slave(749)/monitor/statistics.json from 172.17.0.2:49955
I0523 10:27:45.000288 32003 http.cpp:936] Authorizing principal 'test-principal' to GET the '/monitor/statistics.json' endpoint
I0523 10:27:45.003579 32015 slave.cpp:794] Agent terminating
[       OK ] Endpoint/SlaveEndpointTest.NoAuthorizer/1 (31 ms)
[ RUN      ] Endpoint/SlaveEndpointTest.NoAuthorizer/2
I0523 10:27:45.013255 31984 containerizer.cpp:230] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni,environment_secret
W0523 10:27:45.013768 31984 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0523 10:27:45.013880 31984 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0523 10:27:45.013942 31984 provisioner.cpp:249] Using default backend 'copy'
I0523 10:27:45.015831 31984 cluster.cpp:448] Creating default 'local' authorizer
I0523 10:27:45.017407 32018 slave.cpp:225] Mesos agent started on (750)@172.17.0.2:44498
I0523 10:27:45.017475 32018 slave.cpp:226] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/mesos/store/appc" --authenticate_http_readonly="true" --authenticate_http_readwrite="true" --authenticatee="crammd5" --authentication_backoff_factor="1secs" --authorizer="local" --cgroups_cpu_enable_pids_and_tids_count="false" --cgroups_enable_cfs="false" --cgroups_hierarchy="/sys/fs/cgroup" --cgroups_limit_swap="false" --cgroups_root="mesos" --container_disk_watch_interval="15secs" --containerizers="mesos" --credential="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_g4BiCH/credential" --default_role="*" --disk_watch_interval="1mins" --docker="docker" --docker_kill_orphans="true" --docker_registry="https://registry-1.docker.io" --docker_remove_delay="6hrs" --docker_socket="/var/run/docker.sock" --docker_stop_timeout="0ns" --docker_store_dir="/tmp/mesos/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_g4BiCH/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_g4BiCH/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_g4BiCH" --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_i83KRg"
I0523 10:27:45.018281 32018 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_g4BiCH/credential'
I0523 10:27:45.018643 32018 slave.cpp:258] Agent using credential for: test-principal
I0523 10:27:45.018674 32018 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_g4BiCH/http_credentials'
I0523 10:27:45.019032 32018 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0523 10:27:45.019260 32018 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0523 10:27:45.021613 32018 slave.cpp:529] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0523 10:27:45.021747 32018 slave.cpp:537] Agent attributes: [  ]
I0523 10:27:45.021773 32018 slave.cpp:542] Agent hostname: 94a8843c5bf8
I0523 10:27:45.022001 32008 status_update_manager.cpp:177] Pausing sending status updates
I0523 10:27:45.023766 32003 state.cpp:62] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_i83KRg/meta'
I0523 10:27:45.024112 32018 status_update_manager.cpp:203] Recovering status update manager
I0523 10:27:45.024333 32017 containerizer.cpp:627] Recovering containerizer
I0523 10:27:45.026057 32016 provisioner.cpp:410] Provisioner recovery complete
I0523 10:27:45.026528 32006 slave.cpp:5974] Finished recovery
I0523 10:27:45.027194 32006 slave.cpp:6156] Querying resource estimator for oversubscribable resources
I0523 10:27:45.027470 32003 slave.cpp:6170] Received oversubscribable resources {} from the resource estimator
I0523 10:27:45.030036 32014 process.cpp:3730] Handling HTTP event for process 'slave(750)' with path: '/slave(750)/containers'
I0523 10:27:45.031301 32017 http.cpp:1115] HTTP GET for /slave(750)/containers from 172.17.0.2:49958
I0523 10:27:45.031368 32017 http.cpp:936] Authorizing principal 'test-principal' to GET the '/containers' endpoint
I0523 10:27:45.035079 32003 slave.cpp:794] Agent terminating
[       OK ] Endpoint/SlaveEndpointTest.NoAuthorizer/2 (32 ms)
[----------] 9 tests from Endpoint/SlaveEndpointTest (280 ms total)

[----------] Global test environment tear-down
[==========] 1569 tests from 175 test cases ran. (461755 ms total)
[  PASSED  ] 1568 tests.
[  FAILED  ] 1 test, listed below:
[  FAILED  ] ContentType/AgentAPITest.GetContainers/1, where GetParam() = application/json

 1 FAILED TEST
  YOU HAVE 22 DISABLED TESTS

E0523 10:27:45.108575 32019 process.cpp:950] 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-1495532764-24574
Untagged: mesos-1495532764-24574:latest
Deleted: sha256:797324573d94f9d21f248bda9c37d035837680fa29a1d29ef0f6796997b91151
Deleted: sha256:5907c110273907e7e6d1077369779cbc313d0e02582a15784cd2def23346afeb
Deleted: sha256:2b03b87bc2447e083e9e925ac06f7601e38a64ac0b1c24ae9101dc07da2cf971
Deleted: sha256:84e86b0399a6faabcf25e7b20e5325ad74ca487e33c97749271ab6af86b1080d
Deleted: sha256:4622d2904b87708e0a5ef85de627ae07b70491541a6085b2e1c6daef69b38800
Deleted: sha256:ec120a71e58a32ad08ef0b27881d2f7effd347eb01ee550e7837011d7801649c
Deleted: sha256:25cb731ab9c27343a8e6bf2fd0dc56fca44bb20e548563b8eb227e644c1c1da3
Deleted: sha256:652506999676b4b9dae8bcfaff0ba7ef7578934e9be37a220b7d64166d987e59
Deleted: sha256:d036803de936297ca2ec13895b4c351b8f9c98b72aa70cdc36399106e64b2da1
Deleted: sha256:597af4973ac3e786c275c26b2a81c9c94a0a684f0c8c4b73e16128c0b76891e0
Deleted: sha256:ad785ea58bc5ae6ffe2c219f378dec1dc5273bb38594f21f6c25092db79d0dc4
Deleted: sha256:6a3e9172c9ce7e30406bd10084e8128ff6e125dab3f2a414a77952c9e599e93d
Deleted: sha256:7cf3bca021a5af4cffac7192404ac19561703f7c407d7164ddbfa771558c129d
Deleted: sha256:76e04aa2f8ad1e3ff53082213bbbd903f1724ae2918b1776f39850ebb11fcbd7
Deleted: sha256:c75e45df35657b0447e64b69148569e5f7b450bc4db34d2222900a96a5512741
Deleted: sha256:f3931df8fe6819ea489696e5282b3222510012439d96e734998414776e0c03c5
Deleted: sha256:1af2985f750276cf331142f6c56ccdfae3a565539398ae67373d789e604bb82d
Deleted: sha256:ef2bacea1f4713e97b8fb4b4b2507270d27bdb830faedd4a8dc38fcdbbbc1ce7
Deleted: sha256:4d957f0037762e307f1c2a279251904e96df8b68fda34681adea2a91a7497cb1
Deleted: sha256:bf43a42a454f6cc0a144944c919528baac953f7c8bffe19f8b6b3be6ddfe629d
Deleted: sha256:0d899b06bcd64e5b16dd1cbdc8f1afd19a5a4bf5dbc20a33e08bcd2fd332352a
Deleted: sha256:c4494ece85576baad589307be1b103bc306627c1bce67c2e4c66ab05e6a1eb21
Deleted: sha256:01c752fcd541d6239bb83395c4f138a69c3b8fab58dfb758b9f7bbef4af71d7e
Deleted: sha256:2414638df34705bcfdd14d450d0788cabc6a2e003785bce481f69fd20eab2e3a
Deleted: sha256:480bbf88eecd2080a2f252504494f086d64f34d04aa505cf96c650db6a5d42a5
Build step 'Execute shell' marked build as failure
Not sending mail to unregistered user xujyan@apple.com