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/20 01:38:57 UTC

Build failed in Jenkins: mesos-reviewbot #9789

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

------------------------------------------
[...truncated 148601 lines...]
I1120 00:38:18.877921 30229 master.cpp:1625] Elected as the leading master!
I1120 00:38:18.877944 30229 master.cpp:1385] Recovering from registrar
I1120 00:38:18.878121 30223 registrar.cpp:309] Recovering registrar
I1120 00:38:18.878772 30227 log.cpp:661] Attempting to start the writer
I1120 00:38:18.880089 30227 replica.cpp:496] Replica received implicit promise request from (10549)@172.17.19.102:35541 with proposal 1
I1120 00:38:18.880591 30227 leveldb.cpp:306] Persisting metadata (8 bytes) to leveldb took 461552ns
I1120 00:38:18.880620 30227 replica.cpp:345] Persisted promised to 1
I1120 00:38:18.881273 30219 coordinator.cpp:240] Coordinator attempting to fill missing positions
I1120 00:38:18.882799 30219 replica.cpp:391] Replica received explicit promise request from (10550)@172.17.19.102:35541 for position 0 with proposal 2
I1120 00:38:18.883298 30219 leveldb.cpp:343] Persisting action (8 bytes) to leveldb took 424118ns
I1120 00:38:18.883329 30219 replica.cpp:715] Persisted action at 0
I1120 00:38:18.884528 30223 replica.cpp:540] Replica received write request for position 0 from (10551)@172.17.19.102:35541
I1120 00:38:18.884596 30223 leveldb.cpp:438] Reading position from leveldb took 30917ns
I1120 00:38:18.885000 30223 leveldb.cpp:343] Persisting action (14 bytes) to leveldb took 348239ns
I1120 00:38:18.885037 30223 replica.cpp:715] Persisted action at 0
I1120 00:38:18.885745 30226 replica.cpp:694] Replica received learned notice for position 0 from @0.0.0.0:0
I1120 00:38:18.886466 30226 leveldb.cpp:343] Persisting action (16 bytes) to leveldb took 679795ns
I1120 00:38:18.886497 30226 replica.cpp:715] Persisted action at 0
I1120 00:38:18.886518 30226 replica.cpp:700] Replica learned NOP action at position 0
I1120 00:38:18.887295 30229 log.cpp:677] Writer started with ending position 0
I1120 00:38:18.888499 30218 leveldb.cpp:438] Reading position from leveldb took 34622ns
I1120 00:38:18.889503 30214 registrar.cpp:342] Successfully fetched the registry (0B) in 11.329024ms
I1120 00:38:18.889652 30214 registrar.cpp:441] Applied 1 operations in 52966ns; attempting to update the 'registry'
I1120 00:38:18.890542 30222 log.cpp:685] Attempting to append 178 bytes to the log
I1120 00:38:18.890687 30228 coordinator.cpp:350] Coordinator attempting to write APPEND action at position 1
I1120 00:38:18.891513 30217 replica.cpp:540] Replica received write request for position 1 from (10552)@172.17.19.102:35541
I1120 00:38:18.892200 30217 leveldb.cpp:343] Persisting action (197 bytes) to leveldb took 635498ns
I1120 00:38:18.892231 30217 replica.cpp:715] Persisted action at 1
I1120 00:38:18.893074 30225 replica.cpp:694] Replica received learned notice for position 1 from @0.0.0.0:0
I1120 00:38:18.893604 30225 leveldb.cpp:343] Persisting action (199 bytes) to leveldb took 488564ns
I1120 00:38:18.893635 30225 replica.cpp:715] Persisted action at 1
I1120 00:38:18.893656 30225 replica.cpp:700] Replica learned APPEND action at position 1
I1120 00:38:18.894713 30223 registrar.cpp:486] Successfully updated the 'registry' in 4.987904ms
I1120 00:38:18.894917 30223 registrar.cpp:372] Successfully recovered registrar
I1120 00:38:18.895000 30222 log.cpp:704] Attempting to truncate the log to 1
I1120 00:38:18.895135 30220 coordinator.cpp:350] Coordinator attempting to write TRUNCATE action at position 2
I1120 00:38:18.895342 30229 master.cpp:1422] Recovered 0 slaves from the Registry (139B) ; allowing 10mins for slaves to re-register
I1120 00:38:18.896246 30229 replica.cpp:540] Replica received write request for position 2 from (10553)@172.17.19.102:35541
I1120 00:38:18.896881 30229 leveldb.cpp:343] Persisting action (16 bytes) to leveldb took 590086ns
I1120 00:38:18.896913 30229 replica.cpp:715] Persisted action at 2
I1120 00:38:18.897697 30219 replica.cpp:694] Replica received learned notice for position 2 from @0.0.0.0:0
I1120 00:38:18.898388 30219 leveldb.cpp:343] Persisting action (18 bytes) to leveldb took 592449ns
I1120 00:38:18.898452 30219 leveldb.cpp:401] Deleting ~1 keys from leveldb took 33274ns
I1120 00:38:18.898476 30219 replica.cpp:715] Persisted action at 2
I1120 00:38:18.898499 30219 replica.cpp:700] Replica learned TRUNCATE action at position 2
I1120 00:38:18.906072 30195 scheduler.cpp:156] Version: 0.26.0
I1120 00:38:18.906854 30224 scheduler.cpp:238] New master detected at master@172.17.19.102:35541
I1120 00:38:18.907999 30228 scheduler.cpp:300] Sending SUBSCRIBE call to master@172.17.19.102:35541
I1120 00:38:18.909952 30226 process.cpp:3081] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I1120 00:38:18.910019 30226 http.cpp:338] HTTP POST for /master/api/v1/scheduler from 172.17.19.102:38956
I1120 00:38:18.910214 30226 master.cpp:1874] Received subscription request for HTTP framework 'default'
I1120 00:38:18.910282 30226 master.cpp:1651] Authorizing framework principal 'test-principal' to receive offers for role '*'
I1120 00:38:18.910575 30226 master.cpp:1966] Subscribing framework 'default' with checkpointing disabled and capabilities [  ]
I1120 00:38:18.910955 30229 hierarchical.cpp:197] Added framework 3b7a25f6-8d60-4a56-b7bd-c294efba3439-0000
I1120 00:38:18.911010 30229 hierarchical.cpp:979] No resources available to allocate!
I1120 00:38:18.911020 30220 master.hpp:1522] Sending heartbeat to 3b7a25f6-8d60-4a56-b7bd-c294efba3439-0000
I1120 00:38:18.911049 30229 hierarchical.cpp:1072] No inverse offers to send out!
I1120 00:38:18.911095 30229 hierarchical.cpp:878] Performed allocation for 0 slaves in 110758ns
I1120 00:38:18.911705 30215 scheduler.cpp:459] Enqueuing event SUBSCRIBED received from master@172.17.19.102:35541
I1120 00:38:18.912185 30215 scheduler.cpp:459] Enqueuing event HEARTBEAT received from master@172.17.19.102:35541
I1120 00:38:18.912868 30221 master_maintenance_tests.cpp:174] Ignoring HEARTBEAT event
I1120 00:38:18.912992 30215 scheduler.cpp:300] Sending REQUEST call to master@172.17.19.102:35541
I1120 00:38:18.914360 30217 process.cpp:3081] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I1120 00:38:18.914412 30217 http.cpp:338] HTTP POST for /master/api/v1/scheduler from 172.17.19.102:38957
I1120 00:38:18.914505 30217 master.cpp:2621] Processing REQUEST call for framework 3b7a25f6-8d60-4a56-b7bd-c294efba3439-0000 (default)
I1120 00:38:18.914715 30224 hierarchical.cpp:460] Received resource request from framework 3b7a25f6-8d60-4a56-b7bd-c294efba3439-0000
I1120 00:38:18.915079 30226 master.cpp:928] Master terminating
I1120 00:38:18.915268 30224 hierarchical.cpp:232] Removed framework 3b7a25f6-8d60-4a56-b7bd-c294efba3439-0000
E1120 00:38:18.916146 30227 scheduler.cpp:433] End-Of-File received from master. The master closed the event stream
[       OK ] ContentType/SchedulerTest.Request/0 (57 ms)
[ RUN      ] ContentType/SchedulerTest.Request/1
I1120 00:38:18.925017 30195 leveldb.cpp:176] Opened db in 3.607314ms
I1120 00:38:18.926231 30195 leveldb.cpp:183] Compacted db in 1.175608ms
I1120 00:38:18.926295 30195 leveldb.cpp:198] Created db iterator in 17675ns
I1120 00:38:18.926314 30195 leveldb.cpp:204] Seeked to beginning of db in 1928ns
I1120 00:38:18.926326 30195 leveldb.cpp:273] Iterated through 0 keys in the db in 250ns
I1120 00:38:18.926362 30195 replica.cpp:780] Replica recovered with log positions 0 -> 0 with 1 holes and 0 unlearned
I1120 00:38:18.926914 30226 recover.cpp:449] Starting replica recovery
I1120 00:38:18.927141 30226 recover.cpp:475] Replica is in EMPTY status
I1120 00:38:18.928244 30221 replica.cpp:676] Replica in EMPTY status received a broadcasted recover request from (10558)@172.17.19.102:35541
I1120 00:38:18.928710 30218 recover.cpp:195] Received a recover response from a replica in EMPTY status
I1120 00:38:18.929298 30216 recover.cpp:566] Updating replica status to STARTING
I1120 00:38:18.929961 30226 leveldb.cpp:306] Persisting metadata (8 bytes) to leveldb took 516188ns
I1120 00:38:18.929994 30226 replica.cpp:323] Persisted replica status to STARTING
I1120 00:38:18.930188 30222 recover.cpp:475] Replica is in STARTING status
I1120 00:38:18.931399 30221 replica.cpp:676] Replica in STARTING status received a broadcasted recover request from (10559)@172.17.19.102:35541
I1120 00:38:18.931793 30229 recover.cpp:195] Received a recover response from a replica in STARTING status
I1120 00:38:18.932461 30214 recover.cpp:566] Updating replica status to VOTING
I1120 00:38:18.932724 30219 master.cpp:367] Master 1075df6b-c9c0-4f8f-9e3b-a8bde5f03888 (623854557ac5) started on 172.17.19.102:35541
I1120 00:38:18.932762 30219 master.cpp:369] Flags at startup: --acls="" --allocation_interval="1secs" --allocator="HierarchicalDRF" --authenticate="false" --authenticate_slaves="true" --authenticators="crammd5" --authorizers="local" --credentials="/tmp/OGevYn/credentials" --framework_sorter="drf" --help="false" --hostname_lookup="true" --initialize_driver_logging="true" --log_auto_initialize="true" --logbufsecs="0" --logging_level="INFO" --max_slave_ping_timeouts="5" --quiet="false" --recovery_slave_removal_limit="100%" --registry="replicated_log" --registry_fetch_timeout="1mins" --registry_store_timeout="25secs" --registry_strict="true" --root_submissions="true" --slave_ping_timeout="15secs" --slave_reregister_timeout="10mins" --user_sorter="drf" --version="false" --webui_dir="/mesos/mesos-0.26.0/_inst/share/mesos/webui" --work_dir="/tmp/OGevYn/master" --zk_session_timeout="10secs"
I1120 00:38:18.933187 30219 master.cpp:416] Master allowing unauthenticated frameworks to register
I1120 00:38:18.933202 30219 master.cpp:419] Master only allowing authenticated slaves to register
I1120 00:38:18.933215 30219 credentials.hpp:37] Loading credentials for authentication from '/tmp/OGevYn/credentials'
I1120 00:38:18.933483 30219 master.cpp:458] Using default 'crammd5' authenticator
I1120 00:38:18.933517 30225 leveldb.cpp:306] Persisting metadata (8 bytes) to leveldb took 695199ns
I1120 00:38:18.933547 30225 replica.cpp:323] Persisted replica status to VOTING
I1120 00:38:18.933620 30219 master.cpp:495] Authorization enabled
I1120 00:38:18.933683 30222 recover.cpp:580] Successfully joined the Paxos group
I1120 00:38:18.933920 30227 whitelist_watcher.cpp:79] No whitelist given
I1120 00:38:18.933928 30224 hierarchical.cpp:153] Initialized hierarchical allocator process
I1120 00:38:18.934006 30222 recover.cpp:464] Recover process terminated
I1120 00:38:18.935703 30225 master.cpp:1612] The newly elected leader is master@172.17.19.102:35541 with id 1075df6b-c9c0-4f8f-9e3b-a8bde5f03888
I1120 00:38:18.935745 30225 master.cpp:1625] Elected as the leading master!
I1120 00:38:18.935770 30225 master.cpp:1385] Recovering from registrar
I1120 00:38:18.935964 30223 registrar.cpp:309] Recovering registrar
I1120 00:38:18.936638 30217 log.cpp:661] Attempting to start the writer
I1120 00:38:18.937948 30215 replica.cpp:496] Replica received implicit promise request from (10560)@172.17.19.102:35541 with proposal 1
I1120 00:38:18.938598 30215 leveldb.cpp:306] Persisting metadata (8 bytes) to leveldb took 608576ns
I1120 00:38:18.938627 30215 replica.cpp:345] Persisted promised to 1
I1120 00:38:18.939390 30218 coordinator.cpp:240] Coordinator attempting to fill missing positions
I1120 00:38:18.940801 30221 replica.cpp:391] Replica received explicit promise request from (10561)@172.17.19.102:35541 for position 0 with proposal 2
I1120 00:38:18.941445 30221 leveldb.cpp:343] Persisting action (8 bytes) to leveldb took 575224ns
I1120 00:38:18.941474 30221 replica.cpp:715] Persisted action at 0
I1120 00:38:18.942659 30228 replica.cpp:540] Replica received write request for position 0 from (10562)@172.17.19.102:35541
I1120 00:38:18.942725 30228 leveldb.cpp:438] Reading position from leveldb took 28362ns
I1120 00:38:18.943338 30228 leveldb.cpp:343] Persisting action (14 bytes) to leveldb took 565049ns
I1120 00:38:18.943369 30228 replica.cpp:715] Persisted action at 0
I1120 00:38:18.944064 30217 replica.cpp:694] Replica received learned notice for position 0 from @0.0.0.0:0
I1120 00:38:18.944736 30217 leveldb.cpp:343] Persisting action (16 bytes) to leveldb took 632388ns
I1120 00:38:18.944766 30217 replica.cpp:715] Persisted action at 0
I1120 00:38:18.944787 30217 replica.cpp:700] Replica learned NOP action at position 0
I1120 00:38:18.945438 30218 log.cpp:677] Writer started with ending position 0
I1120 00:38:18.946627 30227 leveldb.cpp:438] Reading position from leveldb took 34262ns
I1120 00:38:18.947592 30214 registrar.cpp:342] Successfully fetched the registry (0B) in 11.5712ms
I1120 00:38:18.947722 30214 registrar.cpp:441] Applied 1 operations in 26807ns; attempting to update the 'registry'
I1120 00:38:18.948516 30222 log.cpp:685] Attempting to append 178 bytes to the log
I1120 00:38:18.948684 30219 coordinator.cpp:350] Coordinator attempting to write APPEND action at position 1
I1120 00:38:18.949427 30228 replica.cpp:540] Replica received write request for position 1 from (10563)@172.17.19.102:35541
I1120 00:38:18.950098 30228 leveldb.cpp:343] Persisting action (197 bytes) to leveldb took 625935ns
I1120 00:38:18.950129 30228 replica.cpp:715] Persisted action at 1
I1120 00:38:18.950894 30216 replica.cpp:694] Replica received learned notice for position 1 from @0.0.0.0:0
I1120 00:38:18.951606 30216 leveldb.cpp:343] Persisting action (199 bytes) to leveldb took 671610ns
I1120 00:38:18.951637 30216 replica.cpp:715] Persisted action at 1
I1120 00:38:18.951658 30216 replica.cpp:700] Replica learned APPEND action at position 1
I1120 00:38:18.952734 30226 registrar.cpp:486] Successfully updated the 'registry' in 4.938752ms
I1120 00:38:18.952998 30226 registrar.cpp:372] Successfully recovered registrar
I1120 00:38:18.953037 30219 log.cpp:704] Attempting to truncate the log to 1
I1120 00:38:18.953186 30228 coordinator.cpp:350] Coordinator attempting to write TRUNCATE action at position 2
I1120 00:38:18.953492 30224 master.cpp:1422] Recovered 0 slaves from the Registry (139B) ; allowing 10mins for slaves to re-register
I1120 00:38:18.954174 30220 replica.cpp:540] Replica received write request for position 2 from (10564)@172.17.19.102:35541
I1120 00:38:18.954900 30220 leveldb.cpp:343] Persisting action (16 bytes) to leveldb took 676689ns
I1120 00:38:18.954931 30220 replica.cpp:715] Persisted action at 2
I1120 00:38:18.955603 30228 replica.cpp:694] Replica received learned notice for position 2 from @0.0.0.0:0
I1120 00:38:18.956295 30228 leveldb.cpp:343] Persisting action (18 bytes) to leveldb took 651335ns
I1120 00:38:18.956363 30228 leveldb.cpp:401] Deleting ~1 keys from leveldb took 37854ns
I1120 00:38:18.956390 30228 replica.cpp:715] Persisted action at 2
I1120 00:38:18.956413 30228 replica.cpp:700] Replica learned TRUNCATE action at position 2
I1120 00:38:18.964205 30195 scheduler.cpp:156] Version: 0.26.0
I1120 00:38:18.964908 30219 scheduler.cpp:238] New master detected at master@172.17.19.102:35541
I1120 00:38:18.966002 30221 scheduler.cpp:300] Sending SUBSCRIBE call to master@172.17.19.102:35541
I1120 00:38:18.968214 30215 process.cpp:3081] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I1120 00:38:18.968287 30215 http.cpp:338] HTTP POST for /master/api/v1/scheduler from 172.17.19.102:38958
I1120 00:38:18.968646 30215 master.cpp:1874] Received subscription request for HTTP framework 'default'
I1120 00:38:18.968714 30215 master.cpp:1651] Authorizing framework principal 'test-principal' to receive offers for role '*'
I1120 00:38:18.969059 30215 master.cpp:1966] Subscribing framework 'default' with checkpointing disabled and capabilities [  ]
I1120 00:38:18.969427 30229 hierarchical.cpp:197] Added framework 1075df6b-c9c0-4f8f-9e3b-a8bde5f03888-0000
I1120 00:38:18.969481 30229 hierarchical.cpp:979] No resources available to allocate!
I1120 00:38:18.969545 30229 hierarchical.cpp:1072] No inverse offers to send out!
I1120 00:38:18.969580 30229 hierarchical.cpp:878] Performed allocation for 0 slaves in 122137ns
I1120 00:38:18.969591 30215 master.hpp:1522] Sending heartbeat to 1075df6b-c9c0-4f8f-9e3b-a8bde5f03888-0000
I1120 00:38:18.970536 30216 scheduler.cpp:459] Enqueuing event SUBSCRIBED received from master@172.17.19.102:35541
I1120 00:38:18.971146 30216 scheduler.cpp:459] Enqueuing event HEARTBEAT received from master@172.17.19.102:35541
I1120 00:38:18.971853 30217 master_maintenance_tests.cpp:174] Ignoring HEARTBEAT event
I1120 00:38:18.971918 30216 scheduler.cpp:300] Sending REQUEST call to master@172.17.19.102:35541
I1120 00:38:18.974020 30222 process.cpp:3081] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I1120 00:38:18.974086 30222 http.cpp:338] HTTP POST for /master/api/v1/scheduler from 172.17.19.102:38959
I1120 00:38:18.974344 30222 master.cpp:2621] Processing REQUEST call for framework 1075df6b-c9c0-4f8f-9e3b-a8bde5f03888-0000 (default)
I1120 00:38:18.974686 30219 hierarchical.cpp:460] Received resource request from framework 1075df6b-c9c0-4f8f-9e3b-a8bde5f03888-0000
I1120 00:38:18.975059 30219 master.cpp:928] Master terminating
I1120 00:38:18.975285 30215 hierarchical.cpp:232] Removed framework 1075df6b-c9c0-4f8f-9e3b-a8bde5f03888-0000
E1120 00:38:18.976321 30223 scheduler.cpp:433] End-Of-File received from master. The master closed the event stream
[       OK ] ContentType/SchedulerTest.Request/1 (61 ms)
[----------] 22 tests from ContentType/SchedulerTest (4161 ms total)

[----------] Global test environment tear-down
[==========] 834 tests from 114 test cases ran. (314328 ms total)
[  PASSED  ] 832 tests.
[  FAILED  ] 2 tests, listed below:
[  FAILED  ] CurlFetcherPluginTest.ValidUri
[  FAILED  ] CurlFetcherPluginTest.InvalidUri

 2 FAILED TESTS
  YOU HAVE 7 DISABLED TESTS

make[4]: *** [check-local] Error 1
make[4]: Leaving directory `/mesos/mesos-0.26.0/_build/src'
make[3]: *** [check-am] Error 2
make[3]: Leaving directory `/mesos/mesos-0.26.0/_build/src'
make[2]: *** [check] Error 2
make[2]: Leaving directory `/mesos/mesos-0.26.0/_build/src'
make[1]: *** [check-recursive] Error 1
make[1]: Leaving directory `/mesos/mesos-0.26.0/_build'
make: *** [distcheck] Error 1
+ docker rmi mesos-1447978328-7964
Untagged: mesos-1447978328-7964:latest
Deleted: 653e2129a2fb149267a83b1c9dc1be41bbdac4e17f1d6a3e5e8093d764084ef1
Deleted: e96aecd861fd02d1c2f4670ef2a72bf57eb10024bc5c4ab6a09cc115357cf8cc
Deleted: c0ea91ec0df84fcae2d3f66805b20c0ade6ff7ecf951590266ad3aa8f0e899be
Deleted: e7ad4f6d15594f681fb0669b49165fae7db03218443795e5ccdc8d414bb95821
Deleted: 07983a162b4cef2c78ac9df386b749bba0c9063ed132b2bf8ec9f31a6123012b
Deleted: 229f64e640405f8de102822feea036786c11b4c4b576d4bfda1436d2aa3dedbb
Deleted: cd70abaad96a9f8d99b9b82911ec7c19ed42888e2b01af50011752483c12cd9d
Deleted: 56308f8770898161c831e1432b1975f050d45013276f7e2a55ac28eefde7aa91
Deleted: 2063ba954871e565df23ae02732b76477d294c2a388db400d35b0f7c79e093fa
Deleted: 9a6d0318beef9849c3d516aeeabee1af18ac7c9a1f758d748f60eb57d78a5b1f
Deleted: 0a33bad101792bc909e304b7badfab64203782bf3cabc38a6a92760763fddbc9
Deleted: 100330819abecb53ab41daf4e8176b366f5b5b2d2e738409b738446feb56a5ed
Deleted: 0111cd60c00ac3546203f76a6ea378f33b3c40a55b837c1b17070beb3a6f6628

