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/04 23:43:16 UTC
Build failed in Jenkins: Mesos » gcc,--verbose --enable-libevent --enable-ssl,ubuntu:14.04,docker||Hadoop #1324
See <https://builds.apache.org/job/Mesos/COMPILER=gcc,CONFIGURATION=--verbose%20--enable-libevent%20--enable-ssl,OS=ubuntu%3A14.04,label_exp=docker%7C%7CHadoop/1324/changes>
Changes:
[joris.van.remoortere] Fixed flakiness in MasterMaintenanceTest.InverseOffersFilters.
[joris.van.remoortere] Quota: Filtered revocable resources out of quotaRoleSorter in allocator.
[yujie.jay] Avoided accepting hex float literals.
[joris.van.remoortere] Quota: Added hierarchical allocator-specific tests.
[joris.van.remoortere] Quota: Ensured resources in `QuotaInfo` do not have non-default role.
[yujie.jay] Fixed the flaky PersistentVolumeTest.SlaveRecovery test.
------------------------------------------
[...truncated 149201 lines...]
I1204 22:37:20.453711 31801 slave.cpp:3773] Cleaning up framework 20ebeabd-42c7-4e8d-9f88-bfe778085e41-0000
I1204 22:37:20.454527 31803 gc.cpp:54] Scheduling '/tmp/ContentType_SchedulerTest_Message_1_VFXqpf/slaves/20ebeabd-42c7-4e8d-9f88-bfe778085e41-S0/frameworks/20ebeabd-42c7-4e8d-9f88-bfe778085e41-0000/executors/default' for gc 6.99999474969778days in the future
I1204 22:37:20.454684 31803 status_update_manager.cpp:282] Closing status update streams for framework 20ebeabd-42c7-4e8d-9f88-bfe778085e41-0000
I1204 22:37:20.454771 31803 status_update_manager.cpp:528] Cleaning up status update stream for task c9e2e692-6cf4-4c94-8bfe-c121f44b95c7 of framework 20ebeabd-42c7-4e8d-9f88-bfe778085e41-0000
I1204 22:37:20.455376 31794 gc.cpp:54] Scheduling '/tmp/ContentType_SchedulerTest_Message_1_VFXqpf/slaves/20ebeabd-42c7-4e8d-9f88-bfe778085e41-S0/frameworks/20ebeabd-42c7-4e8d-9f88-bfe778085e41-0000' for gc 6.99999473241778days in the future
[ OK ] ContentType/SchedulerTest.Message/1 (174 ms)
[ RUN ] ContentType/SchedulerTest.Request/0
I1204 22:37:20.464915 31774 leveldb.cpp:174] Opened db in 2.889094ms
I1204 22:37:20.466037 31774 leveldb.cpp:181] Compacted db in 1.065594ms
I1204 22:37:20.466096 31774 leveldb.cpp:196] Created db iterator in 24126ns
I1204 22:37:20.466198 31774 leveldb.cpp:202] Seeked to beginning of db in 6106ns
I1204 22:37:20.466241 31774 leveldb.cpp:271] Iterated through 0 keys in the db in 473ns
I1204 22:37:20.466475 31774 replica.cpp:778] Replica recovered with log positions 0 -> 0 with 1 holes and 0 unlearned
I1204 22:37:20.467293 31804 recover.cpp:447] Starting replica recovery
I1204 22:37:20.467645 31804 recover.cpp:473] Replica is in EMPTY status
I1204 22:37:20.469338 31801 replica.cpp:674] Replica in EMPTY status received a broadcasted recover request from (11449)@172.17.0.1:53803
I1204 22:37:20.469718 31807 recover.cpp:193] Received a recover response from a replica in EMPTY status
I1204 22:37:20.470378 31800 recover.cpp:564] Updating replica status to STARTING
I1204 22:37:20.471236 31803 leveldb.cpp:304] Persisting metadata (8 bytes) to leveldb took 677519ns
I1204 22:37:20.471366 31803 replica.cpp:321] Persisted replica status to STARTING
I1204 22:37:20.471776 31803 recover.cpp:473] Replica is in STARTING status
I1204 22:37:20.472422 31803 master.cpp:365] Master 25322dd7-f831-45c6-84e3-d3617102529f (960749b344af) started on 172.17.0.1:53803
I1204 22:37:20.472529 31803 master.cpp:367] Flags at startup: --acls="" --allocation_interval="1secs" --allocator="HierarchicalDRF" --authenticate="false" --authenticate_slaves="true" --authenticators="crammd5" --authorizers="local" --credentials="/tmp/PYOlrb/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/PYOlrb/master" --zk_session_timeout="10secs"
I1204 22:37:20.473163 31803 master.cpp:414] Master allowing unauthenticated frameworks to register
I1204 22:37:20.473305 31803 master.cpp:417] Master only allowing authenticated slaves to register
I1204 22:37:20.473465 31803 credentials.hpp:35] Loading credentials for authentication from '/tmp/PYOlrb/credentials'
I1204 22:37:20.473718 31797 replica.cpp:674] Replica in STARTING status received a broadcasted recover request from (11450)@172.17.0.1:53803
I1204 22:37:20.474099 31803 master.cpp:456] Using default 'crammd5' authenticator
I1204 22:37:20.474259 31803 master.cpp:493] Authorization enabled
I1204 22:37:20.474400 31798 recover.cpp:193] Received a recover response from a replica in STARTING status
I1204 22:37:20.474810 31800 hierarchical.cpp:163] Initialized hierarchical allocator process
I1204 22:37:20.475004 31797 whitelist_watcher.cpp:77] No whitelist given
I1204 22:37:20.475093 31797 recover.cpp:564] Updating replica status to VOTING
I1204 22:37:20.475903 31798 leveldb.cpp:304] Persisting metadata (8 bytes) to leveldb took 570003ns
I1204 22:37:20.476007 31798 replica.cpp:321] Persisted replica status to VOTING
I1204 22:37:20.476328 31807 recover.cpp:578] Successfully joined the Paxos group
I1204 22:37:20.476826 31798 recover.cpp:462] Recover process terminated
I1204 22:37:20.477538 31805 master.cpp:1637] The newly elected leader is master@172.17.0.1:53803 with id 25322dd7-f831-45c6-84e3-d3617102529f
I1204 22:37:20.478308 31805 master.cpp:1650] Elected as the leading master!
I1204 22:37:20.478482 31805 master.cpp:1395] Recovering from registrar
I1204 22:37:20.478766 31798 registrar.cpp:307] Recovering registrar
I1204 22:37:20.479434 31802 log.cpp:659] Attempting to start the writer
I1204 22:37:20.481103 31798 replica.cpp:494] Replica received implicit promise request from (11451)@172.17.0.1:53803 with proposal 1
I1204 22:37:20.481878 31798 leveldb.cpp:304] Persisting metadata (8 bytes) to leveldb took 630931ns
I1204 22:37:20.482061 31798 replica.cpp:343] Persisted promised to 1
I1204 22:37:20.483140 31798 coordinator.cpp:238] Coordinator attempting to fill missing positions
I1204 22:37:20.485121 31798 replica.cpp:389] Replica received explicit promise request from (11452)@172.17.0.1:53803 for position 0 with proposal 2
I1204 22:37:20.485682 31798 leveldb.cpp:341] Persisting action (8 bytes) to leveldb took 442424ns
I1204 22:37:20.485790 31798 replica.cpp:713] Persisted action at 0
I1204 22:37:20.489389 31802 replica.cpp:538] Replica received write request for position 0 from (11453)@172.17.0.1:53803
I1204 22:37:20.489465 31802 leveldb.cpp:436] Reading position from leveldb took 38205ns
I1204 22:37:20.490082 31802 leveldb.cpp:341] Persisting action (14 bytes) to leveldb took 561762ns
I1204 22:37:20.490180 31802 replica.cpp:713] Persisted action at 0
I1204 22:37:20.491111 31800 replica.cpp:692] Replica received learned notice for position 0 from @0.0.0.0:0
I1204 22:37:20.491680 31800 leveldb.cpp:341] Persisting action (16 bytes) to leveldb took 470214ns
I1204 22:37:20.491778 31800 replica.cpp:713] Persisted action at 0
I1204 22:37:20.491897 31800 replica.cpp:698] Replica learned NOP action at position 0
I1204 22:37:20.492900 31793 log.cpp:675] Writer started with ending position 0
I1204 22:37:20.494441 31796 leveldb.cpp:436] Reading position from leveldb took 33314ns
I1204 22:37:20.495918 31804 registrar.cpp:340] Successfully fetched the registry (0B) in 17.100032ms
I1204 22:37:20.496206 31804 registrar.cpp:439] Applied 1 operations in 96508ns; attempting to update the 'registry'
I1204 22:37:20.497472 31804 log.cpp:683] Attempting to append 170 bytes to the log
I1204 22:37:20.497725 31806 coordinator.cpp:348] Coordinator attempting to write APPEND action at position 1
I1204 22:37:20.499001 31803 replica.cpp:538] Replica received write request for position 1 from (11454)@172.17.0.1:53803
I1204 22:37:20.499662 31803 leveldb.cpp:341] Persisting action (189 bytes) to leveldb took 463587ns
I1204 22:37:20.499791 31803 replica.cpp:713] Persisted action at 1
I1204 22:37:20.500866 31795 replica.cpp:692] Replica received learned notice for position 1 from @0.0.0.0:0
I1204 22:37:20.502293 31795 leveldb.cpp:341] Persisting action (191 bytes) to leveldb took 1.331773ms
I1204 22:37:20.502331 31795 replica.cpp:713] Persisted action at 1
I1204 22:37:20.502354 31795 replica.cpp:698] Replica learned APPEND action at position 1
I1204 22:37:20.503713 31807 registrar.cpp:484] Successfully updated the 'registry' in 7.331072ms
I1204 22:37:20.504007 31795 log.cpp:702] Attempting to truncate the log to 1
I1204 22:37:20.504494 31795 coordinator.cpp:348] Coordinator attempting to write TRUNCATE action at position 2
I1204 22:37:20.504823 31807 registrar.cpp:370] Successfully recovered registrar
I1204 22:37:20.505439 31802 master.cpp:1447] Recovered 0 slaves from the Registry (131B) ; allowing 10mins for slaves to re-register
I1204 22:37:20.505470 31801 hierarchical.cpp:181] Skipping recovery of hierarchical allocator: nothing to recover
I1204 22:37:20.506520 31795 replica.cpp:538] Replica received write request for position 2 from (11455)@172.17.0.1:53803
I1204 22:37:20.507050 31795 leveldb.cpp:341] Persisting action (16 bytes) to leveldb took 454698ns
I1204 22:37:20.507088 31795 replica.cpp:713] Persisted action at 2
I1204 22:37:20.508338 31797 replica.cpp:692] Replica received learned notice for position 2 from @0.0.0.0:0
I1204 22:37:20.508757 31797 leveldb.cpp:341] Persisting action (18 bytes) to leveldb took 321227ns
I1204 22:37:20.508878 31797 leveldb.cpp:399] Deleting ~1 keys from leveldb took 32802ns
I1204 22:37:20.509003 31797 replica.cpp:713] Persisted action at 2
I1204 22:37:20.509109 31797 replica.cpp:698] Replica learned TRUNCATE action at position 2
I1204 22:37:20.517635 31774 scheduler.cpp:154] Version: 0.27.0
I1204 22:37:20.518667 31804 scheduler.cpp:236] New master detected at master@172.17.0.1:53803
I1204 22:37:20.521427 31799 scheduler.cpp:298] Sending SUBSCRIBE call to master@172.17.0.1:53803
I1204 22:37:20.524327 31801 process.cpp:3077] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I1204 22:37:20.524466 31801 http.cpp:336] HTTP POST for /master/api/v1/scheduler from 172.17.0.1:56121
I1204 22:37:20.524801 31801 master.cpp:1899] Received subscription request for HTTP framework 'default'
I1204 22:37:20.524947 31801 master.cpp:1676] Authorizing framework principal 'test-principal' to receive offers for role '*'
I1204 22:37:20.525346 31801 master.cpp:1991] Subscribing framework 'default' with checkpointing disabled and capabilities [ ]
I1204 22:37:20.526412 31803 hierarchical.cpp:267] Added framework 25322dd7-f831-45c6-84e3-d3617102529f-0000
I1204 22:37:20.526455 31805 master.hpp:1583] Sending heartbeat to 25322dd7-f831-45c6-84e3-d3617102529f-0000
I1204 22:37:20.526505 31803 hierarchical.cpp:1317] No resources available to allocate!
I1204 22:37:20.526541 31803 hierarchical.cpp:1410] No inverse offers to send out!
I1204 22:37:20.526576 31803 hierarchical.cpp:1063] Performed allocation for 0 slaves in 124766ns
I1204 22:37:20.527544 31808 scheduler.cpp:457] Enqueuing event SUBSCRIBED received from master@172.17.0.1:53803
I1204 22:37:20.528852 31801 scheduler.cpp:457] Enqueuing event HEARTBEAT received from master@172.17.0.1:53803
I1204 22:37:20.529338 31801 master_maintenance_tests.cpp:177] Ignoring HEARTBEAT event
I1204 22:37:20.529930 31798 scheduler.cpp:298] Sending REQUEST call to master@172.17.0.1:53803
I1204 22:37:20.531739 31794 process.cpp:3077] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I1204 22:37:20.531816 31794 http.cpp:336] HTTP POST for /master/api/v1/scheduler from 172.17.0.1:56122
I1204 22:37:20.531941 31794 master.cpp:2646] Processing REQUEST call for framework 25322dd7-f831-45c6-84e3-d3617102529f-0000 (default)
I1204 22:37:20.532099 31802 hierarchical.cpp:562] Received resource request from framework 25322dd7-f831-45c6-84e3-d3617102529f-0000
I1204 22:37:20.532815 31799 master.cpp:938] Master terminating
I1204 22:37:20.533268 31797 hierarchical.cpp:308] Removed framework 25322dd7-f831-45c6-84e3-d3617102529f-0000
E1204 22:37:20.536324 31795 scheduler.cpp:431] End-Of-File received from master. The master closed the event stream
[ OK ] ContentType/SchedulerTest.Request/0 (80 ms)
[ RUN ] ContentType/SchedulerTest.Request/1
I1204 22:37:20.543990 31774 leveldb.cpp:174] Opened db in 2.623127ms
I1204 22:37:20.544927 31774 leveldb.cpp:181] Compacted db in 895229ns
I1204 22:37:20.545002 31774 leveldb.cpp:196] Created db iterator in 22508ns
I1204 22:37:20.545024 31774 leveldb.cpp:202] Seeked to beginning of db in 2118ns
I1204 22:37:20.545033 31774 leveldb.cpp:271] Iterated through 0 keys in the db in 219ns
I1204 22:37:20.545080 31774 replica.cpp:778] Replica recovered with log positions 0 -> 0 with 1 holes and 0 unlearned
I1204 22:37:20.546106 31808 recover.cpp:447] Starting replica recovery
I1204 22:37:20.546561 31808 recover.cpp:473] Replica is in EMPTY status
I1204 22:37:20.547752 31802 replica.cpp:674] Replica in EMPTY status received a broadcasted recover request from (11460)@172.17.0.1:53803
I1204 22:37:20.548099 31808 recover.cpp:193] Received a recover response from a replica in EMPTY status
I1204 22:37:20.548787 31796 recover.cpp:564] Updating replica status to STARTING
I1204 22:37:20.549433 31796 master.cpp:365] Master cdb64c45-0342-48c6-889f-ff7fcaf40a5b (960749b344af) started on 172.17.0.1:53803
I1204 22:37:20.549592 31800 leveldb.cpp:304] Persisting metadata (8 bytes) to leveldb took 548759ns
I1204 22:37:20.549623 31800 replica.cpp:321] Persisted replica status to STARTING
I1204 22:37:20.549464 31796 master.cpp:367] Flags at startup: --acls="" --allocation_interval="1secs" --allocator="HierarchicalDRF" --authenticate="false" --authenticate_slaves="true" --authenticators="crammd5" --authorizers="local" --credentials="/tmp/ZNiBua/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/ZNiBua/master" --zk_session_timeout="10secs"
I1204 22:37:20.549742 31796 master.cpp:414] Master allowing unauthenticated frameworks to register
I1204 22:37:20.549753 31796 master.cpp:417] Master only allowing authenticated slaves to register
I1204 22:37:20.549760 31796 credentials.hpp:35] Loading credentials for authentication from '/tmp/ZNiBua/credentials'
I1204 22:37:20.549888 31801 recover.cpp:473] Replica is in STARTING status
I1204 22:37:20.549983 31796 master.cpp:456] Using default 'crammd5' authenticator
I1204 22:37:20.550108 31796 master.cpp:493] Authorization enabled
I1204 22:37:20.550355 31807 whitelist_watcher.cpp:77] No whitelist given
I1204 22:37:20.550417 31793 hierarchical.cpp:163] Initialized hierarchical allocator process
I1204 22:37:20.550931 31800 replica.cpp:674] Replica in STARTING status received a broadcasted recover request from (11461)@172.17.0.1:53803
I1204 22:37:20.551543 31797 recover.cpp:193] Received a recover response from a replica in STARTING status
I1204 22:37:20.552140 31800 master.cpp:1637] The newly elected leader is master@172.17.0.1:53803 with id cdb64c45-0342-48c6-889f-ff7fcaf40a5b
I1204 22:37:20.552166 31800 master.cpp:1650] Elected as the leading master!
I1204 22:37:20.552182 31800 master.cpp:1395] Recovering from registrar
I1204 22:37:20.552176 31803 recover.cpp:564] Updating replica status to VOTING
I1204 22:37:20.552369 31801 registrar.cpp:307] Recovering registrar
I1204 22:37:20.552772 31798 leveldb.cpp:304] Persisting metadata (8 bytes) to leveldb took 442118ns
I1204 22:37:20.552800 31798 replica.cpp:321] Persisted replica status to VOTING
I1204 22:37:20.552906 31802 recover.cpp:578] Successfully joined the Paxos group
I1204 22:37:20.553148 31802 recover.cpp:462] Recover process terminated
I1204 22:37:20.553532 31805 log.cpp:659] Attempting to start the writer
I1204 22:37:20.554674 31796 replica.cpp:494] Replica received implicit promise request from (11462)@172.17.0.1:53803 with proposal 1
I1204 22:37:20.555037 31796 leveldb.cpp:304] Persisting metadata (8 bytes) to leveldb took 329703ns
I1204 22:37:20.555061 31796 replica.cpp:343] Persisted promised to 1
I1204 22:37:20.555627 31804 coordinator.cpp:238] Coordinator attempting to fill missing positions
I1204 22:37:20.556809 31800 replica.cpp:389] Replica received explicit promise request from (11463)@172.17.0.1:53803 for position 0 with proposal 2
I1204 22:37:20.557191 31800 leveldb.cpp:341] Persisting action (8 bytes) to leveldb took 344564ns
I1204 22:37:20.557216 31800 replica.cpp:713] Persisted action at 0
I1204 22:37:20.558245 31800 replica.cpp:538] Replica received write request for position 0 from (11464)@172.17.0.1:53803
I1204 22:37:20.558398 31800 leveldb.cpp:436] Reading position from leveldb took 37090ns
I1204 22:37:20.558799 31800 leveldb.cpp:341] Persisting action (14 bytes) to leveldb took 344171ns
I1204 22:37:20.558823 31800 replica.cpp:713] Persisted action at 0
I1204 22:37:20.559527 31797 replica.cpp:692] Replica received learned notice for position 0 from @0.0.0.0:0
I1204 22:37:20.559985 31797 leveldb.cpp:341] Persisting action (16 bytes) to leveldb took 415800ns
I1204 22:37:20.560016 31797 replica.cpp:713] Persisted action at 0
I1204 22:37:20.560042 31797 replica.cpp:698] Replica learned NOP action at position 0
I1204 22:37:20.560647 31793 log.cpp:675] Writer started with ending position 0
I1204 22:37:20.561650 31807 leveldb.cpp:436] Reading position from leveldb took 25632ns
I1204 22:37:20.562522 31797 registrar.cpp:340] Successfully fetched the registry (0B) in 10.113792ms
I1204 22:37:20.562626 31797 registrar.cpp:439] Applied 1 operations in 23846ns; attempting to update the 'registry'
I1204 22:37:20.563338 31805 log.cpp:683] Attempting to append 170 bytes to the log
I1204 22:37:20.563441 31806 coordinator.cpp:348] Coordinator attempting to write APPEND action at position 1
I1204 22:37:20.564091 31801 replica.cpp:538] Replica received write request for position 1 from (11465)@172.17.0.1:53803
I1204 22:37:20.564523 31801 leveldb.cpp:341] Persisting action (189 bytes) to leveldb took 394073ns
I1204 22:37:20.564548 31801 replica.cpp:713] Persisted action at 1
I1204 22:37:20.565088 31803 replica.cpp:692] Replica received learned notice for position 1 from @0.0.0.0:0
I1204 22:37:20.565541 31803 leveldb.cpp:341] Persisting action (191 bytes) to leveldb took 423276ns
I1204 22:37:20.565565 31803 replica.cpp:713] Persisted action at 1
I1204 22:37:20.565582 31803 replica.cpp:698] Replica learned APPEND action at position 1
I1204 22:37:20.566469 31801 registrar.cpp:484] Successfully updated the 'registry' in 3.791872ms
I1204 22:37:20.566601 31801 registrar.cpp:370] Successfully recovered registrar
I1204 22:37:20.566678 31795 log.cpp:702] Attempting to truncate the log to 1
I1204 22:37:20.566900 31797 coordinator.cpp:348] Coordinator attempting to write TRUNCATE action at position 2
I1204 22:37:20.567335 31796 master.cpp:1447] Recovered 0 slaves from the Registry (131B) ; allowing 10mins for slaves to re-register
I1204 22:37:20.567431 31806 hierarchical.cpp:181] Skipping recovery of hierarchical allocator: nothing to recover
I1204 22:37:20.567965 31793 replica.cpp:538] Replica received write request for position 2 from (11466)@172.17.0.1:53803
I1204 22:37:20.569797 31793 leveldb.cpp:341] Persisting action (16 bytes) to leveldb took 1.783299ms
I1204 22:37:20.569834 31793 replica.cpp:713] Persisted action at 2
I1204 22:37:20.570647 31794 replica.cpp:692] Replica received learned notice for position 2 from @0.0.0.0:0
I1204 22:37:20.571291 31794 leveldb.cpp:341] Persisting action (18 bytes) to leveldb took 601612ns
I1204 22:37:20.571368 31794 leveldb.cpp:399] Deleting ~1 keys from leveldb took 44604ns
I1204 22:37:20.571395 31794 replica.cpp:713] Persisted action at 2
I1204 22:37:20.571419 31794 replica.cpp:698] Replica learned TRUNCATE action at position 2
I1204 22:37:20.577927 31774 scheduler.cpp:154] Version: 0.27.0
I1204 22:37:20.578583 31803 scheduler.cpp:236] New master detected at master@172.17.0.1:53803
I1204 22:37:20.579696 31793 scheduler.cpp:298] Sending SUBSCRIBE call to master@172.17.0.1:53803
I1204 22:37:20.581646 31800 process.cpp:3077] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I1204 22:37:20.581704 31800 http.cpp:336] HTTP POST for /master/api/v1/scheduler from 172.17.0.1:56123
I1204 22:37:20.582051 31800 master.cpp:1899] Received subscription request for HTTP framework 'default'
I1204 22:37:20.582129 31800 master.cpp:1676] Authorizing framework principal 'test-principal' to receive offers for role '*'
I1204 22:37:20.582415 31800 master.cpp:1991] Subscribing framework 'default' with checkpointing disabled and capabilities [ ]
I1204 22:37:20.582790 31798 hierarchical.cpp:267] Added framework cdb64c45-0342-48c6-889f-ff7fcaf40a5b-0000
I1204 22:37:20.582865 31798 hierarchical.cpp:1317] No resources available to allocate!
I1204 22:37:20.582883 31800 master.hpp:1583] Sending heartbeat to cdb64c45-0342-48c6-889f-ff7fcaf40a5b-0000
I1204 22:37:20.582907 31798 hierarchical.cpp:1410] No inverse offers to send out!
I1204 22:37:20.582942 31798 hierarchical.cpp:1063] Performed allocation for 0 slaves in 125328ns
I1204 22:37:20.584056 31797 scheduler.cpp:457] Enqueuing event SUBSCRIBED received from master@172.17.0.1:53803
I1204 22:37:20.584602 31797 scheduler.cpp:457] Enqueuing event HEARTBEAT received from master@172.17.0.1:53803
I1204 22:37:20.585325 31799 master_maintenance_tests.cpp:177] Ignoring HEARTBEAT event
I1204 22:37:20.585362 31800 scheduler.cpp:298] Sending REQUEST call to master@172.17.0.1:53803
I1204 22:37:20.586630 31797 process.cpp:3077] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I1204 22:37:20.586683 31797 http.cpp:336] HTTP POST for /master/api/v1/scheduler from 172.17.0.1:56124
I1204 22:37:20.586905 31797 master.cpp:2646] Processing REQUEST call for framework cdb64c45-0342-48c6-889f-ff7fcaf40a5b-0000 (default)
I1204 22:37:20.587108 31802 hierarchical.cpp:562] Received resource request from framework cdb64c45-0342-48c6-889f-ff7fcaf40a5b-0000
I1204 22:37:20.588083 31795 master.cpp:938] Master terminating
I1204 22:37:20.588274 31797 hierarchical.cpp:308] Removed framework cdb64c45-0342-48c6-889f-ff7fcaf40a5b-0000
E1204 22:37:20.588881 31799 scheduler.cpp:431] End-Of-File received from master. The master closed the event stream
[ OK ] ContentType/SchedulerTest.Request/1 (52 ms)
[----------] 22 tests from ContentType/SchedulerTest (4401 ms total)
[----------] Global test environment tear-down
2015-12-04 22:37:22,729:31774(0x2b224c80b700):ZOO_ERROR@handle_socket_error_msg@1697: Socket [127.0.0.1:55443] zk retcode=-4, errno=111(Connection refused): server refused to accept the client
[==========] 884 tests from 116 test cases ran. (365658 ms total)
[ PASSED ] 883 tests.
[ FAILED ] 1 test, listed below:
[ FAILED ] RegistryClientTest.SimpleGetBlob
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-1449266678-4081
Untagged: mesos-1449266678-4081:latest
Deleted: 1b65fb3409a6110ad7f278b6516358cfb19655fa0a5b90456b738edac5cdefef
Deleted: 9bea52ef0a3280e099df0c001dea8a31a2ba8c226e0d8e3fceb5417ea4a87160
Deleted: 1649634031e52be8cbb8d410f275c09591353efabf9ae8ae2c11f55ee16d9136
Deleted: 053b18c33284712babaf2b67793e81ecd0a56871ac3ff5e7a2a0ff616c999fdb
Deleted: f01d780a854d966576abebaaf6c81aa74cce8a66c2bb9492ecbd40c895adfebf
Deleted: c12b5d44b1ea9303d28fc2193e6d2333672d5b81025b94047e7a709bc69b2288
Deleted: 61c60507c6b1edbdc05f47708dd2cb87a0a6ea6d0c64fb2f853b7e270acacd37
Deleted: 8677a97f742c100563b6c6c0085c4f1987fdc22704b9ad62fcc9f1d833c5be0f
Deleted: 313b31d0dab2bdd8e6d5b2cb5fdb87c60f7e4fbbce780f11a5c192ea3c569a47
Deleted: 1b682605b11babe59132daf07e01a286152ac5c8d64411df8feee32046a71923
Deleted: 175e673f1c0218c75a7057ba52f5b6c4fee1e02f99c40853338b2849245d377f
Deleted: c3b1a050f1367c4847ee982435c7d0b893c1d763d8bf0e0c8b7732793a17328a
Deleted: b61db41f4ad6446b2489c81d4e77e2e901f733eead5364e53bd3c31dab162e38
Build step 'Execute shell' marked build as failure
Jenkins build is back to normal : Mesos » gcc,--verbose --enable-libevent --enable-ssl,ubuntu:14.04,docker||Hadoop #1325
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=ubuntu%3A14.04,label_exp=docker%7C%7CHadoop/1325/changes>