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-Out-Of-Src-Disable-Java-Disable-Python-Disable-Webui #2734
Date Tue, 10 Feb 2015 23:01:17 GMT
See <https://builds.apache.org/job/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Disable-Java-Disable-Python-Disable-Webui/2734/changes>

Changes:

[niklas] Renamed test allocator actions for consistency.

[niklas] Disabled installing module libraries.

------------------------------------------
[...truncated 68044 lines...]
I0210 23:00:45.319550 14675 replica.cpp:678] Persisted action at 1
I0210 23:00:45.322527 14684 replica.cpp:657] Replica received learned notice for position
1
I0210 23:00:45.323204 14684 leveldb.cpp:342] Persisting action (160 bytes) to leveldb took
647894ns
I0210 23:00:45.323235 14684 replica.cpp:678] Persisted action at 1
I0210 23:00:45.323259 14684 replica.cpp:663] Replica learned 2 action at position 1
I0210 23:00:45.324751 14681 log.cpp:702] Attempting to truncate the log to 1
I0210 23:00:45.324867 14675 coordinator.cpp:339] Coordinator attempting to write 3 action
at position 2
I0210 23:00:45.325716 14674 registrar.cpp:489] Successfully updated the 'registry' in 10.863104ms
I0210 23:00:45.325798 14686 replica.cpp:510] Replica received write request for position 2
I0210 23:00:45.325850 14674 registrar.cpp:375] Successfully recovered registrar
I0210 23:00:45.326208 14686 leveldb.cpp:342] Persisting action (16 bytes) to leveldb took
371952ns
I0210 23:00:45.326239 14686 replica.cpp:678] Persisted action at 2
I0210 23:00:45.326689 14674 master.cpp:1213] Recovered 0 slaves from the Registry (101B) ;
allowing 10mins for slaves to re-register
I0210 23:00:45.327877 14686 replica.cpp:657] Replica received learned notice for position
2
I0210 23:00:45.328297 14686 leveldb.cpp:342] Persisting action (18 bytes) to leveldb took
400127ns
I0210 23:00:45.328348 14686 leveldb.cpp:400] Deleting ~1 keys from leveldb took 30941ns
I0210 23:00:45.328363 14686 replica.cpp:678] Persisted action at 2
I0210 23:00:45.328378 14686 replica.cpp:663] Replica learned 3 action at position 2
I0210 23:00:45.344521 14682 slave.cpp:174] Slave started on 223)@67.195.81.187:53677
I0210 23:00:45.344549 14682 credentials.hpp:83] Loading credential for authentication from
'/tmp/MasterTest_KillUnknownTask_zfbUpZ/credential'
I0210 23:00:45.344686 14682 slave.cpp:283] Slave using credential for: test-principal
I0210 23:00:45.344851 14682 slave.cpp:301] Slave resources: cpus(*):2; mem(*):1024; disk(*):1024;
ports(*):[31000-32000]
I0210 23:00:45.344928 14682 slave.cpp:330] Slave hostname: pomona.apache.org
I0210 23:00:45.344941 14682 slave.cpp:331] Slave checkpoint: false
W0210 23:00:45.344948 14682 slave.cpp:333] Disabling checkpointing is deprecated and the --checkpoint
flag will be removed in a future release. Please avoid using this flag
I0210 23:00:45.345929 14683 state.cpp:34] Recovering state from '/tmp/MasterTest_KillUnknownTask_zfbUpZ/meta'
I0210 23:00:45.350471 14679 status_update_manager.cpp:196] Recovering status update manager
I0210 23:00:45.350747 14672 slave.cpp:3619] Finished recovery
I0210 23:00:45.350924 14658 sched.cpp:151] Version: 0.22.0
I0210 23:00:45.351358 14687 status_update_manager.cpp:170] Pausing sending status updates
I0210 23:00:45.351358 14676 slave.cpp:626] New master detected at master@67.195.81.187:53677
I0210 23:00:45.351428 14677 sched.cpp:248] New master detected at master@67.195.81.187:53677
I0210 23:00:45.351480 14676 slave.cpp:689] Authenticating with master master@67.195.81.187:53677
I0210 23:00:45.351501 14676 slave.cpp:694] Using default CRAM-MD5 authenticatee
I0210 23:00:45.351541 14677 sched.cpp:304] Authenticating with master master@67.195.81.187:53677
I0210 23:00:45.351562 14677 sched.cpp:311] Using default CRAM-MD5 authenticatee
I0210 23:00:45.351666 14676 slave.cpp:662] Detecting new master
I0210 23:00:45.351686 14684 authenticatee.hpp:138] Creating new client SASL connection
I0210 23:00:45.351790 14682 authenticatee.hpp:138] Creating new client SASL connection
I0210 23:00:45.351944 14680 master.cpp:3791] Authenticating slave(223)@67.195.81.187:53677
I0210 23:00:45.351969 14680 master.cpp:3802] Using default CRAM-MD5 authenticator
I0210 23:00:45.352133 14684 authenticator.hpp:169] Creating new server SASL connection
I0210 23:00:45.352247 14680 master.cpp:3791] Authenticating scheduler-3140ea46-2690-411a-b1ea-afe4b326585f@67.195.81.187:53677
I0210 23:00:45.352273 14680 master.cpp:3802] Using default CRAM-MD5 authenticator
I0210 23:00:45.352354 14677 authenticatee.hpp:229] Received SASL authentication mechanisms:
CRAM-MD5
I0210 23:00:45.352380 14677 authenticatee.hpp:255] Attempting to authenticate with mechanism
'CRAM-MD5'
I0210 23:00:45.352485 14676 authenticator.hpp:275] Received SASL authentication start
I0210 23:00:45.352509 14681 authenticator.hpp:169] Creating new server SASL connection
I0210 23:00:45.352545 14676 authenticator.hpp:397] Authentication requires more steps
I0210 23:00:45.352676 14686 authenticatee.hpp:229] Received SASL authentication mechanisms:
CRAM-MD5
I0210 23:00:45.352689 14683 authenticatee.hpp:275] Received SASL authentication step
I0210 23:00:45.352708 14686 authenticatee.hpp:255] Attempting to authenticate with mechanism
'CRAM-MD5'
I0210 23:00:45.352849 14678 authenticator.hpp:303] Received SASL authentication step
I0210 23:00:45.352874 14678 auxprop.cpp:98] 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 
I0210 23:00:45.352882 14678 auxprop.cpp:170] Looking up auxiliary property '*userPassword'
I0210 23:00:45.352880 14672 authenticator.hpp:275] Received SASL authentication start
I0210 23:00:45.352913 14678 auxprop.cpp:170] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
I0210 23:00:45.352932 14678 auxprop.cpp:98] 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 
I0210 23:00:45.352931 14672 authenticator.hpp:397] Authentication requires more steps
I0210 23:00:45.352946 14678 auxprop.cpp:120] Skipping auxiliary property '*userPassword' since
SASL_AUXPROP_AUTHZID == true
I0210 23:00:45.352962 14678 auxprop.cpp:120] Skipping auxiliary property '*cmusaslsecretCRAM-MD5'
since SASL_AUXPROP_AUTHZID == true
I0210 23:00:45.352977 14678 authenticator.hpp:389] Authentication success
I0210 23:00:45.353026 14672 authenticatee.hpp:275] Received SASL authentication step
I0210 23:00:45.353070 14683 authenticatee.hpp:315] Authentication success
I0210 23:00:45.353170 14678 authenticator.hpp:303] Received SASL authentication step
I0210 23:00:45.353199 14678 auxprop.cpp:98] 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 
I0210 23:00:45.353214 14678 auxprop.cpp:170] Looking up auxiliary property '*userPassword'
I0210 23:00:45.353236 14678 auxprop.cpp:170] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
I0210 23:00:45.353274 14678 auxprop.cpp:98] 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 
I0210 23:00:45.353307 14678 auxprop.cpp:120] Skipping auxiliary property '*userPassword' since
SASL_AUXPROP_AUTHZID == true
I0210 23:00:45.353317 14678 auxprop.cpp:120] Skipping auxiliary property '*cmusaslsecretCRAM-MD5'
since SASL_AUXPROP_AUTHZID == true
I0210 23:00:45.353333 14678 authenticator.hpp:389] Authentication success
I0210 23:00:45.353425 14680 master.cpp:3849] Successfully authenticated principal 'test-principal'
at slave(223)@67.195.81.187:53677
I0210 23:00:45.353564 14672 slave.cpp:760] Successfully authenticated with master master@67.195.81.187:53677
I0210 23:00:45.353605 14686 authenticatee.hpp:315] Authentication success
I0210 23:00:45.530272 14680 master.cpp:3849] Successfully authenticated principal 'test-principal'
at scheduler-3140ea46-2690-411a-b1ea-afe4b326585f@67.195.81.187:53677
I0210 23:00:45.530347 14672 slave.cpp:1094] Will retry registration in 6.229043ms if necessary
I0210 23:00:45.530845 14683 sched.cpp:392] Successfully authenticated with master master@67.195.81.187:53677
I0210 23:00:45.530869 14683 sched.cpp:515] Sending registration request to master@67.195.81.187:53677
I0210 23:00:45.530907 14683 sched.cpp:548] Will retry registration in 1.804465831secs if necessary
I0210 23:00:45.531074 14680 master.cpp:2916] Registering slave at slave(223)@67.195.81.187:53677
(pomona.apache.org) with id 20150210-230045-3142697795-53677-14658-S0
I0210 23:00:45.531380 14680 master.cpp:1573] Received registration request for framework 'default'
at scheduler-3140ea46-2690-411a-b1ea-afe4b326585f@67.195.81.187:53677
I0210 23:00:45.531468 14680 master.cpp:1434] Authorizing framework principal 'test-principal'
to receive offers for role '*'
I0210 23:00:45.531527 14681 registrar.cpp:444] Applied 1 operations in 41713ns; attempting
to update the 'registry'
I0210 23:00:45.531945 14682 master.cpp:1637] Registering framework 20150210-230045-3142697795-53677-14658-0000
(default) at scheduler-3140ea46-2690-411a-b1ea-afe4b326585f@67.195.81.187:53677
I0210 23:00:45.532315 14672 hierarchical_allocator_process.hpp:318] Added framework 20150210-230045-3142697795-53677-14658-0000
I0210 23:00:45.532316 14686 sched.cpp:442] Framework registered with 20150210-230045-3142697795-53677-14658-0000
I0210 23:00:45.532348 14672 hierarchical_allocator_process.hpp:828] No resources available
to allocate!
I0210 23:00:45.532361 14672 hierarchical_allocator_process.hpp:735] Performed allocation for
0 slaves in 20240ns
I0210 23:00:45.532379 14686 sched.cpp:456] Scheduler::registered took 20069ns
I0210 23:00:45.533927 14687 log.cpp:683] Attempting to append 316 bytes to the log
I0210 23:00:45.534123 14682 coordinator.cpp:339] Coordinator attempting to write 2 action
at position 3
I0210 23:00:45.534669 14681 replica.cpp:510] Replica received write request for position 3
I0210 23:00:45.535218 14681 leveldb.cpp:342] Persisting action (335 bytes) to leveldb took
522665ns
I0210 23:00:45.535240 14681 replica.cpp:678] Persisted action at 3
I0210 23:00:45.536377 14678 replica.cpp:657] Replica received learned notice for position
3
I0210 23:00:45.536782 14681 slave.cpp:1094] Will retry registration in 6.412077ms if necessary
I0210 23:00:45.536921 14678 leveldb.cpp:342] Persisting action (337 bytes) to leveldb took
509680ns
I0210 23:00:45.536942 14678 replica.cpp:678] Persisted action at 3
I0210 23:00:45.536937 14672 master.cpp:2904] Ignoring register slave message from slave(223)@67.195.81.187:53677
(pomona.apache.org) as admission is already in progress
I0210 23:00:45.536957 14678 replica.cpp:663] Replica learned 2 action at position 3
I0210 23:00:45.538419 14675 registrar.cpp:489] Successfully updated the 'registry' in 6.812928ms
I0210 23:00:45.538553 14674 log.cpp:702] Attempting to truncate the log to 3
I0210 23:00:45.538704 14675 coordinator.cpp:339] Coordinator attempting to write 3 action
at position 4
I0210 23:00:45.539005 14686 slave.cpp:2674] Received ping from slave-observer(205)@67.195.81.187:53677
I0210 23:00:45.539023 14683 master.cpp:2973] Registered slave 20150210-230045-3142697795-53677-14658-S0
at slave(223)@67.195.81.187:53677 (pomona.apache.org) with cpus(*):2; mem(*):1024; disk(*):1024;
ports(*):[31000-32000]
I0210 23:00:45.539274 14687 hierarchical_allocator_process.hpp:450] Added slave 20150210-230045-3142697795-53677-14658-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)
I0210 23:00:45.539489 14686 slave.cpp:794] Registered with master master@67.195.81.187:53677;
given slave ID 20150210-230045-3142697795-53677-14658-S0
I0210 23:00:45.539628 14678 replica.cpp:510] Replica received write request for position 4
I0210 23:00:45.539634 14675 status_update_manager.cpp:177] Resuming sending status updates
I0210 23:00:45.539839 14687 hierarchical_allocator_process.hpp:753] Performed allocation for
slave 20150210-230045-3142697795-53677-14658-S0 in 476724ns
I0210 23:00:45.540105 14678 leveldb.cpp:342] Persisting action (16 bytes) to leveldb took
447350ns
I0210 23:00:45.540129 14678 replica.cpp:678] Persisted action at 4
I0210 23:00:45.540199 14676 master.cpp:3733] Sending 1 offers to framework 20150210-230045-3142697795-53677-14658-0000
(default) at scheduler-3140ea46-2690-411a-b1ea-afe4b326585f@67.195.81.187:53677
I0210 23:00:45.540689 14673 sched.cpp:605] Scheduler::resourceOffers took 80763ns
I0210 23:00:45.541635 14679 replica.cpp:657] Replica received learned notice for position
4
I0210 23:00:45.542026 14679 leveldb.cpp:342] Persisting action (18 bytes) to leveldb took
366263ns
I0210 23:00:45.542071 14679 leveldb.cpp:400] Deleting ~2 keys from leveldb took 27827ns
I0210 23:00:45.542084 14679 replica.cpp:678] Persisted action at 4
I0210 23:00:45.542100 14679 replica.cpp:663] Replica learned 3 action at position 4
I0210 23:00:45.542534 14686 master.cpp:2262] Processing ACCEPT call for offers: [ 20150210-230045-3142697795-53677-14658-O0
] on slave 20150210-230045-3142697795-53677-14658-S0 at slave(223)@67.195.81.187:53677 (pomona.apache.org)
for framework 20150210-230045-3142697795-53677-14658-0000 (default) at scheduler-3140ea46-2690-411a-b1ea-afe4b326585f@67.195.81.187:53677
I0210 23:00:45.542579 14686 master.cpp:2111] Authorizing framework principal 'test-principal'
to launch task 1 as user 'jenkins'
W0210 23:00:45.544143 14686 validation.cpp:326] Executor default for task 1 uses less CPUs
(None) than the minimum required (0.01). Please update your executor, as this will be mandatory
in future releases.
W0210 23:00:45.544186 14686 validation.cpp:338] Executor default for task 1 uses less memory
(None) than the minimum required (32MB). Please update your executor, as this will be mandatory
in future releases.
I0210 23:00:45.544585 14686 master.hpp:819] Adding task 1 with resources cpus(*):2; mem(*):1024;
disk(*):1024; ports(*):[31000-32000] on slave 20150210-230045-3142697795-53677-14658-S0 (pomona.apache.org)
I0210 23:00:45.544728 14686 master.cpp:2523] Launching task 1 of framework 20150210-230045-3142697795-53677-14658-0000
(default) at scheduler-3140ea46-2690-411a-b1ea-afe4b326585f@67.195.81.187:53677 with resources
cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] on slave 20150210-230045-3142697795-53677-14658-S0
at slave(223)@67.195.81.187:53677 (pomona.apache.org)
I0210 23:00:45.545042 14672 slave.cpp:1149] Got assigned task 1 for framework 20150210-230045-3142697795-53677-14658-0000
I0210 23:00:45.545714 14672 slave.cpp:1264] Launching task 1 for framework 20150210-230045-3142697795-53677-14658-0000
I0210 23:00:45.547749 14672 slave.cpp:4021] Launching executor default of framework 20150210-230045-3142697795-53677-14658-0000
in work directory '/tmp/MasterTest_KillUnknownTask_zfbUpZ/slaves/20150210-230045-3142697795-53677-14658-S0/frameworks/20150210-230045-3142697795-53677-14658-0000/executors/default/runs/a6f161db-1139-40d5-a919-ae1429789ecb'
I0210 23:00:45.549674 14672 exec.cpp:145] Version: 0.22.0
I0210 23:00:45.549881 14679 exec.cpp:195] Executor started at: executor(78)@67.195.81.187:53677
with pid 14658
I0210 23:00:45.550169 14672 slave.cpp:1411] Queuing task '1' for executor default of framework
'20150210-230045-3142697795-53677-14658-0000
I0210 23:00:45.550266 14672 slave.cpp:579] Successfully attached file '/tmp/MasterTest_KillUnknownTask_zfbUpZ/slaves/20150210-230045-3142697795-53677-14658-S0/frameworks/20150210-230045-3142697795-53677-14658-0000/executors/default/runs/a6f161db-1139-40d5-a919-ae1429789ecb'
I0210 23:00:45.744364 14672 slave.cpp:2976] Monitoring executor 'default' of framework '20150210-230045-3142697795-53677-14658-0000'
in container 'a6f161db-1139-40d5-a919-ae1429789ecb'
I0210 23:00:45.744545 14672 slave.cpp:1998] Got registration for executor 'default' of framework
20150210-230045-3142697795-53677-14658-0000 from executor(78)@67.195.81.187:53677
I0210 23:00:45.745048 14682 exec.cpp:219] Executor registered on slave 20150210-230045-3142697795-53677-14658-S0
I0210 23:00:45.745038 14672 slave.cpp:2117] Flushing queued task 1 for executor 'default'
of framework 20150210-230045-3142697795-53677-14658-0000
I0210 23:00:45.746606 14682 exec.cpp:231] Executor::registered took 22169ns
I0210 23:00:45.746753 14682 exec.cpp:306] Executor asked to run task '1'
I0210 23:00:45.746814 14682 exec.cpp:315] Executor::launchTask took 44204ns
I0210 23:00:45.748260 14682 exec.cpp:538] Executor sending status update TASK_RUNNING (UUID:
2800af94-c3d5-41b2-8064-f4b8521add47) for task 1 of framework 20150210-230045-3142697795-53677-14658-0000
I0210 23:00:45.748428 14682 slave.cpp:2351] Handling status update TASK_RUNNING (UUID: 2800af94-c3d5-41b2-8064-f4b8521add47)
for task 1 of framework 20150210-230045-3142697795-53677-14658-0000 from executor(78)@67.195.81.187:53677
I0210 23:00:45.748693 14686 status_update_manager.cpp:316] Received status update TASK_RUNNING
(UUID: 2800af94-c3d5-41b2-8064-f4b8521add47) for task 1 of framework 20150210-230045-3142697795-53677-14658-0000
I0210 23:00:45.748723 14686 status_update_manager.cpp:493] Creating StatusUpdate stream for
task 1 of framework 20150210-230045-3142697795-53677-14658-0000
I0210 23:00:45.748891 14686 status_update_manager.cpp:370] Forwarding update TASK_RUNNING
(UUID: 2800af94-c3d5-41b2-8064-f4b8521add47) for task 1 of framework 20150210-230045-3142697795-53677-14658-0000
to the slave
I0210 23:00:45.749066 14682 slave.cpp:2594] Forwarding the update TASK_RUNNING (UUID: 2800af94-c3d5-41b2-8064-f4b8521add47)
for task 1 of framework 20150210-230045-3142697795-53677-14658-0000 to master@67.195.81.187:53677
I0210 23:00:45.749227 14682 master.cpp:3273] Status update TASK_RUNNING (UUID: 2800af94-c3d5-41b2-8064-f4b8521add47)
for task 1 of framework 20150210-230045-3142697795-53677-14658-0000 from slave 20150210-230045-3142697795-53677-14658-S0
at slave(223)@67.195.81.187:53677 (pomona.apache.org)
I0210 23:00:45.749253 14682 master.cpp:3314] Forwarding status update TASK_RUNNING (UUID:
2800af94-c3d5-41b2-8064-f4b8521add47) for task 1 of framework 20150210-230045-3142697795-53677-14658-0000
I0210 23:00:45.749364 14682 master.cpp:4596] Updating the latest state of task 1 of framework
20150210-230045-3142697795-53677-14658-0000 to TASK_RUNNING
I0210 23:00:45.749527 14676 sched.cpp:696] Scheduler::statusUpdate took 87161ns
I0210 23:00:45.749966 14678 slave.cpp:2521] Status update manager successfully handled status
update TASK_RUNNING (UUID: 2800af94-c3d5-41b2-8064-f4b8521add47) for task 1 of framework 20150210-230045-3142697795-53677-14658-0000
I0210 23:00:45.749995 14678 slave.cpp:2527] Sending acknowledgement for status update TASK_RUNNING
(UUID: 2800af94-c3d5-41b2-8064-f4b8521add47) for task 1 of framework 20150210-230045-3142697795-53677-14658-0000
to executor(78)@67.195.81.187:53677
I0210 23:00:45.750058 14676 master.cpp:2760] Forwarding status update acknowledgement 2800af94-c3d5-41b2-8064-f4b8521add47
for task 1 of framework 20150210-230045-3142697795-53677-14658-0000 (default) at scheduler-3140ea46-2690-411a-b1ea-afe4b326585f@67.195.81.187:53677
to slave 20150210-230045-3142697795-53677-14658-S0 at slave(223)@67.195.81.187:53677 (pomona.apache.org)
I0210 23:00:45.750185 14681 exec.cpp:352] Executor received status update acknowledgement
2800af94-c3d5-41b2-8064-f4b8521add47 for task 1 of framework 20150210-230045-3142697795-53677-14658-0000
I0210 23:00:45.750392 14687 status_update_manager.cpp:388] Received status update acknowledgement
(UUID: 2800af94-c3d5-41b2-8064-f4b8521add47) for task 1 of framework 20150210-230045-3142697795-53677-14658-0000
I0210 23:00:45.750598 14687 slave.cpp:1938] Status update manager successfully handled status
update acknowledgement (UUID: 2800af94-c3d5-41b2-8064-f4b8521add47) for task 1 of framework
20150210-230045-3142697795-53677-14658-0000
I0210 23:00:45.750645 14684 master.cpp:2596] Asked to kill task 2 of framework 20150210-230045-3142697795-53677-14658-0000
W0210 23:00:45.750686 14684 master.cpp:2634] Cannot kill task 2 of framework 20150210-230045-3142697795-53677-14658-0000
(default) at scheduler-3140ea46-2690-411a-b1ea-afe4b326585f@67.195.81.187:53677 because it
is unknown; performing reconciliation
I0210 23:00:45.750717 14684 master.cpp:3495] Performing explicit task state reconciliation
for 1 tasks of framework 20150210-230045-3142697795-53677-14658-0000 (default) at scheduler-3140ea46-2690-411a-b1ea-afe4b326585f@67.195.81.187:53677
I0210 23:00:45.753000 14684 master.cpp:3579] Sending explicit reconciliation state TASK_LOST
for task 2 of framework 20150210-230045-3142697795-53677-14658-0000 (default) at scheduler-3140ea46-2690-411a-b1ea-afe4b326585f@67.195.81.187:53677
I0210 23:00:45.753226 14684 sched.cpp:696] Scheduler::statusUpdate took 46506ns
I0210 23:00:45.754654 14658 sched.cpp:1470] Asked to stop the driver
I0210 23:00:45.754755 14684 sched.cpp:808] Stopping framework '20150210-230045-3142697795-53677-14658-0000'
I0210 23:00:45.754760 14658 master.cpp:786] Master terminating
W0210 23:00:45.754920 14658 master.cpp:4641] Removing task 1 with resources cpus(*):2; mem(*):1024;
disk(*):1024; ports(*):[31000-32000] of framework 20150210-230045-3142697795-53677-14658-0000
on slave 20150210-230045-3142697795-53677-14658-S0 at slave(223)@67.195.81.187:53677 (pomona.apache.org)
in non-terminal state TASK_RUNNING
I0210 23:00:45.757603 14672 hierarchical_allocator_process.hpp:642] Recovered cpus(*):2; mem(*):1024;
disk(*):1024; ports(*):[31000-32000] (total allocatable: cpus(*):2; mem(*):1024; disk(*):1024;
ports(*):[31000-32000]) on slave 20150210-230045-3142697795-53677-14658-S0 from framework
20150210-230045-3142697795-53677-14658-0000
I0210 23:00:45.757853 14658 master.cpp:4684] Removing executor 'default' with resources  of
framework 20150210-230045-3142697795-53677-14658-0000 on slave 20150210-230045-3142697795-53677-14658-S0
at slave(223)@67.195.81.187:53677 (pomona.apache.org)
I0210 23:00:45.758771 14683 slave.cpp:2759] master@67.195.81.187:53677 exited
W0210 23:00:45.758801 14683 slave.cpp:2762] Master disconnected! Waiting for a new master
to be elected
I0210 23:00:45.763412 14686 slave.cpp:3034] Executor 'default' of framework 20150210-230045-3142697795-53677-14658-0000
exited with status 0
I0210 23:00:45.765964 14686 slave.cpp:2351] Handling status update TASK_LOST (UUID: e732adc2-7750-41cc-a0f1-37de25328c6c)
for task 1 of framework 20150210-230045-3142697795-53677-14658-0000 from @0.0.0.0:0
I0210 23:00:45.766047 14686 slave.cpp:4329] Terminating task 1
I0210 23:00:45.766412 14686 slave.cpp:508] Slave terminating
I0210 23:00:45.766479 14686 slave.cpp:1628] Asked to shut down framework 20150210-230045-3142697795-53677-14658-0000
by @0.0.0.0:0
I0210 23:00:45.766499 14686 slave.cpp:1653] Shutting down framework 20150210-230045-3142697795-53677-14658-0000
I0210 23:00:45.766551 14686 slave.cpp:3143] Cleaning up executor 'default' of framework 20150210-230045-3142697795-53677-14658-0000
I0210 23:00:45.766770 14686 slave.cpp:3222] Cleaning up framework 20150210-230045-3142697795-53677-14658-0000
I0210 23:00:45.766798 14673 gc.cpp:55] Scheduling '/tmp/MasterTest_KillUnknownTask_zfbUpZ/slaves/20150210-230045-3142697795-53677-14658-S0/frameworks/20150210-230045-3142697795-53677-14658-0000/executors/default/runs/a6f161db-1139-40d5-a919-ae1429789ecb'
for gc 6.99999112698074days in the future
I0210 23:00:45.766909 14679 status_update_manager.cpp:278] Closing status update streams for
framework 20150210-230045-3142697795-53677-14658-0000
I0210 23:00:45.947239 14679 status_update_manager.cpp:524] Cleaning up status update stream
for task 1 of framework 20150210-230045-3142697795-53677-14658-0000
[       OK ] MasterTest.KillUnknownTask (695 ms)
[----------] 32 tests from MasterTest (14428 ms total)