Traceback (most recent call last):
  File "./support/verify_reviews.py", line 210, in <module>
    verify_review(review_request)
  File "./support/verify_reviews.py", line 139, in verify_review
    "Error:\n %s" % (applied, e.cmd, e.output))
  File "./support/verify_reviews.py", line 99, in post_review
    api(review_url, data)
  File "./support/verify_reviews.py", line 65, in api
    return json.loads(urllib2.urlopen(url, data=data).read())
  File "/usr/lib/python2.7/urllib2.py", line 127, in urlopen
    return _opener.open(url, data, timeout)
  File "/usr/lib/python2.7/urllib2.py", line 410, in open
    response = meth(req, response)
  File "/usr/lib/python2.7/urllib2.py", line 523, in http_response
    'http', request, response, code, msg, hdrs)
  File "/usr/lib/python2.7/urllib2.py", line 442, in error
    result = self._call_chain(*args)
  File "/usr/lib/python2.7/urllib2.py", line 382, in _call_chain
    result = func(*args)
  File "/usr/lib/python2.7/urllib2.py", line 897, in http_error_401
    url, req, headers)
  File "/usr/lib/python2.7/urllib2.py", line 872, in http_error_auth_reqed
    response = self.retry_http_basic_auth(host, req, realm)
  File "/usr/lib/python2.7/urllib2.py", line 885, in retry_http_basic_auth
    return self.parent.open(req, timeout=req.timeout)
  File "/usr/lib/python2.7/urllib2.py", line 410, in open
    response = meth(req, response)
  File "/usr/lib/python2.7/urllib2.py", line 523, in http_response
    'http', request, response, code, msg, hdrs)
  File "/usr/lib/python2.7/urllib2.py", line 448, in error
    return self._call_chain(*args)
  File "/usr/lib/python2.7/urllib2.py", line 382, in _call_chain
    result = func(*args)
  File "/usr/lib/python2.7/urllib2.py", line 531, in http_error_default
    raise HTTPError(req.get_full_url(), code, msg, hdrs, fp)
urllib2.HTTPError: HTTP Error 500: INTERNAL SERVER ERROR
git clean -fd
git reset --hard bb5c44a7a6fead84789c933a9aa3e1a8cf35722d

Build step 'Execute shell' marked build as failure

Jenkins build is back to normal : mesos-reviewbot #9796

Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/mesos-reviewbot/9796/>


Build failed in Jenkins: mesos-reviewbot #9795

Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/mesos-reviewbot/9795/>

------------------------------------------
[...truncated 148781 lines...]
I1120 06:43:11.333760 30228 replica.cpp:323] Persisted replica status to VOTING
I1120 06:43:11.334086 30228 recover.cpp:580] Successfully joined the Paxos group
I1120 06:43:11.334364 30228 recover.cpp:464] Recover process terminated
I1120 06:43:11.334971 30228 log.cpp:661] Attempting to start the writer
I1120 06:43:11.336661 30228 replica.cpp:496] Replica received implicit promise request from (10534)@172.17.8.139:46176 with proposal 1
I1120 06:43:11.337067 30228 leveldb.cpp:306] Persisting metadata (8 bytes) to leveldb took 310015ns
I1120 06:43:11.337096 30228 replica.cpp:345] Persisted promised to 1
I1120 06:43:11.338486 30215 coordinator.cpp:240] Coordinator attempting to fill missing positions
I1120 06:43:11.340025 30224 replica.cpp:391] Replica received explicit promise request from (10535)@172.17.8.139:46176 for position 0 with proposal 2
I1120 06:43:11.340423 30224 leveldb.cpp:343] Persisting action (8 bytes) to leveldb took 352856ns
I1120 06:43:11.340452 30224 replica.cpp:715] Persisted action at 0
I1120 06:43:11.341701 30225 replica.cpp:540] Replica received write request for position 0 from (10536)@172.17.8.139:46176
I1120 06:43:11.341764 30225 leveldb.cpp:438] Reading position from leveldb took 29140ns
I1120 06:43:11.342109 30225 leveldb.cpp:343] Persisting action (14 bytes) to leveldb took 301781ns
I1120 06:43:11.342134 30225 replica.cpp:715] Persisted action at 0
I1120 06:43:11.342831 30219 replica.cpp:694] Replica received learned notice for position 0 from @0.0.0.0:0
I1120 06:43:11.343214 30219 leveldb.cpp:343] Persisting action (16 bytes) to leveldb took 351634ns
I1120 06:43:11.343242 30219 replica.cpp:715] Persisted action at 0
I1120 06:43:11.343261 30219 replica.cpp:700] Replica learned NOP action at position 0
I1120 06:43:11.343977 30228 log.cpp:677] Writer started with ending position 0
I1120 06:43:11.345258 30227 leveldb.cpp:438] Reading position from leveldb took 26186ns
I1120 06:43:11.346501 30218 registrar.cpp:342] Successfully fetched the registry (0B) in 23.4752ms
I1120 06:43:11.346635 30218 registrar.cpp:441] Applied 1 operations in 34802ns; attempting to update the 'registry'
I1120 06:43:11.347864 30218 log.cpp:685] Attempting to append 176 bytes to the log
I1120 06:43:11.348114 30226 coordinator.cpp:350] Coordinator attempting to write APPEND action at position 1
I1120 06:43:11.349056 30218 replica.cpp:540] Replica received write request for position 1 from (10537)@172.17.8.139:46176
I1120 06:43:11.349576 30218 leveldb.cpp:343] Persisting action (195 bytes) to leveldb took 478079ns
I1120 06:43:11.349603 30218 replica.cpp:715] Persisted action at 1
I1120 06:43:11.350433 30221 replica.cpp:694] Replica received learned notice for position 1 from @0.0.0.0:0
I1120 06:43:11.350729 30221 leveldb.cpp:343] Persisting action (197 bytes) to leveldb took 263050ns
I1120 06:43:11.350754 30221 replica.cpp:715] Persisted action at 1
I1120 06:43:11.350775 30221 replica.cpp:700] Replica learned APPEND action at position 1
I1120 06:43:11.352205 30221 registrar.cpp:486] Successfully updated the 'registry' in 5.499136ms
I1120 06:43:11.352344 30221 registrar.cpp:372] Successfully recovered registrar
I1120 06:43:11.352613 30221 log.cpp:704] Attempting to truncate the log to 1
I1120 06:43:11.353025 30222 coordinator.cpp:350] Coordinator attempting to write TRUNCATE action at position 2
I1120 06:43:11.352915 30221 master.cpp:1422] Recovered 0 slaves from the Registry (137B) ; allowing 10mins for slaves to re-register
I1120 06:43:11.354141 30222 replica.cpp:540] Replica received write request for position 2 from (10538)@172.17.8.139:46176
I1120 06:43:11.354545 30222 leveldb.cpp:343] Persisting action (16 bytes) to leveldb took 364560ns
I1120 06:43:11.354571 30222 replica.cpp:715] Persisted action at 2
I1120 06:43:11.355401 30226 replica.cpp:694] Replica received learned notice for position 2 from @0.0.0.0:0
I1120 06:43:11.355940 30226 leveldb.cpp:343] Persisting action (18 bytes) to leveldb took 504002ns
I1120 06:43:11.356006 30226 leveldb.cpp:401] Deleting ~1 keys from leveldb took 38183ns
I1120 06:43:11.356031 30226 replica.cpp:715] Persisted action at 2
I1120 06:43:11.356055 30226 replica.cpp:700] Replica learned TRUNCATE action at position 2
I1120 06:43:11.364249 30196 scheduler.cpp:156] Version: 0.26.0
I1120 06:43:11.365170 30226 scheduler.cpp:238] New master detected at master@172.17.8.139:46176
I1120 06:43:11.366457 30222 scheduler.cpp:300] Sending SUBSCRIBE call to master@172.17.8.139:46176
I1120 06:43:11.368777 30230 process.cpp:3081] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I1120 06:43:11.368844 30230 http.cpp:338] HTTP POST for /master/api/v1/scheduler from 172.17.8.139:48254
I1120 06:43:11.369067 30230 master.cpp:1874] Received subscription request for HTTP framework 'default'
I1120 06:43:11.369144 30230 master.cpp:1651] Authorizing framework principal 'test-principal' to receive offers for role '*'
I1120 06:43:11.369820 30230 master.cpp:1966] Subscribing framework 'default' with checkpointing disabled and capabilities [  ]
I1120 06:43:11.370812 30230 hierarchical.cpp:197] Added framework 85a24cce-7f99-4b3a-b645-342132406af9-0000
I1120 06:43:11.370872 30230 hierarchical.cpp:979] No resources available to allocate!
I1120 06:43:11.370908 30230 hierarchical.cpp:1072] No inverse offers to send out!
I1120 06:43:11.370940 30230 hierarchical.cpp:878] Performed allocation for 0 slaves in 100094ns
I1120 06:43:11.371162 30230 master.hpp:1522] Sending heartbeat to 85a24cce-7f99-4b3a-b645-342132406af9-0000
I1120 06:43:11.372328 30227 scheduler.cpp:459] Enqueuing event SUBSCRIBED received from master@172.17.8.139:46176
I1120 06:43:11.373101 30227 scheduler.cpp:459] Enqueuing event HEARTBEAT received from master@172.17.8.139:46176
I1120 06:43:11.373673 30227 master_maintenance_tests.cpp:174] Ignoring HEARTBEAT event
I1120 06:43:11.374294 30228 scheduler.cpp:300] Sending REQUEST call to master@172.17.8.139:46176
I1120 06:43:11.376358 30226 process.cpp:3081] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I1120 06:43:11.376495 30226 http.cpp:338] HTTP POST for /master/api/v1/scheduler from 172.17.8.139:48255
I1120 06:43:11.376689 30226 master.cpp:2621] Processing REQUEST call for framework 85a24cce-7f99-4b3a-b645-342132406af9-0000 (default)
I1120 06:43:11.376965 30226 hierarchical.cpp:460] Received resource request from framework 85a24cce-7f99-4b3a-b645-342132406af9-0000
I1120 06:43:11.377480 30196 master.cpp:928] Master terminating
I1120 06:43:11.377681 30220 hierarchical.cpp:232] Removed framework 85a24cce-7f99-4b3a-b645-342132406af9-0000
E1120 06:43:11.379587 30223 scheduler.cpp:433] End-Of-File received from master. The master closed the event stream
[       OK ] ContentType/SchedulerTest.Request/0 (97 ms)
[ RUN      ] ContentType/SchedulerTest.Request/1
I1120 06:43:11.403877 30196 leveldb.cpp:176] Opened db in 2.141239ms
I1120 06:43:11.404903 30196 leveldb.cpp:183] Compacted db in 893380ns
I1120 06:43:11.405019 30196 leveldb.cpp:198] Created db iterator in 18556ns
I1120 06:43:11.405120 30196 leveldb.cpp:204] Seeked to beginning of db in 2206ns
I1120 06:43:11.405201 30196 leveldb.cpp:273] Iterated through 0 keys in the db in 320ns
I1120 06:43:11.405318 30196 replica.cpp:780] Replica recovered with log positions 0 -> 0 with 1 holes and 0 unlearned
I1120 06:43:11.406004 30220 recover.cpp:449] Starting replica recovery
I1120 06:43:11.406529 30220 recover.cpp:475] Replica is in EMPTY status
I1120 06:43:11.407727 30227 replica.cpp:676] Replica in EMPTY status received a broadcasted recover request from (10543)@172.17.8.139:46176
I1120 06:43:11.408087 30222 recover.cpp:195] Received a recover response from a replica in EMPTY status
I1120 06:43:11.408545 30225 recover.cpp:566] Updating replica status to STARTING
I1120 06:43:11.409135 30216 leveldb.cpp:306] Persisting metadata (8 bytes) to leveldb took 379074ns
I1120 06:43:11.409167 30216 replica.cpp:323] Persisted replica status to STARTING
I1120 06:43:11.409317 30225 recover.cpp:475] Replica is in STARTING status
I1120 06:43:11.410017 30216 replica.cpp:676] Replica in STARTING status received a broadcasted recover request from (10544)@172.17.8.139:46176
I1120 06:43:11.410297 30229 recover.cpp:195] Received a recover response from a replica in STARTING status
I1120 06:43:11.410768 30217 recover.cpp:566] Updating replica status to VOTING
I1120 06:43:11.412497 30224 master.cpp:367] Master 058c5daa-56cb-4bb7-a3e2-1eda00178c92 (ec562bd80ef1) started on 172.17.8.139:46176
I1120 06:43:11.412520 30224 master.cpp:369] Flags at startup: --acls="" --allocation_interval="1secs" --allocator="HierarchicalDRF" --authenticate="false" --authenticate_slaves="true" --authenticators="crammd5" --authorizers="local" --credentials="/tmp/e7jvKE/credentials" --framework_sorter="drf" --help="false" --hostname_lookup="true" --initialize_driver_logging="true" --log_auto_initialize="true" --logbufsecs="0" --logging_level="INFO" --max_slave_ping_timeouts="5" --quiet="false" --recovery_slave_removal_limit="100%" --registry="replicated_log" --registry_fetch_timeout="1mins" --registry_store_timeout="25secs" --registry_strict="true" --root_submissions="true" --slave_ping_timeout="15secs" --slave_reregister_timeout="10mins" --user_sorter="drf" --version="false" --webui_dir="/mesos/mesos-0.26.0/_inst/share/mesos/webui" --work_dir="/tmp/e7jvKE/master" --zk_session_timeout="10secs"
I1120 06:43:11.412838 30224 master.cpp:416] Master allowing unauthenticated frameworks to register
I1120 06:43:11.412852 30224 master.cpp:419] Master only allowing authenticated slaves to register
I1120 06:43:11.412860 30224 credentials.hpp:37] Loading credentials for authentication from '/tmp/e7jvKE/credentials'
I1120 06:43:11.413285 30229 leveldb.cpp:306] Persisting metadata (8 bytes) to leveldb took 2.424784ms
I1120 06:43:11.413318 30229 replica.cpp:323] Persisted replica status to VOTING
I1120 06:43:11.413328 30224 master.cpp:458] Using default 'crammd5' authenticator
I1120 06:43:11.413432 30229 recover.cpp:580] Successfully joined the Paxos group
I1120 06:43:11.413441 30224 master.cpp:495] Authorization enabled
I1120 06:43:11.413592 30229 recover.cpp:464] Recover process terminated
I1120 06:43:11.413772 30229 hierarchical.cpp:153] Initialized hierarchical allocator process
I1120 06:43:11.413962 30226 whitelist_watcher.cpp:79] No whitelist given
I1120 06:43:11.415609 30215 master.cpp:1612] The newly elected leader is master@172.17.8.139:46176 with id 058c5daa-56cb-4bb7-a3e2-1eda00178c92
I1120 06:43:11.415643 30215 master.cpp:1625] Elected as the leading master!
I1120 06:43:11.415665 30215 master.cpp:1385] Recovering from registrar
I1120 06:43:11.415910 30215 registrar.cpp:309] Recovering registrar
I1120 06:43:11.416623 30218 log.cpp:661] Attempting to start the writer
I1120 06:43:11.417991 30227 replica.cpp:496] Replica received implicit promise request from (10545)@172.17.8.139:46176 with proposal 1
I1120 06:43:11.418345 30227 leveldb.cpp:306] Persisting metadata (8 bytes) to leveldb took 322255ns
I1120 06:43:11.418370 30227 replica.cpp:345] Persisted promised to 1
I1120 06:43:11.418896 30220 coordinator.cpp:240] Coordinator attempting to fill missing positions
I1120 06:43:11.420119 30219 replica.cpp:391] Replica received explicit promise request from (10546)@172.17.8.139:46176 for position 0 with proposal 2
I1120 06:43:11.420518 30219 leveldb.cpp:343] Persisting action (8 bytes) to leveldb took 359248ns
I1120 06:43:11.420543 30219 replica.cpp:715] Persisted action at 0
I1120 06:43:11.421461 30227 replica.cpp:540] Replica received write request for position 0 from (10547)@172.17.8.139:46176
I1120 06:43:11.421517 30227 leveldb.cpp:438] Reading position from leveldb took 25881ns
I1120 06:43:11.421957 30227 leveldb.cpp:343] Persisting action (14 bytes) to leveldb took 396064ns
I1120 06:43:11.421983 30227 replica.cpp:715] Persisted action at 0
I1120 06:43:11.422423 30225 replica.cpp:694] Replica received learned notice for position 0 from @0.0.0.0:0
I1120 06:43:11.422732 30225 leveldb.cpp:343] Persisting action (16 bytes) to leveldb took 279283ns
I1120 06:43:11.422758 30225 replica.cpp:715] Persisted action at 0
I1120 06:43:11.422776 30225 replica.cpp:700] Replica learned NOP action at position 0
I1120 06:43:11.423277 30227 log.cpp:677] Writer started with ending position 0
I1120 06:43:11.424468 30222 leveldb.cpp:438] Reading position from leveldb took 23827ns
I1120 06:43:11.425520 30222 registrar.cpp:342] Successfully fetched the registry (0B) in 9.53728ms
I1120 06:43:11.425618 30222 registrar.cpp:441] Applied 1 operations in 22763ns; attempting to update the 'registry'
I1120 06:43:11.426578 30225 log.cpp:685] Attempting to append 176 bytes to the log
I1120 06:43:11.426739 30225 coordinator.cpp:350] Coordinator attempting to write APPEND action at position 1
I1120 06:43:11.427578 30225 replica.cpp:540] Replica received write request for position 1 from (10548)@172.17.8.139:46176
I1120 06:43:11.427960 30225 leveldb.cpp:343] Persisting action (195 bytes) to leveldb took 344448ns
I1120 06:43:11.427988 30225 replica.cpp:715] Persisted action at 1
I1120 06:43:11.428671 30229 replica.cpp:694] Replica received learned notice for position 1 from @0.0.0.0:0
I1120 06:43:11.429005 30229 leveldb.cpp:343] Persisting action (197 bytes) to leveldb took 304767ns
I1120 06:43:11.429031 30229 replica.cpp:715] Persisted action at 1
I1120 06:43:11.429050 30229 replica.cpp:700] Replica learned APPEND action at position 1
I1120 06:43:11.430027 30218 registrar.cpp:486] Successfully updated the 'registry' in 4.348928ms
I1120 06:43:11.430162 30218 registrar.cpp:372] Successfully recovered registrar
I1120 06:43:11.430282 30221 log.cpp:704] Attempting to truncate the log to 1
I1120 06:43:11.430421 30218 coordinator.cpp:350] Coordinator attempting to write TRUNCATE action at position 2
I1120 06:43:11.430501 30223 master.cpp:1422] Recovered 0 slaves from the Registry (137B) ; allowing 10mins for slaves to re-register
I1120 06:43:11.431126 30221 replica.cpp:540] Replica received write request for position 2 from (10549)@172.17.8.139:46176
I1120 06:43:11.431438 30221 leveldb.cpp:343] Persisting action (16 bytes) to leveldb took 277956ns
I1120 06:43:11.431464 30221 replica.cpp:715] Persisted action at 2
I1120 06:43:11.431996 30224 replica.cpp:694] Replica received learned notice for position 2 from @0.0.0.0:0
I1120 06:43:11.432399 30224 leveldb.cpp:343] Persisting action (18 bytes) to leveldb took 371194ns
I1120 06:43:11.432451 30224 leveldb.cpp:401] Deleting ~1 keys from leveldb took 27607ns
I1120 06:43:11.432472 30224 replica.cpp:715] Persisted action at 2
I1120 06:43:11.432494 30224 replica.cpp:700] Replica learned TRUNCATE action at position 2
I1120 06:43:11.441603 30196 scheduler.cpp:156] Version: 0.26.0
I1120 06:43:11.442383 30223 scheduler.cpp:238] New master detected at master@172.17.8.139:46176
I1120 06:43:11.443348 30223 scheduler.cpp:300] Sending SUBSCRIBE call to master@172.17.8.139:46176
I1120 06:43:11.445453 30215 process.cpp:3081] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I1120 06:43:11.445513 30215 http.cpp:338] HTTP POST for /master/api/v1/scheduler from 172.17.8.139:48256
I1120 06:43:11.445855 30215 master.cpp:1874] Received subscription request for HTTP framework 'default'
I1120 06:43:11.445922 30215 master.cpp:1651] Authorizing framework principal 'test-principal' to receive offers for role '*'
I1120 06:43:11.446158 30215 master.cpp:1966] Subscribing framework 'default' with checkpointing disabled and capabilities [  ]
I1120 06:43:11.446575 30229 hierarchical.cpp:197] Added framework 058c5daa-56cb-4bb7-a3e2-1eda00178c92-0000
I1120 06:43:11.446636 30229 hierarchical.cpp:979] No resources available to allocate!
I1120 06:43:11.446679 30229 hierarchical.cpp:1072] No inverse offers to send out!
I1120 06:43:11.446712 30229 hierarchical.cpp:878] Performed allocation for 0 slaves in 108390ns
I1120 06:43:11.446743 30229 master.hpp:1522] Sending heartbeat to 058c5daa-56cb-4bb7-a3e2-1eda00178c92-0000
I1120 06:43:11.447561 30229 scheduler.cpp:459] Enqueuing event SUBSCRIBED received from master@172.17.8.139:46176
I1120 06:43:11.448197 30229 scheduler.cpp:459] Enqueuing event HEARTBEAT received from master@172.17.8.139:46176
I1120 06:43:11.448999 30215 scheduler.cpp:300] Sending REQUEST call to master@172.17.8.139:46176
I1120 06:43:11.448920 30228 master_maintenance_tests.cpp:174] Ignoring HEARTBEAT event
I1120 06:43:11.450947 30220 process.cpp:3081] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I1120 06:43:11.451110 30220 http.cpp:338] HTTP POST for /master/api/v1/scheduler from 172.17.8.139:48257
I1120 06:43:11.451586 30220 master.cpp:2621] Processing REQUEST call for framework 058c5daa-56cb-4bb7-a3e2-1eda00178c92-0000 (default)
I1120 06:43:11.451920 30230 hierarchical.cpp:460] Received resource request from framework 058c5daa-56cb-4bb7-a3e2-1eda00178c92-0000
I1120 06:43:11.453032 30230 master.cpp:928] Master terminating
I1120 06:43:11.453238 30222 hierarchical.cpp:232] Removed framework 058c5daa-56cb-4bb7-a3e2-1eda00178c92-0000
E1120 06:43:11.455982 30221 scheduler.cpp:433] End-Of-File received from master. The master closed the event stream
[       OK ] ContentType/SchedulerTest.Request/1 (61 ms)
[----------] 22 tests from ContentType/SchedulerTest (4742 ms total)

