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 2013/08/03 07:52:20 UTC

Build failed in Jenkins: Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Disable-Java-Disable-Python-Disable-Webui #1517

See <https://builds.apache.org/job/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Disable-Java-Disable-Python-Disable-Webui/1517/>

------------------------------------------
[...truncated 14418 lines...]
I0803 05:52:18.318819 10952 hierarchical_allocator_process.hpp:684] No resources available to allocate!
I0803 05:52:18.361277 10952 hierarchical_allocator_process.hpp:646] Performed allocation for 0 slaves in 42.459378ms
I0803 05:52:18.361307 10952 hierarchical_allocator_process.hpp:684] No resources available to allocate!
I0803 05:52:18.422469 10952 hierarchical_allocator_process.hpp:646] Performed allocation for 0 slaves in 61.160608ms
I0803 05:52:18.302953 10946 master.cpp:972] Attempting to register slave on vesta.apache.org at slave(106)@67.195.138.9:56700
I0803 05:52:18.438412 10946 master.cpp:1951] Adding slave 201308030552-160088899-56700-10926-0 at vesta.apache.org with cpus(*):3; mem(*):1024; disk(*):762914; ports(*):[31000-32000]
I0803 05:52:18.446436 10949 slave.cpp:597] Registered with master master@67.195.138.9:56700; given slave ID 201308030552-160088899-56700-10926-0
I0803 05:52:18.446604 10946 hierarchical_allocator_process.hpp:430] Added slave 201308030552-160088899-56700-10926-0 (vesta.apache.org) with cpus(*):3; mem(*):1024; disk(*):762914; ports(*):[31000-32000] (and cpus(*):3; mem(*):1024; disk(*):762914; ports(*):[31000-32000] available)
I0803 05:52:18.462362 10946 hierarchical_allocator_process.hpp:709] Offering cpus(*):3; mem(*):1024; disk(*):762914; ports(*):[31000-32000] on slave 201308030552-160088899-56700-10926-0 to framework 201308030552-160088899-56700-10926-0000
I0803 05:52:18.470403 10946 hierarchical_allocator_process.hpp:666] Performed allocation for slave 201308030552-160088899-56700-10926-0 in 8.067872ms
I0803 05:52:18.470439 10949 master.hpp:331] Adding offer 201308030552-160088899-56700-10926-0 with resources cpus(*):3; mem(*):1024; disk(*):762914; ports(*):[31000-32000] on slave 201308030552-160088899-56700-10926-0
I0803 05:52:18.480659 10945 hierarchical_allocator_process.hpp:646] Performed allocation for 1 slaves in 29.806us
I0803 05:52:18.486289 10949 master.cpp:1332] Sending 1 offers to framework 201308030552-160088899-56700-10926-0000
I0803 05:52:18.502483 10949 sched.cpp:340] Scheduler::resourceOffers took 214.017us
I0803 05:52:18.511593 10951 master.cpp:1565] Processing reply for offer 201308030552-160088899-56700-10926-0 on slave 201308030552-160088899-56700-10926-0 (vesta.apache.org) for framework 201308030552-160088899-56700-10926-0000
I0803 05:52:18.519531 10951 master.hpp:309] Adding task 0 with resources cpus(*):1; mem(*):256 on slave 201308030552-160088899-56700-10926-0
I0803 05:52:18.527415 10951 master.cpp:1684] Launching task 0 of framework 201308030552-160088899-56700-10926-0000 with resources cpus(*):1; mem(*):256 on slave 201308030552-160088899-56700-10926-0 (vesta.apache.org)
I0803 05:52:18.535451 10949 slave.cpp:747] Got assigned task 0 for framework 201308030552-160088899-56700-10926-0000
I0803 05:52:18.535459 10951 master.hpp:309] Adding task 1 with resources cpus(*):1; mem(*):256 on slave 201308030552-160088899-56700-10926-0
I0803 05:52:18.551322 10951 master.cpp:1684] Launching task 1 of framework 201308030552-160088899-56700-10926-0000 with resources cpus(*):1; mem(*):256 on slave 201308030552-160088899-56700-10926-0 (vesta.apache.org)
I0803 05:52:18.544430 10947 hierarchical_allocator_process.hpp:646] Performed allocation for 1 slaves in 14.979us
I0803 05:52:18.543498 10949 slave.cpp:845] Launching task 0 for framework 201308030552-160088899-56700-10926-0000
I0803 05:52:18.559375 10951 master.hpp:341] Removing offer 201308030552-160088899-56700-10926-0 with resources cpus(*):3; mem(*):1024; disk(*):762914; ports(*):[31000-32000] on slave 201308030552-160088899-56700-10926-0
I0803 05:52:18.567229 10947 hierarchical_allocator_process.hpp:505] Framework 201308030552-160088899-56700-10926-0000 left cpus(*):1; mem(*):512; disk(*):762914; ports(*):[31000-32000] unused on slave 201308030552-160088899-56700-10926-0
I0803 05:52:18.576143 10949 paths.hpp:303] Created executor directory '/tmp/AllocatorTest_0_TaskFinished_eIxDhL/slaves/201308030552-160088899-56700-10926-0/frameworks/201308030552-160088899-56700-10926-0000/executors/default/runs/cfbbcc54-16f9-4897-a59a-b6d53c36c234'
I0803 05:52:18.591202 10947 hierarchical_allocator_process.hpp:548] Framework 201308030552-160088899-56700-10926-0000 filtered slave 201308030552-160088899-56700-10926-0 for 5secs
I0803 05:52:18.599232 10949 slave.cpp:956] Queuing task '0' for executor default of framework '201308030552-160088899-56700-10926-0000
I0803 05:52:18.599339 10950 exec.cpp:171] Executor started at: executor(37)@67.195.138.9:56700 with pid 10926
I0803 05:52:18.615064 10949 slave.cpp:747] Got assigned task 1 for framework 201308030552-160088899-56700-10926-0000
I0803 05:52:18.617980 10948 hierarchical_allocator_process.hpp:782] Filtered cpus(*):1; mem(*):512; disk(*):762914; ports(*):[31000-32000] on slave 201308030552-160088899-56700-10926-0 for framework 201308030552-160088899-56700-10926-0000
I0803 05:52:18.638950 10948 hierarchical_allocator_process.hpp:646] Performed allocation for 1 slaves in 21.031784ms
I0803 05:52:18.631042 10949 slave.cpp:519] Successfully attached file '/tmp/AllocatorTest_0_TaskFinished_eIxDhL/slaves/201308030552-160088899-56700-10926-0/frameworks/201308030552-160088899-56700-10926-0000/executors/default/runs/cfbbcc54-16f9-4897-a59a-b6d53c36c234'
I0803 05:52:18.654880 10949 slave.cpp:1423] Got registration for executor 'default' of framework 201308030552-160088899-56700-10926-0000
I0803 05:52:18.662854 10949 slave.cpp:1538] Flushing queued task 0 for executor 'default' of framework 201308030552-160088899-56700-10926-0000
I0803 05:52:18.662917 10951 exec.cpp:195] Executor registered on slave 201308030552-160088899-56700-10926-0
I0803 05:52:18.664186 10950 monitor.cpp:180] Publishing resource usage for executor 'default' of framework '201308030552-160088899-56700-10926-0000'
I0803 05:52:18.670799 10949 slave.cpp:845] Launching task 1 for framework 201308030552-160088899-56700-10926-0000
I0803 05:52:18.678737 10951 exec.cpp:206] Executor::registered took 23.764us
I0803 05:52:18.702651 10951 exec.cpp:274] Executor asked to run task '0'
I0803 05:52:18.697197 10950 hierarchical_allocator_process.hpp:782] Filtered cpus(*):1; mem(*):512; disk(*):762914; ports(*):[31000-32000] on slave 201308030552-160088899-56700-10926-0 for framework 201308030552-160088899-56700-10926-0000
I0803 05:52:18.718523 10950 hierarchical_allocator_process.hpp:646] Performed allocation for 1 slaves in 21.369481ms
I0803 05:52:18.710613 10951 exec.cpp:283] Executor::launchTask took 58.889us
I0803 05:52:18.694672 10949 slave.cpp:981] Sending task '1' to executor 'default' of framework 201308030552-160088899-56700-10926-0000
I0803 05:52:18.735211 10951 exec.cpp:464] Executor sending status update TASK_RUNNING (UUID: e9b5b786-52e6-4ddf-84b2-9a4359b264d5) for task 0 of framework 201308030552-160088899-56700-10926-0000
I0803 05:52:18.750422 10946 slave.cpp:1720] Handling status update TASK_RUNNING (UUID: e9b5b786-52e6-4ddf-84b2-9a4359b264d5) for task 0 of framework 201308030552-160088899-56700-10926-0000 from executor(37)@67.195.138.9:56700
I0803 05:52:18.751147 10951 exec.cpp:464] Executor sending status update TASK_FINISHED (UUID: 1468baad-b711-4017-b84a-adfc2075dcac) for task 0 of framework 201308030552-160088899-56700-10926-0000
I0803 05:52:18.758452 10952 status_update_manager.cpp:290] Received status update TASK_RUNNING (UUID: e9b5b786-52e6-4ddf-84b2-9a4359b264d5) for task 0 of framework 201308030552-160088899-56700-10926-0000 with checkpoint=false
I0803 05:52:18.774240 10952 status_update_manager.cpp:450] Creating StatusUpdate stream for task 0 of framework 201308030552-160088899-56700-10926-0000
I0803 05:52:18.766371 10948 slave.cpp:1720] Handling status update TASK_FINISHED (UUID: 1468baad-b711-4017-b84a-adfc2075dcac) for task 0 of framework 201308030552-160088899-56700-10926-0000 from executor(37)@67.195.138.9:56700
I0803 05:52:18.766342 10951 exec.cpp:274] Executor asked to run task '1'
I0803 05:52:18.776710 10945 hierarchical_allocator_process.hpp:782] Filtered cpus(*):1; mem(*):512; disk(*):762914; ports(*):[31000-32000] on slave 201308030552-160088899-56700-10926-0 for framework 201308030552-160088899-56700-10926-0000
I0803 05:52:18.806156 10945 hierarchical_allocator_process.hpp:646] Performed allocation for 1 slaves in 29.521698ms
I0803 05:52:18.798177 10951 exec.cpp:283] Executor::launchTask took 22.14us
I0803 05:52:18.782260 10952 status_update_manager.cpp:336] Forwarding status update TASK_RUNNING (UUID: e9b5b786-52e6-4ddf-84b2-9a4359b264d5) for task 0 of framework 201308030552-160088899-56700-10926-0000 to master@67.195.138.9:56700
I0803 05:52:18.830062 10947 master.cpp:1103] Status update from slave(106)@67.195.138.9:56700: task 0 of framework 201308030552-160088899-56700-10926-0000 is now in state TASK_RUNNING
I0803 05:52:18.830078 10952 status_update_manager.cpp:290] Received status update TASK_FINISHED (UUID: 1468baad-b711-4017-b84a-adfc2075dcac) for task 0 of framework 201308030552-160088899-56700-10926-0000 with checkpoint=false
I0803 05:52:18.830104 10946 slave.cpp:1831] Status update manager successfully handled status update TASK_RUNNING (UUID: e9b5b786-52e6-4ddf-84b2-9a4359b264d5) for task 0 of framework 201308030552-160088899-56700-10926-0000
I0803 05:52:18.822795 10951 exec.cpp:464] Executor sending status update TASK_RUNNING (UUID: b31729ce-0fb2-4583-9ae6-2ff17ad69d21) for task 1 of framework 201308030552-160088899-56700-10926-0000
I0803 05:52:18.838038 10947 sched.cpp:395] Scheduler::statusUpdate took 7.416us
I0803 05:52:18.853893 10946 slave.cpp:1837] Sending acknowledgement for status update TASK_RUNNING (UUID: e9b5b786-52e6-4ddf-84b2-9a4359b264d5) for task 0 of framework 201308030552-160088899-56700-10926-0000 to executor(37)@67.195.138.9:56700
I0803 05:52:18.864320 10948 hierarchical_allocator_process.hpp:782] Filtered cpus(*):1; mem(*):512; disk(*):762914; ports(*):[31000-32000] on slave 201308030552-160088899-56700-10926-0 for framework 201308030552-160088899-56700-10926-0000
I0803 05:52:18.885750 10948 hierarchical_allocator_process.hpp:646] Performed allocation for 1 slaves in 21.49732ms
I0803 05:52:18.877809 10950 exec.cpp:320] Executor received status update acknowledgement e9b5b786-52e6-4ddf-84b2-9a4359b264d5 for task 0 of framework 201308030552-160088899-56700-10926-0000
I0803 05:52:18.877802 10946 slave.cpp:1831] Status update manager successfully handled status update TASK_FINISHED (UUID: 1468baad-b711-4017-b84a-adfc2075dcac) for task 0 of framework 201308030552-160088899-56700-10926-0000
I0803 05:52:18.909598 10946 slave.cpp:1837] Sending acknowledgement for status update TASK_FINISHED (UUID: 1468baad-b711-4017-b84a-adfc2075dcac) for task 0 of framework 201308030552-160088899-56700-10926-0000 to executor(37)@67.195.138.9:56700
I0803 05:52:18.917593 10946 slave.cpp:1720] Handling status update TASK_RUNNING (UUID: b31729ce-0fb2-4583-9ae6-2ff17ad69d21) for task 1 of framework 201308030552-160088899-56700-10926-0000 from executor(37)@67.195.138.9:56700
I0803 05:52:18.917624 10949 exec.cpp:320] Executor received status update acknowledgement 1468baad-b711-4017-b84a-adfc2075dcac for task 0 of framework 201308030552-160088899-56700-10926-0000
I0803 05:52:18.925624 10947 status_update_manager.cpp:290] Received status update TASK_RUNNING (UUID: b31729ce-0fb2-4583-9ae6-2ff17ad69d21) for task 1 of framework 201308030552-160088899-56700-10926-0000 with checkpoint=false
I0803 05:52:18.941443 10947 status_update_manager.cpp:450] Creating StatusUpdate stream for task 1 of framework 201308030552-160088899-56700-10926-0000
I0803 05:52:18.943900 10950 hierarchical_allocator_process.hpp:782] Filtered cpus(*):1; mem(*):512; disk(*):762914; ports(*):[31000-32000] on slave 201308030552-160088899-56700-10926-0 for framework 201308030552-160088899-56700-10926-0000
I0803 05:52:18.949460 10947 status_update_manager.cpp:336] Forwarding status update TASK_RUNNING (UUID: b31729ce-0fb2-4583-9ae6-2ff17ad69d21) for task 1 of framework 201308030552-160088899-56700-10926-0000 to master@67.195.138.9:56700
I0803 05:52:18.957372 10950 hierarchical_allocator_process.hpp:646] Performed allocation for 1 slaves in 13.51557ms
I0803 05:52:18.965415 10947 status_update_manager.cpp:360] Received status update acknowledgement e9b5b786-52e6-4ddf-84b2-9a4359b264d5 for task 0 of framework 201308030552-160088899-56700-10926-0000
I0803 05:52:18.965420 10948 slave.cpp:1831] Status update manager successfully handled status update TASK_RUNNING (UUID: b31729ce-0fb2-4583-9ae6-2ff17ad69d21) for task 1 of framework 201308030552-160088899-56700-10926-0000
I0803 05:52:18.965502 10945 master.cpp:1103] Status update from slave(106)@67.195.138.9:56700: task 1 of framework 201308030552-160088899-56700-10926-0000 is now in state TASK_RUNNING
I0803 05:52:18.981297 10947 status_update_manager.cpp:336] Forwarding status update TASK_FINISHED (UUID: 1468baad-b711-4017-b84a-adfc2075dcac) for task 0 of framework 201308030552-160088899-56700-10926-0000 to master@67.195.138.9:56700
I0803 05:52:18.989233 10948 slave.cpp:1837] Sending acknowledgement for status update TASK_RUNNING (UUID: b31729ce-0fb2-4583-9ae6-2ff17ad69d21) for task 1 of framework 201308030552-160088899-56700-10926-0000 to executor(37)@67.195.138.9:56700
I0803 05:52:19.013146 10948 slave.cpp:1371] Status update manager successfully handled status update acknowledgement e9b5b786-52e6-4ddf-84b2-9a4359b264d5 for task 0 of framework 201308030552-160088899-56700-10926-0000
I0803 05:52:19.005245 10952 master.cpp:1103] Status update from slave(106)@67.195.138.9:56700: task 0 of framework 201308030552-160088899-56700-10926-0000 is now in state TASK_FINISHED
I0803 05:52:19.013175 10947 exec.cpp:320] Executor received status update acknowledgement b31729ce-0fb2-4583-9ae6-2ff17ad69d21 for task 1 of framework 201308030552-160088899-56700-10926-0000
I0803 05:52:18.997299 10945 sched.cpp:395] Scheduler::statusUpdate took 7.124us
I0803 05:52:19.024291 10950 hierarchical_allocator_process.hpp:782] Filtered cpus(*):1; mem(*):512; disk(*):762914; ports(*):[31000-32000] on slave 201308030552-160088899-56700-10926-0 for framework 201308030552-160088899-56700-10926-0000
I0803 05:52:19.029109 10952 master.hpp:321] Removing task 0 with resources cpus(*):1; mem(*):256 on slave 201308030552-160088899-56700-10926-0
I0803 05:52:19.045011 10945 sched.cpp:395] Scheduler::statusUpdate took 6.782us
I0803 05:52:19.052930 10950 hierarchical_allocator_process.hpp:646] Performed allocation for 1 slaves in 28.681572ms
I0803 05:52:19.068959 10945 status_update_manager.cpp:360] Received status update acknowledgement b31729ce-0fb2-4583-9ae6-2ff17ad69d21 for task 1 of framework 201308030552-160088899-56700-10926-0000
I0803 05:52:19.076869 10950 hierarchical_allocator_process.hpp:595] Recovered cpus(*):1; mem(*):256 (total allocatable: cpus(*):2; mem(*):768; disk(*):762914; ports(*):[31000-32000]) on slave 201308030552-160088899-56700-10926-0 from framework 201308030552-160088899-56700-10926-0000
I0803 05:52:19.084796 10945 status_update_manager.cpp:360] Received status update acknowledgement 1468baad-b711-4017-b84a-adfc2075dcac for task 0 of framework 201308030552-160088899-56700-10926-0000
I0803 05:52:19.084821 10948 slave.cpp:1371] Status update manager successfully handled status update acknowledgement b31729ce-0fb2-4583-9ae6-2ff17ad69d21 for task 1 of framework 201308030552-160088899-56700-10926-0000
I0803 05:52:19.100693 10945 status_update_manager.cpp:481] Cleaning up status update stream for task 0 of framework 201308030552-160088899-56700-10926-0000
I0803 05:52:19.116658 10947 slave.cpp:1371] Status update manager successfully handled status update acknowledgement 1468baad-b711-4017-b84a-adfc2075dcac for task 0 of framework 201308030552-160088899-56700-10926-0000
E0803 05:52:19.124574 10947 slave.cpp:1395] Status update acknowledgement 1468baad-b711-4017-b84a-adfc2075dcac for task 0 of unknown executor
I0803 05:52:19.127545 10945 hierarchical_allocator_process.hpp:709] Offering cpus(*):2; mem(*):768; disk(*):762914; ports(*):[31000-32000] on slave 201308030552-160088899-56700-10926-0 to framework 201308030552-160088899-56700-10926-0000
I0803 05:52:19.140617 10945 hierarchical_allocator_process.hpp:646] Performed allocation for 1 slaves in 13.106064ms
I0803 05:52:19.140687 10949 master.hpp:331] Adding offer 201308030552-160088899-56700-10926-1 with resources cpus(*):2; mem(*):768; disk(*):762914; ports(*):[31000-32000] on slave 201308030552-160088899-56700-10926-0
I0803 05:52:19.156486 10949 master.cpp:1332] Sending 1 offers to framework 201308030552-160088899-56700-10926-0000
I0803 05:52:19.164512 10949 sched.cpp:340] Scheduler::resourceOffers took 30.867us
I0803 05:52:19.164649 10926 master.cpp:446] Master terminating
I0803 05:52:19.172394 10949 sched.cpp:498] Stopping framework '201308030552-160088899-56700-10926-0000'
I0803 05:52:19.180359 10926 master.cpp:209] Shutting down master
I0803 05:52:19.180403 10951 slave.cpp:493] Slave asked to shut down by master@67.195.138.9:56700
I0803 05:52:19.196331 10926 master.hpp:321] Removing task 1 with resources cpus(*):1; mem(*):256 on slave 201308030552-160088899-56700-10926-0
I0803 05:52:19.196388 10946 hierarchical_allocator_process.hpp:393] Deactivated framework 201308030552-160088899-56700-10926-0000
I0803 05:52:19.220152 10946 hierarchical_allocator_process.hpp:646] Performed allocation for 1 slaves in 7.651us
I0803 05:52:19.212307 10926 master.hpp:341] Removing offer 201308030552-160088899-56700-10926-1 with resources cpus(*):2; mem(*):768; disk(*):762914; ports(*):[31000-32000] on slave 201308030552-160088899-56700-10926-0
I0803 05:52:19.204254 10951 slave.cpp:1140] Asked to shut down framework 201308030552-160088899-56700-10926-0000 by master@67.195.138.9:56700
I0803 05:52:19.244035 10951 slave.cpp:1165] Shutting down framework 201308030552-160088899-56700-10926-0000
I0803 05:52:19.228173 10946 hierarchical_allocator_process.hpp:595] Recovered cpus(*):1; mem(*):256 (total allocatable: cpus(*):1; mem(*):256) on slave 201308030552-160088899-56700-10926-0 from framework 201308030552-160088899-56700-10926-0000
I0803 05:52:19.251989 10951 slave.cpp:2356] Shutting down executor 'default' of framework 201308030552-160088899-56700-10926-0000
I0803 05:52:19.260023 10946 hierarchical_allocator_process.hpp:595] Recovered cpus(*):2; mem(*):768; disk(*):762914; ports(*):[31000-32000] (total allocatable: cpus(*):3; mem(*):1024; disk(*):762914; ports(*):[31000-32000]) on slave 201308030552-160088899-56700-10926-0 from framework 201308030552-160088899-56700-10926-0000
I0803 05:52:19.275899 10946 hierarchical_allocator_process.hpp:348] Removed framework 201308030552-160088899-56700-10926-0000
I0803 05:52:19.267968 10950 exec.cpp:360] Executor asked to shutdown
I0803 05:52:19.267958 10951 slave.cpp:448] Slave terminating
I0803 05:52:19.283875 10946 hierarchical_allocator_process.hpp:456] Removed slave 201308030552-160088899-56700-10926-0
I0803 05:52:19.291817 10950 exec.cpp:375] Executor::shutdown took 17.265us
I0803 05:52:19.299752 10951 slave.cpp:1140] Asked to shut down framework 201308030552-160088899-56700-10926-0000 by @0.0.0.0:0
I0803 05:52:19.307715 10946 hierarchical_allocator_process.hpp:684] No resources available to allocate!
W0803 05:52:19.323637 10951 slave.cpp:1161] Ignoring shutdown framework 201308030552-160088899-56700-10926-0000 because it is terminating
I0803 05:52:19.331598 10946 hierarchical_allocator_process.hpp:646] Performed allocation for 0 slaves in 23.881799ms
[       OK ] AllocatorTest/0.TaskFinished (1156 ms)
[ RUN      ] AllocatorTest/0.WhitelistSlave
I0803 05:52:19.348214 10948 master.cpp:230] Master started on 67.195.138.9:56700
I0803 05:52:19.348827 10949 slave.cpp:113] Slave started on 107)@67.195.138.9:56700
I0803 05:52:19.355540 10948 master.cpp:245] Master ID: 201308030552-160088899-56700-10926
I0803 05:52:19.363550 10949 slave.cpp:213] Slave resources: cpus(*):2; mem(*):1024; disk(*):762914; ports(*):[31000-32000]
I0803 05:52:19.371691 10952 hierarchical_allocator_process.hpp:287] Initializing hierarchical allocator process with master : master@67.195.138.9:56700
I0803 05:52:19.371711 10948 master.cpp:593] Elected as master!
I0803 05:52:19.371963 10951 sched.cpp:178] New master at master@67.195.138.9:56700
I0803 05:52:19.379883 10949 slave.cpp:537] New master detected at master@67.195.138.9:56700
I0803 05:52:19.411295 10949 slave.cpp:552] Postponing registration until recovery is complete
I0803 05:52:19.403465 10945 master.cpp:643] Registering framework 201308030552-160088899-56700-10926-0000 at scheduler(96)@67.195.138.9:56700
I0803 05:52:19.387387 10952 hierarchical_allocator_process.hpp:470] Updated slave white list: { dummy-slave }
I0803 05:52:19.411345 10947 status_update_manager.cpp:155] New master detected at master@67.195.138.9:56700
I0803 05:52:19.419245 10949 slave.cpp:398] Finished recovery
I0803 05:52:19.427275 10950 sched.cpp:237] Framework registered with 201308030552-160088899-56700-10926-0000
I0803 05:52:19.467103 10950 sched.cpp:251] Scheduler::registered took 17.926us
I0803 05:52:19.435189 10952 hierarchical_allocator_process.hpp:684] No resources available to allocate!
I0803 05:52:19.427280 10945 master.cpp:630] Framework 201308030552-160088899-56700-10926-0000 (scheduler(96)@67.195.138.9:56700) already registered, resending acknowledgement
I0803 05:52:19.483011 10952 hierarchical_allocator_process.hpp:646] Performed allocation for 0 slaves in 47.823207ms
I0803 05:52:19.491051 10948 sched.cpp:232] Ignoring framework registered message because the driver is already connected!
I0803 05:52:19.491052 10945 master.cpp:972] Attempting to register slave on vesta.apache.org at slave(107)@67.195.138.9:56700
I0803 05:52:19.498991 10952 hierarchical_allocator_process.hpp:317] Added framework 201308030552-160088899-56700-10926-0000
I0803 05:52:19.522884 10952 hierarchical_allocator_process.hpp:684] No resources available to allocate!
I0803 05:52:19.514910 10945 master.cpp:1951] Adding slave 201308030552-160088899-56700-10926-0 at vesta.apache.org with cpus(*):2; mem(*):1024; disk(*):762914; ports(*):[31000-32000]
I0803 05:52:19.530858 10952 hierarchical_allocator_process.hpp:646] Performed allocation for 0 slaves in 7.974034ms
I0803 05:52:19.538898 10951 slave.cpp:597] Registered with master master@67.195.138.9:56700; given slave ID 201308030552-160088899-56700-10926-0
I0803 05:52:19.538950 10945 master.cpp:961] Slave 201308030552-160088899-56700-10926-0 (vesta.apache.org) already registered, resending acknowledgement
I0803 05:52:19.546856 10952 hierarchical_allocator_process.hpp:430] Added slave 201308030552-160088899-56700-10926-0 (vesta.apache.org) with cpus(*):2; mem(*):1024; disk(*):762914; ports(*):[31000-32000] (and cpus(*):2; mem(*):1024; disk(*):762914; ports(*):[31000-32000] available)
W0803 05:52:19.562777 10945 slave.cpp:621] Already registered with master master@67.195.138.9:56700
I0803 05:52:19.570760 10952 hierarchical_allocator_process.hpp:666] Performed allocation for slave 201308030552-160088899-56700-10926-0 in 30.188us
I0803 05:52:19.593464 10947 hierarchical_allocator_process.hpp:646] Performed allocation for 1 slaves in 29.507us
I0803 05:52:19.603514 10949 hierarchical_allocator_process.hpp:646] Performed allocation for 1 slaves in 35.925us
I0803 05:52:19.613567 10950 hierarchical_allocator_process.hpp:646] Performed allocation for 1 slaves in 33.513us
I0803 05:52:19.623672 10946 hierarchical_allocator_process.hpp:646] Performed allocation for 1 slaves in 57.37us
I0803 05:52:19.623765 10946 hierarchical_allocator_process.hpp:470] Updated slave white list: { dummy-slave, vesta.apache.org }
I0803 05:52:19.633704 10951 hierarchical_allocator_process.hpp:709] Offering cpus(*):2; mem(*):1024; disk(*):762914; ports(*):[31000-32000] on slave 201308030552-160088899-56700-10926-0 to framework 201308030552-160088899-56700-10926-0000
I0803 05:52:19.638675 10951 hierarchical_allocator_process.hpp:646] Performed allocation for 1 slaves in 5.013444ms
I0803 05:52:19.638733 10945 master.hpp:331] Adding offer 201308030552-160088899-56700-10926-0 with resources cpus(*):2; mem(*):1024; disk(*):762914; ports(*):[31000-32000] on slave 201308030552-160088899-56700-10926-0
I0803 05:52:19.654517 10945 master.cpp:1332] Sending 1 offers to framework 201308030552-160088899-56700-10926-0000
I0803 05:52:19.662531 10947 sched.cpp:340] Scheduler::resourceOffers took 18.651us
I0803 05:52:19.673902 10945 sched.cpp:498] Stopping framework '201308030552-160088899-56700-10926-0000'
I0803 05:52:19.673923 10926 master.cpp:446] Master terminating
I0803 05:52:19.695574 10926 master.cpp:209] Shutting down master
I0803 05:52:19.695575 10948 slave.cpp:493] Slave asked to shut down by master@67.195.138.9:56700
I0803 05:52:19.707574 10952 hierarchical_allocator_process.hpp:393] Deactivated framework 201308030552-160088899-56700-10926-0000
I0803 05:52:19.707644 10926 master.hpp:341] Removing offer 201308030552-160088899-56700-10926-0 with resources cpus(*):2; mem(*):1024; disk(*):762914; ports(*):[31000-32000] on slave 201308030552-160088899-56700-10926-0
I0803 05:52:19.719476 10948 slave.cpp:448] Slave terminating
I0803 05:52:19.731524 10952 hierarchical_allocator_process.hpp:595] Recovered cpus(*):2; mem(*):1024; disk(*):762914; ports(*):[31000-32000] (total allocatable: cpus(*):2; mem(*):1024; disk(*):762914; ports(*):[31000-32000]) on slave 201308030552-160088899-56700-10926-0 from framework 201308030552-160088899-56700-10926-0000
[       OK ] AllocatorTest/0.WhitelistSlave (420 ms)
[ RUN      ] AllocatorTest/0.RoleTest
I0803 05:52:19.767885 10947 master.cpp:230] Master started on 67.195.138.9:56700
I0803 05:52:19.768190 10948 sched.cpp:178] New master at master@67.195.138.9:56700
I0803 05:52:19.779314 10947 master.cpp:245] Master ID: 201308030552-160088899-56700-10926
W0803 05:52:19.803354 10950 master.cpp:83] No whitelist given. Advertising offers for all slaves
I0803 05:52:19.803531 10952 hierarchical_allocator_process.hpp:287] Initializing hierarchical allocator process with master : master@67.195.138.9:56700
I0803 05:52:19.803637 10947 master.cpp:593] Elected as master!
I0803 05:52:19.835177 10947 sched.cpp:482] Got error 'Role 'role1' is not valid.'
I0803 05:52:19.847075 10947 sched.cpp:493] Scheduler::error took 25.208us
I0803 05:52:19.835600 10945 sched.cpp:178] New master at master@67.195.138.9:56700
I0803 05:52:19.859012 10947 sched.cpp:522] Aborting framework ''
I0803 05:52:19.871042 10945 master.cpp:643] Registering framework 201308030552-160088899-56700-10926-0000 at scheduler(98)@67.195.138.9:56700
I0803 05:52:19.882933 10947 sched.cpp:527] Not sending a deactivate message as master is disconnected
I0803 05:52:19.894963 10950 sched.cpp:237] Framework registered with 201308030552-160088899-56700-10926-0000
I0803 05:52:19.895036 10945 hierarchical_allocator_process.hpp:317] Added framework 201308030552-160088899-56700-10926-0000
I0803 05:52:19.930778 10945 hierarchical_allocator_process.hpp:684] No resources available to allocate!
I0803 05:52:19.919056 10926 master.cpp:446] Master terminating
I0803 05:52:19.919062 10949 sched.cpp:498] Stopping framework ''
I0803 05:52:19.918871 10950 sched.cpp:251] Scheduler::registered took 41.99us
I0803 05:52:19.942739 10945 hierarchical_allocator_process.hpp:646] Performed allocation for 0 slaves in 11.962044ms
I0803 05:52:19.954716 10926 master.cpp:209] Shutting down master
I0803 05:52:19.978646 10950 sched.cpp:498] Stopping framework '201308030552-160088899-56700-10926-0000'
I0803 05:52:20.002710 10951 hierarchical_allocator_process.hpp:393] Deactivated framework 201308030552-160088899-56700-10926-0000
[       OK ] AllocatorTest/0.RoleTest (259 ms)
[----------] 10 tests from AllocatorTest/0 (7108 ms total)

