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-Set-JAVA_HOME #1674
Date Fri, 20 Sep 2013 08:27:40 GMT
See <https://builds.apache.org/job/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Set-JAVA_HOME/1674/changes>

Changes:

[vinod] Removed references of jenkins from Makefile.am and configure.ac.

------------------------------------------
[...truncated 17050 lines...]
I0920 08:27:37.085314 25392 status_update_manager.cpp:351] Forwarding status update TASK_RUNNING
(UUID: ea0ad6eb-3cc0-43d6-a7bd-7756287120f3) for task 0 of framework 201309200827-160088899-59397-25371-0000
to master@67.195.138.9:59397
I0920 08:27:37.085510 25397 master.cpp:1274] Status update TASK_RUNNING (UUID: ea0ad6eb-3cc0-43d6-a7bd-7756287120f3)
for task 0 of framework 201309200827-160088899-59397-25371-0000 from slave(131)@67.195.138.9:59397
I0920 08:27:37.085636 25394 sched.cpp:395] Scheduler::statusUpdate took 19.301us
I0920 08:27:37.085855 25371 master.cpp:481] Master terminating
I0920 08:27:37.085952 25371 master.cpp:206] Shutting down master
I0920 08:27:37.085592 25396 slave.cpp:1892] Status update manager successfully handled status
update TASK_RUNNING (UUID: ea0ad6eb-3cc0-43d6-a7bd-7756287120f3) for task 0 of framework 201309200827-160088899-59397-25371-0000
I0920 08:27:37.086071 25371 master.hpp:337] Removing task 0 with resources cpus(*):1; mem(*):500
on slave 201309200827-160088899-59397-25371-0 (vesta.apache.org)
I0920 08:27:37.086117 25396 slave.cpp:1898] Sending acknowledgement for status update TASK_RUNNING
(UUID: ea0ad6eb-3cc0-43d6-a7bd-7756287120f3) for task 0 of framework 201309200827-160088899-59397-25371-0000
to executor(40)@67.195.138.9:59397
I0920 08:27:37.086308 25371 master.cpp:237] Removing slave 201309200827-160088899-59397-25371-0
(vesta.apache.org)
I0920 08:27:37.086479 25391 exec.cpp:331] Executor received status update acknowledgement
ea0ad6eb-3cc0-43d6-a7bd-7756287120f3 for task 0 of framework 201309200827-160088899-59397-25371-0000
I0920 08:27:37.086524 25396 slave.cpp:1973] master@67.195.138.9:59397 exited
W0920 08:27:37.086659 25396 slave.cpp:1976] Master disconnected! Waiting for a new master
to be elected
I0920 08:27:37.086679 25390 status_update_manager.cpp:375] Received status update acknowledgement
(UUID: ea0ad6eb-3cc0-43d6-a7bd-7756287120f3) for task 0 of framework 201309200827-160088899-59397-25371-0000
I0920 08:27:37.086344 25392 hierarchical_allocator_process.hpp:598] Recovered cpus(*):1; mem(*):500
(total allocatable: cpus(*):2; mem(*):1024; disk(*):1.38501e+06; ports(*):[31000-32000]) on
slave 201309200827-160088899-59397-25371-0 from framework 201309200827-160088899-59397-25371-0000
I0920 08:27:37.087044 25395 slave.cpp:1386] Status update manager successfully handled status
update acknowledgement (UUID: ea0ad6eb-3cc0-43d6-a7bd-7756287120f3) for task 0 of framework
201309200827-160088899-59397-25371-0000
I0920 08:27:37.087888 25392 master.cpp:265] Master started on 67.195.138.9:59397
I0920 08:27:37.088121 25392 master.cpp:280] Master ID: 201309200827-160088899-59397-25371
I0920 08:27:37.088340 25396 master.cpp:80] No whitelist given. Advertising offers for all
slaves
I0920 08:27:37.088552 25395 hierarchical_allocator_process.hpp:291] Initializing hierarchical
allocator process with master : master@67.195.138.9:59397
I0920 08:27:37.106231 25393 detector.cpp:234] Master detector (master@67.195.138.9:59397)
connected to ZooKeeper ...
I0920 08:27:37.106326 25393 detector.cpp:251] Trying to create path '/znode' in ZooKeeper
I0920 08:27:37.106402 25396 detector.cpp:420] Master detector (slave(131)@67.195.138.9:59397)
 found 0 registered masters
I0920 08:27:37.106489 25396 detector.cpp:441] Master detector (slave(131)@67.195.138.9:59397)
couldn't find any masters
I0920 08:27:37.106590 25396 slave.cpp:577] Lost master(s) ... waiting
I0920 08:27:37.106662 25390 detector.cpp:420] Master detector (scheduler(113)@67.195.138.9:59397)
 found 0 registered masters