[----------] Global test environment tear-down
[==========] 834 tests from 114 test cases ran. (343880 ms total)
[  PASSED  ] 832 tests.
[  FAILED  ] 2 tests, listed below:
[  FAILED  ] CurlFetcherPluginTest.ValidUri
[  FAILED  ] CurlFetcherPluginTest.InvalidUri

 2 FAILED TESTS
  YOU HAVE 7 DISABLED TESTS

make[4]: Leaving directory `/mesos/mesos-0.26.0/_build/src'
make[4]: *** [check-local] Error 1
make[3]: *** [check-am] Error 2
make[3]: Leaving directory `/mesos/mesos-0.26.0/_build/src'
make[2]: *** [check] Error 2
make[2]: Leaving directory `/mesos/mesos-0.26.0/_build/src'
make[1]: *** [check-recursive] Error 1
make[1]: Leaving directory `/mesos/mesos-0.26.0/_build'
make: *** [distcheck] Error 1
+ docker rmi mesos-1447999801-14196
Untagged: mesos-1447999801-14196:latest
Deleted: 19c13f536816d73d1883bdd1fcf015c4bef64b5b9ec9aeb19aa592128dfec340
Deleted: f97a8e4742098ad74021c3d8c909c64276494734b95309981a07d0f24fb9d686
Deleted: c0ca52b6e7739ad79a50742b4f35679aa19f5e8027aead53884618da366306c2
Deleted: a5940aff4ac5a457de0bf1194dd29a9d741f4948ef312890f0bc460e4a12ec10
Deleted: cbb69c70c5134a62cf1e3f590585e4e009f01c04e5d4e53867f9ed7276e615fa
Deleted: bd541118c397c93bfe0c97f1178582cbd95aede5c430f0fa6db5a93b5417ae47
Deleted: 3d539f06ea1a06539d1a9943c6c0825ea138aa31cef968fd6a9aafe26cbdab98
Deleted: 870b58c54648fac847abc1795164d595e339350183f0618a54e642c7beea9546
Deleted: 16fb1ad3ffb7a9d7da112b2b855c0e961b8fc8fa623958ac751a4558d9340613
Deleted: 68f7f7bf0e58aa30f8e9be85e7e97ff5db1e0fb4c129b6f5210449bf1945ae03
Deleted: 9493f6880cfabff99ad4f1de902f27001aaa5b491480ac75a5b9a74c38a5fd30
Deleted: 4d336cdf3f57abf2450e90e315940eb4cca4624390352ce6b2669a07a1a51fb4
Deleted: bcde349ac53a612fd92fda7931393bc32f86361e9656210e0607f6cafa132759

Traceback (most recent call last):
  File "./support/verify_reviews.py", line 210, in <module>
    verify_review(review_request)
  File "./support/verify_reviews.py", line 139, in verify_review
    "Error:\n %s" % (applied, e.cmd, e.output))
  File "./support/verify_reviews.py", line 99, in post_review
    api(review_url, data)
  File "./support/verify_reviews.py", line 65, in api
    return json.loads(urllib2.urlopen(url, data=data).read())
  File "/usr/lib/python2.7/urllib2.py", line 127, in urlopen
    return _opener.open(url, data, timeout)
  File "/usr/lib/python2.7/urllib2.py", line 410, in open
    response = meth(req, response)
  File "/usr/lib/python2.7/urllib2.py", line 523, in http_response
    'http', request, response, code, msg, hdrs)
  File "/usr/lib/python2.7/urllib2.py", line 442, in error
    result = self._call_chain(*args)
  File "/usr/lib/python2.7/urllib2.py", line 382, in _call_chain
    result = func(*args)
  File "/usr/lib/python2.7/urllib2.py", line 897, in http_error_401
    url, req, headers)
  File "/usr/lib/python2.7/urllib2.py", line 872, in http_error_auth_reqed
    response = self.retry_http_basic_auth(host, req, realm)
  File "/usr/lib/python2.7/urllib2.py", line 885, in retry_http_basic_auth
    return self.parent.open(req, timeout=req.timeout)
  File "/usr/lib/python2.7/urllib2.py", line 410, in open
    response = meth(req, response)
  File "/usr/lib/python2.7/urllib2.py", line 523, in http_response
    'http', request, response, code, msg, hdrs)
  File "/usr/lib/python2.7/urllib2.py", line 448, in error
    return self._call_chain(*args)
  File "/usr/lib/python2.7/urllib2.py", line 382, in _call_chain
    result = func(*args)
  File "/usr/lib/python2.7/urllib2.py", line 531, in http_error_default
    raise HTTPError(req.get_full_url(), code, msg, hdrs, fp)
urllib2.HTTPError: HTTP Error 500: INTERNAL SERVER ERROR
git clean -fd
git reset --hard d78db0658f36c0afea8db04c148ea82fdbfc6d7b

Build step 'Execute shell' marked build as failure

Build failed in Jenkins: mesos-reviewbot #9794

Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/mesos-reviewbot/9794/>

------------------------------------------
[...truncated 149996 lines...]
I1120 05:39:12.488996 30231 recover.cpp:580] Successfully joined the Paxos group
I1120 05:39:12.489274 30231 recover.cpp:464] Recover process terminated
I1120 05:39:12.489750 30228 log.cpp:661] Attempting to start the writer
I1120 05:39:12.491356 30224 replica.cpp:496] Replica received implicit promise request from (10597)@172.17.19.140:35115 with proposal 1
I1120 05:39:12.534636 30224 leveldb.cpp:306] Persisting metadata (8 bytes) to leveldb took 43.236268ms
I1120 05:39:12.534679 30224 replica.cpp:345] Persisted promised to 1
I1120 05:39:12.535572 30237 coordinator.cpp:240] Coordinator attempting to fill missing positions
I1120 05:39:12.537019 30223 replica.cpp:391] Replica received explicit promise request from (10598)@172.17.19.140:35115 for position 0 with proposal 2
I1120 05:39:12.584790 30223 leveldb.cpp:343] Persisting action (8 bytes) to leveldb took 47.711521ms
I1120 05:39:12.584842 30223 replica.cpp:715] Persisted action at 0
I1120 05:39:12.586091 30238 replica.cpp:540] Replica received write request for position 0 from (10599)@172.17.19.140:35115
I1120 05:39:12.586155 30238 leveldb.cpp:438] Reading position from leveldb took 30648ns
I1120 05:39:12.626782 30238 leveldb.cpp:343] Persisting action (14 bytes) to leveldb took 40.57163ms
I1120 05:39:12.626827 30238 replica.cpp:715] Persisted action at 0
I1120 05:39:12.627744 30233 replica.cpp:694] Replica received learned notice for position 0 from @0.0.0.0:0
I1120 05:39:12.660820 30233 leveldb.cpp:343] Persisting action (16 bytes) to leveldb took 32.931546ms
I1120 05:39:12.660861 30233 replica.cpp:715] Persisted action at 0
I1120 05:39:12.660883 30233 replica.cpp:700] Replica learned NOP action at position 0
I1120 05:39:12.661537 30238 log.cpp:677] Writer started with ending position 0
I1120 05:39:12.662681 30235 leveldb.cpp:438] Reading position from leveldb took 28417ns
I1120 05:39:12.663585 30228 registrar.cpp:342] Successfully fetched the registry (0B) in 248.103936ms
I1120 05:39:12.663705 30228 registrar.cpp:441] Applied 1 operations in 26376ns; attempting to update the 'registry'
I1120 05:39:12.664393 30224 log.cpp:685] Attempting to append 178 bytes to the log
I1120 05:39:12.664573 30230 coordinator.cpp:350] Coordinator attempting to write APPEND action at position 1
I1120 05:39:12.665288 30237 replica.cpp:540] Replica received write request for position 1 from (10600)@172.17.19.140:35115
I1120 05:39:12.698897 30237 leveldb.cpp:343] Persisting action (197 bytes) to leveldb took 33.568355ms
I1120 05:39:12.698936 30237 replica.cpp:715] Persisted action at 1
I1120 05:39:12.699779 30237 replica.cpp:694] Replica received learned notice for position 1 from @0.0.0.0:0
I1120 05:39:12.744707 30237 leveldb.cpp:343] Persisting action (199 bytes) to leveldb took 44.898745ms
I1120 05:39:12.744752 30237 replica.cpp:715] Persisted action at 1
I1120 05:39:12.744777 30237 replica.cpp:700] Replica learned APPEND action at position 1
I1120 05:39:12.745914 30233 registrar.cpp:486] Successfully updated the 'registry' in 82.145024ms
I1120 05:39:12.746129 30233 registrar.cpp:372] Successfully recovered registrar
I1120 05:39:12.746214 30225 log.cpp:704] Attempting to truncate the log to 1
I1120 05:39:12.746444 30228 coordinator.cpp:350] Coordinator attempting to write TRUNCATE action at position 2
I1120 05:39:12.746649 30232 master.cpp:1422] Recovered 0 slaves from the Registry (139B) ; allowing 10mins for slaves to re-register
I1120 05:39:12.747359 30228 replica.cpp:540] Replica received write request for position 2 from (10601)@172.17.19.140:35115
I1120 05:39:12.782668 30228 leveldb.cpp:343] Persisting action (16 bytes) to leveldb took 35.257465ms
I1120 05:39:12.782709 30228 replica.cpp:715] Persisted action at 2
I1120 05:39:12.783437 30229 replica.cpp:694] Replica received learned notice for position 2 from @0.0.0.0:0
I1120 05:39:12.816220 30229 leveldb.cpp:343] Persisting action (18 bytes) to leveldb took 32.743393ms
I1120 05:39:12.816308 30229 leveldb.cpp:401] Deleting ~1 keys from leveldb took 45711ns
I1120 05:39:12.816346 30229 replica.cpp:715] Persisted action at 2
I1120 05:39:12.816395 30229 replica.cpp:700] Replica learned TRUNCATE action at position 2
I1120 05:39:12.817925 30204 scheduler.cpp:156] Version: 0.26.0
I1120 05:39:12.818585 30223 scheduler.cpp:238] New master detected at master@172.17.19.140:35115
I1120 05:39:12.819725 30227 scheduler.cpp:300] Sending SUBSCRIBE call to master@172.17.19.140:35115
I1120 05:39:12.821795 30236 process.cpp:3081] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I1120 05:39:12.821864 30236 http.cpp:338] HTTP POST for /master/api/v1/scheduler from 172.17.19.140:53624
I1120 05:39:12.822118 30236 master.cpp:1874] Received subscription request for HTTP framework 'default'
I1120 05:39:12.822201 30236 master.cpp:1651] Authorizing framework principal 'test-principal' to receive offers for role '*'
I1120 05:39:12.822520 30236 master.cpp:1966] Subscribing framework 'default' with checkpointing disabled and capabilities [  ]
I1120 05:39:12.822916 30229 hierarchical.cpp:197] Added framework 8dc8c1cd-c2be-48a8-a778-e273c487e429-0000
I1120 05:39:12.823019 30229 hierarchical.cpp:979] No resources available to allocate!
I1120 05:39:12.823073 30229 hierarchical.cpp:1072] No inverse offers to send out!
I1120 05:39:12.823110 30229 hierarchical.cpp:878] Performed allocation for 0 slaves in 159605ns
I1120 05:39:12.823276 30233 master.hpp:1522] Sending heartbeat to 8dc8c1cd-c2be-48a8-a778-e273c487e429-0000
I1120 05:39:12.823997 30238 scheduler.cpp:459] Enqueuing event SUBSCRIBED received from master@172.17.19.140:35115
I1120 05:39:12.824558 30238 scheduler.cpp:459] Enqueuing event HEARTBEAT received from master@172.17.19.140:35115
I1120 05:39:12.825260 30234 master_maintenance_tests.cpp:174] Ignoring HEARTBEAT event
I1120 05:39:12.825353 30238 scheduler.cpp:300] Sending REQUEST call to master@172.17.19.140:35115
I1120 05:39:12.827148 30233 process.cpp:3081] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I1120 05:39:12.827219 30233 http.cpp:338] HTTP POST for /master/api/v1/scheduler from 172.17.19.140:53625
I1120 05:39:12.827327 30233 master.cpp:2621] Processing REQUEST call for framework 8dc8c1cd-c2be-48a8-a778-e273c487e429-0000 (default)
I1120 05:39:12.827517 30230 hierarchical.cpp:460] Received resource request from framework 8dc8c1cd-c2be-48a8-a778-e273c487e429-0000
I1120 05:39:12.827807 30233 master.cpp:928] Master terminating
I1120 05:39:12.828047 30238 hierarchical.cpp:232] Removed framework 8dc8c1cd-c2be-48a8-a778-e273c487e429-0000
E1120 05:39:12.828990 30227 scheduler.cpp:433] End-Of-File received from master. The master closed the event stream
[       OK ] ContentType/SchedulerTest.Request/0 (581 ms)
[ RUN      ] ContentType/SchedulerTest.Request/1
I1120 05:39:12.979197 30204 leveldb.cpp:176] Opened db in 128.755428ms
I1120 05:39:13.026644 30204 leveldb.cpp:183] Compacted db in 47.396219ms
I1120 05:39:13.026729 30204 leveldb.cpp:198] Created db iterator in 26259ns
I1120 05:39:13.026746 30204 leveldb.cpp:204] Seeked to beginning of db in 2890ns
I1120 05:39:13.026752 30204 leveldb.cpp:273] Iterated through 0 keys in the db in 240ns
I1120 05:39:13.026799 30204 replica.cpp:780] Replica recovered with log positions 0 -> 0 with 1 holes and 0 unlearned
I1120 05:39:13.027370 30238 recover.cpp:449] Starting replica recovery
I1120 05:39:13.027637 30238 recover.cpp:475] Replica is in EMPTY status
I1120 05:39:13.028945 30225 replica.cpp:676] Replica in EMPTY status received a broadcasted recover request from (10606)@172.17.19.140:35115
I1120 05:39:13.029244 30234 recover.cpp:195] Received a recover response from a replica in EMPTY status
I1120 05:39:13.029737 30230 recover.cpp:566] Updating replica status to STARTING
I1120 05:39:13.030165 30227 master.cpp:367] Master a2cd5d61-e7c2-409f-9822-dc0f0cdc8edc (2d658b3ddc34) started on 172.17.19.140:35115
I1120 05:39:13.030277 30227 master.cpp:369] Flags at startup: --acls="" --allocation_interval="1secs" --allocator="HierarchicalDRF" --authenticate="false" --authenticate_slaves="true" --authenticators="crammd5" --authorizers="local" --credentials="/tmp/aKq0LO/credentials" --framework_sorter="drf" --help="false" --hostname_lookup="true" --initialize_driver_logging="true" --log_auto_initialize="true" --logbufsecs="0" --logging_level="INFO" --max_slave_ping_timeouts="5" --quiet="false" --recovery_slave_removal_limit="100%" --registry="replicated_log" --registry_fetch_timeout="1mins" --registry_store_timeout="25secs" --registry_strict="true" --root_submissions="true" --slave_ping_timeout="15secs" --slave_reregister_timeout="10mins" --user_sorter="drf" --version="false" --webui_dir="/mesos/mesos-0.26.0/_inst/share/mesos/webui" --work_dir="/tmp/aKq0LO/master" --zk_session_timeout="10secs"
I1120 05:39:13.030509 30227 master.cpp:416] Master allowing unauthenticated frameworks to register
I1120 05:39:13.030519 30227 master.cpp:419] Master only allowing authenticated slaves to register
I1120 05:39:13.030524 30227 credentials.hpp:37] Loading credentials for authentication from '/tmp/aKq0LO/credentials'
I1120 05:39:13.030772 30227 master.cpp:458] Using default 'crammd5' authenticator
I1120 05:39:13.030889 30227 master.cpp:495] Authorization enabled
I1120 05:39:13.031091 30226 whitelist_watcher.cpp:79] No whitelist given
I1120 05:39:13.031155 30234 hierarchical.cpp:153] Initialized hierarchical allocator process
I1120 05:39:13.032944 30233 master.cpp:1612] The newly elected leader is master@172.17.19.140:35115 with id a2cd5d61-e7c2-409f-9822-dc0f0cdc8edc
I1120 05:39:13.032979 30233 master.cpp:1625] Elected as the leading master!
I1120 05:39:13.032996 30233 master.cpp:1385] Recovering from registrar
I1120 05:39:13.033138 30225 registrar.cpp:309] Recovering registrar
I1120 05:39:13.060062 30235 leveldb.cpp:306] Persisting metadata (8 bytes) to leveldb took 30.179808ms
I1120 05:39:13.060133 30235 replica.cpp:323] Persisted replica status to STARTING
I1120 05:39:13.060432 30235 recover.cpp:475] Replica is in STARTING status
I1120 05:39:13.061481 30235 replica.cpp:676] Replica in STARTING status received a broadcasted recover request from (10607)@172.17.19.140:35115
I1120 05:39:13.061919 30230 recover.cpp:195] Received a recover response from a replica in STARTING status
I1120 05:39:13.062479 30236 recover.cpp:566] Updating replica status to VOTING
I1120 05:39:13.085278 30238 leveldb.cpp:306] Persisting metadata (8 bytes) to leveldb took 22.559748ms
I1120 05:39:13.085321 30238 replica.cpp:323] Persisted replica status to VOTING
I1120 05:39:13.085480 30227 recover.cpp:580] Successfully joined the Paxos group
I1120 05:39:13.085763 30227 recover.cpp:464] Recover process terminated
I1120 05:39:13.086381 30236 log.cpp:661] Attempting to start the writer
I1120 05:39:13.087862 30236 replica.cpp:496] Replica received implicit promise request from (10608)@172.17.19.140:35115 with proposal 1
I1120 05:39:13.119143 30236 leveldb.cpp:306] Persisting metadata (8 bytes) to leveldb took 31.242793ms
I1120 05:39:13.119184 30236 replica.cpp:345] Persisted promised to 1
I1120 05:39:13.119940 30230 coordinator.cpp:240] Coordinator attempting to fill missing positions
I1120 05:39:13.121364 30236 replica.cpp:391] Replica received explicit promise request from (10609)@172.17.19.140:35115 for position 0 with proposal 2
I1120 05:39:13.153285 30236 leveldb.cpp:343] Persisting action (8 bytes) to leveldb took 31.865948ms
I1120 05:39:13.153331 30236 replica.cpp:715] Persisted action at 0
I1120 05:39:13.154634 30223 replica.cpp:540] Replica received write request for position 0 from (10610)@172.17.19.140:35115
I1120 05:39:13.154716 30223 leveldb.cpp:438] Reading position from leveldb took 36661ns
I1120 05:39:13.186838 30223 leveldb.cpp:343] Persisting action (14 bytes) to leveldb took 32.068906ms
I1120 05:39:13.186884 30223 replica.cpp:715] Persisted action at 0
I1120 05:39:13.187662 30237 replica.cpp:694] Replica received learned notice for position 0 from @0.0.0.0:0
I1120 05:39:13.220373 30237 leveldb.cpp:343] Persisting action (16 bytes) to leveldb took 32.609971ms
I1120 05:39:13.220402 30237 replica.cpp:715] Persisted action at 0
I1120 05:39:13.220418 30237 replica.cpp:700] Replica learned NOP action at position 0
I1120 05:39:13.221009 30233 log.cpp:677] Writer started with ending position 0
I1120 05:39:13.222252 30232 leveldb.cpp:438] Reading position from leveldb took 32078ns
I1120 05:39:13.223402 30229 registrar.cpp:342] Successfully fetched the registry (0B) in 190144us
I1120 05:39:13.223549 30229 registrar.cpp:441] Applied 1 operations in 41108ns; attempting to update the 'registry'
I1120 05:39:13.224409 30224 log.cpp:685] Attempting to append 178 bytes to the log
I1120 05:39:13.224580 30236 coordinator.cpp:350] Coordinator attempting to write APPEND action at position 1
I1120 05:39:13.225402 30237 replica.cpp:540] Replica received write request for position 1 from (10611)@172.17.19.140:35115
I1120 05:39:13.254906 30237 leveldb.cpp:343] Persisting action (197 bytes) to leveldb took 29.45863ms
I1120 05:39:13.254952 30237 replica.cpp:715] Persisted action at 1
I1120 05:39:13.255926 30234 replica.cpp:694] Replica received learned notice for position 1 from @0.0.0.0:0
I1120 05:39:13.305101 30234 leveldb.cpp:343] Persisting action (199 bytes) to leveldb took 49.136677ms
I1120 05:39:13.305140 30234 replica.cpp:715] Persisted action at 1
I1120 05:39:13.305162 30234 replica.cpp:700] Replica learned APPEND action at position 1
I1120 05:39:13.306243 30224 registrar.cpp:486] Successfully updated the 'registry' in 82.616064ms
I1120 05:39:13.306489 30224 registrar.cpp:372] Successfully recovered registrar
I1120 05:39:13.306550 30236 log.cpp:704] Attempting to truncate the log to 1
I1120 05:39:13.306684 30237 coordinator.cpp:350] Coordinator attempting to write TRUNCATE action at position 2
I1120 05:39:13.306931 30223 master.cpp:1422] Recovered 0 slaves from the Registry (139B) ; allowing 10mins for slaves to re-register
I1120 05:39:13.307879 30237 replica.cpp:540] Replica received write request for position 2 from (10612)@172.17.19.140:35115
I1120 05:39:13.355284 30237 leveldb.cpp:343] Persisting action (16 bytes) to leveldb took 47.355845ms
I1120 05:39:13.355329 30237 replica.cpp:715] Persisted action at 2
I1120 05:39:13.356254 30237 replica.cpp:694] Replica received learned notice for position 2 from @0.0.0.0:0
I1120 05:39:13.405519 30237 leveldb.cpp:343] Persisting action (18 bytes) to leveldb took 49.225573ms
I1120 05:39:13.405596 30237 leveldb.cpp:401] Deleting ~1 keys from leveldb took 39938ns
I1120 05:39:13.405621 30237 replica.cpp:715] Persisted action at 2
I1120 05:39:13.405643 30237 replica.cpp:700] Replica learned TRUNCATE action at position 2
I1120 05:39:13.408496 30204 scheduler.cpp:156] Version: 0.26.0
I1120 05:39:13.409250 30233 scheduler.cpp:238] New master detected at master@172.17.19.140:35115
I1120 05:39:13.410454 30227 scheduler.cpp:300] Sending SUBSCRIBE call to master@172.17.19.140:35115
I1120 05:39:13.412580 30235 process.cpp:3081] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I1120 05:39:13.412653 30235 http.cpp:338] HTTP POST for /master/api/v1/scheduler from 172.17.19.140:53626
I1120 05:39:13.413064 30235 master.cpp:1874] Received subscription request for HTTP framework 'default'
I1120 05:39:13.413142 30235 master.cpp:1651] Authorizing framework principal 'test-principal' to receive offers for role '*'
I1120 05:39:13.413473 30235 master.cpp:1966] Subscribing framework 'default' with checkpointing disabled and capabilities [  ]
I1120 05:39:13.413939 30228 hierarchical.cpp:197] Added framework a2cd5d61-e7c2-409f-9822-dc0f0cdc8edc-0000
I1120 05:39:13.414017 30228 hierarchical.cpp:979] No resources available to allocate!
I1120 05:39:13.414065 30228 hierarchical.cpp:1072] No inverse offers to send out!
I1120 05:39:13.414101 30228 hierarchical.cpp:878] Performed allocation for 0 slaves in 114052ns
I1120 05:39:13.414301 30228 master.hpp:1522] Sending heartbeat to a2cd5d61-e7c2-409f-9822-dc0f0cdc8edc-0000
I1120 05:39:13.415508 30229 scheduler.cpp:459] Enqueuing event SUBSCRIBED received from master@172.17.19.140:35115
I1120 05:39:13.416050 30229 scheduler.cpp:459] Enqueuing event HEARTBEAT received from master@172.17.19.140:35115
I1120 05:39:13.416832 30224 master_maintenance_tests.cpp:174] Ignoring HEARTBEAT event
I1120 05:39:13.416877 30229 scheduler.cpp:300] Sending REQUEST call to master@172.17.19.140:35115
I1120 05:39:13.418745 30224 process.cpp:3081] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I1120 05:39:13.418817 30224 http.cpp:338] HTTP POST for /master/api/v1/scheduler from 172.17.19.140:53627
I1120 05:39:13.419100 30224 master.cpp:2621] Processing REQUEST call for framework a2cd5d61-e7c2-409f-9822-dc0f0cdc8edc-0000 (default)
I1120 05:39:13.419288 30236 hierarchical.cpp:460] Received resource request from framework a2cd5d61-e7c2-409f-9822-dc0f0cdc8edc-0000
I1120 05:39:13.419615 30228 master.cpp:928] Master terminating
I1120 05:39:13.419843 30235 hierarchical.cpp:232] Removed framework a2cd5d61-e7c2-409f-9822-dc0f0cdc8edc-0000
E1120 05:39:13.420857 30230 scheduler.cpp:433] End-Of-File received from master. The master closed the event stream
[       OK ] ContentType/SchedulerTest.Request/1 (600 ms)
[----------] 22 tests from ContentType/SchedulerTest (17316 ms total)

