Mailing-List: contact builds-help@mesos.apache.org; run by ezmlm
Precedence: bulk
Reply-To: builds@mesos.apache.org
Date: Thu, 3 Dec 2015 08:54:58 +0000 (UTC)
From: Apache Jenkins Server  <jenkins@builds.apache.org>
To: builds@mesos.apache.org
Message-ID: <31887830.10136.1449132898526.JavaMail.jenkins@crius>
Subject: Build failed in Jenkins: mesos-reviewbot #10010
MIME-Version: 1.0
Content-Type: text/plain; charset=UTF-8
Content-Transfer-Encoding: 7bit

See <https://builds.apache.org/job/mesos-reviewbot/10010/>

------------------------------------------
[...truncated 160054 lines...]
[       OK ] ContentType/SchedulerTest.Message/1 (782 ms)
[ RUN      ] ContentType/SchedulerTest.Request/0
I1203 08:54:29.417843 30308 leveldb.cpp:174] Opened db in 162.353932ms
I1203 08:54:29.476701 30308 leveldb.cpp:181] Compacted db in 58.78272ms
I1203 08:54:29.476794 30308 leveldb.cpp:196] Created db iterator in 26843ns
I1203 08:54:29.476812 30308 leveldb.cpp:202] Seeked to beginning of db in 3331ns
I1203 08:54:29.476824 30308 leveldb.cpp:271] Iterated through 0 keys in the db in 381ns
I1203 08:54:29.476877 30308 replica.cpp:778] Replica recovered with log positions 0 -> 0 with 1 holes and 0 unlearned
I1203 08:54:29.482358 30340 master.cpp:365] Master 68a5e0fd-22b9-47a6-814d-8e6fa32abdc8 (f1295df450cd) started on 172.17.0.1:60986
I1203 08:54:29.482544 30339 recover.cpp:447] Starting replica recovery
I1203 08:54:29.482399 30340 master.cpp:367] Flags at startup: --acls="" --allocation_interval="1secs" --allocator="HierarchicalDRF" --authenticate="false" --authenticate_slaves="true" --authenticators="crammd5" --authorizers="local" --credentials="/tmp/ZmvutN/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/ZmvutN/master" --zk_session_timeout="10secs"
I1203 08:54:29.482751 30340 master.cpp:414] Master allowing unauthenticated frameworks to register
I1203 08:54:29.482764 30340 master.cpp:417] Master only allowing authenticated slaves to register
I1203 08:54:29.482774 30340 credentials.hpp:35] Loading credentials for authentication from '/tmp/ZmvutN/credentials'
I1203 08:54:29.482995 30339 recover.cpp:473] Replica is in EMPTY status
I1203 08:54:29.483094 30340 master.cpp:456] Using default 'crammd5' authenticator
I1203 08:54:29.483333 30340 master.cpp:493] Authorization enabled
I1203 08:54:29.483880 30339 hierarchical.cpp:162] Initialized hierarchical allocator process
I1203 08:54:29.484184 30339 whitelist_watcher.cpp:77] No whitelist given
I1203 08:54:29.484436 30337 replica.cpp:674] Replica in EMPTY status received a broadcasted recover request from (11460)@172.17.0.1:60986
I1203 08:54:29.485110 30339 recover.cpp:193] Received a recover response from a replica in EMPTY status
I1203 08:54:29.488104 30340 master.cpp:1637] The newly elected leader is master@172.17.0.1:60986 with id 68a5e0fd-22b9-47a6-814d-8e6fa32abdc8
I1203 08:54:29.488330 30340 master.cpp:1650] Elected as the leading master!
I1203 08:54:29.488476 30340 master.cpp:1395] Recovering from registrar
I1203 08:54:29.488876 30340 registrar.cpp:307] Recovering registrar
I1203 08:54:29.491420 30338 recover.cpp:564] Updating replica status to STARTING
I1203 08:54:29.527071 30327 leveldb.cpp:304] Persisting metadata (8 bytes) to leveldb took 35.481268ms
I1203 08:54:29.527156 30327 replica.cpp:321] Persisted replica status to STARTING
I1203 08:54:29.527516 30338 recover.cpp:473] Replica is in STARTING status
I1203 08:54:29.528681 30327 replica.cpp:674] Replica in STARTING status received a broadcasted recover request from (11461)@172.17.0.1:60986
I1203 08:54:29.529259 30338 recover.cpp:193] Received a recover response from a replica in STARTING status
I1203 08:54:29.529829 30327 recover.cpp:564] Updating replica status to VOTING
I1203 08:54:29.568976 30338 leveldb.cpp:304] Persisting metadata (8 bytes) to leveldb took 38.973519ms
I1203 08:54:29.569063 30338 replica.cpp:321] Persisted replica status to VOTING
I1203 08:54:29.569301 30327 recover.cpp:578] Successfully joined the Paxos group
I1203 08:54:29.569576 30327 recover.cpp:462] Recover process terminated
I1203 08:54:29.570082 30338 log.cpp:659] Attempting to start the writer
I1203 08:54:29.571569 30336 replica.cpp:494] Replica received implicit promise request from (11462)@172.17.0.1:60986 with proposal 1
I1203 08:54:29.619338 30336 leveldb.cpp:304] Persisting metadata (8 bytes) to leveldb took 47.719984ms
I1203 08:54:29.619408 30336 replica.cpp:343] Persisted promised to 1
I1203 08:54:29.620221 30341 coordinator.cpp:238] Coordinator attempting to fill missing positions
I1203 08:54:29.621928 30339 replica.cpp:389] Replica received explicit promise request from (11463)@172.17.0.1:60986 for position 0 with proposal 2
I1203 08:54:29.686539 30339 leveldb.cpp:341] Persisting action (8 bytes) to leveldb took 64.541365ms
I1203 08:54:29.686621 30339 replica.cpp:713] Persisted action at 0
I1203 08:54:29.688341 30339 replica.cpp:538] Replica received write request for position 0 from (11464)@172.17.0.1:60986
I1203 08:54:29.688422 30339 leveldb.cpp:436] Reading position from leveldb took 41499ns
I1203 08:54:29.722802 30339 leveldb.cpp:341] Persisting action (14 bytes) to leveldb took 34.318931ms
I1203 08:54:29.722872 30339 replica.cpp:713] Persisted action at 0
I1203 08:54:29.723754 30328 replica.cpp:692] Replica received learned notice for position 0 from @0.0.0.0:0
I1203 08:54:29.751986 30328 leveldb.cpp:341] Persisting action (16 bytes) to leveldb took 28.172416ms
I1203 08:54:29.752073 30328 replica.cpp:713] Persisted action at 0
I1203 08:54:29.752110 30328 replica.cpp:698] Replica learned NOP action at position 0
I1203 08:54:29.753306 30327 log.cpp:675] Writer started with ending position 0
I1203 08:54:29.754909 30332 leveldb.cpp:436] Reading position from leveldb took 54055ns
I1203 08:54:29.757530 30330 registrar.cpp:340] Successfully fetched the registry (0B) in 268.3712ms
I1203 08:54:29.757779 30330 registrar.cpp:439] Applied 1 operations in 38570ns; attempting to update the 'registry'
I1203 08:54:29.758813 30335 log.cpp:683] Attempting to append 170 bytes to the log
I1203 08:54:29.759160 30335 coordinator.cpp:348] Coordinator attempting to write APPEND action at position 1
I1203 08:54:29.760411 30340 replica.cpp:538] Replica received write request for position 1 from (11465)@172.17.0.1:60986
I1203 08:54:29.785464 30340 leveldb.cpp:341] Persisting action (189 bytes) to leveldb took 24.985268ms
I1203 08:54:29.785547 30340 replica.cpp:713] Persisted action at 1
I1203 08:54:29.786613 30334 replica.cpp:692] Replica received learned notice for position 1 from @0.0.0.0:0
I1203 08:54:29.810606 30334 leveldb.cpp:341] Persisting action (191 bytes) to leveldb took 23.93952ms
I1203 08:54:29.810683 30334 replica.cpp:713] Persisted action at 1
I1203 08:54:29.810714 30334 replica.cpp:698] Replica learned APPEND action at position 1
I1203 08:54:29.812227 30337 registrar.cpp:484] Successfully updated the 'registry' in 54.279936ms
I1203 08:54:29.812404 30337 registrar.cpp:370] Successfully recovered registrar
I1203 08:54:29.812495 30327 log.cpp:702] Attempting to truncate the log to 1
I1203 08:54:29.813194 30341 hierarchical.cpp:174] Allocator recovery is not supported yet
I1203 08:54:29.813277 30331 master.cpp:1447] Recovered 0 slaves from the Registry (131B) ; allowing 10mins for slaves to re-register
I1203 08:54:29.813372 30329 coordinator.cpp:348] Coordinator attempting to write TRUNCATE action at position 2
I1203 08:54:29.814440 30334 replica.cpp:538] Replica received write request for position 2 from (11466)@172.17.0.1:60986
I1203 08:54:29.840422 30334 leveldb.cpp:341] Persisting action (16 bytes) to leveldb took 25.912288ms
I1203 08:54:29.840523 30334 replica.cpp:713] Persisted action at 2
I1203 08:54:29.841569 30327 replica.cpp:692] Replica received learned notice for position 2 from @0.0.0.0:0
I1203 08:54:29.865568 30327 leveldb.cpp:341] Persisting action (18 bytes) to leveldb took 23.923027ms
I1203 08:54:29.865716 30327 leveldb.cpp:399] Deleting ~1 keys from leveldb took 70535ns
I1203 08:54:29.865744 30327 replica.cpp:713] Persisted action at 2
I1203 08:54:29.865779 30327 replica.cpp:698] Replica learned TRUNCATE action at position 2
I1203 08:54:29.874474 30308 scheduler.cpp:154] Version: 0.27.0
I1203 08:54:29.875582 30336 scheduler.cpp:236] New master detected at master@172.17.0.1:60986
I1203 08:54:29.877001 30336 scheduler.cpp:298] Sending SUBSCRIBE call to master@172.17.0.1:60986
I1203 08:54:29.879727 30330 process.cpp:3067] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I1203 08:54:29.879822 30330 http.cpp:336] HTTP POST for /master/api/v1/scheduler from 172.17.0.1:59439
I1203 08:54:29.880079 30330 master.cpp:1899] Received subscription request for HTTP framework 'default'
I1203 08:54:29.880161 30330 master.cpp:1676] Authorizing framework principal 'test-principal' to receive offers for role '*'
I1203 08:54:29.880934 30330 master.cpp:1991] Subscribing framework 'default' with checkpointing disabled and capabilities [  ]
I1203 08:54:29.882100 30330 hierarchical.cpp:220] Added framework 68a5e0fd-22b9-47a6-814d-8e6fa32abdc8-0000
I1203 08:54:29.882444 30333 master.hpp:1583] Sending heartbeat to 68a5e0fd-22b9-47a6-814d-8e6fa32abdc8-0000
I1203 08:54:29.884011 30333 scheduler.cpp:457] Enqueuing event SUBSCRIBED received from master@172.17.0.1:60986
I1203 08:54:29.882164 30330 hierarchical.cpp:1062] No resources available to allocate!
I1203 08:54:29.884340 30330 hierarchical.cpp:1155] No inverse offers to send out!
I1203 08:54:29.884377 30330 hierarchical.cpp:957] Performed allocation for 0 slaves in 2.253323ms
I1203 08:54:29.884629 30333 scheduler.cpp:457] Enqueuing event HEARTBEAT received from master@172.17.0.1:60986
I1203 08:54:29.885100 30330 master_maintenance_tests.cpp:172] Ignoring HEARTBEAT event
I1203 08:54:29.885728 30331 scheduler.cpp:298] Sending REQUEST call to master@172.17.0.1:60986
I1203 08:54:29.888211 30331 process.cpp:3067] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I1203 08:54:29.888285 30331 http.cpp:336] HTTP POST for /master/api/v1/scheduler from 172.17.0.1:59440
I1203 08:54:29.888406 30331 master.cpp:2646] Processing REQUEST call for framework 68a5e0fd-22b9-47a6-814d-8e6fa32abdc8-0000 (default)
I1203 08:54:29.888666 30331 hierarchical.cpp:492] Received resource request from framework 68a5e0fd-22b9-47a6-814d-8e6fa32abdc8-0000
I1203 08:54:29.889343 30341 master.cpp:938] Master terminating
I1203 08:54:29.889613 30334 hierarchical.cpp:260] Removed framework 68a5e0fd-22b9-47a6-814d-8e6fa32abdc8-0000
E1203 08:54:29.891527 30337 scheduler.cpp:431] End-Of-File received from master. The master closed the event stream
[       OK ] ContentType/SchedulerTest.Request/0 (651 ms)
[ RUN      ] ContentType/SchedulerTest.Request/1
I1203 08:54:30.007683 30308 leveldb.cpp:174] Opened db in 100.603873ms
I1203 08:54:30.055439 30308 leveldb.cpp:181] Compacted db in 47.681158ms
I1203 08:54:30.055531 30308 leveldb.cpp:196] Created db iterator in 24654ns
I1203 08:54:30.055552 30308 leveldb.cpp:202] Seeked to beginning of db in 2998ns
I1203 08:54:30.055564 30308 leveldb.cpp:271] Iterated through 0 keys in the db in 255ns
I1203 08:54:30.055619 30308 replica.cpp:778] Replica recovered with log positions 0 -> 0 with 1 holes and 0 unlearned
I1203 08:54:30.056459 30340 recover.cpp:447] Starting replica recovery
I1203 08:54:30.056766 30340 recover.cpp:473] Replica is in EMPTY status
I1203 08:54:30.058224 30334 replica.cpp:674] Replica in EMPTY status received a broadcasted recover request from (11471)@172.17.0.1:60986
I1203 08:54:30.060616 30339 master.cpp:365] Master 4ef8b0d7-038b-4610-b557-5e895e63f523 (f1295df450cd) started on 172.17.0.1:60986
I1203 08:54:30.060873 30330 recover.cpp:193] Received a recover response from a replica in EMPTY status
I1203 08:54:30.060667 30339 master.cpp:367] Flags at startup: --acls="" --allocation_interval="1secs" --allocator="HierarchicalDRF" --authenticate="false" --authenticate_slaves="true" --authenticators="crammd5" --authorizers="local" --credentials="/tmp/7SWAZo/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/7SWAZo/master" --zk_session_timeout="10secs"
I1203 08:54:30.061400 30339 master.cpp:414] Master allowing unauthenticated frameworks to register
I1203 08:54:30.061414 30339 master.cpp:417] Master only allowing authenticated slaves to register
I1203 08:54:30.061424 30339 credentials.hpp:35] Loading credentials for authentication from '/tmp/7SWAZo/credentials'
I1203 08:54:30.061844 30339 master.cpp:456] Using default 'crammd5' authenticator
I1203 08:54:30.061920 30330 recover.cpp:564] Updating replica status to STARTING
I1203 08:54:30.062031 30339 master.cpp:493] Authorization enabled
I1203 08:54:30.063539 30341 whitelist_watcher.cpp:77] No whitelist given
I1203 08:54:30.063715 30333 hierarchical.cpp:162] Initialized hierarchical allocator process
I1203 08:54:30.065374 30339 master.cpp:1637] The newly elected leader is master@172.17.0.1:60986 with id 4ef8b0d7-038b-4610-b557-5e895e63f523
I1203 08:54:30.065534 30339 master.cpp:1650] Elected as the leading master!
I1203 08:54:30.065667 30339 master.cpp:1395] Recovering from registrar
I1203 08:54:30.065959 30334 registrar.cpp:307] Recovering registrar
I1203 08:54:30.128442 30330 leveldb.cpp:304] Persisting metadata (8 bytes) to leveldb took 66.130462ms
I1203 08:54:30.128525 30330 replica.cpp:321] Persisted replica status to STARTING
I1203 08:54:30.128959 30331 recover.cpp:473] Replica is in STARTING status
I1203 08:54:30.130549 30329 replica.cpp:674] Replica in STARTING status received a broadcasted recover request from (11472)@172.17.0.1:60986
I1203 08:54:30.130861 30338 recover.cpp:193] Received a recover response from a replica in STARTING status
I1203 08:54:30.131595 30337 recover.cpp:564] Updating replica status to VOTING
I1203 08:54:30.187139 30334 leveldb.cpp:304] Persisting metadata (8 bytes) to leveldb took 55.34022ms
I1203 08:54:30.187232 30334 replica.cpp:321] Persisted replica status to VOTING
I1203 08:54:30.187482 30334 recover.cpp:578] Successfully joined the Paxos group
I1203 08:54:30.187677 30334 recover.cpp:462] Recover process terminated
I1203 08:54:30.188344 30334 log.cpp:659] Attempting to start the writer
I1203 08:54:30.189951 30334 replica.cpp:494] Replica received implicit promise request from (11473)@172.17.0.1:60986 with proposal 1
I1203 08:54:30.245693 30334 leveldb.cpp:304] Persisting metadata (8 bytes) to leveldb took 55.682289ms
I1203 08:54:30.245772 30334 replica.cpp:343] Persisted promised to 1
I1203 08:54:30.246996 30341 coordinator.cpp:238] Coordinator attempting to fill missing positions
I1203 08:54:30.248790 30335 replica.cpp:389] Replica received explicit promise request from (11474)@172.17.0.1:60986 for position 0 with proposal 2
I1203 08:54:30.287592 30335 leveldb.cpp:341] Persisting action (8 bytes) to leveldb took 38.697321ms
I1203 08:54:30.287686 30335 replica.cpp:713] Persisted action at 0
I1203 08:54:30.289408 30328 replica.cpp:538] Replica received write request for position 0 from (11475)@172.17.0.1:60986
I1203 08:54:30.289521 30328 leveldb.cpp:436] Reading position from leveldb took 49397ns
I1203 08:54:30.329463 30328 leveldb.cpp:341] Persisting action (14 bytes) to leveldb took 39.867028ms
I1203 08:54:30.329543 30328 replica.cpp:713] Persisted action at 0
I1203 08:54:30.330526 30327 replica.cpp:692] Replica received learned notice for position 0 from @0.0.0.0:0
I1203 08:54:30.371709 30327 leveldb.cpp:341] Persisting action (16 bytes) to leveldb took 41.123508ms
I1203 08:54:30.371798 30327 replica.cpp:713] Persisted action at 0
I1203 08:54:30.371834 30327 replica.cpp:698] Replica learned NOP action at position 0
I1203 08:54:30.372997 30327 log.cpp:675] Writer started with ending position 0
I1203 08:54:30.374464 30337 leveldb.cpp:436] Reading position from leveldb took 59363ns
I1203 08:54:30.375599 30334 registrar.cpp:340] Successfully fetched the registry (0B) in 309504us
I1203 08:54:30.375751 30334 registrar.cpp:439] Applied 1 operations in 44105ns; attempting to update the 'registry'
I1203 08:54:30.376549 30334 log.cpp:683] Attempting to append 170 bytes to the log
I1203 08:54:30.376802 30334 coordinator.cpp:348] Coordinator attempting to write APPEND action at position 1
I1203 08:54:30.377929 30334 replica.cpp:538] Replica received write request for position 1 from (11476)@172.17.0.1:60986
I1203 08:54:30.430621 30334 leveldb.cpp:341] Persisting action (189 bytes) to leveldb took 52.627746ms
I1203 08:54:30.430706 30334 replica.cpp:713] Persisted action at 1
I1203 08:54:30.432207 30331 replica.cpp:692] Replica received learned notice for position 1 from @0.0.0.0:0
I1203 08:54:30.475225 30331 leveldb.cpp:341] Persisting action (191 bytes) to leveldb took 42.963667ms
I1203 08:54:30.475304 30331 replica.cpp:713] Persisted action at 1
I1203 08:54:30.475337 30331 replica.cpp:698] Replica learned APPEND action at position 1
I1203 08:54:30.476830 30337 registrar.cpp:484] Successfully updated the 'registry' in 100.987904ms
I1203 08:54:30.477033 30327 log.cpp:702] Attempting to truncate the log to 1
I1203 08:54:30.477107 30337 registrar.cpp:370] Successfully recovered registrar
I1203 08:54:30.477257 30327 coordinator.cpp:348] Coordinator attempting to write TRUNCATE action at position 2
I1203 08:54:30.477674 30342 master.cpp:1447] Recovered 0 slaves from the Registry (131B) ; allowing 10mins for slaves to re-register
I1203 08:54:30.477769 30342 hierarchical.cpp:174] Allocator recovery is not supported yet
I1203 08:54:30.478492 30327 replica.cpp:538] Replica received write request for position 2 from (11477)@172.17.0.1:60986
I1203 08:54:30.531056 30327 leveldb.cpp:341] Persisting action (16 bytes) to leveldb took 52.499489ms
I1203 08:54:30.531153 30327 replica.cpp:713] Persisted action at 2
I1203 08:54:30.532519 30328 replica.cpp:692] Replica received learned notice for position 2 from @0.0.0.0:0
I1203 08:54:30.598633 30328 leveldb.cpp:341] Persisting action (18 bytes) to leveldb took 66.011447ms
I1203 08:54:30.598814 30328 leveldb.cpp:399] Deleting ~1 keys from leveldb took 86591ns
I1203 08:54:30.598846 30328 replica.cpp:713] Persisted action at 2
I1203 08:54:30.598893 30328 replica.cpp:698] Replica learned TRUNCATE action at position 2
I1203 08:54:30.609959 30308 scheduler.cpp:154] Version: 0.27.0
I1203 08:54:30.611054 30332 scheduler.cpp:236] New master detected at master@172.17.0.1:60986
I1203 08:54:30.612468 30338 scheduler.cpp:298] Sending SUBSCRIBE call to master@172.17.0.1:60986
I1203 08:54:30.615371 30338 process.cpp:3067] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I1203 08:54:30.615458 30338 http.cpp:336] HTTP POST for /master/api/v1/scheduler from 172.17.0.1:59444
I1203 08:54:30.615937 30338 master.cpp:1899] Received subscription request for HTTP framework 'default'
I1203 08:54:30.616016 30338 master.cpp:1676] Authorizing framework principal 'test-principal' to receive offers for role '*'
I1203 08:54:30.616780 30338 master.cpp:1991] Subscribing framework 'default' with checkpointing disabled and capabilities [  ]
I1203 08:54:30.617502 30338 hierarchical.cpp:220] Added framework 4ef8b0d7-038b-4610-b557-5e895e63f523-0000
I1203 08:54:30.617559 30338 hierarchical.cpp:1062] No resources available to allocate!
I1203 08:54:30.617593 30338 hierarchical.cpp:1155] No inverse offers to send out!
I1203 08:54:30.617616 30338 hierarchical.cpp:957] Performed allocation for 0 slaves in 91553ns
I1203 08:54:30.618407 30329 master.hpp:1583] Sending heartbeat to 4ef8b0d7-038b-4610-b557-5e895e63f523-0000
I1203 08:54:30.620329 30327 scheduler.cpp:457] Enqueuing event SUBSCRIBED received from master@172.17.0.1:60986
I1203 08:54:30.621048 30327 scheduler.cpp:457] Enqueuing event HEARTBEAT received from master@172.17.0.1:60986
I1203 08:54:30.622124 30332 master_maintenance_tests.cpp:172] Ignoring HEARTBEAT event
I1203 08:54:30.627588 30327 scheduler.cpp:298] Sending REQUEST call to master@172.17.0.1:60986
I1203 08:54:30.630514 30337 process.cpp:3067] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I1203 08:54:30.630586 30337 http.cpp:336] HTTP POST for /master/api/v1/scheduler from 172.17.0.1:59445
I1203 08:54:30.630872 30337 master.cpp:2646] Processing REQUEST call for framework 4ef8b0d7-038b-4610-b557-5e895e63f523-0000 (default)
I1203 08:54:30.631103 30337 hierarchical.cpp:492] Received resource request from framework 4ef8b0d7-038b-4610-b557-5e895e63f523-0000
I1203 08:54:30.632486 30337 master.cpp:938] Master terminating
I1203 08:54:30.633016 30340 hierarchical.cpp:260] Removed framework 4ef8b0d7-038b-4610-b557-5e895e63f523-0000
E1203 08:54:30.633373 30336 scheduler.cpp:431] End-Of-File received from master. The master closed the event stream
[       OK ] ContentType/SchedulerTest.Request/1 (739 ms)
[----------] 22 tests from ContentType/SchedulerTest (20171 ms total)