I0920 08:27:37.106789 25390 detector.cpp:441] Master detector (scheduler(113)@67.195.138.9:59397)
couldn't find any masters
I0920 08:27:37.106892 25390 sched.cpp:202] No master detected, waiting for another master
I0920 08:27:37.106992 25390 sched.cpp:214] Scheduler::disconnected took 9.864us
I0920 08:27:37.114070 25393 detector.cpp:281] Created ephemeral/sequence znode at '/znode/0000000002'
I0920 08:27:37.114784 25397 detector.cpp:420] Master detector (scheduler(113)@67.195.138.9:59397)
 found 1 registered masters
I0920 08:27:37.114967 25391 detector.cpp:420] Master detector (slave(131)@67.195.138.9:59397)
 found 1 registered masters
I0920 08:27:37.115417 25397 detector.cpp:467] Master detector (scheduler(113)@67.195.138.9:59397)
 got new master pid: master@67.195.138.9:59397
I0920 08:27:37.115461 25393 detector.cpp:420] Master detector (master@67.195.138.9:59397)
 found 1 registered masters
I0920 08:27:37.115594 25397 sched.cpp:178] New master at master@67.195.138.9:59397
I0920 08:27:37.115681 25391 detector.cpp:467] Master detector (slave(131)@67.195.138.9:59397)
 got new master pid: master@67.195.138.9:59397
W0920 08:27:37.115813 25396 master.cpp:716] Ignoring re-register framework message since not
elected yet
I0920 08:27:37.115885 25391 slave.cpp:543] New master detected at master@67.195.138.9:59397
I0920 08:27:37.116116 25394 status_update_manager.cpp:157] New master detected at master@67.195.138.9:59397
I0920 08:27:37.116143 25393 detector.cpp:467] Master detector (master@67.195.138.9:59397)
 got new master pid: master@67.195.138.9:59397