[----------] Global test environment tear-down
2015-11-20 05:39:13,927:30204(0x2b264398b700):ZOO_ERROR@handle_socket_error_msg@1697: Socket [127.0.0.1:56248] zk retcode=-4, errno=111(Connection refused): server refused to accept the client
[==========] 834 tests from 114 test cases ran. (703604 ms total)
[  PASSED  ] 832 tests.
[  FAILED  ] 2 tests, listed below:
[  FAILED  ] CurlFetcherPluginTest.ValidUri
[  FAILED  ] CurlFetcherPluginTest.InvalidUri

 2 FAILED TESTS
  YOU HAVE 7 DISABLED TESTS

make[4]: *** [check-local] Error 1
make[4]: Leaving directory `/mesos/mesos-0.26.0/_build/src'
make[3]: *** [check-am] Error 2
make[3]: Leaving directory `/mesos/mesos-0.26.0/_build/src'
make[2]: *** [check] Error 2
make[2]: Leaving directory `/mesos/mesos-0.26.0/_build/src'
make[1]: *** [check-recursive] Error 1
make[1]: Leaving directory `/mesos/mesos-0.26.0/_build'
make: *** [distcheck] Error 1
+ docker rmi mesos-1447995614-8904
Untagged: mesos-1447995614-8904:latest
Deleted: 003f64e4eb53886c5d9a80b069d5d743af94c95bdbf430657261400a692b3852
Deleted: dae856cb55cbfa337aded7133047181efbb37f243d38fed4ca265009b3644e69
Deleted: fe894ad76d096347a86d828a09a84776d956fa4054036517340ea5a392e4c31d
Deleted: 69fa47f124b8c3f2e81a0f575a03621970d319e5337a28f1fc5e792e5bba7ddc
Deleted: 130fec3694917d3b51ad5dd2fa937483454ac94b1dfb4a6b283791db90dec85a
Deleted: d400367fc0584347158cb688e3f217eb7d84050c2e9cf3b832c174e0669ede05
Deleted: 5645dc0678b32cc088d04f117f9d6ba041df85979aa7e92faeec278719a78cef
Deleted: 0d27bc07e9b1bee05e453323f920e7f601a7026b8d40e01f6d6fe81271d485ac
Deleted: da31701193d0c06adfcb1442203d97907d9891b0489823cc163631dc7306bf0d
Deleted: ff0d6b7a1e6328e48986a76d70f9151006c208f8b8d0a94343e282a23a133141
Deleted: beebe2b2c07353c3629b896540794fd219173a3dbfcd1d828c7ac8b9a0876231
Deleted: 71e58738c3c93d88627cebac86f1a8a7f5c3fca30cdb88474a76c2a9eed5fe2e
Deleted: 2aa1b76c0343d748b5679be3c4d56ef1a37dc0230b74c6633fbc45bb6bc940e6

Traceback (most recent call last):
  File "./support/verify_reviews.py", line 210, in <module>
    verify_review(review_request)
  File "./support/verify_reviews.py", line 139, in verify_review
    "Error:\n %s" % (applied, e.cmd, e.output))
  File "./support/verify_reviews.py", line 99, in post_review
    api(review_url, data)
  File "./support/verify_reviews.py", line 65, in api
    return json.loads(urllib2.urlopen(url, data=data).read())
  File "/usr/lib/python2.7/urllib2.py", line 127, in urlopen
    return _opener.open(url, data, timeout)
  File "/usr/lib/python2.7/urllib2.py", line 410, in open
    response = meth(req, response)
  File "/usr/lib/python2.7/urllib2.py", line 523, in http_response
    'http', request, response, code, msg, hdrs)
  File "/usr/lib/python2.7/urllib2.py", line 442, in error
    result = self._call_chain(*args)
  File "/usr/lib/python2.7/urllib2.py", line 382, in _call_chain
    result = func(*args)
  File "/usr/lib/python2.7/urllib2.py", line 897, in http_error_401
    url, req, headers)
  File "/usr/lib/python2.7/urllib2.py", line 872, in http_error_auth_reqed
    response = self.retry_http_basic_auth(host, req, realm)
  File "/usr/lib/python2.7/urllib2.py", line 885, in retry_http_basic_auth
    return self.parent.open(req, timeout=req.timeout)
  File "/usr/lib/python2.7/urllib2.py", line 410, in open
    response = meth(req, response)
  File "/usr/lib/python2.7/urllib2.py", line 523, in http_response
    'http', request, response, code, msg, hdrs)
  File "/usr/lib/python2.7/urllib2.py", line 448, in error
    return self._call_chain(*args)
  File "/usr/lib/python2.7/urllib2.py", line 382, in _call_chain
    result = func(*args)
  File "/usr/lib/python2.7/urllib2.py", line 531, in http_error_default
    raise HTTPError(req.get_full_url(), code, msg, hdrs, fp)
urllib2.HTTPError: HTTP Error 500: INTERNAL SERVER ERROR
git clean -fd
git reset --hard d78db0658f36c0afea8db04c148ea82fdbfc6d7b

Build step 'Execute shell' marked build as failure

Build failed in Jenkins: mesos-reviewbot #9793

Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/mesos-reviewbot/9793/>

------------------------------------------
[...truncated 148676 lines...]
I1120 04:36:01.319453 30224 master.cpp:1385] Recovering from registrar
I1120 04:36:01.319569 30216 registrar.cpp:309] Recovering registrar
I1120 04:36:01.319597 30220 recover.cpp:464] Recover process terminated
I1120 04:36:01.320305 30221 log.cpp:661] Attempting to start the writer
I1120 04:36:01.321539 30225 replica.cpp:496] Replica received implicit promise request from (10545)@172.17.6.98:35077 with proposal 1
I1120 04:36:01.321918 30225 leveldb.cpp:306] Persisting metadata (8 bytes) to leveldb took 306206ns
I1120 04:36:01.321940 30225 replica.cpp:345] Persisted promised to 1
I1120 04:36:01.322845 30228 coordinator.cpp:240] Coordinator attempting to fill missing positions
I1120 04:36:01.324079 30217 replica.cpp:391] Replica received explicit promise request from (10546)@172.17.6.98:35077 for position 0 with proposal 2
I1120 04:36:01.324684 30217 leveldb.cpp:343] Persisting action (8 bytes) to leveldb took 555133ns
I1120 04:36:01.324720 30217 replica.cpp:715] Persisted action at 0
I1120 04:36:01.326125 30221 replica.cpp:540] Replica received write request for position 0 from (10547)@172.17.6.98:35077
I1120 04:36:01.326195 30221 leveldb.cpp:438] Reading position from leveldb took 30714ns
I1120 04:36:01.326583 30221 leveldb.cpp:343] Persisting action (14 bytes) to leveldb took 340611ns
I1120 04:36:01.326607 30221 replica.cpp:715] Persisted action at 0
I1120 04:36:01.327240 30216 replica.cpp:694] Replica received learned notice for position 0 from @0.0.0.0:0
I1120 04:36:01.327636 30216 leveldb.cpp:343] Persisting action (16 bytes) to leveldb took 365717ns
I1120 04:36:01.327661 30216 replica.cpp:715] Persisted action at 0
I1120 04:36:01.327677 30216 replica.cpp:700] Replica learned NOP action at position 0
I1120 04:36:01.328260 30222 log.cpp:677] Writer started with ending position 0
I1120 04:36:01.329380 30216 leveldb.cpp:438] Reading position from leveldb took 34634ns
I1120 04:36:01.330548 30219 registrar.cpp:342] Successfully fetched the registry (0B) in 10.90688ms
I1120 04:36:01.330724 30219 registrar.cpp:441] Applied 1 operations in 45610ns; attempting to update the 'registry'
I1120 04:36:01.331606 30220 log.cpp:685] Attempting to append 174 bytes to the log
I1120 04:36:01.331789 30215 coordinator.cpp:350] Coordinator attempting to write APPEND action at position 1
I1120 04:36:01.332597 30218 replica.cpp:540] Replica received write request for position 1 from (10548)@172.17.6.98:35077
I1120 04:36:01.333154 30218 leveldb.cpp:343] Persisting action (193 bytes) to leveldb took 477023ns
I1120 04:36:01.333181 30218 replica.cpp:715] Persisted action at 1
I1120 04:36:01.334065 30224 replica.cpp:694] Replica received learned notice for position 1 from @0.0.0.0:0
I1120 04:36:01.334470 30224 leveldb.cpp:343] Persisting action (195 bytes) to leveldb took 366900ns
I1120 04:36:01.334498 30224 replica.cpp:715] Persisted action at 1
I1120 04:36:01.334519 30224 replica.cpp:700] Replica learned APPEND action at position 1
I1120 04:36:01.335750 30223 registrar.cpp:486] Successfully updated the 'registry' in 4.934912ms
I1120 04:36:01.335937 30223 registrar.cpp:372] Successfully recovered registrar
I1120 04:36:01.336045 30218 log.cpp:704] Attempting to truncate the log to 1
I1120 04:36:01.336213 30217 coordinator.cpp:350] Coordinator attempting to write TRUNCATE action at position 2
I1120 04:36:01.336475 30216 master.cpp:1422] Recovered 0 slaves from the Registry (135B) ; allowing 10mins for slaves to re-register
I1120 04:36:01.337345 30215 replica.cpp:540] Replica received write request for position 2 from (10549)@172.17.6.98:35077
I1120 04:36:01.337739 30215 leveldb.cpp:343] Persisting action (16 bytes) to leveldb took 361686ns
I1120 04:36:01.337765 30215 replica.cpp:715] Persisted action at 2
I1120 04:36:01.338430 30225 replica.cpp:694] Replica received learned notice for position 2 from @0.0.0.0:0
I1120 04:36:01.338800 30225 leveldb.cpp:343] Persisting action (18 bytes) to leveldb took 339150ns
I1120 04:36:01.338850 30225 leveldb.cpp:401] Deleting ~1 keys from leveldb took 26572ns
I1120 04:36:01.338865 30225 replica.cpp:715] Persisted action at 2
I1120 04:36:01.338881 30225 replica.cpp:700] Replica learned TRUNCATE action at position 2
I1120 04:36:01.347357 30196 scheduler.cpp:156] Version: 0.26.0
I1120 04:36:01.347920 30217 scheduler.cpp:238] New master detected at master@172.17.6.98:35077
I1120 04:36:01.349095 30230 scheduler.cpp:300] Sending SUBSCRIBE call to master@172.17.6.98:35077
I1120 04:36:01.351058 30222 process.cpp:3081] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I1120 04:36:01.351135 30222 http.cpp:338] HTTP POST for /master/api/v1/scheduler from 172.17.6.98:44388
I1120 04:36:01.351359 30222 master.cpp:1874] Received subscription request for HTTP framework 'default'
I1120 04:36:01.351465 30222 master.cpp:1651] Authorizing framework principal 'test-principal' to receive offers for role '*'
I1120 04:36:01.351748 30222 master.cpp:1966] Subscribing framework 'default' with checkpointing disabled and capabilities [  ]
I1120 04:36:01.352167 30226 hierarchical.cpp:197] Added framework c6de7c68-6ed3-4347-bc94-08cf6c39bf3e-0000
I1120 04:36:01.352226 30226 hierarchical.cpp:979] No resources available to allocate!
I1120 04:36:01.352267 30226 hierarchical.cpp:1072] No inverse offers to send out!
I1120 04:36:01.352267 30219 master.hpp:1522] Sending heartbeat to c6de7c68-6ed3-4347-bc94-08cf6c39bf3e-0000
I1120 04:36:01.352301 30226 hierarchical.cpp:878] Performed allocation for 0 slaves in 103990ns
I1120 04:36:01.353041 30221 scheduler.cpp:459] Enqueuing event SUBSCRIBED received from master@172.17.6.98:35077
I1120 04:36:01.353488 30221 scheduler.cpp:459] Enqueuing event HEARTBEAT received from master@172.17.6.98:35077
I1120 04:36:01.354034 30220 master_maintenance_tests.cpp:174] Ignoring HEARTBEAT event
I1120 04:36:01.354142 30221 scheduler.cpp:300] Sending REQUEST call to master@172.17.6.98:35077
I1120 04:36:01.355530 30226 process.cpp:3081] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I1120 04:36:01.355588 30226 http.cpp:338] HTTP POST for /master/api/v1/scheduler from 172.17.6.98:44389
I1120 04:36:01.355691 30226 master.cpp:2621] Processing REQUEST call for framework c6de7c68-6ed3-4347-bc94-08cf6c39bf3e-0000 (default)
I1120 04:36:01.355842 30228 hierarchical.cpp:460] Received resource request from framework c6de7c68-6ed3-4347-bc94-08cf6c39bf3e-0000
I1120 04:36:01.356111 30218 master.cpp:928] Master terminating
I1120 04:36:01.356294 30223 hierarchical.cpp:232] Removed framework c6de7c68-6ed3-4347-bc94-08cf6c39bf3e-0000
E1120 04:36:01.357576 30225 scheduler.cpp:433] End-Of-File received from master. The master closed the event stream
[       OK ] ContentType/SchedulerTest.Request/0 (52 ms)
[ RUN      ] ContentType/SchedulerTest.Request/1
I1120 04:36:01.364944 30196 leveldb.cpp:176] Opened db in 2.767113ms
I1120 04:36:01.365911 30196 leveldb.cpp:183] Compacted db in 903004ns
I1120 04:36:01.365974 30196 leveldb.cpp:198] Created db iterator in 24844ns
I1120 04:36:01.366004 30196 leveldb.cpp:204] Seeked to beginning of db in 2348ns
I1120 04:36:01.366022 30196 leveldb.cpp:273] Iterated through 0 keys in the db in 339ns
I1120 04:36:01.366081 30196 replica.cpp:780] Replica recovered with log positions 0 -> 0 with 1 holes and 0 unlearned
I1120 04:36:01.367202 30217 recover.cpp:449] Starting replica recovery
I1120 04:36:01.367852 30217 recover.cpp:475] Replica is in EMPTY status
I1120 04:36:01.369664 30228 master.cpp:367] Master 48303314-d8e8-4e7a-9bd1-6363d5b8240b (36e7074fe081) started on 172.17.6.98:35077
I1120 04:36:01.369664 30229 replica.cpp:676] Replica in EMPTY status received a broadcasted recover request from (10554)@172.17.6.98:35077
I1120 04:36:01.369705 30228 master.cpp:369] Flags at startup: --acls="" --allocation_interval="1secs" --allocator="HierarchicalDRF" --authenticate="false" --authenticate_slaves="true" --authenticators="crammd5" --authorizers="local" --credentials="/tmp/hC4AlM/credentials" --framework_sorter="drf" --help="false" --hostname_lookup="true" --initialize_driver_logging="true" --log_auto_initialize="true" --logbufsecs="0" --logging_level="INFO" --max_slave_ping_timeouts="5" --quiet="false" --recovery_slave_removal_limit="100%" --registry="replicated_log" --registry_fetch_timeout="1mins" --registry_store_timeout="25secs" --registry_strict="true" --root_submissions="true" --slave_ping_timeout="15secs" --slave_reregister_timeout="10mins" --user_sorter="drf" --version="false" --webui_dir="/mesos/mesos-0.26.0/_inst/share/mesos/webui" --work_dir="/tmp/hC4AlM/master" --zk_session_timeout="10secs"
I1120 04:36:01.370085 30228 master.cpp:416] Master allowing unauthenticated frameworks to register
I1120 04:36:01.370100 30228 master.cpp:419] Master only allowing authenticated slaves to register
I1120 04:36:01.370111 30228 credentials.hpp:37] Loading credentials for authentication from '/tmp/hC4AlM/credentials'
I1120 04:36:01.370450 30228 master.cpp:458] Using default 'crammd5' authenticator
I1120 04:36:01.370474 30216 recover.cpp:195] Received a recover response from a replica in EMPTY status
I1120 04:36:01.370582 30228 master.cpp:495] Authorization enabled
I1120 04:36:01.370946 30230 whitelist_watcher.cpp:79] No whitelist given
I1120 04:36:01.370965 30225 hierarchical.cpp:153] Initialized hierarchical allocator process
I1120 04:36:01.371217 30222 recover.cpp:566] Updating replica status to STARTING
I1120 04:36:01.372300 30216 leveldb.cpp:306] Persisting metadata (8 bytes) to leveldb took 815803ns
I1120 04:36:01.372469 30216 replica.cpp:323] Persisted replica status to STARTING
I1120 04:36:01.372930 30225 master.cpp:1612] The newly elected leader is master@172.17.6.98:35077 with id 48303314-d8e8-4e7a-9bd1-6363d5b8240b
I1120 04:36:01.372990 30225 master.cpp:1625] Elected as the leading master!
I1120 04:36:01.372989 30229 recover.cpp:475] Replica is in STARTING status
I1120 04:36:01.373029 30225 master.cpp:1385] Recovering from registrar
I1120 04:36:01.373764 30230 registrar.cpp:309] Recovering registrar
I1120 04:36:01.374757 30227 replica.cpp:676] Replica in STARTING status received a broadcasted recover request from (10555)@172.17.6.98:35077
I1120 04:36:01.375643 30230 recover.cpp:195] Received a recover response from a replica in STARTING status
I1120 04:36:01.376368 30230 recover.cpp:566] Updating replica status to VOTING
I1120 04:36:01.377214 30227 leveldb.cpp:306] Persisting metadata (8 bytes) to leveldb took 588027ns
I1120 04:36:01.377250 30227 replica.cpp:323] Persisted replica status to VOTING
I1120 04:36:01.377415 30216 recover.cpp:580] Successfully joined the Paxos group
I1120 04:36:01.377689 30216 recover.cpp:464] Recover process terminated
I1120 04:36:01.378237 30222 log.cpp:661] Attempting to start the writer
I1120 04:36:01.379957 30227 replica.cpp:496] Replica received implicit promise request from (10556)@172.17.6.98:35077 with proposal 1
I1120 04:36:01.380483 30227 leveldb.cpp:306] Persisting metadata (8 bytes) to leveldb took 483626ns
I1120 04:36:01.380516 30227 replica.cpp:345] Persisted promised to 1
I1120 04:36:01.381239 30220 coordinator.cpp:240] Coordinator attempting to fill missing positions
I1120 04:36:01.382753 30230 replica.cpp:391] Replica received explicit promise request from (10557)@172.17.6.98:35077 for position 0 with proposal 2
I1120 04:36:01.383298 30230 leveldb.cpp:343] Persisting action (8 bytes) to leveldb took 470891ns
I1120 04:36:01.383327 30230 replica.cpp:715] Persisted action at 0
I1120 04:36:01.384578 30222 replica.cpp:540] Replica received write request for position 0 from (10558)@172.17.6.98:35077
I1120 04:36:01.384649 30222 leveldb.cpp:438] Reading position from leveldb took 34817ns
I1120 04:36:01.385047 30222 leveldb.cpp:343] Persisting action (14 bytes) to leveldb took 341391ns
I1120 04:36:01.385071 30222 replica.cpp:715] Persisted action at 0
I1120 04:36:01.385870 30225 replica.cpp:694] Replica received learned notice for position 0 from @0.0.0.0:0
I1120 04:36:01.386230 30225 leveldb.cpp:343] Persisting action (16 bytes) to leveldb took 328969ns
I1120 04:36:01.386257 30225 replica.cpp:715] Persisted action at 0
I1120 04:36:01.386276 30225 replica.cpp:700] Replica learned NOP action at position 0
I1120 04:36:01.387475 30222 log.cpp:677] Writer started with ending position 0
I1120 04:36:01.388947 30229 leveldb.cpp:438] Reading position from leveldb took 60560ns
I1120 04:36:01.390012 30225 registrar.cpp:342] Successfully fetched the registry (0B) in 16.177408ms
I1120 04:36:01.390198 30225 registrar.cpp:441] Applied 1 operations in 45739ns; attempting to update the 'registry'
I1120 04:36:01.391201 30220 log.cpp:685] Attempting to append 174 bytes to the log
I1120 04:36:01.391366 30230 coordinator.cpp:350] Coordinator attempting to write APPEND action at position 1
I1120 04:36:01.392289 30230 replica.cpp:540] Replica received write request for position 1 from (10559)@172.17.6.98:35077
I1120 04:36:01.392856 30230 leveldb.cpp:343] Persisting action (193 bytes) to leveldb took 514677ns
I1120 04:36:01.392899 30230 replica.cpp:715] Persisted action at 1
I1120 04:36:01.393666 30225 replica.cpp:694] Replica received learned notice for position 1 from @0.0.0.0:0
I1120 04:36:01.394085 30225 leveldb.cpp:343] Persisting action (195 bytes) to leveldb took 322917ns
I1120 04:36:01.394109 30225 replica.cpp:715] Persisted action at 1
I1120 04:36:01.394130 30225 replica.cpp:700] Replica learned APPEND action at position 1
I1120 04:36:01.395234 30222 registrar.cpp:486] Successfully updated the 'registry' in 4.95616ms
I1120 04:36:01.395448 30222 registrar.cpp:372] Successfully recovered registrar
I1120 04:36:01.395583 30229 log.cpp:704] Attempting to truncate the log to 1
I1120 04:36:01.395795 30223 coordinator.cpp:350] Coordinator attempting to write TRUNCATE action at position 2
I1120 04:36:01.395881 30230 master.cpp:1422] Recovered 0 slaves from the Registry (135B) ; allowing 10mins for slaves to re-register
I1120 04:36:01.396868 30221 replica.cpp:540] Replica received write request for position 2 from (10560)@172.17.6.98:35077
I1120 04:36:01.397274 30221 leveldb.cpp:343] Persisting action (16 bytes) to leveldb took 354852ns
I1120 04:36:01.397305 30221 replica.cpp:715] Persisted action at 2
I1120 04:36:01.398155 30220 replica.cpp:694] Replica received learned notice for position 2 from @0.0.0.0:0
I1120 04:36:01.398525 30220 leveldb.cpp:343] Persisting action (18 bytes) to leveldb took 335134ns
I1120 04:36:01.398584 30220 leveldb.cpp:401] Deleting ~1 keys from leveldb took 32069ns
I1120 04:36:01.398605 30220 replica.cpp:715] Persisted action at 2
I1120 04:36:01.398623 30220 replica.cpp:700] Replica learned TRUNCATE action at position 2
I1120 04:36:01.406723 30196 scheduler.cpp:156] Version: 0.26.0
I1120 04:36:01.407315 30223 scheduler.cpp:238] New master detected at master@172.17.6.98:35077
I1120 04:36:01.408556 30215 scheduler.cpp:300] Sending SUBSCRIBE call to master@172.17.6.98:35077
I1120 04:36:01.410917 30225 process.cpp:3081] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I1120 04:36:01.410997 30225 http.cpp:338] HTTP POST for /master/api/v1/scheduler from 172.17.6.98:44391
I1120 04:36:01.411458 30225 master.cpp:1874] Received subscription request for HTTP framework 'default'
I1120 04:36:01.411546 30225 master.cpp:1651] Authorizing framework principal 'test-principal' to receive offers for role '*'
I1120 04:36:01.411882 30225 master.cpp:1966] Subscribing framework 'default' with checkpointing disabled and capabilities [  ]
I1120 04:36:01.412421 30228 hierarchical.cpp:197] Added framework 48303314-d8e8-4e7a-9bd1-6363d5b8240b-0000
I1120 04:36:01.412502 30228 hierarchical.cpp:979] No resources available to allocate!
I1120 04:36:01.412555 30225 master.hpp:1522] Sending heartbeat to 48303314-d8e8-4e7a-9bd1-6363d5b8240b-0000
I1120 04:36:01.412644 30228 hierarchical.cpp:1072] No inverse offers to send out!
I1120 04:36:01.412689 30228 hierarchical.cpp:878] Performed allocation for 0 slaves in 232868ns
I1120 04:36:01.413852 30216 scheduler.cpp:459] Enqueuing event SUBSCRIBED received from master@172.17.6.98:35077
I1120 04:36:01.414458 30216 scheduler.cpp:459] Enqueuing event HEARTBEAT received from master@172.17.6.98:35077
I1120 04:36:01.415436 30228 master_maintenance_tests.cpp:174] Ignoring HEARTBEAT event
I1120 04:36:01.415487 30216 scheduler.cpp:300] Sending REQUEST call to master@172.17.6.98:35077
I1120 04:36:01.417544 30225 process.cpp:3081] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I1120 04:36:01.417615 30225 http.cpp:338] HTTP POST for /master/api/v1/scheduler from 172.17.6.98:44392
I1120 04:36:01.417860 30225 master.cpp:2621] Processing REQUEST call for framework 48303314-d8e8-4e7a-9bd1-6363d5b8240b-0000 (default)
I1120 04:36:01.418037 30228 hierarchical.cpp:460] Received resource request from framework 48303314-d8e8-4e7a-9bd1-6363d5b8240b-0000
I1120 04:36:01.418388 30229 master.cpp:928] Master terminating
I1120 04:36:01.418608 30216 hierarchical.cpp:232] Removed framework 48303314-d8e8-4e7a-9bd1-6363d5b8240b-0000
E1120 04:36:01.419996 30224 scheduler.cpp:433] End-Of-File received from master. The master closed the event stream
[       OK ] ContentType/SchedulerTest.Request/1 (64 ms)
[----------] 22 tests from ContentType/SchedulerTest (4152 ms total)

