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 02:04:53 UTC
Build failed in Jenkins: Mesos » gcc,--verbose,ubuntu:14.04,docker||Hadoop #1276
See <https://builds.apache.org/job/Mesos/COMPILER=gcc,CONFIGURATION=--verbose,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 143775 lines...]
I1125 01:04:50.714109 30291 gc.cpp:54] Scheduling '/tmp/ContentType_SchedulerTest_Message_1_cK4gHq/slaves/f2fb1cb5-f555-4de9-9be3-ad0f70d928d4-S0/frameworks/f2fb1cb5-f555-4de9-9be3-ad0f70d928d4-0000/executors/default/runs/95fbf522-5bc3-477c-8bfb-432e3b5286e7' for gc 6.99999173599407days in the future
I1125 01:04:50.714226 30289 slave.cpp:3773] Cleaning up framework f2fb1cb5-f555-4de9-9be3-ad0f70d928d4-0000
I1125 01:04:50.714292 30291 gc.cpp:54] Scheduling '/tmp/ContentType_SchedulerTest_Message_1_cK4gHq/slaves/f2fb1cb5-f555-4de9-9be3-ad0f70d928d4-S0/frameworks/f2fb1cb5-f555-4de9-9be3-ad0f70d928d4-0000/executors/default' for gc 6.99999173415407days in the future
I1125 01:04:50.714380 30293 status_update_manager.cpp:282] Closing status update streams for framework f2fb1cb5-f555-4de9-9be3-ad0f70d928d4-0000
I1125 01:04:50.714421 30291 gc.cpp:54] Scheduling '/tmp/ContentType_SchedulerTest_Message_1_cK4gHq/slaves/f2fb1cb5-f555-4de9-9be3-ad0f70d928d4-S0/frameworks/f2fb1cb5-f555-4de9-9be3-ad0f70d928d4-0000' for gc 6.99999173240889days in the future
I1125 01:04:50.714437 30293 status_update_manager.cpp:528] Cleaning up status update stream for task 7582ea08-585b-4e2c-b8f0-838e586fa0f5 of framework f2fb1cb5-f555-4de9-9be3-ad0f70d928d4-0000
[ OK ] ContentType/SchedulerTest.Message/1 (135 ms)
[ RUN ] ContentType/SchedulerTest.Request/0
I1125 01:04:50.721247 30266 leveldb.cpp:174] Opened db in 2.23361ms
I1125 01:04:50.722290 30266 leveldb.cpp:181] Compacted db in 1.001247ms
I1125 01:04:50.722347 30266 leveldb.cpp:196] Created db iterator in 23141ns
I1125 01:04:50.722363 30266 leveldb.cpp:202] Seeked to beginning of db in 2227ns
I1125 01:04:50.722373 30266 leveldb.cpp:271] Iterated through 0 keys in the db in 317ns
I1125 01:04:50.722416 30266 replica.cpp:778] Replica recovered with log positions 0 -> 0 with 1 holes and 0 unlearned
I1125 01:04:50.722893 30289 recover.cpp:447] Starting replica recovery
I1125 01:04:50.723321 30289 recover.cpp:473] Replica is in EMPTY status
I1125 01:04:50.724525 30288 replica.cpp:674] Replica in EMPTY status received a broadcasted recover request from (10854)@172.17.6.188:51980
I1125 01:04:50.724992 30287 recover.cpp:193] Received a recover response from a replica in EMPTY status
I1125 01:04:50.725512 30300 master.cpp:365] Master 581add0b-62f2-40c6-906f-a5a911e34cf7 (1dba8ce2d829) started on 172.17.6.188:51980
I1125 01:04:50.725641 30299 recover.cpp:564] Updating replica status to STARTING
I1125 01:04:50.725574 30300 master.cpp:367] Flags at startup: --acls="" --allocation_interval="1secs" --allocator="HierarchicalDRF" --authenticate="false" --authenticate_slaves="true" --authenticators="crammd5" --authorizers="local" --credentials="/tmp/sq9NMY/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/sq9NMY/master" --zk_session_timeout="10secs"
I1125 01:04:50.725916 30300 master.cpp:414] Master allowing unauthenticated frameworks to register
I1125 01:04:50.725926 30300 master.cpp:417] Master only allowing authenticated slaves to register
I1125 01:04:50.725932 30300 credentials.hpp:35] Loading credentials for authentication from '/tmp/sq9NMY/credentials'
I1125 01:04:50.726239 30300 master.cpp:456] Using default 'crammd5' authenticator
I1125 01:04:50.726369 30300 master.cpp:493] Authorization enabled
I1125 01:04:50.726527 30294 leveldb.cpp:304] Persisting metadata (8 bytes) to leveldb took 595633ns
I1125 01:04:50.726557 30294 replica.cpp:321] Persisted replica status to STARTING
I1125 01:04:50.726593 30292 whitelist_watcher.cpp:77] No whitelist given
I1125 01:04:50.726639 30285 hierarchical.cpp:162] Initialized hierarchical allocator process
I1125 01:04:50.726775 30292 recover.cpp:473] Replica is in STARTING status
I1125 01:04:50.727833 30293 replica.cpp:674] Replica in STARTING status received a broadcasted recover request from (10855)@172.17.6.188:51980
I1125 01:04:50.728157 30292 recover.cpp:193] Received a recover response from a replica in STARTING status
I1125 01:04:50.728260 30299 master.cpp:1625] The newly elected leader is master@172.17.6.188:51980 with id 581add0b-62f2-40c6-906f-a5a911e34cf7
I1125 01:04:50.728400 30299 master.cpp:1638] Elected as the leading master!
I1125 01:04:50.728440 30299 master.cpp:1383] Recovering from registrar
I1125 01:04:50.728706 30295 registrar.cpp:307] Recovering registrar
I1125 01:04:50.728948 30299 recover.cpp:564] Updating replica status to VOTING
I1125 01:04:50.729436 30285 leveldb.cpp:304] Persisting metadata (8 bytes) to leveldb took 348212ns
I1125 01:04:50.729460 30285 replica.cpp:321] Persisted replica status to VOTING
I1125 01:04:50.729543 30293 recover.cpp:578] Successfully joined the Paxos group
I1125 01:04:50.729828 30293 recover.cpp:462] Recover process terminated
I1125 01:04:50.730250 30300 log.cpp:659] Attempting to start the writer
I1125 01:04:50.731513 30294 replica.cpp:494] Replica received implicit promise request from (10856)@172.17.6.188:51980 with proposal 1
I1125 01:04:50.731855 30294 leveldb.cpp:304] Persisting metadata (8 bytes) to leveldb took 305412ns
I1125 01:04:50.731883 30294 replica.cpp:343] Persisted promised to 1
I1125 01:04:50.732565 30298 coordinator.cpp:238] Coordinator attempting to fill missing positions
I1125 01:04:50.733845 30294 replica.cpp:389] Replica received explicit promise request from (10857)@172.17.6.188:51980 for position 0 with proposal 2
I1125 01:04:50.734252 30294 leveldb.cpp:341] Persisting action (8 bytes) to leveldb took 360584ns
I1125 01:04:50.734282 30294 replica.cpp:713] Persisted action at 0
I1125 01:04:50.735627 30292 replica.cpp:538] Replica received write request for position 0 from (10858)@172.17.6.188:51980
I1125 01:04:50.735859 30292 leveldb.cpp:436] Reading position from leveldb took 55311ns
I1125 01:04:50.736402 30292 leveldb.cpp:341] Persisting action (14 bytes) to leveldb took 462174ns
I1125 01:04:50.736521 30292 replica.cpp:713] Persisted action at 0
I1125 01:04:50.737507 30295 replica.cpp:692] Replica received learned notice for position 0 from @0.0.0.0:0
I1125 01:04:50.737946 30295 leveldb.cpp:341] Persisting action (16 bytes) to leveldb took 396259ns
I1125 01:04:50.738016 30295 replica.cpp:713] Persisted action at 0
I1125 01:04:50.738047 30295 replica.cpp:698] Replica learned NOP action at position 0
I1125 01:04:50.738735 30295 log.cpp:675] Writer started with ending position 0
I1125 01:04:50.740341 30287 leveldb.cpp:436] Reading position from leveldb took 58888ns
I1125 01:04:50.741933 30287 registrar.cpp:340] Successfully fetched the registry (0B) in 13.17504ms
I1125 01:04:50.742794 30287 registrar.cpp:439] Applied 1 operations in 45257ns; attempting to update the 'registry'
I1125 01:04:50.744071 30299 log.cpp:683] Attempting to append 176 bytes to the log
I1125 01:04:50.744240 30290 coordinator.cpp:348] Coordinator attempting to write APPEND action at position 1
I1125 01:04:50.745110 30294 replica.cpp:538] Replica received write request for position 1 from (10859)@172.17.6.188:51980
I1125 01:04:50.745533 30294 leveldb.cpp:341] Persisting action (195 bytes) to leveldb took 379781ns
I1125 01:04:50.745558 30294 replica.cpp:713] Persisted action at 1
I1125 01:04:50.746181 30297 replica.cpp:692] Replica received learned notice for position 1 from @0.0.0.0:0
I1125 01:04:50.746498 30297 leveldb.cpp:341] Persisting action (197 bytes) to leveldb took 285211ns
I1125 01:04:50.746521 30297 replica.cpp:713] Persisted action at 1
I1125 01:04:50.746538 30297 replica.cpp:698] Replica learned APPEND action at position 1
I1125 01:04:50.747516 30299 registrar.cpp:484] Successfully updated the 'registry' in 4.431104ms
I1125 01:04:50.747689 30299 registrar.cpp:370] Successfully recovered registrar
I1125 01:04:50.747755 30296 log.cpp:702] Attempting to truncate the log to 1
I1125 01:04:50.747875 30300 coordinator.cpp:348] Coordinator attempting to write TRUNCATE action at position 2
I1125 01:04:50.748158 30296 master.cpp:1435] Recovered 0 slaves from the Registry (137B) ; allowing 10mins for slaves to re-register
I1125 01:04:50.748215 30300 hierarchical.cpp:174] Allocator recovery is not supported yet
I1125 01:04:50.748824 30291 replica.cpp:538] Replica received write request for position 2 from (10860)@172.17.6.188:51980
I1125 01:04:50.749183 30291 leveldb.cpp:341] Persisting action (16 bytes) to leveldb took 319164ns
I1125 01:04:50.749207 30291 replica.cpp:713] Persisted action at 2
I1125 01:04:50.749727 30300 replica.cpp:692] Replica received learned notice for position 2 from @0.0.0.0:0
I1125 01:04:50.750089 30300 leveldb.cpp:341] Persisting action (18 bytes) to leveldb took 293355ns
I1125 01:04:50.750144 30300 leveldb.cpp:399] Deleting ~1 keys from leveldb took 29668ns
I1125 01:04:50.750169 30300 replica.cpp:713] Persisted action at 2
I1125 01:04:50.750186 30300 replica.cpp:698] Replica learned TRUNCATE action at position 2
I1125 01:04:50.759316 30266 scheduler.cpp:154] Version: 0.27.0
I1125 01:04:50.759948 30298 scheduler.cpp:236] New master detected at master@172.17.6.188:51980
I1125 01:04:50.761076 30298 scheduler.cpp:298] Sending SUBSCRIBE call to master@172.17.6.188:51980
I1125 01:04:50.763542 30287 process.cpp:3067] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I1125 01:04:50.763604 30287 http.cpp:336] HTTP POST for /master/api/v1/scheduler from 172.17.6.188:56339
I1125 01:04:50.763799 30287 master.cpp:1887] Received subscription request for HTTP framework 'default'
I1125 01:04:50.763870 30287 master.cpp:1664] Authorizing framework principal 'test-principal' to receive offers for role '*'
I1125 01:04:50.764211 30295 master.cpp:1979] Subscribing framework 'default' with checkpointing disabled and capabilities [ ]
I1125 01:04:50.764607 30291 hierarchical.cpp:220] Added framework 581add0b-62f2-40c6-906f-a5a911e34cf7-0000
I1125 01:04:50.764672 30292 master.hpp:1514] Sending heartbeat to 581add0b-62f2-40c6-906f-a5a911e34cf7-0000
I1125 01:04:50.764677 30291 hierarchical.cpp:1066] No resources available to allocate!
I1125 01:04:50.764753 30291 hierarchical.cpp:1159] No inverse offers to send out!
I1125 01:04:50.764794 30291 hierarchical.cpp:961] Performed allocation for 0 slaves in 156330ns
I1125 01:04:50.766208 30294 scheduler.cpp:457] Enqueuing event SUBSCRIBED received from master@172.17.6.188:51980
I1125 01:04:50.766701 30294 scheduler.cpp:457] Enqueuing event HEARTBEAT received from master@172.17.6.188:51980
I1125 01:04:50.767467 30299 master_maintenance_tests.cpp:172] Ignoring HEARTBEAT event
I1125 01:04:50.767649 30294 scheduler.cpp:298] Sending REQUEST call to master@172.17.6.188:51980
I1125 01:04:50.769567 30290 process.cpp:3067] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I1125 01:04:50.769650 30290 http.cpp:336] HTTP POST for /master/api/v1/scheduler from 172.17.6.188:56340
I1125 01:04:50.769796 30290 master.cpp:2634] Processing REQUEST call for framework 581add0b-62f2-40c6-906f-a5a911e34cf7-0000 (default)
I1125 01:04:50.770031 30286 hierarchical.cpp:494] Received resource request from framework 581add0b-62f2-40c6-906f-a5a911e34cf7-0000
I1125 01:04:50.770578 30295 master.cpp:926] Master terminating
I1125 01:04:50.770871 30299 hierarchical.cpp:260] Removed framework 581add0b-62f2-40c6-906f-a5a911e34cf7-0000
E1125 01:04:50.771661 30297 scheduler.cpp:431] End-Of-File received from master. The master closed the event stream
[ OK ] ContentType/SchedulerTest.Request/0 (63 ms)
[ RUN ] ContentType/SchedulerTest.Request/1
I1125 01:04:50.785336 30266 leveldb.cpp:174] Opened db in 2.558908ms
I1125 01:04:50.786689 30266 leveldb.cpp:181] Compacted db in 1.176989ms
I1125 01:04:50.786841 30266 leveldb.cpp:196] Created db iterator in 39192ns
I1125 01:04:50.786995 30266 leveldb.cpp:202] Seeked to beginning of db in 3022ns
I1125 01:04:50.787124 30266 leveldb.cpp:271] Iterated through 0 keys in the db in 511ns
I1125 01:04:50.787309 30266 replica.cpp:778] Replica recovered with log positions 0 -> 0 with 1 holes and 0 unlearned
I1125 01:04:50.788350 30291 recover.cpp:447] Starting replica recovery
I1125 01:04:50.788704 30288 recover.cpp:473] Replica is in EMPTY status
I1125 01:04:50.790261 30293 replica.cpp:674] Replica in EMPTY status received a broadcasted recover request from (10865)@172.17.6.188:51980
I1125 01:04:50.790575 30293 recover.cpp:193] Received a recover response from a replica in EMPTY status
I1125 01:04:50.790941 30294 recover.cpp:564] Updating replica status to STARTING
I1125 01:04:50.791621 30287 leveldb.cpp:304] Persisting metadata (8 bytes) to leveldb took 503049ns
I1125 01:04:50.791649 30287 replica.cpp:321] Persisted replica status to STARTING
I1125 01:04:50.791831 30296 recover.cpp:473] Replica is in STARTING status
I1125 01:04:50.792562 30287 master.cpp:365] Master 53fc042d-6df1-463a-8b4d-283bcd54f7c0 (1dba8ce2d829) started on 172.17.6.188:51980
I1125 01:04:50.792637 30287 master.cpp:367] Flags at startup: --acls="" --allocation_interval="1secs" --allocator="HierarchicalDRF" --authenticate="false" --authenticate_slaves="true" --authenticators="crammd5" --authorizers="local" --credentials="/tmp/uVP4LP/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/uVP4LP/master" --zk_session_timeout="10secs"
I1125 01:04:50.793017 30287 master.cpp:414] Master allowing unauthenticated frameworks to register
I1125 01:04:50.793123 30287 master.cpp:417] Master only allowing authenticated slaves to register
I1125 01:04:50.793205 30287 credentials.hpp:35] Loading credentials for authentication from '/tmp/uVP4LP/credentials'
I1125 01:04:50.793331 30285 replica.cpp:674] Replica in STARTING status received a broadcasted recover request from (10866)@172.17.6.188:51980
I1125 01:04:50.793598 30287 master.cpp:456] Using default 'crammd5' authenticator
I1125 01:04:50.793736 30287 master.cpp:493] Authorization enabled
I1125 01:04:50.793783 30300 recover.cpp:193] Received a recover response from a replica in STARTING status
I1125 01:04:50.794157 30285 hierarchical.cpp:162] Initialized hierarchical allocator process
I1125 01:04:50.794247 30286 whitelist_watcher.cpp:77] No whitelist given
I1125 01:04:50.794355 30298 recover.cpp:564] Updating replica status to VOTING
I1125 01:04:50.794853 30293 leveldb.cpp:304] Persisting metadata (8 bytes) to leveldb took 345297ns
I1125 01:04:50.794937 30293 replica.cpp:321] Persisted replica status to VOTING
I1125 01:04:50.795156 30290 recover.cpp:578] Successfully joined the Paxos group
I1125 01:04:50.795500 30290 recover.cpp:462] Recover process terminated
I1125 01:04:50.797803 30299 master.cpp:1625] The newly elected leader is master@172.17.6.188:51980 with id 53fc042d-6df1-463a-8b4d-283bcd54f7c0
I1125 01:04:50.797847 30299 master.cpp:1638] Elected as the leading master!
I1125 01:04:50.797869 30299 master.cpp:1383] Recovering from registrar
I1125 01:04:50.798074 30286 registrar.cpp:307] Recovering registrar
I1125 01:04:50.798933 30286 log.cpp:659] Attempting to start the writer
I1125 01:04:50.800428 30286 replica.cpp:494] Replica received implicit promise request from (10867)@172.17.6.188:51980 with proposal 1
I1125 01:04:50.800925 30286 leveldb.cpp:304] Persisting metadata (8 bytes) to leveldb took 452163ns
I1125 01:04:50.800967 30286 replica.cpp:343] Persisted promised to 1
I1125 01:04:50.801704 30286 coordinator.cpp:238] Coordinator attempting to fill missing positions
I1125 01:04:50.803084 30296 replica.cpp:389] Replica received explicit promise request from (10868)@172.17.6.188:51980 for position 0 with proposal 2
I1125 01:04:50.803515 30296 leveldb.cpp:341] Persisting action (8 bytes) to leveldb took 379769ns
I1125 01:04:50.803545 30296 replica.cpp:713] Persisted action at 0
I1125 01:04:50.806038 30286 replica.cpp:538] Replica received write request for position 0 from (10869)@172.17.6.188:51980
I1125 01:04:50.806148 30286 leveldb.cpp:436] Reading position from leveldb took 51146ns
I1125 01:04:50.806649 30286 leveldb.cpp:341] Persisting action (14 bytes) to leveldb took 435175ns
I1125 01:04:50.807037 30286 replica.cpp:713] Persisted action at 0
I1125 01:04:50.808238 30286 replica.cpp:692] Replica received learned notice for position 0 from @0.0.0.0:0
I1125 01:04:50.809028 30286 leveldb.cpp:341] Persisting action (16 bytes) to leveldb took 380583ns
I1125 01:04:50.809392 30286 replica.cpp:713] Persisted action at 0
I1125 01:04:50.809504 30286 replica.cpp:698] Replica learned NOP action at position 0
I1125 01:04:50.810863 30297 log.cpp:675] Writer started with ending position 0
I1125 01:04:50.812608 30286 leveldb.cpp:436] Reading position from leveldb took 59601ns
I1125 01:04:50.813737 30293 registrar.cpp:340] Successfully fetched the registry (0B) in 15.613952ms
I1125 01:04:50.813882 30293 registrar.cpp:439] Applied 1 operations in 40201ns; attempting to update the 'registry'
I1125 01:04:50.814672 30288 log.cpp:683] Attempting to append 176 bytes to the log
I1125 01:04:50.814981 30288 coordinator.cpp:348] Coordinator attempting to write APPEND action at position 1
I1125 01:04:50.816112 30287 replica.cpp:538] Replica received write request for position 1 from (10870)@172.17.6.188:51980
I1125 01:04:50.817011 30287 leveldb.cpp:341] Persisting action (195 bytes) to leveldb took 846916ns
I1125 01:04:50.817044 30287 replica.cpp:713] Persisted action at 1
I1125 01:04:50.818060 30290 replica.cpp:692] Replica received learned notice for position 1 from @0.0.0.0:0
I1125 01:04:50.818583 30290 leveldb.cpp:341] Persisting action (197 bytes) to leveldb took 413434ns
I1125 01:04:50.818676 30290 replica.cpp:713] Persisted action at 1
I1125 01:04:50.818796 30290 replica.cpp:698] Replica learned APPEND action at position 1
I1125 01:04:50.821017 30290 registrar.cpp:484] Successfully updated the 'registry' in 7.055104ms
I1125 01:04:50.821537 30290 registrar.cpp:370] Successfully recovered registrar
I1125 01:04:50.821017 30287 log.cpp:702] Attempting to truncate the log to 1
I1125 01:04:50.823026 30300 master.cpp:1435] Recovered 0 slaves from the Registry (137B) ; allowing 10mins for slaves to re-register
I1125 01:04:50.823048 30288 hierarchical.cpp:174] Allocator recovery is not supported yet
I1125 01:04:50.823320 30286 coordinator.cpp:348] Coordinator attempting to write TRUNCATE action at position 2
I1125 01:04:50.824856 30300 replica.cpp:538] Replica received write request for position 2 from (10871)@172.17.6.188:51980
I1125 01:04:50.826006 30300 leveldb.cpp:341] Persisting action (16 bytes) to leveldb took 1.092547ms
I1125 01:04:50.826056 30300 replica.cpp:713] Persisted action at 2
I1125 01:04:50.827138 30300 replica.cpp:692] Replica received learned notice for position 2 from @0.0.0.0:0
I1125 01:04:50.827996 30300 leveldb.cpp:341] Persisting action (18 bytes) to leveldb took 818002ns
I1125 01:04:50.828065 30300 leveldb.cpp:399] Deleting ~1 keys from leveldb took 38812ns
I1125 01:04:50.828093 30300 replica.cpp:713] Persisted action at 2
I1125 01:04:50.828124 30300 replica.cpp:698] Replica learned TRUNCATE action at position 2
I1125 01:04:50.834837 30266 scheduler.cpp:154] Version: 0.27.0
I1125 01:04:50.836572 30285 scheduler.cpp:236] New master detected at master@172.17.6.188:51980
I1125 01:04:50.839136 30285 scheduler.cpp:298] Sending SUBSCRIBE call to master@172.17.6.188:51980
I1125 01:04:50.842684 30291 process.cpp:3067] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I1125 01:04:50.842768 30291 http.cpp:336] HTTP POST for /master/api/v1/scheduler from 172.17.6.188:56341
I1125 01:04:50.843261 30291 master.cpp:1887] Received subscription request for HTTP framework 'default'
I1125 01:04:50.843343 30291 master.cpp:1664] Authorizing framework principal 'test-principal' to receive offers for role '*'
I1125 01:04:50.844032 30290 master.cpp:1979] Subscribing framework 'default' with checkpointing disabled and capabilities [ ]
I1125 01:04:50.844775 30290 hierarchical.cpp:220] Added framework 53fc042d-6df1-463a-8b4d-283bcd54f7c0-0000
I1125 01:04:50.844841 30290 hierarchical.cpp:1066] No resources available to allocate!
I1125 01:04:50.844878 30290 hierarchical.cpp:1159] No inverse offers to send out!
I1125 01:04:50.844903 30290 hierarchical.cpp:961] Performed allocation for 0 slaves in 101129ns
I1125 01:04:50.845005 30285 master.hpp:1514] Sending heartbeat to 53fc042d-6df1-463a-8b4d-283bcd54f7c0-0000
I1125 01:04:50.846884 30285 scheduler.cpp:457] Enqueuing event SUBSCRIBED received from master@172.17.6.188:51980
I1125 01:04:50.847780 30285 scheduler.cpp:457] Enqueuing event HEARTBEAT received from master@172.17.6.188:51980
I1125 01:04:50.848400 30285 master_maintenance_tests.cpp:172] Ignoring HEARTBEAT event
[ OK ] ContentType/SchedulerTest.Request/1 (83 ms)
I1125 01:04:50.850134 30285 scheduler.cpp:298] Sending REQUEST call to master@172.17.6.188:51980
I1125 01:04:50.854167 30294 process.cpp:3067] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I1125 01:04:50.854255 30294 http.cpp:336] HTTP POST for /master/api/v1/scheduler from 172.17.6.188:56342
I1125 01:04:50.854646 30294 master.cpp:2634] Processing REQUEST call for framework 53fc042d-6df1-463a-8b4d-283bcd54f7c0-0000 (default)
I1125 01:04:50.854923 30294 hierarchical.cpp:494] Received resource request from framework 53fc042d-6df1-463a-8b4d-283bcd54f7c0-0000
I1125 01:04:50.855453 30266 master.cpp:926] Master terminating
I1125 01:04:50.855849 30285 hierarchical.cpp:260] Removed framework 53fc042d-6df1-463a-8b4d-283bcd54f7c0-0000
E1125 01:04:50.858270 30298 scheduler.cpp:431] End-Of-File received from master. The master closed the event stream
[----------] 22 tests from ContentType/SchedulerTest (4516 ms total)
[----------] Global test environment tear-down
[==========] 842 tests from 114 test cases ran. (366271 ms total)
[ PASSED ] 841 tests.
[ FAILED ] 1 test, listed below:
[ FAILED ] MonitorIntegrationTest.RunningExecutor
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-1448411540-22679
Untagged: mesos-1448411540-22679:latest
Deleted: 4af2cfdbbaae3f05281bc8616167b6467789d399389e06d09a03cf08e79ba15e
Deleted: f4bc60857318719e3225fdaaf48705c5c2981fde2643d86bc08fe5607cedac8b
Deleted: 54e1e841fbd8c0ad8ef4721c5c86e997f090f0b63be87c82140a5aee265c40da
Deleted: 4b6c9ddba82f92e8bd68fc7e261b71d7b8cfa2084a04ab3d2a3cc10cec91fe4f
Deleted: e598677ee3dbc9c6ece37fbdfeb4a4de88fbbe305a8452219129e7fc175588e6
Deleted: 602c6cd457de5734115602ef694805eb999c30d6ea66806ceabef61e577d7722
Deleted: 16eaf222de0aec8867cd71925eb8d8cf4609bd2fb420995f51ee54298d8b3692
Deleted: 434f40c4844d5912710e4ef695b880242a6540f4656256504ce53234688060a1
Deleted: bff4f9085302c4a9a6ae2f61ce5f7a26b1dfa77c1ef064dd046c664bd362d69d
Deleted: c78d335294b984987f91b7a83bdb342c13ae735e2ea012deb39235cd21ae8e8d
Deleted: f76f7bc78bb1abf1aa7f0543e4f65b444e468db3cbbe6da44548673e4cbcda01
Deleted: 42bebca925c7050116947dfc01f37039dcc6e6c9e6e1e4927c7d9eedd1be1197
Deleted: e4175d19902bc530c54a5cbd771b3d7c721f35556b3bc604a7fd98f7ff20d92d
Build step 'Execute shell' marked build as failure
Jenkins build is back to normal : Mesos » gcc,--verbose,ubuntu:14.04,docker||Hadoop #1277
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/1277/changes>