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/01/11 21:57:36 UTC
Build failed in Jenkins: Mesos » gcc,--verbose,ubuntu:14.04,docker||Hadoop #1467
See <https://builds.apache.org/job/Mesos/COMPILER=gcc,CONFIGURATION=--verbose,OS=ubuntu%3A14.04,label_exp=docker%7C%7CHadoop/1467/changes>
Changes:
[joris.van.remoortere] Docs: Added minimum supported compiler versions in getting started doc.
------------------------------------------
[...truncated 154982 lines...]
I0111 20:57:33.307216 31434 status_update_manager.cpp:282] Closing status update streams for framework 96db3640-1aaa-4dc7-a332-8530bd73eaa1-0000
I0111 20:57:33.307306 31445 gc.cpp:54] Scheduling '/tmp/ContentType_SchedulerTest_Message_1_tkhqNH/slaves/96db3640-1aaa-4dc7-a332-8530bd73eaa1-S0/frameworks/96db3640-1aaa-4dc7-a332-8530bd73eaa1-0000' for gc 6.99999644420148days in the future
I0111 20:57:33.309901 31434 status_update_manager.cpp:528] Cleaning up status update stream for task cc36a1f9-a1f3-4408-9b7a-34ed0f30fb18 of framework 96db3640-1aaa-4dc7-a332-8530bd73eaa1-0000
[ OK ] ContentType/SchedulerTest.Message/1 (140 ms)
[ RUN ] ContentType/SchedulerTest.Request/0
I0111 20:57:33.317576 31411 leveldb.cpp:174] Opened db in 2.368656ms
I0111 20:57:33.318275 31411 leveldb.cpp:181] Compacted db in 661269ns
I0111 20:57:33.318372 31411 leveldb.cpp:196] Created db iterator in 68965ns
I0111 20:57:33.318410 31411 leveldb.cpp:202] Seeked to beginning of db in 2334ns
I0111 20:57:33.318426 31411 leveldb.cpp:271] Iterated through 0 keys in the db in 495ns
I0111 20:57:33.318542 31411 replica.cpp:779] Replica recovered with log positions 0 -> 0 with 1 holes and 0 unlearned
I0111 20:57:33.319203 31445 recover.cpp:447] Starting replica recovery
I0111 20:57:33.319525 31445 recover.cpp:473] Replica is in EMPTY status
I0111 20:57:33.321135 31431 replica.cpp:673] Replica in EMPTY status received a broadcasted recover request from (13436)@172.17.0.2:41169
I0111 20:57:33.321583 31435 recover.cpp:193] Received a recover response from a replica in EMPTY status
I0111 20:57:33.322162 31441 recover.cpp:564] Updating replica status to STARTING
I0111 20:57:33.322856 31435 leveldb.cpp:304] Persisting metadata (8 bytes) to leveldb took 578206ns
I0111 20:57:33.322887 31435 replica.cpp:320] Persisted replica status to STARTING
I0111 20:57:33.323065 31441 recover.cpp:473] Replica is in STARTING status
I0111 20:57:33.323276 31441 master.cpp:372] Master 1cac301c-ea9f-4db5-820b-e93cabbc0d36 (9f360326e5c1) started on 172.17.0.2:41169
I0111 20:57:33.323300 31441 master.cpp:374] Flags at startup: --acls="" --allocation_interval="1secs" --allocator="HierarchicalDRF" --authenticate="false" --authenticate_http="true" --authenticate_slaves="true" --authenticators="crammd5" --authorizers="local" --credentials="/tmp/HB8IuQ/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_slave_ping_timeouts="5" --quiet="false" --recovery_slave_removal_limit="100%" --registry="replicated_log" --registry_fetch_timeout="1mins" --registry_store_timeout="25secs" --registry_strict="true" --root_submissions="true" --slave_ping_timeout="15secs" --slave_reregister_timeout="10mins" --user_sorter="drf" --version="false" --webui_dir="/mesos/mesos-0.27.0/_inst/share/mesos/webui" --work_dir="/tmp/HB8IuQ/master" --zk_session_timeout="10secs"
I0111 20:57:33.323674 31441 master.cpp:421] Master allowing unauthenticated frameworks to register
I0111 20:57:33.323695 31441 master.cpp:424] Master only allowing authenticated slaves to register
I0111 20:57:33.323707 31441 credentials.hpp:35] Loading credentials for authentication from '/tmp/HB8IuQ/credentials'
I0111 20:57:33.324090 31441 master.cpp:464] Using default 'crammd5' authenticator
I0111 20:57:33.324092 31436 replica.cpp:673] Replica in STARTING status received a broadcasted recover request from (13437)@172.17.0.2:41169
I0111 20:57:33.324256 31441 master.cpp:533] Using default 'basic' HTTP authenticator
I0111 20:57:33.324381 31439 recover.cpp:193] Received a recover response from a replica in STARTING status
I0111 20:57:33.324414 31441 master.cpp:567] Authorization enabled
I0111 20:57:33.324800 31444 hierarchical.cpp:147] Initialized hierarchical allocator process
I0111 20:57:33.324904 31444 whitelist_watcher.cpp:77] No whitelist given
I0111 20:57:33.324998 31439 recover.cpp:564] Updating replica status to VOTING
I0111 20:57:33.325516 31444 leveldb.cpp:304] Persisting metadata (8 bytes) to leveldb took 315432ns
I0111 20:57:33.325541 31444 replica.cpp:320] Persisted replica status to VOTING
I0111 20:57:33.325758 31433 recover.cpp:578] Successfully joined the Paxos group
I0111 20:57:33.326002 31433 recover.cpp:462] Recover process terminated
I0111 20:57:33.327945 31430 master.cpp:1715] The newly elected leader is master@172.17.0.2:41169 with id 1cac301c-ea9f-4db5-820b-e93cabbc0d36
I0111 20:57:33.327983 31430 master.cpp:1728] Elected as the leading master!
I0111 20:57:33.328008 31430 master.cpp:1473] Recovering from registrar
I0111 20:57:33.328302 31430 registrar.cpp:307] Recovering registrar
I0111 20:57:33.329329 31438 log.cpp:659] Attempting to start the writer
I0111 20:57:33.330749 31430 replica.cpp:493] Replica received implicit promise request from (13439)@172.17.0.2:41169 with proposal 1
I0111 20:57:33.331161 31430 leveldb.cpp:304] Persisting metadata (8 bytes) to leveldb took 371817ns
I0111 20:57:33.331190 31430 replica.cpp:342] Persisted promised to 1
I0111 20:57:33.332123 31430 coordinator.cpp:238] Coordinator attempting to fill missing positions
I0111 20:57:33.333595 31445 replica.cpp:388] Replica received explicit promise request from (13440)@172.17.0.2:41169 for position 0 with proposal 2
I0111 20:57:33.333978 31445 leveldb.cpp:341] Persisting action (8 bytes) to leveldb took 339423ns
I0111 20:57:33.334002 31445 replica.cpp:712] Persisted action at 0
I0111 20:57:33.335005 31437 replica.cpp:537] Replica received write request for position 0 from (13441)@172.17.0.2:41169
I0111 20:57:33.335078 31437 leveldb.cpp:436] Reading position from leveldb took 31989ns
I0111 20:57:33.335443 31437 leveldb.cpp:341] Persisting action (14 bytes) to leveldb took 311604ns
I0111 20:57:33.335472 31437 replica.cpp:712] Persisted action at 0
I0111 20:57:33.336236 31437 replica.cpp:691] Replica received learned notice for position 0 from @0.0.0.0:0
I0111 20:57:33.336567 31437 leveldb.cpp:341] Persisting action (16 bytes) to leveldb took 296647ns
I0111 20:57:33.336597 31437 replica.cpp:712] Persisted action at 0
I0111 20:57:33.336621 31437 replica.cpp:697] Replica learned NOP action at position 0
I0111 20:57:33.337308 31442 log.cpp:675] Writer started with ending position 0
I0111 20:57:33.338534 31435 leveldb.cpp:436] Reading position from leveldb took 25799ns
I0111 20:57:33.339740 31432 registrar.cpp:340] Successfully fetched the registry (0B) in 11.37408ms
I0111 20:57:33.339907 31432 registrar.cpp:439] Applied 1 operations in 39975ns; attempting to update the 'registry'
I0111 20:57:33.340780 31435 log.cpp:683] Attempting to append 170 bytes to the log
I0111 20:57:33.341063 31440 coordinator.cpp:348] Coordinator attempting to write APPEND action at position 1
I0111 20:57:33.342000 31434 replica.cpp:537] Replica received write request for position 1 from (13442)@172.17.0.2:41169
I0111 20:57:33.342492 31434 leveldb.cpp:341] Persisting action (189 bytes) to leveldb took 393174ns
I0111 20:57:33.342517 31434 replica.cpp:712] Persisted action at 1
I0111 20:57:33.343250 31439 replica.cpp:691] Replica received learned notice for position 1 from @0.0.0.0:0
I0111 20:57:33.343623 31439 leveldb.cpp:341] Persisting action (191 bytes) to leveldb took 340378ns
I0111 20:57:33.343653 31439 replica.cpp:712] Persisted action at 1
I0111 20:57:33.343678 31439 replica.cpp:697] Replica learned APPEND action at position 1
I0111 20:57:33.344749 31433 registrar.cpp:484] Successfully updated the 'registry' in 4.778752ms
I0111 20:57:33.344985 31433 registrar.cpp:370] Successfully recovered registrar
I0111 20:57:33.345046 31442 log.cpp:702] Attempting to truncate the log to 1
I0111 20:57:33.345183 31436 coordinator.cpp:348] Coordinator attempting to write TRUNCATE action at position 2
I0111 20:57:33.345715 31445 master.cpp:1525] Recovered 0 slaves from the Registry (131B) ; allowing 10mins for slaves to re-register
I0111 20:57:33.346071 31443 hierarchical.cpp:165] Skipping recovery of hierarchical allocator: nothing to recover
I0111 20:57:33.346509 31430 replica.cpp:537] Replica received write request for position 2 from (13443)@172.17.0.2:41169
I0111 20:57:33.346901 31430 leveldb.cpp:341] Persisting action (16 bytes) to leveldb took 350563ns
I0111 20:57:33.346932 31430 replica.cpp:712] Persisted action at 2
I0111 20:57:33.347726 31439 replica.cpp:691] Replica received learned notice for position 2 from @0.0.0.0:0
I0111 20:57:33.348091 31439 leveldb.cpp:341] Persisting action (18 bytes) to leveldb took 333270ns
I0111 20:57:33.348207 31439 leveldb.cpp:399] Deleting ~1 keys from leveldb took 90645ns
I0111 20:57:33.348317 31439 replica.cpp:712] Persisted action at 2
I0111 20:57:33.348433 31439 replica.cpp:697] Replica learned TRUNCATE action at position 2
I0111 20:57:33.356767 31411 scheduler.cpp:154] Version: 0.27.0
I0111 20:57:33.357460 31435 scheduler.cpp:236] New master detected at master@172.17.0.2:41169
I0111 20:57:33.358649 31436 scheduler.cpp:298] Sending SUBSCRIBE call to master@172.17.0.2:41169
I0111 20:57:33.360653 31439 process.cpp:3141] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I0111 20:57:33.361145 31434 http.cpp:315] HTTP POST for /master/api/v1/scheduler from 172.17.0.2:47636
I0111 20:57:33.361371 31434 master.cpp:1977] Received subscription request for HTTP framework 'default'
I0111 20:57:33.361451 31434 master.cpp:1754] Authorizing framework principal 'test-principal' to receive offers for role '*'
I0111 20:57:33.361774 31434 master.cpp:2068] Subscribing framework 'default' with checkpointing disabled and capabilities [ ]
I0111 20:57:33.362251 31433 hierarchical.cpp:260] Added framework 1cac301c-ea9f-4db5-820b-e93cabbc0d36-0000
I0111 20:57:33.362303 31434 master.hpp:1657] Sending heartbeat to 1cac301c-ea9f-4db5-820b-e93cabbc0d36-0000
I0111 20:57:33.362442 31433 hierarchical.cpp:1329] No resources available to allocate!
I0111 20:57:33.362515 31433 hierarchical.cpp:1423] No inverse offers to send out!
I0111 20:57:33.362568 31433 hierarchical.cpp:1079] Performed allocation for 0 slaves in 191640ns
I0111 20:57:33.363368 31435 scheduler.cpp:457] Enqueuing event SUBSCRIBED received from master@172.17.0.2:41169
I0111 20:57:33.363895 31435 scheduler.cpp:457] Enqueuing event HEARTBEAT received from master@172.17.0.2:41169
I0111 20:57:33.364491 31435 master_maintenance_tests.cpp:177] Ignoring HEARTBEAT event
I0111 20:57:33.365191 31438 scheduler.cpp:298] Sending REQUEST call to master@172.17.0.2:41169
I0111 20:57:33.366864 31440 process.cpp:3141] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I0111 20:57:33.367323 31430 http.cpp:315] HTTP POST for /master/api/v1/scheduler from 172.17.0.2:47637
I0111 20:57:33.367491 31430 master.cpp:2722] Processing REQUEST call for framework 1cac301c-ea9f-4db5-820b-e93cabbc0d36-0000 (default)
I0111 20:57:33.367656 31437 hierarchical.cpp:579] Received resource request from framework 1cac301c-ea9f-4db5-820b-e93cabbc0d36-0000
I0111 20:57:33.368039 31411 master.cpp:1016] Master terminating
I0111 20:57:33.368386 31432 hierarchical.cpp:321] Removed framework 1cac301c-ea9f-4db5-820b-e93cabbc0d36-0000
E0111 20:57:33.369871 31437 scheduler.cpp:431] End-Of-File received from master. The master closed the event stream
[ OK ] ContentType/SchedulerTest.Request/0 (60 ms)
[ RUN ] ContentType/SchedulerTest.Request/1
I0111 20:57:33.377607 31411 leveldb.cpp:174] Opened db in 2.055376ms
I0111 20:57:33.378319 31411 leveldb.cpp:181] Compacted db in 670269ns
I0111 20:57:33.378377 31411 leveldb.cpp:196] Created db iterator in 32104ns
I0111 20:57:33.378406 31411 leveldb.cpp:202] Seeked to beginning of db in 2161ns
I0111 20:57:33.378437 31411 leveldb.cpp:271] Iterated through 0 keys in the db in 13711ns
I0111 20:57:33.378495 31411 replica.cpp:779] Replica recovered with log positions 0 -> 0 with 1 holes and 0 unlearned
I0111 20:57:33.379010 31435 recover.cpp:447] Starting replica recovery
I0111 20:57:33.379405 31435 recover.cpp:473] Replica is in EMPTY status
I0111 20:57:33.380528 31434 replica.cpp:673] Replica in EMPTY status received a broadcasted recover request from (13451)@172.17.0.2:41169
I0111 20:57:33.380939 31444 recover.cpp:193] Received a recover response from a replica in EMPTY status
I0111 20:57:33.381618 31441 recover.cpp:564] Updating replica status to STARTING
I0111 20:57:33.382307 31441 leveldb.cpp:304] Persisting metadata (8 bytes) to leveldb took 486914ns
I0111 20:57:33.382395 31441 replica.cpp:320] Persisted replica status to STARTING
I0111 20:57:33.382871 31444 recover.cpp:473] Replica is in STARTING status
I0111 20:57:33.383949 31435 replica.cpp:673] Replica in STARTING status received a broadcasted recover request from (13452)@172.17.0.2:41169
I0111 20:57:33.384138 31433 master.cpp:372] Master e2584af1-1d99-42d5-b069-0b7079f194af (9f360326e5c1) started on 172.17.0.2:41169
I0111 20:57:33.384369 31434 recover.cpp:193] Received a recover response from a replica in STARTING status
I0111 20:57:33.384162 31433 master.cpp:374] Flags at startup: --acls="" --allocation_interval="1secs" --allocator="HierarchicalDRF" --authenticate="false" --authenticate_http="true" --authenticate_slaves="true" --authenticators="crammd5" --authorizers="local" --credentials="/tmp/B0Zvme/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_slave_ping_timeouts="5" --quiet="false" --recovery_slave_removal_limit="100%" --registry="replicated_log" --registry_fetch_timeout="1mins" --registry_store_timeout="25secs" --registry_strict="true" --root_submissions="true" --slave_ping_timeout="15secs" --slave_reregister_timeout="10mins" --user_sorter="drf" --version="false" --webui_dir="/mesos/mesos-0.27.0/_inst/share/mesos/webui" --work_dir="/tmp/B0Zvme/master" --zk_session_timeout="10secs"
I0111 20:57:33.384557 31433 master.cpp:421] Master allowing unauthenticated frameworks to register
I0111 20:57:33.384572 31433 master.cpp:424] Master only allowing authenticated slaves to register
I0111 20:57:33.384583 31433 credentials.hpp:35] Loading credentials for authentication from '/tmp/B0Zvme/credentials'
I0111 20:57:33.384943 31436 recover.cpp:564] Updating replica status to VOTING
I0111 20:57:33.384977 31433 master.cpp:464] Using default 'crammd5' authenticator
I0111 20:57:33.385126 31433 master.cpp:533] Using default 'basic' HTTP authenticator
I0111 20:57:33.385277 31433 master.cpp:567] Authorization enabled
I0111 20:57:33.385454 31436 hierarchical.cpp:147] Initialized hierarchical allocator process
I0111 20:57:33.385458 31435 whitelist_watcher.cpp:77] No whitelist given
I0111 20:57:33.385586 31432 leveldb.cpp:304] Persisting metadata (8 bytes) to leveldb took 398404ns
I0111 20:57:33.385617 31432 replica.cpp:320] Persisted replica status to VOTING
I0111 20:57:33.385726 31437 recover.cpp:578] Successfully joined the Paxos group
I0111 20:57:33.385992 31437 recover.cpp:462] Recover process terminated
I0111 20:57:33.387689 31434 master.cpp:1715] The newly elected leader is master@172.17.0.2:41169 with id e2584af1-1d99-42d5-b069-0b7079f194af
I0111 20:57:33.387722 31434 master.cpp:1728] Elected as the leading master!
I0111 20:57:33.387747 31434 master.cpp:1473] Recovering from registrar
I0111 20:57:33.387928 31440 registrar.cpp:307] Recovering registrar
I0111 20:57:33.388701 31434 log.cpp:659] Attempting to start the writer
I0111 20:57:33.390184 31436 replica.cpp:493] Replica received implicit promise request from (13454)@172.17.0.2:41169 with proposal 1
I0111 20:57:33.390651 31436 leveldb.cpp:304] Persisting metadata (8 bytes) to leveldb took 427321ns
I0111 20:57:33.390681 31436 replica.cpp:342] Persisted promised to 1
I0111 20:57:33.391217 31431 coordinator.cpp:238] Coordinator attempting to fill missing positions
I0111 20:57:33.392458 31430 replica.cpp:388] Replica received explicit promise request from (13455)@172.17.0.2:41169 for position 0 with proposal 2
I0111 20:57:33.392846 31430 leveldb.cpp:341] Persisting action (8 bytes) to leveldb took 341928ns
I0111 20:57:33.392873 31430 replica.cpp:712] Persisted action at 0
I0111 20:57:33.394019 31434 replica.cpp:537] Replica received write request for position 0 from (13456)@172.17.0.2:41169
I0111 20:57:33.394088 31434 leveldb.cpp:436] Reading position from leveldb took 34260ns
I0111 20:57:33.394515 31434 leveldb.cpp:341] Persisting action (14 bytes) to leveldb took 374945ns
I0111 20:57:33.394544 31434 replica.cpp:712] Persisted action at 0
I0111 20:57:33.395153 31431 replica.cpp:691] Replica received learned notice for position 0 from @0.0.0.0:0
I0111 20:57:33.395663 31431 leveldb.cpp:341] Persisting action (16 bytes) to leveldb took 478966ns
I0111 20:57:33.395687 31431 replica.cpp:712] Persisted action at 0
I0111 20:57:33.395779 31431 replica.cpp:697] Replica learned NOP action at position 0
I0111 20:57:33.396504 31442 log.cpp:675] Writer started with ending position 0
I0111 20:57:33.397644 31432 leveldb.cpp:436] Reading position from leveldb took 27811ns
I0111 20:57:33.398566 31443 registrar.cpp:340] Successfully fetched the registry (0B) in 10.585088ms
I0111 20:57:33.398708 31443 registrar.cpp:439] Applied 1 operations in 38962ns; attempting to update the 'registry'
I0111 20:57:33.399485 31438 log.cpp:683] Attempting to append 170 bytes to the log
I0111 20:57:33.399668 31441 coordinator.cpp:348] Coordinator attempting to write APPEND action at position 1
I0111 20:57:33.400492 31434 replica.cpp:537] Replica received write request for position 1 from (13457)@172.17.0.2:41169
I0111 20:57:33.400934 31434 leveldb.cpp:341] Persisting action (189 bytes) to leveldb took 400146ns
I0111 20:57:33.400956 31434 replica.cpp:712] Persisted action at 1
I0111 20:57:33.401646 31442 replica.cpp:691] Replica received learned notice for position 1 from @0.0.0.0:0
I0111 20:57:33.401998 31442 leveldb.cpp:341] Persisting action (191 bytes) to leveldb took 322229ns
I0111 20:57:33.402019 31442 replica.cpp:712] Persisted action at 1
I0111 20:57:33.402035 31442 replica.cpp:697] Replica learned APPEND action at position 1
I0111 20:57:33.403132 31432 registrar.cpp:484] Successfully updated the 'registry' in 4.365056ms
I0111 20:57:33.403262 31432 registrar.cpp:370] Successfully recovered registrar
I0111 20:57:33.403453 31443 log.cpp:702] Attempting to truncate the log to 1
I0111 20:57:33.403638 31443 coordinator.cpp:348] Coordinator attempting to write TRUNCATE action at position 2
I0111 20:57:33.403671 31432 master.cpp:1525] Recovered 0 slaves from the Registry (131B) ; allowing 10mins for slaves to re-register
I0111 20:57:33.403796 31442 hierarchical.cpp:165] Skipping recovery of hierarchical allocator: nothing to recover
I0111 20:57:33.404603 31435 replica.cpp:537] Replica received write request for position 2 from (13458)@172.17.0.2:41169
I0111 20:57:33.404975 31435 leveldb.cpp:341] Persisting action (16 bytes) to leveldb took 336365ns
I0111 20:57:33.404999 31435 replica.cpp:712] Persisted action at 2
I0111 20:57:33.405576 31440 replica.cpp:691] Replica received learned notice for position 2 from @0.0.0.0:0
I0111 20:57:33.406028 31440 leveldb.cpp:341] Persisting action (18 bytes) to leveldb took 313104ns
I0111 20:57:33.406095 31440 leveldb.cpp:399] Deleting ~1 keys from leveldb took 36625ns
I0111 20:57:33.406122 31440 replica.cpp:712] Persisted action at 2
I0111 20:57:33.406148 31440 replica.cpp:697] Replica learned TRUNCATE action at position 2
I0111 20:57:33.414911 31411 scheduler.cpp:154] Version: 0.27.0
I0111 20:57:33.415648 31445 scheduler.cpp:236] New master detected at master@172.17.0.2:41169
I0111 20:57:33.416755 31435 scheduler.cpp:298] Sending SUBSCRIBE call to master@172.17.0.2:41169
I0111 20:57:33.418892 31433 process.cpp:3141] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I0111 20:57:33.419528 31434 http.cpp:315] HTTP POST for /master/api/v1/scheduler from 172.17.0.2:47638
I0111 20:57:33.419941 31434 master.cpp:1977] Received subscription request for HTTP framework 'default'
I0111 20:57:33.420019 31434 master.cpp:1754] Authorizing framework principal 'test-principal' to receive offers for role '*'
I0111 20:57:33.420430 31434 master.cpp:2068] Subscribing framework 'default' with checkpointing disabled and capabilities [ ]
I0111 20:57:33.420939 31440 hierarchical.cpp:260] Added framework e2584af1-1d99-42d5-b069-0b7079f194af-0000
I0111 20:57:33.421082 31431 master.hpp:1657] Sending heartbeat to e2584af1-1d99-42d5-b069-0b7079f194af-0000
I0111 20:57:33.421769 31440 hierarchical.cpp:1329] No resources available to allocate!
I0111 20:57:33.422111 31440 hierarchical.cpp:1423] No inverse offers to send out!
I0111 20:57:33.422279 31440 hierarchical.cpp:1079] Performed allocation for 0 slaves in 606317ns
I0111 20:57:33.423064 31431 scheduler.cpp:457] Enqueuing event SUBSCRIBED received from master@172.17.0.2:41169
I0111 20:57:33.423634 31431 scheduler.cpp:457] Enqueuing event HEARTBEAT received from master@172.17.0.2:41169
I0111 20:57:33.424216 31436 master_maintenance_tests.cpp:177] Ignoring HEARTBEAT event
I0111 20:57:33.424381 31431 scheduler.cpp:298] Sending REQUEST call to master@172.17.0.2:41169
I0111 20:57:33.425952 31443 process.cpp:3141] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I0111 20:57:33.426540 31435 http.cpp:315] HTTP POST for /master/api/v1/scheduler from 172.17.0.2:47639
I0111 20:57:33.427151 31435 master.cpp:2722] Processing REQUEST call for framework e2584af1-1d99-42d5-b069-0b7079f194af-0000 (default)
I0111 20:57:33.427417 31430 hierarchical.cpp:579] Received resource request from framework e2584af1-1d99-42d5-b069-0b7079f194af-0000
I0111 20:57:33.429021 31430 master.cpp:1016] Master terminating
I0111 20:57:33.429304 31436 hierarchical.cpp:321] Removed framework e2584af1-1d99-42d5-b069-0b7079f194af-0000
E0111 20:57:33.430413 31431 scheduler.cpp:431] End-Of-File received from master. The master closed the event stream
[ OK ] ContentType/SchedulerTest.Request/1 (63 ms)
[----------] 22 tests from ContentType/SchedulerTest (4522 ms total)
[----------] Global test environment tear-down
[==========] 925 tests from 122 test cases ran. (355213 ms total)
[ PASSED ] 924 tests.
[ FAILED ] 1 test, listed below:
[ FAILED ] PersistentVolumeTest.BadACLDropCreateAndDestroy
1 FAILED TEST
YOU HAVE 7 DISABLED TESTS
make[4]: *** [check-local] Error 1
make[4]: Leaving directory `/mesos/mesos-0.27.0/_build/src'
make[3]: *** [check-am] Error 2
make[3]: Leaving directory `/mesos/mesos-0.27.0/_build/src'
make[2]: *** [check] Error 2
make[2]: Leaving directory `/mesos/mesos-0.27.0/_build/src'
make[1]: *** [check-recursive] Error 1
make[1]: Leaving directory `/mesos/mesos-0.27.0/_build'
make: *** [distcheck] Error 1
+ docker rmi mesos-1452543800-1323
Untagged: mesos-1452543800-1323:latest
Deleted: c5f6db3b7228482af0b9d2d9fae28042393e756d5c1d931d058819b9aebf19c2
Deleted: 1da3f9f87c8f3ef9cd8005d31f50282d8d311a170391a45fac8b8fffa1ecb7e0
Deleted: a573963795b539dd712edbb1ebf9b3798b365c856963261a4fdfa581fb2bc742
Deleted: 7dc43109b5bc9a38e150149e3cc65810fa3f09ffbf9fbfff01fedec76860cd1c
Deleted: aa5242d298aded75866cccd28d67ea22376ac0fd358995e4cd0c54384071382d
Deleted: e5c21a08fd0ce86d825a948e605a0157038a4f69b0e9336b037738eac3f65b92
Deleted: 7b19f670d8e59efcd539e0c9ad22c28961418c5da43fe9cea24bc1cc96e8e7ee
Deleted: a3ce1d607c04b978a6b208a2f7fa898efcf62a21fd42f3cde0af7ba3056b38a1
Deleted: 0dc4c5f95d5546704681ff30a68d1801d1d1b7fee1ed87f0c53170383b20a7b8
Deleted: c598a68514bd91155912e15d30737e55010219f82733b793e1bc59be3a55fe3d
Deleted: 80aae15012d2a025f4ba11ec7a7b344fd35700dc1f4df1568680d410606e691f
Deleted: 5844125fd10dbe42d017e15bff03cb374cc40d05211621fc75b05c8473e67e58
Deleted: 2dcd0e952fb5825d7ee5f0511c64330590db1b29d1ff1d803d63f9fb65bac428
Deleted: 3163b32f9cf17f4d61e3f3b4501effc6a6025ca240f59fd4c82e89879b59687e
Build step 'Execute shell' marked build as failure
Re: Build failed in Jenkins: Mesos » gcc,--verbose,ubuntu:14.04,docker||Hadoop #1467
Posted by Greg Mann <gr...@mesosphere.io>.
There's a review up to fix this here: https://reviews.apache.org/r/42096/
On Mon, Jan 11, 2016 at 12:57 PM, Apache Jenkins Server <
jenkins@builds.apache.org> wrote:
> See <
> https://builds.apache.org/job/Mesos/COMPILER=gcc,CONFIGURATION=--verbose,OS=ubuntu%3A14.04,label_exp=docker%7C%7CHadoop/1467/changes
> >
>
> Changes:
>
> [joris.van.remoortere] Docs: Added minimum supported compiler versions in
> getting started doc.
>
> ------------------------------------------
> [...truncated 154982 lines...]
> I0111 20:57:33.307216 31434 status_update_manager.cpp:282] Closing status
> update streams for framework 96db3640-1aaa-4dc7-a332-8530bd73eaa1-0000
> I0111 20:57:33.307306 31445 gc.cpp:54] Scheduling
> '/tmp/ContentType_SchedulerTest_Message_1_tkhqNH/slaves/96db3640-1aaa-4dc7-a332-8530bd73eaa1-S0/frameworks/96db3640-1aaa-4dc7-a332-8530bd73eaa1-0000'
> for gc 6.99999644420148days in the future
> I0111 20:57:33.309901 31434 status_update_manager.cpp:528] Cleaning up
> status update stream for task cc36a1f9-a1f3-4408-9b7a-34ed0f30fb18 of
> framework 96db3640-1aaa-4dc7-a332-8530bd73eaa1-0000
> [ OK ] ContentType/SchedulerTest.Message/1 (140 ms)
> [ RUN ] ContentType/SchedulerTest.Request/0
> I0111 20:57:33.317576 31411 leveldb.cpp:174] Opened db in 2.368656ms
> I0111 20:57:33.318275 31411 leveldb.cpp:181] Compacted db in 661269ns
> I0111 20:57:33.318372 31411 leveldb.cpp:196] Created db iterator in 68965ns
> I0111 20:57:33.318410 31411 leveldb.cpp:202] Seeked to beginning of db in
> 2334ns
> I0111 20:57:33.318426 31411 leveldb.cpp:271] Iterated through 0 keys in
> the db in 495ns
> I0111 20:57:33.318542 31411 replica.cpp:779] Replica recovered with log
> positions 0 -> 0 with 1 holes and 0 unlearned
> I0111 20:57:33.319203 31445 recover.cpp:447] Starting replica recovery
> I0111 20:57:33.319525 31445 recover.cpp:473] Replica is in EMPTY status
> I0111 20:57:33.321135 31431 replica.cpp:673] Replica in EMPTY status
> received a broadcasted recover request from (13436)@172.17.0.2:41169
> I0111 20:57:33.321583 31435 recover.cpp:193] Received a recover response
> from a replica in EMPTY status
> I0111 20:57:33.322162 31441 recover.cpp:564] Updating replica status to
> STARTING
> I0111 20:57:33.322856 31435 leveldb.cpp:304] Persisting metadata (8 bytes)
> to leveldb took 578206ns
> I0111 20:57:33.322887 31435 replica.cpp:320] Persisted replica status to
> STARTING
> I0111 20:57:33.323065 31441 recover.cpp:473] Replica is in STARTING status
> I0111 20:57:33.323276 31441 master.cpp:372] Master
> 1cac301c-ea9f-4db5-820b-e93cabbc0d36 (9f360326e5c1) started on
> 172.17.0.2:41169
> I0111 20:57:33.323300 31441 master.cpp:374] Flags at startup: --acls=""
> --allocation_interval="1secs" --allocator="HierarchicalDRF"
> --authenticate="false" --authenticate_http="true"
> --authenticate_slaves="true" --authenticators="crammd5"
> --authorizers="local" --credentials="/tmp/HB8IuQ/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_slave_ping_timeouts="5" --quiet="false"
> --recovery_slave_removal_limit="100%" --registry="replicated_log"
> --registry_fetch_timeout="1mins" --registry_store_timeout="25secs"
> --registry_strict="true" --root_submissions="true"
> --slave_ping_timeout="15secs" --slave_reregister_timeout="10mins"
> --user_sorter="drf" --version="false"
> --webui_dir="/mesos/mesos-0.27.0/_inst/share/mesos/webui"
> --work_dir="/tmp/HB8IuQ/master" --zk_session_timeout="10secs"
> I0111 20:57:33.323674 31441 master.cpp:421] Master allowing
> unauthenticated frameworks to register
> I0111 20:57:33.323695 31441 master.cpp:424] Master only allowing
> authenticated slaves to register
> I0111 20:57:33.323707 31441 credentials.hpp:35] Loading credentials for
> authentication from '/tmp/HB8IuQ/credentials'
> I0111 20:57:33.324090 31441 master.cpp:464] Using default 'crammd5'
> authenticator
> I0111 20:57:33.324092 31436 replica.cpp:673] Replica in STARTING status
> received a broadcasted recover request from (13437)@172.17.0.2:41169
> I0111 20:57:33.324256 31441 master.cpp:533] Using default 'basic' HTTP
> authenticator
> I0111 20:57:33.324381 31439 recover.cpp:193] Received a recover response
> from a replica in STARTING status
> I0111 20:57:33.324414 31441 master.cpp:567] Authorization enabled
> I0111 20:57:33.324800 31444 hierarchical.cpp:147] Initialized hierarchical
> allocator process
> I0111 20:57:33.324904 31444 whitelist_watcher.cpp:77] No whitelist given
> I0111 20:57:33.324998 31439 recover.cpp:564] Updating replica status to
> VOTING
> I0111 20:57:33.325516 31444 leveldb.cpp:304] Persisting metadata (8 bytes)
> to leveldb took 315432ns
> I0111 20:57:33.325541 31444 replica.cpp:320] Persisted replica status to
> VOTING
> I0111 20:57:33.325758 31433 recover.cpp:578] Successfully joined the Paxos
> group
> I0111 20:57:33.326002 31433 recover.cpp:462] Recover process terminated
> I0111 20:57:33.327945 31430 master.cpp:1715] The newly elected leader is
> master@172.17.0.2:41169 with id 1cac301c-ea9f-4db5-820b-e93cabbc0d36
> I0111 20:57:33.327983 31430 master.cpp:1728] Elected as the leading master!
> I0111 20:57:33.328008 31430 master.cpp:1473] Recovering from registrar
> I0111 20:57:33.328302 31430 registrar.cpp:307] Recovering registrar
> I0111 20:57:33.329329 31438 log.cpp:659] Attempting to start the writer
> I0111 20:57:33.330749 31430 replica.cpp:493] Replica received implicit
> promise request from (13439)@172.17.0.2:41169 with proposal 1
> I0111 20:57:33.331161 31430 leveldb.cpp:304] Persisting metadata (8 bytes)
> to leveldb took 371817ns
> I0111 20:57:33.331190 31430 replica.cpp:342] Persisted promised to 1
> I0111 20:57:33.332123 31430 coordinator.cpp:238] Coordinator attempting to
> fill missing positions
> I0111 20:57:33.333595 31445 replica.cpp:388] Replica received explicit
> promise request from (13440)@172.17.0.2:41169 for position 0 with
> proposal 2
> I0111 20:57:33.333978 31445 leveldb.cpp:341] Persisting action (8 bytes)
> to leveldb took 339423ns
> I0111 20:57:33.334002 31445 replica.cpp:712] Persisted action at 0
> I0111 20:57:33.335005 31437 replica.cpp:537] Replica received write
> request for position 0 from (13441)@172.17.0.2:41169
> I0111 20:57:33.335078 31437 leveldb.cpp:436] Reading position from leveldb
> took 31989ns
> I0111 20:57:33.335443 31437 leveldb.cpp:341] Persisting action (14 bytes)
> to leveldb took 311604ns
> I0111 20:57:33.335472 31437 replica.cpp:712] Persisted action at 0
> I0111 20:57:33.336236 31437 replica.cpp:691] Replica received learned
> notice for position 0 from @0.0.0.0:0
> I0111 20:57:33.336567 31437 leveldb.cpp:341] Persisting action (16 bytes)
> to leveldb took 296647ns
> I0111 20:57:33.336597 31437 replica.cpp:712] Persisted action at 0
> I0111 20:57:33.336621 31437 replica.cpp:697] Replica learned NOP action at
> position 0
> I0111 20:57:33.337308 31442 log.cpp:675] Writer started with ending
> position 0
> I0111 20:57:33.338534 31435 leveldb.cpp:436] Reading position from leveldb
> took 25799ns
> I0111 20:57:33.339740 31432 registrar.cpp:340] Successfully fetched the
> registry (0B) in 11.37408ms
> I0111 20:57:33.339907 31432 registrar.cpp:439] Applied 1 operations in
> 39975ns; attempting to update the 'registry'
> I0111 20:57:33.340780 31435 log.cpp:683] Attempting to append 170 bytes to
> the log
> I0111 20:57:33.341063 31440 coordinator.cpp:348] Coordinator attempting to
> write APPEND action at position 1
> I0111 20:57:33.342000 31434 replica.cpp:537] Replica received write
> request for position 1 from (13442)@172.17.0.2:41169
> I0111 20:57:33.342492 31434 leveldb.cpp:341] Persisting action (189 bytes)
> to leveldb took 393174ns
> I0111 20:57:33.342517 31434 replica.cpp:712] Persisted action at 1
> I0111 20:57:33.343250 31439 replica.cpp:691] Replica received learned
> notice for position 1 from @0.0.0.0:0
> I0111 20:57:33.343623 31439 leveldb.cpp:341] Persisting action (191 bytes)
> to leveldb took 340378ns
> I0111 20:57:33.343653 31439 replica.cpp:712] Persisted action at 1
> I0111 20:57:33.343678 31439 replica.cpp:697] Replica learned APPEND action
> at position 1
> I0111 20:57:33.344749 31433 registrar.cpp:484] Successfully updated the
> 'registry' in 4.778752ms
> I0111 20:57:33.344985 31433 registrar.cpp:370] Successfully recovered
> registrar
> I0111 20:57:33.345046 31442 log.cpp:702] Attempting to truncate the log to
> 1
> I0111 20:57:33.345183 31436 coordinator.cpp:348] Coordinator attempting to
> write TRUNCATE action at position 2
> I0111 20:57:33.345715 31445 master.cpp:1525] Recovered 0 slaves from the
> Registry (131B) ; allowing 10mins for slaves to re-register
> I0111 20:57:33.346071 31443 hierarchical.cpp:165] Skipping recovery of
> hierarchical allocator: nothing to recover
> I0111 20:57:33.346509 31430 replica.cpp:537] Replica received write
> request for position 2 from (13443)@172.17.0.2:41169
> I0111 20:57:33.346901 31430 leveldb.cpp:341] Persisting action (16 bytes)
> to leveldb took 350563ns
> I0111 20:57:33.346932 31430 replica.cpp:712] Persisted action at 2
> I0111 20:57:33.347726 31439 replica.cpp:691] Replica received learned
> notice for position 2 from @0.0.0.0:0
> I0111 20:57:33.348091 31439 leveldb.cpp:341] Persisting action (18 bytes)
> to leveldb took 333270ns
> I0111 20:57:33.348207 31439 leveldb.cpp:399] Deleting ~1 keys from leveldb
> took 90645ns
> I0111 20:57:33.348317 31439 replica.cpp:712] Persisted action at 2
> I0111 20:57:33.348433 31439 replica.cpp:697] Replica learned TRUNCATE
> action at position 2
> I0111 20:57:33.356767 31411 scheduler.cpp:154] Version: 0.27.0
> I0111 20:57:33.357460 31435 scheduler.cpp:236] New master detected at
> master@172.17.0.2:41169
> I0111 20:57:33.358649 31436 scheduler.cpp:298] Sending SUBSCRIBE call to
> master@172.17.0.2:41169
> I0111 20:57:33.360653 31439 process.cpp:3141] Handling HTTP event for
> process 'master' with path: '/master/api/v1/scheduler'
> I0111 20:57:33.361145 31434 http.cpp:315] HTTP POST for
> /master/api/v1/scheduler from 172.17.0.2:47636
> I0111 20:57:33.361371 31434 master.cpp:1977] Received subscription request
> for HTTP framework 'default'
> I0111 20:57:33.361451 31434 master.cpp:1754] Authorizing framework
> principal 'test-principal' to receive offers for role '*'
> I0111 20:57:33.361774 31434 master.cpp:2068] Subscribing framework
> 'default' with checkpointing disabled and capabilities [ ]
> I0111 20:57:33.362251 31433 hierarchical.cpp:260] Added framework
> 1cac301c-ea9f-4db5-820b-e93cabbc0d36-0000
> I0111 20:57:33.362303 31434 master.hpp:1657] Sending heartbeat to
> 1cac301c-ea9f-4db5-820b-e93cabbc0d36-0000
> I0111 20:57:33.362442 31433 hierarchical.cpp:1329] No resources available
> to allocate!
> I0111 20:57:33.362515 31433 hierarchical.cpp:1423] No inverse offers to
> send out!
> I0111 20:57:33.362568 31433 hierarchical.cpp:1079] Performed allocation
> for 0 slaves in 191640ns
> I0111 20:57:33.363368 31435 scheduler.cpp:457] Enqueuing event SUBSCRIBED
> received from master@172.17.0.2:41169
> I0111 20:57:33.363895 31435 scheduler.cpp:457] Enqueuing event HEARTBEAT
> received from master@172.17.0.2:41169
> I0111 20:57:33.364491 31435 master_maintenance_tests.cpp:177] Ignoring
> HEARTBEAT event
> I0111 20:57:33.365191 31438 scheduler.cpp:298] Sending REQUEST call to
> master@172.17.0.2:41169
> I0111 20:57:33.366864 31440 process.cpp:3141] Handling HTTP event for
> process 'master' with path: '/master/api/v1/scheduler'
> I0111 20:57:33.367323 31430 http.cpp:315] HTTP POST for
> /master/api/v1/scheduler from 172.17.0.2:47637
> I0111 20:57:33.367491 31430 master.cpp:2722] Processing REQUEST call for
> framework 1cac301c-ea9f-4db5-820b-e93cabbc0d36-0000 (default)
> I0111 20:57:33.367656 31437 hierarchical.cpp:579] Received resource
> request from framework 1cac301c-ea9f-4db5-820b-e93cabbc0d36-0000
> I0111 20:57:33.368039 31411 master.cpp:1016] Master terminating
> I0111 20:57:33.368386 31432 hierarchical.cpp:321] Removed framework
> 1cac301c-ea9f-4db5-820b-e93cabbc0d36-0000
> E0111 20:57:33.369871 31437 scheduler.cpp:431] End-Of-File received from
> master. The master closed the event stream
> [ OK ] ContentType/SchedulerTest.Request/0 (60 ms)
> [ RUN ] ContentType/SchedulerTest.Request/1
> I0111 20:57:33.377607 31411 leveldb.cpp:174] Opened db in 2.055376ms
> I0111 20:57:33.378319 31411 leveldb.cpp:181] Compacted db in 670269ns
> I0111 20:57:33.378377 31411 leveldb.cpp:196] Created db iterator in 32104ns
> I0111 20:57:33.378406 31411 leveldb.cpp:202] Seeked to beginning of db in
> 2161ns
> I0111 20:57:33.378437 31411 leveldb.cpp:271] Iterated through 0 keys in
> the db in 13711ns
> I0111 20:57:33.378495 31411 replica.cpp:779] Replica recovered with log
> positions 0 -> 0 with 1 holes and 0 unlearned
> I0111 20:57:33.379010 31435 recover.cpp:447] Starting replica recovery
> I0111 20:57:33.379405 31435 recover.cpp:473] Replica is in EMPTY status
> I0111 20:57:33.380528 31434 replica.cpp:673] Replica in EMPTY status
> received a broadcasted recover request from (13451)@172.17.0.2:41169
> I0111 20:57:33.380939 31444 recover.cpp:193] Received a recover response
> from a replica in EMPTY status
> I0111 20:57:33.381618 31441 recover.cpp:564] Updating replica status to
> STARTING
> I0111 20:57:33.382307 31441 leveldb.cpp:304] Persisting metadata (8 bytes)
> to leveldb took 486914ns
> I0111 20:57:33.382395 31441 replica.cpp:320] Persisted replica status to
> STARTING
> I0111 20:57:33.382871 31444 recover.cpp:473] Replica is in STARTING status
> I0111 20:57:33.383949 31435 replica.cpp:673] Replica in STARTING status
> received a broadcasted recover request from (13452)@172.17.0.2:41169
> I0111 20:57:33.384138 31433 master.cpp:372] Master
> e2584af1-1d99-42d5-b069-0b7079f194af (9f360326e5c1) started on
> 172.17.0.2:41169
> I0111 20:57:33.384369 31434 recover.cpp:193] Received a recover response
> from a replica in STARTING status
> I0111 20:57:33.384162 31433 master.cpp:374] Flags at startup: --acls=""
> --allocation_interval="1secs" --allocator="HierarchicalDRF"
> --authenticate="false" --authenticate_http="true"
> --authenticate_slaves="true" --authenticators="crammd5"
> --authorizers="local" --credentials="/tmp/B0Zvme/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_slave_ping_timeouts="5" --quiet="false"
> --recovery_slave_removal_limit="100%" --registry="replicated_log"
> --registry_fetch_timeout="1mins" --registry_store_timeout="25secs"
> --registry_strict="true" --root_submissions="true"
> --slave_ping_timeout="15secs" --slave_reregister_timeout="10mins"
> --user_sorter="drf" --version="false"
> --webui_dir="/mesos/mesos-0.27.0/_inst/share/mesos/webui"
> --work_dir="/tmp/B0Zvme/master" --zk_session_timeout="10secs"
> I0111 20:57:33.384557 31433 master.cpp:421] Master allowing
> unauthenticated frameworks to register
> I0111 20:57:33.384572 31433 master.cpp:424] Master only allowing
> authenticated slaves to register
> I0111 20:57:33.384583 31433 credentials.hpp:35] Loading credentials for
> authentication from '/tmp/B0Zvme/credentials'
> I0111 20:57:33.384943 31436 recover.cpp:564] Updating replica status to
> VOTING
> I0111 20:57:33.384977 31433 master.cpp:464] Using default 'crammd5'
> authenticator
> I0111 20:57:33.385126 31433 master.cpp:533] Using default 'basic' HTTP
> authenticator
> I0111 20:57:33.385277 31433 master.cpp:567] Authorization enabled
> I0111 20:57:33.385454 31436 hierarchical.cpp:147] Initialized hierarchical
> allocator process
> I0111 20:57:33.385458 31435 whitelist_watcher.cpp:77] No whitelist given
> I0111 20:57:33.385586 31432 leveldb.cpp:304] Persisting metadata (8 bytes)
> to leveldb took 398404ns
> I0111 20:57:33.385617 31432 replica.cpp:320] Persisted replica status to
> VOTING
> I0111 20:57:33.385726 31437 recover.cpp:578] Successfully joined the Paxos
> group
> I0111 20:57:33.385992 31437 recover.cpp:462] Recover process terminated
> I0111 20:57:33.387689 31434 master.cpp:1715] The newly elected leader is
> master@172.17.0.2:41169 with id e2584af1-1d99-42d5-b069-0b7079f194af
> I0111 20:57:33.387722 31434 master.cpp:1728] Elected as the leading master!
> I0111 20:57:33.387747 31434 master.cpp:1473] Recovering from registrar
> I0111 20:57:33.387928 31440 registrar.cpp:307] Recovering registrar
> I0111 20:57:33.388701 31434 log.cpp:659] Attempting to start the writer
> I0111 20:57:33.390184 31436 replica.cpp:493] Replica received implicit
> promise request from (13454)@172.17.0.2:41169 with proposal 1
> I0111 20:57:33.390651 31436 leveldb.cpp:304] Persisting metadata (8 bytes)
> to leveldb took 427321ns
> I0111 20:57:33.390681 31436 replica.cpp:342] Persisted promised to 1
> I0111 20:57:33.391217 31431 coordinator.cpp:238] Coordinator attempting to
> fill missing positions
> I0111 20:57:33.392458 31430 replica.cpp:388] Replica received explicit
> promise request from (13455)@172.17.0.2:41169 for position 0 with
> proposal 2
> I0111 20:57:33.392846 31430 leveldb.cpp:341] Persisting action (8 bytes)
> to leveldb took 341928ns
> I0111 20:57:33.392873 31430 replica.cpp:712] Persisted action at 0
> I0111 20:57:33.394019 31434 replica.cpp:537] Replica received write
> request for position 0 from (13456)@172.17.0.2:41169
> I0111 20:57:33.394088 31434 leveldb.cpp:436] Reading position from leveldb
> took 34260ns
> I0111 20:57:33.394515 31434 leveldb.cpp:341] Persisting action (14 bytes)
> to leveldb took 374945ns
> I0111 20:57:33.394544 31434 replica.cpp:712] Persisted action at 0
> I0111 20:57:33.395153 31431 replica.cpp:691] Replica received learned
> notice for position 0 from @0.0.0.0:0
> I0111 20:57:33.395663 31431 leveldb.cpp:341] Persisting action (16 bytes)
> to leveldb took 478966ns
> I0111 20:57:33.395687 31431 replica.cpp:712] Persisted action at 0
> I0111 20:57:33.395779 31431 replica.cpp:697] Replica learned NOP action at
> position 0
> I0111 20:57:33.396504 31442 log.cpp:675] Writer started with ending
> position 0
> I0111 20:57:33.397644 31432 leveldb.cpp:436] Reading position from leveldb
> took 27811ns
> I0111 20:57:33.398566 31443 registrar.cpp:340] Successfully fetched the
> registry (0B) in 10.585088ms
> I0111 20:57:33.398708 31443 registrar.cpp:439] Applied 1 operations in
> 38962ns; attempting to update the 'registry'
> I0111 20:57:33.399485 31438 log.cpp:683] Attempting to append 170 bytes to
> the log
> I0111 20:57:33.399668 31441 coordinator.cpp:348] Coordinator attempting to
> write APPEND action at position 1
> I0111 20:57:33.400492 31434 replica.cpp:537] Replica received write
> request for position 1 from (13457)@172.17.0.2:41169
> I0111 20:57:33.400934 31434 leveldb.cpp:341] Persisting action (189 bytes)
> to leveldb took 400146ns
> I0111 20:57:33.400956 31434 replica.cpp:712] Persisted action at 1
> I0111 20:57:33.401646 31442 replica.cpp:691] Replica received learned
> notice for position 1 from @0.0.0.0:0
> I0111 20:57:33.401998 31442 leveldb.cpp:341] Persisting action (191 bytes)
> to leveldb took 322229ns
> I0111 20:57:33.402019 31442 replica.cpp:712] Persisted action at 1
> I0111 20:57:33.402035 31442 replica.cpp:697] Replica learned APPEND action
> at position 1
> I0111 20:57:33.403132 31432 registrar.cpp:484] Successfully updated the
> 'registry' in 4.365056ms
> I0111 20:57:33.403262 31432 registrar.cpp:370] Successfully recovered
> registrar
> I0111 20:57:33.403453 31443 log.cpp:702] Attempting to truncate the log to
> 1
> I0111 20:57:33.403638 31443 coordinator.cpp:348] Coordinator attempting to
> write TRUNCATE action at position 2
> I0111 20:57:33.403671 31432 master.cpp:1525] Recovered 0 slaves from the
> Registry (131B) ; allowing 10mins for slaves to re-register
> I0111 20:57:33.403796 31442 hierarchical.cpp:165] Skipping recovery of
> hierarchical allocator: nothing to recover
> I0111 20:57:33.404603 31435 replica.cpp:537] Replica received write
> request for position 2 from (13458)@172.17.0.2:41169
> I0111 20:57:33.404975 31435 leveldb.cpp:341] Persisting action (16 bytes)
> to leveldb took 336365ns
> I0111 20:57:33.404999 31435 replica.cpp:712] Persisted action at 2
> I0111 20:57:33.405576 31440 replica.cpp:691] Replica received learned
> notice for position 2 from @0.0.0.0:0
> I0111 20:57:33.406028 31440 leveldb.cpp:341] Persisting action (18 bytes)
> to leveldb took 313104ns
> I0111 20:57:33.406095 31440 leveldb.cpp:399] Deleting ~1 keys from leveldb
> took 36625ns
> I0111 20:57:33.406122 31440 replica.cpp:712] Persisted action at 2
> I0111 20:57:33.406148 31440 replica.cpp:697] Replica learned TRUNCATE
> action at position 2
> I0111 20:57:33.414911 31411 scheduler.cpp:154] Version: 0.27.0
> I0111 20:57:33.415648 31445 scheduler.cpp:236] New master detected at
> master@172.17.0.2:41169
> I0111 20:57:33.416755 31435 scheduler.cpp:298] Sending SUBSCRIBE call to
> master@172.17.0.2:41169
> I0111 20:57:33.418892 31433 process.cpp:3141] Handling HTTP event for
> process 'master' with path: '/master/api/v1/scheduler'
> I0111 20:57:33.419528 31434 http.cpp:315] HTTP POST for
> /master/api/v1/scheduler from 172.17.0.2:47638
> I0111 20:57:33.419941 31434 master.cpp:1977] Received subscription request
> for HTTP framework 'default'
> I0111 20:57:33.420019 31434 master.cpp:1754] Authorizing framework
> principal 'test-principal' to receive offers for role '*'
> I0111 20:57:33.420430 31434 master.cpp:2068] Subscribing framework
> 'default' with checkpointing disabled and capabilities [ ]
> I0111 20:57:33.420939 31440 hierarchical.cpp:260] Added framework
> e2584af1-1d99-42d5-b069-0b7079f194af-0000
> I0111 20:57:33.421082 31431 master.hpp:1657] Sending heartbeat to
> e2584af1-1d99-42d5-b069-0b7079f194af-0000
> I0111 20:57:33.421769 31440 hierarchical.cpp:1329] No resources available
> to allocate!
> I0111 20:57:33.422111 31440 hierarchical.cpp:1423] No inverse offers to
> send out!
> I0111 20:57:33.422279 31440 hierarchical.cpp:1079] Performed allocation
> for 0 slaves in 606317ns
> I0111 20:57:33.423064 31431 scheduler.cpp:457] Enqueuing event SUBSCRIBED
> received from master@172.17.0.2:41169
> I0111 20:57:33.423634 31431 scheduler.cpp:457] Enqueuing event HEARTBEAT
> received from master@172.17.0.2:41169
> I0111 20:57:33.424216 31436 master_maintenance_tests.cpp:177] Ignoring
> HEARTBEAT event
> I0111 20:57:33.424381 31431 scheduler.cpp:298] Sending REQUEST call to
> master@172.17.0.2:41169
> I0111 20:57:33.425952 31443 process.cpp:3141] Handling HTTP event for
> process 'master' with path: '/master/api/v1/scheduler'
> I0111 20:57:33.426540 31435 http.cpp:315] HTTP POST for
> /master/api/v1/scheduler from 172.17.0.2:47639
> I0111 20:57:33.427151 31435 master.cpp:2722] Processing REQUEST call for
> framework e2584af1-1d99-42d5-b069-0b7079f194af-0000 (default)
> I0111 20:57:33.427417 31430 hierarchical.cpp:579] Received resource
> request from framework e2584af1-1d99-42d5-b069-0b7079f194af-0000
> I0111 20:57:33.429021 31430 master.cpp:1016] Master terminating
> I0111 20:57:33.429304 31436 hierarchical.cpp:321] Removed framework
> e2584af1-1d99-42d5-b069-0b7079f194af-0000
> E0111 20:57:33.430413 31431 scheduler.cpp:431] End-Of-File received from
> master. The master closed the event stream
> [ OK ] ContentType/SchedulerTest.Request/1 (63 ms)
> [----------] 22 tests from ContentType/SchedulerTest (4522 ms total)
>
> [----------] Global test environment tear-down
> [==========] 925 tests from 122 test cases ran. (355213 ms total)
> [ PASSED ] 924 tests.
> [ FAILED ] 1 test, listed below:
> [ FAILED ] PersistentVolumeTest.BadACLDropCreateAndDestroy
>
> 1 FAILED TEST
> YOU HAVE 7 DISABLED TESTS
>
> make[4]: *** [check-local] Error 1
> make[4]: Leaving directory `/mesos/mesos-0.27.0/_build/src'
> make[3]: *** [check-am] Error 2
> make[3]: Leaving directory `/mesos/mesos-0.27.0/_build/src'
> make[2]: *** [check] Error 2
> make[2]: Leaving directory `/mesos/mesos-0.27.0/_build/src'
> make[1]: *** [check-recursive] Error 1
> make[1]: Leaving directory `/mesos/mesos-0.27.0/_build'
> make: *** [distcheck] Error 1
> + docker rmi mesos-1452543800-1323
> Untagged: mesos-1452543800-1323:latest
> Deleted: c5f6db3b7228482af0b9d2d9fae28042393e756d5c1d931d058819b9aebf19c2
> Deleted: 1da3f9f87c8f3ef9cd8005d31f50282d8d311a170391a45fac8b8fffa1ecb7e0
> Deleted: a573963795b539dd712edbb1ebf9b3798b365c856963261a4fdfa581fb2bc742
> Deleted: 7dc43109b5bc9a38e150149e3cc65810fa3f09ffbf9fbfff01fedec76860cd1c
> Deleted: aa5242d298aded75866cccd28d67ea22376ac0fd358995e4cd0c54384071382d
> Deleted: e5c21a08fd0ce86d825a948e605a0157038a4f69b0e9336b037738eac3f65b92
> Deleted: 7b19f670d8e59efcd539e0c9ad22c28961418c5da43fe9cea24bc1cc96e8e7ee
> Deleted: a3ce1d607c04b978a6b208a2f7fa898efcf62a21fd42f3cde0af7ba3056b38a1
> Deleted: 0dc4c5f95d5546704681ff30a68d1801d1d1b7fee1ed87f0c53170383b20a7b8
> Deleted: c598a68514bd91155912e15d30737e55010219f82733b793e1bc59be3a55fe3d
> Deleted: 80aae15012d2a025f4ba11ec7a7b344fd35700dc1f4df1568680d410606e691f
> Deleted: 5844125fd10dbe42d017e15bff03cb374cc40d05211621fc75b05c8473e67e58
> Deleted: 2dcd0e952fb5825d7ee5f0511c64330590db1b29d1ff1d803d63f9fb65bac428
> Deleted: 3163b32f9cf17f4d61e3f3b4501effc6a6025ca240f59fd4c82e89879b59687e
> Build step 'Execute shell' marked build as failure
>
Jenkins build is back to normal : Mesos » gcc,--verbose,ubuntu:14.04,docker||Hadoop #1468
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/Mesos/COMPILER=gcc,CONFIGURATION=--verbose,OS=ubuntu%3A14.04,label_exp=docker%7C%7CHadoop/1468/changes>