[----------] Global test environment tear-down
[==========] 834 tests from 114 test cases ran. (324099 ms total)
[  PASSED  ] 832 tests.
[  FAILED  ] 2 tests, listed below:
[  FAILED  ] CurlFetcherPluginTest.ValidUri
[  FAILED  ] CurlFetcherPluginTest.InvalidUri

 2 FAILED TESTS
  YOU HAVE 7 DISABLED TESTS

make[4]: *** [check-local] Error 1
make[4]: Leaving directory `/mesos/mesos-0.26.0/_build/src'
make[3]: *** [check-am] Error 2
make[3]: Leaving directory `/mesos/mesos-0.26.0/_build/src'
make[2]: *** [check] Error 2
make[2]: Leaving directory `/mesos/mesos-0.26.0/_build/src'
make[1]: *** [check-recursive] Error 1
make[1]: Leaving directory `/mesos/mesos-0.26.0/_build'
make: *** [distcheck] Error 1
+ docker rmi mesos-1447992258-30311
Untagged: mesos-1447992258-30311:latest
Deleted: 2c781f252f874b7def762adc804cfc8825b8983cd82eae9e789f8dfdda35e683
Deleted: 3bdd03eaf80265be55e515ae68161f0b768f93898e017079b6045c0a0fbb4799
Deleted: 1295906eac269438cb039321417d808003b52cb071cdf9562d86d14658b6dbe6
Deleted: 5ddf373405672e883f7aed6ffdd7d040f87253e678d10ac19ad24492a4270cbb
Deleted: 834d487e30d70884871de84dcd879bcd723725cb0fb2a49f09b7c452cbaea6d0
Deleted: 06a8ad93c41b86a68949ecb8471a58a665d524eb67ed7fe1522624caae4c8ad7
Deleted: 1aaefb5c8d295ca67dff5a1f82d3f441950e58f5e98423e7dc7c8204c1dafaa1
Deleted: 83f4abbadf05c5b614ddff12a5762e918d186325ae5e4bb6e4ce84d974d0e0f6
Deleted: 18441525fa0dc50b7fb4a698cc9d92f870b147d57b8be26bd0ae24eb002f0d47
Deleted: 5c8cf02993eef8071418e33a4b73c359bfd7891b6d31d6929c53a8e6a62ba97f
Deleted: 88354a3c30202303db12f50b1abdb175e7d1e0d5632532514b6616003c97c099
Deleted: 601f5b16704378546c70a10d23086e69d97d872323d71d2f0318f0e363a5bc07
Deleted: 1074190005f57adb268eb4bf7247a66ac9b5303f7792b871a486ce0ef87e51e7

Traceback (most recent call last):
  File "./support/verify_reviews.py", line 210, in <module>
    verify_review(review_request)
  File "./support/verify_reviews.py", line 139, in verify_review
    "Error:\n %s" % (applied, e.cmd, e.output))
  File "./support/verify_reviews.py", line 99, in post_review
    api(review_url, data)
  File "./support/verify_reviews.py", line 65, in api
    return json.loads(urllib2.urlopen(url, data=data).read())
  File "/usr/lib/python2.7/urllib2.py", line 127, in urlopen
    return _opener.open(url, data, timeout)
  File "/usr/lib/python2.7/urllib2.py", line 410, in open
    response = meth(req, response)
  File "/usr/lib/python2.7/urllib2.py", line 523, in http_response
    'http', request, response, code, msg, hdrs)
  File "/usr/lib/python2.7/urllib2.py", line 442, in error
    result = self._call_chain(*args)
  File "/usr/lib/python2.7/urllib2.py", line 382, in _call_chain
    result = func(*args)
  File "/usr/lib/python2.7/urllib2.py", line 897, in http_error_401
    url, req, headers)
  File "/usr/lib/python2.7/urllib2.py", line 872, in http_error_auth_reqed
    response = self.retry_http_basic_auth(host, req, realm)
  File "/usr/lib/python2.7/urllib2.py", line 885, in retry_http_basic_auth
    return self.parent.open(req, timeout=req.timeout)
  File "/usr/lib/python2.7/urllib2.py", line 410, in open
    response = meth(req, response)
  File "/usr/lib/python2.7/urllib2.py", line 523, in http_response
    'http', request, response, code, msg, hdrs)
  File "/usr/lib/python2.7/urllib2.py", line 448, in error
    return self._call_chain(*args)
  File "/usr/lib/python2.7/urllib2.py", line 382, in _call_chain
    result = func(*args)
  File "/usr/lib/python2.7/urllib2.py", line 531, in http_error_default
    raise HTTPError(req.get_full_url(), code, msg, hdrs, fp)
urllib2.HTTPError: HTTP Error 500: INTERNAL SERVER ERROR
git clean -fd
git reset --hard d78db0658f36c0afea8db04c148ea82fdbfc6d7b

Build step 'Execute shell' marked build as failure

Build failed in Jenkins: mesos-reviewbot #9792

Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/mesos-reviewbot/9792/>

