mesos-dev mailing list archives

Site index · List index
Message view « Date » · « Thread »
Top « Date » · « Thread »
From Apache Jenkins Server <jenk...@builds.apache.org>
Subject Build failed in Jenkins: Mesos-Trunk-Ubuntu-Build-In-Src-Set-JAVA_HOME #2257
Date Fri, 07 Nov 2014 03:35:46 GMT
See <https://builds.apache.org/job/Mesos-Trunk-Ubuntu-Build-In-Src-Set-JAVA_HOME/2257/changes>

Changes:

[vinodkone] Updated scheduler driver to exponentially backoff during registration

------------------------------------------
[...truncated 70446 lines...]
2014-11-07 03:34:49,335:19187(0x2ae0adb1e700):ZOO_INFO@zookeeper_init@786: Initiating client
connection, host=127.0.0.1:48480 sessionTimeout=10000 watcher=0x2ae0a923a2ca sessionId=0 sessionPasswd=<null>
context=0x2ae0f40a0100 flags=0
2014-11-07 03:34:49,335:19187(0x2ae468a04700):ZOO_INFO@check_events@1703: initiated connection
to server [127.0.0.1:48480]
2014-11-07 03:34:49,338:19187(0x2ae468a04700):ZOO_INFO@check_events@1750: session establishment
complete on server [127.0.0.1:48480], sessionId=0x149885198b90000, negotiated timeout=10000
2014-11-07 03:34:49,353:19187(0x2ae0ae925700):ZOO_INFO@zookeeper_close@2505: Closing zookeeper
sessionId=0x149885198b90000 to [127.0.0.1:48480]

I1107 03:34:49.354049 19187 zookeeper_test_server.cpp:118] Shutting down ZooKeeperTestServer
on port 48480
[       OK ] ZooKeeperStateTest.FetchAndStoreAndStoreFailAndFetch (84 ms)
[ RUN      ] ZooKeeperStateTest.Names
I1107 03:34:49.359802 19187 zookeeper_test_server.cpp:158] Started ZooKeeperTestServer on
port 45825
2014-11-07 03:34:49,360:19187(0x2ae0af52b700):ZOO_INFO@log_env@712: Client environment:zookeeper.version=zookeeper
C client 3.4.5
2014-11-07 03:34:49,360:19187(0x2ae0af52b700):ZOO_INFO@log_env@716: Client environment:host.name=pomona.apache.org
2014-11-07 03:34:49,360:19187(0x2ae0af52b700):ZOO_INFO@log_env@723: Client environment:os.name=Linux
2014-11-07 03:34:49,360:19187(0x2ae0af52b700):ZOO_INFO@log_env@724: Client environment:os.arch=3.13.0-36-lowlatency
2014-11-07 03:34:49,360:19187(0x2ae0af52b700):ZOO_INFO@log_env@725: Client environment:os.version=#63-Ubuntu
SMP PREEMPT Wed Sep 3 21:56:12 UTC 2014
2014-11-07 03:34:49,360:19187(0x2ae0af52b700):ZOO_INFO@log_env@733: Client environment:user.name=jenkins
2014-11-07 03:34:49,360:19187(0x2ae0af52b700):ZOO_INFO@log_env@741: Client environment:user.home=/home/jenkins
2014-11-07 03:34:49,360:19187(0x2ae0af52b700):ZOO_INFO@log_env@753: Client environment:user.dir=<https://builds.apache.org/job/Mesos-Trunk-Ubuntu-Build-In-Src-Set-JAVA_HOME/ws/src>
2014-11-07 03:34:49,360:19187(0x2ae0af52b700):ZOO_INFO@zookeeper_init@786: Initiating client
connection, host=127.0.0.1:45825 sessionTimeout=10000 watcher=0x2ae0a923a2ca sessionId=0 sessionPasswd=<null>
context=0x2ae0e808c7d0 flags=0
2014-11-07 03:34:49,360:19187(0x2ae468a04700):ZOO_INFO@check_events@1703: initiated connection
to server [127.0.0.1:45825]
2014-11-07 03:34:49,363:19187(0x2ae468a04700):ZOO_INFO@check_events@1750: session establishment
complete on server [127.0.0.1:45825], sessionId=0x1498851990e0000, negotiated timeout=10000
2014-11-07 03:34:49,374:19187(0x2ae0adb1e700):ZOO_INFO@zookeeper_close@2505: Closing zookeeper
sessionId=0x1498851990e0000 to [127.0.0.1:45825]

