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/11/22 22:06:33 UTC
Build failed in Jenkins: Mesos » gcc,--verbose,ubuntu:14.04,docker||Hadoop #1262
See <https://builds.apache.org/job/Mesos/COMPILER=gcc,CONFIGURATION=--verbose,OS=ubuntu%3A14.04,label_exp=docker%7C%7CHadoop/1262/changes>
Changes:
[joris.van.remoortere] Removed stale comment.
------------------------------------------
[...truncated 145000 lines...]
I1122 21:06:23.762051 30283 slave.cpp:3657] Cleaning up executor 'default' of framework a4be3eda-2ab1-4111-a84a-55c183a1a67f-0000 at executor(132)@172.17.18.24:45738
I1122 21:06:23.762661 30283 slave.cpp:3745] Cleaning up framework a4be3eda-2ab1-4111-a84a-55c183a1a67f-0000
I1122 21:06:23.763118 30288 status_update_manager.cpp:284] Closing status update streams for framework a4be3eda-2ab1-4111-a84a-55c183a1a67f-0000
I1122 21:06:23.763352 30288 status_update_manager.cpp:530] Cleaning up status update stream for task 1720cb12-5ae8-4a4d-9cef-d8e1b51b2fa2 of framework a4be3eda-2ab1-4111-a84a-55c183a1a67f-0000
I1122 21:06:23.762876 30277 gc.cpp:56] Scheduling '/tmp/ContentType_SchedulerTest_Message_1_AqS0li/slaves/a4be3eda-2ab1-4111-a84a-55c183a1a67f-S0/frameworks/a4be3eda-2ab1-4111-a84a-55c183a1a67f-0000/executors/default/runs/aacaa88b-2a7f-4ea2-b36f-7135c54cbb36' for gc 6.99999117526815days in the future
I1122 21:06:23.764049 30277 gc.cpp:56] Scheduling '/tmp/ContentType_SchedulerTest_Message_1_AqS0li/slaves/a4be3eda-2ab1-4111-a84a-55c183a1a67f-S0/frameworks/a4be3eda-2ab1-4111-a84a-55c183a1a67f-0000/executors/default' for gc 6.99999117352889days in the future
I1122 21:06:23.764236 30277 gc.cpp:56] Scheduling '/tmp/ContentType_SchedulerTest_Message_1_AqS0li/slaves/a4be3eda-2ab1-4111-a84a-55c183a1a67f-S0/frameworks/a4be3eda-2ab1-4111-a84a-55c183a1a67f-0000' for gc 6.99999116802074days in the future
[ OK ] ContentType/SchedulerTest.Message/1 (672 ms)
[ RUN ] ContentType/SchedulerTest.Request/0
I1122 21:06:23.883216 30257 leveldb.cpp:176] Opened db in 95.878091ms
I1122 21:06:23.925143 30257 leveldb.cpp:183] Compacted db in 41.850265ms
I1122 21:06:23.925240 30257 leveldb.cpp:198] Created db iterator in 24392ns
I1122 21:06:23.925261 30257 leveldb.cpp:204] Seeked to beginning of db in 3306ns
I1122 21:06:23.925271 30257 leveldb.cpp:273] Iterated through 0 keys in the db in 261ns
I1122 21:06:23.925321 30257 replica.cpp:780] Replica recovered with log positions 0 -> 0 with 1 holes and 0 unlearned
I1122 21:06:23.926393 30281 recover.cpp:449] Starting replica recovery
I1122 21:06:23.926792 30281 recover.cpp:475] Replica is in EMPTY status
I1122 21:06:23.928899 30281 replica.cpp:676] Replica in EMPTY status received a broadcasted recover request from (10751)@172.17.18.24:45738
I1122 21:06:23.929215 30283 recover.cpp:195] Received a recover response from a replica in EMPTY status
I1122 21:06:23.929860 30283 recover.cpp:566] Updating replica status to STARTING
I1122 21:06:23.935590 30277 master.cpp:367] Master ef6d07f8-bcfd-4fbe-b56e-aa1481644b40 (2fc568cdd310) started on 172.17.18.24:45738
I1122 21:06:23.935636 30277 master.cpp:369] Flags at startup: --acls="" --allocation_interval="1secs" --allocator="HierarchicalDRF" --authenticate="false" --authenticate_slaves="true" --authenticators="crammd5" --authorizers="local" --credentials="/tmp/AXdr4S/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.26.0/_inst/share/mesos/webui" --work_dir="/tmp/AXdr4S/master" --zk_session_timeout="10secs"
I1122 21:06:23.936024 30277 master.cpp:416] Master allowing unauthenticated frameworks to register
I1122 21:06:23.936038 30277 master.cpp:419] Master only allowing authenticated slaves to register
I1122 21:06:23.936046 30277 credentials.hpp:37] Loading credentials for authentication from '/tmp/AXdr4S/credentials'
I1122 21:06:23.936409 30277 master.cpp:458] Using default 'crammd5' authenticator
I1122 21:06:23.936612 30277 master.cpp:495] Authorization enabled
I1122 21:06:23.936997 30278 whitelist_watcher.cpp:79] No whitelist given
I1122 21:06:23.937077 30285 hierarchical.cpp:153] Initialized hierarchical allocator process
I1122 21:06:23.939355 30276 master.cpp:1627] The newly elected leader is master@172.17.18.24:45738 with id ef6d07f8-bcfd-4fbe-b56e-aa1481644b40
I1122 21:06:23.939488 30276 master.cpp:1640] Elected as the leading master!
I1122 21:06:23.939625 30276 master.cpp:1385] Recovering from registrar
I1122 21:06:23.939838 30285 registrar.cpp:309] Recovering registrar
I1122 21:06:23.965543 30286 leveldb.cpp:306] Persisting metadata (8 bytes) to leveldb took 35.346985ms
I1122 21:06:23.965631 30286 replica.cpp:323] Persisted replica status to STARTING
I1122 21:06:23.966009 30290 recover.cpp:475] Replica is in STARTING status
I1122 21:06:23.968143 30281 replica.cpp:676] Replica in STARTING status received a broadcasted recover request from (10752)@172.17.18.24:45738
I1122 21:06:23.968703 30281 recover.cpp:195] Received a recover response from a replica in STARTING status
I1122 21:06:23.969563 30281 recover.cpp:566] Updating replica status to VOTING
I1122 21:06:23.990767 30281 leveldb.cpp:306] Persisting metadata (8 bytes) to leveldb took 20.796817ms
I1122 21:06:23.990859 30281 replica.cpp:323] Persisted replica status to VOTING
I1122 21:06:23.991117 30281 recover.cpp:580] Successfully joined the Paxos group
I1122 21:06:23.991483 30281 recover.cpp:464] Recover process terminated
I1122 21:06:23.992352 30291 log.cpp:661] Attempting to start the writer
I1122 21:06:23.993865 30284 replica.cpp:496] Replica received implicit promise request from (10753)@172.17.18.24:45738 with proposal 1
I1122 21:06:24.016268 30284 leveldb.cpp:306] Persisting metadata (8 bytes) to leveldb took 22.321364ms
I1122 21:06:24.016363 30284 replica.cpp:345] Persisted promised to 1
I1122 21:06:24.017673 30284 coordinator.cpp:240] Coordinator attempting to fill missing positions
I1122 21:06:24.019773 30278 replica.cpp:391] Replica received explicit promise request from (10754)@172.17.18.24:45738 for position 0 with proposal 2
I1122 21:06:24.040995 30278 leveldb.cpp:343] Persisting action (8 bytes) to leveldb took 20.912381ms
I1122 21:06:24.041262 30278 replica.cpp:715] Persisted action at 0
I1122 21:06:24.043714 30288 replica.cpp:540] Replica received write request for position 0 from (10755)@172.17.18.24:45738
I1122 21:06:24.043814 30288 leveldb.cpp:438] Reading position from leveldb took 46560ns
I1122 21:06:24.066151 30288 leveldb.cpp:343] Persisting action (14 bytes) to leveldb took 22.267754ms
I1122 21:06:24.066265 30288 replica.cpp:715] Persisted action at 0
I1122 21:06:24.067286 30283 replica.cpp:694] Replica received learned notice for position 0 from @0.0.0.0:0
I1122 21:06:24.091291 30283 leveldb.cpp:343] Persisting action (16 bytes) to leveldb took 23.953203ms
I1122 21:06:24.091379 30283 replica.cpp:715] Persisted action at 0
I1122 21:06:24.091416 30283 replica.cpp:700] Replica learned NOP action at position 0
I1122 21:06:24.092535 30278 log.cpp:677] Writer started with ending position 0
I1122 21:06:24.093783 30281 leveldb.cpp:438] Reading position from leveldb took 58857ns
I1122 21:06:24.096320 30281 registrar.cpp:342] Successfully fetched the registry (0B) in 155.036928ms
I1122 21:06:24.096485 30281 registrar.cpp:441] Applied 1 operations in 38333ns; attempting to update the 'registry'
I1122 21:06:24.097491 30289 log.cpp:685] Attempting to append 176 bytes to the log
I1122 21:06:24.097832 30289 coordinator.cpp:350] Coordinator attempting to write APPEND action at position 1
I1122 21:06:24.098979 30280 replica.cpp:540] Replica received write request for position 1 from (10756)@172.17.18.24:45738
I1122 21:06:24.116448 30280 leveldb.cpp:343] Persisting action (195 bytes) to leveldb took 17.31149ms
I1122 21:06:24.116664 30280 replica.cpp:715] Persisted action at 1
I1122 21:06:24.117858 30281 replica.cpp:694] Replica received learned notice for position 1 from @0.0.0.0:0
I1122 21:06:24.141564 30281 leveldb.cpp:343] Persisting action (197 bytes) to leveldb took 23.542947ms
I1122 21:06:24.141800 30281 replica.cpp:715] Persisted action at 1
I1122 21:06:24.141983 30281 replica.cpp:700] Replica learned APPEND action at position 1
I1122 21:06:24.143507 30280 registrar.cpp:486] Successfully updated the 'registry' in 46.946816ms
I1122 21:06:24.144189 30291 log.cpp:704] Attempting to truncate the log to 1
I1122 21:06:24.144455 30281 coordinator.cpp:350] Coordinator attempting to write TRUNCATE action at position 2
I1122 21:06:24.144547 30280 registrar.cpp:372] Successfully recovered registrar
I1122 21:06:24.144995 30283 master.cpp:1437] Recovered 0 slaves from the Registry (137B) ; allowing 10mins for slaves to re-register
I1122 21:06:24.145154 30283 hierarchical.cpp:165] Allocator recovery is not supported yet
I1122 21:06:24.145951 30283 replica.cpp:540] Replica received write request for position 2 from (10757)@172.17.18.24:45738
I1122 21:06:24.166782 30283 leveldb.cpp:343] Persisting action (16 bytes) to leveldb took 20.769317ms
I1122 21:06:24.166862 30283 replica.cpp:715] Persisted action at 2
I1122 21:06:24.167775 30285 replica.cpp:694] Replica received learned notice for position 2 from @0.0.0.0:0
I1122 21:06:24.191993 30285 leveldb.cpp:343] Persisting action (18 bytes) to leveldb took 24.116465ms
I1122 21:06:24.192420 30285 leveldb.cpp:401] Deleting ~1 keys from leveldb took 168354ns
I1122 21:06:24.192520 30285 replica.cpp:715] Persisted action at 2
I1122 21:06:24.192678 30285 replica.cpp:700] Replica learned TRUNCATE action at position 2
I1122 21:06:24.197736 30257 scheduler.cpp:156] Version: 0.26.0
I1122 21:06:24.199164 30288 scheduler.cpp:238] New master detected at master@172.17.18.24:45738
I1122 21:06:24.200505 30286 scheduler.cpp:300] Sending SUBSCRIBE call to master@172.17.18.24:45738
I1122 21:06:24.203027 30285 process.cpp:3081] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I1122 21:06:24.203390 30285 http.cpp:338] HTTP POST for /master/api/v1/scheduler from 172.17.18.24:36548
I1122 21:06:24.203922 30285 master.cpp:1889] Received subscription request for HTTP framework 'default'
I1122 21:06:24.204259 30285 master.cpp:1666] Authorizing framework principal 'test-principal' to receive offers for role '*'
I1122 21:06:24.204951 30285 master.cpp:1981] Subscribing framework 'default' with checkpointing disabled and capabilities [ ]
I1122 21:06:24.206434 30288 master.hpp:1516] Sending heartbeat to ef6d07f8-bcfd-4fbe-b56e-aa1481644b40-0000
I1122 21:06:24.206707 30285 hierarchical.cpp:207] Added framework ef6d07f8-bcfd-4fbe-b56e-aa1481644b40-0000
I1122 21:06:24.206971 30285 hierarchical.cpp:989] No resources available to allocate!
I1122 21:06:24.207228 30285 hierarchical.cpp:1082] No inverse offers to send out!
I1122 21:06:24.207459 30285 hierarchical.cpp:888] Performed allocation for 0 slaves in 571196ns
I1122 21:06:24.207612 30277 scheduler.cpp:459] Enqueuing event SUBSCRIBED received from master@172.17.18.24:45738
I1122 21:06:24.208336 30277 scheduler.cpp:459] Enqueuing event HEARTBEAT received from master@172.17.18.24:45738
I1122 21:06:24.209604 30277 scheduler.cpp:300] Sending REQUEST call to master@172.17.18.24:45738
I1122 21:06:24.209918 30279 master_maintenance_tests.cpp:174] Ignoring HEARTBEAT event
I1122 21:06:24.212707 30282 process.cpp:3081] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I1122 21:06:24.212805 30282 http.cpp:338] HTTP POST for /master/api/v1/scheduler from 172.17.18.24:36549
I1122 21:06:24.213039 30282 master.cpp:2636] Processing REQUEST call for framework ef6d07f8-bcfd-4fbe-b56e-aa1481644b40-0000 (default)
I1122 21:06:24.213301 30288 hierarchical.cpp:470] Received resource request from framework ef6d07f8-bcfd-4fbe-b56e-aa1481644b40-0000
I1122 21:06:24.213722 30276 master.cpp:928] Master terminating
I1122 21:06:24.214321 30276 hierarchical.cpp:242] Removed framework ef6d07f8-bcfd-4fbe-b56e-aa1481644b40-0000
[ OK ] ContentType/SchedulerTest.Request/0 (440 ms)
[ RUN ] ContentType/SchedulerTest.Request/1
I1122 21:06:24.318305 30257 leveldb.cpp:176] Opened db in 89.463459ms
I1122 21:06:24.360326 30257 leveldb.cpp:183] Compacted db in 41.943434ms
I1122 21:06:24.360538 30257 leveldb.cpp:198] Created db iterator in 24889ns
I1122 21:06:24.360664 30257 leveldb.cpp:204] Seeked to beginning of db in 3780ns
I1122 21:06:24.360762 30257 leveldb.cpp:273] Iterated through 0 keys in the db in 418ns
I1122 21:06:24.360898 30257 replica.cpp:780] Replica recovered with log positions 0 -> 0 with 1 holes and 0 unlearned
I1122 21:06:24.361533 30285 recover.cpp:449] Starting replica recovery
I1122 21:06:24.361838 30282 recover.cpp:475] Replica is in EMPTY status
I1122 21:06:24.362954 30280 replica.cpp:676] Replica in EMPTY status received a broadcasted recover request from (10762)@172.17.18.24:45738
I1122 21:06:24.363369 30282 recover.cpp:195] Received a recover response from a replica in EMPTY status
I1122 21:06:24.363880 30285 master.cpp:367] Master 3e949c13-bc38-4360-8fb3-0a5d1b202aaf (2fc568cdd310) started on 172.17.18.24:45738
I1122 21:06:24.363903 30279 recover.cpp:566] Updating replica status to STARTING
I1122 21:06:24.363903 30285 master.cpp:369] Flags at startup: --acls="" --allocation_interval="1secs" --allocator="HierarchicalDRF" --authenticate="false" --authenticate_slaves="true" --authenticators="crammd5" --authorizers="local" --credentials="/tmp/hhOZkr/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.26.0/_inst/share/mesos/webui" --work_dir="/tmp/hhOZkr/master" --zk_session_timeout="10secs"
I1122 21:06:24.364259 30285 master.cpp:416] Master allowing unauthenticated frameworks to register
I1122 21:06:24.364276 30285 master.cpp:419] Master only allowing authenticated slaves to register
I1122 21:06:24.364285 30285 credentials.hpp:37] Loading credentials for authentication from '/tmp/hhOZkr/credentials'
I1122 21:06:24.364609 30285 master.cpp:458] Using default 'crammd5' authenticator
I1122 21:06:24.364747 30285 master.cpp:495] Authorization enabled
I1122 21:06:24.364928 30279 whitelist_watcher.cpp:79] No whitelist given
I1122 21:06:24.365074 30277 hierarchical.cpp:153] Initialized hierarchical allocator process
I1122 21:06:24.367429 30290 master.cpp:1627] The newly elected leader is master@172.17.18.24:45738 with id 3e949c13-bc38-4360-8fb3-0a5d1b202aaf
I1122 21:06:24.367466 30290 master.cpp:1640] Elected as the leading master!
I1122 21:06:24.367485 30290 master.cpp:1385] Recovering from registrar
I1122 21:06:24.367772 30285 registrar.cpp:309] Recovering registrar
I1122 21:06:24.400593 30287 leveldb.cpp:306] Persisting metadata (8 bytes) to leveldb took 36.504302ms
I1122 21:06:24.400668 30287 replica.cpp:323] Persisted replica status to STARTING
I1122 21:06:24.401031 30278 recover.cpp:475] Replica is in STARTING status
I1122 21:06:24.402488 30279 replica.cpp:676] Replica in STARTING status received a broadcasted recover request from (10763)@172.17.18.24:45738
I1122 21:06:24.402745 30276 recover.cpp:195] Received a recover response from a replica in STARTING status
I1122 21:06:24.403198 30278 recover.cpp:566] Updating replica status to VOTING
I1122 21:06:24.425767 30276 leveldb.cpp:306] Persisting metadata (8 bytes) to leveldb took 22.383215ms
I1122 21:06:24.425847 30276 replica.cpp:323] Persisted replica status to VOTING
I1122 21:06:24.426062 30278 recover.cpp:580] Successfully joined the Paxos group
I1122 21:06:24.426321 30278 recover.cpp:464] Recover process terminated
I1122 21:06:24.426926 30282 log.cpp:661] Attempting to start the writer
I1122 21:06:24.428192 30290 replica.cpp:496] Replica received implicit promise request from (10764)@172.17.18.24:45738 with proposal 1
I1122 21:06:24.450947 30290 leveldb.cpp:306] Persisting metadata (8 bytes) to leveldb took 22.701242ms
I1122 21:06:24.451043 30290 replica.cpp:345] Persisted promised to 1
I1122 21:06:24.452236 30290 coordinator.cpp:240] Coordinator attempting to fill missing positions
I1122 21:06:24.453516 30285 replica.cpp:391] Replica received explicit promise request from (10765)@172.17.18.24:45738 for position 0 with proposal 2
I1122 21:06:24.492718 30285 leveldb.cpp:343] Persisting action (8 bytes) to leveldb took 39.135205ms
I1122 21:06:24.492799 30285 replica.cpp:715] Persisted action at 0
I1122 21:06:24.494150 30291 replica.cpp:540] Replica received write request for position 0 from (10766)@172.17.18.24:45738
I1122 21:06:24.494251 30291 leveldb.cpp:438] Reading position from leveldb took 42879ns
I1122 21:06:24.526329 30291 leveldb.cpp:343] Persisting action (14 bytes) to leveldb took 32.011514ms
I1122 21:06:24.526414 30291 replica.cpp:715] Persisted action at 0
I1122 21:06:24.527376 30291 replica.cpp:694] Replica received learned notice for position 0 from @0.0.0.0:0
I1122 21:06:24.552261 30291 leveldb.cpp:343] Persisting action (16 bytes) to leveldb took 24.665551ms
I1122 21:06:24.552350 30291 replica.cpp:715] Persisted action at 0
I1122 21:06:24.552386 30291 replica.cpp:700] Replica learned NOP action at position 0
I1122 21:06:24.553552 30291 log.cpp:677] Writer started with ending position 0
I1122 21:06:24.555290 30287 leveldb.cpp:438] Reading position from leveldb took 73065ns
I1122 21:06:24.556807 30287 registrar.cpp:342] Successfully fetched the registry (0B) in 188.986112ms
I1122 21:06:24.556969 30287 registrar.cpp:441] Applied 1 operations in 46019ns; attempting to update the 'registry'
I1122 21:06:24.558848 30286 log.cpp:685] Attempting to append 176 bytes to the log
I1122 21:06:24.559145 30291 coordinator.cpp:350] Coordinator attempting to write APPEND action at position 1
I1122 21:06:24.560313 30291 replica.cpp:540] Replica received write request for position 1 from (10767)@172.17.18.24:45738
I1122 21:06:24.584942 30291 leveldb.cpp:343] Persisting action (195 bytes) to leveldb took 24.573083ms
I1122 21:06:24.585024 30291 replica.cpp:715] Persisted action at 1
I1122 21:06:24.586187 30287 replica.cpp:694] Replica received learned notice for position 1 from @0.0.0.0:0
I1122 21:06:24.610270 30287 leveldb.cpp:343] Persisting action (197 bytes) to leveldb took 24.00365ms
I1122 21:06:24.610366 30287 replica.cpp:715] Persisted action at 1
I1122 21:06:24.610404 30287 replica.cpp:700] Replica learned APPEND action at position 1
I1122 21:06:24.612413 30283 registrar.cpp:486] Successfully updated the 'registry' in 55.353344ms
I1122 21:06:24.612646 30283 registrar.cpp:372] Successfully recovered registrar
I1122 21:06:24.612598 30281 log.cpp:704] Attempting to truncate the log to 1
I1122 21:06:24.612915 30283 coordinator.cpp:350] Coordinator attempting to write TRUNCATE action at position 2
I1122 21:06:24.613113 30281 master.cpp:1437] Recovered 0 slaves from the Registry (137B) ; allowing 10mins for slaves to re-register
I1122 21:06:24.613421 30280 hierarchical.cpp:165] Allocator recovery is not supported yet
I1122 21:06:24.614229 30288 replica.cpp:540] Replica received write request for position 2 from (10768)@172.17.18.24:45738
I1122 21:06:24.635207 30288 leveldb.cpp:343] Persisting action (16 bytes) to leveldb took 20.889784ms
I1122 21:06:24.635450 30288 replica.cpp:715] Persisted action at 2
I1122 21:06:24.637022 30288 replica.cpp:694] Replica received learned notice for position 2 from @0.0.0.0:0
I1122 21:06:24.660317 30288 leveldb.cpp:343] Persisting action (18 bytes) to leveldb took 23.012096ms
I1122 21:06:24.660754 30288 leveldb.cpp:401] Deleting ~1 keys from leveldb took 216082ns
I1122 21:06:24.660861 30288 replica.cpp:715] Persisted action at 2
I1122 21:06:24.661015 30288 replica.cpp:700] Replica learned TRUNCATE action at position 2
I1122 21:06:24.665047 30257 scheduler.cpp:156] Version: 0.26.0
I1122 21:06:24.666230 30279 scheduler.cpp:238] New master detected at master@172.17.18.24:45738
I1122 21:06:24.667626 30278 scheduler.cpp:300] Sending SUBSCRIBE call to master@172.17.18.24:45738
I1122 21:06:24.670578 30282 process.cpp:3081] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I1122 21:06:24.670922 30282 http.cpp:338] HTTP POST for /master/api/v1/scheduler from 172.17.18.24:36551
I1122 21:06:24.671830 30282 master.cpp:1889] Received subscription request for HTTP framework 'default'
I1122 21:06:24.672121 30282 master.cpp:1666] Authorizing framework principal 'test-principal' to receive offers for role '*'
I1122 21:06:24.672848 30282 master.cpp:1981] Subscribing framework 'default' with checkpointing disabled and capabilities [ ]
I1122 21:06:24.674271 30276 hierarchical.cpp:207] Added framework 3e949c13-bc38-4360-8fb3-0a5d1b202aaf-0000
I1122 21:06:24.674363 30276 hierarchical.cpp:989] No resources available to allocate!
I1122 21:06:24.674401 30288 master.hpp:1516] Sending heartbeat to 3e949c13-bc38-4360-8fb3-0a5d1b202aaf-0000
I1122 21:06:24.674408 30276 hierarchical.cpp:1082] No inverse offers to send out!
I1122 21:06:24.674769 30276 hierarchical.cpp:888] Performed allocation for 0 slaves in 450709ns
I1122 21:06:24.676614 30279 scheduler.cpp:459] Enqueuing event SUBSCRIBED received from master@172.17.18.24:45738
I1122 21:06:24.677441 30279 scheduler.cpp:459] Enqueuing event HEARTBEAT received from master@172.17.18.24:45738
I1122 21:06:24.678366 30279 master_maintenance_tests.cpp:174] Ignoring HEARTBEAT event
I1122 21:06:24.679044 30290 scheduler.cpp:300] Sending REQUEST call to master@172.17.18.24:45738
I1122 21:06:24.683282 30285 process.cpp:3081] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I1122 21:06:24.683511 30285 http.cpp:338] HTTP POST for /master/api/v1/scheduler from 172.17.18.24:36552
I1122 21:06:24.684021 30285 master.cpp:2636] Processing REQUEST call for framework 3e949c13-bc38-4360-8fb3-0a5d1b202aaf-0000 (default)
I1122 21:06:24.684386 30279 hierarchical.cpp:470] Received resource request from framework 3e949c13-bc38-4360-8fb3-0a5d1b202aaf-0000
I1122 21:06:24.685648 30285 master.cpp:928] Master terminating
I1122 21:06:24.687293 30277 hierarchical.cpp:242] Removed framework 3e949c13-bc38-4360-8fb3-0a5d1b202aaf-0000
E1122 21:06:24.698189 30284 scheduler.cpp:433] End-Of-File received from master. The master closed the event stream
[ OK ] ContentType/SchedulerTest.Request/1 (486 ms)
[----------] 22 tests from ContentType/SchedulerTest (15260 ms total)
[----------] Global test environment tear-down
[==========] 837 tests from 113 test cases ran. (751333 ms total)
[ PASSED ] 836 tests.
[ FAILED ] 1 test, listed below:
[ FAILED ] PersistentVolumeTest.SlaveRecovery
1 FAILED TEST
YOU HAVE 7 DISABLED TESTS
make[4]: Leaving directory `/mesos/mesos-0.26.0/_build/src'
make[4]: *** [check-local] Error 1
make[3]: *** [check-am] Error 2
make[3]: Leaving directory `/mesos/mesos-0.26.0/_build/src'
make[2]: *** [check] Error 2
make[2]: Leaving directory `/mesos/mesos-0.26.0/_build/src'
make[1]: *** [check-recursive] Error 1
make[1]: Leaving directory `/mesos/mesos-0.26.0/_build'
make: *** [distcheck] Error 1
+ docker rmi mesos-1448223035-7412
Untagged: mesos-1448223035-7412:latest
Deleted: 79f0974581c3fdf51a6be3ab9bb77ebf019a5c7c002c2031258bcaa8fa75634d
Deleted: b42ddbd905d6ddf747fb9a6ef3ac26b8d3694a7755f557dec598a5ec56360d40
Deleted: da816efb6ee47438a6085ddfd50ea1b5a54755227df5e329f656f4e5ee2f3dc8
Deleted: 8f8bd50c80886fbda4457665b5efe8f7b1f405ec4f7bbaaf8bfe9d46b758bd1d
Deleted: f395e821f3b8e1db22d842f8f3f776f65b816df509c3a572aea7328bc4fb47a9
Deleted: abd6caba0076a39ba84b196aed723383f9312c4037276df73e3fb75a585a1698
Deleted: 2ee755ef90deb5ac385211e75e9b80d6b3e85ce0fe22812bbab40ec84a5e5cf1
Deleted: 2206bbac0b50fb3d38857d6c584623ee2cef5221a9d500948ae39482ce36ad74
Deleted: 67d4cf222507ad0526cd6ab09da605b4d32b8caabcaa58a076330cc067496ee8
Deleted: a68a6d5444bb3407e03922804a7694c5419db3fb485e76a9c88cc4063b0fb5de
Deleted: ccc84d95b5f7b403c2dd335bf754ba9e0de05f4eae7fa5b48dd11c42606e3198
Deleted: f98588424c3835c3080cccf0dc9be48345102192250c7f9304ceb5b6fb8e6e6d
Deleted: 76fd5710d14ad1ff9ec10a7c806f73d4a5c94843c32d8a755951a057de820ca5
Build step 'Execute shell' marked build as failure
Jenkins build is back to normal : Mesos » gcc,--verbose,ubuntu:14.04,docker||Hadoop #1263
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/1263/changes>