------------------------------------------
[...truncated 149868 lines...]
I1120 03:34:15.701244 30230 recover.cpp:580] Successfully joined the Paxos group
I1120 03:34:15.701449 30230 recover.cpp:464] Recover process terminated
I1120 03:34:15.701874 30237 log.cpp:661] Attempting to start the writer
I1120 03:34:15.702960 30238 replica.cpp:496] Replica received implicit promise request from (10568)@172.17.19.115:43001 with proposal 1
I1120 03:34:15.726378 30238 leveldb.cpp:306] Persisting metadata (8 bytes) to leveldb took 23.389311ms
I1120 03:34:15.726414 30238 replica.cpp:345] Persisted promised to 1
I1120 03:34:15.726948 30235 coordinator.cpp:240] Coordinator attempting to fill missing positions
I1120 03:34:15.727977 30231 replica.cpp:391] Replica received explicit promise request from (10569)@172.17.19.115:43001 for position 0 with proposal 2
I1120 03:34:15.751412 30231 leveldb.cpp:343] Persisting action (8 bytes) to leveldb took 23.395402ms
I1120 03:34:15.751446 30231 replica.cpp:715] Persisted action at 0
I1120 03:34:15.752429 30234 replica.cpp:540] Replica received write request for position 0 from (10570)@172.17.19.115:43001
I1120 03:34:15.752485 30234 leveldb.cpp:438] Reading position from leveldb took 26064ns
I1120 03:34:15.776520 30234 leveldb.cpp:343] Persisting action (14 bytes) to leveldb took 23.990891ms
I1120 03:34:15.776547 30234 replica.cpp:715] Persisted action at 0
I1120 03:34:15.777143 30236 replica.cpp:694] Replica received learned notice for position 0 from @0.0.0.0:0
I1120 03:34:15.801663 30236 leveldb.cpp:343] Persisting action (16 bytes) to leveldb took 24.488248ms
I1120 03:34:15.801692 30236 replica.cpp:715] Persisted action at 0
I1120 03:34:15.801708 30236 replica.cpp:700] Replica learned NOP action at position 0
I1120 03:34:15.802302 30228 log.cpp:677] Writer started with ending position 0
I1120 03:34:15.803354 30231 leveldb.cpp:438] Reading position from leveldb took 29954ns
I1120 03:34:15.804270 30230 registrar.cpp:342] Successfully fetched the registry (0B) in 156.379904ms
I1120 03:34:15.804435 30230 registrar.cpp:441] Applied 1 operations in 32744ns; attempting to update the 'registry'
I1120 03:34:15.805156 30237 log.cpp:685] Attempting to append 178 bytes to the log
I1120 03:34:15.805282 30233 coordinator.cpp:350] Coordinator attempting to write APPEND action at position 1
I1120 03:34:15.805975 30229 replica.cpp:540] Replica received write request for position 1 from (10571)@172.17.19.115:43001
I1120 03:34:15.831980 30229 leveldb.cpp:343] Persisting action (197 bytes) to leveldb took 25.967739ms
I1120 03:34:15.832010 30229 replica.cpp:715] Persisted action at 1
I1120 03:34:15.832567 30227 replica.cpp:694] Replica received learned notice for position 1 from @0.0.0.0:0
I1120 03:34:15.863226 30227 leveldb.cpp:343] Persisting action (199 bytes) to leveldb took 30.630715ms
I1120 03:34:15.863255 30227 replica.cpp:715] Persisted action at 1
I1120 03:34:15.863272 30227 replica.cpp:700] Replica learned APPEND action at position 1
I1120 03:34:15.864223 30232 registrar.cpp:486] Successfully updated the 'registry' in 59.72608ms
I1120 03:34:15.864364 30232 registrar.cpp:372] Successfully recovered registrar
I1120 03:34:15.864476 30229 log.cpp:704] Attempting to truncate the log to 1
I1120 03:34:15.864624 30237 coordinator.cpp:350] Coordinator attempting to write TRUNCATE action at position 2
I1120 03:34:15.864748 30232 master.cpp:1422] Recovered 0 slaves from the Registry (139B) ; allowing 10mins for slaves to re-register
I1120 03:34:15.865366 30228 replica.cpp:540] Replica received write request for position 2 from (10572)@172.17.19.115:43001
I1120 03:34:15.896761 30228 leveldb.cpp:343] Persisting action (16 bytes) to leveldb took 31.36235ms
I1120 03:34:15.896790 30228 replica.cpp:715] Persisted action at 2
I1120 03:34:15.897372 30226 replica.cpp:694] Replica received learned notice for position 2 from @0.0.0.0:0
I1120 03:34:15.930255 30226 leveldb.cpp:343] Persisting action (18 bytes) to leveldb took 32.853392ms
I1120 03:34:15.930326 30226 leveldb.cpp:401] Deleting ~1 keys from leveldb took 36330ns
I1120 03:34:15.930368 30226 replica.cpp:715] Persisted action at 2
I1120 03:34:15.930392 30226 replica.cpp:700] Replica learned TRUNCATE action at position 2
I1120 03:34:15.936009 30205 scheduler.cpp:156] Version: 0.26.0
I1120 03:34:15.936576 30229 scheduler.cpp:238] New master detected at master@172.17.19.115:43001
I1120 03:34:15.937516 30234 scheduler.cpp:300] Sending SUBSCRIBE call to master@172.17.19.115:43001
I1120 03:34:15.939232 30233 process.cpp:3081] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I1120 03:34:15.939290 30233 http.cpp:338] HTTP POST for /master/api/v1/scheduler from 172.17.19.115:48323
I1120 03:34:15.939445 30233 master.cpp:1874] Received subscription request for HTTP framework 'default'
I1120 03:34:15.939503 30233 master.cpp:1651] Authorizing framework principal 'test-principal' to receive offers for role '*'
I1120 03:34:15.939856 30233 master.cpp:1966] Subscribing framework 'default' with checkpointing disabled and capabilities [  ]
I1120 03:34:15.940213 30239 hierarchical.cpp:197] Added framework 4def0103-c75e-41c7-b080-6f1beda9b37a-0000
I1120 03:34:15.940281 30228 master.hpp:1522] Sending heartbeat to 4def0103-c75e-41c7-b080-6f1beda9b37a-0000
I1120 03:34:15.940398 30239 hierarchical.cpp:979] No resources available to allocate!
I1120 03:34:15.940434 30239 hierarchical.cpp:1072] No inverse offers to send out!
I1120 03:34:15.940464 30239 hierarchical.cpp:878] Performed allocation for 0 slaves in 94237ns
I1120 03:34:15.941185 30236 scheduler.cpp:459] Enqueuing event SUBSCRIBED received from master@172.17.19.115:43001
I1120 03:34:15.941589 30236 scheduler.cpp:459] Enqueuing event HEARTBEAT received from master@172.17.19.115:43001
I1120 03:34:15.942173 30225 master_maintenance_tests.cpp:174] Ignoring HEARTBEAT event
I1120 03:34:15.942248 30236 scheduler.cpp:300] Sending REQUEST call to master@172.17.19.115:43001
I1120 03:34:15.943503 30224 process.cpp:3081] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I1120 03:34:15.943560 30224 http.cpp:338] HTTP POST for /master/api/v1/scheduler from 172.17.19.115:48324
I1120 03:34:15.943675 30224 master.cpp:2621] Processing REQUEST call for framework 4def0103-c75e-41c7-b080-6f1beda9b37a-0000 (default)
I1120 03:34:15.943886 30227 hierarchical.cpp:460] Received resource request from framework 4def0103-c75e-41c7-b080-6f1beda9b37a-0000
I1120 03:34:15.944115 30224 master.cpp:928] Master terminating
I1120 03:34:15.944254 30229 hierarchical.cpp:232] Removed framework 4def0103-c75e-41c7-b080-6f1beda9b37a-0000
E1120 03:34:15.945489 30239 scheduler.cpp:433] End-Of-File received from master. The master closed the event stream
[       OK ] ContentType/SchedulerTest.Request/0 (434 ms)
[ RUN      ] ContentType/SchedulerTest.Request/1
I1120 03:34:16.066036 30205 leveldb.cpp:176] Opened db in 116.329885ms
I1120 03:34:16.418368 30205 leveldb.cpp:183] Compacted db in 352.273075ms
I1120 03:34:16.418462 30205 leveldb.cpp:198] Created db iterator in 25746ns
I1120 03:34:16.418481 30205 leveldb.cpp:204] Seeked to beginning of db in 2842ns
I1120 03:34:16.418489 30205 leveldb.cpp:273] Iterated through 0 keys in the db in 214ns
I1120 03:34:16.418536 30205 replica.cpp:780] Replica recovered with log positions 0 -> 0 with 1 holes and 0 unlearned
I1120 03:34:16.419240 30234 recover.cpp:449] Starting replica recovery
I1120 03:34:16.419471 30234 recover.cpp:475] Replica is in EMPTY status
I1120 03:34:16.420423 30232 replica.cpp:676] Replica in EMPTY status received a broadcasted recover request from (10577)@172.17.19.115:43001
I1120 03:34:16.420840 30236 recover.cpp:195] Received a recover response from a replica in EMPTY status
I1120 03:34:16.421231 30228 recover.cpp:566] Updating replica status to STARTING
I1120 03:34:16.422102 30232 master.cpp:367] Master 08a86dcb-5f51-4157-b52b-3605ba889ffb (fc9139964baf) started on 172.17.19.115:43001
I1120 03:34:16.422127 30232 master.cpp:369] Flags at startup: --acls="" --allocation_interval="1secs" --allocator="HierarchicalDRF" --authenticate="false" --authenticate_slaves="true" --authenticators="crammd5" --authorizers="local" --credentials="/tmp/BnmjL9/credentials" --framework_sorter="drf" --help="false" --hostname_lookup="true" --initialize_driver_logging="true" --log_auto_initialize="true" --logbufsecs="0" --logging_level="INFO" --max_slave_ping_timeouts="5" --quiet="false" --recovery_slave_removal_limit="100%" --registry="replicated_log" --registry_fetch_timeout="1mins" --registry_store_timeout="25secs" --registry_strict="true" --root_submissions="true" --slave_ping_timeout="15secs" --slave_reregister_timeout="10mins" --user_sorter="drf" --version="false" --webui_dir="/mesos/mesos-0.26.0/_inst/share/mesos/webui" --work_dir="/tmp/BnmjL9/master" --zk_session_timeout="10secs"
I1120 03:34:16.422365 30232 master.cpp:416] Master allowing unauthenticated frameworks to register
I1120 03:34:16.422375 30232 master.cpp:419] Master only allowing authenticated slaves to register
I1120 03:34:16.422381 30232 credentials.hpp:37] Loading credentials for authentication from '/tmp/BnmjL9/credentials'
I1120 03:34:16.422699 30232 master.cpp:458] Using default 'crammd5' authenticator
I1120 03:34:16.422804 30232 master.cpp:495] Authorization enabled
I1120 03:34:16.423004 30225 whitelist_watcher.cpp:79] No whitelist given
I1120 03:34:16.423038 30231 hierarchical.cpp:153] Initialized hierarchical allocator process
I1120 03:34:16.424413 30234 master.cpp:1612] The newly elected leader is master@172.17.19.115:43001 with id 08a86dcb-5f51-4157-b52b-3605ba889ffb
I1120 03:34:16.424443 30234 master.cpp:1625] Elected as the leading master!
I1120 03:34:16.424463 30234 master.cpp:1385] Recovering from registrar
I1120 03:34:16.424587 30226 registrar.cpp:309] Recovering registrar
I1120 03:34:16.464763 30227 leveldb.cpp:306] Persisting metadata (8 bytes) to leveldb took 43.408917ms
I1120 03:34:16.464825 30227 replica.cpp:323] Persisted replica status to STARTING
I1120 03:34:16.465101 30235 recover.cpp:475] Replica is in STARTING status
I1120 03:34:16.466186 30233 replica.cpp:676] Replica in STARTING status received a broadcasted recover request from (10578)@172.17.19.115:43001
I1120 03:34:16.466657 30228 recover.cpp:195] Received a recover response from a replica in STARTING status
I1120 03:34:16.467079 30233 recover.cpp:566] Updating replica status to VOTING
2015-11-20 03:34:16,474:30205(0x2aff03201700):ZOO_ERROR@handle_socket_error_msg@1697: Socket [127.0.0.1:38903] zk retcode=-4, errno=111(Connection refused): server refused to accept the client
I1120 03:34:16.498827 30230 leveldb.cpp:306] Persisting metadata (8 bytes) to leveldb took 31.595865ms
I1120 03:34:16.498867 30230 replica.cpp:323] Persisted replica status to VOTING
I1120 03:34:16.498970 30231 recover.cpp:580] Successfully joined the Paxos group
I1120 03:34:16.499200 30231 recover.cpp:464] Recover process terminated
I1120 03:34:16.499779 30226 log.cpp:661] Attempting to start the writer
I1120 03:34:16.500910 30238 replica.cpp:496] Replica received implicit promise request from (10579)@172.17.19.115:43001 with proposal 1
I1120 03:34:16.523895 30238 leveldb.cpp:306] Persisting metadata (8 bytes) to leveldb took 22.946692ms
I1120 03:34:16.523928 30238 replica.cpp:345] Persisted promised to 1
I1120 03:34:16.524430 30235 coordinator.cpp:240] Coordinator attempting to fill missing positions
I1120 03:34:16.525899 30235 replica.cpp:391] Replica received explicit promise request from (10580)@172.17.19.115:43001 for position 0 with proposal 2
I1120 03:34:16.549201 30235 leveldb.cpp:343] Persisting action (8 bytes) to leveldb took 23.236684ms
I1120 03:34:16.549250 30235 replica.cpp:715] Persisted action at 0
I1120 03:34:16.550631 30238 replica.cpp:540] Replica received write request for position 0 from (10581)@172.17.19.115:43001
I1120 03:34:16.550705 30238 leveldb.cpp:438] Reading position from leveldb took 35120ns
I1120 03:34:16.574297 30238 leveldb.cpp:343] Persisting action (14 bytes) to leveldb took 23.54286ms
I1120 03:34:16.574334 30238 replica.cpp:715] Persisted action at 0
I1120 03:34:16.574864 30239 replica.cpp:694] Replica received learned notice for position 0 from @0.0.0.0:0
I1120 03:34:16.599364 30239 leveldb.cpp:343] Persisting action (16 bytes) to leveldb took 24.468283ms
I1120 03:34:16.599393 30239 replica.cpp:715] Persisted action at 0
I1120 03:34:16.599411 30239 replica.cpp:700] Replica learned NOP action at position 0
I1120 03:34:16.599922 30233 log.cpp:677] Writer started with ending position 0
I1120 03:34:16.600935 30225 leveldb.cpp:438] Reading position from leveldb took 28462ns
I1120 03:34:16.602329 30227 registrar.cpp:342] Successfully fetched the registry (0B) in 177.68192ms
I1120 03:34:16.602491 30227 registrar.cpp:441] Applied 1 operations in 46873ns; attempting to update the 'registry'
I1120 03:34:16.603559 30234 log.cpp:685] Attempting to append 178 bytes to the log
I1120 03:34:16.603747 30239 coordinator.cpp:350] Coordinator attempting to write APPEND action at position 1
I1120 03:34:16.604683 30230 replica.cpp:540] Replica received write request for position 1 from (10582)@172.17.19.115:43001
I1120 03:34:16.628669 30230 leveldb.cpp:343] Persisting action (197 bytes) to leveldb took 23.93589ms
I1120 03:34:16.628715 30230 replica.cpp:715] Persisted action at 1
I1120 03:34:16.629456 30229 replica.cpp:694] Replica received learned notice for position 1 from @0.0.0.0:0
I1120 03:34:16.653913 30229 leveldb.cpp:343] Persisting action (199 bytes) to leveldb took 24.413772ms
I1120 03:34:16.653962 30229 replica.cpp:715] Persisted action at 1
I1120 03:34:16.653990 30229 replica.cpp:700] Replica learned APPEND action at position 1
I1120 03:34:16.655083 30233 registrar.cpp:486] Successfully updated the 'registry' in 52.515072ms
I1120 03:34:16.655294 30233 registrar.cpp:372] Successfully recovered registrar
I1120 03:34:16.655378 30228 log.cpp:704] Attempting to truncate the log to 1
I1120 03:34:16.655516 30234 coordinator.cpp:350] Coordinator attempting to write TRUNCATE action at position 2
I1120 03:34:16.655773 30232 master.cpp:1422] Recovered 0 slaves from the Registry (139B) ; allowing 10mins for slaves to re-register
I1120 03:34:16.656472 30229 replica.cpp:540] Replica received write request for position 2 from (10583)@172.17.19.115:43001
I1120 03:34:16.678951 30229 leveldb.cpp:343] Persisting action (16 bytes) to leveldb took 22.440071ms
I1120 03:34:16.678990 30229 replica.cpp:715] Persisted action at 2
I1120 03:34:16.679888 30228 replica.cpp:694] Replica received learned notice for position 2 from @0.0.0.0:0
I1120 03:34:16.720959 30228 leveldb.cpp:343] Persisting action (18 bytes) to leveldb took 41.025877ms
I1120 03:34:16.721052 30228 leveldb.cpp:401] Deleting ~1 keys from leveldb took 45854ns
I1120 03:34:16.721076 30228 replica.cpp:715] Persisted action at 2
I1120 03:34:16.721101 30228 replica.cpp:700] Replica learned TRUNCATE action at position 2
I1120 03:34:16.727336 30205 scheduler.cpp:156] Version: 0.26.0
I1120 03:34:16.727958 30226 scheduler.cpp:238] New master detected at master@172.17.19.115:43001
I1120 03:34:16.729010 30225 scheduler.cpp:300] Sending SUBSCRIBE call to master@172.17.19.115:43001
I1120 03:34:16.730754 30235 process.cpp:3081] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I1120 03:34:16.730819 30235 http.cpp:338] HTTP POST for /master/api/v1/scheduler from 172.17.19.115:48326
I1120 03:34:16.731154 30235 master.cpp:1874] Received subscription request for HTTP framework 'default'
I1120 03:34:16.731217 30235 master.cpp:1651] Authorizing framework principal 'test-principal' to receive offers for role '*'
I1120 03:34:16.731492 30235 master.cpp:1966] Subscribing framework 'default' with checkpointing disabled and capabilities [  ]
I1120 03:34:16.731928 30224 hierarchical.cpp:197] Added framework 08a86dcb-5f51-4157-b52b-3605ba889ffb-0000
I1120 03:34:16.732012 30224 hierarchical.cpp:979] No resources available to allocate!
I1120 03:34:16.732074 30224 hierarchical.cpp:1072] No inverse offers to send out!
I1120 03:34:16.732110 30224 hierarchical.cpp:878] Performed allocation for 0 slaves in 147016ns
I1120 03:34:16.732163 30226 master.hpp:1522] Sending heartbeat to 08a86dcb-5f51-4157-b52b-3605ba889ffb-0000
I1120 03:34:16.733449 30227 scheduler.cpp:459] Enqueuing event SUBSCRIBED received from master@172.17.19.115:43001
I1120 03:34:16.734037 30227 scheduler.cpp:459] Enqueuing event HEARTBEAT received from master@172.17.19.115:43001
I1120 03:34:16.734910 30224 master_maintenance_tests.cpp:174] Ignoring HEARTBEAT event
I1120 03:34:16.734985 30239 scheduler.cpp:300] Sending REQUEST call to master@172.17.19.115:43001
I1120 03:34:16.736692 30229 process.cpp:3081] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I1120 03:34:16.736752 30229 http.cpp:338] HTTP POST for /master/api/v1/scheduler from 172.17.19.115:48327
I1120 03:34:16.737025 30229 master.cpp:2621] Processing REQUEST call for framework 08a86dcb-5f51-4157-b52b-3605ba889ffb-0000 (default)
I1120 03:34:16.737345 30224 hierarchical.cpp:460] Received resource request from framework 08a86dcb-5f51-4157-b52b-3605ba889ffb-0000
I1120 03:34:16.737633 30205 master.cpp:928] Master terminating
I1120 03:34:16.737790 30229 hierarchical.cpp:232] Removed framework 08a86dcb-5f51-4157-b52b-3605ba889ffb-0000
E1120 03:34:16.739233 30226 scheduler.cpp:433] End-Of-File received from master. The master closed the event stream
[       OK ] ContentType/SchedulerTest.Request/1 (795 ms)
[----------] 22 tests from ContentType/SchedulerTest (16762 ms total)

[----------] Global test environment tear-down
[==========] 834 tests from 114 test cases ran. (663296 ms total)
[  PASSED  ] 832 tests.
[  FAILED  ] 2 tests, listed below:
[  FAILED  ] CurlFetcherPluginTest.ValidUri
[  FAILED  ] CurlFetcherPluginTest.InvalidUri

 2 FAILED TESTS
  YOU HAVE 7 DISABLED TESTS

make[4]: *** [check-local] Error 1
make[4]: Leaving directory `/mesos/mesos-0.26.0/_build/src'
make[3]: *** [check-am] Error 2
make[3]: Leaving directory `/mesos/mesos-0.26.0/_build/src'
make[2]: *** [check] Error 2
make[2]: Leaving directory `/mesos/mesos-0.26.0/_build/src'
make[1]: *** [check-recursive] Error 1
make[1]: Leaving directory `/mesos/mesos-0.26.0/_build'
make: *** [distcheck] Error 1
+ docker rmi mesos-1447987926-21693
Untagged: mesos-1447987926-21693:latest
Deleted: 12890770524c563c83830ea73149f5b4117f24add88f3e87ac02c9bb8f943407
Deleted: a1be838cc7272c0619aa2714cb780eb0bd9a99b0c5ba29a3d8933a79116d4c5a
Deleted: e8338e771c7212c58060ff991d569251d2ea6340297bb8c109b508171c3c016c
Deleted: cac9ccdbf5e4bccfeba9182ecb7bb6ca1879324e10665e87dd3623d3fc23cd1e
Deleted: 75710382c1f892a9ce5a216becaf8ae7cb089dd35ad55da625679bbe17adace0
Deleted: 4d1f5c0aa6e7d413f9a9bc75ade94f3a577a13f31bd17f9b02edf5d76410c2ee
Deleted: a272682f6c4bd648a9390292d9927681f90351752fcb04615c7fab20f3d28103
Deleted: 540a4ca7244111d0c684fc3d6427664f2ff0b223a9bad0345f8581789dc34290
Deleted: b274e17f4e9258179e856d90610bf7854e76b6f592b7f74a4819aec9e85cc11a
Deleted: d20c970d2cf165c8fdd9c0040fa4317a729c29393204c73b05c417e810504d51
Deleted: f43af9bc6e64083cefc3431f47522a0d0656005dbd29cf7f2336b8153542ca44
Deleted: 52e3bb7d41bd74ce4adf4172aa6cf7daa83ba340ffae5d7eadcbfc28f759b51f
Deleted: 018a2c41d629c58c2a7ef8ea84c5e7474be0b6183001b7180913c437b4592a89

Traceback (most recent call last):
  File "./support/verify_reviews.py", line 210, in <module>
    verify_review(review_request)
  File "./support/verify_reviews.py", line 139, in verify_review
    "Error:\n %s" % (applied, e.cmd, e.output))
  File "./support/verify_reviews.py", line 99, in post_review
    api(review_url, data)
  File "./support/verify_reviews.py", line 65, in api
    return json.loads(urllib2.urlopen(url, data=data).read())
  File "/usr/lib/python2.7/urllib2.py", line 127, in urlopen
    return _opener.open(url, data, timeout)
  File "/usr/lib/python2.7/urllib2.py", line 410, in open
    response = meth(req, response)
  File "/usr/lib/python2.7/urllib2.py", line 523, in http_response
    'http', request, response, code, msg, hdrs)
  File "/usr/lib/python2.7/urllib2.py", line 442, in error
    result = self._call_chain(*args)
  File "/usr/lib/python2.7/urllib2.py", line 382, in _call_chain
    result = func(*args)
  File "/usr/lib/python2.7/urllib2.py", line 897, in http_error_401
    url, req, headers)
  File "/usr/lib/python2.7/urllib2.py", line 872, in http_error_auth_reqed
    response = self.retry_http_basic_auth(host, req, realm)
  File "/usr/lib/python2.7/urllib2.py", line 885, in retry_http_basic_auth
    return self.parent.open(req, timeout=req.timeout)
  File "/usr/lib/python2.7/urllib2.py", line 410, in open
    response = meth(req, response)
  File "/usr/lib/python2.7/urllib2.py", line 523, in http_response
    'http', request, response, code, msg, hdrs)
  File "/usr/lib/python2.7/urllib2.py", line 448, in error
    return self._call_chain(*args)
  File "/usr/lib/python2.7/urllib2.py", line 382, in _call_chain
    result = func(*args)
  File "/usr/lib/python2.7/urllib2.py", line 531, in http_error_default
    raise HTTPError(req.get_full_url(), code, msg, hdrs, fp)
urllib2.HTTPError: HTTP Error 500: INTERNAL SERVER ERROR
git clean -fd
git reset --hard d78db0658f36c0afea8db04c148ea82fdbfc6d7b

Build step 'Execute shell' marked build as failure

Build failed in Jenkins: mesos-reviewbot #9791

Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/mesos-reviewbot/9791/changes>

Changes:

[tnachen] Disabled docker bridge executor test.