[----------] Global test environment tear-down
2015-12-03 08:54:32,146:30308(0x2b80c317b700):ZOO_ERROR@handle_socket_error_msg@1697: Socket [127.0.0.1:44556] zk retcode=-4, errno=111(Connection refused): server refused to accept the client
[==========] 871 tests from 115 test cases ran. (859440 ms total)
[  PASSED  ] 870 tests.
[  FAILED  ] 1 test, listed below:
[  FAILED  ] ReservationTest.ACLMultipleOperations

 1 FAILED TEST
  YOU HAVE 7 DISABLED TESTS

make[4]: Leaving directory `/mesos/mesos-0.27.0/_build/src'
make[4]: *** [check-local] Error 1
make[3]: *** [check-am] Error 2
make[3]: Leaving directory `/mesos/mesos-0.27.0/_build/src'
make[2]: Leaving directory `/mesos/mesos-0.27.0/_build/src'
make[2]: *** [check] Error 2
make[1]: *** [check-recursive] Error 1
make[1]: Leaving directory `/mesos/mesos-0.27.0/_build'
make: *** [distcheck] Error 1
+ docker rmi mesos-1449130061-26328
Untagged: mesos-1449130061-26328:latest
Deleted: 294967e61270d4e06fb0610b5f673642d3c49abfdc24376c62ffe9e6d490b02b
Deleted: aec56470fe4de4486e9252db845df7d0678fe538ff8b0a4f23cf045372200ebb
Deleted: e2944772dffc229176c88525e56a40d0f503c5e4ff1d0410a516a3fc3a923dbf
Deleted: b81a03095821ccef96a59d26fb60ca0f77fda0115690f6baec95e909798fdbe5
Deleted: 5d98a514b8b6683e97e8ba5748edb4d2de005f0492e0fe86463bc20934615510
Deleted: a3342cea2328f5664738dc0a2dab11bd42a3f91b5dcd5e35ff0107ec5d34af59
Deleted: 25062f9eeb17c18d195a1f7d7b2de6d1b4e2775b9184249cad38a7a0b5593887
Deleted: 27c7d1e1b1b968d18468a75fdda75a8c5cfd11b9a2b925b2facb991fcb3ce7d7
Deleted: fdd8b5a7240e6b622a1e40c1d0b339572060d9ee6b2b0341e82f16c3d9aaa96d
Deleted: 1b0d0dbf5bdfb814c52923cf805b296b6857b20e9af782bc9b7c1ae5615a489f
Deleted: f5c57316dd4ff823580bf57d884d1049dfb49b09d1cc309920209f83cd552662
Deleted: d0f2177314befc729562dfa1fa0f13251dd83898cf16e6ddd84185620113addc
Deleted: 6772083ea9c3f96156266f23e27b29f2b6e16fc0599def7f303776429a91cdaa

Error handling URL https://reviews.apache.org/api/review-requests/40435/reviews/: INTERNAL SERVER ERROR
git clean -fd
git reset --hard 0a82c2b12123ea6099bc169b1eb567b0f5ab473f

Build step 'Execute shell' marked build as failure