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/25 01:49:58 UTC
Build failed in Jenkins: Mesos » clang,--verbose --enable-libevent --enable-ssl,ubuntu:14.04,docker||Hadoop #1276
See <https://builds.apache.org/job/Mesos/COMPILER=clang,CONFIGURATION=--verbose%20--enable-libevent%20--enable-ssl,OS=ubuntu%3A14.04,label_exp=docker%7C%7CHadoop/1276/changes>
Changes:
[tnachen] Increased launch and wait timeout in filesystem test.
[tnachen] Removed redundant os exists check before mkdir.
[tnachen] Refactored Docker registry client to use protobuf messages.
------------------------------------------
[...truncated 143939 lines...]
I1125 00:49:55.455534 30117 gc.cpp:54] Scheduling '/tmp/ContentType_SchedulerTest_Message_1_UuTrYJ/slaves/b7171477-3141-4bd3-bece-0d818a01ad27-S0/frameworks/b7171477-3141-4bd3-bece-0d818a01ad27-0000/executors/default/runs/2dd93c74-7728-4653-ab16-11e18cc6d891' for gc 6.99999472907259days in the future
I1125 00:49:55.455600 30116 slave.cpp:3773] Cleaning up framework b7171477-3141-4bd3-bece-0d818a01ad27-0000
I1125 00:49:55.455729 30126 status_update_manager.cpp:282] Closing status update streams for framework b7171477-3141-4bd3-bece-0d818a01ad27-0000
I1125 00:49:55.455817 30117 gc.cpp:54] Scheduling '/tmp/ContentType_SchedulerTest_Message_1_UuTrYJ/slaves/b7171477-3141-4bd3-bece-0d818a01ad27-S0/frameworks/b7171477-3141-4bd3-bece-0d818a01ad27-0000/executors/default' for gc 6.99999472737185days in the future
I1125 00:49:55.455875 30126 status_update_manager.cpp:528] Cleaning up status update stream for task 2f5ca1de-e50d-49cd-967c-6da442e3896c of framework b7171477-3141-4bd3-bece-0d818a01ad27-0000
I1125 00:49:55.455891 30117 gc.cpp:54] Scheduling '/tmp/ContentType_SchedulerTest_Message_1_UuTrYJ/slaves/b7171477-3141-4bd3-bece-0d818a01ad27-S0/frameworks/b7171477-3141-4bd3-bece-0d818a01ad27-0000' for gc 6.99999472530074days in the future
[ OK ] ContentType/SchedulerTest.Message/1 (107 ms)
[ RUN ] ContentType/SchedulerTest.Request/0
I1125 00:49:55.463398 30093 leveldb.cpp:174] Opened db in 3.241204ms
I1125 00:49:55.464419 30093 leveldb.cpp:181] Compacted db in 1.002356ms
I1125 00:49:55.464474 30093 leveldb.cpp:196] Created db iterator in 30809ns
I1125 00:49:55.464491 30093 leveldb.cpp:202] Seeked to beginning of db in 7088ns
I1125 00:49:55.464499 30093 leveldb.cpp:271] Iterated through 0 keys in the db in 4636ns
I1125 00:49:55.464540 30093 replica.cpp:778] Replica recovered with log positions 0 -> 0 with 1 holes and 0 unlearned
I1125 00:49:55.464990 30115 recover.cpp:447] Starting replica recovery
I1125 00:49:55.465292 30115 recover.cpp:473] Replica is in EMPTY status
I1125 00:49:55.466354 30115 replica.cpp:674] Replica in EMPTY status received a broadcasted recover request from (10890)@172.17.3.34:52833
I1125 00:49:55.466795 30123 recover.cpp:193] Received a recover response from a replica in EMPTY status
I1125 00:49:55.467201 30112 recover.cpp:564] Updating replica status to STARTING
I1125 00:49:55.468224 30113 leveldb.cpp:304] Persisting metadata (8 bytes) to leveldb took 869900ns
I1125 00:49:55.468350 30113 replica.cpp:321] Persisted replica status to STARTING
I1125 00:49:55.468606 30113 recover.cpp:473] Replica is in STARTING status
I1125 00:49:55.468916 30119 master.cpp:365] Master a549ef30-fce5-40e4-a3df-dd249fff704d (41e79a769377) started on 172.17.3.34:52833
I1125 00:49:55.469022 30119 master.cpp:367] Flags at startup: --acls="" --allocation_interval="1secs" --allocator="HierarchicalDRF" --authenticate="false" --authenticate_slaves="true" --authenticators="crammd5" --authorizers="local" --credentials="/tmp/pZU5d7/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/pZU5d7/master" --zk_session_timeout="10secs"
I1125 00:49:55.469465 30119 master.cpp:414] Master allowing unauthenticated frameworks to register
I1125 00:49:55.469555 30119 master.cpp:417] Master only allowing authenticated slaves to register
I1125 00:49:55.469573 30119 credentials.hpp:35] Loading credentials for authentication from '/tmp/pZU5d7/credentials'
I1125 00:49:55.469831 30115 replica.cpp:674] Replica in STARTING status received a broadcasted recover request from (10891)@172.17.3.34:52833
I1125 00:49:55.469902 30119 master.cpp:456] Using default 'crammd5' authenticator
I1125 00:49:55.470156 30119 master.cpp:493] Authorization enabled
I1125 00:49:55.470206 30111 recover.cpp:193] Received a recover response from a replica in STARTING status
I1125 00:49:55.470752 30111 recover.cpp:564] Updating replica status to VOTING
I1125 00:49:55.471336 30111 leveldb.cpp:304] Persisting metadata (8 bytes) to leveldb took 396389ns
I1125 00:49:55.471452 30111 replica.cpp:321] Persisted replica status to VOTING
I1125 00:49:55.471668 30113 whitelist_watcher.cpp:77] No whitelist given
I1125 00:49:55.471812 30113 recover.cpp:578] Successfully joined the Paxos group
I1125 00:49:55.471899 30111 hierarchical.cpp:162] Initialized hierarchical allocator process
I1125 00:49:55.472023 30113 recover.cpp:462] Recover process terminated
I1125 00:49:55.473542 30126 master.cpp:1625] The newly elected leader is master@172.17.3.34:52833 with id a549ef30-fce5-40e4-a3df-dd249fff704d
I1125 00:49:55.473578 30126 master.cpp:1638] Elected as the leading master!
I1125 00:49:55.473593 30126 master.cpp:1383] Recovering from registrar
I1125 00:49:55.474236 30111 registrar.cpp:307] Recovering registrar
I1125 00:49:55.475163 30115 log.cpp:659] Attempting to start the writer
I1125 00:49:55.476716 30113 replica.cpp:494] Replica received implicit promise request from (10892)@172.17.3.34:52833 with proposal 1
I1125 00:49:55.477252 30113 leveldb.cpp:304] Persisting metadata (8 bytes) to leveldb took 508780ns
I1125 00:49:55.477283 30113 replica.cpp:343] Persisted promised to 1
I1125 00:49:55.478094 30116 coordinator.cpp:238] Coordinator attempting to fill missing positions
I1125 00:49:55.480680 30115 replica.cpp:389] Replica received explicit promise request from (10893)@172.17.3.34:52833 for position 0 with proposal 2
I1125 00:49:55.481657 30115 leveldb.cpp:341] Persisting action (8 bytes) to leveldb took 947139ns
I1125 00:49:55.481684 30115 replica.cpp:713] Persisted action at 0
I1125 00:49:55.482689 30120 replica.cpp:538] Replica received write request for position 0 from (10894)@172.17.3.34:52833
I1125 00:49:55.482754 30120 leveldb.cpp:436] Reading position from leveldb took 41827ns
I1125 00:49:55.483103 30120 leveldb.cpp:341] Persisting action (14 bytes) to leveldb took 314622ns
I1125 00:49:55.483130 30120 replica.cpp:713] Persisted action at 0
I1125 00:49:55.483614 30113 replica.cpp:692] Replica received learned notice for position 0 from @0.0.0.0:0
I1125 00:49:55.484096 30113 leveldb.cpp:341] Persisting action (16 bytes) to leveldb took 458973ns
I1125 00:49:55.484119 30113 replica.cpp:713] Persisted action at 0
I1125 00:49:55.484133 30113 replica.cpp:698] Replica learned NOP action at position 0
I1125 00:49:55.484645 30122 log.cpp:675] Writer started with ending position 0
I1125 00:49:55.485519 30118 leveldb.cpp:436] Reading position from leveldb took 53472ns
I1125 00:49:55.486393 30115 registrar.cpp:340] Successfully fetched the registry (0B) in 12.050944ms
I1125 00:49:55.486515 30115 registrar.cpp:439] Applied 1 operations in 39240ns; attempting to update the 'registry'
I1125 00:49:55.487087 30117 log.cpp:683] Attempting to append 174 bytes to the log
I1125 00:49:55.487181 30122 coordinator.cpp:348] Coordinator attempting to write APPEND action at position 1
I1125 00:49:55.488076 30114 replica.cpp:538] Replica received write request for position 1 from (10895)@172.17.3.34:52833
I1125 00:49:55.488579 30114 leveldb.cpp:341] Persisting action (193 bytes) to leveldb took 453354ns
I1125 00:49:55.488610 30114 replica.cpp:713] Persisted action at 1
I1125 00:49:55.489301 30115 replica.cpp:692] Replica received learned notice for position 1 from @0.0.0.0:0
I1125 00:49:55.489656 30115 leveldb.cpp:341] Persisting action (195 bytes) to leveldb took 338455ns
I1125 00:49:55.489681 30115 replica.cpp:713] Persisted action at 1
I1125 00:49:55.489697 30115 replica.cpp:698] Replica learned APPEND action at position 1
I1125 00:49:55.490675 30114 registrar.cpp:484] Successfully updated the 'registry' in 4.07808ms
I1125 00:49:55.490953 30114 registrar.cpp:370] Successfully recovered registrar
I1125 00:49:55.491005 30121 log.cpp:702] Attempting to truncate the log to 1
I1125 00:49:55.491248 30121 coordinator.cpp:348] Coordinator attempting to write TRUNCATE action at position 2
I1125 00:49:55.491536 30114 master.cpp:1435] Recovered 0 slaves from the Registry (135B) ; allowing 10mins for slaves to re-register
I1125 00:49:55.491669 30112 hierarchical.cpp:174] Allocator recovery is not supported yet
I1125 00:49:55.492290 30114 replica.cpp:538] Replica received write request for position 2 from (10896)@172.17.3.34:52833
I1125 00:49:55.492985 30114 leveldb.cpp:341] Persisting action (16 bytes) to leveldb took 669197ns
I1125 00:49:55.493017 30114 replica.cpp:713] Persisted action at 2
I1125 00:49:55.493631 30112 replica.cpp:692] Replica received learned notice for position 2 from @0.0.0.0:0
I1125 00:49:55.494076 30112 leveldb.cpp:341] Persisting action (18 bytes) to leveldb took 428504ns
I1125 00:49:55.494149 30112 leveldb.cpp:399] Deleting ~1 keys from leveldb took 59674ns
I1125 00:49:55.494189 30112 replica.cpp:713] Persisted action at 2
I1125 00:49:55.494220 30112 replica.cpp:698] Replica learned TRUNCATE action at position 2
I1125 00:49:55.502522 30093 scheduler.cpp:154] Version: 0.27.0
I1125 00:49:55.503113 30111 scheduler.cpp:236] New master detected at master@172.17.3.34:52833
I1125 00:49:55.504205 30113 scheduler.cpp:298] Sending SUBSCRIBE call to master@172.17.3.34:52833
I1125 00:49:55.505789 30123 process.cpp:3067] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I1125 00:49:55.505861 30123 http.cpp:336] HTTP POST for /master/api/v1/scheduler from 172.17.3.34:54341
I1125 00:49:55.506078 30123 master.cpp:1887] Received subscription request for HTTP framework 'default'
I1125 00:49:55.506110 30123 master.cpp:1664] Authorizing framework principal 'test-principal' to receive offers for role '*'
I1125 00:49:55.506423 30123 master.cpp:1979] Subscribing framework 'default' with checkpointing disabled and capabilities [ ]
I1125 00:49:55.506837 30114 hierarchical.cpp:220] Added framework a549ef30-fce5-40e4-a3df-dd249fff704d-0000
I1125 00:49:55.506899 30114 hierarchical.cpp:1066] No resources available to allocate!
I1125 00:49:55.506942 30114 hierarchical.cpp:1159] No inverse offers to send out!
I1125 00:49:55.506974 30114 hierarchical.cpp:961] Performed allocation for 0 slaves in 123643ns
I1125 00:49:55.507012 30114 master.hpp:1514] Sending heartbeat to a549ef30-fce5-40e4-a3df-dd249fff704d-0000
I1125 00:49:55.507769 30126 scheduler.cpp:457] Enqueuing event SUBSCRIBED received from master@172.17.3.34:52833
I1125 00:49:55.508193 30126 scheduler.cpp:457] Enqueuing event HEARTBEAT received from master@172.17.3.34:52833
I1125 00:49:55.508983 30124 master_maintenance_tests.cpp:172] Ignoring HEARTBEAT event
I1125 00:49:55.509300 30124 scheduler.cpp:298] Sending REQUEST call to master@172.17.3.34:52833
I1125 00:49:55.510570 30115 process.cpp:3067] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I1125 00:49:55.510630 30115 http.cpp:336] HTTP POST for /master/api/v1/scheduler from 172.17.3.34:54342
I1125 00:49:55.510727 30115 master.cpp:2634] Processing REQUEST call for framework a549ef30-fce5-40e4-a3df-dd249fff704d-0000 (default)
I1125 00:49:55.510895 30113 hierarchical.cpp:494] Received resource request from framework a549ef30-fce5-40e4-a3df-dd249fff704d-0000
I1125 00:49:55.511148 30124 master.cpp:926] Master terminating
I1125 00:49:55.511324 30113 hierarchical.cpp:260] Removed framework a549ef30-fce5-40e4-a3df-dd249fff704d-0000
E1125 00:49:55.513852 30122 scheduler.cpp:431] End-Of-File received from master. The master closed the event stream
[ OK ] ContentType/SchedulerTest.Request/0 (58 ms)
[ RUN ] ContentType/SchedulerTest.Request/1
I1125 00:49:55.521082 30093 leveldb.cpp:174] Opened db in 2.804322ms
I1125 00:49:55.522174 30093 leveldb.cpp:181] Compacted db in 1.06864ms
I1125 00:49:55.522244 30093 leveldb.cpp:196] Created db iterator in 74060ns
I1125 00:49:55.522331 30093 leveldb.cpp:202] Seeked to beginning of db in 11383ns
I1125 00:49:55.522343 30093 leveldb.cpp:271] Iterated through 0 keys in the db in 5487ns
I1125 00:49:55.522409 30093 replica.cpp:778] Replica recovered with log positions 0 -> 0 with 1 holes and 0 unlearned
I1125 00:49:55.523175 30122 recover.cpp:447] Starting replica recovery
I1125 00:49:55.523442 30122 recover.cpp:473] Replica is in EMPTY status
I1125 00:49:55.524505 30122 replica.cpp:674] Replica in EMPTY status received a broadcasted recover request from (10901)@172.17.3.34:52833
I1125 00:49:55.525216 30121 recover.cpp:193] Received a recover response from a replica in EMPTY status
I1125 00:49:55.525817 30112 recover.cpp:564] Updating replica status to STARTING
I1125 00:49:55.526552 30125 leveldb.cpp:304] Persisting metadata (8 bytes) to leveldb took 662168ns
I1125 00:49:55.526583 30125 replica.cpp:321] Persisted replica status to STARTING
I1125 00:49:55.526796 30118 recover.cpp:473] Replica is in STARTING status
I1125 00:49:55.527436 30121 master.cpp:365] Master 62ddd35f-9a2d-4784-ab1b-936930a8d25e (41e79a769377) started on 172.17.3.34:52833
I1125 00:49:55.527467 30121 master.cpp:367] Flags at startup: --acls="" --allocation_interval="1secs" --allocator="HierarchicalDRF" --authenticate="false" --authenticate_slaves="true" --authenticators="crammd5" --authorizers="local" --credentials="/tmp/UOXkyU/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/UOXkyU/master" --zk_session_timeout="10secs"
I1125 00:49:55.527858 30121 master.cpp:414] Master allowing unauthenticated frameworks to register
I1125 00:49:55.527876 30121 master.cpp:417] Master only allowing authenticated slaves to register
I1125 00:49:55.527889 30121 credentials.hpp:35] Loading credentials for authentication from '/tmp/UOXkyU/credentials'
I1125 00:49:55.528187 30119 replica.cpp:674] Replica in STARTING status received a broadcasted recover request from (10902)@172.17.3.34:52833
I1125 00:49:55.528262 30121 master.cpp:456] Using default 'crammd5' authenticator
I1125 00:49:55.528462 30121 master.cpp:493] Authorization enabled
I1125 00:49:55.528537 30113 recover.cpp:193] Received a recover response from a replica in STARTING status
I1125 00:49:55.529000 30114 whitelist_watcher.cpp:77] No whitelist given
I1125 00:49:55.529193 30115 recover.cpp:564] Updating replica status to VOTING
I1125 00:49:55.529011 30124 hierarchical.cpp:162] Initialized hierarchical allocator process
I1125 00:49:55.529901 30124 leveldb.cpp:304] Persisting metadata (8 bytes) to leveldb took 566086ns
I1125 00:49:55.529932 30124 replica.cpp:321] Persisted replica status to VOTING
I1125 00:49:55.530077 30124 recover.cpp:578] Successfully joined the Paxos group
I1125 00:49:55.530416 30124 recover.cpp:462] Recover process terminated
I1125 00:49:55.531231 30122 master.cpp:1625] The newly elected leader is master@172.17.3.34:52833 with id 62ddd35f-9a2d-4784-ab1b-936930a8d25e
I1125 00:49:55.531262 30122 master.cpp:1638] Elected as the leading master!
I1125 00:49:55.531272 30122 master.cpp:1383] Recovering from registrar
I1125 00:49:55.531371 30124 registrar.cpp:307] Recovering registrar
I1125 00:49:55.531915 30113 log.cpp:659] Attempting to start the writer
I1125 00:49:55.533125 30121 replica.cpp:494] Replica received implicit promise request from (10903)@172.17.3.34:52833 with proposal 1
I1125 00:49:55.533619 30121 leveldb.cpp:304] Persisting metadata (8 bytes) to leveldb took 511956ns
I1125 00:49:55.533681 30121 replica.cpp:343] Persisted promised to 1
I1125 00:49:55.534226 30113 coordinator.cpp:238] Coordinator attempting to fill missing positions
I1125 00:49:55.535336 30126 replica.cpp:389] Replica received explicit promise request from (10904)@172.17.3.34:52833 for position 0 with proposal 2
I1125 00:49:55.535835 30126 leveldb.cpp:341] Persisting action (8 bytes) to leveldb took 471465ns
I1125 00:49:55.535858 30126 replica.cpp:713] Persisted action at 0
I1125 00:49:55.536824 30126 replica.cpp:538] Replica received write request for position 0 from (10905)@172.17.3.34:52833
I1125 00:49:55.536890 30126 leveldb.cpp:436] Reading position from leveldb took 41871ns
I1125 00:49:55.537318 30126 leveldb.cpp:341] Persisting action (14 bytes) to leveldb took 399889ns
I1125 00:49:55.537341 30126 replica.cpp:713] Persisted action at 0
I1125 00:49:55.537919 30112 replica.cpp:692] Replica received learned notice for position 0 from @0.0.0.0:0
I1125 00:49:55.538458 30112 leveldb.cpp:341] Persisting action (16 bytes) to leveldb took 464869ns
I1125 00:49:55.538485 30112 replica.cpp:713] Persisted action at 0
I1125 00:49:55.538508 30112 replica.cpp:698] Replica learned NOP action at position 0
I1125 00:49:55.539270 30122 log.cpp:675] Writer started with ending position 0
I1125 00:49:55.540359 30125 leveldb.cpp:436] Reading position from leveldb took 43406ns
I1125 00:49:55.541378 30120 registrar.cpp:340] Successfully fetched the registry (0B) in 9.968128ms
I1125 00:49:55.541510 30120 registrar.cpp:439] Applied 1 operations in 44984ns; attempting to update the 'registry'
I1125 00:49:55.542266 30116 log.cpp:683] Attempting to append 174 bytes to the log
I1125 00:49:55.542367 30119 coordinator.cpp:348] Coordinator attempting to write APPEND action at position 1
I1125 00:49:55.543356 30122 replica.cpp:538] Replica received write request for position 1 from (10906)@172.17.3.34:52833
I1125 00:49:55.543840 30122 leveldb.cpp:341] Persisting action (193 bytes) to leveldb took 439047ns
I1125 00:49:55.543867 30122 replica.cpp:713] Persisted action at 1
I1125 00:49:55.544420 30122 replica.cpp:692] Replica received learned notice for position 1 from @0.0.0.0:0
I1125 00:49:55.544782 30122 leveldb.cpp:341] Persisting action (195 bytes) to leveldb took 347224ns
I1125 00:49:55.544809 30122 replica.cpp:713] Persisted action at 1
I1125 00:49:55.544836 30122 replica.cpp:698] Replica learned APPEND action at position 1
I1125 00:49:55.545822 30122 registrar.cpp:484] Successfully updated the 'registry' in 4.246016ms
I1125 00:49:55.545959 30122 registrar.cpp:370] Successfully recovered registrar
I1125 00:49:55.546010 30121 log.cpp:702] Attempting to truncate the log to 1
I1125 00:49:55.546120 30113 coordinator.cpp:348] Coordinator attempting to write TRUNCATE action at position 2
I1125 00:49:55.546476 30117 master.cpp:1435] Recovered 0 slaves from the Registry (135B) ; allowing 10mins for slaves to re-register
I1125 00:49:55.546516 30111 hierarchical.cpp:174] Allocator recovery is not supported yet
I1125 00:49:55.547003 30118 replica.cpp:538] Replica received write request for position 2 from (10907)@172.17.3.34:52833
I1125 00:49:55.547466 30118 leveldb.cpp:341] Persisting action (16 bytes) to leveldb took 389496ns
I1125 00:49:55.547488 30118 replica.cpp:713] Persisted action at 2
I1125 00:49:55.548055 30123 replica.cpp:692] Replica received learned notice for position 2 from @0.0.0.0:0
I1125 00:49:55.548488 30123 leveldb.cpp:341] Persisting action (18 bytes) to leveldb took 414045ns
I1125 00:49:55.548535 30123 leveldb.cpp:399] Deleting ~1 keys from leveldb took 33567ns
I1125 00:49:55.548554 30123 replica.cpp:713] Persisted action at 2
I1125 00:49:55.548571 30123 replica.cpp:698] Replica learned TRUNCATE action at position 2
I1125 00:49:55.557358 30093 scheduler.cpp:154] Version: 0.27.0
I1125 00:49:55.558105 30116 scheduler.cpp:236] New master detected at master@172.17.3.34:52833
I1125 00:49:55.559113 30113 scheduler.cpp:298] Sending SUBSCRIBE call to master@172.17.3.34:52833
I1125 00:49:55.560767 30112 process.cpp:3067] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I1125 00:49:55.560847 30112 http.cpp:336] HTTP POST for /master/api/v1/scheduler from 172.17.3.34:54343
I1125 00:49:55.561166 30112 master.cpp:1887] Received subscription request for HTTP framework 'default'
I1125 00:49:55.561192 30112 master.cpp:1664] Authorizing framework principal 'test-principal' to receive offers for role '*'
I1125 00:49:55.561450 30112 master.cpp:1979] Subscribing framework 'default' with checkpointing disabled and capabilities [ ]
I1125 00:49:55.561818 30126 hierarchical.cpp:220] Added framework 62ddd35f-9a2d-4784-ab1b-936930a8d25e-0000
I1125 00:49:55.561877 30126 hierarchical.cpp:1066] No resources available to allocate!
I1125 00:49:55.561918 30126 hierarchical.cpp:1159] No inverse offers to send out!
I1125 00:49:55.561949 30126 hierarchical.cpp:961] Performed allocation for 0 slaves in 116377ns
I1125 00:49:55.561940 30119 master.hpp:1514] Sending heartbeat to 62ddd35f-9a2d-4784-ab1b-936930a8d25e-0000
I1125 00:49:55.562728 30120 scheduler.cpp:457] Enqueuing event SUBSCRIBED received from master@172.17.3.34:52833
I1125 00:49:55.563161 30120 scheduler.cpp:457] Enqueuing event HEARTBEAT received from master@172.17.3.34:52833
I1125 00:49:55.563704 30123 master_maintenance_tests.cpp:172] Ignoring HEARTBEAT event
I1125 00:49:55.563771 30120 scheduler.cpp:298] Sending REQUEST call to master@172.17.3.34:52833
I1125 00:49:55.564936 30125 process.cpp:3067] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I1125 00:49:55.564988 30125 http.cpp:336] HTTP POST for /master/api/v1/scheduler from 172.17.3.34:54344
I1125 00:49:55.565176 30125 master.cpp:2634] Processing REQUEST call for framework 62ddd35f-9a2d-4784-ab1b-936930a8d25e-0000 (default)
I1125 00:49:55.565320 30114 hierarchical.cpp:494] Received resource request from framework 62ddd35f-9a2d-4784-ab1b-936930a8d25e-0000
I1125 00:49:55.565631 30123 master.cpp:926] Master terminating
I1125 00:49:55.565846 30121 hierarchical.cpp:260] Removed framework 62ddd35f-9a2d-4784-ab1b-936930a8d25e-0000
E1125 00:49:55.566426 30117 scheduler.cpp:431] End-Of-File received from master. The master closed the event stream
[ OK ] ContentType/SchedulerTest.Request/1 (53 ms)
[----------] 22 tests from ContentType/SchedulerTest (4077 ms total)
[----------] Global test environment tear-down
[==========] 849 tests from 115 test cases ran. (348474 ms total)
[ PASSED ] 848 tests.
[ FAILED ] 1 test, listed below:
[ FAILED ] FetcherCacheHttpTest.HttpMixed
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-1448410967-29299
Untagged: mesos-1448410967-29299:latest
Deleted: b8bc5b0abede9cdf766249855b7c407e19f164ae921cb242c669185eecc7573e
Deleted: d0b6d13e2b051395d21bfbeb503a1c9e948ca00e71953ce4d250e20cb71570c0
Deleted: 25ab8385ad0e190ef0fd0f8fdd89330d01c5f968a839d3f3114cc1056dab833a
Deleted: a77c922f58522291c9c69bdd53dcf5ffbea253c57d611a63bb81b6791b1d424b
Deleted: 6fd3af92affadaf5af000ff5119e2b47a96494f18b4e7da868ac484b8913a7b0
Deleted: 208a3cc9216e4c2ced726c5f3bec28b72b83f3cb4d06c0cc91c103df0b25b0f7
Deleted: 1dd5e9d7abd08d25fcd27392fd6c4501c2d520bebae6e815d263fecf919e9e83
Deleted: 27d8bdc01a5ac212f0c66c4285c1e64b8d50b4fe9f824d09dd2bb5901d6af757
Deleted: 16e6c289a48c98d707ccc4b44eb9ddf6ee03969ab7b69f0ae8c72151d81e2e60
Deleted: 83bcb0bcfa99c7a5b39d50a42f28b0a40ca17fdcf9ba3a30e532488c739bf496
Deleted: 6298d749a3a50cfe6d8b73d47c07f19d5926d53359e31fa32a82f785dc8e8916
Deleted: c28395ff4fa926403e184baa01d878de74cd5559af457aa918970fdb57a3edb8
Deleted: cf858ae9eb6b88ec7beeff6fb40a87a58662fd44ff20dcb149a621adf4bb2c2e
Build step 'Execute shell' marked build as failure
Jenkins build is back to normal : Mesos » clang,--verbose --enable-libevent --enable-ssl,ubuntu:14.04,docker||Hadoop #1277
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/Mesos/COMPILER=clang,CONFIGURATION=--verbose%20--enable-libevent%20--enable-ssl,OS=ubuntu%3A14.04,label_exp=docker%7C%7CHadoop/1277/changes>