I0920 08:27:37.116351 25393 master.cpp:644] Elected as master!
I0920 08:27:38.076817 25391 master.cpp:736] Re-registering framework 201309200827-160088899-59397-25371-0000
at scheduler(113)@67.195.138.9:59397
I0920 08:27:38.077080 25395 sched.cpp:237] Framework registered with 201309200827-160088899-59397-25371-0000
I0920 08:27:38.077159 25395 sched.cpp:251] Scheduler::registered took 9.954us
I0920 08:27:38.077163 25391 hierarchical_allocator_process.hpp:321] Added framework 201309200827-160088899-59397-25371-0000
I0920 08:27:38.077342 25391 hierarchical_allocator_process.hpp:687] No resources available
to allocate!
I0920 08:27:38.077389 25391 hierarchical_allocator_process.hpp:649] Performed allocation for
0 slaves in 49.59us
I0920 08:27:38.081943 25392 monitor.cpp:187] Publishing resource usage for executor 'default'
of framework '201309200827-160088899-59397-25371-0000'
I0920 08:27:38.088958 25395 hierarchical_allocator_process.hpp:687] No resources available
to allocate!
I0920 08:27:38.089046 25395 hierarchical_allocator_process.hpp:649] Performed allocation for
0 slaves in 92.457us
I0920 08:27:38.117230 25391 master.cpp:1175] Attempting to re-register slave 201309200827-160088899-59397-25371-0
at slave(131)@67.195.138.9:59397 (vesta.apache.org)
I0920 08:27:38.117331 25391 master.cpp:2165] Adding slave 201309200827-160088899-59397-25371-0
at vesta.apache.org with cpus(*):2; mem(*):1024; disk(*):1.38501e+06; ports(*):[31000-32000]
I0920 08:27:38.117492 25391 master.hpp:321] Adding task 0 with resources cpus(*):1; mem(*):500
on slave 201309200827-160088899-59397-25371-0 (vesta.apache.org)
I0920 08:27:38.117676 25391 slave.cpp:644] Re-registered with master master@67.195.138.9:59397
I0920 08:27:38.117753 25391 slave.cpp:1332] Updating framework 201309200827-160088899-59397-25371-0000
pid to scheduler(113)@67.195.138.9:59397
I0920 08:27:38.117964 25391 hierarchical_allocator_process.hpp:434] Added slave 201309200827-160088899-59397-25371-0
(vesta.apache.org) with cpus(*):2; mem(*):1024; disk(*):1.38501e+06; ports(*):[31000-32000]
(and cpus(*):1; mem(*):524; disk(*):1.38501e+06; ports(*):[31000-32000] available)
I0920 08:27:38.118077 25391 hierarchical_allocator_process.hpp:712] Offering cpus(*):1; mem(*):524;
disk(*):1.38501e+06; ports(*):[31000-32000] on slave 201309200827-160088899-59397-25371-0
to framework 201309200827-160088899-59397-25371-0000
I0920 08:27:38.118242 25391 hierarchical_allocator_process.hpp:669] Performed allocation for
slave 201309200827-160088899-59397-25371-0 in 203.576us
I0920 08:27:38.118381 25392 master.hpp:347] Adding offer 201309200827-160088899-59397-25371-0
with resources cpus(*):1; mem(*):524; disk(*):1.38501e+06; ports(*):[31000-32000] on slave
201309200827-160088899-59397-25371-0 (vesta.apache.org)
I0920 08:27:38.118540 25392 master.cpp:1462] Sending 1 offers to framework 201309200827-160088899-59397-25371-0000
I0920 08:27:38.118753 25392 sched.cpp:340] Scheduler::resourceOffers took 21.98us
I0920 08:27:38.119071 25390 sched.cpp:498] Stopping framework '201309200827-160088899-59397-25371-0000'
I0920 08:27:38.119072 25394 master.cpp:481] Master terminating
I0920 08:27:38.119298 25394 slave.cpp:1973] master@67.195.138.9:59397 exited
I0920 08:27:38.119314 25371 master.cpp:206] Shutting down master
W0920 08:27:38.119405 25394 slave.cpp:1976] Master disconnected! Waiting for a new master
to be elected
I0920 08:27:38.119540 25371 master.hpp:337] Removing task 0 with resources cpus(*):1; mem(*):500
on slave 201309200827-160088899-59397-25371-0 (vesta.apache.org)
I0920 08:27:38.119801 25371 master.hpp:357] Removing offer 201309200827-160088899-59397-25371-0
with resources cpus(*):1; mem(*):524; disk(*):1.38501e+06; ports(*):[31000-32000] on slave
201309200827-160088899-59397-25371-0 (vesta.apache.org)
I0920 08:27:38.119938 25371 master.cpp:237] Removing slave 201309200827-160088899-59397-25371-0
(vesta.apache.org)
I0920 08:27:38.120076 25392 hierarchical_allocator_process.hpp:598] Recovered cpus(*):1; mem(*):500
(total allocatable: cpus(*):1; mem(*):500) on slave 201309200827-160088899-59397-25371-0 from
framework 201309200827-160088899-59397-25371-0000
I0920 08:27:38.120657 25371 slave.cpp:454] Slave terminating
I0920 08:27:38.120765 25371 slave.cpp:1167] Asked to shut down framework 201309200827-160088899-59397-25371-0000
by @0.0.0.0:0
I0920 08:27:38.120820 25371 slave.cpp:1192] Shutting down framework 201309200827-160088899-59397-25371-0000
I0920 08:27:38.120878 25371 slave.cpp:2426] Shutting down executor 'default' of framework
201309200827-160088899-59397-25371-0000
I0920 08:27:38.120965 25396 exec.cpp:371] Executor asked to shutdown

GMOCK WARNING:
Uninteresting mock function call - returning directly.
    Function call: shutdown(0x2ada34017600)
Stack trace:
I0920 08:27:38.121083 25396 exec.cpp:386] Executor::shutdown took 23.878us
[       OK ] AllocatorZooKeeperTest/0.FrameworkReregistersFirst (2128 ms)
[ RUN      ] AllocatorZooKeeperTest/0.SlaveReregistersFirst
I0920 08:27:38.122149 25393 master.cpp:265] Master started on 67.195.138.9:59397
I0920 08:27:38.122243 25393 master.cpp:280] Master ID: 201309200827-160088899-59397-25371
I0920 08:27:38.122473 25396 master.cpp:80] No whitelist given. Advertising offers for all
slaves
I0920 08:27:38.122606 25390 hierarchical_allocator_process.hpp:291] Initializing hierarchical
allocator process with master : master@67.195.138.9:59397
I0920 08:27:38.123005 25395 slave.cpp:108] Slave started on 132)@67.195.138.9:59397
I0920 08:27:38.123154 25395 slave.cpp:208] Slave resources: cpus(*):2; mem(*):1024; disk(*):1.38501e+06;
ports(*):[31000-32000]
2013-09-20 08:27:38,123:25371(0x2ada25ccb700):ZOO_INFO@log_env@658: Client environment:zookeeper.version=zookeeper
C client 3.3.4
2013-09-20 08:27:38,123:25371(0x2ada25ccb700):ZOO_INFO@log_env@662: Client environment:host.name=vesta.apache.org
2013-09-20 08:27:38,123:25371(0x2ada25ccb700):ZOO_INFO@log_env@669: Client environment:os.name=Linux
2013-09-20 08:27:38,123:25371(0x2ada25ccb700):ZOO_INFO@log_env@670: Client environment:os.arch=3.2.0-51-generic
2013-09-20 08:27:38,123:25371(0x2ada25ccb700):ZOO_INFO@log_env@671: Client environment:os.version=#77-Ubuntu
SMP Wed Jul 24 20:18:19 UTC 2013
2013-09-20 08:27:38,123:25371(0x2ada25ccb700):ZOO_INFO@log_env@679: Client environment:user.name=(null)
I0920 08:27:38.123965 25392 slave.cpp:399] Finished recovery
I0920 08:27:38.166183 25395 detector.cpp:234] Master detector (master@67.195.138.9:59397)
connected to ZooKeeper ...
I0920 08:27:38.166259 25395 detector.cpp:251] Trying to create path '/znode' in ZooKeeper
I0920 08:27:38.166669 25396 detector.cpp:234] Master detector (slave(132)@67.195.138.9:59397)
connected to ZooKeeper ...
I0920 08:27:38.166798 25396 detector.cpp:251] Trying to create path '/znode' in ZooKeeper
I0920 08:27:38.167191 25390 detector.cpp:234] Master detector (scheduler(114)@67.195.138.9:59397)
connected to ZooKeeper ...
I0920 08:27:38.167284 25390 detector.cpp:251] Trying to create path '/znode' in ZooKeeper
I0920 08:27:38.181639 25395 detector.cpp:281] Created ephemeral/sequence znode at '/znode/0000000004'
I0920 08:27:38.182051 25396 detector.cpp:420] Master detector (slave(132)@67.195.138.9:59397)
 found 1 registered masters