I1107 03:34:49.374914 19187 zookeeper_test_server.cpp:118] Shutting down ZooKeeperTestServer
on port 45825
[       OK ] ZooKeeperStateTest.Names (21 ms)
[ RUN      ] ZooKeeperStateTest.FetchAndStoreAndStoreAndFetch
I1107 03:34:49.380270 19187 zookeeper_test_server.cpp:158] Started ZooKeeperTestServer on
port 34105
2014-11-07 03:34:49,380:19187(0x2ae0ae724700):ZOO_INFO@log_env@712: Client environment:zookeeper.version=zookeeper
C client 3.4.5
2014-11-07 03:34:49,380:19187(0x2ae0ae724700):ZOO_INFO@log_env@716: Client environment:host.name=pomona.apache.org
2014-11-07 03:34:49,380:19187(0x2ae0ae724700):ZOO_INFO@log_env@723: Client environment:os.name=Linux
2014-11-07 03:34:49,380:19187(0x2ae0ae724700):ZOO_INFO@log_env@724: Client environment:os.arch=3.13.0-36-lowlatency
2014-11-07 03:34:49,380:19187(0x2ae0ae724700):ZOO_INFO@log_env@725: Client environment:os.version=#63-Ubuntu
SMP PREEMPT Wed Sep 3 21:56:12 UTC 2014
2014-11-07 03:34:49,380:19187(0x2ae0ae724700):ZOO_INFO@log_env@733: Client environment:user.name=jenkins
2014-11-07 03:34:49,380:19187(0x2ae0ae724700):ZOO_INFO@log_env@741: Client environment:user.home=/home/jenkins
2014-11-07 03:34:49,380:19187(0x2ae0ae724700):ZOO_INFO@log_env@753: Client environment:user.dir=<https://builds.apache.org/job/Mesos-Trunk-Ubuntu-Build-In-Src-Set-JAVA_HOME/ws/src>
2014-11-07 03:34:49,380:19187(0x2ae0ae724700):ZOO_INFO@zookeeper_init@786: Initiating client
connection, host=127.0.0.1:34105 sessionTimeout=10000 watcher=0x2ae0a923a2ca sessionId=0 sessionPasswd=<null>
context=0x2ae0e808c7d0 flags=0
2014-11-07 03:34:49,381:19187(0x2ae468a04700):ZOO_INFO@check_events@1703: initiated connection
to server [127.0.0.1:34105]
2014-11-07 03:34:49,383:19187(0x2ae468a04700):ZOO_INFO@check_events@1750: session establishment
complete on server [127.0.0.1:34105], sessionId=0x149885199230000, negotiated timeout=10000
2014-11-07 03:34:49,403:19187(0x2ae0af32a700):ZOO_INFO@zookeeper_close@2505: Closing zookeeper
sessionId=0x149885199230000 to [127.0.0.1:34105]

I1107 03:34:49.403419 19187 zookeeper_test_server.cpp:118] Shutting down ZooKeeperTestServer
on port 34105
[       OK ] ZooKeeperStateTest.FetchAndStoreAndStoreAndFetch (28 ms)
[----------] 7 tests from ZooKeeperStateTest (313 ms total)

