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/07/14 18:28:48 UTC
Build failed in Jenkins:
Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Disable-Java-Disable-Python-Disable-Webui
#1374
See <https://builds.apache.org/job/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Disable-Java-Disable-Python-Disable-Webui/1374/>
------------------------------------------
[...truncated 12904 lines...]
I0714 16:28:45.075263 10012 slave.cpp:390] Finished recovery
I0714 16:28:45.067291 10009 hierarchical_allocator_process.hpp:704] No resources available to allocate!
I0714 16:28:45.091210 10009 hierarchical_allocator_process.hpp:666] Performed allocation for 0 slaves in 23.92075ms
I0714 16:28:45.083300 10012 master.cpp:962] Attempting to register slave on vesta.apache.org at slave(98)@67.195.138.9:50740
I0714 16:28:45.059371 10007 status_update_manager.cpp:155] New master detected at master@67.195.138.9:50740
I0714 16:28:45.107151 10012 master.cpp:1929] Adding slave 201307141628-160088899-50740-9984-0 at vesta.apache.org with cpus=3; mem=1024; ports=[31000-32000]; disk=787215
I0714 16:28:45.123152 10011 slave.cpp:589] Registered with master master@67.195.138.9:50740; given slave ID 201307141628-160088899-50740-9984-0
I0714 16:28:45.123237 10013 hierarchical_allocator_process.hpp:448] Added slave 201307141628-160088899-50740-9984-0 (vesta.apache.org) with cpus=3; mem=1024; ports=[31000-32000]; disk=787215 (and cpus=3; mem=1024; ports=[31000-32000]; disk=787215 available)
I0714 16:28:45.139063 10013 hierarchical_allocator_process.hpp:726] Offering cpus=3; mem=1024; ports=[31000-32000]; disk=787215 on slave 201307141628-160088899-50740-9984-0 to framework 201307141628-160088899-50740-9984-0000
I0714 16:28:45.147112 10013 hierarchical_allocator_process.hpp:686] Performed allocation for slave 201307141628-160088899-50740-9984-0 in 8.058544ms
I0714 16:28:45.147136 10011 master.hpp:327] Adding offer 201307141628-160088899-50740-9984-0 with resources cpus=3; mem=1024; ports=[31000-32000]; disk=787215 on slave 201307141628-160088899-50740-9984-0
I0714 16:28:45.162997 10011 master.cpp:1310] Sending 1 offers to framework 201307141628-160088899-50740-9984-0000
I0714 16:28:45.155010 10013 hierarchical_allocator_process.hpp:666] Performed allocation for 1 slaves in 11.283us
I0714 16:28:45.171078 10011 sched.cpp:340] Scheduler::resourceOffers took 74.89us
I0714 16:28:45.186964 10012 master.cpp:1543] Processing reply for offer 201307141628-160088899-50740-9984-0 on slave 201307141628-160088899-50740-9984-0 (vesta.apache.org) for framework 201307141628-160088899-50740-9984-0000
I0714 16:28:45.194942 10012 master.hpp:305] Adding task 0 with resources cpus=1; mem=256 on slave 201307141628-160088899-50740-9984-0
I0714 16:28:45.202867 10012 master.cpp:1662] Launching task 0 of framework 201307141628-160088899-50740-9984-0000 with resources cpus=1; mem=256 on slave 201307141628-160088899-50740-9984-0 (vesta.apache.org)
I0714 16:28:45.210887 10011 slave.cpp:739] Got assigned task 0 for framework 201307141628-160088899-50740-9984-0000
I0714 16:28:45.210901 10012 master.hpp:305] Adding task 1 with resources cpus=1; mem=256 on slave 201307141628-160088899-50740-9984-0
I0714 16:28:45.226784 10012 master.cpp:1662] Launching task 1 of framework 201307141628-160088899-50740-9984-0000 with resources cpus=1; mem=256 on slave 201307141628-160088899-50740-9984-0 (vesta.apache.org)
I0714 16:28:45.218938 10011 slave.cpp:837] Launching task 0 for framework 201307141628-160088899-50740-9984-0000
I0714 16:28:45.229095 10009 hierarchical_allocator_process.hpp:666] Performed allocation for 1 slaves in 13.524us
I0714 16:28:45.238859 10012 master.hpp:337] Removing offer 201307141628-160088899-50740-9984-0 with resources cpus=3; mem=1024; ports=[31000-32000]; disk=787215 on slave 201307141628-160088899-50740-9984-0
I0714 16:28:45.247668 10011 paths.hpp:303] Created executor directory '/tmp/AllocatorTest_0_TaskFinished_2Cx3Be/slaves/201307141628-160088899-50740-9984-0/frameworks/201307141628-160088899-50740-9984-0000/executors/default/runs/65cb7844-3d5c-4fda-a9df-f33cca3ec2c1'
I0714 16:28:45.254705 10009 hierarchical_allocator_process.hpp:525] Framework 201307141628-160088899-50740-9984-0000 left cpus=1; mem=512; ports=[31000-32000]; disk=787215 unused on slave 201307141628-160088899-50740-9984-0
I0714 16:28:45.270730 10011 slave.cpp:948] Queuing task '0' for executor default of framework '201307141628-160088899-50740-9984-0000
I0714 16:28:45.270913 10010 exec.cpp:171] Executor started at: executor(36)@67.195.138.9:50740 with pid 9984
I0714 16:28:45.278676 10009 hierarchical_allocator_process.hpp:568] Framework 201307141628-160088899-50740-9984-0000 filtered slave 201307141628-160088899-50740-9984-0 for 5secs
I0714 16:28:45.286609 10011 slave.cpp:739] Got assigned task 1 for framework 201307141628-160088899-50740-9984-0000
I0714 16:28:45.305335 10008 hierarchical_allocator_process.hpp:796] Filtered cpus=1; mem=512; ports=[31000-32000]; disk=787215 on slave 201307141628-160088899-50740-9984-0 for framework 201307141628-160088899-50740-9984-0000
I0714 16:28:45.318477 10008 hierarchical_allocator_process.hpp:666] Performed allocation for 1 slaves in 13.164152ms
I0714 16:28:45.310575 10011 slave.cpp:511] Successfully attached file '/tmp/AllocatorTest_0_TaskFinished_2Cx3Be/slaves/201307141628-160088899-50740-9984-0/frameworks/201307141628-160088899-50740-9984-0000/executors/default/runs/65cb7844-3d5c-4fda-a9df-f33cca3ec2c1'
I0714 16:28:45.334465 10011 slave.cpp:1395] Got registration for executor 'default' of framework 201307141628-160088899-50740-9984-0000
I0714 16:28:45.342434 10011 slave.cpp:1510] Flushing queued task 0 for executor 'default' of framework 201307141628-160088899-50740-9984-0000
I0714 16:28:45.342491 10012 exec.cpp:195] Executor registered on slave 201307141628-160088899-50740-9984-0
I0714 16:28:45.423542 10012 exec.cpp:206] Executor::registered took 17.529us
I0714 16:28:45.376622 10013 hierarchical_allocator_process.hpp:796] Filtered cpus=1; mem=512; ports=[31000-32000]; disk=787215 on slave 201307141628-160088899-50740-9984-0 for framework 201307141628-160088899-50740-9984-0000
I0714 16:28:45.442052 10013 hierarchical_allocator_process.hpp:666] Performed allocation for 1 slaves in 65.457098ms
I0714 16:28:45.434119 10012 exec.cpp:274] Executor asked to run task '0'
I0714 16:28:45.350399 10011 slave.cpp:837] Launching task 1 for framework 201307141628-160088899-50740-9984-0000
I0714 16:28:45.458045 10012 exec.cpp:283] Executor::launchTask took 53.933us
I0714 16:28:45.466009 10011 slave.cpp:973] Sending task '1' to executor 'default' of framework 201307141628-160088899-50740-9984-0000
I0714 16:28:45.474714 10012 exec.cpp:464] Executor sending status update TASK_RUNNING (UUID: 512671ae-0f9b-4545-97e7-624749dec9da) for task 0 of framework 201307141628-160088899-50740-9984-0000
I0714 16:28:45.489951 10013 slave.cpp:1692] Handling status update TASK_RUNNING (UUID: 512671ae-0f9b-4545-97e7-624749dec9da) for task 0 of framework 201307141628-160088899-50740-9984-0000 from executor(36)@67.195.138.9:50740
I0714 16:28:45.490664 10012 exec.cpp:464] Executor sending status update TASK_FINISHED (UUID: 1ba138f9-6d5c-4a8c-81ef-6c02b1b02b8c) for task 0 of framework 201307141628-160088899-50740-9984-0000
I0714 16:28:45.505894 10012 exec.cpp:274] Executor asked to run task '1'
I0714 16:28:45.500251 10006 hierarchical_allocator_process.hpp:796] Filtered cpus=1; mem=512; ports=[31000-32000]; disk=787215 on slave 201307141628-160088899-50740-9984-0 for framework 201307141628-160088899-50740-9984-0000
I0714 16:28:45.521824 10006 hierarchical_allocator_process.hpp:666] Performed allocation for 1 slaves in 21.636673ms
I0714 16:28:45.505926 10007 slave.cpp:1692] Handling status update TASK_FINISHED (UUID: 1ba138f9-6d5c-4a8c-81ef-6c02b1b02b8c) for task 0 of framework 201307141628-160088899-50740-9984-0000 from executor(36)@67.195.138.9:50740
I0714 16:28:45.513845 10012 exec.cpp:283] Executor::launchTask took 22.961us
I0714 16:28:45.497951 10013 status_update_manager.cpp:290] Received status update TASK_RUNNING (UUID: 512671ae-0f9b-4545-97e7-624749dec9da) for task 0 of framework 201307141628-160088899-50740-9984-0000 with checkpoint=false
I0714 16:28:45.553696 10013 status_update_manager.cpp:450] Creating StatusUpdate stream for task 0 of framework 201307141628-160088899-50740-9984-0000
I0714 16:28:45.546466 10012 exec.cpp:464] Executor sending status update TASK_RUNNING (UUID: 44e5b035-b903-465d-a5a0-33d200c37d90) for task 1 of framework 201307141628-160088899-50740-9984-0000
I0714 16:28:45.569664 10012 slave.cpp:1692] Handling status update TASK_RUNNING (UUID: 44e5b035-b903-465d-a5a0-33d200c37d90) for task 1 of framework 201307141628-160088899-50740-9984-0000 from executor(36)@67.195.138.9:50740
I0714 16:28:45.561714 10013 status_update_manager.cpp:336] Forwarding status update TASK_RUNNING (UUID: 512671ae-0f9b-4545-97e7-624749dec9da) for task 0 of framework 201307141628-160088899-50740-9984-0000 to master@67.195.138.9:50740
I0714 16:28:45.585638 10013 status_update_manager.cpp:290] Received status update TASK_FINISHED (UUID: 1ba138f9-6d5c-4a8c-81ef-6c02b1b02b8c) for task 0 of framework 201307141628-160088899-50740-9984-0000 with checkpoint=false
I0714 16:28:45.580560 10012 hierarchical_allocator_process.hpp:796] Filtered cpus=1; mem=512; ports=[31000-32000]; disk=787215 on slave 201307141628-160088899-50740-9984-0 for framework 201307141628-160088899-50740-9984-0000
I0714 16:28:45.585660 10010 master.cpp:1093] Status update from slave(98)@67.195.138.9:50740: task 0 of framework 201307141628-160088899-50740-9984-0000 is now in state TASK_RUNNING
I0714 16:28:45.585700 10007 slave.cpp:1803] Status update manager successfully handled status update TASK_RUNNING (UUID: 512671ae-0f9b-4545-97e7-624749dec9da) for task 0 of framework 201307141628-160088899-50740-9984-0000
I0714 16:28:45.593581 10013 status_update_manager.cpp:290] Received status update TASK_RUNNING (UUID: 44e5b035-b903-465d-a5a0-33d200c37d90) for task 1 of framework 201307141628-160088899-50740-9984-0000 with checkpoint=false
I0714 16:28:45.625443 10013 status_update_manager.cpp:450] Creating StatusUpdate stream for task 1 of framework 201307141628-160088899-50740-9984-0000
I0714 16:28:45.609565 10010 sched.cpp:395] Scheduler::statusUpdate took 8.017us
I0714 16:28:45.617475 10007 slave.cpp:1809] Sending acknowledgement for status update TASK_RUNNING (UUID: 512671ae-0f9b-4545-97e7-624749dec9da) for task 0 of framework 201307141628-160088899-50740-9984-0000 to executor(36)@67.195.138.9:50740
I0714 16:28:45.649413 10007 slave.cpp:1803] Status update manager successfully handled status update TASK_FINISHED (UUID: 1ba138f9-6d5c-4a8c-81ef-6c02b1b02b8c) for task 0 of framework 201307141628-160088899-50740-9984-0000
I0714 16:28:45.657356 10007 slave.cpp:1809] Sending acknowledgement for status update TASK_FINISHED (UUID: 1ba138f9-6d5c-4a8c-81ef-6c02b1b02b8c) for task 0 of framework 201307141628-160088899-50740-9984-0000 to executor(36)@67.195.138.9:50740
I0714 16:28:45.601533 10012 hierarchical_allocator_process.hpp:666] Performed allocation for 1 slaves in 21.005185ms
I0714 16:28:45.649446 10009 exec.cpp:320] Executor received status update acknowledgement 512671ae-0f9b-4545-97e7-624749dec9da for task 0 of framework 201307141628-160088899-50740-9984-0000
I0714 16:28:45.633460 10013 status_update_manager.cpp:336] Forwarding status update TASK_RUNNING (UUID: 44e5b035-b903-465d-a5a0-33d200c37d90) for task 1 of framework 201307141628-160088899-50740-9984-0000 to master@67.195.138.9:50740
I0714 16:28:45.689318 10013 status_update_manager.cpp:360] Received status update acknowledgement 512671ae-0f9b-4545-97e7-624749dec9da for task 0 of framework 201307141628-160088899-50740-9984-0000
I0714 16:28:45.681334 10009 exec.cpp:320] Executor received status update acknowledgement 1ba138f9-6d5c-4a8c-81ef-6c02b1b02b8c for task 0 of framework 201307141628-160088899-50740-9984-0000
I0714 16:28:45.689331 10007 master.cpp:1093] Status update from slave(98)@67.195.138.9:50740: task 1 of framework 201307141628-160088899-50740-9984-0000 is now in state TASK_RUNNING
I0714 16:28:45.689364 10008 slave.cpp:1803] Status update manager successfully handled status update TASK_RUNNING (UUID: 44e5b035-b903-465d-a5a0-33d200c37d90) for task 1 of framework 201307141628-160088899-50740-9984-0000
I0714 16:28:45.721160 10008 slave.cpp:1809] Sending acknowledgement for status update TASK_RUNNING (UUID: 44e5b035-b903-465d-a5a0-33d200c37d90) for task 1 of framework 201307141628-160088899-50740-9984-0000 to executor(36)@67.195.138.9:50740
I0714 16:28:45.729159 10008 exec.cpp:320] Executor received status update acknowledgement 44e5b035-b903-465d-a5a0-33d200c37d90 for task 1 of framework 201307141628-160088899-50740-9984-0000
I0714 16:28:45.697253 10013 status_update_manager.cpp:336] Forwarding status update TASK_FINISHED (UUID: 1ba138f9-6d5c-4a8c-81ef-6c02b1b02b8c) for task 0 of framework 201307141628-160088899-50740-9984-0000 to master@67.195.138.9:50740
I0714 16:28:45.723877 10010 hierarchical_allocator_process.hpp:796] Filtered cpus=1; mem=512; ports=[31000-32000]; disk=787215 on slave 201307141628-160088899-50740-9984-0 for framework 201307141628-160088899-50740-9984-0000
I0714 16:28:45.713248 10007 sched.cpp:395] Scheduler::statusUpdate took 6.811us
I0714 16:28:45.745139 10011 slave.cpp:1343] Status update manager successfully handled status update acknowledgement 512671ae-0f9b-4545-97e7-624749dec9da for task 0 of framework 201307141628-160088899-50740-9984-0000
I0714 16:28:45.745141 10013 master.cpp:1093] Status update from slave(98)@67.195.138.9:50740: task 0 of framework 201307141628-160088899-50740-9984-0000 is now in state TASK_FINISHED
I0714 16:28:45.777016 10013 master.hpp:317] Removing task 0 with resources cpus=1; mem=256 on slave 201307141628-160088899-50740-9984-0
I0714 16:28:45.769053 10011 status_update_manager.cpp:360] Received status update acknowledgement 44e5b035-b903-465d-a5a0-33d200c37d90 for task 1 of framework 201307141628-160088899-50740-9984-0000
I0714 16:28:45.792944 10011 slave.cpp:1343] Status update manager successfully handled status update acknowledgement 44e5b035-b903-465d-a5a0-33d200c37d90 for task 1 of framework 201307141628-160088899-50740-9984-0000
I0714 16:28:45.777039 10006 sched.cpp:395] Scheduler::statusUpdate took 12.287us
I0714 16:28:45.753058 10010 hierarchical_allocator_process.hpp:666] Performed allocation for 1 slaves in 29.213658ms
I0714 16:28:45.808945 10006 status_update_manager.cpp:360] Received status update acknowledgement 1ba138f9-6d5c-4a8c-81ef-6c02b1b02b8c for task 0 of framework 201307141628-160088899-50740-9984-0000
I0714 16:28:45.868705 10006 status_update_manager.cpp:481] Cleaning up status update stream for task 0 of framework 201307141628-160088899-50740-9984-0000
I0714 16:28:45.816896 10010 hierarchical_allocator_process.hpp:615] Recovered cpus=1; mem=256 (total allocatable: cpus=2; mem=768; ports=[31000-32000]; disk=787215) on slave 201307141628-160088899-50740-9984-0 from framework 201307141628-160088899-50740-9984-0000
I0714 16:28:45.885486 10010 hierarchical_allocator_process.hpp:726] Offering cpus=2; mem=768; ports=[31000-32000]; disk=787215 on slave 201307141628-160088899-50740-9984-0 to framework 201307141628-160088899-50740-9984-0000
I0714 16:28:45.876693 10006 slave.cpp:1343] Status update manager successfully handled status update acknowledgement 1ba138f9-6d5c-4a8c-81ef-6c02b1b02b8c for task 0 of framework 201307141628-160088899-50740-9984-0000
E0714 16:28:45.901391 10006 slave.cpp:1367] Status update acknowledgement 1ba138f9-6d5c-4a8c-81ef-6c02b1b02b8c for task 0 of unknown executor
I0714 16:28:45.893584 10011 master.hpp:327] Adding offer 201307141628-160088899-50740-9984-1 with resources cpus=2; mem=768; ports=[31000-32000]; disk=787215 on slave 201307141628-160088899-50740-9984-0
I0714 16:28:45.893548 10010 hierarchical_allocator_process.hpp:666] Performed allocation for 1 slaves in 8.079197ms
I0714 16:28:45.920542 10011 master.cpp:1310] Sending 1 offers to framework 201307141628-160088899-50740-9984-0000
I0714 16:28:45.937312 10011 sched.cpp:340] Scheduler::resourceOffers took 17.292us
I0714 16:28:45.937474 9984 master.cpp:436] Master terminating
I0714 16:28:45.953191 9984 master.cpp:209] Shutting down master
I0714 16:28:45.961182 10008 hierarchical_allocator_process.hpp:411] Deactivated framework 201307141628-160088899-50740-9984-0000
I0714 16:28:45.953202 10009 slave.cpp:485] Slave asked to shut down by master@67.195.138.9:50740
I0714 16:28:45.977044 10009 slave.cpp:1112] Asked to shut down framework 201307141628-160088899-50740-9984-0000 by master@67.195.138.9:50740
I0714 16:28:45.985004 10009 slave.cpp:1137] Shutting down framework 201307141628-160088899-50740-9984-0000
I0714 16:28:45.992971 10009 slave.cpp:2328] Shutting down executor 'default' of framework 201307141628-160088899-50740-9984-0000
I0714 16:28:45.980304 10007 hierarchical_allocator_process.hpp:666] Performed allocation for 1 slaves in 13.196us
I0714 16:28:45.945205 10011 sched.cpp:498] Stopping framework '201307141628-160088899-50740-9984-0000'
I0714 16:28:45.961176 9984 master.hpp:317] Removing task 1 with resources cpus=1; mem=256 on slave 201307141628-160088899-50740-9984-0
I0714 16:28:46.000954 10009 slave.cpp:1884] master@67.195.138.9:50740 exited
I0714 16:28:46.001011 10013 exec.cpp:360] Executor asked to shutdown
I0714 16:28:46.040788 10013 exec.cpp:375] Executor::shutdown took 18.985us
I0714 16:28:46.024982 10006 hierarchical_allocator_process.hpp:615] Recovered cpus=1; mem=256 (total allocatable: cpus=1; mem=256; ports=[]; disk=0) on slave 201307141628-160088899-50740-9984-0 from framework 201307141628-160088899-50740-9984-0000
W0714 16:28:46.032793 10009 slave.cpp:1887] Master disconnected! Waiting for a new master to be elected
I0714 16:28:46.024922 9984 master.hpp:337] Removing offer 201307141628-160088899-50740-9984-1 with resources cpus=2; mem=768; ports=[31000-32000]; disk=787215 on slave 201307141628-160088899-50740-9984-0
I0714 16:28:46.056790 10006 hierarchical_allocator_process.hpp:615] Recovered cpus=2; mem=768; ports=[31000-32000]; disk=787215 (total allocatable: cpus=3; mem=1024; ports=[31000-32000]; disk=787215) on slave 201307141628-160088899-50740-9984-0 from framework 201307141628-160088899-50740-9984-0000
I0714 16:28:46.084573 10006 hierarchical_allocator_process.hpp:666] Performed allocation for 1 slaves in 12.772us
I0714 16:28:46.064646 10009 slave.cpp:1112] Asked to shut down framework 201307141628-160088899-50740-9984-0000 by master@67.195.138.9:50740
I0714 16:28:46.092579 10006 hierarchical_allocator_process.hpp:366] Removed framework 201307141628-160088899-50740-9984-0000
W0714 16:28:46.100478 10009 slave.cpp:1133] Ignoring shutdown framework 201307141628-160088899-50740-9984-0000 because it is terminating
I0714 16:28:46.108479 10006 hierarchical_allocator_process.hpp:476] Removed slave 201307141628-160088899-50740-9984-0
I0714 16:28:46.116422 10009 slave.cpp:440] Slave terminating
I0714 16:28:46.136351 10009 slave.cpp:1112] Asked to shut down framework 201307141628-160088899-50740-9984-0000 by @0.0.0.0:0
I0714 16:28:46.142673 10008 hierarchical_allocator_process.hpp:704] No resources available to allocate!
W0714 16:28:46.144310 10009 slave.cpp:1133] Ignoring shutdown framework 201307141628-160088899-50740-9984-0000 because it is terminating
I0714 16:28:46.152277 10008 hierarchical_allocator_process.hpp:666] Performed allocation for 0 slaves in 9.61574ms
[ OK ] AllocatorTest/0.TaskFinished (1224 ms)
[ RUN ] AllocatorTest/0.WhitelistSlave
I0714 16:28:46.172214 10007 master.cpp:230] Master started on 67.195.138.9:50740
I0714 16:28:46.180171 10007 master.cpp:245] Master ID: 201307141628-160088899-50740-9984
I0714 16:28:46.172616 10013 slave.cpp:113] Slave started on 99)@67.195.138.9:50740
I0714 16:28:46.188381 10010 hierarchical_allocator_process.hpp:305] Initializing hierarchical allocator process with master : master@67.195.138.9:50740
I0714 16:28:46.204067 10010 hierarchical_allocator_process.hpp:490] Updated slave white list: { dummy-slave }
I0714 16:28:46.212005 10010 hierarchical_allocator_process.hpp:704] No resources available to allocate!
I0714 16:28:46.219964 10010 hierarchical_allocator_process.hpp:666] Performed allocation for 0 slaves in 7.958684ms
I0714 16:28:46.188395 10007 master.cpp:583] Elected as master!
I0714 16:28:46.188545 10011 sched.cpp:178] New master at master@67.195.138.9:50740
I0714 16:28:46.196157 10013 slave.cpp:205] Slave resources: cpus=2; mem=1024; ports=[31000-32000]; disk=787215
I0714 16:28:46.243971 10011 master.cpp:633] Registering framework 201307141628-160088899-50740-9984-0000 at scheduler(90)@67.195.138.9:50740
I0714 16:28:46.259814 10011 master.cpp:620] Framework 201307141628-160088899-50740-9984-0000 (scheduler(90)@67.195.138.9:50740) already registered, resending acknowledgement
I0714 16:28:46.252262 10013 slave.cpp:529] New master detected at master@67.195.138.9:50740
I0714 16:28:46.259840 10012 sched.cpp:237] Framework registered with 201307141628-160088899-50740-9984-0000
I0714 16:28:46.283684 10012 sched.cpp:251] Scheduler::registered took 10.018us
I0714 16:28:46.291645 10012 sched.cpp:232] Ignoring framework registered message because the driver is already connected!
I0714 16:28:46.275753 10006 status_update_manager.cpp:155] New master detected at master@67.195.138.9:50740
I0714 16:28:46.259865 10007 hierarchical_allocator_process.hpp:335] Added framework 201307141628-160088899-50740-9984-0000
I0714 16:28:46.315523 10007 hierarchical_allocator_process.hpp:704] No resources available to allocate!
I0714 16:28:46.323485 10007 hierarchical_allocator_process.hpp:666] Performed allocation for 0 slaves in 7.963321ms
I0714 16:28:46.275717 10013 slave.cpp:544] Postponing registration until recovery is complete
I0714 16:28:46.339414 10013 slave.cpp:390] Finished recovery
I0714 16:28:46.347472 10008 master.cpp:962] Attempting to register slave on vesta.apache.org at slave(99)@67.195.138.9:50740
I0714 16:28:46.355352 10008 master.cpp:1929] Adding slave 201307141628-160088899-50740-9984-0 at vesta.apache.org with cpus=2; mem=1024; ports=[31000-32000]; disk=787215
I0714 16:28:46.363364 10011 slave.cpp:589] Registered with master master@67.195.138.9:50740; given slave ID 201307141628-160088899-50740-9984-0
I0714 16:28:46.363461 10008 master.cpp:951] Slave 201307141628-160088899-50740-9984-0 (vesta.apache.org) already registered, resending acknowledgement
I0714 16:28:46.363505 10013 hierarchical_allocator_process.hpp:448] Added slave 201307141628-160088899-50740-9984-0 (vesta.apache.org) with cpus=2; mem=1024; ports=[31000-32000]; disk=787215 (and cpus=2; mem=1024; ports=[31000-32000]; disk=787215 available)
W0714 16:28:46.379256 10008 slave.cpp:613] Already registered with master master@67.195.138.9:50740
I0714 16:28:46.399857 10011 hierarchical_allocator_process.hpp:666] Performed allocation for 1 slaves in 12.255us
I0714 16:28:46.409914 10007 hierarchical_allocator_process.hpp:666] Performed allocation for 1 slaves in 24.471us
I0714 16:28:46.419975 10012 hierarchical_allocator_process.hpp:666] Performed allocation for 1 slaves in 13us
I0714 16:28:46.430040 10006 hierarchical_allocator_process.hpp:666] Performed allocation for 1 slaves in 25.98us
I0714 16:28:46.430131 10010 hierarchical_allocator_process.hpp:490] Updated slave white list: { dummy-slave, vesta.apache.org }
I0714 16:28:46.450157 10009 hierarchical_allocator_process.hpp:726] Offering cpus=2; mem=1024; ports=[31000-32000]; disk=787215 on slave 201307141628-160088899-50740-9984-0 to framework 201307141628-160088899-50740-9984-0000
I0714 16:28:46.454872 10009 hierarchical_allocator_process.hpp:666] Performed allocation for 1 slaves in 4.762561ms
I0714 16:28:46.454906 10007 master.hpp:327] Adding offer 201307141628-160088899-50740-9984-0 with resources cpus=2; mem=1024; ports=[31000-32000]; disk=787215 on slave 201307141628-160088899-50740-9984-0
I0714 16:28:46.470860 10007 master.cpp:1310] Sending 1 offers to framework 201307141628-160088899-50740-9984-0000
I0714 16:28:46.478901 10007 sched.cpp:340] Scheduler::resourceOffers took 41.369us
I0714 16:28:46.490382 10010 master.cpp:436] Master terminating
I0714 16:28:46.490391 10013 sched.cpp:498] Stopping framework '201307141628-160088899-50740-9984-0000'
I0714 16:28:46.494750 10010 slave.cpp:485] Slave asked to shut down by master@67.195.138.9:50740
I0714 16:28:46.494840 9984 master.cpp:209] Shutting down master
I0714 16:28:46.510650 10010 slave.cpp:440] Slave terminating
I0714 16:28:46.518708 10008 hierarchical_allocator_process.hpp:411] Deactivated framework 201307141628-160088899-50740-9984-0000
I0714 16:28:46.518756 9984 master.hpp:337] Removing offer 201307141628-160088899-50740-9984-0 with resources cpus=2; mem=1024; ports=[31000-32000]; disk=787215 on slave 201307141628-160088899-50740-9984-0
I0714 16:28:46.534616 10008 hierarchical_allocator_process.hpp:615] Recovered cpus=2; mem=1024; ports=[31000-32000]; disk=787215 (total allocatable: cpus=2; mem=1024; ports=[31000-32000]; disk=787215) on slave 201307141628-160088899-50740-9984-0 from framework 201307141628-160088899-50740-9984-0000
[ OK ] AllocatorTest/0.WhitelistSlave (379 ms)
[ RUN ] AllocatorTest/0.RoleTest
I0714 16:28:46.550942 10006 master.cpp:230] Master started on 67.195.138.9:50740
I0714 16:28:46.551257 10010 sched.cpp:178] New master at master@67.195.138.9:50740
I0714 16:28:46.558444 10006 master.cpp:245] Master ID: 201307141628-160088899-50740-9984
W0714 16:28:46.574542 10007 master.cpp:83] No whitelist given. Advertising offers for all slaves
I0714 16:28:46.574612 10008 hierarchical_allocator_process.hpp:305] Initializing hierarchical allocator process with master : master@67.195.138.9:50740
I0714 16:28:46.574728 10006 master.cpp:583] Elected as master!
I0714 16:28:46.598350 10006 sched.cpp:482] Got error 'Role 'role1' is not valid.'
I0714 16:28:46.598640 10007 sched.cpp:178] New master at master@67.195.138.9:50740
I0714 16:28:46.606257 10006 sched.cpp:493] Scheduler::error took 10.105us
I0714 16:28:46.614384 10013 master.cpp:633] Registering framework 201307141628-160088899-50740-9984-0000 at scheduler(92)@67.195.138.9:50740
I0714 16:28:46.622207 10006 sched.cpp:522] Aborting framework ''
I0714 16:28:46.630242 10010 sched.cpp:237] Framework registered with 201307141628-160088899-50740-9984-0000
I0714 16:28:46.630295 10007 hierarchical_allocator_process.hpp:335] Added framework 201307141628-160088899-50740-9984-0000
I0714 16:28:46.654083 10007 hierarchical_allocator_process.hpp:704] No resources available to allocate!
I0714 16:28:46.646147 10010 sched.cpp:251] Scheduler::registered took 25.637us
I0714 16:28:46.646272 9984 master.cpp:436] Master terminating
I0714 16:28:46.638134 10006 sched.cpp:527] Not sending a deactivate message as master is disconnected
I0714 16:28:46.685982 10006 sched.cpp:498] Stopping framework ''
I0714 16:28:46.670039 10010 sched.cpp:498] Stopping framework '201307141628-160088899-50740-9984-0000'
I0714 16:28:46.678009 9984 master.cpp:209] Shutting down master
I0714 16:28:46.662050 10007 hierarchical_allocator_process.hpp:666] Performed allocation for 0 slaves in 7.966389ms
[ OK ] AllocatorTest/0.RoleTest (173 ms)
[----------] 10 tests from AllocatorTest/0 (6994 ms total)
[----------] 1 test from LoggingTest
[ RUN ] LoggingTest.Toggle
I0714 16:28:46.723775 10012 process.cpp:3139] Handling HTTP event for process 'logging' with path: '/logging/toggle'
I0714 16:28:46.738580 10014 process.cpp:985] Socket closed while receiving
I0714 16:28:46.746490 10011 process.cpp:3139] Handling HTTP event for process 'logging' with path: '/logging/toggle'
I0714 16:28:46.762198 10014 process.cpp:985] Socket closed while receiving
I0714 16:28:46.770506 10013 process.cpp:3139] Handling HTTP event for process 'logging' with path: '/logging/toggle'
I0714 16:28:46.786290 10014 process.cpp:985] Socket closed while receiving
I0714 16:28:46.794298 10006 process.cpp:3139] Handling HTTP event for process 'logging' with path: '/logging/toggle'
I0714 16:28:46.810072 10014 process.cpp:985] Socket closed while receiving
I0714 16:28:46.818119 10013 process.cpp:3139] Handling HTTP event for process 'logging' with path: '/logging/toggle'
I0714 16:28:46.834256 10014 process.cpp:985] Socket closed while receiving
I0714 16:28:46.842288 10009 process.cpp:3139] Handling HTTP event for process 'logging' with path: '/logging/toggle'
I0714 16:28:46.858000 10014 process.cpp:985] Socket closed while receiving
[ OK ] LoggingTest.Toggle (142 ms)
[----------] 1 test from LoggingTest (142 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 (0 ms)
[ RUN ] CgroupsCpusetTest.IntegerAllocations
[ OK ] CgroupsCpusetTest.IntegerAllocations (0 ms)
[----------] 5 tests from CgroupsCpusetTest (0 ms total)
[----------] 3 tests from FsTest
[ RUN ] FsTest.MountTableRead
[ OK ] FsTest.MountTableRead (0 ms)
[ RUN ] FsTest.MountTableHasOption
[ OK ] FsTest.MountTableHasOption (0 ms)
[ RUN ] FsTest.FileSystemTableRead
[ OK ] FsTest.FileSystemTableRead (20 ms)
[----------] 3 tests from FsTest (20 ms total)
[----------] Global test environment tear-down
[==========] 170 tests from 32 test cases ran. (144448 ms total)
[ PASSED ] 169 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
#1375
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/1375/>