------------------------------------------
[...truncated 148585 lines...]
I1120 02:29:18.076967 30216 recover.cpp:580] Successfully joined the Paxos group
I1120 02:29:18.077214 30216 recover.cpp:464] Recover process terminated
I1120 02:29:18.077510 30225 log.cpp:661] Attempting to start the writer
I1120 02:29:18.078800 30221 replica.cpp:496] Replica received implicit promise request from (10538)@172.17.19.219:32778 with proposal 1
I1120 02:29:18.079179 30221 leveldb.cpp:306] Persisting metadata (8 bytes) to leveldb took 348868ns
I1120 02:29:18.079200 30221 replica.cpp:345] Persisted promised to 1
I1120 02:29:18.079949 30223 coordinator.cpp:240] Coordinator attempting to fill missing positions
I1120 02:29:18.081197 30216 replica.cpp:391] Replica received explicit promise request from (10539)@172.17.19.219:32778 for position 0 with proposal 2
I1120 02:29:18.081611 30216 leveldb.cpp:343] Persisting action (8 bytes) to leveldb took 370050ns
I1120 02:29:18.081645 30216 replica.cpp:715] Persisted action at 0
I1120 02:29:18.082748 30229 replica.cpp:540] Replica received write request for position 0 from (10540)@172.17.19.219:32778
I1120 02:29:18.082823 30229 leveldb.cpp:438] Reading position from leveldb took 33841ns
I1120 02:29:18.083370 30229 leveldb.cpp:343] Persisting action (14 bytes) to leveldb took 444677ns
I1120 02:29:18.083396 30229 replica.cpp:715] Persisted action at 0
I1120 02:29:18.084238 30216 replica.cpp:694] Replica received learned notice for position 0 from @0.0.0.0:0
I1120 02:29:18.084832 30216 leveldb.cpp:343] Persisting action (16 bytes) to leveldb took 376599ns
I1120 02:29:18.084869 30216 replica.cpp:715] Persisted action at 0
I1120 02:29:18.084899 30216 replica.cpp:700] Replica learned NOP action at position 0
I1120 02:29:18.085640 30229 log.cpp:677] Writer started with ending position 0
I1120 02:29:18.086995 30219 leveldb.cpp:438] Reading position from leveldb took 39211ns
I1120 02:29:18.088093 30225 registrar.cpp:342] Successfully fetched the registry (0B) in 11.446016ms
I1120 02:29:18.088266 30225 registrar.cpp:441] Applied 1 operations in 44184ns; attempting to update the 'registry'
I1120 02:29:18.089330 30220 log.cpp:685] Attempting to append 178 bytes to the log
I1120 02:29:18.089645 30223 coordinator.cpp:350] Coordinator attempting to write APPEND action at position 1
I1120 02:29:18.090490 30228 replica.cpp:540] Replica received write request for position 1 from (10541)@172.17.19.219:32778
I1120 02:29:18.090942 30228 leveldb.cpp:343] Persisting action (197 bytes) to leveldb took 394743ns
I1120 02:29:18.090975 30228 replica.cpp:715] Persisted action at 1
I1120 02:29:18.091742 30218 replica.cpp:694] Replica received learned notice for position 1 from @0.0.0.0:0
I1120 02:29:18.092161 30218 leveldb.cpp:343] Persisting action (199 bytes) to leveldb took 380598ns
I1120 02:29:18.092191 30218 replica.cpp:715] Persisted action at 1
I1120 02:29:18.092212 30218 replica.cpp:700] Replica learned APPEND action at position 1
I1120 02:29:18.093353 30220 registrar.cpp:486] Successfully updated the 'registry' in 4.998144ms
I1120 02:29:18.093541 30220 registrar.cpp:372] Successfully recovered registrar
I1120 02:29:18.093776 30227 log.cpp:704] Attempting to truncate the log to 1
I1120 02:29:18.093956 30221 coordinator.cpp:350] Coordinator attempting to write TRUNCATE action at position 2
I1120 02:29:18.094051 30225 master.cpp:1422] Recovered 0 slaves from the Registry (139B) ; allowing 10mins for slaves to re-register
I1120 02:29:18.094915 30220 replica.cpp:540] Replica received write request for position 2 from (10542)@172.17.19.219:32778
I1120 02:29:18.095345 30220 leveldb.cpp:343] Persisting action (16 bytes) to leveldb took 379473ns
I1120 02:29:18.095376 30220 replica.cpp:715] Persisted action at 2
I1120 02:29:18.096130 30226 replica.cpp:694] Replica received learned notice for position 2 from @0.0.0.0:0
I1120 02:29:18.096549 30226 leveldb.cpp:343] Persisting action (18 bytes) to leveldb took 374853ns
I1120 02:29:18.096634 30226 leveldb.cpp:401] Deleting ~1 keys from leveldb took 55369ns
I1120 02:29:18.096662 30226 replica.cpp:715] Persisted action at 2
I1120 02:29:18.096685 30226 replica.cpp:700] Replica learned TRUNCATE action at position 2
I1120 02:29:18.105216 30196 scheduler.cpp:156] Version: 0.26.0
I1120 02:29:18.106122 30218 scheduler.cpp:238] New master detected at master@172.17.19.219:32778
I1120 02:29:18.107746 30216 scheduler.cpp:300] Sending SUBSCRIBE call to master@172.17.19.219:32778
I1120 02:29:18.110273 30225 process.cpp:3081] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I1120 02:29:18.110369 30225 http.cpp:338] HTTP POST for /master/api/v1/scheduler from 172.17.19.219:50179
I1120 02:29:18.110666 30225 master.cpp:1874] Received subscription request for HTTP framework 'default'
I1120 02:29:18.110777 30225 master.cpp:1651] Authorizing framework principal 'test-principal' to receive offers for role '*'
I1120 02:29:18.111140 30225 master.cpp:1966] Subscribing framework 'default' with checkpointing disabled and capabilities [  ]
I1120 02:29:18.111804 30226 master.hpp:1522] Sending heartbeat to 9a3c9537-ca9c-4089-82a9-6c708fc361f9-0000
I1120 02:29:18.111959 30215 hierarchical.cpp:197] Added framework 9a3c9537-ca9c-4089-82a9-6c708fc361f9-0000
I1120 02:29:18.112038 30215 hierarchical.cpp:979] No resources available to allocate!
I1120 02:29:18.112093 30215 hierarchical.cpp:1072] No inverse offers to send out!
I1120 02:29:18.112216 30215 hierarchical.cpp:878] Performed allocation for 0 slaves in 221806ns
I1120 02:29:18.112797 30216 scheduler.cpp:459] Enqueuing event SUBSCRIBED received from master@172.17.19.219:32778
I1120 02:29:18.113232 30216 scheduler.cpp:459] Enqueuing event HEARTBEAT received from master@172.17.19.219:32778
I1120 02:29:18.113780 30218 master_maintenance_tests.cpp:174] Ignoring HEARTBEAT event
I1120 02:29:18.113960 30222 scheduler.cpp:300] Sending REQUEST call to master@172.17.19.219:32778
I1120 02:29:18.115352 30215 process.cpp:3081] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I1120 02:29:18.115500 30215 http.cpp:338] HTTP POST for /master/api/v1/scheduler from 172.17.19.219:50180
I1120 02:29:18.115665 30215 master.cpp:2621] Processing REQUEST call for framework 9a3c9537-ca9c-4089-82a9-6c708fc361f9-0000 (default)
I1120 02:29:18.115854 30226 hierarchical.cpp:460] Received resource request from framework 9a3c9537-ca9c-4089-82a9-6c708fc361f9-0000
I1120 02:29:18.116199 30227 master.cpp:928] Master terminating
I1120 02:29:18.116436 30218 hierarchical.cpp:232] Removed framework 9a3c9537-ca9c-4089-82a9-6c708fc361f9-0000
E1120 02:29:18.117501 30220 scheduler.cpp:433] End-Of-File received from master. The master closed the event stream
[       OK ] ContentType/SchedulerTest.Request/0 (57 ms)
[ RUN      ] ContentType/SchedulerTest.Request/1
2015-11-20 02:29:18,121:30196(0x2b58e791f700):ZOO_ERROR@handle_socket_error_msg@1697: Socket [127.0.0.1:50650] zk retcode=-4, errno=111(Connection refused): server refused to accept the client
I1120 02:29:18.125919 30196 leveldb.cpp:176] Opened db in 2.766781ms
I1120 02:29:18.126821 30196 leveldb.cpp:183] Compacted db in 858699ns
I1120 02:29:18.126881 30196 leveldb.cpp:198] Created db iterator in 24042ns
I1120 02:29:18.126917 30196 leveldb.cpp:204] Seeked to beginning of db in 2578ns
I1120 02:29:18.126929 30196 leveldb.cpp:273] Iterated through 0 keys in the db in 492ns
I1120 02:29:18.126988 30196 replica.cpp:780] Replica recovered with log positions 0 -> 0 with 1 holes and 0 unlearned
I1120 02:29:18.127533 30216 recover.cpp:449] Starting replica recovery
I1120 02:29:18.127987 30216 recover.cpp:475] Replica is in EMPTY status
I1120 02:29:18.129284 30230 replica.cpp:676] Replica in EMPTY status received a broadcasted recover request from (10547)@172.17.19.219:32778
I1120 02:29:18.129763 30230 recover.cpp:195] Received a recover response from a replica in EMPTY status
I1120 02:29:18.130523 30225 recover.cpp:566] Updating replica status to STARTING
I1120 02:29:18.131266 30229 leveldb.cpp:306] Persisting metadata (8 bytes) to leveldb took 528072ns
I1120 02:29:18.131304 30229 replica.cpp:323] Persisted replica status to STARTING
I1120 02:29:18.131665 30226 recover.cpp:475] Replica is in STARTING status
I1120 02:29:18.131922 30217 master.cpp:367] Master 186ee89f-812d-43de-8e55-e789a05f7396 (dfca81f9271a) started on 172.17.19.219:32778
I1120 02:29:18.131947 30217 master.cpp:369] Flags at startup: --acls="" --allocation_interval="1secs" --allocator="HierarchicalDRF" --authenticate="false" --authenticate_slaves="true" --authenticators="crammd5" --authorizers="local" --credentials="/tmp/YUYSrO/credentials" --framework_sorter="drf" --help="false" --hostname_lookup="true" --initialize_driver_logging="true" --log_auto_initialize="true" --logbufsecs="0" --logging_level="INFO" --max_slave_ping_timeouts="5" --quiet="false" --recovery_slave_removal_limit="100%" --registry="replicated_log" --registry_fetch_timeout="1mins" --registry_store_timeout="25secs" --registry_strict="true" --root_submissions="true" --slave_ping_timeout="15secs" --slave_reregister_timeout="10mins" --user_sorter="drf" --version="false" --webui_dir="/mesos/mesos-0.26.0/_inst/share/mesos/webui" --work_dir="/tmp/YUYSrO/master" --zk_session_timeout="10secs"
I1120 02:29:18.132271 30217 master.cpp:416] Master allowing unauthenticated frameworks to register
I1120 02:29:18.132287 30217 master.cpp:419] Master only allowing authenticated slaves to register
I1120 02:29:18.132299 30217 credentials.hpp:37] Loading credentials for authentication from '/tmp/YUYSrO/credentials'
I1120 02:29:18.132555 30217 master.cpp:458] Using default 'crammd5' authenticator
I1120 02:29:18.132606 30230 replica.cpp:676] Replica in STARTING status received a broadcasted recover request from (10548)@172.17.19.219:32778
I1120 02:29:18.132729 30217 master.cpp:495] Authorization enabled
I1120 02:29:18.132962 30222 recover.cpp:195] Received a recover response from a replica in STARTING status
I1120 02:29:18.133303 30219 whitelist_watcher.cpp:79] No whitelist given
I1120 02:29:18.133319 30225 hierarchical.cpp:153] Initialized hierarchical allocator process
I1120 02:29:18.133394 30221 recover.cpp:566] Updating replica status to VOTING
I1120 02:29:18.133908 30223 leveldb.cpp:306] Persisting metadata (8 bytes) to leveldb took 279346ns
I1120 02:29:18.133932 30223 replica.cpp:323] Persisted replica status to VOTING
I1120 02:29:18.134088 30226 recover.cpp:580] Successfully joined the Paxos group
I1120 02:29:18.134291 30226 recover.cpp:464] Recover process terminated
I1120 02:29:18.135134 30218 master.cpp:1612] The newly elected leader is master@172.17.19.219:32778 with id 186ee89f-812d-43de-8e55-e789a05f7396
I1120 02:29:18.135179 30218 master.cpp:1625] Elected as the leading master!
I1120 02:29:18.135210 30218 master.cpp:1385] Recovering from registrar
I1120 02:29:18.135407 30220 registrar.cpp:309] Recovering registrar
I1120 02:29:18.136203 30219 log.cpp:661] Attempting to start the writer
I1120 02:29:18.137302 30224 replica.cpp:496] Replica received implicit promise request from (10549)@172.17.19.219:32778 with proposal 1
I1120 02:29:18.137681 30224 leveldb.cpp:306] Persisting metadata (8 bytes) to leveldb took 346979ns
I1120 02:29:18.137701 30224 replica.cpp:345] Persisted promised to 1
I1120 02:29:18.138222 30217 coordinator.cpp:240] Coordinator attempting to fill missing positions
I1120 02:29:18.139422 30217 replica.cpp:391] Replica received explicit promise request from (10550)@172.17.19.219:32778 for position 0 with proposal 2
I1120 02:29:18.139775 30217 leveldb.cpp:343] Persisting action (8 bytes) to leveldb took 314175ns
I1120 02:29:18.139797 30217 replica.cpp:715] Persisted action at 0
I1120 02:29:18.140720 30219 replica.cpp:540] Replica received write request for position 0 from (10551)@172.17.19.219:32778
I1120 02:29:18.140787 30219 leveldb.cpp:438] Reading position from leveldb took 32501ns
I1120 02:29:18.141121 30219 leveldb.cpp:343] Persisting action (14 bytes) to leveldb took 282460ns
I1120 02:29:18.141146 30219 replica.cpp:715] Persisted action at 0
I1120 02:29:18.141954 30219 replica.cpp:694] Replica received learned notice for position 0 from @0.0.0.0:0
I1120 02:29:18.142348 30219 leveldb.cpp:343] Persisting action (16 bytes) to leveldb took 307199ns
I1120 02:29:18.142372 30219 replica.cpp:715] Persisted action at 0
I1120 02:29:18.142390 30219 replica.cpp:700] Replica learned NOP action at position 0
I1120 02:29:18.143005 30229 log.cpp:677] Writer started with ending position 0
I1120 02:29:18.144223 30216 leveldb.cpp:438] Reading position from leveldb took 31805ns
I1120 02:29:18.145378 30230 registrar.cpp:342] Successfully fetched the registry (0B) in 9.916928ms
I1120 02:29:18.145505 30230 registrar.cpp:441] Applied 1 operations in 34273ns; attempting to update the 'registry'
I1120 02:29:18.146459 30220 log.cpp:685] Attempting to append 178 bytes to the log
I1120 02:29:18.146668 30222 coordinator.cpp:350] Coordinator attempting to write APPEND action at position 1
I1120 02:29:18.147569 30227 replica.cpp:540] Replica received write request for position 1 from (10552)@172.17.19.219:32778
I1120 02:29:18.148139 30227 leveldb.cpp:343] Persisting action (197 bytes) to leveldb took 492468ns
I1120 02:29:18.148175 30227 replica.cpp:715] Persisted action at 1
I1120 02:29:18.149004 30222 replica.cpp:694] Replica received learned notice for position 1 from @0.0.0.0:0
I1120 02:29:18.149376 30222 leveldb.cpp:343] Persisting action (199 bytes) to leveldb took 337254ns
I1120 02:29:18.149404 30222 replica.cpp:715] Persisted action at 1
I1120 02:29:18.149425 30222 replica.cpp:700] Replica learned APPEND action at position 1
I1120 02:29:18.150501 30217 registrar.cpp:486] Successfully updated the 'registry' in 4.930048ms
I1120 02:29:18.150652 30217 registrar.cpp:372] Successfully recovered registrar
I1120 02:29:18.150789 30219 log.cpp:704] Attempting to truncate the log to 1
I1120 02:29:18.150976 30227 coordinator.cpp:350] Coordinator attempting to write TRUNCATE action at position 2
I1120 02:29:18.151095 30225 master.cpp:1422] Recovered 0 slaves from the Registry (139B) ; allowing 10mins for slaves to re-register
I1120 02:29:18.151998 30220 replica.cpp:540] Replica received write request for position 2 from (10553)@172.17.19.219:32778
I1120 02:29:18.152420 30220 leveldb.cpp:343] Persisting action (16 bytes) to leveldb took 383813ns
I1120 02:29:18.152451 30220 replica.cpp:715] Persisted action at 2
I1120 02:29:18.153333 30226 replica.cpp:694] Replica received learned notice for position 2 from @0.0.0.0:0
I1120 02:29:18.153688 30226 leveldb.cpp:343] Persisting action (18 bytes) to leveldb took 322952ns
I1120 02:29:18.153764 30226 leveldb.cpp:401] Deleting ~1 keys from leveldb took 44806ns
I1120 02:29:18.153795 30226 replica.cpp:715] Persisted action at 2
I1120 02:29:18.153827 30226 replica.cpp:700] Replica learned TRUNCATE action at position 2
I1120 02:29:18.162045 30196 scheduler.cpp:156] Version: 0.26.0
I1120 02:29:18.162878 30219 scheduler.cpp:238] New master detected at master@172.17.19.219:32778
I1120 02:29:18.164001 30220 scheduler.cpp:300] Sending SUBSCRIBE call to master@172.17.19.219:32778
I1120 02:29:18.166378 30227 process.cpp:3081] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I1120 02:29:18.166462 30227 http.cpp:338] HTTP POST for /master/api/v1/scheduler from 172.17.19.219:50186
I1120 02:29:18.166908 30227 master.cpp:1874] Received subscription request for HTTP framework 'default'
I1120 02:29:18.166992 30227 master.cpp:1651] Authorizing framework principal 'test-principal' to receive offers for role '*'
I1120 02:29:18.167381 30221 master.cpp:1966] Subscribing framework 'default' with checkpointing disabled and capabilities [  ]
I1120 02:29:18.167876 30227 hierarchical.cpp:197] Added framework 186ee89f-812d-43de-8e55-e789a05f7396-0000
I1120 02:29:18.167939 30227 hierarchical.cpp:979] No resources available to allocate!
I1120 02:29:18.167979 30227 hierarchical.cpp:1072] No inverse offers to send out!
I1120 02:29:18.168002 30227 hierarchical.cpp:878] Performed allocation for 0 slaves in 98558ns
I1120 02:29:18.168033 30221 master.hpp:1522] Sending heartbeat to 186ee89f-812d-43de-8e55-e789a05f7396-0000
I1120 02:29:18.169381 30223 scheduler.cpp:459] Enqueuing event SUBSCRIBED received from master@172.17.19.219:32778
I1120 02:29:18.169919 30223 scheduler.cpp:459] Enqueuing event HEARTBEAT received from master@172.17.19.219:32778
I1120 02:29:18.170617 30225 master_maintenance_tests.cpp:174] Ignoring HEARTBEAT event
I1120 02:29:18.170712 30219 scheduler.cpp:300] Sending REQUEST call to master@172.17.19.219:32778
I1120 02:29:18.172747 30227 process.cpp:3081] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I1120 02:29:18.172807 30227 http.cpp:338] HTTP POST for /master/api/v1/scheduler from 172.17.19.219:50187
I1120 02:29:18.173079 30227 master.cpp:2621] Processing REQUEST call for framework 186ee89f-812d-43de-8e55-e789a05f7396-0000 (default)
I1120 02:29:18.173269 30216 hierarchical.cpp:460] Received resource request from framework 186ee89f-812d-43de-8e55-e789a05f7396-0000
I1120 02:29:18.173673 30227 master.cpp:928] Master terminating
I1120 02:29:18.173888 30222 hierarchical.cpp:232] Removed framework 186ee89f-812d-43de-8e55-e789a05f7396-0000
E1120 02:29:18.174913 30227 scheduler.cpp:433] End-Of-File received from master. The master closed the event stream
[       OK ] ContentType/SchedulerTest.Request/1 (59 ms)
[----------] 22 tests from ContentType/SchedulerTest (4163 ms total)

[----------] Global test environment tear-down
[==========] 834 tests from 114 test cases ran. (322341 ms total)
[  PASSED  ] 832 tests.
[  FAILED  ] 2 tests, listed below:
[  FAILED  ] CurlFetcherPluginTest.ValidUri
[  FAILED  ] CurlFetcherPluginTest.InvalidUri

 2 FAILED TESTS
  YOU HAVE 7 DISABLED TESTS

make[4]: *** [check-local] Error 1
make[4]: Leaving directory `/mesos/mesos-0.26.0/_build/src'
make[3]: *** [check-am] Error 2
make[3]: Leaving directory `/mesos/mesos-0.26.0/_build/src'
make[2]: *** [check] Error 2
make[2]: Leaving directory `/mesos/mesos-0.26.0/_build/src'
make[1]: *** [check-recursive] Error 1
make[1]: Leaving directory `/mesos/mesos-0.26.0/_build'
make: *** [distcheck] Error 1
+ docker rmi mesos-1447984801-31454
Untagged: mesos-1447984801-31454:latest
Deleted: 97c3a2ea372429c5babc909488c053bc10ede172a40a26cfc97601e6cfcfac24
Deleted: 22f5bf3ea741822dc112f3d1fcfa394a9900ecd5f4252b6b2798da0a3cb46f9e
Deleted: 942e001e7a4774631e9f1dbb7a9c29a856a9b71cc4c05de06c959bdb1a7b51a6
Deleted: 9fc8ec6f368bbf7e97d93ab34173baa92c4892af9d7269b4ed2dca921e2d31bb
Deleted: 4046984ae20915c1bdf2b3804da3c96c64f624ce7c0c3d8e80a262ea9ecfaf03
Deleted: fb91aad56ac374674e262f06959d76d916edaa32bbdd481e9b3eee9df49e79ff
Deleted: 0b3e093e06075425ce5a72411cbc83e6c575c93617e7f828141d8c6f1bbc9913
Deleted: 1dbfd1266d565b3ebc871d3e25cd0b2b3d3e881531316b78442d8aacdc331027
Deleted: bd7682c28adaa89e30d6a55adb0b66ade6e041ec72181594a8af1a1e93e52cb4
Deleted: 3ae34b4c9d7ff1e3021c68b61f57409e9f8acb857f1cf022f4b59b703b1172d7
Deleted: fa8058ec2d6fd3abb8c5a027935c82f75eaaa7d025e1d4a255929f1159df0219
Deleted: 68c3e0ec0e475a7c2da2b9ef2ebcb3c9fbb25b7a99f83d311b48bc6981871570
Deleted: 3735b79349d2f4db7d2f4af613001948591b00bcc33bff6c9433d65e757b8c39

Traceback (most recent call last):
  File "./support/verify_reviews.py", line 210, in <module>
    verify_review(review_request)
  File "./support/verify_reviews.py", line 139, in verify_review
    "Error:\n %s" % (applied, e.cmd, e.output))
  File "./support/verify_reviews.py", line 99, in post_review
    api(review_url, data)
  File "./support/verify_reviews.py", line 65, in api
    return json.loads(urllib2.urlopen(url, data=data).read())
  File "/usr/lib/python2.7/urllib2.py", line 127, in urlopen
    return _opener.open(url, data, timeout)
  File "/usr/lib/python2.7/urllib2.py", line 410, in open
    response = meth(req, response)
  File "/usr/lib/python2.7/urllib2.py", line 523, in http_response
    'http', request, response, code, msg, hdrs)
  File "/usr/lib/python2.7/urllib2.py", line 442, in error
    result = self._call_chain(*args)
  File "/usr/lib/python2.7/urllib2.py", line 382, in _call_chain
    result = func(*args)
  File "/usr/lib/python2.7/urllib2.py", line 897, in http_error_401
    url, req, headers)
  File "/usr/lib/python2.7/urllib2.py", line 872, in http_error_auth_reqed
    response = self.retry_http_basic_auth(host, req, realm)
  File "/usr/lib/python2.7/urllib2.py", line 885, in retry_http_basic_auth
    return self.parent.open(req, timeout=req.timeout)
  File "/usr/lib/python2.7/urllib2.py", line 410, in open
    response = meth(req, response)
  File "/usr/lib/python2.7/urllib2.py", line 523, in http_response
    'http', request, response, code, msg, hdrs)
  File "/usr/lib/python2.7/urllib2.py", line 448, in error
    return self._call_chain(*args)
  File "/usr/lib/python2.7/urllib2.py", line 382, in _call_chain
    result = func(*args)
  File "/usr/lib/python2.7/urllib2.py", line 531, in http_error_default
    raise HTTPError(req.get_full_url(), code, msg, hdrs, fp)
urllib2.HTTPError: HTTP Error 500: INTERNAL SERVER ERROR
git clean -fd
git reset --hard d78db0658f36c0afea8db04c148ea82fdbfc6d7b

Build step 'Execute shell' marked build as failure

Build failed in Jenkins: mesos-reviewbot #9790

Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/mesos-reviewbot/9790/changes>

Changes:

[yujie.jay] Error out when root qdisc already exists in port mapping isolator.

[yujie.jay] Documented --egress_unique_flow_per_container in docs/configuration.md.

[yujie.jay] Fixed a few style issues in docs/configuration.md.