I0920 08:27:38.182240 25395 detector.cpp:420] Master detector (master@67.195.138.9:59397)
 found 1 registered masters
I0920 08:27:38.182632 25396 detector.cpp:467] Master detector (slave(132)@67.195.138.9:59397)
 got new master pid: master@67.195.138.9:59397
I0920 08:27:38.182837 25396 slave.cpp:543] New master detected at master@67.195.138.9:59397
I0920 08:27:38.182848 25395 detector.cpp:467] Master detector (master@67.195.138.9:59397)
 got new master pid: master@67.195.138.9:59397
I0920 08:27:38.182982 25391 status_update_manager.cpp:157] New master detected at master@67.195.138.9:59397
W0920 08:27:38.183013 25392 master.cpp:1044] Ignoring register slave message from vesta.apache.org
since not elected yet
I0920 08:27:38.183235 25390 detector.cpp:420] Master detector (scheduler(114)@67.195.138.9:59397)
 found 1 registered masters
I0920 08:27:38.183274 25392 master.cpp:644] Elected as master!
I0920 08:27:38.183755 25390 detector.cpp:467] Master detector (scheduler(114)@67.195.138.9:59397)
 got new master pid: master@67.195.138.9:59397
I0920 08:27:38.183904 25390 sched.cpp:178] New master at master@67.195.138.9:59397
I0920 08:27:38.184101 25390 master.cpp:694] Registering framework 201309200827-160088899-59397-25371-0000
at scheduler(114)@67.195.138.9:59397
I0920 08:27:38.184195 25390 sched.cpp:237] Framework registered with 201309200827-160088899-59397-25371-0000
I0920 08:27:38.184206 25392 hierarchical_allocator_process.hpp:321] Added framework 201309200827-160088899-59397-25371-0000
I0920 08:27:38.184273 25390 sched.cpp:251] Scheduler::registered took 26.229us
I0920 08:27:38.184329 25392 hierarchical_allocator_process.hpp:687] No resources available
to allocate!
I0920 08:27:38.184463 25392 hierarchical_allocator_process.hpp:649] Performed allocation for
0 slaves in 134.522us
I0920 08:27:39.123601 25391 hierarchical_allocator_process.hpp:687] No resources available
to allocate!
I0920 08:27:39.123704 25391 hierarchical_allocator_process.hpp:649] Performed allocation for
0 slaves in 107.745us
I0920 08:27:39.183827 25393 master.cpp:1075] Attempting to register slave on vesta.apache.org
at slave(132)@67.195.138.9:59397
I0920 08:27:39.183904 25393 master.cpp:2165] Adding slave 201309200827-160088899-59397-25371-0
at vesta.apache.org with cpus(*):2; mem(*):1024; disk(*):1.38501e+06; ports(*):[31000-32000]
I0920 08:27:39.184087 25394 slave.cpp:603] Registered with master master@67.195.138.9:59397;
given slave ID 201309200827-160088899-59397-25371-0
I0920 08:27:39.184171 25393 hierarchical_allocator_process.hpp:434] Added slave 201309200827-160088899-59397-25371-0
(vesta.apache.org) with cpus(*):2; mem(*):1024; disk(*):1.38501e+06; ports(*):[31000-32000]
(and cpus(*):2; mem(*):1024; disk(*):1.38501e+06; ports(*):[31000-32000] available)
I0920 08:27:39.184348 25393 hierarchical_allocator_process.hpp:712] Offering cpus(*):2; mem(*):1024;
disk(*):1.38501e+06; ports(*):[31000-32000] on slave 201309200827-160088899-59397-25371-0
to framework 201309200827-160088899-59397-25371-0000
I0920 08:27:39.184547 25393 hierarchical_allocator_process.hpp:669] Performed allocation for
slave 201309200827-160088899-59397-25371-0 in 225.561us
I0920 08:27:39.184617 25394 master.hpp:347] Adding offer 201309200827-160088899-59397-25371-0
with resources cpus(*):2; mem(*):1024; disk(*):1.38501e+06; ports(*):[31000-32000] on slave
201309200827-160088899-59397-25371-0 (vesta.apache.org)
I0920 08:27:39.184763 25394 master.cpp:1462] Sending 1 offers to framework 201309200827-160088899-59397-25371-0000
I0920 08:27:39.185108 25390 sched.cpp:340] Scheduler::resourceOffers took 166.911us
I0920 08:27:39.185264 25394 master.cpp:1699] Processing reply for offer 201309200827-160088899-59397-25371-0
on slave 201309200827-160088899-59397-25371-0 (vesta.apache.org) for framework 201309200827-160088899-59397-25371-0000
I0920 08:27:39.185457 25394 master.hpp:321] Adding task 0 with resources cpus(*):1; mem(*):500
on slave 201309200827-160088899-59397-25371-0 (vesta.apache.org)
I0920 08:27:39.185533 25394 master.cpp:1823] Launching task 0 of framework 201309200827-160088899-59397-25371-0000
with resources cpus(*):1; mem(*):500 on slave 201309200827-160088899-59397-25371-0 (vesta.apache.org)
I0920 08:27:39.185645 25390 slave.cpp:772] Got assigned task 0 for framework 201309200827-160088899-59397-25371-0000
I0920 08:27:39.185722 25394 master.hpp:357] Removing offer 201309200827-160088899-59397-25371-0
with resources cpus(*):2; mem(*):1024; disk(*):1.38501e+06; ports(*):[31000-32000] on slave
201309200827-160088899-59397-25371-0 (vesta.apache.org)
I0920 08:27:39.185822 25394 hierarchical_allocator_process.hpp:508] Framework 201309200827-160088899-59397-25371-0000
left cpus(*):1; mem(*):524; disk(*):1.38501e+06; ports(*):[31000-32000] unused on slave 201309200827-160088899-59397-25371-0
I0920 08:27:39.185891 25390 slave.cpp:883] Launching task 0 for framework 201309200827-160088899-59397-25371-0000
I0920 08:27:39.185987 25394 hierarchical_allocator_process.hpp:551] Framework 201309200827-160088899-59397-25371-0000
filtered slave 201309200827-160088899-59397-25371-0 for 5secs
I0920 08:27:39.187417 25390 slave.cpp:994] Queuing task '0' for executor default of framework
'201309200827-160088899-59397-25371-0000
I0920 08:27:39.187536 25390 slave.cpp:525] Successfully attached file '/tmp/AllocatorZooKeeperTest_0_SlaveReregistersFirst_pUreiL/slaves/201309200827-160088899-59397-25371-0/frameworks/201309200827-160088899-59397-25371-0000/executors/default/runs/266abd6e-6ced-43b4-84f0-8754934bd0a7'
I0920 08:27:39.188793 25393 exec.cpp:174] Executor started at: executor(41)@67.195.138.9:59397
with pid 25371
I0920 08:27:39.188938 25396 slave.cpp:1440] Got registration for executor 'default' of framework
201309200827-160088899-59397-25371-0000
I0920 08:27:39.189296 25396 slave.cpp:1561] Flushing queued task 0 for executor 'default'
of framework 201309200827-160088899-59397-25371-0000
I0920 08:27:39.189312 25394 exec.cpp:198] Executor registered on slave 201309200827-160088899-59397-25371-0
I0920 08:27:39.190554 25394 exec.cpp:210] Executor::registered took 11.028us
I0920 08:27:39.190666 25394 exec.cpp:285] Executor asked to run task '0'
I0920 08:27:39.190784 25394 exec.cpp:294] Executor::launchTask took 39.485us
I0920 08:27:39.191956 25394 exec.cpp:501] Executor sending status update TASK_RUNNING (UUID:
90d7ccc1-fb23-4b11-b2ba-8168dbfa0250) for task 0 of framework 201309200827-160088899-59397-25371-0000
I0920 08:27:39.192109 25390 slave.cpp:1773] Handling status update TASK_RUNNING (UUID: 90d7ccc1-fb23-4b11-b2ba-8168dbfa0250)
for task 0 of framework 201309200827-160088899-59397-25371-0000 from executor(41)@67.195.138.9:59397
I0920 08:27:39.192293 25395 status_update_manager.cpp:300] Received status update TASK_RUNNING
(UUID: 90d7ccc1-fb23-4b11-b2ba-8168dbfa0250) for task 0 of framework 201309200827-160088899-59397-25371-0000
I0920 08:27:39.192411 25395 status_update_manager.cpp:471] Creating StatusUpdate stream for
task 0 of framework 201309200827-160088899-59397-25371-0000
I0920 08:27:39.192572 25395 status_update_manager.cpp:351] Forwarding status update TASK_RUNNING
(UUID: 90d7ccc1-fb23-4b11-b2ba-8168dbfa0250) for task 0 of framework 201309200827-160088899-59397-25371-0000
to master@67.195.138.9:59397
I0920 08:27:39.192731 25390 master.cpp:1274] Status update TASK_RUNNING (UUID: 90d7ccc1-fb23-4b11-b2ba-8168dbfa0250)
for task 0 of framework 201309200827-160088899-59397-25371-0000 from slave(132)@67.195.138.9:59397
I0920 08:27:39.192821 25392 slave.cpp:1892] Status update manager successfully handled status
update TASK_RUNNING (UUID: 90d7ccc1-fb23-4b11-b2ba-8168dbfa0250) for task 0 of framework 201309200827-160088899-59397-25371-0000
I0920 08:27:39.192845 25396 sched.cpp:395] Scheduler::statusUpdate took 37.243us
I0920 08:27:39.192921 25392 slave.cpp:1898] Sending acknowledgement for status update TASK_RUNNING
(UUID: 90d7ccc1-fb23-4b11-b2ba-8168dbfa0250) for task 0 of framework 201309200827-160088899-59397-25371-0000
to executor(41)@67.195.138.9:59397
I0920 08:27:39.193142 25391 exec.cpp:331] Executor received status update acknowledgement
90d7ccc1-fb23-4b11-b2ba-8168dbfa0250 for task 0 of framework 201309200827-160088899-59397-25371-0000
I0920 08:27:39.193292 25391 master.cpp:481] Master terminating
I0920 08:27:39.193337 25392 status_update_manager.cpp:375] Received status update acknowledgement
(UUID: 90d7ccc1-fb23-4b11-b2ba-8168dbfa0250) for task 0 of framework 201309200827-160088899-59397-25371-0000
I0920 08:27:39.193457 25391 slave.cpp:1973] master@67.195.138.9:59397 exited
W0920 08:27:39.193577 25391 slave.cpp:1976] Master disconnected! Waiting for a new master
to be elected
I0920 08:27:39.193459 25371 master.cpp:206] Shutting down master
I0920 08:27:39.193703 25391 slave.cpp:1386] Status update manager successfully handled status
update acknowledgement (UUID: 90d7ccc1-fb23-4b11-b2ba-8168dbfa0250) for task 0 of framework
201309200827-160088899-59397-25371-0000
I0920 08:27:39.193826 25371 master.hpp:337] Removing task 0 with resources cpus(*):1; mem(*):500
on slave 201309200827-160088899-59397-25371-0 (vesta.apache.org)
I0920 08:27:39.194058 25371 master.cpp:237] Removing slave 201309200827-160088899-59397-25371-0
(vesta.apache.org)
I0920 08:27:39.194074 25393 hierarchical_allocator_process.hpp:598] Recovered cpus(*):1; mem(*):500
(total allocatable: cpus(*):2; mem(*):1024; disk(*):1.38501e+06; ports(*):[31000-32000]) on
slave 201309200827-160088899-59397-25371-0 from framework 201309200827-160088899-59397-25371-0000
I0920 08:27:39.195350 25394 master.cpp:265] Master started on 67.195.138.9:59397
I0920 08:27:39.195556 25394 master.cpp:280] Master ID: 201309200827-160088899-59397-25371
I0920 08:27:39.195755 25396 master.cpp:80] No whitelist given. Advertising offers for all
slaves
I0920 08:27:39.195953 25393 hierarchical_allocator_process.hpp:291] Initializing hierarchical
allocator process with master : master@67.195.138.9:59397
I0920 08:27:39.236302 25397 detector.cpp:234] Master detector (master@67.195.138.9:59397)
connected to ZooKeeper ...
I0920 08:27:39.236413 25397 detector.cpp:251] Trying to create path '/znode' in ZooKeeper
I0920 08:27:39.236522 25396 detector.cpp:420] Master detector (slave(132)@67.195.138.9:59397)
 found 0 registered masters
