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 2016/03/26 14:50:14 UTC

Build failed in Jenkins: Mesos » clang,--verbose,GLOG_v=1 MESOS_VERBOSE=1,ubuntu:14.04,(docker||Hadoop)&&(!ubuntu-us1) #1879

See <https://builds.apache.org/job/Mesos/COMPILER=clang,CONFIGURATION=--verbose,ENVIRONMENT=GLOG_v=1%20MESOS_VERBOSE=1,OS=ubuntu%3A14.04,label_exp=(docker%7C%7CHadoop)&&(!ubuntu-us1)/1879/changes>

Changes:

[joris.van.remoortere] Refactored Error behavior of 'extendLifetime' parentHook.

[joris.van.remoortere] Changed subprocess comment to reflect Error handling of parent Hooks.

[joris.van.remoortere] LinuxLauncher: Used `parentHook` to implement freezer assignment.

[joris.van.remoortere] Docker Containerizer: Used `parentHook` to implement checkpointing.

------------------------------------------
[...truncated 178545 lines...]
I0326 13:50:16.857229 32309 master.cpp:378] Flags at startup: --acls="" --allocation_interval="1secs" --allocator="HierarchicalDRF" --authenticate="false" --authenticate_http="true" --authenticate_slaves="true" --authenticators="crammd5" --authorizers="local" --credentials="/tmp/h4I6Yn/credentials" --framework_sorter="drf" --help="false" --hostname_lookup="true" --http_authenticators="basic" --initialize_driver_logging="true" --log_auto_initialize="true" --logbufsecs="0" --logging_level="INFO" --max_completed_frameworks="50" --max_completed_tasks_per_framework="1000" --max_slave_ping_timeouts="5" --quiet="false" --recovery_slave_removal_limit="100%" --registry="replicated_log" --registry_fetch_timeout="1mins" --registry_store_timeout="100secs" --registry_strict="true" --root_submissions="true" --slave_ping_timeout="15secs" --slave_reregister_timeout="10mins" --user_sorter="drf" --version="false" --webui_dir="/mesos/mesos-0.29.0/_inst/share/mesos/webui" --work_dir="/tmp/h4I6Yn/master" --zk_session_timeout="10secs"
I0326 13:50:16.857610 32309 master.cpp:429] Master allowing unauthenticated frameworks to register
I0326 13:50:16.857622 32309 master.cpp:432] Master only allowing authenticated slaves to register
I0326 13:50:16.857632 32309 credentials.hpp:35] Loading credentials for authentication from '/tmp/h4I6Yn/credentials'
I0326 13:50:16.857987 32309 master.cpp:474] Using default 'crammd5' authenticator
I0326 13:50:16.858108 32309 master.cpp:545] Using default 'basic' HTTP authenticator
I0326 13:50:16.858237 32309 master.cpp:583] Authorization enabled
I0326 13:50:16.859235 32301 whitelist_watcher.cpp:77] No whitelist given
I0326 13:50:16.859799 32300 hierarchical.cpp:144] Initialized hierarchical allocator process
I0326 13:50:16.861225 32309 master.cpp:1826] The newly elected leader is master@172.17.0.2:41873 with id 65683e5e-e110-49e5-8acc-ec3232b56efd
I0326 13:50:16.861263 32309 master.cpp:1839] Elected as the leading master!
I0326 13:50:16.861297 32309 master.cpp:1526] Recovering from registrar
I0326 13:50:16.861449 32312 registrar.cpp:307] Recovering registrar
I0326 13:50:16.892894 32303 leveldb.cpp:304] Persisting metadata (8 bytes) to leveldb took 37.489092ms
I0326 13:50:16.892935 32303 replica.cpp:320] Persisted replica status to STARTING
I0326 13:50:16.893183 32313 recover.cpp:473] Replica is in STARTING status
I0326 13:50:16.894268 32313 replica.cpp:673] Replica in STARTING status received a broadcasted recover request from (16426)@172.17.0.2:41873
I0326 13:50:16.894553 32301 recover.cpp:193] Received a recover response from a replica in STARTING status
I0326 13:50:16.895097 32301 recover.cpp:564] Updating replica status to VOTING
I0326 13:50:16.927822 32301 leveldb.cpp:304] Persisting metadata (8 bytes) to leveldb took 32.499397ms
I0326 13:50:16.927875 32301 replica.cpp:320] Persisted replica status to VOTING
I0326 13:50:16.928030 32301 recover.cpp:578] Successfully joined the Paxos group
I0326 13:50:16.928259 32301 recover.cpp:462] Recover process terminated
I0326 13:50:16.928922 32301 log.cpp:659] Attempting to start the writer
I0326 13:50:16.930593 32302 replica.cpp:493] Replica received implicit promise request from (16427)@172.17.0.2:41873 with proposal 1
I0326 13:50:16.961266 32302 leveldb.cpp:304] Persisting metadata (8 bytes) to leveldb took 30.656863ms
I0326 13:50:16.961328 32302 replica.cpp:342] Persisted promised to 1
I0326 13:50:16.962427 32305 coordinator.cpp:238] Coordinator attempting to fill missing positions
I0326 13:50:16.963768 32304 replica.cpp:388] Replica received explicit promise request from (16428)@172.17.0.2:41873 for position 0 with proposal 2
I0326 13:50:16.994696 32304 leveldb.cpp:341] Persisting action (8 bytes) to leveldb took 30.894753ms
I0326 13:50:16.994741 32304 replica.cpp:712] Persisted action at 0
I0326 13:50:16.996183 32304 replica.cpp:537] Replica received write request for position 0 from (16429)@172.17.0.2:41873
I0326 13:50:16.996260 32304 leveldb.cpp:436] Reading position from leveldb took 51393ns
I0326 13:50:17.028156 32304 leveldb.cpp:341] Persisting action (14 bytes) to leveldb took 31.861479ms
I0326 13:50:17.028204 32304 replica.cpp:712] Persisted action at 0
I0326 13:50:17.029068 32304 replica.cpp:691] Replica received learned notice for position 0 from @0.0.0.0:0
I0326 13:50:17.059358 32304 leveldb.cpp:341] Persisting action (16 bytes) to leveldb took 30.278329ms
I0326 13:50:17.059402 32304 replica.cpp:712] Persisted action at 0
I0326 13:50:17.059427 32304 replica.cpp:697] Replica learned NOP action at position 0
I0326 13:50:17.060314 32312 log.cpp:675] Writer started with ending position 0
I0326 13:50:17.061666 32315 leveldb.cpp:436] Reading position from leveldb took 59692ns
I0326 13:50:17.062978 32315 registrar.cpp:340] Successfully fetched the registry (0B) in 201.48608ms
I0326 13:50:17.063120 32315 registrar.cpp:439] Applied 1 operations in 57805ns; attempting to update the 'registry'
I0326 13:50:17.063896 32307 log.cpp:683] Attempting to append 170 bytes to the log
I0326 13:50:17.064157 32307 coordinator.cpp:348] Coordinator attempting to write APPEND action at position 1
I0326 13:50:17.065182 32307 replica.cpp:537] Replica received write request for position 1 from (16430)@172.17.0.2:41873
I0326 13:50:17.092802 32307 leveldb.cpp:341] Persisting action (189 bytes) to leveldb took 27.591859ms
I0326 13:50:17.092842 32307 replica.cpp:712] Persisted action at 1
I0326 13:50:17.093775 32304 replica.cpp:691] Replica received learned notice for position 1 from @0.0.0.0:0
I0326 13:50:17.117945 32304 leveldb.cpp:341] Persisting action (191 bytes) to leveldb took 24.155605ms
I0326 13:50:17.117985 32304 replica.cpp:712] Persisted action at 1
I0326 13:50:17.118010 32304 replica.cpp:697] Replica learned APPEND action at position 1
I0326 13:50:17.119458 32302 registrar.cpp:484] Successfully updated the 'registry' in 56.250112ms
I0326 13:50:17.119609 32302 registrar.cpp:370] Successfully recovered registrar
I0326 13:50:17.119747 32308 log.cpp:702] Attempting to truncate the log to 1
I0326 13:50:17.119916 32302 coordinator.cpp:348] Coordinator attempting to write TRUNCATE action at position 2
I0326 13:50:17.120095 32308 master.cpp:1634] Recovered 0 slaves from the Registry (131B) ; allowing 10mins for slaves to re-register
I0326 13:50:17.120245 32302 hierarchical.cpp:171] Skipping recovery of hierarchical allocator: nothing to recover
I0326 13:50:17.121345 32301 replica.cpp:537] Replica received write request for position 2 from (16431)@172.17.0.2:41873
I0326 13:50:17.143074 32301 leveldb.cpp:341] Persisting action (16 bytes) to leveldb took 21.678609ms
I0326 13:50:17.143116 32301 replica.cpp:712] Persisted action at 2
I0326 13:50:17.144202 32301 replica.cpp:691] Replica received learned notice for position 2 from @0.0.0.0:0
I0326 13:50:17.168193 32301 leveldb.cpp:341] Persisting action (18 bytes) to leveldb took 23.979343ms
I0326 13:50:17.168267 32301 leveldb.cpp:399] Deleting ~1 keys from leveldb took 48794ns
I0326 13:50:17.168289 32301 replica.cpp:712] Persisted action at 2
I0326 13:50:17.168313 32301 replica.cpp:697] Replica learned TRUNCATE action at position 2
I0326 13:50:17.171818 32282 scheduler.cpp:172] Version: 0.29.0
I0326 13:50:17.172440 32305 scheduler.cpp:438] New master detected at master@172.17.0.2:41873
I0326 13:50:17.174156 32301 scheduler.cpp:338] Connected with the master at http://172.17.0.2:41873/master/api/v1/scheduler
I0326 13:50:17.175564 32311 scheduler.cpp:231] Sending SUBSCRIBE call to http://172.17.0.2:41873/master/api/v1/scheduler
I0326 13:50:17.176645 32311 process.cpp:3136] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I0326 13:50:17.177145 32311 http.cpp:313] HTTP POST for /master/api/v1/scheduler from 172.17.0.2:55617
I0326 13:50:17.177355 32311 master.cpp:2088] Received subscription request for HTTP framework 'default'
I0326 13:50:17.177379 32311 master.cpp:1865] Authorizing framework principal 'test-principal' to receive offers for role '*'
I0326 13:50:17.177641 32311 master.cpp:2179] Subscribing framework 'default' with checkpointing disabled and capabilities [  ]
I0326 13:50:17.178107 32310 master.hpp:1715] Sending heartbeat to 65683e5e-e110-49e5-8acc-ec3232b56efd-0000
I0326 13:50:17.178117 32305 hierarchical.cpp:266] Added framework 65683e5e-e110-49e5-8acc-ec3232b56efd-0000
I0326 13:50:17.178210 32305 hierarchical.cpp:1490] No resources available to allocate!
I0326 13:50:17.178244 32305 hierarchical.cpp:1585] No inverse offers to send out!
I0326 13:50:17.178298 32305 hierarchical.cpp:1141] Performed allocation for 0 slaves in 160834ns
I0326 13:50:17.179335 32311 scheduler.cpp:629] Enqueuing event SUBSCRIBED received from http://172.17.0.2:41873/master/api/v1/scheduler
I0326 13:50:17.179699 32311 scheduler.cpp:629] Enqueuing event HEARTBEAT received from http://172.17.0.2:41873/master/api/v1/scheduler
I0326 13:50:17.180519 32305 scheduler.cpp:231] Sending REQUEST call to http://172.17.0.2:41873/master/api/v1/scheduler
I0326 13:50:17.181803 32305 process.cpp:3136] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I0326 13:50:17.182420 32314 http.cpp:313] HTTP POST for /master/api/v1/scheduler from 172.17.0.2:55618
I0326 13:50:17.182633 32314 master.cpp:2785] Processing REQUEST call for framework 65683e5e-e110-49e5-8acc-ec3232b56efd-0000 (default)
I0326 13:50:17.182781 32310 hierarchical.cpp:592] Received resource request from framework 65683e5e-e110-49e5-8acc-ec3232b56efd-0000
I0326 13:50:17.185447 32314 master.cpp:1269] Framework 65683e5e-e110-49e5-8acc-ec3232b56efd-0000 (default) disconnected
I0326 13:50:17.185472 32314 master.cpp:2642] Disconnecting framework 65683e5e-e110-49e5-8acc-ec3232b56efd-0000 (default)
I0326 13:50:17.185494 32314 master.cpp:2666] Deactivating framework 65683e5e-e110-49e5-8acc-ec3232b56efd-0000 (default)
I0326 13:50:17.185668 32314 master.cpp:1293] Giving framework 65683e5e-e110-49e5-8acc-ec3232b56efd-0000 (default) 0ns to failover
I0326 13:50:17.185788 32308 hierarchical.cpp:378] Deactivated framework 65683e5e-e110-49e5-8acc-ec3232b56efd-0000
I0326 13:50:17.187024 32309 master.cpp:5360] Framework failover timeout, removing framework 65683e5e-e110-49e5-8acc-ec3232b56efd-0000 (default)
I0326 13:50:17.187137 32309 master.cpp:6093] Removing framework 65683e5e-e110-49e5-8acc-ec3232b56efd-0000 (default)
I0326 13:50:17.187487 32309 hierarchical.cpp:329] Removed framework 65683e5e-e110-49e5-8acc-ec3232b56efd-0000
I0326 13:50:17.195101 32282 master.cpp:1083] Master terminating
[       OK ] ContentType/SchedulerTest.Request/0 (484 ms)
[ RUN      ] ContentType/SchedulerTest.Request/1
I0326 13:50:17.204447 32282 cluster.cpp:139] Creating default 'local' authorizer
I0326 13:50:17.278509 32282 leveldb.cpp:174] Opened db in 73.823991ms
I0326 13:50:17.320498 32282 leveldb.cpp:181] Compacted db in 41.960852ms
I0326 13:50:17.320556 32282 leveldb.cpp:196] Created db iterator in 31629ns
I0326 13:50:17.320579 32282 leveldb.cpp:202] Seeked to beginning of db in 9594ns
I0326 13:50:17.320591 32282 leveldb.cpp:271] Iterated through 0 keys in the db in 7006ns
I0326 13:50:17.320641 32282 replica.cpp:779] Replica recovered with log positions 0 -> 0 with 1 holes and 0 unlearned
I0326 13:50:17.321427 32315 recover.cpp:447] Starting replica recovery
I0326 13:50:17.321882 32315 recover.cpp:473] Replica is in EMPTY status
I0326 13:50:17.323390 32315 replica.cpp:673] Replica in EMPTY status received a broadcasted recover request from (16439)@172.17.0.2:41873
I0326 13:50:17.323845 32315 recover.cpp:193] Received a recover response from a replica in EMPTY status
I0326 13:50:17.324337 32312 recover.cpp:564] Updating replica status to STARTING
I0326 13:50:17.324919 32309 master.cpp:376] Master eef2acb1-f6a8-4281-a759-f3cc9b22a9fc (ced1f61d7531) started on 172.17.0.2:41873
I0326 13:50:17.324954 32309 master.cpp:378] Flags at startup: --acls="" --allocation_interval="1secs" --allocator="HierarchicalDRF" --authenticate="false" --authenticate_http="true" --authenticate_slaves="true" --authenticators="crammd5" --authorizers="local" --credentials="/tmp/wiDCNh/credentials" --framework_sorter="drf" --help="false" --hostname_lookup="true" --http_authenticators="basic" --initialize_driver_logging="true" --log_auto_initialize="true" --logbufsecs="0" --logging_level="INFO" --max_completed_frameworks="50" --max_completed_tasks_per_framework="1000" --max_slave_ping_timeouts="5" --quiet="false" --recovery_slave_removal_limit="100%" --registry="replicated_log" --registry_fetch_timeout="1mins" --registry_store_timeout="100secs" --registry_strict="true" --root_submissions="true" --slave_ping_timeout="15secs" --slave_reregister_timeout="10mins" --user_sorter="drf" --version="false" --webui_dir="/mesos/mesos-0.29.0/_inst/share/mesos/webui" --work_dir="/tmp/wiDCNh/master" --zk_session_timeout="10secs"
I0326 13:50:17.325309 32309 master.cpp:429] Master allowing unauthenticated frameworks to register
I0326 13:50:17.325322 32309 master.cpp:432] Master only allowing authenticated slaves to register
I0326 13:50:17.325333 32309 credentials.hpp:35] Loading credentials for authentication from '/tmp/wiDCNh/credentials'
I0326 13:50:17.325670 32309 master.cpp:474] Using default 'crammd5' authenticator
I0326 13:50:17.325800 32309 master.cpp:545] Using default 'basic' HTTP authenticator
I0326 13:50:17.326073 32309 master.cpp:583] Authorization enabled
I0326 13:50:17.326334 32306 hierarchical.cpp:144] Initialized hierarchical allocator process
I0326 13:50:17.326395 32308 whitelist_watcher.cpp:77] No whitelist given
I0326 13:50:17.329522 32309 master.cpp:1826] The newly elected leader is master@172.17.0.2:41873 with id eef2acb1-f6a8-4281-a759-f3cc9b22a9fc
I0326 13:50:17.329562 32309 master.cpp:1839] Elected as the leading master!
I0326 13:50:17.329577 32309 master.cpp:1526] Recovering from registrar
I0326 13:50:17.329903 32309 registrar.cpp:307] Recovering registrar
I0326 13:50:17.354051 32310 leveldb.cpp:304] Persisting metadata (8 bytes) to leveldb took 29.415945ms
I0326 13:50:17.354094 32310 replica.cpp:320] Persisted replica status to STARTING
I0326 13:50:17.354344 32314 recover.cpp:473] Replica is in STARTING status
I0326 13:50:17.356029 32314 replica.cpp:673] Replica in STARTING status received a broadcasted recover request from (16441)@172.17.0.2:41873
I0326 13:50:17.356287 32315 recover.cpp:193] Received a recover response from a replica in STARTING status
I0326 13:50:17.356663 32314 recover.cpp:564] Updating replica status to VOTING
I0326 13:50:17.396167 32315 leveldb.cpp:304] Persisting metadata (8 bytes) to leveldb took 39.278952ms
I0326 13:50:17.396222 32315 replica.cpp:320] Persisted replica status to VOTING
I0326 13:50:17.396387 32315 recover.cpp:578] Successfully joined the Paxos group
I0326 13:50:17.396561 32315 recover.cpp:462] Recover process terminated
I0326 13:50:17.397248 32315 log.cpp:659] Attempting to start the writer
I0326 13:50:17.398430 32315 replica.cpp:493] Replica received implicit promise request from (16442)@172.17.0.2:41873 with proposal 1
I0326 13:50:17.429596 32315 leveldb.cpp:304] Persisting metadata (8 bytes) to leveldb took 31.152847ms
I0326 13:50:17.429648 32315 replica.cpp:342] Persisted promised to 1
I0326 13:50:17.430922 32304 coordinator.cpp:238] Coordinator attempting to fill missing positions
I0326 13:50:17.432260 32304 replica.cpp:388] Replica received explicit promise request from (16443)@172.17.0.2:41873 for position 0 with proposal 2
I0326 13:50:17.463032 32304 leveldb.cpp:341] Persisting action (8 bytes) to leveldb took 30.741266ms
I0326 13:50:17.463073 32304 replica.cpp:712] Persisted action at 0
I0326 13:50:17.464073 32304 replica.cpp:537] Replica received write request for position 0 from (16444)@172.17.0.2:41873
I0326 13:50:17.464145 32304 leveldb.cpp:436] Reading position from leveldb took 50355ns
I0326 13:50:17.496475 32304 leveldb.cpp:341] Persisting action (14 bytes) to leveldb took 32.294996ms
I0326 13:50:17.496512 32304 replica.cpp:712] Persisted action at 0
I0326 13:50:17.497262 32304 replica.cpp:691] Replica received learned notice for position 0 from @0.0.0.0:0
I0326 13:50:17.529925 32304 leveldb.cpp:341] Persisting action (16 bytes) to leveldb took 32.652322ms
I0326 13:50:17.529961 32304 replica.cpp:712] Persisted action at 0
I0326 13:50:17.529983 32304 replica.cpp:697] Replica learned NOP action at position 0
I0326 13:50:17.530886 32304 log.cpp:675] Writer started with ending position 0
I0326 13:50:17.532163 32313 leveldb.cpp:436] Reading position from leveldb took 56631ns
I0326 13:50:17.533300 32313 registrar.cpp:340] Successfully fetched the registry (0B) in 203360us
I0326 13:50:17.533445 32313 registrar.cpp:439] Applied 1 operations in 42995ns; attempting to update the 'registry'
I0326 13:50:17.534404 32310 log.cpp:683] Attempting to append 170 bytes to the log
I0326 13:50:17.534548 32311 coordinator.cpp:348] Coordinator attempting to write APPEND action at position 1
I0326 13:50:17.535468 32305 replica.cpp:537] Replica received write request for position 1 from (16445)@172.17.0.2:41873
I0326 13:50:17.568631 32305 leveldb.cpp:341] Persisting action (189 bytes) to leveldb took 33.136494ms
I0326 13:50:17.568688 32305 replica.cpp:712] Persisted action at 1
I0326 13:50:17.569777 32311 replica.cpp:691] Replica received learned notice for position 1 from @0.0.0.0:0
I0326 13:50:17.594704 32311 leveldb.cpp:341] Persisting action (191 bytes) to leveldb took 24.916972ms
I0326 13:50:17.594779 32311 replica.cpp:712] Persisted action at 1
I0326 13:50:17.594811 32311 replica.cpp:697] Replica learned APPEND action at position 1
I0326 13:50:17.596472 32306 registrar.cpp:484] Successfully updated the 'registry' in 62.961664ms
I0326 13:50:17.596607 32306 registrar.cpp:370] Successfully recovered registrar
I0326 13:50:17.596853 32306 log.cpp:702] Attempting to truncate the log to 1
I0326 13:50:17.597246 32306 master.cpp:1634] Recovered 0 slaves from the Registry (131B) ; allowing 10mins for slaves to re-register
I0326 13:50:17.597339 32306 coordinator.cpp:348] Coordinator attempting to write TRUNCATE action at position 2
I0326 13:50:17.597707 32306 hierarchical.cpp:171] Skipping recovery of hierarchical allocator: nothing to recover
I0326 13:50:17.598563 32306 replica.cpp:537] Replica received write request for position 2 from (16446)@172.17.0.2:41873
I0326 13:50:17.619781 32306 leveldb.cpp:341] Persisting action (16 bytes) to leveldb took 21.192024ms
I0326 13:50:17.619818 32306 replica.cpp:712] Persisted action at 2
I0326 13:50:17.620718 32303 replica.cpp:691] Replica received learned notice for position 2 from @0.0.0.0:0
I0326 13:50:17.644912 32303 leveldb.cpp:341] Persisting action (18 bytes) to leveldb took 24.15566ms
I0326 13:50:17.645022 32303 leveldb.cpp:399] Deleting ~1 keys from leveldb took 65130ns
I0326 13:50:17.645050 32303 replica.cpp:712] Persisted action at 2
I0326 13:50:17.645082 32303 replica.cpp:697] Replica learned TRUNCATE action at position 2
I0326 13:50:17.649147 32282 scheduler.cpp:172] Version: 0.29.0
I0326 13:50:17.649852 32303 scheduler.cpp:438] New master detected at master@172.17.0.2:41873
I0326 13:50:17.652220 32315 scheduler.cpp:338] Connected with the master at http://172.17.0.2:41873/master/api/v1/scheduler
I0326 13:50:17.653594 32304 scheduler.cpp:231] Sending SUBSCRIBE call to http://172.17.0.2:41873/master/api/v1/scheduler
I0326 13:50:17.654772 32301 process.cpp:3136] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I0326 13:50:17.655267 32311 http.cpp:313] HTTP POST for /master/api/v1/scheduler from 172.17.0.2:55619
I0326 13:50:17.655661 32311 master.cpp:2088] Received subscription request for HTTP framework 'default'
I0326 13:50:17.655686 32311 master.cpp:1865] Authorizing framework principal 'test-principal' to receive offers for role '*'
I0326 13:50:17.655971 32311 master.cpp:2179] Subscribing framework 'default' with checkpointing disabled and capabilities [  ]
I0326 13:50:17.656540 32307 master.hpp:1715] Sending heartbeat to eef2acb1-f6a8-4281-a759-f3cc9b22a9fc-0000
I0326 13:50:17.656566 32303 hierarchical.cpp:266] Added framework eef2acb1-f6a8-4281-a759-f3cc9b22a9fc-0000
I0326 13:50:17.656669 32303 hierarchical.cpp:1490] No resources available to allocate!
I0326 13:50:17.656705 32303 hierarchical.cpp:1585] No inverse offers to send out!
I0326 13:50:17.656769 32303 hierarchical.cpp:1141] Performed allocation for 0 slaves in 190663ns
I0326 13:50:17.657420 32303 scheduler.cpp:629] Enqueuing event SUBSCRIBED received from http://172.17.0.2:41873/master/api/v1/scheduler
I0326 13:50:17.658584 32304 scheduler.cpp:231] Sending REQUEST call to http://172.17.0.2:41873/master/api/v1/scheduler
I0326 13:50:17.659137 32304 scheduler.cpp:629] Enqueuing event HEARTBEAT received from http://172.17.0.2:41873/master/api/v1/scheduler
I0326 13:50:17.660154 32300 process.cpp:3136] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I0326 13:50:17.660526 32303 http.cpp:313] HTTP POST for /master/api/v1/scheduler from 172.17.0.2:55620
I0326 13:50:17.660740 32303 master.cpp:2785] Processing REQUEST call for framework eef2acb1-f6a8-4281-a759-f3cc9b22a9fc-0000 (default)
I0326 13:50:17.660888 32307 hierarchical.cpp:592] Received resource request from framework eef2acb1-f6a8-4281-a759-f3cc9b22a9fc-0000
I0326 13:50:17.662889 32312 master.cpp:1269] Framework eef2acb1-f6a8-4281-a759-f3cc9b22a9fc-0000 (default) disconnected
I0326 13:50:17.663008 32312 master.cpp:2642] Disconnecting framework eef2acb1-f6a8-4281-a759-f3cc9b22a9fc-0000 (default)
I0326 13:50:17.663152 32312 master.cpp:2666] Deactivating framework eef2acb1-f6a8-4281-a759-f3cc9b22a9fc-0000 (default)
I0326 13:50:17.663379 32312 master.cpp:1293] Giving framework eef2acb1-f6a8-4281-a759-f3cc9b22a9fc-0000 (default) 0ns to failover
I0326 13:50:17.663419 32302 hierarchical.cpp:378] Deactivated framework eef2acb1-f6a8-4281-a759-f3cc9b22a9fc-0000
I0326 13:50:17.664767 32307 master.cpp:5360] Framework failover timeout, removing framework eef2acb1-f6a8-4281-a759-f3cc9b22a9fc-0000 (default)
I0326 13:50:17.664857 32307 master.cpp:6093] Removing framework eef2acb1-f6a8-4281-a759-f3cc9b22a9fc-0000 (default)
I0326 13:50:17.665196 32310 hierarchical.cpp:329] Removed framework eef2acb1-f6a8-4281-a759-f3cc9b22a9fc-0000
I0326 13:50:17.672785 32306 master.cpp:1083] Master terminating
[       OK ] ContentType/SchedulerTest.Request/1 (475 ms)
[----------] 26 tests from ContentType/SchedulerTest (17036 ms total)