------------------------------------------
[...truncated 148655 lines...]
I1120 01:28:20.611382 30234 registrar.cpp:309] Recovering registrar
I1120 01:28:20.611575 30230 recover.cpp:464] Recover process terminated
I1120 01:28:20.612217 30232 log.cpp:661] Attempting to start the writer
I1120 01:28:20.613669 30231 replica.cpp:496] Replica received implicit promise request from (10537)@172.17.19.116:44686 with proposal 1
I1120 01:28:20.614264 30231 leveldb.cpp:306] Persisting metadata (8 bytes) to leveldb took 551618ns
I1120 01:28:20.614298 30231 replica.cpp:345] Persisted promised to 1
I1120 01:28:20.614964 30235 coordinator.cpp:240] Coordinator attempting to fill missing positions
I1120 01:28:20.616307 30223 replica.cpp:391] Replica received explicit promise request from (10538)@172.17.19.116:44686 for position 0 with proposal 2
I1120 01:28:20.616930 30223 leveldb.cpp:343] Persisting action (8 bytes) to leveldb took 576264ns
I1120 01:28:20.616966 30223 replica.cpp:715] Persisted action at 0
I1120 01:28:20.618163 30233 replica.cpp:540] Replica received write request for position 0 from (10539)@172.17.19.116:44686
I1120 01:28:20.618232 30233 leveldb.cpp:438] Reading position from leveldb took 30350ns
I1120 01:28:20.618774 30233 leveldb.cpp:343] Persisting action (14 bytes) to leveldb took 494408ns
I1120 01:28:20.618803 30233 replica.cpp:715] Persisted action at 0
I1120 01:28:20.619503 30225 replica.cpp:694] Replica received learned notice for position 0 from @0.0.0.0:0
I1120 01:28:20.620101 30225 leveldb.cpp:343] Persisting action (16 bytes) to leveldb took 468394ns
I1120 01:28:20.620132 30225 replica.cpp:715] Persisted action at 0
I1120 01:28:20.620154 30225 replica.cpp:700] Replica learned NOP action at position 0
I1120 01:28:20.620874 30230 log.cpp:677] Writer started with ending position 0
I1120 01:28:20.622041 30233 leveldb.cpp:438] Reading position from leveldb took 30284ns
I1120 01:28:20.623059 30231 registrar.cpp:342] Successfully fetched the registry (0B) in 11.6224ms
I1120 01:28:20.623189 30231 registrar.cpp:441] Applied 1 operations in 27932ns; attempting to update the 'registry'
I1120 01:28:20.623975 30225 log.cpp:685] Attempting to append 178 bytes to the log
I1120 01:28:20.624111 30227 coordinator.cpp:350] Coordinator attempting to write APPEND action at position 1
I1120 01:28:20.624986 30221 replica.cpp:540] Replica received write request for position 1 from (10540)@172.17.19.116:44686
I1120 01:28:20.625537 30221 leveldb.cpp:343] Persisting action (197 bytes) to leveldb took 506456ns
I1120 01:28:20.625567 30221 replica.cpp:715] Persisted action at 1
I1120 01:28:20.626391 30231 replica.cpp:694] Replica received learned notice for position 1 from @0.0.0.0:0
I1120 01:28:20.626873 30231 leveldb.cpp:343] Persisting action (199 bytes) to leveldb took 441us
I1120 01:28:20.626909 30231 replica.cpp:715] Persisted action at 1
I1120 01:28:20.626931 30231 replica.cpp:700] Replica learned APPEND action at position 1
I1120 01:28:20.628093 30226 registrar.cpp:486] Successfully updated the 'registry' in 4.818688ms
I1120 01:28:20.628269 30226 registrar.cpp:372] Successfully recovered registrar
I1120 01:28:20.628423 30229 log.cpp:704] Attempting to truncate the log to 1
I1120 01:28:20.628590 30233 coordinator.cpp:350] Coordinator attempting to write TRUNCATE action at position 2
I1120 01:28:20.628984 30227 master.cpp:1422] Recovered 0 slaves from the Registry (139B) ; allowing 10mins for slaves to re-register
I1120 01:28:20.629649 30234 replica.cpp:540] Replica received write request for position 2 from (10541)@172.17.19.116:44686
I1120 01:28:20.630228 30234 leveldb.cpp:343] Persisting action (16 bytes) to leveldb took 535693ns
I1120 01:28:20.630265 30234 replica.cpp:715] Persisted action at 2
I1120 01:28:20.630997 30230 replica.cpp:694] Replica received learned notice for position 2 from @0.0.0.0:0
I1120 01:28:20.631563 30230 leveldb.cpp:343] Persisting action (18 bytes) to leveldb took 524210ns
I1120 01:28:20.631626 30230 leveldb.cpp:401] Deleting ~1 keys from leveldb took 33236ns
I1120 01:28:20.631650 30230 replica.cpp:715] Persisted action at 2
I1120 01:28:20.631680 30230 replica.cpp:700] Replica learned TRUNCATE action at position 2
I1120 01:28:20.639915 30201 scheduler.cpp:156] Version: 0.26.0
I1120 01:28:20.640614 30232 scheduler.cpp:238] New master detected at master@172.17.19.116:44686
I1120 01:28:20.641942 30226 scheduler.cpp:300] Sending SUBSCRIBE call to master@172.17.19.116:44686
I1120 01:28:20.643903 30229 process.cpp:3081] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I1120 01:28:20.643970 30229 http.cpp:338] HTTP POST for /master/api/v1/scheduler from 172.17.19.116:44325
I1120 01:28:20.644167 30229 master.cpp:1874] Received subscription request for HTTP framework 'default'
I1120 01:28:20.644237 30229 master.cpp:1651] Authorizing framework principal 'test-principal' to receive offers for role '*'
I1120 01:28:20.644526 30229 master.cpp:1966] Subscribing framework 'default' with checkpointing disabled and capabilities [  ]
I1120 01:28:20.644950 30227 hierarchical.cpp:197] Added framework 78e21bb1-06ee-4c5f-9c8e-59273f3e7605-0000
I1120 01:28:20.645015 30227 hierarchical.cpp:979] No resources available to allocate!
I1120 01:28:20.645023 30230 master.hpp:1522] Sending heartbeat to 78e21bb1-06ee-4c5f-9c8e-59273f3e7605-0000
I1120 01:28:20.645059 30227 hierarchical.cpp:1072] No inverse offers to send out!
I1120 01:28:20.645092 30227 hierarchical.cpp:878] Performed allocation for 0 slaves in 106672ns
I1120 01:28:20.646004 30229 scheduler.cpp:459] Enqueuing event SUBSCRIBED received from master@172.17.19.116:44686
I1120 01:28:20.646566 30229 scheduler.cpp:459] Enqueuing event HEARTBEAT received from master@172.17.19.116:44686
I1120 01:28:20.647408 30227 master_maintenance_tests.cpp:174] Ignoring HEARTBEAT event
I1120 01:28:20.647516 30229 scheduler.cpp:300] Sending REQUEST call to master@172.17.19.116:44686
I1120 01:28:20.649405 30224 process.cpp:3081] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I1120 01:28:20.649469 30224 http.cpp:338] HTTP POST for /master/api/v1/scheduler from 172.17.19.116:44326
I1120 01:28:20.649574 30224 master.cpp:2621] Processing REQUEST call for framework 78e21bb1-06ee-4c5f-9c8e-59273f3e7605-0000 (default)
I1120 01:28:20.649772 30232 hierarchical.cpp:460] Received resource request from framework 78e21bb1-06ee-4c5f-9c8e-59273f3e7605-0000
I1120 01:28:20.650167 30201 master.cpp:928] Master terminating
I1120 01:28:20.650370 30221 hierarchical.cpp:232] Removed framework 78e21bb1-06ee-4c5f-9c8e-59273f3e7605-0000
E1120 01:28:20.651857 30228 scheduler.cpp:433] End-Of-File received from master. The master closed the event stream
[       OK ] ContentType/SchedulerTest.Request/0 (60 ms)
[ RUN      ] ContentType/SchedulerTest.Request/1
I1120 01:28:20.661361 30201 leveldb.cpp:176] Opened db in 2.893427ms
I1120 01:28:20.662418 30201 leveldb.cpp:183] Compacted db in 1.014826ms
I1120 01:28:20.662484 30201 leveldb.cpp:198] Created db iterator in 20444ns
I1120 01:28:20.662529 30201 leveldb.cpp:204] Seeked to beginning of db in 2377ns
I1120 01:28:20.662554 30201 leveldb.cpp:273] Iterated through 0 keys in the db in 503ns
I1120 01:28:20.662611 30201 replica.cpp:780] Replica recovered with log positions 0 -> 0 with 1 holes and 0 unlearned
I1120 01:28:20.663194 30222 recover.cpp:449] Starting replica recovery
I1120 01:28:20.663585 30222 recover.cpp:475] Replica is in EMPTY status
I1120 01:28:20.664716 30230 replica.cpp:676] Replica in EMPTY status received a broadcasted recover request from (10546)@172.17.19.116:44686
I1120 01:28:20.665200 30225 recover.cpp:195] Received a recover response from a replica in EMPTY status
I1120 01:28:20.665715 30228 recover.cpp:566] Updating replica status to STARTING
I1120 01:28:20.666554 30233 leveldb.cpp:306] Persisting metadata (8 bytes) to leveldb took 556400ns
I1120 01:28:20.666589 30233 replica.cpp:323] Persisted replica status to STARTING
I1120 01:28:20.667019 30229 master.cpp:367] Master 0659dd7e-147f-42d5-8097-c1e6b449fe40 (5479c9c08832) started on 172.17.19.116:44686
I1120 01:28:20.667106 30227 recover.cpp:475] Replica is in STARTING status
I1120 01:28:20.667044 30229 master.cpp:369] Flags at startup: --acls="" --allocation_interval="1secs" --allocator="HierarchicalDRF" --authenticate="false" --authenticate_slaves="true" --authenticators="crammd5" --authorizers="local" --credentials="/tmp/VK1dFN/credentials" --framework_sorter="drf" --help="false" --hostname_lookup="true" --initialize_driver_logging="true" --log_auto_initialize="true" --logbufsecs="0" --logging_level="INFO" --max_slave_ping_timeouts="5" --quiet="false" --recovery_slave_removal_limit="100%" --registry="replicated_log" --registry_fetch_timeout="1mins" --registry_store_timeout="25secs" --registry_strict="true" --root_submissions="true" --slave_ping_timeout="15secs" --slave_reregister_timeout="10mins" --user_sorter="drf" --version="false" --webui_dir="/mesos/mesos-0.26.0/_inst/share/mesos/webui" --work_dir="/tmp/VK1dFN/master" --zk_session_timeout="10secs"
I1120 01:28:20.667402 30229 master.cpp:416] Master allowing unauthenticated frameworks to register
I1120 01:28:20.667418 30229 master.cpp:419] Master only allowing authenticated slaves to register
I1120 01:28:20.667428 30229 credentials.hpp:37] Loading credentials for authentication from '/tmp/VK1dFN/credentials'
I1120 01:28:20.667716 30229 master.cpp:458] Using default 'crammd5' authenticator
I1120 01:28:20.667906 30229 master.cpp:495] Authorization enabled
I1120 01:28:20.668238 30228 whitelist_watcher.cpp:79] No whitelist given
I1120 01:28:20.668246 30224 hierarchical.cpp:153] Initialized hierarchical allocator process
I1120 01:28:20.668320 30227 replica.cpp:676] Replica in STARTING status received a broadcasted recover request from (10547)@172.17.19.116:44686
I1120 01:28:20.669039 30220 recover.cpp:195] Received a recover response from a replica in STARTING status
I1120 01:28:20.669623 30231 recover.cpp:566] Updating replica status to VOTING
I1120 01:28:20.670428 30224 leveldb.cpp:306] Persisting metadata (8 bytes) to leveldb took 535007ns
I1120 01:28:20.670467 30228 master.cpp:1612] The newly elected leader is master@172.17.19.116:44686 with id 0659dd7e-147f-42d5-8097-c1e6b449fe40
I1120 01:28:20.670465 30224 replica.cpp:323] Persisted replica status to VOTING
I1120 01:28:20.670507 30228 master.cpp:1625] Elected as the leading master!
I1120 01:28:20.670527 30228 master.cpp:1385] Recovering from registrar
I1120 01:28:20.670706 30227 recover.cpp:580] Successfully joined the Paxos group
I1120 01:28:20.670759 30224 registrar.cpp:309] Recovering registrar
I1120 01:28:20.671291 30227 recover.cpp:464] Recover process terminated
I1120 01:28:20.671808 30231 log.cpp:661] Attempting to start the writer
I1120 01:28:20.673369 30226 replica.cpp:496] Replica received implicit promise request from (10548)@172.17.19.116:44686 with proposal 1
I1120 01:28:20.673809 30226 leveldb.cpp:306] Persisting metadata (8 bytes) to leveldb took 397395ns
I1120 01:28:20.673861 30226 replica.cpp:345] Persisted promised to 1
I1120 01:28:20.674495 30220 coordinator.cpp:240] Coordinator attempting to fill missing positions
I1120 01:28:20.675976 30235 replica.cpp:391] Replica received explicit promise request from (10549)@172.17.19.116:44686 for position 0 with proposal 2
I1120 01:28:20.676434 30235 leveldb.cpp:343] Persisting action (8 bytes) to leveldb took 409260ns
I1120 01:28:20.676465 30235 replica.cpp:715] Persisted action at 0
I1120 01:28:20.677698 30223 replica.cpp:540] Replica received write request for position 0 from (10550)@172.17.19.116:44686
I1120 01:28:20.677767 30223 leveldb.cpp:438] Reading position from leveldb took 31297ns
I1120 01:28:20.678184 30223 leveldb.cpp:343] Persisting action (14 bytes) to leveldb took 369619ns
I1120 01:28:20.678216 30223 replica.cpp:715] Persisted action at 0
I1120 01:28:20.678922 30222 replica.cpp:694] Replica received learned notice for position 0 from @0.0.0.0:0
I1120 01:28:20.679414 30222 leveldb.cpp:343] Persisting action (16 bytes) to leveldb took 389221ns
I1120 01:28:20.679445 30222 replica.cpp:715] Persisted action at 0
I1120 01:28:20.679466 30222 replica.cpp:700] Replica learned NOP action at position 0
I1120 01:28:20.680013 30223 log.cpp:677] Writer started with ending position 0
I1120 01:28:20.681159 30230 leveldb.cpp:438] Reading position from leveldb took 35057ns
I1120 01:28:20.682163 30222 registrar.cpp:342] Successfully fetched the registry (0B) in 11.3472ms
I1120 01:28:20.682345 30222 registrar.cpp:441] Applied 1 operations in 26202ns; attempting to update the 'registry'
I1120 01:28:20.683145 30221 log.cpp:685] Attempting to append 178 bytes to the log
I1120 01:28:20.683342 30235 coordinator.cpp:350] Coordinator attempting to write APPEND action at position 1
I1120 01:28:20.684170 30220 replica.cpp:540] Replica received write request for position 1 from (10551)@172.17.19.116:44686
I1120 01:28:20.684603 30220 leveldb.cpp:343] Persisting action (197 bytes) to leveldb took 390086ns
I1120 01:28:20.684633 30220 replica.cpp:715] Persisted action at 1
I1120 01:28:20.685538 30230 replica.cpp:694] Replica received learned notice for position 1 from @0.0.0.0:0
I1120 01:28:20.686074 30230 leveldb.cpp:343] Persisting action (199 bytes) to leveldb took 494753ns
I1120 01:28:20.686110 30230 replica.cpp:715] Persisted action at 1
I1120 01:28:20.686133 30230 replica.cpp:700] Replica learned APPEND action at position 1
I1120 01:28:20.687213 30232 registrar.cpp:486] Successfully updated the 'registry' in 4.803072ms
I1120 01:28:20.687366 30232 registrar.cpp:372] Successfully recovered registrar
I1120 01:28:20.687551 30225 log.cpp:704] Attempting to truncate the log to 1
I1120 01:28:20.687778 30228 master.cpp:1422] Recovered 0 slaves from the Registry (139B) ; allowing 10mins for slaves to re-register
I1120 01:28:20.688172 30226 coordinator.cpp:350] Coordinator attempting to write TRUNCATE action at position 2
I1120 01:28:20.689105 30225 replica.cpp:540] Replica received write request for position 2 from (10552)@172.17.19.116:44686
I1120 01:28:20.689563 30225 leveldb.cpp:343] Persisting action (16 bytes) to leveldb took 414698ns
I1120 01:28:20.689594 30225 replica.cpp:715] Persisted action at 2
I1120 01:28:20.690472 30235 replica.cpp:694] Replica received learned notice for position 2 from @0.0.0.0:0
I1120 01:28:20.691157 30235 leveldb.cpp:343] Persisting action (18 bytes) to leveldb took 648655ns
I1120 01:28:20.691236 30235 leveldb.cpp:401] Deleting ~1 keys from leveldb took 44144ns
I1120 01:28:20.691259 30235 replica.cpp:715] Persisted action at 2
I1120 01:28:20.691282 30235 replica.cpp:700] Replica learned TRUNCATE action at position 2
I1120 01:28:20.698750 30201 scheduler.cpp:156] Version: 0.26.0
I1120 01:28:20.699467 30225 scheduler.cpp:238] New master detected at master@172.17.19.116:44686
I1120 01:28:20.700784 30233 scheduler.cpp:300] Sending SUBSCRIBE call to master@172.17.19.116:44686
I1120 01:28:20.702895 30227 process.cpp:3081] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I1120 01:28:20.703033 30227 http.cpp:338] HTTP POST for /master/api/v1/scheduler from 172.17.19.116:44327
I1120 01:28:20.703411 30227 master.cpp:1874] Received subscription request for HTTP framework 'default'
I1120 01:28:20.703482 30227 master.cpp:1651] Authorizing framework principal 'test-principal' to receive offers for role '*'
I1120 01:28:20.703804 30227 master.cpp:1966] Subscribing framework 'default' with checkpointing disabled and capabilities [  ]
I1120 01:28:20.704203 30226 hierarchical.cpp:197] Added framework 0659dd7e-147f-42d5-8097-c1e6b449fe40-0000
I1120 01:28:20.704264 30226 hierarchical.cpp:979] No resources available to allocate!
I1120 01:28:20.704344 30226 hierarchical.cpp:1072] No inverse offers to send out!
I1120 01:28:20.704344 30220 master.hpp:1522] Sending heartbeat to 0659dd7e-147f-42d5-8097-c1e6b449fe40-0000
I1120 01:28:20.704390 30226 hierarchical.cpp:878] Performed allocation for 0 slaves in 153956ns
I1120 01:28:20.705595 30230 scheduler.cpp:459] Enqueuing event SUBSCRIBED received from master@172.17.19.116:44686
I1120 01:28:20.706164 30230 scheduler.cpp:459] Enqueuing event HEARTBEAT received from master@172.17.19.116:44686
I1120 01:28:20.706883 30224 master_maintenance_tests.cpp:174] Ignoring HEARTBEAT event
I1120 01:28:20.706967 30230 scheduler.cpp:300] Sending REQUEST call to master@172.17.19.116:44686
I1120 01:28:20.708746 30226 process.cpp:3081] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I1120 01:28:20.708858 30226 http.cpp:338] HTTP POST for /master/api/v1/scheduler from 172.17.19.116:44328
I1120 01:28:20.709115 30226 master.cpp:2621] Processing REQUEST call for framework 0659dd7e-147f-42d5-8097-c1e6b449fe40-0000 (default)
I1120 01:28:20.709271 30224 hierarchical.cpp:460] Received resource request from framework 0659dd7e-147f-42d5-8097-c1e6b449fe40-0000
I1120 01:28:20.709560 30230 master.cpp:928] Master terminating
I1120 01:28:20.709749 30228 hierarchical.cpp:232] Removed framework 0659dd7e-147f-42d5-8097-c1e6b449fe40-0000
E1120 01:28:20.711026 30226 scheduler.cpp:433] End-Of-File received from master. The master closed the event stream
[       OK ] ContentType/SchedulerTest.Request/1 (58 ms)
[----------] 22 tests from ContentType/SchedulerTest (4087 ms total)

[----------] Global test environment tear-down
2015-11-20 01:28:20,784:30201(0x2b04eac79700):ZOO_ERROR@handle_socket_error_msg@1697: Socket [127.0.0.1:57859] zk retcode=-4, errno=111(Connection refused): server refused to accept the client
[==========] 834 tests from 114 test cases ran. (320470 ms total)
[  PASSED  ] 832 tests.
[  FAILED  ] 2 tests, listed below:
[  FAILED  ] CurlFetcherPluginTest.ValidUri
[  FAILED  ] CurlFetcherPluginTest.InvalidUri

 2 FAILED TESTS
  YOU HAVE 7 DISABLED TESTS

make[4]: *** [check-local] Error 1
make[4]: Leaving directory `/mesos/mesos-0.26.0/_build/src'
make[3]: *** [check-am] Error 2
make[3]: Leaving directory `/mesos/mesos-0.26.0/_build/src'
make[2]: *** [check] Error 2
make[2]: Leaving directory `/mesos/mesos-0.26.0/_build/src'
make[1]: *** [check-recursive] Error 1
make[1]: Leaving directory `/mesos/mesos-0.26.0/_build'
make: *** [distcheck] Error 1
+ docker rmi mesos-1447981195-25127
Untagged: mesos-1447981195-25127:latest
Deleted: 541c1ed1c010d3162f62d6891367dd504c7fd5b6aa979c739c6a83d11c944af4
Deleted: 0399cd46b19b167c633527177b15e3356dc425e0141ac0b0ee96aad7eb4bc543
Deleted: 6a78b09e65c1faeca2e1c17d82290dcf153ab9c0870707afdce5a973fad0d243
Deleted: b50d22b0bafd917590266a42e819e1f62437c4783dd89192c20962adb18dfd91
Deleted: 711ebec8e9bf109112e7b5e26a64a3bd1ee039cafba59e9bd96b2fa9d293591d
Deleted: c90fe3736accf835631c25fba14c8582b8b214a1ea54f7539b738eb2322641ec
Deleted: 1b81bdfb9d1584d616145e726be2a6f1c1875e03596461eb986eb17c067125ae
Deleted: 848b3b4377685048b2fe200147936e44916fecf35bd6f266f39e96a9c07b089d
Deleted: 506ed2b9cf7f5a014e479a6aba3ce108916676af5b193290bc2d1591c3f9b6a8
Deleted: 5c124e5e1aa5f9bcbcb0ec2b71e362708565eb66d42c984cd1ddbce54e863d5b
Deleted: 90f554044c1f6d28b4c606feeb7232cbe488f69204a9e637e4462940f250b4bd
Deleted: eb7e1ecc67b264a020b9b99bbda86fb6bfbcf3c4c425caaac63d392521c029ae
Deleted: 2c516e9bb692129893b2ef85f04540911438803c380e302034b2c1352e39f1fd

Traceback (most recent call last):
  File "./support/verify_reviews.py", line 210, in <module>
    verify_review(review_request)
  File "./support/verify_reviews.py", line 139, in verify_review
    "Error:\n %s" % (applied, e.cmd, e.output))
  File "./support/verify_reviews.py", line 99, in post_review
    api(review_url, data)
  File "./support/verify_reviews.py", line 65, in api
    return json.loads(urllib2.urlopen(url, data=data).read())
  File "/usr/lib/python2.7/urllib2.py", line 127, in urlopen
    return _opener.open(url, data, timeout)
  File "/usr/lib/python2.7/urllib2.py", line 410, in open
    response = meth(req, response)
  File "/usr/lib/python2.7/urllib2.py", line 523, in http_response
    'http', request, response, code, msg, hdrs)
  File "/usr/lib/python2.7/urllib2.py", line 442, in error
    result = self._call_chain(*args)
  File "/usr/lib/python2.7/urllib2.py", line 382, in _call_chain
    result = func(*args)
  File "/usr/lib/python2.7/urllib2.py", line 897, in http_error_401
    url, req, headers)
  File "/usr/lib/python2.7/urllib2.py", line 872, in http_error_auth_reqed
    response = self.retry_http_basic_auth(host, req, realm)
  File "/usr/lib/python2.7/urllib2.py", line 885, in retry_http_basic_auth
    return self.parent.open(req, timeout=req.timeout)
  File "/usr/lib/python2.7/urllib2.py", line 410, in open
    response = meth(req, response)
  File "/usr/lib/python2.7/urllib2.py", line 523, in http_response
    'http', request, response, code, msg, hdrs)
  File "/usr/lib/python2.7/urllib2.py", line 448, in error
    return self._call_chain(*args)
  File "/usr/lib/python2.7/urllib2.py", line 382, in _call_chain
    result = func(*args)
  File "/usr/lib/python2.7/urllib2.py", line 531, in http_error_default
    raise HTTPError(req.get_full_url(), code, msg, hdrs, fp)
urllib2.HTTPError: HTTP Error 500: INTERNAL SERVER ERROR
git clean -fd
git reset --hard 80b8a974cd757fc2a6f1dee99f3b99adcda99b58

Build step 'Execute shell' marked build as failure