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/08 02:15:41 UTC
Build failed in Jenkins: Mesos » gcc,--verbose --enable-libevent --enable-ssl,centos:7,docker||Hadoop #1457
See <https://builds.apache.org/job/Mesos/COMPILER=gcc,CONFIGURATION=--verbose%20--enable-libevent%20--enable-ssl,OS=centos%3A7,label_exp=docker%7C%7CHadoop/1457/changes>
Changes:
[adam] Disabled flaky/failing TerminatingSlaveDoesNotReregister test.
------------------------------------------
[...truncated 153909 lines...]
I0108 01:15:43.746836 1359 gc.cpp:54] Scheduling '/tmp/ContentType_SchedulerTest_Message_1_YnW5sT/slaves/6089e8b0-5cd7-4105-88bb-2a7d4ba5033c-S0/frameworks/6089e8b0-5cd7-4105-88bb-2a7d4ba5033c-0000/executors/default/runs/3cf1d709-8162-4021-bf81-67337522f42d' for gc 6.99999135696889days in the future
I0108 01:15:43.746981 1351 slave.cpp:3942] Cleaning up framework 6089e8b0-5cd7-4105-88bb-2a7d4ba5033c-0000
I0108 01:15:43.747202 1359 gc.cpp:54] Scheduling '/tmp/ContentType_SchedulerTest_Message_1_YnW5sT/slaves/6089e8b0-5cd7-4105-88bb-2a7d4ba5033c-S0/frameworks/6089e8b0-5cd7-4105-88bb-2a7d4ba5033c-0000/executors/default' for gc 6.99999135517333days in the future
I0108 01:15:43.747262 1350 status_update_manager.cpp:282] Closing status update streams for framework 6089e8b0-5cd7-4105-88bb-2a7d4ba5033c-0000
I0108 01:15:43.747501 1350 status_update_manager.cpp:528] Cleaning up status update stream for task f7d8ca9b-beee-4b5e-85da-6464bea61f2c of framework 6089e8b0-5cd7-4105-88bb-2a7d4ba5033c-0000
I0108 01:15:43.747570 1359 gc.cpp:54] Scheduling '/tmp/ContentType_SchedulerTest_Message_1_YnW5sT/slaves/6089e8b0-5cd7-4105-88bb-2a7d4ba5033c-S0/frameworks/6089e8b0-5cd7-4105-88bb-2a7d4ba5033c-0000' for gc 6.99999135107556days in the future
[ OK ] ContentType/SchedulerTest.Message/1 (100 ms)
[ RUN ] ContentType/SchedulerTest.Request/0
I0108 01:15:43.755234 1325 leveldb.cpp:174] Opened db in 2.542473ms
I0108 01:15:43.756042 1325 leveldb.cpp:181] Compacted db in 689905ns
I0108 01:15:43.756144 1325 leveldb.cpp:196] Created db iterator in 19851ns
I0108 01:15:43.756240 1325 leveldb.cpp:202] Seeked to beginning of db in 2112ns
I0108 01:15:43.756326 1325 leveldb.cpp:271] Iterated through 0 keys in the db in 457ns
I0108 01:15:43.756443 1325 replica.cpp:779] Replica recovered with log positions 0 -> 0 with 1 holes and 0 unlearned
I0108 01:15:43.756991 1357 recover.cpp:447] Starting replica recovery
I0108 01:15:43.757303 1352 recover.cpp:473] Replica is in EMPTY status
I0108 01:15:43.758620 1357 replica.cpp:673] Replica in EMPTY status received a broadcasted recover request from (12944)@172.17.0.2:32801
I0108 01:15:43.759131 1358 recover.cpp:193] Received a recover response from a replica in EMPTY status
I0108 01:15:43.760004 1358 recover.cpp:564] Updating replica status to STARTING
I0108 01:15:43.760980 1358 leveldb.cpp:304] Persisting metadata (8 bytes) to leveldb took 610077ns
I0108 01:15:43.760990 1352 master.cpp:365] Master 92c71da8-e7d7-417a-bc6e-c019214ad008 (d9632dd1c41e) started on 172.17.0.2:32801
I0108 01:15:43.761075 1358 replica.cpp:320] Persisted replica status to STARTING
I0108 01:15:43.761085 1352 master.cpp:367] Flags at startup: --acls="" --allocation_interval="1secs" --allocator="HierarchicalDRF" --authenticate="false" --authenticate_slaves="true" --authenticators="crammd5" --authorizers="local" --credentials="/tmp/vjYx2e/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/vjYx2e/master" --zk_session_timeout="10secs"
I0108 01:15:43.761386 1352 master.cpp:414] Master allowing unauthenticated frameworks to register
I0108 01:15:43.761399 1352 master.cpp:417] Master only allowing authenticated slaves to register
I0108 01:15:43.761407 1352 credentials.hpp:35] Loading credentials for authentication from '/tmp/vjYx2e/credentials'
I0108 01:15:43.761617 1358 recover.cpp:473] Replica is in STARTING status
I0108 01:15:43.761714 1352 master.cpp:456] Using default 'crammd5' authenticator
I0108 01:15:43.761843 1352 master.cpp:493] Authorization enabled
I0108 01:15:43.762121 1351 hierarchical.cpp:147] Initialized hierarchical allocator process
I0108 01:15:43.762367 1359 whitelist_watcher.cpp:77] No whitelist given
I0108 01:15:43.763084 1344 replica.cpp:673] Replica in STARTING status received a broadcasted recover request from (12945)@172.17.0.2:32801
I0108 01:15:43.763512 1348 recover.cpp:193] Received a recover response from a replica in STARTING status
I0108 01:15:43.764020 1349 recover.cpp:564] Updating replica status to VOTING
I0108 01:15:43.764716 1347 leveldb.cpp:304] Persisting metadata (8 bytes) to leveldb took 434648ns
I0108 01:15:43.764742 1347 replica.cpp:320] Persisted replica status to VOTING
I0108 01:15:43.765203 1359 master.cpp:1629] The newly elected leader is master@172.17.0.2:32801 with id 92c71da8-e7d7-417a-bc6e-c019214ad008
I0108 01:15:43.765209 1349 recover.cpp:578] Successfully joined the Paxos group
I0108 01:15:43.765240 1359 master.cpp:1642] Elected as the leading master!
I0108 01:15:43.765261 1359 master.cpp:1387] Recovering from registrar
I0108 01:15:43.765435 1345 registrar.cpp:307] Recovering registrar
I0108 01:15:43.765590 1349 recover.cpp:462] Recover process terminated
I0108 01:15:43.766433 1353 log.cpp:659] Attempting to start the writer
I0108 01:15:43.767930 1356 replica.cpp:493] Replica received implicit promise request from (12946)@172.17.0.2:32801 with proposal 1
I0108 01:15:43.768350 1356 leveldb.cpp:304] Persisting metadata (8 bytes) to leveldb took 378801ns
I0108 01:15:43.768373 1356 replica.cpp:342] Persisted promised to 1
I0108 01:15:43.769183 1359 coordinator.cpp:238] Coordinator attempting to fill missing positions
I0108 01:15:43.770367 1347 replica.cpp:388] Replica received explicit promise request from (12947)@172.17.0.2:32801 for position 0 with proposal 2
I0108 01:15:43.770697 1347 leveldb.cpp:341] Persisting action (8 bytes) to leveldb took 289280ns
I0108 01:15:43.770725 1347 replica.cpp:712] Persisted action at 0
I0108 01:15:43.771877 1356 replica.cpp:537] Replica received write request for position 0 from (12948)@172.17.0.2:32801
I0108 01:15:43.771935 1356 leveldb.cpp:436] Reading position from leveldb took 29358ns
I0108 01:15:43.772353 1356 leveldb.cpp:341] Persisting action (14 bytes) to leveldb took 364949ns
I0108 01:15:43.772377 1356 replica.cpp:712] Persisted action at 0
I0108 01:15:43.773003 1353 replica.cpp:691] Replica received learned notice for position 0 from @0.0.0.0:0
I0108 01:15:43.773563 1353 leveldb.cpp:341] Persisting action (16 bytes) to leveldb took 443351ns
I0108 01:15:43.773602 1353 replica.cpp:712] Persisted action at 0
I0108 01:15:43.773627 1353 replica.cpp:697] Replica learned NOP action at position 0
I0108 01:15:43.774176 1359 log.cpp:675] Writer started with ending position 0
I0108 01:15:43.775185 1349 leveldb.cpp:436] Reading position from leveldb took 42678ns
I0108 01:15:43.776077 1358 registrar.cpp:340] Successfully fetched the registry (0B) in 10.58304ms
I0108 01:15:43.776196 1358 registrar.cpp:439] Applied 1 operations in 28656ns; attempting to update the 'registry'
I0108 01:15:43.776850 1353 log.cpp:683] Attempting to append 170 bytes to the log
I0108 01:15:43.777051 1356 coordinator.cpp:348] Coordinator attempting to write APPEND action at position 1
I0108 01:15:43.777712 1347 replica.cpp:537] Replica received write request for position 1 from (12949)@172.17.0.2:32801
I0108 01:15:43.778061 1347 leveldb.cpp:341] Persisting action (189 bytes) to leveldb took 307285ns
I0108 01:15:43.778084 1347 replica.cpp:712] Persisted action at 1
I0108 01:15:43.778625 1358 replica.cpp:691] Replica received learned notice for position 1 from @0.0.0.0:0
I0108 01:15:43.778916 1358 leveldb.cpp:341] Persisting action (191 bytes) to leveldb took 263371ns
I0108 01:15:43.778941 1358 replica.cpp:712] Persisted action at 1
I0108 01:15:43.778981 1358 replica.cpp:697] Replica learned APPEND action at position 1
I0108 01:15:43.779803 1356 registrar.cpp:484] Successfully updated the 'registry' in 3.544064ms
I0108 01:15:43.779968 1356 registrar.cpp:370] Successfully recovered registrar
I0108 01:15:43.780058 1357 log.cpp:702] Attempting to truncate the log to 1
I0108 01:15:43.780279 1355 coordinator.cpp:348] Coordinator attempting to write TRUNCATE action at position 2
I0108 01:15:43.780534 1346 master.cpp:1439] Recovered 0 slaves from the Registry (131B) ; allowing 10mins for slaves to re-register
I0108 01:15:43.780580 1357 hierarchical.cpp:165] Skipping recovery of hierarchical allocator: nothing to recover
I0108 01:15:43.781052 1346 replica.cpp:537] Replica received write request for position 2 from (12950)@172.17.0.2:32801
I0108 01:15:43.781395 1346 leveldb.cpp:341] Persisting action (16 bytes) to leveldb took 302232ns
I0108 01:15:43.781417 1346 replica.cpp:712] Persisted action at 2
I0108 01:15:43.782009 1358 replica.cpp:691] Replica received learned notice for position 2 from @0.0.0.0:0
I0108 01:15:43.782311 1358 leveldb.cpp:341] Persisting action (18 bytes) to leveldb took 271471ns
I0108 01:15:43.782358 1358 leveldb.cpp:399] Deleting ~1 keys from leveldb took 24308ns
I0108 01:15:43.782377 1358 replica.cpp:712] Persisted action at 2
I0108 01:15:43.782392 1358 replica.cpp:697] Replica learned TRUNCATE action at position 2
I0108 01:15:43.791069 1325 scheduler.cpp:154] Version: 0.27.0
I0108 01:15:43.791728 1355 scheduler.cpp:236] New master detected at master@172.17.0.2:32801
I0108 01:15:43.792979 1348 scheduler.cpp:298] Sending SUBSCRIBE call to master@172.17.0.2:32801
I0108 01:15:43.795135 1359 process.cpp:3141] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I0108 01:15:43.795833 1359 http.cpp:315] HTTP POST for /master/api/v1/scheduler from 172.17.0.2:54790
I0108 01:15:43.796161 1359 master.cpp:1891] Received subscription request for HTTP framework 'default'
I0108 01:15:43.796301 1359 master.cpp:1668] Authorizing framework principal 'test-principal' to receive offers for role '*'
I0108 01:15:43.797760 1359 master.cpp:1982] Subscribing framework 'default' with checkpointing disabled and capabilities [ ]
I0108 01:15:43.798355 1356 hierarchical.cpp:260] Added framework 92c71da8-e7d7-417a-bc6e-c019214ad008-0000
I0108 01:15:43.798434 1356 hierarchical.cpp:1329] No resources available to allocate!
I0108 01:15:43.798473 1356 hierarchical.cpp:1423] No inverse offers to send out!
I0108 01:15:43.798499 1356 hierarchical.cpp:1079] Performed allocation for 0 slaves in 113813ns
I0108 01:15:43.798993 1352 master.hpp:1662] Sending heartbeat to 92c71da8-e7d7-417a-bc6e-c019214ad008-0000
I0108 01:15:43.799540 1359 scheduler.cpp:457] Enqueuing event SUBSCRIBED received from master@172.17.0.2:32801
I0108 01:15:43.800511 1359 scheduler.cpp:457] Enqueuing event HEARTBEAT received from master@172.17.0.2:32801
I0108 01:15:43.801496 1359 scheduler.cpp:298] Sending REQUEST call to master@172.17.0.2:32801
I0108 01:15:43.804383 1358 process.cpp:3141] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I0108 01:15:43.805138 1358 http.cpp:315] HTTP POST for /master/api/v1/scheduler from 172.17.0.2:54791
I0108 01:15:43.805389 1358 master.cpp:2636] Processing REQUEST call for framework 92c71da8-e7d7-417a-bc6e-c019214ad008-0000 (default)
I0108 01:15:43.805711 1352 hierarchical.cpp:579] Received resource request from framework 92c71da8-e7d7-417a-bc6e-c019214ad008-0000
I0108 01:15:43.807724 1358 master.cpp:930] Master terminating
I0108 01:15:43.807945 1354 hierarchical.cpp:321] Removed framework 92c71da8-e7d7-417a-bc6e-c019214ad008-0000
E0108 01:15:43.809092 1359 scheduler.cpp:431] End-Of-File received from master. The master closed the event stream
I0108 01:15:43.809103 1351 master_maintenance_tests.cpp:177] Ignoring HEARTBEAT event
[ OK ] ContentType/SchedulerTest.Request/0 (62 ms)
[ RUN ] ContentType/SchedulerTest.Request/1
I0108 01:15:43.816985 1325 leveldb.cpp:174] Opened db in 2.518146ms
I0108 01:15:43.817798 1325 leveldb.cpp:181] Compacted db in 778415ns
I0108 01:15:43.817852 1325 leveldb.cpp:196] Created db iterator in 20628ns
I0108 01:15:43.817876 1325 leveldb.cpp:202] Seeked to beginning of db in 1946ns
I0108 01:15:43.817893 1325 leveldb.cpp:271] Iterated through 0 keys in the db in 555ns
I0108 01:15:43.817942 1325 replica.cpp:779] Replica recovered with log positions 0 -> 0 with 1 holes and 0 unlearned
I0108 01:15:43.818445 1355 recover.cpp:447] Starting replica recovery
I0108 01:15:43.818794 1355 recover.cpp:473] Replica is in EMPTY status
I0108 01:15:43.819813 1356 replica.cpp:673] Replica in EMPTY status received a broadcasted recover request from (12958)@172.17.0.2:32801
I0108 01:15:43.820382 1350 recover.cpp:193] Received a recover response from a replica in EMPTY status
I0108 01:15:43.820858 1345 recover.cpp:564] Updating replica status to STARTING
I0108 01:15:43.821437 1353 leveldb.cpp:304] Persisting metadata (8 bytes) to leveldb took 390604ns
I0108 01:15:43.821468 1353 replica.cpp:320] Persisted replica status to STARTING
I0108 01:15:43.821679 1351 recover.cpp:473] Replica is in STARTING status
I0108 01:15:43.821720 1353 master.cpp:365] Master ef4fe11d-a25a-43d9-bf3c-d0b11687ee27 (d9632dd1c41e) started on 172.17.0.2:32801
I0108 01:15:43.821743 1353 master.cpp:367] Flags at startup: --acls="" --allocation_interval="1secs" --allocator="HierarchicalDRF" --authenticate="false" --authenticate_slaves="true" --authenticators="crammd5" --authorizers="local" --credentials="/tmp/O5wcum/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/O5wcum/master" --zk_session_timeout="10secs"
I0108 01:15:43.822177 1353 master.cpp:414] Master allowing unauthenticated frameworks to register
I0108 01:15:43.822198 1353 master.cpp:417] Master only allowing authenticated slaves to register
I0108 01:15:43.822211 1353 credentials.hpp:35] Loading credentials for authentication from '/tmp/O5wcum/credentials'
I0108 01:15:43.822520 1353 master.cpp:456] Using default 'crammd5' authenticator
I0108 01:15:43.822649 1353 master.cpp:493] Authorization enabled
I0108 01:15:43.822708 1352 replica.cpp:673] Replica in STARTING status received a broadcasted recover request from (12959)@172.17.0.2:32801
I0108 01:15:43.822788 1355 whitelist_watcher.cpp:77] No whitelist given
I0108 01:15:43.822813 1359 hierarchical.cpp:147] Initialized hierarchical allocator process
I0108 01:15:43.823192 1344 recover.cpp:193] Received a recover response from a replica in STARTING status
I0108 01:15:43.823617 1351 recover.cpp:564] Updating replica status to VOTING
I0108 01:15:43.824249 1347 leveldb.cpp:304] Persisting metadata (8 bytes) to leveldb took 354905ns
I0108 01:15:43.824275 1347 replica.cpp:320] Persisted replica status to VOTING
I0108 01:15:43.824398 1347 recover.cpp:578] Successfully joined the Paxos group
I0108 01:15:43.824578 1347 recover.cpp:462] Recover process terminated
I0108 01:15:43.824854 1347 master.cpp:1629] The newly elected leader is master@172.17.0.2:32801 with id ef4fe11d-a25a-43d9-bf3c-d0b11687ee27
I0108 01:15:43.824880 1347 master.cpp:1642] Elected as the leading master!
I0108 01:15:43.824898 1347 master.cpp:1387] Recovering from registrar
I0108 01:15:43.825073 1353 registrar.cpp:307] Recovering registrar
I0108 01:15:43.825794 1353 log.cpp:659] Attempting to start the writer
I0108 01:15:43.826925 1352 replica.cpp:493] Replica received implicit promise request from (12960)@172.17.0.2:32801 with proposal 1
I0108 01:15:43.827270 1352 leveldb.cpp:304] Persisting metadata (8 bytes) to leveldb took 299716ns
I0108 01:15:43.827294 1352 replica.cpp:342] Persisted promised to 1
I0108 01:15:43.827877 1344 coordinator.cpp:238] Coordinator attempting to fill missing positions
I0108 01:15:43.828987 1348 replica.cpp:388] Replica received explicit promise request from (12961)@172.17.0.2:32801 for position 0 with proposal 2
I0108 01:15:43.829344 1348 leveldb.cpp:341] Persisting action (8 bytes) to leveldb took 314900ns
I0108 01:15:43.829367 1348 replica.cpp:712] Persisted action at 0
I0108 01:15:43.830354 1349 replica.cpp:537] Replica received write request for position 0 from (12962)@172.17.0.2:32801
I0108 01:15:43.830483 1349 leveldb.cpp:436] Reading position from leveldb took 38991ns
I0108 01:15:43.830894 1349 leveldb.cpp:341] Persisting action (14 bytes) to leveldb took 304213ns
I0108 01:15:43.830917 1349 replica.cpp:712] Persisted action at 0
I0108 01:15:43.831562 1345 replica.cpp:691] Replica received learned notice for position 0 from @0.0.0.0:0
I0108 01:15:43.831993 1345 leveldb.cpp:341] Persisting action (16 bytes) to leveldb took 322785ns
I0108 01:15:43.832018 1345 replica.cpp:712] Persisted action at 0
I0108 01:15:43.832038 1345 replica.cpp:697] Replica learned NOP action at position 0
I0108 01:15:43.832669 1351 log.cpp:675] Writer started with ending position 0
I0108 01:15:43.833644 1359 leveldb.cpp:436] Reading position from leveldb took 30474ns
I0108 01:15:43.834591 1344 registrar.cpp:340] Successfully fetched the registry (0B) in 9.473024ms
I0108 01:15:43.834705 1344 registrar.cpp:439] Applied 1 operations in 26564ns; attempting to update the 'registry'
I0108 01:15:43.835402 1358 log.cpp:683] Attempting to append 170 bytes to the log
I0108 01:15:43.835563 1356 coordinator.cpp:348] Coordinator attempting to write APPEND action at position 1
I0108 01:15:43.836282 1358 replica.cpp:537] Replica received write request for position 1 from (12963)@172.17.0.2:32801
I0108 01:15:43.836643 1358 leveldb.cpp:341] Persisting action (189 bytes) to leveldb took 326635ns
I0108 01:15:43.836668 1358 replica.cpp:712] Persisted action at 1
I0108 01:15:43.837296 1354 replica.cpp:691] Replica received learned notice for position 1 from @0.0.0.0:0
I0108 01:15:43.837683 1354 leveldb.cpp:341] Persisting action (191 bytes) to leveldb took 360286ns
I0108 01:15:43.837707 1354 replica.cpp:712] Persisted action at 1
I0108 01:15:43.837728 1354 replica.cpp:697] Replica learned APPEND action at position 1
I0108 01:15:43.838575 1346 registrar.cpp:484] Successfully updated the 'registry' in 3.803136ms
I0108 01:15:43.838762 1346 registrar.cpp:370] Successfully recovered registrar
I0108 01:15:43.838840 1347 log.cpp:702] Attempting to truncate the log to 1
I0108 01:15:43.838945 1358 coordinator.cpp:348] Coordinator attempting to write TRUNCATE action at position 2
I0108 01:15:43.839274 1351 master.cpp:1439] Recovered 0 slaves from the Registry (131B) ; allowing 10mins for slaves to re-register
I0108 01:15:43.839318 1348 hierarchical.cpp:165] Skipping recovery of hierarchical allocator: nothing to recover
I0108 01:15:43.840004 1352 replica.cpp:537] Replica received write request for position 2 from (12964)@172.17.0.2:32801
I0108 01:15:43.840417 1352 leveldb.cpp:341] Persisting action (16 bytes) to leveldb took 331142ns
I0108 01:15:43.840440 1352 replica.cpp:712] Persisted action at 2
I0108 01:15:43.841017 1347 replica.cpp:691] Replica received learned notice for position 2 from @0.0.0.0:0
I0108 01:15:43.841341 1347 leveldb.cpp:341] Persisting action (18 bytes) to leveldb took 297299ns
I0108 01:15:43.841389 1347 leveldb.cpp:399] Deleting ~1 keys from leveldb took 24116ns
I0108 01:15:43.841413 1347 replica.cpp:712] Persisted action at 2
I0108 01:15:43.841430 1347 replica.cpp:697] Replica learned TRUNCATE action at position 2
I0108 01:15:43.849781 1325 scheduler.cpp:154] Version: 0.27.0
I0108 01:15:43.850419 1355 scheduler.cpp:236] New master detected at master@172.17.0.2:32801
I0108 01:15:43.851462 1353 scheduler.cpp:298] Sending SUBSCRIBE call to master@172.17.0.2:32801
I0108 01:15:43.853049 1345 process.cpp:3141] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I0108 01:15:43.853494 1356 http.cpp:315] HTTP POST for /master/api/v1/scheduler from 172.17.0.2:54792
I0108 01:15:43.853796 1356 master.cpp:1891] Received subscription request for HTTP framework 'default'
I0108 01:15:43.853863 1356 master.cpp:1668] Authorizing framework principal 'test-principal' to receive offers for role '*'
I0108 01:15:43.854153 1356 master.cpp:1982] Subscribing framework 'default' with checkpointing disabled and capabilities [ ]
I0108 01:15:43.854521 1354 hierarchical.cpp:260] Added framework ef4fe11d-a25a-43d9-bf3c-d0b11687ee27-0000
I0108 01:15:43.854585 1354 hierarchical.cpp:1329] No resources available to allocate!
I0108 01:15:43.854622 1354 hierarchical.cpp:1423] No inverse offers to send out!
I0108 01:15:43.854650 1354 hierarchical.cpp:1079] Performed allocation for 0 slaves in 101452ns
I0108 01:15:43.854681 1354 master.hpp:1662] Sending heartbeat to ef4fe11d-a25a-43d9-bf3c-d0b11687ee27-0000
I0108 01:15:43.855329 1348 scheduler.cpp:457] Enqueuing event SUBSCRIBED received from master@172.17.0.2:32801
I0108 01:15:43.855742 1348 scheduler.cpp:457] Enqueuing event HEARTBEAT received from master@172.17.0.2:32801
I0108 01:15:43.856345 1349 master_maintenance_tests.cpp:177] Ignoring HEARTBEAT event
I0108 01:15:43.856360 1348 scheduler.cpp:298] Sending REQUEST call to master@172.17.0.2:32801
I0108 01:15:43.857589 1357 process.cpp:3141] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I0108 01:15:43.857990 1353 http.cpp:315] HTTP POST for /master/api/v1/scheduler from 172.17.0.2:54793
I0108 01:15:43.858228 1353 master.cpp:2636] Processing REQUEST call for framework ef4fe11d-a25a-43d9-bf3c-d0b11687ee27-0000 (default)
I0108 01:15:43.858561 1356 hierarchical.cpp:579] Received resource request from framework ef4fe11d-a25a-43d9-bf3c-d0b11687ee27-0000
I0108 01:15:43.858993 1358 master.cpp:930] Master terminating
I0108 01:15:43.859226 1349 hierarchical.cpp:321] Removed framework ef4fe11d-a25a-43d9-bf3c-d0b11687ee27-0000
E0108 01:15:43.860128 1355 scheduler.cpp:431] End-Of-File received from master. The master closed the event stream
[ OK ] ContentType/SchedulerTest.Request/1 (51 ms)
[----------] 22 tests from ContentType/SchedulerTest (4203 ms total)
[----------] Global test environment tear-down
[==========] 931 tests from 122 test cases ran. (372853 ms total)
[ PASSED ] 930 tests.
[ FAILED ] 1 test, listed below:
[ FAILED ] PersistentVolumeTest.BadACLNoPrincipal
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-1452213951-21579
Untagged: mesos-1452213951-21579:latest
Deleted: cd6f4a79c2055267f9a0604345127d444c4be9151706956c88612d58650f3070
Deleted: 06a0d721e0841cf2a06c776b5e9e3afb9137746aa7e6df4047ffa64a3c89e2f9
Deleted: cc56438b4dfcbdd854d1cb1fad8c2c1e96571e7bb2feb36440f940ab8db0077e
Deleted: daed4ad4c8665014966a59cea243cb5ab86550df035974a58236922ef8ae68c1
Deleted: 9dc4f1da0efc6fefeb9eee37aa8d43f59c97b4c2710d5a52d5c1ad22a324472e
Deleted: bce35b99da2d06993c826a0398a5edbab11bcb726508bc96dec93cbdc766dd8e
Deleted: 6a20ba0ccb4dbfabab635ba935527ea9a264654fe343f6e98a89f33b72679940
Deleted: 38305848c4494f714fae47ecd57388ca66f200928c14b32f4f9b1b1029af2f9c
Deleted: 19b186f9fa1975b68f326f11be9c73afc7ad238d37f09cf51901ea9075e299fb
Deleted: 90ab5fb09a81b2eff729e98c14891af4ac8b8055191abe9ac145f0bf54ad5397
Deleted: ae4a2a5d7ead7175c327482ced9790fcda57ae12468f12f01a9ed30087e650c2
Deleted: 44f20e9d6a91141dc54cd3703996fcf72f21ed4dc7c138906752f7d776e0cc71
Deleted: 5f01dcb8613f0eeb4e31ab95e9ab0b19536f8ae7974ab9ee4a0d9db68d6e9771
Build step 'Execute shell' marked build as failure
Jenkins build is back to normal : Mesos » gcc,--verbose --enable-libevent --enable-ssl,centos:7,docker||Hadoop #1458
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/Mesos/COMPILER=gcc,CONFIGURATION=--verbose%20--enable-libevent%20--enable-ssl,OS=centos%3A7,label_exp=docker%7C%7CHadoop/1458/changes>