[----------] 1 test from MasterContenderDetectorTest
[ RUN      ] MasterContenderDetectorTest.File
Using temporary directory '/tmp/MasterContenderDetectorTest_File_MC0uYR'
I1107 03:34:49.409931 19187 leveldb.cpp:176] Opened db in 3.039696ms
I1107 03:34:49.411093 19187 leveldb.cpp:183] Compacted db in 1.128784ms
I1107 03:34:49.411136 19187 leveldb.cpp:198] Created db iterator in 5930ns
I1107 03:34:49.411154 19187 leveldb.cpp:204] Seeked to beginning of db in 830ns
I1107 03:34:49.411164 19187 leveldb.cpp:273] Iterated through 0 keys in the db in 362ns
I1107 03:34:49.411206 19187 replica.cpp:741] Replica recovered with log positions 0 ->
0 with 1 holes and 0 unlearned
I1107 03:34:49.411751 19201 recover.cpp:437] Starting replica recovery
I1107 03:34:49.412052 19201 recover.cpp:463] Replica is in EMPTY status
I1107 03:34:49.413154 19204 replica.cpp:638] Replica in EMPTY status received a broadcasted
recover request
I1107 03:34:49.413694 19205 recover.cpp:188] Received a recover response from a replica in
EMPTY status
I1107 03:34:49.414175 19202 recover.cpp:554] Updating replica status to STARTING
I1107 03:34:49.415038 19204 leveldb.cpp:306] Persisting metadata (8 bytes) to leveldb took
735680ns
I1107 03:34:49.415060 19204 replica.cpp:320] Persisted replica status to STARTING
I1107 03:34:49.415237 19206 recover.cpp:463] Replica is in STARTING status
I1107 03:34:49.416031 19205 master.cpp:318] Master 20141107-033449-3142697795-60759-19187
(pomona.apache.org) started on 67.195.81.187:60759
I1107 03:34:49.416075 19205 master.cpp:364] Master only allowing authenticated frameworks
to register
I1107 03:34:49.416090 19205 master.cpp:369] Master only allowing authenticated slaves to register
I1107 03:34:49.416120 19205 credentials.hpp:36] Loading credentials for authentication from
'/tmp/MasterContenderDetectorTest_File_MC0uYR/credentials'
I1107 03:34:49.416136 19211 replica.cpp:638] Replica in STARTING status received a broadcasted
recover request
I1107 03:34:49.416424 19205 master.cpp:408] Authorization enabled
I1107 03:34:49.416422 19204 recover.cpp:188] Received a recover response from a replica in
STARTING status
I1107 03:34:49.416760 19202 recover.cpp:554] Updating replica status to VOTING
I1107 03:34:49.416851 19209 master.cpp:126] No whitelist given. Advertising offers for all
slaves
I1107 03:34:49.416982 19203 hierarchical_allocator_process.hpp:299] Initializing hierarchical
allocator process with master : master@67.195.81.187:60759
I1107 03:34:49.417413 19215 leveldb.cpp:306] Persisting metadata (8 bytes) to leveldb took
544537ns
I1107 03:34:49.417438 19215 replica.cpp:320] Persisted replica status to VOTING
I1107 03:34:49.417549 19202 recover.cpp:568] Successfully joined the Paxos group
I1107 03:34:49.417732 19202 recover.cpp:452] Recover process terminated
I1107 03:34:49.418016 19216 master.cpp:1258] The newly elected leader is master@67.195.81.187:60759
with id 20141107-033449-3142697795-60759-19187
I1107 03:34:49.418040 19216 master.cpp:1271] Elected as the leading master!
I1107 03:34:49.418057 19216 master.cpp:1089] Recovering from registrar
I1107 03:34:49.526754 19210 registrar.cpp:313] Recovering registrar
I1107 03:34:49.527593 19211 log.cpp:656] Attempting to start the writer
I1107 03:34:49.528934 19204 replica.cpp:474] Replica received implicit promise request with
proposal 1
I1107 03:34:49.529721 19204 leveldb.cpp:306] Persisting metadata (8 bytes) to leveldb took
757169ns
I1107 03:34:49.529747 19204 replica.cpp:342] Persisted promised to 1
I1107 03:34:49.530339 19215 coordinator.cpp:230] Coordinator attemping to fill missing position
I1107 03:34:49.531711 19206 replica.cpp:375] Replica received explicit promise request for
position 0 with proposal 2
I1107 03:34:49.532320 19206 leveldb.cpp:343] Persisting action (8 bytes) to leveldb took 576274ns
I1107 03:34:49.532338 19206 replica.cpp:676] Persisted action at 0
I1107 03:34:49.533443 19201 replica.cpp:508] Replica received write request for position 0
I1107 03:34:49.533486 19201 leveldb.cpp:438] Reading position from leveldb took 22601ns
I1107 03:34:49.534031 19201 leveldb.cpp:343] Persisting action (14 bytes) to leveldb took
517504ns
I1107 03:34:49.534050 19201 replica.cpp:676] Persisted action at 0
I1107 03:34:49.534503 19204 replica.cpp:655] Replica received learned notice for position
0
I1107 03:34:49.535070 19204 leveldb.cpp:343] Persisting action (16 bytes) to leveldb took
544284ns
I1107 03:34:49.535089 19204 replica.cpp:676] Persisted action at 0
I1107 03:34:49.535102 19204 replica.cpp:661] Replica learned NOP action at position 0
I1107 03:34:49.535609 19203 log.cpp:672] Writer started with ending position 0
I1107 03:34:49.536766 19208 leveldb.cpp:438] Reading position from leveldb took 19755ns
I1107 03:34:49.539250 19209 registrar.cpp:346] Successfully fetched the registry (0B) in 12.43904ms
I1107 03:34:49.539397 19209 registrar.cpp:445] Applied 1 operations in 22476ns; attempting
to update the 'registry'
I1107 03:34:49.541635 19215 log.cpp:680] Attempting to append 139 bytes to the log
I1107 03:34:49.541785 19205 coordinator.cpp:340] Coordinator attempting to write APPEND action
at position 1
I1107 03:34:49.542486 19206 replica.cpp:508] Replica received write request for position 1
I1107 03:34:49.543081 19206 leveldb.cpp:343] Persisting action (158 bytes) to leveldb took
566441ns
I1107 03:34:49.543100 19206 replica.cpp:676] Persisted action at 1
I1107 03:34:49.543669 19201 replica.cpp:655] Replica received learned notice for position
1
I1107 03:34:49.544338 19201 leveldb.cpp:343] Persisting action (160 bytes) to leveldb took
646684ns
I1107 03:34:49.544358 19201 replica.cpp:676] Persisted action at 1
I1107 03:34:49.544373 19201 replica.cpp:661] Replica learned APPEND action at position 1
I1107 03:34:49.545184 19215 registrar.cpp:490] Successfully updated the 'registry' in 5.74208ms
I1107 03:34:49.545299 19215 registrar.cpp:376] Successfully recovered registrar
I1107 03:34:49.545522 19206 log.cpp:699] Attempting to truncate the log to 1
I1107 03:34:49.545531 19208 master.cpp:1116] Recovered 0 slaves from the Registry (101B) ;
allowing 10mins for slaves to re-register
I1107 03:34:49.545663 19202 coordinator.cpp:340] Coordinator attempting to write TRUNCATE
action at position 2
I1107 03:34:49.546414 19205 replica.cpp:508] Replica received write request for position 2
I1107 03:34:49.546975 19205 leveldb.cpp:343] Persisting action (16 bytes) to leveldb took
535160ns
I1107 03:34:49.546995 19205 replica.cpp:676] Persisted action at 2
I1107 03:34:49.547615 19216 replica.cpp:655] Replica received learned notice for position
2
I1107 03:34:49.548393 19216 leveldb.cpp:343] Persisting action (18 bytes) to leveldb took
746894ns
I1107 03:34:49.548455 19216 leveldb.cpp:401] Deleting ~1 keys from leveldb took 32505ns
I1107 03:34:49.548478 19216 replica.cpp:676] Persisted action at 2
I1107 03:34:49.548504 19216 replica.cpp:661] Replica learned TRUNCATE action at position 2
I1107 03:34:49.560914 19187 containerizer.cpp:100] Using isolation: posix/cpu,posix/mem
I1107 03:34:49.562712 19203 slave.cpp:169] Slave started on 223)@67.195.81.187:60759
I1107 03:34:49.562752 19203 credentials.hpp:84] Loading credential for authentication from
'/tmp/MasterContenderDetectorTest_File_D26k38/credential'
I1107 03:34:49.562916 19203 slave.cpp:276] Slave using credential for: test-principal
I1107 03:34:49.563202 19203 slave.cpp:289] Slave resources: cpus(*):2; mem(*):1024; disk(*):1024;
ports(*):[31000-32000]
I1107 03:34:49.563321 19203 slave.cpp:318] Slave hostname: pomona.apache.org
I1107 03:34:49.563340 19203 slave.cpp:319] Slave checkpoint: false
W1107 03:34:49.563349 19203 slave.cpp:321] Disabling checkpointing is deprecated and the --checkpoint
flag will be removed in a future release. Please avoid using this flag
I1107 03:34:49.564355 19216 state.cpp:33] Recovering state from '/tmp/MasterContenderDetectorTest_File_D26k38/meta'
I1107 03:34:49.564872 19202 status_update_manager.cpp:197] Recovering status update manager
I1107 03:34:49.565210 19204 containerizer.cpp:281] Recovering containerizer
I1107 03:34:49.566436 19215 slave.cpp:3464] Finished recovery
I1107 03:34:49.567010 19212 slave.cpp:602] New master detected at master@67.195.81.187:60759
I1107 03:34:49.567019 19201 status_update_manager.cpp:171] Pausing sending status updates
I1107 03:34:49.567065 19212 slave.cpp:665] Authenticating with master master@67.195.81.187:60759
I1107 03:34:49.567240 19212 slave.cpp:638] Detecting new master
I1107 03:34:49.567339 19208 authenticatee.hpp:133] Creating new client SASL connection
I1107 03:34:49.567580 19204 master.cpp:3896] Authenticating slave(223)@67.195.81.187:60759
I1107 03:34:49.567638 19204 master.cpp:3907] Using default CRAM-MD5 authenticator
I1107 03:34:49.567893 19213 authenticator.hpp:169] Creating new server SASL connection
I1107 03:34:49.567975 19187 sched.cpp:143] Version: 0.22.0
I1107 03:34:49.568112 19206 authenticatee.hpp:224] Received SASL authentication mechanisms:
CRAM-MD5
I1107 03:34:49.568157 19206 authenticatee.hpp:250] Attempting to authenticate with mechanism
'CRAM-MD5'
I1107 03:34:49.568263 19206 authenticator.hpp:275] Received SASL authentication start
I1107 03:34:49.568347 19206 authenticator.hpp:397] Authentication requires more steps
I1107 03:34:49.568496 19210 authenticatee.hpp:270] Received SASL authentication step
I1107 03:34:49.568505 19212 sched.cpp:239] New master detected at master@67.195.81.187:60759
I1107 03:34:49.568548 19212 sched.cpp:295] Authenticating with master master@67.195.81.187:60759
I1107 03:34:49.568625 19202 authenticator.hpp:303] Received SASL authentication step
I1107 03:34:49.568662 19202 auxprop.cpp:99] Request to lookup properties for user: 'test-principal'
realm: 'pomona.apache.org' server FQDN: 'pomona.apache.org' SASL_AUXPROP_VERIFY_AGAINST_HASH:
false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false 
I1107 03:34:49.568678 19202 auxprop.cpp:171] Looking up auxiliary property '*userPassword'
I1107 03:34:49.568723 19202 auxprop.cpp:171] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
I1107 03:34:49.568737 19214 authenticatee.hpp:133] Creating new client SASL connection
I1107 03:34:49.568758 19202 auxprop.cpp:99] Request to lookup properties for user: 'test-principal'
realm: 'pomona.apache.org' server FQDN: 'pomona.apache.org' SASL_AUXPROP_VERIFY_AGAINST_HASH:
false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true 
I1107 03:34:49.568770 19202 auxprop.cpp:121] Skipping auxiliary property '*userPassword' since
SASL_AUXPROP_AUTHZID == true
I1107 03:34:49.568778 19202 auxprop.cpp:121] Skipping auxiliary property '*cmusaslsecretCRAM-MD5'
since SASL_AUXPROP_AUTHZID == true
I1107 03:34:49.568795 19202 authenticator.hpp:389] Authentication success
I1107 03:34:49.568927 19216 authenticatee.hpp:310] Authentication success
I1107 03:34:49.568955 19212 master.cpp:3896] Authenticating scheduler-bd47b1b3-c3d6-47c1-b043-73c716aac5a1@67.195.81.187:60759
I1107 03:34:49.569006 19212 master.cpp:3907] Using default CRAM-MD5 authenticator
I1107 03:34:49.569172 19214 slave.cpp:722] Successfully authenticated with master master@67.195.81.187:60759
I1107 03:34:49.569314 19201 authenticator.hpp:169] Creating new server SASL connection
I1107 03:34:49.569322 19214 slave.cpp:1050] Will retry registration in 9.093275ms if necessary
I1107 03:34:49.569421 19212 master.cpp:3957] Successfully authenticated principal 'test-principal'
at slave(223)@67.195.81.187:60759
I1107 03:34:49.694494 19213 authenticatee.hpp:224] Received SASL authentication mechanisms:
CRAM-MD5
I1107 03:34:49.694530 19213 authenticatee.hpp:250] Attempting to authenticate with mechanism
'CRAM-MD5'
I1107 03:34:49.694741 19202 authenticator.hpp:275] Received SASL authentication start
I1107 03:34:49.694798 19202 authenticator.hpp:397] Authentication requires more steps
I1107 03:34:49.694849 19212 master.cpp:3063] Registering slave at slave(223)@67.195.81.187:60759
(pomona.apache.org) with id 20141107-033449-3142697795-60759-19187-S0
I1107 03:34:49.694900 19202 authenticatee.hpp:270] Received SASL authentication step
I1107 03:34:49.695019 19210 authenticator.hpp:303] Received SASL authentication step
I1107 03:34:49.695055 19210 auxprop.cpp:99] Request to lookup properties for user: 'test-principal'
realm: 'pomona.apache.org' server FQDN: 'pomona.apache.org' SASL_AUXPROP_VERIFY_AGAINST_HASH:
false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false 
I1107 03:34:49.695075 19210 auxprop.cpp:171] Looking up auxiliary property '*userPassword'
I1107 03:34:49.695106 19210 auxprop.cpp:171] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
I1107 03:34:49.695130 19210 auxprop.cpp:99] Request to lookup properties for user: 'test-principal'
realm: 'pomona.apache.org' server FQDN: 'pomona.apache.org' SASL_AUXPROP_VERIFY_AGAINST_HASH:
false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true 
I1107 03:34:49.695142 19210 auxprop.cpp:121] Skipping auxiliary property '*userPassword' since
SASL_AUXPROP_AUTHZID == true
I1107 03:34:49.695158 19210 auxprop.cpp:121] Skipping auxiliary property '*cmusaslsecretCRAM-MD5'
since SASL_AUXPROP_AUTHZID == true
I1107 03:34:49.695176 19210 authenticator.hpp:389] Authentication success
I1107 03:34:49.695386 19210 authenticatee.hpp:310] Authentication success
I1107 03:34:49.695411 19207 registrar.cpp:445] Applied 1 operations in 82018ns; attempting
to update the 'registry'
I1107 03:34:49.695418 19204 master.cpp:3957] Successfully authenticated principal 'test-principal'
at scheduler-bd47b1b3-c3d6-47c1-b043-73c716aac5a1@67.195.81.187:60759
I1107 03:34:49.695704 19210 sched.cpp:369] Successfully authenticated with master master@67.195.81.187:60759
I1107 03:34:49.695729 19210 sched.cpp:488] Sending registration request to master@67.195.81.187:60759
I1107 03:34:49.695785 19210 sched.cpp:521] Will retry registration in 736.266806ms if necessary
I1107 03:34:49.695916 19205 master.cpp:1378] Received registration request for framework 'default'
at scheduler-bd47b1b3-c3d6-47c1-b043-73c716aac5a1@67.195.81.187:60759
I1107 03:34:49.696005 19205 master.cpp:1337] Authorizing framework principal 'test-principal'
to receive offers for role '*'
I1107 03:34:49.696467 19205 master.cpp:1442] Registering framework 20141107-033449-3142697795-60759-19187-0000
(default) at scheduler-bd47b1b3-c3d6-47c1-b043-73c716aac5a1@67.195.81.187:60759
I1107 03:34:49.696703 19216 hierarchical_allocator_process.hpp:329] Added framework 20141107-033449-3142697795-60759-19187-0000
I1107 03:34:49.696728 19216 hierarchical_allocator_process.hpp:697] No resources available
to allocate!
I1107 03:34:49.696741 19216 hierarchical_allocator_process.hpp:659] Performed allocation for
0 slaves in 18321ns
I1107 03:34:49.696799 19209 sched.cpp:419] Framework registered with 20141107-033449-3142697795-60759-19187-0000
I1107 03:34:49.696835 19209 sched.cpp:433] Scheduler::registered took 19838ns
I1107 03:34:49.698026 19215 log.cpp:680] Attempting to append 316 bytes to the log
I1107 03:34:49.698197 19214 coordinator.cpp:340] Coordinator attempting to write APPEND action
at position 3
I1107 03:34:49.699096 19204 replica.cpp:508] Replica received write request for position 3
I1107 03:34:49.699664 19204 leveldb.cpp:343] Persisting action (335 bytes) to leveldb took
532837ns
I1107 03:34:49.699692 19204 replica.cpp:676] Persisted action at 3
I1107 03:34:49.700239 19207 replica.cpp:655] Replica received learned notice for position
3
I1107 03:34:49.700652 19207 leveldb.cpp:343] Persisting action (337 bytes) to leveldb took
385943ns
I1107 03:34:49.700678 19207 replica.cpp:676] Persisted action at 3
I1107 03:34:49.700698 19207 replica.cpp:661] Replica learned APPEND action at position 3
I1107 03:34:49.701675 19214 registrar.cpp:490] Successfully updated the 'registry' in 6.201088ms
I1107 03:34:49.701920 19201 log.cpp:699] Attempting to truncate the log to 3
I1107 03:34:49.702024 19205 coordinator.cpp:340] Coordinator attempting to write TRUNCATE
action at position 4
I1107 03:34:49.702112 19215 slave.cpp:2536] Received ping from slave-observer(202)@67.195.81.187:60759
I1107 03:34:49.702217 19206 master.cpp:3117] Registered slave 20141107-033449-3142697795-60759-19187-S0
at slave(223)@67.195.81.187:60759 (pomona.apache.org) with cpus(*):2; mem(*):1024; disk(*):1024;
ports(*):[31000-32000]
I1107 03:34:49.702260 19203 slave.cpp:756] Registered with master master@67.195.81.187:60759;
given slave ID 20141107-033449-3142697795-60759-19187-S0
I1107 03:34:49.702401 19204 status_update_manager.cpp:178] Resuming sending status updates
I1107 03:34:49.702394 19213 hierarchical_allocator_process.hpp:442] Added slave 20141107-033449-3142697795-60759-19187-S0
(pomona.apache.org) with cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] (and
cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] available)
I1107 03:34:49.702534 19213 hierarchical_allocator_process.hpp:734] Offering cpus(*):2; mem(*):1024;
disk(*):1024; ports(*):[31000-32000] on slave 20141107-033449-3142697795-60759-19187-S0 to
framework 20141107-033449-3142697795-60759-19187-0000
I1107 03:34:49.702704 19214 replica.cpp:508] Replica received write request for position 4
I1107 03:34:49.702828 19213 hierarchical_allocator_process.hpp:679] Performed allocation for
slave 20141107-033449-3142697795-60759-19187-S0 in 382874ns
I1107 03:34:49.703037 19214 leveldb.cpp:343] Persisting action (16 bytes) to leveldb took
310462ns
I1107 03:34:49.703048 19216 master.cpp:3838] Sending 1 offers to framework 20141107-033449-3142697795-60759-19187-0000
(default) at scheduler-bd47b1b3-c3d6-47c1-b043-73c716aac5a1@67.195.81.187:60759
I1107 03:34:49.703058 19214 replica.cpp:676] Persisted action at 4
I1107 03:34:49.703451 19214 sched.cpp:578] Scheduler::resourceOffers took 91417ns
I1107 03:34:49.703606 19206 replica.cpp:655] Replica received learned notice for position
4
I1107 03:34:49.703903 19187 master.cpp:693] Master terminating
I1107 03:34:49.703948 19212 sched.cpp:779] Stopping framework '20141107-033449-3142697795-60759-19187-0000'
I1107 03:34:49.703968 19206 leveldb.cpp:343] Persisting action (18 bytes) to leveldb took
338144ns
I1107 03:34:49.704005 19206 leveldb.cpp:401] Deleting ~2 keys from leveldb took 19094ns
I1107 03:34:49.704017 19206 replica.cpp:676] Persisted action at 4
I1107 03:34:49.704033 19206 replica.cpp:661] Replica learned TRUNCATE action at position 4
I1107 03:34:49.704814 19209 slave.cpp:2621] master@67.195.81.187:60759 exited
W1107 03:34:49.704849 19209 slave.cpp:2624] Master disconnected! Waiting for a new master
to be elected
I1107 03:34:49.708652 19207 slave.cpp:484] Slave terminating
[       OK ] MasterContenderDetectorTest.File (306 ms)
[----------] 1 test from MasterContenderDetectorTest (306 ms total)

[----------] Global test environment tear-down
[==========] 456 tests from 71 test cases ran. (383489 ms total)
[  PASSED  ] 455 tests.
[  FAILED  ] 1 test, listed below:
[  FAILED  ] MesosContainerizerExecuteTest.IoRedirection

 1 FAILED TEST
  YOU HAVE 6 DISABLED TESTS

make[3]: *** [check-local] Error 1
make[3]: Leaving directory `<https://builds.apache.org/job/Mesos-Trunk-Ubuntu-Build-In-Src-Set-JAVA_HOME/ws/src'>
make[2]: *** [check-am] Error 2
make[2]: Leaving directory `<https://builds.apache.org/job/Mesos-Trunk-Ubuntu-Build-In-Src-Set-JAVA_HOME/ws/src'>
make[1]: *** [check] Error 2
make[1]: Leaving directory `<https://builds.apache.org/job/Mesos-Trunk-Ubuntu-Build-In-Src-Set-JAVA_HOME/ws/src'>
make: *** [check-recursive] Error 1
Test finished
Exit status: 2
Build step 'Execute shell' marked build as failure
Recording test results

Mime
View raw message