[----------] 6 tests from FilesTest
[ RUN      ] FilesTest.DetachTest
Using temporary directory '/tmp/FilesTest_DetachTest_Dw3ksG'
[       OK ] FilesTest.DetachTest (1 ms)
[ RUN      ] FilesTest.ReadTest
Using temporary directory '/tmp/FilesTest_ReadTest_ZPb7L2'
I0210 23:00:45.961832 14675 process.cpp:2768] Handling HTTP event for process 'files' with
path: '/files/read.json'
I0210 23:00:45.964911 14681 process.cpp:2768] Handling HTTP event for process 'files' with
path: '/files/read.json'
I0210 23:00:45.967784 14684 process.cpp:2768] Handling HTTP event for process 'files' with
path: '/files/read.json'
I0210 23:00:45.971207 14679 process.cpp:2768] Handling HTTP event for process 'files' with
path: '/files/read.json'
I0210 23:00:45.974620 14676 process.cpp:2768] Handling HTTP event for process 'files' with
path: '/files/read.json'
I0210 23:00:45.977623 14673 process.cpp:2768] Handling HTTP event for process 'files' with
path: '/files/read.json'
[       OK ] FilesTest.ReadTest (19 ms)
[ RUN      ] FilesTest.ResolveTest
Using temporary directory '/tmp/FilesTest_ResolveTest_9i0Y8o'
I0210 23:00:45.981842 14673 process.cpp:2768] Handling HTTP event for process 'files' with
path: '/files/read.json'
I0210 23:00:45.984969 14679 process.cpp:2768] Handling HTTP event for process 'files' with
path: '/files/read.json'
I0210 23:00:45.988106 14677 process.cpp:2768] Handling HTTP event for process 'files' with
path: '/files/read.json'
I0210 23:00:46.009490 14685 process.cpp:2768] Handling HTTP event for process 'files' with
path: '/files/read.json'
I0210 23:00:46.057253 14681 process.cpp:2768] Handling HTTP event for process 'files' with
path: '/files/read.json'
I0210 23:00:46.162173 14674 process.cpp:2768] Handling HTTP event for process 'files' with
path: '/files/read.json'
I0210 23:00:46.165534 14683 process.cpp:2768] Handling HTTP event for process 'files' with
path: '/files/read.json'
I0210 23:00:46.168002 14684 process.cpp:2768] Handling HTTP event for process 'files' with
path: '/files/read.json'
I0210 23:00:46.170244 14677 process.cpp:2768] Handling HTTP event for process 'files' with
path: '/files/read.json'
I0210 23:00:46.172547 14675 process.cpp:2768] Handling HTTP event for process 'files' with
path: '/files/read.json'
[       OK ] FilesTest.ResolveTest (196 ms)
[ RUN      ] FilesTest.DownloadTest
Using temporary directory '/tmp/FilesTest_DownloadTest_7oUK1L'
I0210 23:00:46.198158 14678 process.cpp:2768] Handling HTTP event for process 'files' with
path: '/files/download.json'
I0210 23:00:46.198493 14683 process.cpp:1108] Sending file at '/tmp/FilesTest_DownloadTest_7oUK1L/binary'
with length 17
I0210 23:00:46.363972 14680 process.cpp:2768] Handling HTTP event for process 'files' with
path: '/files/download.json'
I0210 23:00:46.364243 14679 process.cpp:1108] Sending file at '/tmp/FilesTest_DownloadTest_7oUK1L/black.gif'
with length 42
[       OK ] FilesTest.DownloadTest (194 ms)
[ RUN      ] FilesTest.BrowseTest
Using temporary directory '/tmp/FilesTest_BrowseTest_t1u1p9'
I0210 23:00:46.425760 14680 process.cpp:2768] Handling HTTP event for process 'files' with
path: '/files/browse.json'
I0210 23:00:46.469018 14675 process.cpp:2768] Handling HTTP event for process 'files' with
path: '/files/browse.json'
I0210 23:00:46.472647 14679 process.cpp:2768] Handling HTTP event for process 'files' with
path: '/files/browse.json'
I0210 23:00:46.476418 14682 process.cpp:2768] Handling HTTP event for process 'files' with
path: '/files/browse.json'
I0210 23:00:46.563807 14673 process.cpp:2768] Handling HTTP event for process 'files' with
path: '/files/browse.json'
[       OK ] FilesTest.BrowseTest (196 ms)
[ RUN      ] FilesTest.AttachTest
Using temporary directory '/tmp/FilesTest_AttachTest_97Cakx'
[       OK ] FilesTest.AttachTest (3 ms)
[----------] 6 tests from FilesTest (609 ms total)

[----------] Global test environment tear-down
[==========] 488 tests from 77 test cases ran. (146660 ms total)
[  PASSED  ] 487 tests.
[  FAILED  ] 1 test, listed below:
[  FAILED  ] MasterAuthorizationTest.DuplicateRegistration

 1 FAILED TEST
  YOU HAVE 7 DISABLED TESTS

make[3]: *** [check-local] Error 1
make[3]: Leaving directory `<https://builds.apache.org/job/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Disable-Java-Disable-Python-Disable-Webui/ws/build/src'>
make[2]: *** [check-am] Error 2
make[2]: Leaving directory `<https://builds.apache.org/job/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Disable-Java-Disable-Python-Disable-Webui/ws/build/src'>
make[1]: *** [check] Error 2
make[1]: Leaving directory `<https://builds.apache.org/job/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Disable-Java-Disable-Python-Disable-Webui/ws/build/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