See <https://builds.apache.org/job/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Set-JAVA_HOME/349/changes>
Changes: [benh] Fixed bug creating SVN tag in release.sh. Review: https://reviews.apache.org/r/10767 [benh] Removed use of AWAIT_*_FOR since defaults have been increased. Review: https://reviews.apache.org/r/10765 [benh] Increased default duration to await on futures when testing. Review: https://reviews.apache.org/r/10764 [benh] Missed refactors for new testing abstractions after rebase. [benh] Fixed a comment. Review: https://reviews.apache.org/r/10761 [benh] Updated output of libprocess gtest abstractions. Review: https://reviews.apache.org/r/10760 [benh] Updated some tests to use new testing abstractions. Review: https://reviews.apache.org/r/10759 [benh] Added a Socket reference to Encoder. Review: https://reviews.apache.org/r/10742 [benh] Increased timeouts used in log tests to avoid test failures due to slow hardware or resource contention from other processes. Review: https://reviews.apache.org/r/10464 [benh] Used libprocess testing abstractions in log tests. Review: https://reviews.apache.org/r/10463 [benh] Fixed bug in test where Scheduler::error might not have been invoked before we attempted to stop the scheduler driver. Review: https://reviews.apache.org/r/10462 [benh] Replaced libprocess specific testing abstractions. Review: https://reviews.apache.org/r/10461 [benh] Renamed and improved testing abstractions for awaiting on futures. Review: https://reviews.apache.org/r/10460 [benh] Updated some variable naming to be consistent. Review: https://reviews.apache.org/r/10459 [benh] Removed or replaced use of ProcessIsolator with TestingIsolator. Review: https://reviews.apache.org/r/10458 [benh] Removed unused testing utilities. Review: https://reviews.apache.org/r/10457 [benh] Cleaned up fault tolerant tests and fixed a disabled test. Review: https://reviews.apache.org/r/10456 ------------------------------------------ [...truncated 8888 lines...] I0425 06:59:27.553472 29341 gc.cpp:134] Deleting /tmp/GarbageCollectorIntegrationTest_DiskUsage_9a7bto/slaves/201304250659-1015726915-33163-29148-0/frameworks/201304250659-1015726915-33163-29148-0000/executors/default/runs/2f36d110-8874-4fbf-94a1-32d9c9b9d149 I0425 06:59:27.553900 29341 gc.cpp:143] Deleted '/tmp/GarbageCollectorIntegrationTest_DiskUsage_9a7bto/slaves/201304250659-1015726915-33163-29148-0/frameworks/201304250659-1015726915-33163-29148-0000/executors/default/runs/2f36d110-8874-4fbf-94a1-32d9c9b9d149' I0425 06:59:27.554481 29341 gc.cpp:134] Deleting /tmp/GarbageCollectorIntegrationTest_DiskUsage_9a7bto/slaves/201304250659-1015726915-33163-29148-0/frameworks/201304250659-1015726915-33163-29148-0000/executors/default I0425 06:59:27.554968 29341 gc.cpp:143] Deleted '/tmp/GarbageCollectorIntegrationTest_DiskUsage_9a7bto/slaves/201304250659-1015726915-33163-29148-0/frameworks/201304250659-1015726915-33163-29148-0000/executors/default' I0425 06:59:27.555691 29341 gc.cpp:134] Deleting /tmp/GarbageCollectorIntegrationTest_DiskUsage_9a7bto/slaves/201304250659-1015726915-33163-29148-0/frameworks/201304250659-1015726915-33163-29148-0000 I0425 06:59:27.582525 29341 gc.cpp:143] Deleted '/tmp/GarbageCollectorIntegrationTest_DiskUsage_9a7bto/slaves/201304250659-1015726915-33163-29148-0/frameworks/201304250659-1015726915-33163-29148-0000' I0425 06:59:27.593468 29341 process.cpp:2921] Handling HTTP event for process 'files' with path: '/files/browse.json' I0425 06:59:27.594214 29348 process.cpp:870] Socket closed while receiving I0425 06:59:27.594547 29148 master.cpp:477] Master terminating I0425 06:59:27.594578 29346 sched.cpp:422] Stopping framework '201304250659-1015726915-33163-29148-0000' I0425 06:59:27.594605 29148 master.cpp:283] Shutting down master I0425 06:59:27.594615 29347 slave.cpp:486] Slave asked to shut down by [email protected]:33163 I0425 06:59:27.595705 29344 hierarchical_allocator_process.hpp:359] Deactivated framework 201304250659-1015726915-33163-29148-0000 I0425 06:59:27.596129 29347 slave.cpp:441] Slave terminating [ OK ] GarbageCollectorIntegrationTest.DiskUsage (115 ms) [ RUN ] GarbageCollectorIntegrationTest.Unschedule I0425 06:59:27.597949 29341 master.cpp:309] Master started on 67.195.138.60:33163 I0425 06:59:27.598039 29341 master.cpp:324] Master ID: 201304250659-1015726915-33163-29148 W0425 06:59:27.598531 29347 master.cpp:81] No whitelist given. Advertising offers for all slaves I0425 06:59:27.598577 29344 hierarchical_allocator_process.hpp:236] Initializing hierarchical allocator process with master : [email protected]:33163 I0425 06:59:27.598794 29345 slave.cpp:210] Slave started on 41)@67.195.138.60:33163 I0425 06:59:27.599784 29345 slave.cpp:211] Slave resources: cpus=2; mem=1024; ports=[31000-32000]; disk=1024 I0425 06:59:27.598819 29341 master.cpp:603] Elected as master! I0425 06:59:27.600867 29345 slave.cpp:530] New master detected at [email protected]:33163 I0425 06:59:27.601205 29345 slave.cpp:545] Postponing registration until recovery is complete I0425 06:59:27.601220 29340 status_update_manager.cpp:154] New master detected at [email protected]:33163 I0425 06:59:27.601685 29345 slave.cpp:391] Finished recovery I0425 06:59:27.602738 29344 master.cpp:968] Attempting to register slave on janus.apache.org at slave(41)@67.195.138.60:33163 I0425 06:59:27.603117 29344 master.cpp:1224] Master now considering a slave at janus.apache.org:33163 as active I0425 06:59:27.603587 29344 master.cpp:1885] Adding slave 201304250659-1015726915-33163-29148-0 at janus.apache.org with cpus=2; mem=1024; ports=[31000-32000]; disk=1024 I0425 06:59:27.604111 29345 slave.cpp:590] Registered with master [email protected]:33163; given slave ID 201304250659-1015726915-33163-29148-0 I0425 06:59:27.604650 29341 sched.cpp:182] New master at [email protected]:33163 I0425 06:59:27.604185 29344 hierarchical_allocator_process.hpp:395] Added slave 201304250659-1015726915-33163-29148-0 (janus.apache.org) with cpus=2; mem=1024; ports=[31000-32000]; disk=1024 (and cpus=2; mem=1024; ports=[31000-32000]; disk=1024 available) I0425 06:59:27.605643 29344 hierarchical_allocator_process.hpp:632] No users to allocate resources! I0425 06:59:27.606112 29344 hierarchical_allocator_process.hpp:619] Performed allocation for slave 201304250659-1015726915-33163-29148-0 in 468.484000000000037us I0425 06:59:27.605221 29340 master.cpp:646] Registering framework 201304250659-1015726915-33163-29148-0000 at scheduler(32)@67.195.138.60:33163 I0425 06:59:27.607092 29341 sched.cpp:217] Framework registered with 201304250659-1015726915-33163-29148-0000 I0425 06:59:27.607110 29340 hierarchical_allocator_process.hpp:268] Added framework 201304250659-1015726915-33163-29148-0000 I0425 06:59:27.608502 29340 hierarchical_allocator_process.hpp:660] Found available resources: cpus=2; mem=1024; ports=[31000-32000]; disk=1024 on slave 201304250659-1015726915-33163-29148-0 I0425 06:59:27.608937 29340 hierarchical_allocator_process.hpp:686] Offering cpus=2; mem=1024; ports=[31000-32000]; disk=1024 on slave 201304250659-1015726915-33163-29148-0 to framework 201304250659-1015726915-33163-29148-0000 I0425 06:59:27.609499 29340 hierarchical_allocator_process.hpp:599] Performed allocation for 1 slaves in 1.008825000000000ms I0425 06:59:27.609537 29345 master.hpp:309] Adding offer with resources cpus=2; mem=1024; ports=[31000-32000]; disk=1024 on slave 201304250659-1015726915-33163-29148-0 I0425 06:59:27.610395 29345 master.cpp:1327] Sending 1 offers to framework 201304250659-1015726915-33163-29148-0000 I0425 06:59:27.610895 29342 sched.cpp:282] Received 1 offers I0425 06:59:27.611493 29346 master.cpp:1556] Processing reply for offer 201304250659-1015726915-33163-29148-0 on slave 201304250659-1015726915-33163-29148-0 (janus.apache.org) for framework 201304250659-1015726915-33163-29148-0000 I0425 06:59:27.611904 29346 master.hpp:289] Adding task with resources cpus=2; mem=1024 on slave 201304250659-1015726915-33163-29148-0 I0425 06:59:27.612340 29346 master.cpp:1674] Launching task 0 of framework 201304250659-1015726915-33163-29148-0000 with resources cpus=2; mem=1024 on slave 201304250659-1015726915-33163-29148-0 (janus.apache.org) I0425 06:59:27.612861 29342 slave.cpp:719] Got assigned task 0 for framework 201304250659-1015726915-33163-29148-0000 I0425 06:59:27.613462 29342 slave.cpp:817] Launching task 0 for framework 201304250659-1015726915-33163-29148-0000 I0425 06:59:27.615175 29342 paths.hpp:302] Created executor directory '/tmp/GarbageCollectorIntegrationTest_Unschedule_LPEn0a/slaves/201304250659-1015726915-33163-29148-0/frameworks/201304250659-1015726915-33163-29148-0000/executors/default/runs/fc541685-2c0b-4dbd-9ba0-f1f752468574' I0425 06:59:27.615694 29342 slave.cpp:928] Queuing task '0' for executor default of framework '201304250659-1015726915-33163-29148-0000 I0425 06:59:27.612958 29345 hierarchical_allocator_process.hpp:471] Framework 201304250659-1015726915-33163-29148-0000 left ports=[31000-32000]; disk=1024 unused on slave 201304250659-1015726915-33163-29148-0 I0425 06:59:27.612915 29346 master.hpp:318] Removing offer with resources cpus=2; mem=1024; ports=[31000-32000]; disk=1024 on slave 201304250659-1015726915-33163-29148-0 I0425 06:59:27.615818 29344 exec.cpp:170] Executor started at: executor(17)@67.195.138.60:33163 with pid 29148 I0425 06:59:27.616863 29342 slave.cpp:512] Successfully attached file '/tmp/GarbageCollectorIntegrationTest_Unschedule_LPEn0a/slaves/201304250659-1015726915-33163-29148-0/frameworks/201304250659-1015726915-33163-29148-0000/executors/default/runs/fc541685-2c0b-4dbd-9ba0-f1f752468574' I0425 06:59:27.618928 29342 slave.cpp:1385] Got registration for executor 'default' of framework 201304250659-1015726915-33163-29148-0000 I0425 06:59:27.617385 29345 hierarchical_allocator_process.hpp:497] Framework 201304250659-1015726915-33163-29148-0000 filtered slave 201304250659-1015726915-33163-29148-0 for 5.000000000000000secs I0425 06:59:27.619437 29342 slave.cpp:1500] Flushing queued task 0 for executor 'default' of framework 201304250659-1015726915-33163-29148-0000 I0425 06:59:27.619474 29344 exec.cpp:194] Executor registered on slave 201304250659-1015726915-33163-29148-0 I0425 06:59:27.620970 29344 exec.cpp:258] Executor asked to run task '0' I0425 06:59:27.621587 29344 exec.cpp:382] Executor sending status update for task 0 in state TASK_RUNNING I0425 06:59:27.623567 29344 slave.cpp:1729] Handling status update TASK_RUNNING (UUID: e8c0c32e-4cbf-4de7-9486-f3c30b5432d3) for task 0 of framework 201304250659-1015726915-33163-29148-0000 I0425 06:59:27.623683 29344 status_update_manager.cpp:289] Received status update TASK_RUNNING (UUID: e8c0c32e-4cbf-4de7-9486-f3c30b5432d3) for task 0 of framework 201304250659-1015726915-33163-29148-0000 with checkpoint=false I0425 06:59:27.624002 29344 status_update_manager.cpp:450] Creating StatusUpdate stream for task 0 of framework 201304250659-1015726915-33163-29148-0000 I0425 06:59:27.625066 29344 status_update_manager.cpp:335] Forwarding status update TASK_RUNNING (UUID: e8c0c32e-4cbf-4de7-9486-f3c30b5432d3) for task 0 of framework 201304250659-1015726915-33163-29148-0000 to the master at [email protected]:33163 I0425 06:59:27.625589 29346 master.cpp:1086] Status update from (151)@67.195.138.60:33163: task 0 of framework 201304250659-1015726915-33163-29148-0000 is now in state TASK_RUNNING I0425 06:59:27.625591 29344 slave.cpp:1786] Status update manager successfully handled status update TASK_RUNNING (UUID: e8c0c32e-4cbf-4de7-9486-f3c30b5432d3) for task 0 of framework 201304250659-1015726915-33163-29148-0000 I0425 06:59:27.626576 29344 slave.cpp:1792] Sending acknowledgement for status update TASK_RUNNING (UUID: e8c0c32e-4cbf-4de7-9486-f3c30b5432d3) for task 0 of framework 201304250659-1015726915-33163-29148-0000 to executor executor(17)@67.195.138.60:33163 I0425 06:59:27.626107 29341 sched.cpp:327] Received status update TASK_RUNNING (UUID: e8c0c32e-4cbf-4de7-9486-f3c30b5432d3) for task 0 of framework 201304250659-1015726915-33163-29148-0000 from slave(41)@67.195.138.60:33163 I0425 06:59:27.627143 29346 exec.cpp:289] Executor received ACK for status update of task 0 of framework 201304250659-1015726915-33163-29148-0000 I0425 06:59:27.628049 29341 sched.cpp:360] Sending ACK for status update TASK_RUNNING (UUID: e8c0c32e-4cbf-4de7-9486-f3c30b5432d3) for task 0 of framework 201304250659-1015726915-33163-29148-0000 to slave(41)@67.195.138.60:33163 I0425 06:59:27.628376 29344 slave.cpp:2034] Executor 'default' of framework 201304250659-1015726915-33163-29148-0000 has exited with status '0' I0425 06:59:27.630517 29344 slave.cpp:1729] Handling status update TASK_LOST (UUID: b151b679-f21d-4f46-9bbf-4d2e61cc4c84) for task 0 of framework 201304250659-1015726915-33163-29148-0000 I0425 06:59:27.630712 29343 status_update_manager.cpp:289] Received status update TASK_LOST (UUID: b151b679-f21d-4f46-9bbf-4d2e61cc4c84) for task 0 of framework 201304250659-1015726915-33163-29148-0000 with checkpoint=false I0425 06:59:27.630734 29344 slave.cpp:1292] Got status update acknowledgement e8c0c32e-4cbf-4de7-9486-f3c30b5432d3 for task 0 of framework 201304250659-1015726915-33163-29148-0000 I0425 06:59:27.630751 29346 master.cpp:1188] Executor default of framework 201304250659-1015726915-33163-29148-0000 on slave 201304250659-1015726915-33163-29148-0 (janus.apache.org) exited with status 0 I0425 06:59:27.632200 29344 slave.cpp:1786] Status update manager successfully handled status update TASK_LOST (UUID: b151b679-f21d-4f46-9bbf-4d2e61cc4c84) for task 0 of framework 201304250659-1015726915-33163-29148-0000 I0425 06:59:27.632213 29345 status_update_manager.cpp:360] Received status update acknowledgement e8c0c32e-4cbf-4de7-9486-f3c30b5432d3 for task 0 of framework 201304250659-1015726915-33163-29148-0000 I0425 06:59:27.633364 29344 slave.cpp:1792] Sending acknowledgement for status update TASK_LOST (UUID: b151b679-f21d-4f46-9bbf-4d2e61cc4c84) for task 0 of framework 201304250659-1015726915-33163-29148-0000 to executor executor(17)@67.195.138.60:33163 I0425 06:59:27.633903 29345 status_update_manager.cpp:335] Forwarding status update TASK_LOST (UUID: b151b679-f21d-4f46-9bbf-4d2e61cc4c84) for task 0 of framework 201304250659-1015726915-33163-29148-0000 to the master at [email protected]:33163 I0425 06:59:27.635639 29346 master.cpp:1086] Status update from (151)@67.195.138.60:33163: task 0 of framework 201304250659-1015726915-33163-29148-0000 is now in state TASK_LOST I0425 06:59:27.635646 29343 slave.cpp:1335] Status update manager successfully handled status update acknowledgement e8c0c32e-4cbf-4de7-9486-f3c30b5432d3 for task 0 of framework 201304250659-1015726915-33163-29148-0000 I0425 06:59:27.636093 29346 master.hpp:300] Removing task with resources cpus=2; mem=1024 on slave 201304250659-1015726915-33163-29148-0 I0425 06:59:27.636157 29342 sched.cpp:327] Received status update TASK_LOST (UUID: b151b679-f21d-4f46-9bbf-4d2e61cc4c84) for task 0 of framework 201304250659-1015726915-33163-29148-0000 from slave(41)@67.195.138.60:33163 I0425 06:59:27.637230 29346 hierarchical_allocator_process.hpp:544] Recovered cpus=2; mem=1024 (total allocatable: cpus=2; mem=1024; ports=[31000-32000]; disk=1024) on slave 201304250659-1015726915-33163-29148-0 from framework 201304250659-1015726915-33163-29148-0000 I0425 06:59:27.637663 29342 sched.cpp:360] Sending ACK for status update TASK_LOST (UUID: b151b679-f21d-4f46-9bbf-4d2e61cc4c84) for task 0 of framework 201304250659-1015726915-33163-29148-0000 to slave(41)@67.195.138.60:33163 I0425 06:59:27.638824 29342 slave.cpp:1292] Got status update acknowledgement b151b679-f21d-4f46-9bbf-4d2e61cc4c84 for task 0 of framework 201304250659-1015726915-33163-29148-0000 I0425 06:59:27.639394 29341 status_update_manager.cpp:360] Received status update acknowledgement b151b679-f21d-4f46-9bbf-4d2e61cc4c84 for task 0 of framework 201304250659-1015726915-33163-29148-0000 I0425 06:59:27.639771 29341 status_update_manager.cpp:481] Cleaning up status update stream for task 0 of framework 201304250659-1015726915-33163-29148-0000 I0425 06:59:27.640305 29341 slave.cpp:1335] Status update manager successfully handled status update acknowledgement b151b679-f21d-4f46-9bbf-4d2e61cc4c84 for task 0 of framework 201304250659-1015726915-33163-29148-0000 I0425 06:59:27.640740 29341 slave.cpp:2169] Cleaning up executor 'default' of framework 201304250659-1015726915-33163-29148-0000 I0425 06:59:27.641396 29341 slave.cpp:2233] Cleaning up framework 201304250659-1015726915-33163-29148-0000 I0425 06:59:27.641422 29345 gc.cpp:56] Scheduling '/tmp/GarbageCollectorIntegrationTest_Unschedule_LPEn0a/slaves/201304250659-1015726915-33163-29148-0/frameworks/201304250659-1015726915-33163-29148-0000/executors/default/runs/fc541685-2c0b-4dbd-9ba0-f1f752468574' for removal I0425 06:59:27.641826 29343 status_update_manager.cpp:251] Closing status update streams for framework 201304250659-1015726915-33163-29148-0000 I0425 06:59:27.643074 29345 gc.cpp:56] Scheduling '/tmp/GarbageCollectorIntegrationTest_Unschedule_LPEn0a/slaves/201304250659-1015726915-33163-29148-0/frameworks/201304250659-1015726915-33163-29148-0000/executors/default' for removal I0425 06:59:27.643990 29345 gc.cpp:56] Scheduling '/tmp/GarbageCollectorIntegrationTest_Unschedule_LPEn0a/slaves/201304250659-1015726915-33163-29148-0/frameworks/201304250659-1015726915-33163-29148-0000' for removal I0425 06:59:27.644181 29340 hierarchical_allocator_process.hpp:660] Found available resources: cpus=2; mem=1024; ports=[31000-32000]; disk=1024 on slave 201304250659-1015726915-33163-29148-0 I0425 06:59:27.645393 29340 hierarchical_allocator_process.hpp:686] Offering cpus=2; mem=1024; ports=[31000-32000]; disk=1024 on slave 201304250659-1015726915-33163-29148-0 to framework 201304250659-1015726915-33163-29148-0000 I0425 06:59:27.646205 29340 hierarchical_allocator_process.hpp:599] Performed allocation for 1 slaves in 2.053951000000000ms I0425 06:59:27.646266 29345 master.hpp:309] Adding offer with resources cpus=2; mem=1024; ports=[31000-32000]; disk=1024 on slave 201304250659-1015726915-33163-29148-0 I0425 06:59:27.647625 29345 master.cpp:1327] Sending 1 offers to framework 201304250659-1015726915-33163-29148-0000 I0425 06:59:27.648166 29346 sched.cpp:282] Received 1 offers I0425 06:59:27.648852 29345 master.cpp:1556] Processing reply for offer 201304250659-1015726915-33163-29148-1 on slave 201304250659-1015726915-33163-29148-0 (janus.apache.org) for framework 201304250659-1015726915-33163-29148-0000 I0425 06:59:27.649605 29345 master.hpp:289] Adding task with resources cpus=2; mem=1024 on slave 201304250659-1015726915-33163-29148-0 I0425 06:59:27.651067 29345 master.cpp:1674] Launching task 0 of framework 201304250659-1015726915-33163-29148-0000 with resources cpus=2; mem=1024 on slave 201304250659-1015726915-33163-29148-0 (janus.apache.org) I0425 06:59:27.651931 29346 slave.cpp:719] Got assigned task 0 for framework 201304250659-1015726915-33163-29148-0000 I0425 06:59:27.652001 29345 master.hpp:318] Removing offer with resources cpus=2; mem=1024; ports=[31000-32000]; disk=1024 on slave 201304250659-1015726915-33163-29148-0 I0425 06:59:27.652014 29347 hierarchical_allocator_process.hpp:471] Framework 201304250659-1015726915-33163-29148-0000 left ports=[31000-32000]; disk=1024 unused on slave 201304250659-1015726915-33163-29148-0 I0425 06:59:27.653090 29344 gc.cpp:84] Unscheduling '/tmp/GarbageCollectorIntegrationTest_Unschedule_LPEn0a/slaves/201304250659-1015726915-33163-29148-0/frameworks/201304250659-1015726915-33163-29148-0000' for removal I0425 06:59:27.654288 29347 hierarchical_allocator_process.hpp:497] Framework 201304250659-1015726915-33163-29148-0000 filtered slave 201304250659-1015726915-33163-29148-0 for 5.000000000000000secs I0425 06:59:27.654986 29344 gc.cpp:84] Unscheduling '/tmp/GarbageCollectorIntegrationTest_Unschedule_LPEn0a/slaves/201304250659-1015726915-33163-29148-0/frameworks/201304250659-1015726915-33163-29148-0000/executors/default' for removal I0425 06:59:27.656473 29347 slave.cpp:817] Launching task 0 for framework 201304250659-1015726915-33163-29148-0000 I0425 06:59:27.658133 29347 paths.hpp:302] Created executor directory '/tmp/GarbageCollectorIntegrationTest_Unschedule_LPEn0a/slaves/201304250659-1015726915-33163-29148-0/frameworks/201304250659-1015726915-33163-29148-0000/executors/default/runs/880d2a15-777e-43ca-9a6c-99ddce860b9c' I0425 06:59:27.658334 29347 slave.cpp:928] Queuing task '0' for executor default of framework '201304250659-1015726915-33163-29148-0000 I0425 06:59:27.658474 29341 exec.cpp:170] Executor started at: executor(18)@67.195.138.60:33163 with pid 29148 I0425 06:59:27.658815 29347 slave.cpp:512] Successfully attached file '/tmp/GarbageCollectorIntegrationTest_Unschedule_LPEn0a/slaves/201304250659-1015726915-33163-29148-0/frameworks/201304250659-1015726915-33163-29148-0000/executors/default/runs/880d2a15-777e-43ca-9a6c-99ddce860b9c' I0425 06:59:27.660362 29347 slave.cpp:1385] Got registration for executor 'default' of framework 201304250659-1015726915-33163-29148-0000 I0425 06:59:27.660877 29347 slave.cpp:1500] Flushing queued task 0 for executor 'default' of framework 201304250659-1015726915-33163-29148-0000 I0425 06:59:27.660917 29343 exec.cpp:194] Executor registered on slave 201304250659-1015726915-33163-29148-0 I0425 06:59:27.661834 29343 exec.cpp:258] Executor asked to run task '0' I0425 06:59:27.662322 29343 exec.cpp:382] Executor sending status update for task 0 in state TASK_RUNNING I0425 06:59:27.664181 29343 slave.cpp:1729] Handling status update TASK_RUNNING (UUID: 66ad531d-8b13-432e-96a3-6069c84122a1) for task 0 of framework 201304250659-1015726915-33163-29148-0000 I0425 06:59:27.664369 29346 status_update_manager.cpp:289] Received status update TASK_RUNNING (UUID: 66ad531d-8b13-432e-96a3-6069c84122a1) for task 0 of framework 201304250659-1015726915-33163-29148-0000 with checkpoint=false I0425 06:59:27.664696 29346 status_update_manager.cpp:450] Creating StatusUpdate stream for task 0 of framework 201304250659-1015726915-33163-29148-0000 I0425 06:59:27.665212 29346 status_update_manager.cpp:335] Forwarding status update TASK_RUNNING (UUID: 66ad531d-8b13-432e-96a3-6069c84122a1) for task 0 of framework 201304250659-1015726915-33163-29148-0000 to the master at [email protected]:33163 I0425 06:59:27.665752 29343 slave.cpp:1786] Status update manager successfully handled status update TASK_RUNNING (UUID: 66ad531d-8b13-432e-96a3-6069c84122a1) for task 0 of framework 201304250659-1015726915-33163-29148-0000 I0425 06:59:27.665756 29340 master.cpp:1086] Status update from (151)@67.195.138.60:33163: task 0 of framework 201304250659-1015726915-33163-29148-0000 is now in state TASK_RUNNING I0425 06:59:27.666174 29343 slave.cpp:1792] Sending acknowledgement for status update TASK_RUNNING (UUID: 66ad531d-8b13-432e-96a3-6069c84122a1) for task 0 of framework 201304250659-1015726915-33163-29148-0000 to executor executor(18)@67.195.138.60:33163 I0425 06:59:27.666745 29341 sched.cpp:327] Received status update TASK_RUNNING (UUID: 66ad531d-8b13-432e-96a3-6069c84122a1) for task 0 of framework 201304250659-1015726915-33163-29148-0000 from slave(41)@67.195.138.60:33163 I0425 06:59:27.667217 29344 exec.cpp:289] Executor received ACK for status update of task 0 of framework 201304250659-1015726915-33163-29148-0000 I0425 06:59:27.668898 29341 sched.cpp:360] Sending ACK for status update TASK_RUNNING (UUID: 66ad531d-8b13-432e-96a3-6069c84122a1) for task 0 of framework 201304250659-1015726915-33163-29148-0000 to slave(41)@67.195.138.60:33163 I0425 06:59:27.669770 29341 slave.cpp:1292] Got status update acknowledgement 66ad531d-8b13-432e-96a3-6069c84122a1 for task 0 of framework 201304250659-1015726915-33163-29148-0000 I0425 06:59:27.670302 29341 status_update_manager.cpp:360] Received status update acknowledgement 66ad531d-8b13-432e-96a3-6069c84122a1 for task 0 of framework 201304250659-1015726915-33163-29148-0000 I0425 06:59:27.670737 29341 slave.cpp:1335] Status update manager successfully handled status update acknowledgement 66ad531d-8b13-432e-96a3-6069c84122a1 for task 0 of framework 201304250659-1015726915-33163-29148-0000 I0425 06:59:27.674314 29148 master.cpp:477] Master terminating I0425 06:59:27.674392 29148 master.cpp:283] Shutting down master I0425 06:59:27.674325 29344 sched.cpp:422] Stopping framework '201304250659-1015726915-33163-29148-0000' I0425 06:59:27.674420 29347 slave.cpp:486] Slave asked to shut down by [email protected]:33163 I0425 06:59:27.674974 29148 master.hpp:300] Removing task with resources cpus=2; mem=1024 on slave 201304250659-1015726915-33163-29148-0 I0425 06:59:27.674995 29345 hierarchical_allocator_process.hpp:359] Deactivated framework 201304250659-1015726915-33163-29148-0000 I0425 06:59:27.677106 29347 slave.cpp:1099] Asked to shut down framework 201304250659-1015726915-33163-29148-0000 by [email protected]:33163 I0425 06:59:27.679515 29347 slave.cpp:1124] Shutting down framework 201304250659-1015726915-33163-29148-0000 I0425 06:59:27.680558 29347 slave.cpp:2302] Shutting down executor 'default' of framework 201304250659-1015726915-33163-29148-0000 I0425 06:59:27.681424 29347 slave.cpp:441] Slave terminating I0425 06:59:27.682075 29347 slave.cpp:1099] Asked to shut down framework 201304250659-1015726915-33163-29148-0000 by @0.0.0.0:0 W0425 06:59:27.682546 29347 slave.cpp:1120] Ignoring shutdown framework 201304250659-1015726915-33163-29148-0000 because it is terminating [ OK ] GarbageCollectorIntegrationTest.Unschedule (86 ms) [----------] 5 tests from GarbageCollectorIntegrationTest (1233 ms total) [----------] 8 tests from ResourceOffersTest [ RUN ] ResourceOffersTest.ResourceOfferWithMultipleSlaves I0425 06:59:27.681432 29342 exec.cpp:321] Executor asked to shutdown # # A fatal error has been detected by the Java Runtime Environment: # # SIGSEGV (0xb) at pc=0x00002ad0db3e0949, pid=29148, tid=47076565010176 # # JRE version: 6.0_20-b02 # Java VM: Java HotSpot(TM) 64-Bit Server VM (16.3-b01 mixed mode linux-amd64 ) # Problematic frame: # C [libmesos-0.13.0.so+0x41b949]I0425 06:59:27.684298 29344 master.cpp:309] Master started on 67.195.138.60:33163 _ZN5mesos8internal15ExecutorProcess8shutdownEv+0x159 # # An error report file with more information is saved as: # <https://builds.apache.org/job/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Set-JAVA_HOME/ws/build/src/hs_err_pid29148.log> I0425 06:59:27.685427 29344 master.cpp:324] Master ID: 201304250659-1015726915-33163-29148 I0425 06:59:27.685451 29340 slave.cpp:210] Slave started on 42)@67.195.138.60:33163 I0425 06:59:27.685462 29345 slave.cpp:210] Slave started on 43)@67.195.138.60:33163 I0425 06:59:27.686409 29344 slave.cpp:210] Slave started on 44)@67.195.138.60:33163 I0425 06:59:27.688825 29344 slave.cpp:211] Slave resources: cpus=2; mem=1024; ports=[31000-32000]; disk=1024 I0425 06:59:27.686761 29346 hierarchical_allocator_process.hpp:236] Initializing hierarchical allocator process with master : [email protected]:33163 I0425 06:59:27.690040 29346 slave.cpp:210] Slave started on 47)@67.195.138.60:33163 I0425 06:59:27.686828 29340 slave.cpp:211] Slave resources: cpus=2; mem=1024; ports=[31000-32000]; disk=1024 I0425 06:59:27.687579 29345 slave.cpp:211] Slave resources: cpus=2; mem=1024; ports=[31000-32000]; disk=1024 I0425 06:59:27.691879 29345 slave.cpp:530] New master detected at [email protected]:33163 W0425 06:59:27.686733 29347 master.cpp:81] No whitelist given. Advertising offers for all slaves I0425 06:59:27.689914 29344 slave.cpp:530] New master detected at [email protected]:33163 I0425 06:59:27.686799 29341 slave.cpp:210] Slave started on 45)@67.195.138.60:33163 I0425 06:59:27.690469 29346 slave.cpp:211] Slave resources: cpus=2; mem=1024; ports=[31000-32000]; disk=1024 I0425 06:59:27.691340 29340 slave.cpp:530] New master detected at [email protected]:33163 I0425 06:59:27.687959 29343 slave.cpp:210] Slave started on 46)@67.195.138.60:33163 I0425 06:59:27.691992 29345 slave.cpp:545] Postponing registration until recovery is complete I0425 06:59:27.693243 29347 slave.cpp:210] Slave started on 48)@67.195.138.60:33163 I0425 06:59:27.693694 29344 slave.cpp:545] Postponing registration until recovery is complete I0425 06:59:27.694282 29341 slave.cpp:211] Slave resources: cpus=2; mem=1024; ports=[31000-32000]; disk=1024 I0425 06:59:27.695130 29346 slave.cpp:530] New master detected at [email protected]:33163 I0425 06:59:27.695317 29340 slave.cpp:545] Postponing registration until recovery is complete I0425 06:59:27.695770 29343 slave.cpp:211] Slave resources: cpus=2; mem=1024; ports=[31000-32000]; disk=1024 I0425 06:59:27.696317 29345 slave.cpp:210] Slave started on 49)@67.195.138.60:33163 I0425 06:59:27.696780 29347 slave.cpp:211] Slave resources: cpus=2; mem=1024; ports=[31000-32000]; disk=1024 I0425 06:59:27.697517 29344 slave.cpp:210] Slave started on 50)@67.195.138.60:33163 I0425 06:59:27.698318 29341 slave.cpp:530] New master detected at [email protected]:33163 I0425 06:59:27.702206 29341 slave.cpp:545] Postponing registration until recovery is complete I0425 06:59:27.698982 29340 slave.cpp:210] Slave started on 51)@67.195.138.60:33163 I0425 06:59:27.699779 29343 slave.cpp:530] New master detected at [email protected]:33163 I0425 06:59:27.699996 29345 slave.cpp:211] Slave resources: cpus=2; mem=1024; ports=[31000-32000]; disk=1024 I0425 06:59:27.700783 29347 slave.cpp:530] New master detected at [email protected]:33163 I0425 06:59:27.701701 29344 slave.cpp:211] Slave resources: cpus=2; mem=1024; ports=[31000-32000]; disk=1024 I0425 06:59:27.698487 29346 slave.cpp:545] Postponing registration until recovery is complete I0425 06:59:27.702749 29341 master.cpp:603] Elected as master! I0425 06:59:27.703274 29340 slave.cpp:211] Slave resources: cpus=2; mem=1024; ports=[31000-32000]; disk=1024 I0425 06:59:27.703752 29343 slave.cpp:545] Postponing registration until recovery is complete I0425 06:59:27.704496 29345 slave.cpp:530] New master detected at [email protected]:33163 I0425 06:59:27.707986 29345 slave.cpp:545] Postponing registration until recovery is complete I0425 06:59:27.708578 29345 process_isolator.cpp:304] Recovering isolator I0425 06:59:27.710069 29345 status_update_manager.cpp:154] New master detected at [email protected]:33163 I0425 06:59:27.706511 29341 process_isolator.cpp:304] Recovering isolator I0425 06:59:27.707247 29340 slave.cpp:530] New master detected at [email protected]:33163 I0425 06:59:27.707485 29343 status_update_manager.cpp:154] New master detected at [email protected]:33163 I0425 06:59:27.704735 29347 slave.cpp:545] Postponing registration until recovery is complete I0425 06:59:27.705735 29344 slave.cpp:530] New master detected at [email protected]:33163 I0425 06:59:27.706064 29346 sched.cpp:182] New master at [email protected]:33163 I0425 06:59:27.723693 29345 process_isolator.cpp:304] Recovering isolator I0425 06:59:27.724566 29341 status_update_manager.cpp:154] New master detected at [email protected]:33163 I0425 06:59:27.725332 29340 slave.cpp:545] Postponing registration until recovery is complete I0425 06:59:27.726240 29343 process_isolator.cpp:304] Recovering isolator I0425 06:59:27.727066 29347 status_update_manager.cpp:154] New master detected at [email protected]:33163 I0425 06:59:27.727856 29344 slave.cpp:545] Postponing registration until recovery is complete I0425 06:59:27.728718 29346 process_isolator.cpp:304] Recovering isolator I0425 06:59:27.729606 29345 status_update_manager.cpp:154] New master detected at [email protected]:33163 I0425 06:59:27.730175 29341 process_isolator.cpp:304] Recovering isolator I0425 06:59:27.730628 29340 status_update_manager.cpp:154] New master detected at [email protected]:33163 I0425 06:59:27.731215 29343 process_isolator.cpp:304] Recovering isolator I0425 06:59:27.731726 29347 status_update_manager.cpp:154] New master detected at [email protected]:33163 I0425 06:59:27.732355 29344 process_isolator.cpp:304] Recovering isolator I0425 06:59:27.732882 29346 status_update_manager.cpp:154] New master detected at [email protected]:33163 I0425 06:59:27.733402 29345 process_isolator.cpp:304] Recovering isolator I0425 06:59:27.733923 29341 status_update_manager.cpp:154] New master detected at [email protected]:33163 I0425 06:59:27.734455 29340 process_isolator.cpp:304] Recovering isolator I0425 06:59:27.735478 29343 status_update_manager.cpp:154] New master detected at [email protected]:33163 I0425 06:59:27.735896 29347 slave.cpp:391] Finished recovery # # If you would like to submit a bug report, please visit: # http://java.sun.com/webapps/bugreport/crash.jsp # I0425 06:59:27.736434 29344 slave.cpp:391] Finished recovery /bin/bash: line 5: 29148 Aborted ${dir}$tst FAIL: mesos-tests ================== 1 of 1 test failed ================== make[3]: *** [check-TESTS] Error 1 make[3]: Leaving directory `<https://builds.apache.org/job/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Set-JAVA_HOME/ws/build/src'> make[2]: *** [check-am] Error 2 make[2]: Leaving directory `<https://builds.apache.org/job/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Set-JAVA_HOME/ws/build/src'> make[1]: *** [check] Error 2 make[1]: Leaving directory `<https://builds.apache.org/job/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Set-JAVA_HOME/ws/build/src'> make: *** [check-recursive] Error 1 Build step 'Execute shell' marked build as failure