I0920 08:27:39.236739 25391 detector.cpp:420] Master detector (scheduler(114)@67.195.138.9:59397)
 found 0 registered masters
I0920 08:27:39.236835 25391 detector.cpp:441] Master detector (scheduler(114)@67.195.138.9:59397)
couldn't find any masters
I0920 08:27:39.236758 25396 detector.cpp:441] Master detector (slave(132)@67.195.138.9:59397)
couldn't find any masters
I0920 08:27:39.237120 25396 slave.cpp:577] Lost master(s) ... waiting
I0920 08:27:39.236991 25391 sched.cpp:202] No master detected, waiting for another master
I0920 08:27:39.237360 25391 sched.cpp:214] Scheduler::disconnected took 15.694us
I0920 08:27:39.248180 25397 detector.cpp:281] Created ephemeral/sequence znode at '/znode/0000000006'
I0920 08:27:39.248505 25392 detector.cpp:420] Master detector (slave(132)@67.195.138.9:59397)
 found 1 registered masters
I0920 08:27:39.248764 25395 detector.cpp:420] Master detector (scheduler(114)@67.195.138.9:59397)
 found 1 registered masters
I0920 08:27:39.248889 25397 detector.cpp:420] Master detector (master@67.195.138.9:59397)
 found 1 registered masters