[----------] 1 test from LoggingTest
[ RUN      ] LoggingTest.Toggle
I0803 05:52:20.026878 10952 process.cpp:3150] Handling HTTP event for process 'logging' with path: '/logging/toggle'
I0803 05:52:20.045938 10953 process.cpp:986] Socket closed while receiving
I0803 05:52:20.050951 10952 process.cpp:3150] Handling HTTP event for process 'logging' with path: '/logging/toggle'
I0803 05:52:20.063009 10953 process.cpp:986] Socket closed while receiving
I0803 05:52:20.074795 10951 process.cpp:3150] Handling HTTP event for process 'logging' with path: '/logging/toggle'
I0803 05:52:20.086902 10953 process.cpp:986] Socket closed while receiving
I0803 05:52:20.098748 10949 process.cpp:3150] Handling HTTP event for process 'logging' with path: '/logging/toggle'
I0803 05:52:20.110769 10953 process.cpp:986] Socket closed while receiving
I0803 05:52:20.122725 10947 process.cpp:3150] Handling HTTP event for process 'logging' with path: '/logging/toggle'
I0803 05:52:20.134589 10953 process.cpp:986] Socket closed while receiving
I0803 05:52:20.146800 10949 process.cpp:3150] Handling HTTP event for process 'logging' with path: '/logging/toggle'
I0803 05:52:20.159863 10953 process.cpp:986] Socket closed while receiving
[       OK ] LoggingTest.Toggle (141 ms)
[----------] 1 test from LoggingTest (141 ms total)