[----------] Global test environment tear-down
E0326 13:50:17.803871 32282 environment.cpp:778] Failed to remove '/tmp/LogZooKeeperTest_WriteRead_h4kWQG': No such file or directory
E0326 13:50:17.803948 32282 environment.cpp:778] Failed to remove '/tmp/LogZooKeeperTest_LostZooKeeper_dl62DD': No such file or directory
[==========] 1048 tests from 131 test cases ran. (760582 ms total)
[  PASSED  ] 1047 tests.
[  FAILED  ] 1 test, listed below:
[  FAILED  ] ContainerLoggerTest.LOGROTATE_RotateInSandbox

 1 FAILED TEST
  YOU HAVE 6 DISABLED TESTS

make[4]: *** [check-local] Error 1
make[4]: Leaving directory `/mesos/mesos-0.29.0/_build/src'
make[3]: *** [check-am] Error 2
make[3]: Leaving directory `/mesos/mesos-0.29.0/_build/src'
make[2]: *** [check] Error 2
make[2]: Leaving directory `/mesos/mesos-0.29.0/_build/src'
make[1]: *** [check-recursive] Error 1
make[1]: Leaving directory `/mesos/mesos-0.29.0/_build'
make: *** [distcheck] Error 1
+ docker rmi mesos-1458997030-8114
Untagged: mesos-1458997030-8114:latest
Deleted: 9e05ebaffade3dc8cded8befbea10b5532606ec16a9435e84b5684e22c43ead2
Deleted: c28924e0baf00ca586896f47fb620c7358daf1eb84083348291ed679b55a2046
Deleted: 12a3e5d2bc907e8182cee72cb3482e9b34802c76737dabf669043d79d2a50316
Deleted: 798e02ac02b66aacca36277d54e608f0693dc84c3a5b0de8ff8cc5bc9b9a84c5
Deleted: 4475620dd89f5b6ca8e375d233acae398fb08951b94ad244387ddafab11e1908
Deleted: 7a5b98f1aeff0a79c2e9a9e782a7621d708cb0f1d7589bfdf7d6a416e7937b93
Deleted: 65fcb8ce686bcce61076354f56aa2e33e8812ac6c7894fd373b3d06f5f6f9ec2
Deleted: 53d3447f72cfdb49e456cfbd30d10381a35503177a6e3d9d7e2fbcdcd51b1b3b
Deleted: ea7e77de4f5f6f0de5dfa21b0d2beba866fdb955e0b16e4dea96f453ef99094d
Deleted: 8548c86ea70d5f4e1aee917f24c54ad801939eee3caf64626c0fc817ee80a0bf
Deleted: a632734abeea00cae8faab0a0e63c50001e6cc552bf5aac66c6d0ee11099581d
Deleted: 4bf627c255717094423460eb1bcf697f3ceb1b7ed349b4fd8f21bc297077ada9
Deleted: 35b64d9ffbfd7ae6d66aaeb848f398a136a1536ae3e7e1eb91e0601888259093
Deleted: ee9f6fba53e5d9b10f82d94544a8f3005814e83c779637bd6eb95c41b437d447
Deleted: 0760bbc544cee391442f4c161ef485deff2817cadf2b44e6002221307905ce0d
Deleted: 390d6b45c95b05ee8ca9f352e875bb8ea230329fda0bdb8b53c44de9486ac155
Build step 'Execute shell' marked build as failure

Jenkins build is back to normal : Mesos » clang,--verbose,GLOG_v=1 MESOS_VERBOSE=1,ubuntu:14.04,(docker||Hadoop)&&(!ubuntu-us1) #1880

Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/Mesos/COMPILER=clang,CONFIGURATION=--verbose,ENVIRONMENT=GLOG_v=1%20MESOS_VERBOSE=1,OS=ubuntu%3A14.04,label_exp=(docker%7C%7CHadoop)&&(!ubuntu-us1)/1880/changes>