I0920 08:27:39.249068 25392 detector.cpp:467] Master detector (slave(132)@67.195.138.9:59397)
 got new master pid: master@67.195.138.9:59397
I0920 08:27:39.249193 25392 slave.cpp:543] New master detected at master@67.195.138.9:59397
I0920 08:27:39.249310 25394 status_update_manager.cpp:157] New master detected at master@67.195.138.9:59397
W0920 08:27:39.249430 25396 master.cpp:1102] Ignoring re-register slave message from vesta.apache.org
since not elected yet
I0920 08:27:39.249709 25397 detector.cpp:467] Master detector (master@67.195.138.9:59397)
 got new master pid: master@67.195.138.9:59397
I0920 08:27:39.249927 25395 detector.cpp:467] Master detector (scheduler(114)@67.195.138.9:59397)
 got new master pid: master@67.195.138.9:59397
I0920 08:27:39.249936 25397 master.cpp:644] Elected as master!
I0920 08:27:39.250097 25395 sched.cpp:178] New master at master@67.195.138.9:59397
I0920 08:27:40.184027 25397 master.cpp:1175] Attempting to re-register slave 201309200827-160088899-59397-25371-0
at slave(132)@67.195.138.9:59397 (vesta.apache.org)
I0920 08:27:40.184125 25397 master.cpp:2165] Adding slave 201309200827-160088899-59397-25371-0
at vesta.apache.org with cpus(*):2; mem(*):1024; disk(*):1.38501e+06; ports(*):[31000-32000]
I0920 08:27:40.184329 25397 master.hpp:321] Adding task 0 with resources cpus(*):1; mem(*):500
on slave 201309200827-160088899-59397-25371-0 (vesta.apache.org)
I0920 08:27:40.184356 25393 slave.cpp:644] Re-registered with master master@67.195.138.9:59397
W0920 08:27:40.184458 25397 master.cpp:2260] Possibly orphaned task 0 of framework 201309200827-160088899-59397-25371-0000
running on slave 201309200827-160088899-59397-25371-0 (vesta.apache.org)
I0920 08:27:40.184980 25395 hierarchical_allocator_process.hpp:434] Added slave 201309200827-160088899-59397-25371-0
(vesta.apache.org) with cpus(*):2; mem(*):1024; disk(*):1.38501e+06; ports(*):[31000-32000]
(and cpus(*):1; mem(*):524; disk(*):1.38501e+06; ports(*):[31000-32000] available)
I0920 08:27:40.185158 25395 hierarchical_allocator_process.hpp:669] Performed allocation for
slave 201309200827-160088899-59397-25371-0 in 18.54us
I0920 08:27:40.190084 25391 monitor.cpp:187] Publishing resource usage for executor 'default'
of framework '201309200827-160088899-59397-25371-0000'
I0920 08:27:40.197088 25395 hierarchical_allocator_process.hpp:649] Performed allocation for
1 slaves in 18.519us
I0920 08:27:40.251332 25396 master.cpp:736] Re-registering framework 201309200827-160088899-59397-25371-0000
at scheduler(114)@67.195.138.9:59397
I0920 08:27:40.251555 25393 sched.cpp:237] Framework registered with 201309200827-160088899-59397-25371-0000
I0920 08:27:40.251588 25396 slave.cpp:1332] Updating framework 201309200827-160088899-59397-25371-0000
pid to scheduler(114)@67.195.138.9:59397
I0920 08:27:40.251729 25392 hierarchical_allocator_process.hpp:321] Added framework 201309200827-160088899-59397-25371-0000
I0920 08:27:40.251765 25393 sched.cpp:251] Scheduler::registered took 96.858us
I0920 08:27:40.251924 25392 hierarchical_allocator_process.hpp:712] Offering cpus(*):1; mem(*):524;
disk(*):1.38501e+06; ports(*):[31000-32000] on slave 201309200827-160088899-59397-25371-0
to framework 201309200827-160088899-59397-25371-0000
I0920 08:27:40.252219 25392 hierarchical_allocator_process.hpp:649] Performed allocation for
1 slaves in 329.693us
I0920 08:27:40.252317 25391 master.hpp:347] Adding offer 201309200827-160088899-59397-25371-0
with resources cpus(*):1; mem(*):524; disk(*):1.38501e+06; ports(*):[31000-32000] on slave
201309200827-160088899-59397-25371-0 (vesta.apache.org)
I0920 08:27:40.252437 25391 master.cpp:1462] Sending 1 offers to framework 201309200827-160088899-59397-25371-0000
I0920 08:27:40.252643 25397 sched.cpp:340] Scheduler::resourceOffers took 21.354us
I0920 08:27:40.252846 25391 sched.cpp:498] Stopping framework '201309200827-160088899-59397-25371-0000'
I0920 08:27:40.252873 25371 master.cpp:481] Master terminating
I0920 08:27:40.253049 25371 master.cpp:206] Shutting down master
I0920 08:27:40.253051 25396 slave.cpp:1973] master@67.195.138.9:59397 exited
I0920 08:27:40.253216 25371 master.hpp:337] Removing task 0 with resources cpus(*):1; mem(*):500
on slave 201309200827-160088899-59397-25371-0 (vesta.apache.org)
W0920 08:27:40.253252 25396 slave.cpp:1976] Master disconnected! Waiting for a new master
to be elected
I0920 08:27:40.253525 25371 master.hpp:357] Removing offer 201309200827-160088899-59397-25371-0
with resources cpus(*):1; mem(*):524; disk(*):1.38501e+06; ports(*):[31000-32000] on slave
201309200827-160088899-59397-25371-0 (vesta.apache.org)
I0920 08:27:40.253624 25391 hierarchical_allocator_process.hpp:598] Recovered cpus(*):1; mem(*):500
(total allocatable: cpus(*):1; mem(*):500) on slave 201309200827-160088899-59397-25371-0 from
framework 201309200827-160088899-59397-25371-0000
I0920 08:27:40.253855 25371 master.cpp:237] Removing slave 201309200827-160088899-59397-25371-0
(vesta.apache.org)
I0920 08:27:40.254473 25371 slave.cpp:454] Slave terminating
I0920 08:27:40.254554 25371 slave.cpp:1167] Asked to shut down framework 201309200827-160088899-59397-25371-0000
by @0.0.0.0:0
I0920 08:27:40.254642 25371 slave.cpp:1192] Shutting down framework 201309200827-160088899-59397-25371-0000
I0920 08:27:40.254708 25371 slave.cpp:2426] Shutting down executor 'default' of framework
201309200827-160088899-59397-25371-0000
I0920 08:27:40.254822 25397 exec.cpp:371] Executor asked to shutdown