[----------] 5 tests from CgroupsCpusetTest
[ RUN      ] CgroupsCpusetTest.OneCPUOneCpuset
[       OK ] CgroupsCpusetTest.OneCPUOneCpuset (0 ms)
[ RUN      ] CgroupsCpusetTest.OneCPUManyCpusets
[       OK ] CgroupsCpusetTest.OneCPUManyCpusets (0 ms)
[ RUN      ] CgroupsCpusetTest.ManyCPUOneCpuset
[       OK ] CgroupsCpusetTest.ManyCPUOneCpuset (0 ms)
[ RUN      ] CgroupsCpusetTest.ManyCPUManyCpusets
[       OK ] CgroupsCpusetTest.ManyCPUManyCpusets (1 ms)
[ RUN      ] CgroupsCpusetTest.IntegerAllocations
[       OK ] CgroupsCpusetTest.IntegerAllocations (0 ms)
[----------] 5 tests from CgroupsCpusetTest (1 ms total)

[----------] 3 tests from FsTest
[ RUN      ] FsTest.MountTableRead
[       OK ] FsTest.MountTableRead (12 ms)
[ RUN      ] FsTest.MountTableHasOption
[       OK ] FsTest.MountTableHasOption (0 ms)
[ RUN      ] FsTest.FileSystemTableRead
[       OK ] FsTest.FileSystemTableRead (36 ms)
[----------] 3 tests from FsTest (48 ms total)

[----------] Global test environment tear-down
[==========] 180 tests from 33 test cases ran. (156170 ms total)
[  PASSED  ] 179 tests.
[  FAILED  ] 1 test, listed below:
[  FAILED  ] CoordinatorTest.MultipleAppendsNotLearnedFill

 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-Disable-Java-Disable-Python-Disable-Webui/build/src'
make[2]: *** [check-am] Error 2
make[2]: Leaving directory `/home/hudson/jenkins-slave/workspace/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Disable-Java-Disable-Python-Disable-Webui/build/src'
make[1]: *** [check] Error 2
make[1]: Leaving directory `/home/hudson/jenkins-slave/workspace/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Disable-Java-Disable-Python-Disable-Webui/build/src'
make: *** [check-recursive] Error 1
Build step 'Execute shell' marked build as failure

Jenkins build is back to normal : Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Disable-Java-Disable-Python-Disable-Webui #1518

Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Disable-Java-Disable-Python-Disable-Webui/1518/>