You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@mesos.apache.org by Apache Jenkins Server <je...@builds.apache.org> on 2014/07/04 05:30:57 UTC
Build failed in Jenkins:
Mesos-Trunk-Ubuntu-Build-In-Src-Set-JAVA_HOME #1977
See <https://builds.apache.org/job/Mesos-Trunk-Ubuntu-Build-In-Src-Set-JAVA_HOME/1977/changes>
Changes:
[yan] Improved gate.hpp documentation.
[yan] Created an example LoadGeneratorScheduler to test Master's framework rate limiting feature.
[vinodkone] PortMapping: allow containers to recover even when they were not
[vinodkone] Minor fix to mesos_tests_SOURCES in Makefile.am
------------------------------------------
[...truncated 59532 lines...]
I0704 03:30:56.127792 1054 leveldb.cpp:306] Persisting metadata (8 bytes) to leveldb took 22.385668ms
I0704 03:30:56.127812 1054 replica.cpp:320] Persisted replica status to STARTING
I0704 03:30:56.127887 1054 recover.cpp:451] Replica is in STARTING status
I0704 03:30:56.128208 1053 replica.cpp:638] Replica in STARTING status received a broadcasted recover request
I0704 03:30:56.128286 1057 recover.cpp:188] Received a recover response from a replica in STARTING status
I0704 03:30:56.128411 1057 recover.cpp:542] Updating replica status to VOTING
I0704 03:30:56.133699 1057 leveldb.cpp:306] Persisting metadata (8 bytes) to leveldb took 5.232652ms
I0704 03:30:56.133718 1057 replica.cpp:320] Persisted replica status to VOTING
I0704 03:30:56.133759 1057 recover.cpp:556] Successfully joined the Paxos group
I0704 03:30:56.133821 1057 recover.cpp:440] Recover process terminated
I0704 03:30:56.133941 1057 log.cpp:656] Attempting to start the writer
I0704 03:30:56.134290 1053 replica.cpp:474] Replica received implicit promise request with proposal 1
I0704 03:30:56.142029 1053 leveldb.cpp:306] Persisting metadata (8 bytes) to leveldb took 7.717529ms
I0704 03:30:56.142046 1053 replica.cpp:342] Persisted promised to 1
I0704 03:30:56.142241 1053 coordinator.cpp:230] Coordinator attemping to fill missing position
I0704 03:30:56.142639 1053 replica.cpp:375] Replica received explicit promise request for position 0 with proposal 2
I0704 03:30:56.150357 1053 leveldb.cpp:343] Persisting action (8 bytes) to leveldb took 7.702259ms
I0704 03:30:56.150377 1053 replica.cpp:676] Persisted action at 0
I0704 03:30:56.150672 1053 replica.cpp:508] Replica received write request for position 0
I0704 03:30:56.150693 1053 leveldb.cpp:438] Reading position from leveldb took 10797ns
I0704 03:30:56.158687 1053 leveldb.cpp:343] Persisting action (14 bytes) to leveldb took 7.97992ms
I0704 03:30:56.158705 1053 replica.cpp:676] Persisted action at 0
I0704 03:30:56.158860 1053 replica.cpp:655] Replica received learned notice for position 0
I0704 03:30:56.167023 1053 leveldb.cpp:343] Persisting action (16 bytes) to leveldb took 8.144982ms
I0704 03:30:56.167042 1053 replica.cpp:676] Persisted action at 0
I0704 03:30:56.167050 1053 replica.cpp:661] Replica learned NOP action at position 0
I0704 03:30:56.167232 1053 log.cpp:672] Writer started with ending position 0
I0704 03:30:56.167525 1053 leveldb.cpp:438] Reading position from leveldb took 7782ns
I0704 03:30:56.169028 1055 registrar.cpp:346] Successfully fetched the registry (0B)
I0704 03:30:56.169059 1055 registrar.cpp:422] Attempting to update the 'registry'
I0704 03:30:56.170518 1051 log.cpp:680] Attempting to append 136 bytes to the log
I0704 03:30:56.170570 1051 coordinator.cpp:340] Coordinator attempting to write APPEND action at position 1
I0704 03:30:56.170794 1051 replica.cpp:508] Replica received write request for position 1
I0704 03:30:56.175344 1051 leveldb.cpp:343] Persisting action (155 bytes) to leveldb took 4.537003ms
I0704 03:30:56.175362 1051 replica.cpp:676] Persisted action at 1
I0704 03:30:56.175557 1051 replica.cpp:655] Replica received learned notice for position 1
I0704 03:30:56.183676 1051 leveldb.cpp:343] Persisting action (157 bytes) to leveldb took 8.106349ms
I0704 03:30:56.183696 1051 replica.cpp:676] Persisted action at 1
I0704 03:30:56.183704 1051 replica.cpp:661] Replica learned APPEND action at position 1
I0704 03:30:56.183987 1051 registrar.cpp:479] Successfully updated 'registry'
I0704 03:30:56.184023 1051 registrar.cpp:372] Successfully recovered registrar
I0704 03:30:56.184067 1051 log.cpp:699] Attempting to truncate the log to 1
I0704 03:30:56.184134 1051 master.cpp:981] Recovered 0 slaves from the Registry (98B) ; allowing 10mins for slaves to re-register
I0704 03:30:56.184173 1051 coordinator.cpp:340] Coordinator attempting to write TRUNCATE action at position 2
I0704 03:30:56.184470 1051 replica.cpp:508] Replica received write request for position 2
I0704 03:30:56.192004 1051 leveldb.cpp:343] Persisting action (16 bytes) to leveldb took 7.519029ms
I0704 03:30:56.192023 1051 replica.cpp:676] Persisted action at 2
I0704 03:30:56.192206 1051 replica.cpp:655] Replica received learned notice for position 2
I0704 03:30:56.200333 1051 leveldb.cpp:343] Persisting action (18 bytes) to leveldb took 8.114395ms
I0704 03:30:56.200371 1051 leveldb.cpp:401] Deleting ~1 keys from leveldb took 19866ns
I0704 03:30:56.200381 1051 replica.cpp:676] Persisted action at 2
I0704 03:30:56.200391 1051 replica.cpp:661] Replica learned TRUNCATE action at position 2
I0704 03:30:56.207379 1055 slave.cpp:168] Slave started on 192)@67.195.138.61:51677
I0704 03:30:56.207394 1055 credentials.hpp:84] Loading credential for authentication from '/tmp/GarbageCollectorIntegrationTest_ExitedExecutor_uJQnQE/credential'
I0704 03:30:56.207460 1055 slave.cpp:266] Slave using credential for: test-principal
I0704 03:30:56.207566 1055 slave.cpp:279] Slave resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0704 03:30:56.207619 1055 slave.cpp:324] Slave hostname: juno.apache.org
I0704 03:30:56.207628 1055 slave.cpp:325] Slave checkpoint: false
I0704 03:30:56.208169 1054 state.cpp:33] Recovering state from '/tmp/GarbageCollectorIntegrationTest_ExitedExecutor_uJQnQE/meta'
I0704 03:30:56.208268 1054 status_update_manager.cpp:193] Recovering status update manager
I0704 03:30:56.208415 1054 slave.cpp:3126] Finished recovery
I0704 03:30:56.208622 1054 slave.cpp:599] New master detected at master@67.195.138.61:51677
I0704 03:30:56.208642 1054 slave.cpp:675] Authenticating with master master@67.195.138.61:51677
I0704 03:30:56.208678 1054 slave.cpp:648] Detecting new master
I0704 03:30:56.208714 1054 status_update_manager.cpp:167] New master detected at master@67.195.138.61:51677
I0704 03:30:56.208748 1054 authenticatee.hpp:128] Creating new client SASL connection
I0704 03:30:56.208880 1054 master.cpp:3502] Authenticating slave(192)@67.195.138.61:51677
I0704 03:30:56.208959 1054 authenticator.hpp:156] Creating new server SASL connection
I0704 03:30:56.209053 1054 authenticatee.hpp:219] Received SASL authentication mechanisms: CRAM-MD5
I0704 03:30:56.209069 1054 authenticatee.hpp:245] Attempting to authenticate with mechanism 'CRAM-MD5'
I0704 03:30:56.209097 1054 authenticator.hpp:262] Received SASL authentication start
I0704 03:30:56.209130 1054 authenticator.hpp:384] Authentication requires more steps
I0704 03:30:56.209156 1054 authenticatee.hpp:265] Received SASL authentication step
I0704 03:30:56.209194 1054 authenticator.hpp:290] Received SASL authentication step
I0704 03:30:56.209210 1054 auxprop.cpp:81] Request to lookup properties for user: 'test-principal' realm: 'juno.apache.org' server FQDN: 'juno.apache.org' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false
I0704 03:30:56.209218 1054 auxprop.cpp:153] Looking up auxiliary property '*userPassword'
I0704 03:30:56.209229 1054 auxprop.cpp:153] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
I0704 03:30:56.209239 1054 auxprop.cpp:81] Request to lookup properties for user: 'test-principal' realm: 'juno.apache.org' server FQDN: 'juno.apache.org' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true
I0704 03:30:56.209246 1054 auxprop.cpp:103] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true
I0704 03:30:56.209252 1054 auxprop.cpp:103] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
I0704 03:30:56.209264 1054 authenticator.hpp:376] Authentication success
I0704 03:30:56.209291 1054 authenticatee.hpp:305] Authentication success
I0704 03:30:56.209313 1054 master.cpp:3542] Successfully authenticated principal 'test-principal' at slave(192)@67.195.138.61:51677
I0704 03:30:56.209378 1054 slave.cpp:732] Successfully authenticated with master master@67.195.138.61:51677
I0704 03:30:56.209410 1054 slave.cpp:970] Will retry registration in 7.69748ms if necessary
I0704 03:30:56.209475 1054 master.cpp:2784] Registering slave at slave(192)@67.195.138.61:51677 (juno.apache.org) with id 20140704-033056-1032504131-51677-1029-0
I0704 03:30:56.209672 1057 registrar.cpp:422] Attempting to update the 'registry'
I0704 03:30:56.211299 1052 log.cpp:680] Attempting to append 326 bytes to the log
I0704 03:30:56.211357 1052 coordinator.cpp:340] Coordinator attempting to write APPEND action at position 3
I0704 03:30:56.211580 1052 replica.cpp:508] Replica received write request for position 3
I0704 03:30:56.216995 1052 leveldb.cpp:343] Persisting action (345 bytes) to leveldb took 5.4013ms
I0704 03:30:56.217015 1052 replica.cpp:676] Persisted action at 3
I0704 03:30:56.217207 1052 replica.cpp:655] Replica received learned notice for position 3
I0704 03:30:56.217659 1054 slave.cpp:970] Will retry registration in 16.551732ms if necessary
I0704 03:30:56.217689 1056 master.cpp:2772] Ignoring register slave message from slave(192)@67.195.138.61:51677 (juno.apache.org) as admission is already in progress
I0704 03:30:56.225322 1052 leveldb.cpp:343] Persisting action (347 bytes) to leveldb took 8.102932ms
I0704 03:30:56.225340 1052 replica.cpp:676] Persisted action at 3
I0704 03:30:56.225349 1052 replica.cpp:661] Replica learned APPEND action at position 3
I0704 03:30:56.225733 1057 registrar.cpp:479] Successfully updated 'registry'
I0704 03:30:56.225841 1052 log.cpp:699] Attempting to truncate the log to 3
I0704 03:30:56.225883 1053 master.cpp:2824] Registered slave 20140704-033056-1032504131-51677-1029-0 at slave(192)@67.195.138.61:51677 (juno.apache.org)
I0704 03:30:56.225904 1054 coordinator.cpp:340] Coordinator attempting to write TRUNCATE action at position 4
I0704 03:30:56.225901 1053 master.cpp:3970] Adding slave 20140704-033056-1032504131-51677-1029-0 at slave(192)@67.195.138.61:51677 (juno.apache.org) with cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0704 03:30:56.226016 1056 slave.cpp:766] Registered with master master@67.195.138.61:51677; given slave ID 20140704-033056-1032504131-51677-1029-0
I0704 03:30:56.226065 1056 slave.cpp:2323] Received ping from slave-observer(161)@67.195.138.61:51677
I0704 03:30:56.226094 1053 hierarchical_allocator_process.hpp:444] Added slave 20140704-033056-1032504131-51677-1029-0 (juno.apache.org) with cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] (and cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] available)
I0704 03:30:56.226135 1053 hierarchical_allocator_process.hpp:706] Performed allocation for slave 20140704-033056-1032504131-51677-1029-0 in 9840ns
I0704 03:30:56.226269 1051 replica.cpp:508] Replica received write request for position 4
I0704 03:30:56.229217 1029 sched.cpp:139] Version: 0.20.0
I0704 03:30:56.229383 1056 sched.cpp:235] New master detected at master@67.195.138.61:51677
I0704 03:30:56.229403 1056 sched.cpp:285] Authenticating with master master@67.195.138.61:51677
I0704 03:30:56.229477 1052 authenticatee.hpp:128] Creating new client SASL connection
I0704 03:30:56.229672 1050 master.cpp:3502] Authenticating scheduler-cd36b619-77ba-4862-9aa0-742da41e2b5d@67.195.138.61:51677
I0704 03:30:56.229771 1050 authenticator.hpp:156] Creating new server SASL connection
I0704 03:30:56.229882 1050 authenticatee.hpp:219] Received SASL authentication mechanisms: CRAM-MD5
I0704 03:30:56.229898 1050 authenticatee.hpp:245] Attempting to authenticate with mechanism 'CRAM-MD5'
I0704 03:30:56.229926 1050 authenticator.hpp:262] Received SASL authentication start
I0704 03:30:56.229966 1050 authenticator.hpp:384] Authentication requires more steps
I0704 03:30:56.229992 1050 authenticatee.hpp:265] Received SASL authentication step
I0704 03:30:56.230031 1050 authenticator.hpp:290] Received SASL authentication step
I0704 03:30:56.230047 1050 auxprop.cpp:81] Request to lookup properties for user: 'test-principal' realm: 'juno.apache.org' server FQDN: 'juno.apache.org' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false
I0704 03:30:56.230056 1050 auxprop.cpp:153] Looking up auxiliary property '*userPassword'
I0704 03:30:56.230067 1050 auxprop.cpp:153] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
I0704 03:30:56.230077 1050 auxprop.cpp:81] Request to lookup properties for user: 'test-principal' realm: 'juno.apache.org' server FQDN: 'juno.apache.org' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true
I0704 03:30:56.230085 1050 auxprop.cpp:103] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true
I0704 03:30:56.230092 1050 auxprop.cpp:103] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
I0704 03:30:56.230103 1050 authenticator.hpp:376] Authentication success
I0704 03:30:56.230130 1050 authenticatee.hpp:305] Authentication success
I0704 03:30:56.230154 1050 master.cpp:3542] Successfully authenticated principal 'test-principal' at scheduler-cd36b619-77ba-4862-9aa0-742da41e2b5d@67.195.138.61:51677
I0704 03:30:56.230228 1050 sched.cpp:359] Successfully authenticated with master master@67.195.138.61:51677
I0704 03:30:56.230239 1050 sched.cpp:478] Sending registration request to master@67.195.138.61:51677
I0704 03:30:56.230284 1050 master.cpp:1242] Received registration request from scheduler-cd36b619-77ba-4862-9aa0-742da41e2b5d@67.195.138.61:51677
I0704 03:30:56.230304 1050 master.cpp:1202] Authorizing framework principal 'test-principal' to receive offers for role '*'
I0704 03:30:56.230432 1050 master.cpp:1301] Registering framework 20140704-033056-1032504131-51677-1029-0000 at scheduler-cd36b619-77ba-4862-9aa0-742da41e2b5d@67.195.138.61:51677
I0704 03:30:56.230525 1050 sched.cpp:409] Framework registered with 20140704-033056-1032504131-51677-1029-0000
I0704 03:30:56.230551 1050 sched.cpp:423] Scheduler::registered took 16347ns
I0704 03:30:56.230586 1050 hierarchical_allocator_process.hpp:331] Added framework 20140704-033056-1032504131-51677-1029-0000
I0704 03:30:56.230626 1050 hierarchical_allocator_process.hpp:750] Offering cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] on slave 20140704-033056-1032504131-51677-1029-0 to framework 20140704-033056-1032504131-51677-1029-0000
I0704 03:30:56.230762 1050 hierarchical_allocator_process.hpp:686] Performed allocation for 1 slaves in 163958ns
I0704 03:30:56.230871 1050 master.hpp:794] Adding offer 20140704-033056-1032504131-51677-1029-0 with resources cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] on slave 20140704-033056-1032504131-51677-1029-0 (juno.apache.org)
I0704 03:30:56.230921 1050 master.cpp:3449] Sending 1 offers to framework 20140704-033056-1032504131-51677-1029-0000
I0704 03:30:56.231220 1050 sched.cpp:546] Scheduler::resourceOffers took 175724ns
I0704 03:30:56.231405 1050 master.hpp:804] Removing offer 20140704-033056-1032504131-51677-1029-0 with resources cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] on slave 20140704-033056-1032504131-51677-1029-0 (juno.apache.org)
I0704 03:30:56.231459 1050 master.cpp:2128] Processing reply for offers: [ 20140704-033056-1032504131-51677-1029-0 ] on slave 20140704-033056-1032504131-51677-1029-0 at slave(192)@67.195.138.61:51677 (juno.apache.org) for framework 20140704-033056-1032504131-51677-1029-0000
I0704 03:30:56.231485 1050 master.cpp:2214] Authorizing framework principal 'test-principal' to launch task 0 as user 'jenkins'
I0704 03:30:56.231832 1050 master.hpp:766] Adding task 0 with resources cpus(*):2; mem(*):1024 on slave 20140704-033056-1032504131-51677-1029-0 (juno.apache.org)
I0704 03:30:56.231859 1050 master.cpp:2280] Launching task 0 of framework 20140704-033056-1032504131-51677-1029-0000 with resources cpus(*):2; mem(*):1024 on slave 20140704-033056-1032504131-51677-1029-0 at slave(192)@67.195.138.61:51677 (juno.apache.org)
I0704 03:30:56.231992 1050 slave.cpp:1001] Got assigned task 0 for framework 20140704-033056-1032504131-51677-1029-0000
I0704 03:30:56.232172 1050 slave.cpp:1111] Launching task 0 for framework 20140704-033056-1032504131-51677-1029-0000
I0704 03:30:56.232414 1054 hierarchical_allocator_process.hpp:546] Framework 20140704-033056-1032504131-51677-1029-0000 left disk(*):1024; ports(*):[31000-32000] unused on slave 20140704-033056-1032504131-51677-1029-0
I0704 03:30:56.232480 1054 hierarchical_allocator_process.hpp:588] Framework 20140704-033056-1032504131-51677-1029-0000 filtered slave 20140704-033056-1032504131-51677-1029-0 for 5secs
I0704 03:30:56.233654 1051 leveldb.cpp:343] Persisting action (16 bytes) to leveldb took 7.370214ms
I0704 03:30:56.233675 1051 replica.cpp:676] Persisted action at 4
I0704 03:30:56.233857 1051 replica.cpp:655] Replica received learned notice for position 4
I0704 03:30:56.235409 1050 exec.cpp:131] Version: 0.20.0
I0704 03:30:56.235476 1056 exec.cpp:181] Executor started at: executor(62)@67.195.138.61:51677 with pid 1029
I0704 03:30:56.235533 1050 slave.cpp:1221] Queuing task '0' for executor default of framework '20140704-033056-1032504131-51677-1029-0000
I0704 03:30:56.235599 1050 slave.cpp:560] Successfully attached file '/tmp/GarbageCollectorIntegrationTest_ExitedExecutor_uJQnQE/slaves/20140704-033056-1032504131-51677-1029-0/frameworks/20140704-033056-1032504131-51677-1029-0000/executors/default/runs/35320140-231c-424a-b764-079c5774f898'
I0704 03:30:56.235635 1050 slave.cpp:2468] Monitoring executor 'default' of framework '20140704-033056-1032504131-51677-1029-0000' in container '35320140-231c-424a-b764-079c5774f898'
I0704 03:30:56.235699 1050 slave.cpp:1732] Got registration for executor 'default' of framework 20140704-033056-1032504131-51677-1029-0000
I0704 03:30:56.235810 1050 slave.cpp:1851] Flushing queued task 0 for executor 'default' of framework 20140704-033056-1032504131-51677-1029-0000
I0704 03:30:56.235857 1052 exec.cpp:205] Executor registered on slave 20140704-033056-1032504131-51677-1029-0
I0704 03:30:56.237129 1052 exec.cpp:217] Executor::registered took 11486ns
I0704 03:30:56.237196 1052 exec.cpp:292] Executor asked to run task '0'
I0704 03:30:56.237231 1052 exec.cpp:301] Executor::launchTask took 21116ns
I0704 03:30:56.238478 1052 exec.cpp:524] Executor sending status update TASK_RUNNING (UUID: a9235d02-1de9-4d01-891c-58baff6551bb) for task 0 of framework 20140704-033056-1032504131-51677-1029-0000
I0704 03:30:56.238556 1052 slave.cpp:2086] Handling status update TASK_RUNNING (UUID: a9235d02-1de9-4d01-891c-58baff6551bb) for task 0 of framework 20140704-033056-1032504131-51677-1029-0000 from executor(62)@67.195.138.61:51677
I0704 03:30:56.238665 1057 status_update_manager.cpp:320] Received status update TASK_RUNNING (UUID: a9235d02-1de9-4d01-891c-58baff6551bb) for task 0 of framework 20140704-033056-1032504131-51677-1029-0000
I0704 03:30:56.238683 1057 status_update_manager.cpp:499] Creating StatusUpdate stream for task 0 of framework 20140704-033056-1032504131-51677-1029-0000
I0704 03:30:56.238756 1057 status_update_manager.cpp:373] Forwarding status update TASK_RUNNING (UUID: a9235d02-1de9-4d01-891c-58baff6551bb) for task 0 of framework 20140704-033056-1032504131-51677-1029-0000 to master@67.195.138.61:51677
I0704 03:30:56.238845 1057 slave.cpp:2244] Status update manager successfully handled status update TASK_RUNNING (UUID: a9235d02-1de9-4d01-891c-58baff6551bb) for task 0 of framework 20140704-033056-1032504131-51677-1029-0000
I0704 03:30:56.238860 1057 slave.cpp:2250] Sending acknowledgement for status update TASK_RUNNING (UUID: a9235d02-1de9-4d01-891c-58baff6551bb) for task 0 of framework 20140704-033056-1032504131-51677-1029-0000 to executor(62)@67.195.138.61:51677
I0704 03:30:56.238862 1052 master.cpp:3110] Status update TASK_RUNNING (UUID: a9235d02-1de9-4d01-891c-58baff6551bb) for task 0 of framework 20140704-033056-1032504131-51677-1029-0000 from slave 20140704-033056-1032504131-51677-1029-0 at slave(192)@67.195.138.61:51677 (juno.apache.org)
I0704 03:30:56.238929 1057 exec.cpp:338] Executor received status update acknowledgement a9235d02-1de9-4d01-891c-58baff6551bb for task 0 of framework 20140704-033056-1032504131-51677-1029-0000
I0704 03:30:56.238944 1052 sched.cpp:637] Scheduler::statusUpdate took 20246ns
I0704 03:30:56.239025 1057 master.cpp:2634] Forwarding status update acknowledgement a9235d02-1de9-4d01-891c-58baff6551bb for task 0 of framework 20140704-033056-1032504131-51677-1029-0000 to slave 20140704-033056-1032504131-51677-1029-0 at slave(192)@67.195.138.61:51677 (juno.apache.org)
I0704 03:30:56.239116 1057 status_update_manager.cpp:398] Received status update acknowledgement (UUID: a9235d02-1de9-4d01-891c-58baff6551bb) for task 0 of framework 20140704-033056-1032504131-51677-1029-0000
I0704 03:30:56.239255 1055 slave.cpp:1672] Status update manager successfully handled status update acknowledgement (UUID: a9235d02-1de9-4d01-891c-58baff6551bb) for task 0 of framework 20140704-033056-1032504131-51677-1029-0000
I0704 03:30:56.239308 1055 slave.cpp:2526] Executor 'default' of framework 20140704-033056-1032504131-51677-1029-0000 exited with status 0
I0704 03:30:56.240603 1055 slave.cpp:2086] Handling status update TASK_LOST (UUID: f3311ef0-834a-4e66-b572-eb90b3b018b6) for task 0 of framework 20140704-033056-1032504131-51677-1029-0000 from @0.0.0.0:0
I0704 03:30:56.240625 1055 slave.cpp:3768] Terminating task 0
I0704 03:30:56.240777 1056 master.cpp:3186] Executor default of framework 20140704-033056-1032504131-51677-1029-0000 on slave 20140704-033056-1032504131-51677-1029-0 at slave(192)@67.195.138.61:51677 (juno.apache.org) exited with status 0
I0704 03:30:56.240857 1054 status_update_manager.cpp:320] Received status update TASK_LOST (UUID: f3311ef0-834a-4e66-b572-eb90b3b018b6) for task 0 of framework 20140704-033056-1032504131-51677-1029-0000
I0704 03:30:56.240903 1054 status_update_manager.cpp:373] Forwarding status update TASK_LOST (UUID: f3311ef0-834a-4e66-b572-eb90b3b018b6) for task 0 of framework 20140704-033056-1032504131-51677-1029-0000 to master@67.195.138.61:51677
I0704 03:30:56.241024 1052 master.cpp:3110] Status update TASK_LOST (UUID: f3311ef0-834a-4e66-b572-eb90b3b018b6) for task 0 of framework 20140704-033056-1032504131-51677-1029-0000 from slave 20140704-033056-1032504131-51677-1029-0 at slave(192)@67.195.138.61:51677 (juno.apache.org)
I0704 03:30:56.241044 1053 slave.cpp:2244] Status update manager successfully handled status update TASK_LOST (UUID: f3311ef0-834a-4e66-b572-eb90b3b018b6) for task 0 of framework 20140704-033056-1032504131-51677-1029-0000
I0704 03:30:56.241073 1052 master.hpp:784] Removing task 0 with resources cpus(*):2; mem(*):1024 on slave 20140704-033056-1032504131-51677-1029-0 (juno.apache.org)
I0704 03:30:56.241122 1054 sched.cpp:637] Scheduler::statusUpdate took 11658ns
I0704 03:30:56.241189 1057 master.cpp:2634] Forwarding status update acknowledgement f3311ef0-834a-4e66-b572-eb90b3b018b6 for task 0 of framework 20140704-033056-1032504131-51677-1029-0000 to slave 20140704-033056-1032504131-51677-1029-0 at slave(192)@67.195.138.61:51677 (juno.apache.org)
I0704 03:30:56.241195 1053 hierarchical_allocator_process.hpp:635] Recovered cpus(*):2; mem(*):1024 (total allocatable: disk(*):1024; ports(*):[31000-32000]; cpus(*):2; mem(*):1024) on slave 20140704-033056-1032504131-51677-1029-0 from framework 20140704-033056-1032504131-51677-1029-0000
I0704 03:30:56.241271 1053 status_update_manager.cpp:398] Received status update acknowledgement (UUID: f3311ef0-834a-4e66-b572-eb90b3b018b6) for task 0 of framework 20140704-033056-1032504131-51677-1029-0000
I0704 03:30:56.241297 1053 status_update_manager.cpp:530] Cleaning up status update stream for task 0 of framework 20140704-033056-1032504131-51677-1029-0000
I0704 03:30:56.241379 1057 slave.cpp:1672] Status update manager successfully handled status update acknowledgement (UUID: f3311ef0-834a-4e66-b572-eb90b3b018b6) for task 0 of framework 20140704-033056-1032504131-51677-1029-0000
I0704 03:30:56.241396 1057 slave.cpp:3810] Completing task 0
I0704 03:30:56.241406 1057 slave.cpp:2660] Cleaning up executor 'default' of framework 20140704-033056-1032504131-51677-1029-0000
I0704 03:30:56.241482 1053 gc.cpp:56] Scheduling '/tmp/GarbageCollectorIntegrationTest_ExitedExecutor_uJQnQE/slaves/20140704-033056-1032504131-51677-1029-0/frameworks/20140704-033056-1032504131-51677-1029-0000/executors/default/runs/35320140-231c-424a-b764-079c5774f898' for gc 6.99999723250074days in the future
I0704 03:30:56.241507 1057 slave.cpp:2735] Cleaning up framework 20140704-033056-1032504131-51677-1029-0000
I0704 03:30:56.241533 1053 gc.cpp:56] Scheduling '/tmp/GarbageCollectorIntegrationTest_ExitedExecutor_uJQnQE/slaves/20140704-033056-1032504131-51677-1029-0/frameworks/20140704-033056-1032504131-51677-1029-0000/executors/default' for gc 6.99999723250074days in the future
I0704 03:30:56.241572 1057 status_update_manager.cpp:282] Closing status update streams for framework 20140704-033056-1032504131-51677-1029-0000
I0704 03:30:56.241587 1053 gc.cpp:56] Scheduling '/tmp/GarbageCollectorIntegrationTest_ExitedExecutor_uJQnQE/slaves/20140704-033056-1032504131-51677-1029-0/frameworks/20140704-033056-1032504131-51677-1029-0000' for gc 6.99999723250074days in the future
I0704 03:30:56.241986 1051 leveldb.cpp:343] Persisting action (18 bytes) to leveldb took 8.112809ms
I0704 03:30:56.242019 1051 leveldb.cpp:401] Deleting ~2 keys from leveldb took 15413ns
I0704 03:30:56.242030 1051 replica.cpp:676] Persisted action at 4
I0704 03:30:56.242038 1051 replica.cpp:661] Replica learned TRUNCATE action at position 4
I0704 03:30:56.259696 1056 hierarchical_allocator_process.hpp:750] Offering disk(*):1024; ports(*):[31000-32000]; cpus(*):2; mem(*):1024 on slave 20140704-033056-1032504131-51677-1029-0 to framework 20140704-033056-1032504131-51677-1029-0000
I0704 03:30:56.259742 1057 slave.cpp:2897] Framework 20140704-033056-1032504131-51677-1029-0000 seems to have exited. Ignoring registration timeout for executor 'default'
I0704 03:30:56.259773 1057 slave.cpp:2981] Current usage 8.78%. Max allowed age: 5.685267086187338days
I0704 03:30:56.259872 1054 gc.cpp:134] Deleting /tmp/GarbageCollectorIntegrationTest_ExitedExecutor_uJQnQE/slaves/20140704-033056-1032504131-51677-1029-0/frameworks/20140704-033056-1032504131-51677-1029-0000/executors/default/runs/35320140-231c-424a-b764-079c5774f898
I0704 03:30:56.259932 1056 hierarchical_allocator_process.hpp:686] Performed allocation for 1 slaves in 295695ns
I0704 03:30:56.259966 1054 gc.cpp:143] Deleted '/tmp/GarbageCollectorIntegrationTest_ExitedExecutor_uJQnQE/slaves/20140704-033056-1032504131-51677-1029-0/frameworks/20140704-033056-1032504131-51677-1029-0000/executors/default/runs/35320140-231c-424a-b764-079c5774f898'
I0704 03:30:56.259985 1053 master.hpp:794] Adding offer 20140704-033056-1032504131-51677-1029-1 with resources disk(*):1024; ports(*):[31000-32000]; cpus(*):2; mem(*):1024 on slave 20140704-033056-1032504131-51677-1029-0 (juno.apache.org)
I0704 03:30:56.260006 1054 gc.cpp:134] Deleting /tmp/GarbageCollectorIntegrationTest_ExitedExecutor_uJQnQE/slaves/20140704-033056-1032504131-51677-1029-0/frameworks/20140704-033056-1032504131-51677-1029-0000/executors/default
I0704 03:30:56.260042 1053 master.cpp:3449] Sending 1 offers to framework 20140704-033056-1032504131-51677-1029-0000
I0704 03:30:56.259872 1057 slave.cpp:2323] Received ping from slave-observer(161)@67.195.138.61:51677
I0704 03:30:56.260126 1054 gc.cpp:143] Deleted '/tmp/GarbageCollectorIntegrationTest_ExitedExecutor_uJQnQE/slaves/20140704-033056-1032504131-51677-1029-0/frameworks/20140704-033056-1032504131-51677-1029-0000/executors/default'
I0704 03:30:56.260143 1054 gc.cpp:134] Deleting /tmp/GarbageCollectorIntegrationTest_ExitedExecutor_uJQnQE/slaves/20140704-033056-1032504131-51677-1029-0/frameworks/20140704-033056-1032504131-51677-1029-0000
I0704 03:30:56.260150 1051 master.cpp:122] No whitelist given. Advertising offers for all slaves
I0704 03:30:56.260161 1055 sched.cpp:546] Scheduler::resourceOffers took 10637ns
I0704 03:30:56.260221 1054 gc.cpp:143] Deleted '/tmp/GarbageCollectorIntegrationTest_ExitedExecutor_uJQnQE/slaves/20140704-033056-1032504131-51677-1029-0/frameworks/20140704-033056-1032504131-51677-1029-0000'
I0704 03:30:56.269799 1057 process.cpp:3335] Handling HTTP event for process 'files' with path: '/files/browse.json'
I0704 03:30:56.270134 1058 process.cpp:1037] Socket closed while receiving
I0704 03:30:56.279919 1056 sched.cpp:747] Stopping framework '20140704-033056-1032504131-51677-1029-0000'
I0704 03:30:56.279924 1029 master.cpp:620] Master terminating
I0704 03:30:56.280041 1029 master.hpp:804] Removing offer 20140704-033056-1032504131-51677-1029-1 with resources disk(*):1024; ports(*):[31000-32000]; cpus(*):2; mem(*):1024 on slave 20140704-033056-1032504131-51677-1029-0 (juno.apache.org)
I0704 03:30:56.280598 1055 slave.cpp:2330] master@67.195.138.61:51677 exited
W0704 03:30:56.280617 1055 slave.cpp:2333] Master disconnected! Waiting for a new master to be elected
I0704 03:30:56.282644 1029 slave.cpp:484] Slave terminating
[ OK ] GarbageCollectorIntegrationTest.ExitedExecutor (286 ms)
[----------] 5 tests from GarbageCollectorIntegrationTest (1717 ms total)
[----------] Global test environment tear-down
[==========] 384 tests from 62 test cases ran. (325474 ms total)
[ PASSED ] 383 tests.
[ FAILED ] 1 test, listed below:
[ FAILED ] ReservationAllocatorTest.ResourcesReturned
1 FAILED TEST
YOU HAVE 7 DISABLED TESTS
make[4]: *** [check-local] Error 1
make[4]: Leaving directory `<https://builds.apache.org/job/Mesos-Trunk-Ubuntu-Build-In-Src-Set-JAVA_HOME/ws/mesos-0.20.0/_build/src'>
make[3]: *** [check-am] Error 2
make[3]: Leaving directory `<https://builds.apache.org/job/Mesos-Trunk-Ubuntu-Build-In-Src-Set-JAVA_HOME/ws/mesos-0.20.0/_build/src'>
make[2]: *** [check] Error 2
make[2]: Leaving directory `<https://builds.apache.org/job/Mesos-Trunk-Ubuntu-Build-In-Src-Set-JAVA_HOME/ws/mesos-0.20.0/_build/src'>
make[1]: *** [check-recursive] Error 1
make[1]: Leaving directory `<https://builds.apache.org/job/Mesos-Trunk-Ubuntu-Build-In-Src-Set-JAVA_HOME/ws/mesos-0.20.0/_build'>
make: *** [distcheck] Error 1
Build step 'Execute shell' marked build as failure
Jenkins build is back to normal :
Mesos-Trunk-Ubuntu-Build-In-Src-Set-JAVA_HOME #1978
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/Mesos-Trunk-Ubuntu-Build-In-Src-Set-JAVA_HOME/1978/changes>
Re: Build failed in Jenkins: Mesos-Trunk-Ubuntu-Build-In-Src-Set-JAVA_HOME
#1977
Posted by Yan Xu <ya...@jxu.me>.
This is https://issues.apache.org/jira/browse/MESOS-1250
--
Jiang Yan Xu <ya...@jxu.me> @xujyan <http://twitter.com/xujyan>
On Thu, Jul 3, 2014 at 8:30 PM, Apache Jenkins Server <
jenkins@builds.apache.org> wrote:
> See <
> https://builds.apache.org/job/Mesos-Trunk-Ubuntu-Build-In-Src-Set-JAVA_HOME/1977/changes
> >
>
> Changes:
>
> [yan] Improved gate.hpp documentation.
>
> [yan] Created an example LoadGeneratorScheduler to test Master's framework
> rate limiting feature.
>
> [vinodkone] PortMapping: allow containers to recover even when they were
> not
>
> [vinodkone] Minor fix to mesos_tests_SOURCES in Makefile.am
>
> ------------------------------------------
> [...truncated 59532 lines...]
> I0704 03:30:56.127792 1054 leveldb.cpp:306] Persisting metadata (8 bytes)
> to leveldb took 22.385668ms
> I0704 03:30:56.127812 1054 replica.cpp:320] Persisted replica status to
> STARTING
> I0704 03:30:56.127887 1054 recover.cpp:451] Replica is in STARTING status
> I0704 03:30:56.128208 1053 replica.cpp:638] Replica in STARTING status
> received a broadcasted recover request
> I0704 03:30:56.128286 1057 recover.cpp:188] Received a recover response
> from a replica in STARTING status
> I0704 03:30:56.128411 1057 recover.cpp:542] Updating replica status to
> VOTING
> I0704 03:30:56.133699 1057 leveldb.cpp:306] Persisting metadata (8 bytes)
> to leveldb took 5.232652ms
> I0704 03:30:56.133718 1057 replica.cpp:320] Persisted replica status to
> VOTING
> I0704 03:30:56.133759 1057 recover.cpp:556] Successfully joined the Paxos
> group
> I0704 03:30:56.133821 1057 recover.cpp:440] Recover process terminated
> I0704 03:30:56.133941 1057 log.cpp:656] Attempting to start the writer
> I0704 03:30:56.134290 1053 replica.cpp:474] Replica received implicit
> promise request with proposal 1
> I0704 03:30:56.142029 1053 leveldb.cpp:306] Persisting metadata (8 bytes)
> to leveldb took 7.717529ms
> I0704 03:30:56.142046 1053 replica.cpp:342] Persisted promised to 1
> I0704 03:30:56.142241 1053 coordinator.cpp:230] Coordinator attemping to
> fill missing position
> I0704 03:30:56.142639 1053 replica.cpp:375] Replica received explicit
> promise request for position 0 with proposal 2
> I0704 03:30:56.150357 1053 leveldb.cpp:343] Persisting action (8 bytes)
> to leveldb took 7.702259ms
> I0704 03:30:56.150377 1053 replica.cpp:676] Persisted action at 0
> I0704 03:30:56.150672 1053 replica.cpp:508] Replica received write
> request for position 0
> I0704 03:30:56.150693 1053 leveldb.cpp:438] Reading position from leveldb
> took 10797ns
> I0704 03:30:56.158687 1053 leveldb.cpp:343] Persisting action (14 bytes)
> to leveldb took 7.97992ms
> I0704 03:30:56.158705 1053 replica.cpp:676] Persisted action at 0
> I0704 03:30:56.158860 1053 replica.cpp:655] Replica received learned
> notice for position 0
> I0704 03:30:56.167023 1053 leveldb.cpp:343] Persisting action (16 bytes)
> to leveldb took 8.144982ms
> I0704 03:30:56.167042 1053 replica.cpp:676] Persisted action at 0
> I0704 03:30:56.167050 1053 replica.cpp:661] Replica learned NOP action at
> position 0
> I0704 03:30:56.167232 1053 log.cpp:672] Writer started with ending
> position 0
> I0704 03:30:56.167525 1053 leveldb.cpp:438] Reading position from leveldb
> took 7782ns
> I0704 03:30:56.169028 1055 registrar.cpp:346] Successfully fetched the
> registry (0B)
> I0704 03:30:56.169059 1055 registrar.cpp:422] Attempting to update the
> 'registry'
> I0704 03:30:56.170518 1051 log.cpp:680] Attempting to append 136 bytes to
> the log
> I0704 03:30:56.170570 1051 coordinator.cpp:340] Coordinator attempting to
> write APPEND action at position 1
> I0704 03:30:56.170794 1051 replica.cpp:508] Replica received write
> request for position 1
> I0704 03:30:56.175344 1051 leveldb.cpp:343] Persisting action (155 bytes)
> to leveldb took 4.537003ms
> I0704 03:30:56.175362 1051 replica.cpp:676] Persisted action at 1
> I0704 03:30:56.175557 1051 replica.cpp:655] Replica received learned
> notice for position 1
> I0704 03:30:56.183676 1051 leveldb.cpp:343] Persisting action (157 bytes)
> to leveldb took 8.106349ms
> I0704 03:30:56.183696 1051 replica.cpp:676] Persisted action at 1
> I0704 03:30:56.183704 1051 replica.cpp:661] Replica learned APPEND action
> at position 1
> I0704 03:30:56.183987 1051 registrar.cpp:479] Successfully updated
> 'registry'
> I0704 03:30:56.184023 1051 registrar.cpp:372] Successfully recovered
> registrar
> I0704 03:30:56.184067 1051 log.cpp:699] Attempting to truncate the log to
> 1
> I0704 03:30:56.184134 1051 master.cpp:981] Recovered 0 slaves from the
> Registry (98B) ; allowing 10mins for slaves to re-register
> I0704 03:30:56.184173 1051 coordinator.cpp:340] Coordinator attempting to
> write TRUNCATE action at position 2
> I0704 03:30:56.184470 1051 replica.cpp:508] Replica received write
> request for position 2
> I0704 03:30:56.192004 1051 leveldb.cpp:343] Persisting action (16 bytes)
> to leveldb took 7.519029ms
> I0704 03:30:56.192023 1051 replica.cpp:676] Persisted action at 2
> I0704 03:30:56.192206 1051 replica.cpp:655] Replica received learned
> notice for position 2
> I0704 03:30:56.200333 1051 leveldb.cpp:343] Persisting action (18 bytes)
> to leveldb took 8.114395ms
> I0704 03:30:56.200371 1051 leveldb.cpp:401] Deleting ~1 keys from leveldb
> took 19866ns
> I0704 03:30:56.200381 1051 replica.cpp:676] Persisted action at 2
> I0704 03:30:56.200391 1051 replica.cpp:661] Replica learned TRUNCATE
> action at position 2
> I0704 03:30:56.207379 1055 slave.cpp:168] Slave started on 192)@
> 67.195.138.61:51677
> I0704 03:30:56.207394 1055 credentials.hpp:84] Loading credential for
> authentication from
> '/tmp/GarbageCollectorIntegrationTest_ExitedExecutor_uJQnQE/credential'
> I0704 03:30:56.207460 1055 slave.cpp:266] Slave using credential for:
> test-principal
> I0704 03:30:56.207566 1055 slave.cpp:279] Slave resources: cpus(*):2;
> mem(*):1024; disk(*):1024; ports(*):[31000-32000]
> I0704 03:30:56.207619 1055 slave.cpp:324] Slave hostname: juno.apache.org
> I0704 03:30:56.207628 1055 slave.cpp:325] Slave checkpoint: false
> I0704 03:30:56.208169 1054 state.cpp:33] Recovering state from
> '/tmp/GarbageCollectorIntegrationTest_ExitedExecutor_uJQnQE/meta'
> I0704 03:30:56.208268 1054 status_update_manager.cpp:193] Recovering
> status update manager
> I0704 03:30:56.208415 1054 slave.cpp:3126] Finished recovery
> I0704 03:30:56.208622 1054 slave.cpp:599] New master detected at
> master@67.195.138.61:51677
> I0704 03:30:56.208642 1054 slave.cpp:675] Authenticating with master
> master@67.195.138.61:51677
> I0704 03:30:56.208678 1054 slave.cpp:648] Detecting new master
> I0704 03:30:56.208714 1054 status_update_manager.cpp:167] New master
> detected at master@67.195.138.61:51677
> I0704 03:30:56.208748 1054 authenticatee.hpp:128] Creating new client
> SASL connection
> I0704 03:30:56.208880 1054 master.cpp:3502] Authenticating slave(192)@
> 67.195.138.61:51677
> I0704 03:30:56.208959 1054 authenticator.hpp:156] Creating new server
> SASL connection
> I0704 03:30:56.209053 1054 authenticatee.hpp:219] Received SASL
> authentication mechanisms: CRAM-MD5
> I0704 03:30:56.209069 1054 authenticatee.hpp:245] Attempting to
> authenticate with mechanism 'CRAM-MD5'
> I0704 03:30:56.209097 1054 authenticator.hpp:262] Received SASL
> authentication start
> I0704 03:30:56.209130 1054 authenticator.hpp:384] Authentication requires
> more steps
> I0704 03:30:56.209156 1054 authenticatee.hpp:265] Received SASL
> authentication step
> I0704 03:30:56.209194 1054 authenticator.hpp:290] Received SASL
> authentication step
> I0704 03:30:56.209210 1054 auxprop.cpp:81] Request to lookup properties
> for user: 'test-principal' realm: 'juno.apache.org' server FQDN: '
> juno.apache.org' SASL_AUXPROP_VERIFY_AGAINST_HASH: false
> SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false
> I0704 03:30:56.209218 1054 auxprop.cpp:153] Looking up auxiliary property
> '*userPassword'
> I0704 03:30:56.209229 1054 auxprop.cpp:153] Looking up auxiliary property
> '*cmusaslsecretCRAM-MD5'
> I0704 03:30:56.209239 1054 auxprop.cpp:81] Request to lookup properties
> for user: 'test-principal' realm: 'juno.apache.org' server FQDN: '
> juno.apache.org' SASL_AUXPROP_VERIFY_AGAINST_HASH: false
> SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true
> I0704 03:30:56.209246 1054 auxprop.cpp:103] Skipping auxiliary property
> '*userPassword' since SASL_AUXPROP_AUTHZID == true
> I0704 03:30:56.209252 1054 auxprop.cpp:103] Skipping auxiliary property
> '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
> I0704 03:30:56.209264 1054 authenticator.hpp:376] Authentication success
> I0704 03:30:56.209291 1054 authenticatee.hpp:305] Authentication success
> I0704 03:30:56.209313 1054 master.cpp:3542] Successfully authenticated
> principal 'test-principal' at slave(192)@67.195.138.61:51677
> I0704 03:30:56.209378 1054 slave.cpp:732] Successfully authenticated with
> master master@67.195.138.61:51677
> I0704 03:30:56.209410 1054 slave.cpp:970] Will retry registration in
> 7.69748ms if necessary
> I0704 03:30:56.209475 1054 master.cpp:2784] Registering slave at
> slave(192)@67.195.138.61:51677 (juno.apache.org) with id
> 20140704-033056-1032504131-51677-1029-0
> I0704 03:30:56.209672 1057 registrar.cpp:422] Attempting to update the
> 'registry'
> I0704 03:30:56.211299 1052 log.cpp:680] Attempting to append 326 bytes to
> the log
> I0704 03:30:56.211357 1052 coordinator.cpp:340] Coordinator attempting to
> write APPEND action at position 3
> I0704 03:30:56.211580 1052 replica.cpp:508] Replica received write
> request for position 3
> I0704 03:30:56.216995 1052 leveldb.cpp:343] Persisting action (345 bytes)
> to leveldb took 5.4013ms
> I0704 03:30:56.217015 1052 replica.cpp:676] Persisted action at 3
> I0704 03:30:56.217207 1052 replica.cpp:655] Replica received learned
> notice for position 3
> I0704 03:30:56.217659 1054 slave.cpp:970] Will retry registration in
> 16.551732ms if necessary
> I0704 03:30:56.217689 1056 master.cpp:2772] Ignoring register slave
> message from slave(192)@67.195.138.61:51677 (juno.apache.org) as
> admission is already in progress
> I0704 03:30:56.225322 1052 leveldb.cpp:343] Persisting action (347 bytes)
> to leveldb took 8.102932ms
> I0704 03:30:56.225340 1052 replica.cpp:676] Persisted action at 3
> I0704 03:30:56.225349 1052 replica.cpp:661] Replica learned APPEND action
> at position 3
> I0704 03:30:56.225733 1057 registrar.cpp:479] Successfully updated
> 'registry'
> I0704 03:30:56.225841 1052 log.cpp:699] Attempting to truncate the log to
> 3
> I0704 03:30:56.225883 1053 master.cpp:2824] Registered slave
> 20140704-033056-1032504131-51677-1029-0 at slave(192)@67.195.138.61:51677
> (juno.apache.org)
> I0704 03:30:56.225904 1054 coordinator.cpp:340] Coordinator attempting to
> write TRUNCATE action at position 4
> I0704 03:30:56.225901 1053 master.cpp:3970] Adding slave
> 20140704-033056-1032504131-51677-1029-0 at slave(192)@67.195.138.61:51677
> (juno.apache.org) with cpus(*):2; mem(*):1024; disk(*):1024;
> ports(*):[31000-32000]
> I0704 03:30:56.226016 1056 slave.cpp:766] Registered with master
> master@67.195.138.61:51677; given slave ID
> 20140704-033056-1032504131-51677-1029-0
> I0704 03:30:56.226065 1056 slave.cpp:2323] Received ping from
> slave-observer(161)@67.195.138.61:51677
> I0704 03:30:56.226094 1053 hierarchical_allocator_process.hpp:444] Added
> slave 20140704-033056-1032504131-51677-1029-0 (juno.apache.org) with
> cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] (and
> cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] available)
> I0704 03:30:56.226135 1053 hierarchical_allocator_process.hpp:706]
> Performed allocation for slave 20140704-033056-1032504131-51677-1029-0 in
> 9840ns
> I0704 03:30:56.226269 1051 replica.cpp:508] Replica received write
> request for position 4
> I0704 03:30:56.229217 1029 sched.cpp:139] Version: 0.20.0
> I0704 03:30:56.229383 1056 sched.cpp:235] New master detected at
> master@67.195.138.61:51677
> I0704 03:30:56.229403 1056 sched.cpp:285] Authenticating with master
> master@67.195.138.61:51677
> I0704 03:30:56.229477 1052 authenticatee.hpp:128] Creating new client
> SASL connection
> I0704 03:30:56.229672 1050 master.cpp:3502] Authenticating
> scheduler-cd36b619-77ba-4862-9aa0-742da41e2b5d@67.195.138.61:51677
> I0704 03:30:56.229771 1050 authenticator.hpp:156] Creating new server
> SASL connection
> I0704 03:30:56.229882 1050 authenticatee.hpp:219] Received SASL
> authentication mechanisms: CRAM-MD5
> I0704 03:30:56.229898 1050 authenticatee.hpp:245] Attempting to
> authenticate with mechanism 'CRAM-MD5'
> I0704 03:30:56.229926 1050 authenticator.hpp:262] Received SASL
> authentication start
> I0704 03:30:56.229966 1050 authenticator.hpp:384] Authentication requires
> more steps
> I0704 03:30:56.229992 1050 authenticatee.hpp:265] Received SASL
> authentication step
> I0704 03:30:56.230031 1050 authenticator.hpp:290] Received SASL
> authentication step
> I0704 03:30:56.230047 1050 auxprop.cpp:81] Request to lookup properties
> for user: 'test-principal' realm: 'juno.apache.org' server FQDN: '
> juno.apache.org' SASL_AUXPROP_VERIFY_AGAINST_HASH: false
> SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false
> I0704 03:30:56.230056 1050 auxprop.cpp:153] Looking up auxiliary property
> '*userPassword'
> I0704 03:30:56.230067 1050 auxprop.cpp:153] Looking up auxiliary property
> '*cmusaslsecretCRAM-MD5'
> I0704 03:30:56.230077 1050 auxprop.cpp:81] Request to lookup properties
> for user: 'test-principal' realm: 'juno.apache.org' server FQDN: '
> juno.apache.org' SASL_AUXPROP_VERIFY_AGAINST_HASH: false
> SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true
> I0704 03:30:56.230085 1050 auxprop.cpp:103] Skipping auxiliary property
> '*userPassword' since SASL_AUXPROP_AUTHZID == true
> I0704 03:30:56.230092 1050 auxprop.cpp:103] Skipping auxiliary property
> '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
> I0704 03:30:56.230103 1050 authenticator.hpp:376] Authentication success
> I0704 03:30:56.230130 1050 authenticatee.hpp:305] Authentication success
> I0704 03:30:56.230154 1050 master.cpp:3542] Successfully authenticated
> principal 'test-principal' at
> scheduler-cd36b619-77ba-4862-9aa0-742da41e2b5d@67.195.138.61:51677
> I0704 03:30:56.230228 1050 sched.cpp:359] Successfully authenticated with
> master master@67.195.138.61:51677
> I0704 03:30:56.230239 1050 sched.cpp:478] Sending registration request to
> master@67.195.138.61:51677
> I0704 03:30:56.230284 1050 master.cpp:1242] Received registration request
> from scheduler-cd36b619-77ba-4862-9aa0-742da41e2b5d@67.195.138.61:51677
> I0704 03:30:56.230304 1050 master.cpp:1202] Authorizing framework
> principal 'test-principal' to receive offers for role '*'
> I0704 03:30:56.230432 1050 master.cpp:1301] Registering framework
> 20140704-033056-1032504131-51677-1029-0000 at
> scheduler-cd36b619-77ba-4862-9aa0-742da41e2b5d@67.195.138.61:51677
> I0704 03:30:56.230525 1050 sched.cpp:409] Framework registered with
> 20140704-033056-1032504131-51677-1029-0000
> I0704 03:30:56.230551 1050 sched.cpp:423] Scheduler::registered took
> 16347ns
> I0704 03:30:56.230586 1050 hierarchical_allocator_process.hpp:331] Added
> framework 20140704-033056-1032504131-51677-1029-0000
> I0704 03:30:56.230626 1050 hierarchical_allocator_process.hpp:750]
> Offering cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] on
> slave 20140704-033056-1032504131-51677-1029-0 to framework
> 20140704-033056-1032504131-51677-1029-0000
> I0704 03:30:56.230762 1050 hierarchical_allocator_process.hpp:686]
> Performed allocation for 1 slaves in 163958ns
> I0704 03:30:56.230871 1050 master.hpp:794] Adding offer
> 20140704-033056-1032504131-51677-1029-0 with resources cpus(*):2;
> mem(*):1024; disk(*):1024; ports(*):[31000-32000] on slave
> 20140704-033056-1032504131-51677-1029-0 (juno.apache.org)
> I0704 03:30:56.230921 1050 master.cpp:3449] Sending 1 offers to framework
> 20140704-033056-1032504131-51677-1029-0000
> I0704 03:30:56.231220 1050 sched.cpp:546] Scheduler::resourceOffers took
> 175724ns
> I0704 03:30:56.231405 1050 master.hpp:804] Removing offer
> 20140704-033056-1032504131-51677-1029-0 with resources cpus(*):2;
> mem(*):1024; disk(*):1024; ports(*):[31000-32000] on slave
> 20140704-033056-1032504131-51677-1029-0 (juno.apache.org)
> I0704 03:30:56.231459 1050 master.cpp:2128] Processing reply for offers:
> [ 20140704-033056-1032504131-51677-1029-0 ] on slave
> 20140704-033056-1032504131-51677-1029-0 at slave(192)@67.195.138.61:51677
> (juno.apache.org) for framework 20140704-033056-1032504131-51677-1029-0000
> I0704 03:30:56.231485 1050 master.cpp:2214] Authorizing framework
> principal 'test-principal' to launch task 0 as user 'jenkins'
> I0704 03:30:56.231832 1050 master.hpp:766] Adding task 0 with resources
> cpus(*):2; mem(*):1024 on slave 20140704-033056-1032504131-51677-1029-0 (
> juno.apache.org)
> I0704 03:30:56.231859 1050 master.cpp:2280] Launching task 0 of framework
> 20140704-033056-1032504131-51677-1029-0000 with resources cpus(*):2;
> mem(*):1024 on slave 20140704-033056-1032504131-51677-1029-0 at slave(192)@
> 67.195.138.61:51677 (juno.apache.org)
> I0704 03:30:56.231992 1050 slave.cpp:1001] Got assigned task 0 for
> framework 20140704-033056-1032504131-51677-1029-0000
> I0704 03:30:56.232172 1050 slave.cpp:1111] Launching task 0 for framework
> 20140704-033056-1032504131-51677-1029-0000
> I0704 03:30:56.232414 1054 hierarchical_allocator_process.hpp:546]
> Framework 20140704-033056-1032504131-51677-1029-0000 left disk(*):1024;
> ports(*):[31000-32000] unused on slave
> 20140704-033056-1032504131-51677-1029-0
> I0704 03:30:56.232480 1054 hierarchical_allocator_process.hpp:588]
> Framework 20140704-033056-1032504131-51677-1029-0000 filtered slave
> 20140704-033056-1032504131-51677-1029-0 for 5secs
> I0704 03:30:56.233654 1051 leveldb.cpp:343] Persisting action (16 bytes)
> to leveldb took 7.370214ms
> I0704 03:30:56.233675 1051 replica.cpp:676] Persisted action at 4
> I0704 03:30:56.233857 1051 replica.cpp:655] Replica received learned
> notice for position 4
> I0704 03:30:56.235409 1050 exec.cpp:131] Version: 0.20.0
> I0704 03:30:56.235476 1056 exec.cpp:181] Executor started at:
> executor(62)@67.195.138.61:51677 with pid 1029
> I0704 03:30:56.235533 1050 slave.cpp:1221] Queuing task '0' for executor
> default of framework '20140704-033056-1032504131-51677-1029-0000
> I0704 03:30:56.235599 1050 slave.cpp:560] Successfully attached file
> '/tmp/GarbageCollectorIntegrationTest_ExitedExecutor_uJQnQE/slaves/20140704-033056-1032504131-51677-1029-0/frameworks/20140704-033056-1032504131-51677-1029-0000/executors/default/runs/35320140-231c-424a-b764-079c5774f898'
> I0704 03:30:56.235635 1050 slave.cpp:2468] Monitoring executor 'default'
> of framework '20140704-033056-1032504131-51677-1029-0000' in container
> '35320140-231c-424a-b764-079c5774f898'
> I0704 03:30:56.235699 1050 slave.cpp:1732] Got registration for executor
> 'default' of framework 20140704-033056-1032504131-51677-1029-0000
> I0704 03:30:56.235810 1050 slave.cpp:1851] Flushing queued task 0 for
> executor 'default' of framework 20140704-033056-1032504131-51677-1029-0000
> I0704 03:30:56.235857 1052 exec.cpp:205] Executor registered on slave
> 20140704-033056-1032504131-51677-1029-0
> I0704 03:30:56.237129 1052 exec.cpp:217] Executor::registered took 11486ns
> I0704 03:30:56.237196 1052 exec.cpp:292] Executor asked to run task '0'
> I0704 03:30:56.237231 1052 exec.cpp:301] Executor::launchTask took 21116ns
> I0704 03:30:56.238478 1052 exec.cpp:524] Executor sending status update
> TASK_RUNNING (UUID: a9235d02-1de9-4d01-891c-58baff6551bb) for task 0 of
> framework 20140704-033056-1032504131-51677-1029-0000
> I0704 03:30:56.238556 1052 slave.cpp:2086] Handling status update
> TASK_RUNNING (UUID: a9235d02-1de9-4d01-891c-58baff6551bb) for task 0 of
> framework 20140704-033056-1032504131-51677-1029-0000 from executor(62)@
> 67.195.138.61:51677
> I0704 03:30:56.238665 1057 status_update_manager.cpp:320] Received status
> update TASK_RUNNING (UUID: a9235d02-1de9-4d01-891c-58baff6551bb) for task 0
> of framework 20140704-033056-1032504131-51677-1029-0000
> I0704 03:30:56.238683 1057 status_update_manager.cpp:499] Creating
> StatusUpdate stream for task 0 of framework
> 20140704-033056-1032504131-51677-1029-0000
> I0704 03:30:56.238756 1057 status_update_manager.cpp:373] Forwarding
> status update TASK_RUNNING (UUID: a9235d02-1de9-4d01-891c-58baff6551bb) for
> task 0 of framework 20140704-033056-1032504131-51677-1029-0000 to
> master@67.195.138.61:51677
> I0704 03:30:56.238845 1057 slave.cpp:2244] Status update manager
> successfully handled status update TASK_RUNNING (UUID:
> a9235d02-1de9-4d01-891c-58baff6551bb) for task 0 of framework
> 20140704-033056-1032504131-51677-1029-0000
> I0704 03:30:56.238860 1057 slave.cpp:2250] Sending acknowledgement for
> status update TASK_RUNNING (UUID: a9235d02-1de9-4d01-891c-58baff6551bb) for
> task 0 of framework 20140704-033056-1032504131-51677-1029-0000 to
> executor(62)@67.195.138.61:51677
> I0704 03:30:56.238862 1052 master.cpp:3110] Status update TASK_RUNNING
> (UUID: a9235d02-1de9-4d01-891c-58baff6551bb) for task 0 of framework
> 20140704-033056-1032504131-51677-1029-0000 from slave
> 20140704-033056-1032504131-51677-1029-0 at slave(192)@67.195.138.61:51677
> (juno.apache.org)
> I0704 03:30:56.238929 1057 exec.cpp:338] Executor received status update
> acknowledgement a9235d02-1de9-4d01-891c-58baff6551bb for task 0 of
> framework 20140704-033056-1032504131-51677-1029-0000
> I0704 03:30:56.238944 1052 sched.cpp:637] Scheduler::statusUpdate took
> 20246ns
> I0704 03:30:56.239025 1057 master.cpp:2634] Forwarding status update
> acknowledgement a9235d02-1de9-4d01-891c-58baff6551bb for task 0 of
> framework 20140704-033056-1032504131-51677-1029-0000 to slave
> 20140704-033056-1032504131-51677-1029-0 at slave(192)@67.195.138.61:51677
> (juno.apache.org)
> I0704 03:30:56.239116 1057 status_update_manager.cpp:398] Received status
> update acknowledgement (UUID: a9235d02-1de9-4d01-891c-58baff6551bb) for
> task 0 of framework 20140704-033056-1032504131-51677-1029-0000
> I0704 03:30:56.239255 1055 slave.cpp:1672] Status update manager
> successfully handled status update acknowledgement (UUID:
> a9235d02-1de9-4d01-891c-58baff6551bb) for task 0 of framework
> 20140704-033056-1032504131-51677-1029-0000
> I0704 03:30:56.239308 1055 slave.cpp:2526] Executor 'default' of
> framework 20140704-033056-1032504131-51677-1029-0000 exited with status 0
> I0704 03:30:56.240603 1055 slave.cpp:2086] Handling status update
> TASK_LOST (UUID: f3311ef0-834a-4e66-b572-eb90b3b018b6) for task 0 of
> framework 20140704-033056-1032504131-51677-1029-0000 from @0.0.0.0:0
> I0704 03:30:56.240625 1055 slave.cpp:3768] Terminating task 0
> I0704 03:30:56.240777 1056 master.cpp:3186] Executor default of framework
> 20140704-033056-1032504131-51677-1029-0000 on slave
> 20140704-033056-1032504131-51677-1029-0 at slave(192)@67.195.138.61:51677
> (juno.apache.org) exited with status 0
> I0704 03:30:56.240857 1054 status_update_manager.cpp:320] Received status
> update TASK_LOST (UUID: f3311ef0-834a-4e66-b572-eb90b3b018b6) for task 0 of
> framework 20140704-033056-1032504131-51677-1029-0000
> I0704 03:30:56.240903 1054 status_update_manager.cpp:373] Forwarding
> status update TASK_LOST (UUID: f3311ef0-834a-4e66-b572-eb90b3b018b6) for
> task 0 of framework 20140704-033056-1032504131-51677-1029-0000 to
> master@67.195.138.61:51677
> I0704 03:30:56.241024 1052 master.cpp:3110] Status update TASK_LOST
> (UUID: f3311ef0-834a-4e66-b572-eb90b3b018b6) for task 0 of framework
> 20140704-033056-1032504131-51677-1029-0000 from slave
> 20140704-033056-1032504131-51677-1029-0 at slave(192)@67.195.138.61:51677
> (juno.apache.org)
> I0704 03:30:56.241044 1053 slave.cpp:2244] Status update manager
> successfully handled status update TASK_LOST (UUID:
> f3311ef0-834a-4e66-b572-eb90b3b018b6) for task 0 of framework
> 20140704-033056-1032504131-51677-1029-0000
> I0704 03:30:56.241073 1052 master.hpp:784] Removing task 0 with resources
> cpus(*):2; mem(*):1024 on slave 20140704-033056-1032504131-51677-1029-0 (
> juno.apache.org)
> I0704 03:30:56.241122 1054 sched.cpp:637] Scheduler::statusUpdate took
> 11658ns
> I0704 03:30:56.241189 1057 master.cpp:2634] Forwarding status update
> acknowledgement f3311ef0-834a-4e66-b572-eb90b3b018b6 for task 0 of
> framework 20140704-033056-1032504131-51677-1029-0000 to slave
> 20140704-033056-1032504131-51677-1029-0 at slave(192)@67.195.138.61:51677
> (juno.apache.org)
> I0704 03:30:56.241195 1053 hierarchical_allocator_process.hpp:635]
> Recovered cpus(*):2; mem(*):1024 (total allocatable: disk(*):1024;
> ports(*):[31000-32000]; cpus(*):2; mem(*):1024) on slave
> 20140704-033056-1032504131-51677-1029-0 from framework
> 20140704-033056-1032504131-51677-1029-0000
> I0704 03:30:56.241271 1053 status_update_manager.cpp:398] Received status
> update acknowledgement (UUID: f3311ef0-834a-4e66-b572-eb90b3b018b6) for
> task 0 of framework 20140704-033056-1032504131-51677-1029-0000
> I0704 03:30:56.241297 1053 status_update_manager.cpp:530] Cleaning up
> status update stream for task 0 of framework
> 20140704-033056-1032504131-51677-1029-0000
> I0704 03:30:56.241379 1057 slave.cpp:1672] Status update manager
> successfully handled status update acknowledgement (UUID:
> f3311ef0-834a-4e66-b572-eb90b3b018b6) for task 0 of framework
> 20140704-033056-1032504131-51677-1029-0000
> I0704 03:30:56.241396 1057 slave.cpp:3810] Completing task 0
> I0704 03:30:56.241406 1057 slave.cpp:2660] Cleaning up executor 'default'
> of framework 20140704-033056-1032504131-51677-1029-0000
> I0704 03:30:56.241482 1053 gc.cpp:56] Scheduling
> '/tmp/GarbageCollectorIntegrationTest_ExitedExecutor_uJQnQE/slaves/20140704-033056-1032504131-51677-1029-0/frameworks/20140704-033056-1032504131-51677-1029-0000/executors/default/runs/35320140-231c-424a-b764-079c5774f898'
> for gc 6.99999723250074days in the future
> I0704 03:30:56.241507 1057 slave.cpp:2735] Cleaning up framework
> 20140704-033056-1032504131-51677-1029-0000
> I0704 03:30:56.241533 1053 gc.cpp:56] Scheduling
> '/tmp/GarbageCollectorIntegrationTest_ExitedExecutor_uJQnQE/slaves/20140704-033056-1032504131-51677-1029-0/frameworks/20140704-033056-1032504131-51677-1029-0000/executors/default'
> for gc 6.99999723250074days in the future
> I0704 03:30:56.241572 1057 status_update_manager.cpp:282] Closing status
> update streams for framework 20140704-033056-1032504131-51677-1029-0000
> I0704 03:30:56.241587 1053 gc.cpp:56] Scheduling
> '/tmp/GarbageCollectorIntegrationTest_ExitedExecutor_uJQnQE/slaves/20140704-033056-1032504131-51677-1029-0/frameworks/20140704-033056-1032504131-51677-1029-0000'
> for gc 6.99999723250074days in the future
> I0704 03:30:56.241986 1051 leveldb.cpp:343] Persisting action (18 bytes)
> to leveldb took 8.112809ms
> I0704 03:30:56.242019 1051 leveldb.cpp:401] Deleting ~2 keys from leveldb
> took 15413ns
> I0704 03:30:56.242030 1051 replica.cpp:676] Persisted action at 4
> I0704 03:30:56.242038 1051 replica.cpp:661] Replica learned TRUNCATE
> action at position 4
> I0704 03:30:56.259696 1056 hierarchical_allocator_process.hpp:750]
> Offering disk(*):1024; ports(*):[31000-32000]; cpus(*):2; mem(*):1024 on
> slave 20140704-033056-1032504131-51677-1029-0 to framework
> 20140704-033056-1032504131-51677-1029-0000
> I0704 03:30:56.259742 1057 slave.cpp:2897] Framework
> 20140704-033056-1032504131-51677-1029-0000 seems to have exited. Ignoring
> registration timeout for executor 'default'
> I0704 03:30:56.259773 1057 slave.cpp:2981] Current usage 8.78%. Max
> allowed age: 5.685267086187338days
> I0704 03:30:56.259872 1054 gc.cpp:134] Deleting
> /tmp/GarbageCollectorIntegrationTest_ExitedExecutor_uJQnQE/slaves/20140704-033056-1032504131-51677-1029-0/frameworks/20140704-033056-1032504131-51677-1029-0000/executors/default/runs/35320140-231c-424a-b764-079c5774f898
> I0704 03:30:56.259932 1056 hierarchical_allocator_process.hpp:686]
> Performed allocation for 1 slaves in 295695ns
> I0704 03:30:56.259966 1054 gc.cpp:143] Deleted
> '/tmp/GarbageCollectorIntegrationTest_ExitedExecutor_uJQnQE/slaves/20140704-033056-1032504131-51677-1029-0/frameworks/20140704-033056-1032504131-51677-1029-0000/executors/default/runs/35320140-231c-424a-b764-079c5774f898'
> I0704 03:30:56.259985 1053 master.hpp:794] Adding offer
> 20140704-033056-1032504131-51677-1029-1 with resources disk(*):1024;
> ports(*):[31000-32000]; cpus(*):2; mem(*):1024 on slave
> 20140704-033056-1032504131-51677-1029-0 (juno.apache.org)
> I0704 03:30:56.260006 1054 gc.cpp:134] Deleting
> /tmp/GarbageCollectorIntegrationTest_ExitedExecutor_uJQnQE/slaves/20140704-033056-1032504131-51677-1029-0/frameworks/20140704-033056-1032504131-51677-1029-0000/executors/default
> I0704 03:30:56.260042 1053 master.cpp:3449] Sending 1 offers to framework
> 20140704-033056-1032504131-51677-1029-0000
> I0704 03:30:56.259872 1057 slave.cpp:2323] Received ping from
> slave-observer(161)@67.195.138.61:51677
> I0704 03:30:56.260126 1054 gc.cpp:143] Deleted
> '/tmp/GarbageCollectorIntegrationTest_ExitedExecutor_uJQnQE/slaves/20140704-033056-1032504131-51677-1029-0/frameworks/20140704-033056-1032504131-51677-1029-0000/executors/default'
> I0704 03:30:56.260143 1054 gc.cpp:134] Deleting
> /tmp/GarbageCollectorIntegrationTest_ExitedExecutor_uJQnQE/slaves/20140704-033056-1032504131-51677-1029-0/frameworks/20140704-033056-1032504131-51677-1029-0000
> I0704 03:30:56.260150 1051 master.cpp:122] No whitelist given.
> Advertising offers for all slaves
> I0704 03:30:56.260161 1055 sched.cpp:546] Scheduler::resourceOffers took
> 10637ns
> I0704 03:30:56.260221 1054 gc.cpp:143] Deleted
> '/tmp/GarbageCollectorIntegrationTest_ExitedExecutor_uJQnQE/slaves/20140704-033056-1032504131-51677-1029-0/frameworks/20140704-033056-1032504131-51677-1029-0000'
> I0704 03:30:56.269799 1057 process.cpp:3335] Handling HTTP event for
> process 'files' with path: '/files/browse.json'
> I0704 03:30:56.270134 1058 process.cpp:1037] Socket closed while receiving
> I0704 03:30:56.279919 1056 sched.cpp:747] Stopping framework
> '20140704-033056-1032504131-51677-1029-0000'
> I0704 03:30:56.279924 1029 master.cpp:620] Master terminating
> I0704 03:30:56.280041 1029 master.hpp:804] Removing offer
> 20140704-033056-1032504131-51677-1029-1 with resources disk(*):1024;
> ports(*):[31000-32000]; cpus(*):2; mem(*):1024 on slave
> 20140704-033056-1032504131-51677-1029-0 (juno.apache.org)
> I0704 03:30:56.280598 1055 slave.cpp:2330] master@67.195.138.61:51677
> exited
> W0704 03:30:56.280617 1055 slave.cpp:2333] Master disconnected! Waiting
> for a new master to be elected
> I0704 03:30:56.282644 1029 slave.cpp:484] Slave terminating
> [ OK ] GarbageCollectorIntegrationTest.ExitedExecutor (286 ms)
> [----------] 5 tests from GarbageCollectorIntegrationTest (1717 ms total)
>
> [----------] Global test environment tear-down
> [==========] 384 tests from 62 test cases ran. (325474 ms total)
> [ PASSED ] 383 tests.
> [ FAILED ] 1 test, listed below:
> [ FAILED ] ReservationAllocatorTest.ResourcesReturned
>
> 1 FAILED TEST
> YOU HAVE 7 DISABLED TESTS
>
> make[4]: *** [check-local] Error 1
> make[4]: Leaving directory `<
> https://builds.apache.org/job/Mesos-Trunk-Ubuntu-Build-In-Src-Set-JAVA_HOME/ws/mesos-0.20.0/_build/src
> '>
> make[3]: *** [check-am] Error 2
> make[3]: Leaving directory `<
> https://builds.apache.org/job/Mesos-Trunk-Ubuntu-Build-In-Src-Set-JAVA_HOME/ws/mesos-0.20.0/_build/src
> '>
> make[2]: *** [check] Error 2
> make[2]: Leaving directory `<
> https://builds.apache.org/job/Mesos-Trunk-Ubuntu-Build-In-Src-Set-JAVA_HOME/ws/mesos-0.20.0/_build/src
> '>
> make[1]: *** [check-recursive] Error 1
> make[1]: Leaving directory `<
> https://builds.apache.org/job/Mesos-Trunk-Ubuntu-Build-In-Src-Set-JAVA_HOME/ws/mesos-0.20.0/_build
> '>
> make: *** [distcheck] Error 1
> Build step 'Execute shell' marked build as failure
>