GMOCK WARNING:
Uninteresting mock function call - returning directly.
    Function call: shutdown(0x2ada3002ba20)
Stack trace:
I0920 08:27:40.254905 25397 exec.cpp:386] Executor::shutdown took 20.077us
[       OK ] AllocatorZooKeeperTest/0.SlaveReregistersFirst (2134 ms)
I0920 08:27:40.291591 25371 zookeeper_test_server.cpp:93] Shutdown ZooKeeperTestServer on
port 35570
[----------] 2 tests from AllocatorZooKeeperTest/0 (4262 ms total)

[----------] Global test environment tear-down
[==========] 220 tests from 39 test cases ran. (176250 ms total)
[  PASSED  ] 219 tests.
[  FAILED  ] 1 test, listed below:
[  FAILED  ] ZooKeeperTest.Create

 1 FAILED TEST
make[3]: *** [check-local] Error 1
make[3]: Leaving directory `/home/hudson/jenkins-slave/workspace/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Set-JAVA_HOME/build/src'
make[2]: *** [check-am] Error 2
make[2]: Leaving directory `/home/hudson/jenkins-slave/workspace/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Set-JAVA_HOME/build/src'
make[1]: *** [check] Error 2
make[1]: Leaving directory `/home/hudson/jenkins-slave/workspace/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Set-JAVA_HOME/build/src'
make: *** [check-recursive] Error 1
Build step 'Execute shell' marked build as failure

Mime
View raw message