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 2015/12/08 22:30:03 UTC
Build failed in Jenkins: Mesos » gcc,--verbose,centos:7,docker||Hadoop #1331
See <https://builds.apache.org/job/Mesos/COMPILER=gcc,CONFIGURATION=--verbose,OS=centos%3A7,label_exp=docker%7C%7CHadoop/1331/>
------------------------------------------
[...truncated 150766 lines...]
I1208 21:29:59.189986 31385 gc.cpp:54] Scheduling '/tmp/ContentType_SchedulerTest_Message_1_Bl7T5s/slaves/cf46c2e2-6484-4ac7-808b-2994c0d89738-S0/frameworks/cf46c2e2-6484-4ac7-808b-2994c0d89738-0000/executors/default/runs/dc246860-cef7-4966-917c-07e0eda9e79a' for gc 6.99999780209482days in the future
I1208 21:29:59.190095 31383 slave.cpp:3947] Cleaning up framework cf46c2e2-6484-4ac7-808b-2994c0d89738-0000
I1208 21:29:59.190145 31385 gc.cpp:54] Scheduling '/tmp/ContentType_SchedulerTest_Message_1_Bl7T5s/slaves/cf46c2e2-6484-4ac7-808b-2994c0d89738-S0/frameworks/cf46c2e2-6484-4ac7-808b-2994c0d89738-0000/executors/default' for gc 6.99999780051852days in the future
I1208 21:29:59.190217 31391 status_update_manager.cpp:282] Closing status update streams for framework cf46c2e2-6484-4ac7-808b-2994c0d89738-0000
I1208 21:29:59.190263 31391 status_update_manager.cpp:528] Cleaning up status update stream for task cd4875a1-dd76-4c1f-bcc8-5a6722617c0e of framework cf46c2e2-6484-4ac7-808b-2994c0d89738-0000
I1208 21:29:59.190429 31385 gc.cpp:54] Scheduling '/tmp/ContentType_SchedulerTest_Message_1_Bl7T5s/slaves/cf46c2e2-6484-4ac7-808b-2994c0d89738-S0/frameworks/cf46c2e2-6484-4ac7-808b-2994c0d89738-0000' for gc 6.99999779845037days in the future
[ OK ] ContentType/SchedulerTest.Message/1 (878 ms)
[ RUN ] ContentType/SchedulerTest.Request/0
I1208 21:29:59.315748 31357 leveldb.cpp:174] Opened db in 121.316174ms
I1208 21:29:59.375648 31357 leveldb.cpp:181] Compacted db in 59.850747ms
I1208 21:29:59.375730 31357 leveldb.cpp:196] Created db iterator in 27766ns
I1208 21:29:59.375768 31357 leveldb.cpp:202] Seeked to beginning of db in 3424ns
I1208 21:29:59.375794 31357 leveldb.cpp:271] Iterated through 0 keys in the db in 712ns
I1208 21:29:59.375866 31357 replica.cpp:778] Replica recovered with log positions 0 -> 0 with 1 holes and 0 unlearned
I1208 21:29:59.376539 31385 recover.cpp:447] Starting replica recovery
I1208 21:29:59.376864 31382 recover.cpp:473] Replica is in EMPTY status
I1208 21:29:59.378099 31389 replica.cpp:674] Replica in EMPTY status received a broadcasted recover request from (11534)@172.17.1.252:59639
I1208 21:29:59.378446 31389 recover.cpp:193] Received a recover response from a replica in EMPTY status
I1208 21:29:59.379063 31380 recover.cpp:564] Updating replica status to STARTING
I1208 21:29:59.380213 31382 master.cpp:365] Master e0c74ba6-5bb6-4900-9637-3ed4c356af49 (88c80f39a34d) started on 172.17.1.252:59639
I1208 21:29:59.380244 31382 master.cpp:367] Flags at startup: --acls="" --allocation_interval="1secs" --allocator="HierarchicalDRF" --authenticate="false" --authenticate_slaves="true" --authenticators="crammd5" --authorizers="local" --credentials="/tmp/lI1dPQ/credentials" --framework_sorter="drf" --help="false" --hostname_lookup="true" --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/lI1dPQ/master" --zk_session_timeout="10secs"
I1208 21:29:59.380630 31382 master.cpp:414] Master allowing unauthenticated frameworks to register
I1208 21:29:59.380648 31382 master.cpp:417] Master only allowing authenticated slaves to register
I1208 21:29:59.380657 31382 credentials.hpp:35] Loading credentials for authentication from '/tmp/lI1dPQ/credentials'
I1208 21:29:59.380954 31382 master.cpp:456] Using default 'crammd5' authenticator
I1208 21:29:59.381094 31382 master.cpp:493] Authorization enabled
I1208 21:29:59.381400 31390 whitelist_watcher.cpp:77] No whitelist given
I1208 21:29:59.381453 31388 hierarchical.cpp:163] Initialized hierarchical allocator process
I1208 21:29:59.383859 31386 master.cpp:1637] The newly elected leader is master@172.17.1.252:59639 with id e0c74ba6-5bb6-4900-9637-3ed4c356af49
I1208 21:29:59.383896 31386 master.cpp:1650] Elected as the leading master!
I1208 21:29:59.383916 31386 master.cpp:1395] Recovering from registrar
I1208 21:29:59.384165 31391 registrar.cpp:307] Recovering registrar
I1208 21:29:59.413319 31387 leveldb.cpp:304] Persisting metadata (8 bytes) to leveldb took 33.964569ms
I1208 21:29:59.413365 31387 replica.cpp:321] Persisted replica status to STARTING
I1208 21:29:59.413643 31381 recover.cpp:473] Replica is in STARTING status
I1208 21:29:59.414822 31389 replica.cpp:674] Replica in STARTING status received a broadcasted recover request from (11535)@172.17.1.252:59639
I1208 21:29:59.415144 31376 recover.cpp:193] Received a recover response from a replica in STARTING status
I1208 21:29:59.415705 31377 recover.cpp:564] Updating replica status to VOTING
I1208 21:29:59.455390 31380 leveldb.cpp:304] Persisting metadata (8 bytes) to leveldb took 39.504397ms
I1208 21:29:59.455436 31380 replica.cpp:321] Persisted replica status to VOTING
I1208 21:29:59.455582 31387 recover.cpp:578] Successfully joined the Paxos group
I1208 21:29:59.455782 31387 recover.cpp:462] Recover process terminated
I1208 21:29:59.456331 31376 log.cpp:659] Attempting to start the writer
I1208 21:29:59.457798 31388 replica.cpp:494] Replica received implicit promise request from (11536)@172.17.1.252:59639 with proposal 1
I1208 21:29:59.514008 31388 leveldb.cpp:304] Persisting metadata (8 bytes) to leveldb took 56.167078ms
I1208 21:29:59.514053 31388 replica.cpp:343] Persisted promised to 1
I1208 21:29:59.514695 31390 coordinator.cpp:238] Coordinator attempting to fill missing positions
I1208 21:29:59.516034 31391 replica.cpp:389] Replica received explicit promise request from (11537)@172.17.1.252:59639 for position 0 with proposal 2
I1208 21:29:59.589939 31391 leveldb.cpp:341] Persisting action (8 bytes) to leveldb took 73.851483ms
I1208 21:29:59.589985 31391 replica.cpp:713] Persisted action at 0
I1208 21:29:59.591413 31389 replica.cpp:538] Replica received write request for position 0 from (11538)@172.17.1.252:59639
I1208 21:29:59.591482 31389 leveldb.cpp:436] Reading position from leveldb took 30641ns
I1208 21:29:59.617123 31389 leveldb.cpp:341] Persisting action (14 bytes) to leveldb took 25.587252ms
I1208 21:29:59.617163 31389 replica.cpp:713] Persisted action at 0
I1208 21:29:59.618031 31386 replica.cpp:692] Replica received learned notice for position 0 from @0.0.0.0:0
I1208 21:29:59.659091 31386 leveldb.cpp:341] Persisting action (16 bytes) to leveldb took 41.018032ms
I1208 21:29:59.659131 31386 replica.cpp:713] Persisted action at 0
I1208 21:29:59.659152 31386 replica.cpp:698] Replica learned NOP action at position 0
2015-12-08 21:29:59,659:31357(0x7f56ce1df700):ZOO_ERROR@handle_socket_error_msg@1697: Socket [127.0.0.1:35093] zk retcode=-4, errno=111(Connection refused): server refused to accept the client
I1208 21:29:59.659817 31390 log.cpp:675] Writer started with ending position 0
I1208 21:29:59.660727 31388 leveldb.cpp:436] Reading position from leveldb took 23114ns
I1208 21:29:59.661542 31380 registrar.cpp:340] Successfully fetched the registry (0B) in 277.286144ms
I1208 21:29:59.661664 31380 registrar.cpp:439] Applied 1 operations in 22736ns; attempting to update the 'registry'
I1208 21:29:59.662456 31391 log.cpp:683] Attempting to append 176 bytes to the log
I1208 21:29:59.662641 31384 coordinator.cpp:348] Coordinator attempting to write APPEND action at position 1
I1208 21:29:59.663316 31387 replica.cpp:538] Replica received write request for position 1 from (11539)@172.17.1.252:59639
I1208 21:29:59.717806 31387 leveldb.cpp:341] Persisting action (195 bytes) to leveldb took 54.446537ms
I1208 21:29:59.717854 31387 replica.cpp:713] Persisted action at 1
I1208 21:29:59.718756 31381 replica.cpp:692] Replica received learned notice for position 1 from @0.0.0.0:0
I1208 21:29:59.752694 31381 leveldb.cpp:341] Persisting action (197 bytes) to leveldb took 33.896564ms
I1208 21:29:59.752743 31381 replica.cpp:713] Persisted action at 1
I1208 21:29:59.752778 31381 replica.cpp:698] Replica learned APPEND action at position 1
I1208 21:29:59.754022 31384 registrar.cpp:484] Successfully updated the 'registry' in 92.286976ms
I1208 21:29:59.754241 31384 registrar.cpp:370] Successfully recovered registrar
I1208 21:29:59.754436 31387 log.cpp:702] Attempting to truncate the log to 1
I1208 21:29:59.754587 31385 coordinator.cpp:348] Coordinator attempting to write TRUNCATE action at position 2
I1208 21:29:59.754678 31389 master.cpp:1447] Recovered 0 slaves from the Registry (137B) ; allowing 10mins for slaves to re-register
I1208 21:29:59.754714 31383 hierarchical.cpp:181] Skipping recovery of hierarchical allocator: nothing to recover
I1208 21:29:59.755468 31379 replica.cpp:538] Replica received write request for position 2 from (11540)@172.17.1.252:59639
I1208 21:29:59.992041 31379 leveldb.cpp:341] Persisting action (16 bytes) to leveldb took 236.516611ms
I1208 21:29:59.992132 31379 replica.cpp:713] Persisted action at 2
I1208 21:29:59.993036 31385 replica.cpp:692] Replica received learned notice for position 2 from @0.0.0.0:0
I1208 21:30:00.061431 31385 leveldb.cpp:341] Persisting action (18 bytes) to leveldb took 68.359931ms
I1208 21:30:00.061523 31385 leveldb.cpp:399] Deleting ~1 keys from leveldb took 44231ns
I1208 21:30:00.061552 31385 replica.cpp:713] Persisted action at 2
I1208 21:30:00.061578 31385 replica.cpp:698] Replica learned TRUNCATE action at position 2
I1208 21:30:00.069306 31357 scheduler.cpp:154] Version: 0.27.0
I1208 21:30:00.070005 31389 scheduler.cpp:236] New master detected at master@172.17.1.252:59639
I1208 21:30:00.071329 31380 scheduler.cpp:298] Sending SUBSCRIBE call to master@172.17.1.252:59639
I1208 21:30:00.073328 31383 process.cpp:3077] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I1208 21:30:00.073395 31383 http.cpp:336] HTTP POST for /master/api/v1/scheduler from 172.17.1.252:44769
I1208 21:30:00.073662 31383 master.cpp:1899] Received subscription request for HTTP framework 'default'
I1208 21:30:00.073746 31383 master.cpp:1676] Authorizing framework principal 'test-principal' to receive offers for role '*'
I1208 21:30:00.074131 31383 master.cpp:1991] Subscribing framework 'default' with checkpointing disabled and capabilities [ ]
I1208 21:30:00.074731 31387 hierarchical.cpp:267] Added framework e0c74ba6-5bb6-4900-9637-3ed4c356af49-0000
I1208 21:30:00.074800 31378 master.hpp:1583] Sending heartbeat to e0c74ba6-5bb6-4900-9637-3ed4c356af49-0000
I1208 21:30:00.074847 31387 hierarchical.cpp:1317] No resources available to allocate!
I1208 21:30:00.074909 31387 hierarchical.cpp:1410] No inverse offers to send out!
I1208 21:30:00.074951 31387 hierarchical.cpp:1063] Performed allocation for 0 slaves in 183455ns
I1208 21:30:00.075960 31381 scheduler.cpp:457] Enqueuing event SUBSCRIBED received from master@172.17.1.252:59639
I1208 21:30:00.076534 31381 scheduler.cpp:457] Enqueuing event HEARTBEAT received from master@172.17.1.252:59639
I1208 21:30:00.077265 31377 master_maintenance_tests.cpp:177] Ignoring HEARTBEAT event
I1208 21:30:00.077380 31381 scheduler.cpp:298] Sending REQUEST call to master@172.17.1.252:59639
I1208 21:30:00.079185 31386 process.cpp:3077] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I1208 21:30:00.079267 31386 http.cpp:336] HTTP POST for /master/api/v1/scheduler from 172.17.1.252:44770
I1208 21:30:00.079398 31386 master.cpp:2646] Processing REQUEST call for framework e0c74ba6-5bb6-4900-9637-3ed4c356af49-0000 (default)
I1208 21:30:00.079689 31377 hierarchical.cpp:562] Received resource request from framework e0c74ba6-5bb6-4900-9637-3ed4c356af49-0000
I1208 21:30:00.080013 31378 master.cpp:938] Master terminating
I1208 21:30:00.080286 31390 hierarchical.cpp:308] Removed framework e0c74ba6-5bb6-4900-9637-3ed4c356af49-0000
E1208 21:30:00.081320 31389 scheduler.cpp:431] End-Of-File received from master. The master closed the event stream
[ OK ] ContentType/SchedulerTest.Request/0 (903 ms)
[ RUN ] ContentType/SchedulerTest.Request/1
I1208 21:30:00.250023 31357 leveldb.cpp:174] Opened db in 152.242077ms
I1208 21:30:00.304741 31357 leveldb.cpp:181] Compacted db in 54.662239ms
I1208 21:30:00.304816 31357 leveldb.cpp:196] Created db iterator in 26612ns
I1208 21:30:00.304836 31357 leveldb.cpp:202] Seeked to beginning of db in 2150ns
I1208 21:30:00.304848 31357 leveldb.cpp:271] Iterated through 0 keys in the db in 330ns
I1208 21:30:00.304903 31357 replica.cpp:778] Replica recovered with log positions 0 -> 0 with 1 holes and 0 unlearned
I1208 21:30:00.305479 31378 recover.cpp:447] Starting replica recovery
I1208 21:30:00.306041 31378 recover.cpp:473] Replica is in EMPTY status
I1208 21:30:00.307309 31385 replica.cpp:674] Replica in EMPTY status received a broadcasted recover request from (11545)@172.17.1.252:59639
I1208 21:30:00.307777 31382 recover.cpp:193] Received a recover response from a replica in EMPTY status
I1208 21:30:00.308275 31386 master.cpp:365] Master 5f4f4a7d-62f3-4ea2-9fb1-095edff6d348 (88c80f39a34d) started on 172.17.1.252:59639
I1208 21:30:00.308455 31377 recover.cpp:564] Updating replica status to STARTING
I1208 21:30:00.308308 31386 master.cpp:367] Flags at startup: --acls="" --allocation_interval="1secs" --allocator="HierarchicalDRF" --authenticate="false" --authenticate_slaves="true" --authenticators="crammd5" --authorizers="local" --credentials="/tmp/wp070l/credentials" --framework_sorter="drf" --help="false" --hostname_lookup="true" --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/wp070l/master" --zk_session_timeout="10secs"
I1208 21:30:00.308698 31386 master.cpp:414] Master allowing unauthenticated frameworks to register
I1208 21:30:00.308715 31386 master.cpp:417] Master only allowing authenticated slaves to register
I1208 21:30:00.308724 31386 credentials.hpp:35] Loading credentials for authentication from '/tmp/wp070l/credentials'
I1208 21:30:00.309047 31386 master.cpp:456] Using default 'crammd5' authenticator
I1208 21:30:00.309247 31386 master.cpp:493] Authorization enabled
I1208 21:30:00.309530 31381 whitelist_watcher.cpp:77] No whitelist given
I1208 21:30:00.309602 31383 hierarchical.cpp:163] Initialized hierarchical allocator process
I1208 21:30:00.311441 31385 master.cpp:1637] The newly elected leader is master@172.17.1.252:59639 with id 5f4f4a7d-62f3-4ea2-9fb1-095edff6d348
I1208 21:30:00.311486 31385 master.cpp:1650] Elected as the leading master!
I1208 21:30:00.311514 31385 master.cpp:1395] Recovering from registrar
I1208 21:30:00.311722 31389 registrar.cpp:307] Recovering registrar
I1208 21:30:00.346858 31382 leveldb.cpp:304] Persisting metadata (8 bytes) to leveldb took 38.132055ms
I1208 21:30:00.346901 31382 replica.cpp:321] Persisted replica status to STARTING
I1208 21:30:00.347152 31390 recover.cpp:473] Replica is in STARTING status
I1208 21:30:00.348354 31379 replica.cpp:674] Replica in STARTING status received a broadcasted recover request from (11546)@172.17.1.252:59639
I1208 21:30:00.348796 31377 recover.cpp:193] Received a recover response from a replica in STARTING status
I1208 21:30:00.349331 31386 recover.cpp:564] Updating replica status to VOTING
I1208 21:30:00.388887 31377 leveldb.cpp:304] Persisting metadata (8 bytes) to leveldb took 39.379332ms
I1208 21:30:00.388934 31377 replica.cpp:321] Persisted replica status to VOTING
I1208 21:30:00.389060 31385 recover.cpp:578] Successfully joined the Paxos group
I1208 21:30:00.389348 31385 recover.cpp:462] Recover process terminated
I1208 21:30:00.389803 31385 log.cpp:659] Attempting to start the writer
I1208 21:30:00.391243 31378 replica.cpp:494] Replica received implicit promise request from (11547)@172.17.1.252:59639 with proposal 1
I1208 21:30:00.472519 31378 leveldb.cpp:304] Persisting metadata (8 bytes) to leveldb took 81.226661ms
I1208 21:30:00.472565 31378 replica.cpp:343] Persisted promised to 1
I1208 21:30:00.473417 31384 coordinator.cpp:238] Coordinator attempting to fill missing positions
I1208 21:30:00.474838 31377 replica.cpp:389] Replica received explicit promise request from (11548)@172.17.1.252:59639 for position 0 with proposal 2
I1208 21:30:00.531353 31377 leveldb.cpp:341] Persisting action (8 bytes) to leveldb took 56.459449ms
I1208 21:30:00.531411 31377 replica.cpp:713] Persisted action at 0
I1208 21:30:00.532835 31386 replica.cpp:538] Replica received write request for position 0 from (11549)@172.17.1.252:59639
I1208 21:30:00.532912 31386 leveldb.cpp:436] Reading position from leveldb took 35779ns
I1208 21:30:00.577996 31386 leveldb.cpp:341] Persisting action (14 bytes) to leveldb took 45.029936ms
I1208 21:30:00.578042 31386 replica.cpp:713] Persisted action at 0
I1208 21:30:00.578706 31377 replica.cpp:692] Replica received learned notice for position 0 from @0.0.0.0:0
I1208 21:30:00.595566 31377 leveldb.cpp:341] Persisting action (16 bytes) to leveldb took 16.767111ms
I1208 21:30:00.595607 31377 replica.cpp:713] Persisted action at 0
I1208 21:30:00.595630 31377 replica.cpp:698] Replica learned NOP action at position 0
I1208 21:30:00.596364 31385 log.cpp:675] Writer started with ending position 0
I1208 21:30:00.597523 31379 leveldb.cpp:436] Reading position from leveldb took 34411ns
I1208 21:30:00.598517 31382 registrar.cpp:340] Successfully fetched the registry (0B) in 286.738944ms
I1208 21:30:00.598651 31382 registrar.cpp:439] Applied 1 operations in 30099ns; attempting to update the 'registry'
I1208 21:30:00.599488 31383 log.cpp:683] Attempting to append 176 bytes to the log
I1208 21:30:00.599772 31376 coordinator.cpp:348] Coordinator attempting to write APPEND action at position 1
I1208 21:30:00.600641 31388 replica.cpp:538] Replica received write request for position 1 from (11550)@172.17.1.252:59639
I1208 21:30:00.620813 31388 leveldb.cpp:341] Persisting action (195 bytes) to leveldb took 20.124465ms
I1208 21:30:00.620853 31388 replica.cpp:713] Persisted action at 1
I1208 21:30:00.621642 31384 replica.cpp:692] Replica received learned notice for position 1 from @0.0.0.0:0
I1208 21:30:00.671159 31384 leveldb.cpp:341] Persisting action (197 bytes) to leveldb took 49.477334ms
I1208 21:30:00.671224 31384 replica.cpp:713] Persisted action at 1
I1208 21:30:00.671258 31384 replica.cpp:698] Replica learned APPEND action at position 1
I1208 21:30:00.672355 31385 registrar.cpp:484] Successfully updated the 'registry' in 73.638144ms
I1208 21:30:00.672540 31385 registrar.cpp:370] Successfully recovered registrar
I1208 21:30:00.672601 31381 log.cpp:702] Attempting to truncate the log to 1
I1208 21:30:00.672729 31384 coordinator.cpp:348] Coordinator attempting to write TRUNCATE action at position 2
I1208 21:30:00.673302 31382 master.cpp:1447] Recovered 0 slaves from the Registry (137B) ; allowing 10mins for slaves to re-register
I1208 21:30:00.673338 31391 hierarchical.cpp:181] Skipping recovery of hierarchical allocator: nothing to recover
I1208 21:30:00.673835 31379 replica.cpp:538] Replica received write request for position 2 from (11551)@172.17.1.252:59639
I1208 21:30:00.704854 31379 leveldb.cpp:341] Persisting action (16 bytes) to leveldb took 30.966686ms
I1208 21:30:00.704892 31379 replica.cpp:713] Persisted action at 2
I1208 21:30:00.705435 31388 replica.cpp:692] Replica received learned notice for position 2 from @0.0.0.0:0
I1208 21:30:00.741215 31388 leveldb.cpp:341] Persisting action (18 bytes) to leveldb took 35.745488ms
I1208 21:30:00.741299 31388 leveldb.cpp:399] Deleting ~1 keys from leveldb took 42758ns
I1208 21:30:00.741322 31388 replica.cpp:713] Persisted action at 2
I1208 21:30:00.741346 31388 replica.cpp:698] Replica learned TRUNCATE action at position 2
I1208 21:30:00.744415 31357 scheduler.cpp:154] Version: 0.27.0
I1208 21:30:00.745091 31378 scheduler.cpp:236] New master detected at master@172.17.1.252:59639
I1208 21:30:00.745939 31389 scheduler.cpp:298] Sending SUBSCRIBE call to master@172.17.1.252:59639
I1208 21:30:00.747658 31377 process.cpp:3077] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I1208 21:30:00.747712 31377 http.cpp:336] HTTP POST for /master/api/v1/scheduler from 172.17.1.252:44771
I1208 21:30:00.747992 31377 master.cpp:1899] Received subscription request for HTTP framework 'default'
I1208 21:30:00.748051 31377 master.cpp:1676] Authorizing framework principal 'test-principal' to receive offers for role '*'
I1208 21:30:00.748445 31377 master.cpp:1991] Subscribing framework 'default' with checkpointing disabled and capabilities [ ]
I1208 21:30:00.748778 31378 hierarchical.cpp:267] Added framework 5f4f4a7d-62f3-4ea2-9fb1-095edff6d348-0000
I1208 21:30:00.748845 31378 hierarchical.cpp:1317] No resources available to allocate!
I1208 21:30:00.748893 31384 master.hpp:1583] Sending heartbeat to 5f4f4a7d-62f3-4ea2-9fb1-095edff6d348-0000
I1208 21:30:00.748980 31378 hierarchical.cpp:1410] No inverse offers to send out!
I1208 21:30:00.749092 31378 hierarchical.cpp:1063] Performed allocation for 0 slaves in 285758ns
I1208 21:30:00.749724 31391 scheduler.cpp:457] Enqueuing event SUBSCRIBED received from master@172.17.1.252:59639
I1208 21:30:00.750116 31391 scheduler.cpp:457] Enqueuing event HEARTBEAT received from master@172.17.1.252:59639
I1208 21:30:00.750694 31391 scheduler.cpp:298] Sending REQUEST call to master@172.17.1.252:59639
I1208 21:30:00.750705 31384 master_maintenance_tests.cpp:177] Ignoring HEARTBEAT event
I1208 21:30:00.752147 31382 process.cpp:3077] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I1208 21:30:00.752322 31382 http.cpp:336] HTTP POST for /master/api/v1/scheduler from 172.17.1.252:44772
I1208 21:30:00.752527 31382 master.cpp:2646] Processing REQUEST call for framework 5f4f4a7d-62f3-4ea2-9fb1-095edff6d348-0000 (default)
I1208 21:30:00.752668 31377 hierarchical.cpp:562] Received resource request from framework 5f4f4a7d-62f3-4ea2-9fb1-095edff6d348-0000
I1208 21:30:00.752941 31391 master.cpp:938] Master terminating
I1208 21:30:00.753080 31387 hierarchical.cpp:308] Removed framework 5f4f4a7d-62f3-4ea2-9fb1-095edff6d348-0000
E1208 21:30:00.754215 31387 scheduler.cpp:431] End-Of-File received from master. The master closed the event stream
[ OK ] ContentType/SchedulerTest.Request/1 (661 ms)
[----------] 22 tests from ContentType/SchedulerTest (19360 ms total)
[----------] Global test environment tear-down
[==========] 882 tests from 116 test cases ran. (802398 ms total)
[ PASSED ] 881 tests.
[ FAILED ] 1 test, listed below:
[ FAILED ] HealthTest.ObserveEndpoint
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-1449607651-6763
Untagged: mesos-1449607651-6763:latest
Deleted: ab2de609d7232cc651830c8130d32e49ca687d1cd596cadb96979bdf671948f0
Deleted: 74d81ac4fe3b53b65b5e24e884f2c8def32459d409346afa4c0da164a3b45537
Deleted: 5dc37bea8e602c646de4e84d360d0e740309962350564ba0fafe4b8255d04027
Deleted: 1728ed8fe860ac2d69561e47ffedaebc2cb076e8886030f1192a863241004a5a
Deleted: cbd3d109e0235e04a8d66c65097e78713d15b7df40e771af40533acd2fc0e713
Deleted: 4d2fd951518baa7600c62f55a9f7b4afaa82316deec5dd861f31741802ad085b
Deleted: 568d2cc0b92795103477e28dc62d4309f84d3650a86539814a63938bd965e38a
Deleted: bad787e07a763b95aa827850c2515ecd41a593ace1d86203fd3bacc48ae1b519
Deleted: 2ec9aa7ddfe23621da26f0e2a3940a0c8d9b6366e24cf8df1194127ac4f0d823
Deleted: 14466704bdcd1b9b928da968cd93d95ae66eb2ce8a5b4a9c320c0996dab64bc0
Deleted: 124541d73157eb48d21161e8ee19b1eb8ea80ec0191480b22413ba78d9353fab
Deleted: dfa6d17b3cf374abd722f560b63633585b68091d214b9157ed44721077563afe
Build step 'Execute shell' marked build as failure
Jenkins build is back to normal : Mesos » gcc,--verbose,centos:7,docker||Hadoop #1332
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/Mesos/COMPILER=gcc,CONFIGURATION=--verbose,OS=centos%3A7,label_exp=docker%7C%7CHadoop/1332/changes>