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/06/25 05:22:31 UTC
Build failed in Jenkins:
Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Set-JAVA_HOME #1244
See <https://builds.apache.org/job/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Set-JAVA_HOME/1244/>
------------------------------------------
[...truncated 14249 lines...]
I0625 03:22:28.316751 3235 exec.cpp:194] Executor registered on slave 201306250322-143311683-38651-3181-0
I0625 03:22:28.316864 3235 exec.cpp:258] Executor asked to run task '0'
I0625 03:22:28.318099 3235 exec.cpp:404] Executor sending status update TASK_RUNNING (UUID: 10372a95-fff2-468f-b70d-6bc99b7fcbb6) for task 0 of framework 201306250322-143311683-38651-3181-0000
I0625 03:22:28.318169 3235 slave.cpp:1681] Handling status update TASK_RUNNING (UUID: 10372a95-fff2-468f-b70d-6bc99b7fcbb6) for task 0 of framework 201306250322-143311683-38651-3181-0000
I0625 03:22:28.318352 3233 status_update_manager.cpp:290] Received status update TASK_RUNNING (UUID: 10372a95-fff2-468f-b70d-6bc99b7fcbb6) for task 0 of framework 201306250322-143311683-38651-3181-0000 with checkpoint=false
I0625 03:22:28.318389 3233 status_update_manager.cpp:450] Creating StatusUpdate stream for task 0 of framework 201306250322-143311683-38651-3181-0000
I0625 03:22:28.318486 3233 status_update_manager.cpp:336] Forwarding status update TASK_RUNNING (UUID: 10372a95-fff2-468f-b70d-6bc99b7fcbb6) for task 0 of framework 201306250322-143311683-38651-3181-0000 to master@67.195.138.8:38651
I0625 03:22:28.318572 3233 slave.cpp:1792] Status update manager successfully handled status update TASK_RUNNING (UUID: 10372a95-fff2-468f-b70d-6bc99b7fcbb6) for task 0 of framework 201306250322-143311683-38651-3181-0000
I0625 03:22:28.318600 3233 slave.cpp:1798] Sending acknowledgement for status update TASK_RUNNING (UUID: 10372a95-fff2-468f-b70d-6bc99b7fcbb6) for task 0 of framework 201306250322-143311683-38651-3181-0000 to executor(37)@67.195.138.8:38651
I0625 03:22:28.318579 3235 master.cpp:1022] Status update from slave(99)@67.195.138.8:38651: task 0 of framework 201306250322-143311683-38651-3181-0000 is now in state TASK_RUNNING
I0625 03:22:28.318701 3233 exec.cpp:290] Executor received status update acknowledgement 10372a95-fff2-468f-b70d-6bc99b7fcbb6 for task 0 of framework 201306250322-143311683-38651-3181-0000
I0625 03:22:28.318918 3232 status_update_manager.cpp:360] Received status update acknowledgement 10372a95-fff2-468f-b70d-6bc99b7fcbb6 for task 0 of framework 201306250322-143311683-38651-3181-0000
I0625 03:22:28.318982 3232 slave.cpp:1332] Status update manager successfully handled status update acknowledgement 10372a95-fff2-468f-b70d-6bc99b7fcbb6 for task 0 of framework 201306250322-143311683-38651-3181-0000
I0625 03:22:28.319512 3181 master.cpp:385] Master terminating
I0625 03:22:28.319602 3181 master.cpp:207] Shutting down master
I0625 03:22:28.319627 3232 slave.cpp:1873] master@67.195.138.8:38651 exited
W0625 03:22:28.319730 3232 slave.cpp:1876] Master disconnected! Waiting for a new master to be elected
I0625 03:22:28.319723 3181 master.hpp:303] Removing task 0 with resources cpus=1; mem=500 on slave 201306250322-143311683-38651-3181-0
I0625 03:22:28.319807 3232 slave.cpp:1101] Asked to shut down framework 201306250322-143311683-38651-3181-0000 by master@67.195.138.8:38651
I0625 03:22:28.319682 3235 hierarchical_allocator_process.hpp:412] Deactivated framework 201306250322-143311683-38651-3181-0000
I0625 03:22:28.320147 3235 hierarchical_allocator_process.hpp:616] Recovered cpus=1; mem=500 (total allocatable: cpus=2; mem=1024; ports=[31000-32000]; disk=20030) on slave 201306250322-143311683-38651-3181-0 from framework 201306250322-143311683-38651-3181-0000
I0625 03:22:28.320034 3232 slave.cpp:1126] Shutting down framework 201306250322-143311683-38651-3181-0000
I0625 03:22:28.320361 3232 slave.cpp:2317] Shutting down executor 'default' of framework 201306250322-143311683-38651-3181-0000
I0625 03:22:28.320580 3232 exec.cpp:323] Executor asked to shutdown
I0625 03:22:28.320976 3227 master.cpp:228] Master started on 67.195.138.8:38651
I0625 03:22:28.321169 3227 master.cpp:243] Master ID: 201306250322-143311683-38651-3181
W0625 03:22:28.321650 3227 master.cpp:83] No whitelist given. Advertising offers for all slaves
I0625 03:22:28.321784 3227 hierarchical_allocator_process.hpp:295] Initializing hierarchical allocator process with master : master@67.195.138.8:38651
I0625 03:22:28.322968 3230 detector.cpp:420] Master detector (slave(99)@67.195.138.8:38651) found 0 registered masters
I0625 03:22:28.322993 3235 detector.cpp:420] Master detector (scheduler(90)@67.195.138.8:38651) found 0 registered masters
I0625 03:22:28.329802 3235 detector.cpp:441] Master detector (scheduler(90)@67.195.138.8:38651) couldn't find any masters
I0625 03:22:28.329716 3230 detector.cpp:441] Master detector (slave(99)@67.195.138.8:38651) couldn't find any masters
I0625 03:22:28.323808 3231 detector.cpp:234] Master detector (master@67.195.138.8:38651) connected to ZooKeeper ...
I0625 03:22:28.329998 3231 detector.cpp:251] Trying to create path '/znode' in ZooKeeper
I0625 03:22:28.330121 3235 sched.cpp:194] No master detected, waiting for another master
I0625 03:22:28.330180 3233 slave.cpp:562] Lost master(s) ... waiting
I0625 03:22:28.331712 3231 detector.cpp:281] Created ephemeral/sequence znode at '/znode/0000000002'
I0625 03:22:28.332357 3227 detector.cpp:420] Master detector (scheduler(90)@67.195.138.8:38651) found 1 registered masters
I0625 03:22:28.332694 3231 detector.cpp:420] Master detector (master@67.195.138.8:38651) found 1 registered masters
I0625 03:22:28.332701 3232 detector.cpp:420] Master detector (slave(99)@67.195.138.8:38651) found 1 registered masters
I0625 03:22:28.338580 3231 detector.cpp:467] Master detector (master@67.195.138.8:38651) got new master pid: master@67.195.138.8:38651
I0625 03:22:28.338683 3232 detector.cpp:467] Master detector (slave(99)@67.195.138.8:38651) got new master pid: master@67.195.138.8:38651
I0625 03:22:28.338695 3227 detector.cpp:467] Master detector (scheduler(90)@67.195.138.8:38651) got new master pid: master@67.195.138.8:38651
I0625 03:22:28.338773 3231 master.cpp:526] Elected as master!
I0625 03:22:28.338814 3232 slave.cpp:528] New master detected at master@67.195.138.8:38651
I0625 03:22:28.338985 3227 sched.cpp:177] New master at master@67.195.138.8:38651
I0625 03:22:28.339016 3234 status_update_manager.cpp:155] New master detected at master@67.195.138.8:38651
I0625 03:22:28.339095 3232 master.cpp:604] Re-registering framework 201306250322-143311683-38651-3181-0000 at scheduler(90)@67.195.138.8:38651
I0625 03:22:28.339321 3229 sched.cpp:246] Framework re-registered with 201306250322-143311683-38651-3181-0000
I0625 03:22:28.339406 3232 hierarchical_allocator_process.hpp:327] Added framework 201306250322-143311683-38651-3181-0000
I0625 03:22:28.339455 3232 hierarchical_allocator_process.hpp:705] No resources available to allocate!
I0625 03:22:28.339524 3232 hierarchical_allocator_process.hpp:667] Performed allocation for 0 slaves in 69.853us
I0625 03:22:29.312247 3233 master.cpp:963] Attempting to re-register slave 201306250322-143311683-38651-3181-0 at slave(99)@67.195.138.8:38651 (minerva.apache.org)
I0625 03:22:29.312392 3233 master.cpp:1851] Adding slave 201306250322-143311683-38651-3181-0 at minerva.apache.org with cpus=2; mem=1024; ports=[31000-32000]; disk=20030
I0625 03:22:29.312537 3230 slave.cpp:624] Re-registered with master master@67.195.138.8:38651
I0625 03:22:29.312602 3233 master.hpp:291] Adding task 0 with resources cpus=1; mem=500 on slave 201306250322-143311683-38651-3181-0
W0625 03:22:29.312780 3229 slave.cpp:1262] Ignoring updating pid for framework 201306250322-143311683-38651-3181-0000 because it is terminating
I0625 03:22:29.312923 3233 hierarchical_allocator_process.hpp:449] Added slave 201306250322-143311683-38651-3181-0 (minerva.apache.org) with cpus=2; mem=1024; ports=[31000-32000]; disk=20030 (and cpus=1; mem=524; ports=[31000-32000]; disk=20030 available)
I0625 03:22:29.313002 3233 hierarchical_allocator_process.hpp:727] Offering cpus=1; mem=524; ports=[31000-32000]; disk=20030 on slave 201306250322-143311683-38651-3181-0 to framework 201306250322-143311683-38651-3181-0000
I0625 03:22:29.313120 3233 hierarchical_allocator_process.hpp:687] Performed allocation for slave 201306250322-143311683-38651-3181-0 in 127.307us
I0625 03:22:29.313197 3234 master.hpp:313] Adding offer 201306250322-143311683-38651-3181-0 with resources cpus=1; mem=524; ports=[31000-32000]; disk=20030 on slave 201306250322-143311683-38651-3181-0
I0625 03:22:29.313302 3234 master.cpp:1239] Sending 1 offers to framework 201306250322-143311683-38651-3181-0000
I0625 03:22:29.313755 3233 sched.cpp:427] Stopping framework '201306250322-143311683-38651-3181-0000'
I0625 03:22:29.313776 3181 master.cpp:385] Master terminating
I0625 03:22:29.314280 3181 master.cpp:207] Shutting down master
I0625 03:22:29.314378 3181 master.hpp:303] Removing task 0 with resources cpus=1; mem=500 on slave 201306250322-143311683-38651-3181-0
I0625 03:22:29.314662 3231 slave.cpp:484] Slave asked to shut down by master@67.195.138.8:38651
I0625 03:22:29.314712 3231 slave.cpp:1101] Asked to shut down framework 201306250322-143311683-38651-3181-0000 by master@67.195.138.8:38651
I0625 03:22:29.314738 3235 hierarchical_allocator_process.hpp:412] Deactivated framework 201306250322-143311683-38651-3181-0000
I0625 03:22:29.321704 3235 hierarchical_allocator_process.hpp:616] Recovered cpus=1; mem=500 (total allocatable: cpus=1; mem=500; ports=[]; disk=0) on slave 201306250322-143311683-38651-3181-0 from framework 201306250322-143311683-38651-3181-0000
I0625 03:22:29.321816 3235 hierarchical_allocator_process.hpp:616] Recovered cpus=1; mem=524; ports=[31000-32000]; disk=20030 (total allocatable: cpus=2; mem=1024; ports=[31000-32000]; disk=20030) on slave 201306250322-143311683-38651-3181-0 from framework 201306250322-143311683-38651-3181-0000
I0625 03:22:29.315178 3181 master.hpp:323] Removing offer 201306250322-143311683-38651-3181-0 with resources cpus=1; mem=524; ports=[31000-32000]; disk=20030 on slave 201306250322-143311683-38651-3181-0
W0625 03:22:29.314925 3231 slave.cpp:1122] Ignoring shutdown framework 201306250322-143311683-38651-3181-0000 because it is terminating
I0625 03:22:29.322278 3231 slave.cpp:1873] master@67.195.138.8:38651 exited
W0625 03:22:29.322321 3231 slave.cpp:1876] Master disconnected! Waiting for a new master to be elected
I0625 03:22:29.322406 3231 slave.cpp:1101] Asked to shut down framework 201306250322-143311683-38651-3181-0000 by master@67.195.138.8:38651
W0625 03:22:29.322463 3231 slave.cpp:1122] Ignoring shutdown framework 201306250322-143311683-38651-3181-0000 because it is terminating
I0625 03:22:29.322876 3181 slave.cpp:439] Slave terminating
I0625 03:22:29.322911 3181 slave.cpp:1101] Asked to shut down framework 201306250322-143311683-38651-3181-0000 by @0.0.0.0:0
W0625 03:22:29.323036 3181 slave.cpp:1122] Ignoring shutdown framework 201306250322-143311683-38651-3181-0000 because it is terminating
I0625 03:22:29.324002 3234 detector.cpp:420] Master detector (slave(99)@67.195.138.8:38651) found 0 registered masters
I0625 03:22:29.329782 3234 detector.cpp:441] Master detector (slave(99)@67.195.138.8:38651) couldn't find any masters
I0625 03:22:29.330602 3234 hierarchical_allocator_process.hpp:667] Performed allocation for 1 slaves in 15.533us
[ OK ] AllocatorZooKeeperTest/0.FrameworkReregistersFirst (2055 ms)
[ RUN ] AllocatorZooKeeperTest/0.SlaveReregistersFirst
2013-06-25 03:22:29,332:3181(0x2af8619ad700):ZOO_INFO@log_env@658: Client environment:zookeeper.version=zookeeper C client 3.3.4
2013-06-25 03:22:29,332:3181(0x2af8619ad700):ZOO_INFO@log_env@662: Client environment:host.name=minerva
2013-06-25 03:22:29,332:3181(0x2af8619ad700):ZOO_INFO@log_env@669: Client environment:os.name=Linux
2013-06-25 03:22:29,332:3181(0x2af8619ad700):ZOO_INFO@log_env@670: Client environment:os.arch=3.2.0-38-generic
2013-06-25 03:22:29,332:3181(0x2af8619ad700):ZOO_INFO@log_env@671: Client environment:os.version=#61-Ubuntu SMP Tue Feb 19 12:18:21 UTC 2013
2013-06-25 03:22:29,332:3181(0x2af8619ad700):ZOO_INFO@log_env@679: Client environment:user.name=(null)
2013-06-25 03:22:29,332:3181(0x2af970b73700):ZOO_INFO@check_events@1585: initiated connection to server [127.0.0.1:50724]
I0625 03:22:29.331264 3232 master.cpp:228] Master started on 67.195.138.8:38651
I0625 03:22:29.341694 3232 master.cpp:243] Master ID: 201306250322-143311683-38651-3181
I0625 03:22:29.333645 3235 detector.cpp:234] Master detector (master@67.195.138.8:38651) connected to ZooKeeper ...
I0625 03:22:29.341871 3235 detector.cpp:251] Trying to create path '/znode' in ZooKeeper
W0625 03:22:29.341958 3234 master.cpp:83] No whitelist given. Advertising offers for all slaves
I0625 03:22:29.331845 3229 slave.cpp:112] Slave started on 100)@67.195.138.8:38651
I0625 03:22:29.334744 3231 detector.cpp:234] Master detector (scheduler(91)@67.195.138.8:38651) connected to ZooKeeper ...
I0625 03:22:29.342171 3231 detector.cpp:251] Trying to create path '/znode' in ZooKeeper
I0625 03:22:29.341922 3233 hierarchical_allocator_process.hpp:295] Initializing hierarchical allocator process with master : master@67.195.138.8:38651
I0625 03:22:29.334419 3227 detector.cpp:234] Master detector (slave(100)@67.195.138.8:38651) connected to ZooKeeper ...
I0625 03:22:29.342202 3229 slave.cpp:204] Slave resources: cpus=2; mem=1024; ports=[31000-32000]; disk=20030
I0625 03:22:29.342349 3227 detector.cpp:251] Trying to create path '/znode' in ZooKeeper
I0625 03:22:29.345832 3230 slave.cpp:389] Finished recovery
I0625 03:22:29.347018 3235 detector.cpp:281] Created ephemeral/sequence znode at '/znode/0000000004'
I0625 03:22:29.347084 3231 detector.cpp:420] Master detector (scheduler(91)@67.195.138.8:38651) found 1 registered masters
I0625 03:22:29.347467 3227 detector.cpp:420] Master detector (slave(100)@67.195.138.8:38651) found 1 registered masters
I0625 03:22:29.347648 3235 detector.cpp:420] Master detector (master@67.195.138.8:38651) found 1 registered masters
I0625 03:22:29.354456 3231 detector.cpp:467] Master detector (scheduler(91)@67.195.138.8:38651) got new master pid: master@67.195.138.8:38651
I0625 03:22:29.354555 3231 sched.cpp:177] New master at master@67.195.138.8:38651
W0625 03:22:29.354670 3229 master.cpp:549] Ignoring register framework message since not elected yet
I0625 03:22:29.357540 3227 detector.cpp:467] Master detector (slave(100)@67.195.138.8:38651) got new master pid: master@67.195.138.8:38651
I0625 03:22:29.357597 3235 detector.cpp:467] Master detector (master@67.195.138.8:38651) got new master pid: master@67.195.138.8:38651
I0625 03:22:29.357624 3227 slave.cpp:528] New master detected at master@67.195.138.8:38651
I0625 03:22:29.357697 3230 master.cpp:526] Elected as master!
I0625 03:22:29.357751 3229 status_update_manager.cpp:155] New master detected at master@67.195.138.8:38651
I0625 03:22:29.357828 3230 master.cpp:891] Attempting to register slave on minerva.apache.org at slave(100)@67.195.138.8:38651
I0625 03:22:29.357985 3230 master.cpp:1851] Adding slave 201306250322-143311683-38651-3181-0 at minerva.apache.org with cpus=2; mem=1024; ports=[31000-32000]; disk=20030
I0625 03:22:29.358074 3227 slave.cpp:588] Registered with master master@67.195.138.8:38651; given slave ID 201306250322-143311683-38651-3181-0
I0625 03:22:29.358160 3230 hierarchical_allocator_process.hpp:449] Added slave 201306250322-143311683-38651-3181-0 (minerva.apache.org) with cpus=2; mem=1024; ports=[31000-32000]; disk=20030 (and cpus=2; mem=1024; ports=[31000-32000]; disk=20030 available)
I0625 03:22:29.358204 3230 hierarchical_allocator_process.hpp:700] No users to allocate resources!
I0625 03:22:29.358270 3230 hierarchical_allocator_process.hpp:687] Performed allocation for slave 201306250322-143311683-38651-3181-0 in 66.407us
I0625 03:22:30.342771 3227 hierarchical_allocator_process.hpp:700] No users to allocate resources!
I0625 03:22:30.342911 3227 hierarchical_allocator_process.hpp:667] Performed allocation for 1 slaves in 183.564us
I0625 03:22:30.354995 3234 master.cpp:569] Registering framework 201306250322-143311683-38651-3181-0000 at scheduler(91)@67.195.138.8:38651
I0625 03:22:30.355116 3234 hierarchical_allocator_process.hpp:327] Added framework 201306250322-143311683-38651-3181-0000
I0625 03:22:30.355144 3231 sched.cpp:222] Framework registered with 201306250322-143311683-38651-3181-0000
I0625 03:22:30.355181 3234 hierarchical_allocator_process.hpp:727] Offering cpus=2; mem=1024; ports=[31000-32000]; disk=20030 on slave 201306250322-143311683-38651-3181-0 to framework 201306250322-143311683-38651-3181-0000
I0625 03:22:30.355543 3234 hierarchical_allocator_process.hpp:667] Performed allocation for 1 slaves in 386.991us
I0625 03:22:30.355594 3235 master.hpp:313] Adding offer 201306250322-143311683-38651-3181-0 with resources cpus=2; mem=1024; ports=[31000-32000]; disk=20030 on slave 201306250322-143311683-38651-3181-0
I0625 03:22:30.355775 3235 master.cpp:1239] Sending 1 offers to framework 201306250322-143311683-38651-3181-0000
I0625 03:22:30.356094 3234 master.cpp:1472] Processing reply for offer 201306250322-143311683-38651-3181-0 on slave 201306250322-143311683-38651-3181-0 (minerva.apache.org) for framework 201306250322-143311683-38651-3181-0000
I0625 03:22:30.356269 3234 master.hpp:291] Adding task 0 with resources cpus=1; mem=500 on slave 201306250322-143311683-38651-3181-0
I0625 03:22:30.356314 3234 master.cpp:1591] Launching task 0 of framework 201306250322-143311683-38651-3181-0000 with resources cpus=1; mem=500 on slave 201306250322-143311683-38651-3181-0 (minerva.apache.org)
I0625 03:22:30.356441 3227 slave.cpp:728] Got assigned task 0 for framework 201306250322-143311683-38651-3181-0000
I0625 03:22:30.356536 3230 hierarchical_allocator_process.hpp:526] Framework 201306250322-143311683-38651-3181-0000 left cpus=1; mem=524; ports=[31000-32000]; disk=20030 unused on slave 201306250322-143311683-38651-3181-0
I0625 03:22:30.356649 3227 slave.cpp:826] Launching task 0 for framework 201306250322-143311683-38651-3181-0000
I0625 03:22:30.356690 3234 master.hpp:323] Removing offer 201306250322-143311683-38651-3181-0 with resources cpus=2; mem=1024; ports=[31000-32000]; disk=20030 on slave 201306250322-143311683-38651-3181-0
I0625 03:22:30.356667 3230 hierarchical_allocator_process.hpp:569] Framework 201306250322-143311683-38651-3181-0000 filtered slave 201306250322-143311683-38651-3181-0 for 5secs
I0625 03:22:30.358161 3227 paths.hpp:303] Created executor directory '/tmp/AllocatorZooKeeperTest_0_SlaveReregistersFirst_zlX9NK/slaves/201306250322-143311683-38651-3181-0/frameworks/201306250322-143311683-38651-3181-0000/executors/default/runs/b4b1ed34-cb5c-479a-b97c-8b423f113751'
I0625 03:22:30.358327 3227 slave.cpp:937] Queuing task '0' for executor default of framework '201306250322-143311683-38651-3181-0000
I0625 03:22:30.358389 3227 slave.cpp:510] Successfully attached file '/tmp/AllocatorZooKeeperTest_0_SlaveReregistersFirst_zlX9NK/slaves/201306250322-143311683-38651-3181-0/frameworks/201306250322-143311683-38651-3181-0000/executors/default/runs/b4b1ed34-cb5c-479a-b97c-8b423f113751'
I0625 03:22:30.358542 3227 exec.cpp:170] Executor started at: executor(38)@67.195.138.8:38651 with pid 3181
I0625 03:22:30.358652 3230 slave.cpp:1384] Got registration for executor 'default' of framework 201306250322-143311683-38651-3181-0000
I0625 03:22:30.358765 3230 slave.cpp:1499] Flushing queued task 0 for executor 'default' of framework 201306250322-143311683-38651-3181-0000
I0625 03:22:30.358821 3231 exec.cpp:194] Executor registered on slave 201306250322-143311683-38651-3181-0
I0625 03:22:30.358949 3231 exec.cpp:258] Executor asked to run task '0'
I0625 03:22:30.360216 3231 exec.cpp:404] Executor sending status update TASK_RUNNING (UUID: 90e880b2-0ab0-45b1-b702-cd81db66d68a) for task 0 of framework 201306250322-143311683-38651-3181-0000
I0625 03:22:30.360327 3227 slave.cpp:1681] Handling status update TASK_RUNNING (UUID: 90e880b2-0ab0-45b1-b702-cd81db66d68a) for task 0 of framework 201306250322-143311683-38651-3181-0000
I0625 03:22:30.360513 3235 status_update_manager.cpp:290] Received status update TASK_RUNNING (UUID: 90e880b2-0ab0-45b1-b702-cd81db66d68a) for task 0 of framework 201306250322-143311683-38651-3181-0000 with checkpoint=false
I0625 03:22:30.360633 3235 status_update_manager.cpp:450] Creating StatusUpdate stream for task 0 of framework 201306250322-143311683-38651-3181-0000
I0625 03:22:30.360810 3235 status_update_manager.cpp:336] Forwarding status update TASK_RUNNING (UUID: 90e880b2-0ab0-45b1-b702-cd81db66d68a) for task 0 of framework 201306250322-143311683-38651-3181-0000 to master@67.195.138.8:38651
I0625 03:22:30.360946 3231 master.cpp:1022] Status update from slave(100)@67.195.138.8:38651: task 0 of framework 201306250322-143311683-38651-3181-0000 is now in state TASK_RUNNING
I0625 03:22:30.360980 3232 slave.cpp:1792] Status update manager successfully handled status update TASK_RUNNING (UUID: 90e880b2-0ab0-45b1-b702-cd81db66d68a) for task 0 of framework 201306250322-143311683-38651-3181-0000
I0625 03:22:30.361085 3232 slave.cpp:1798] Sending acknowledgement for status update TASK_RUNNING (UUID: 90e880b2-0ab0-45b1-b702-cd81db66d68a) for task 0 of framework 201306250322-143311683-38651-3181-0000 to executor(38)@67.195.138.8:38651
I0625 03:22:30.361217 3230 exec.cpp:290] Executor received status update acknowledgement 90e880b2-0ab0-45b1-b702-cd81db66d68a for task 0 of framework 201306250322-143311683-38651-3181-0000
I0625 03:22:30.361371 3235 status_update_manager.cpp:360] Received status update acknowledgement 90e880b2-0ab0-45b1-b702-cd81db66d68a for task 0 of framework 201306250322-143311683-38651-3181-0000
I0625 03:22:30.361699 3229 slave.cpp:1332] Status update manager successfully handled status update acknowledgement 90e880b2-0ab0-45b1-b702-cd81db66d68a for task 0 of framework 201306250322-143311683-38651-3181-0000
I0625 03:22:30.361851 3231 master.cpp:385] Master terminating
I0625 03:22:30.362056 3181 master.cpp:207] Shutting down master
I0625 03:22:30.362071 3235 slave.cpp:1873] master@67.195.138.8:38651 exited
W0625 03:22:30.362287 3235 slave.cpp:1876] Master disconnected! Waiting for a new master to be elected
I0625 03:22:30.362329 3227 hierarchical_allocator_process.hpp:412] Deactivated framework 201306250322-143311683-38651-3181-0000
I0625 03:22:30.362373 3181 master.hpp:303] Removing task 0 with resources cpus=1; mem=500 on slave 201306250322-143311683-38651-3181-0
I0625 03:22:30.362428 3235 slave.cpp:1101] Asked to shut down framework 201306250322-143311683-38651-3181-0000 by master@67.195.138.8:38651
I0625 03:22:30.362622 3235 slave.cpp:1126] Shutting down framework 201306250322-143311683-38651-3181-0000
I0625 03:22:30.362670 3235 slave.cpp:2317] Shutting down executor 'default' of framework 201306250322-143311683-38651-3181-0000
I0625 03:22:30.362725 3229 hierarchical_allocator_process.hpp:616] Recovered cpus=1; mem=500 (total allocatable: cpus=2; mem=1024; ports=[31000-32000]; disk=20030) on slave 201306250322-143311683-38651-3181-0 from framework 201306250322-143311683-38651-3181-0000
I0625 03:22:30.362777 3227 exec.cpp:323] Executor asked to shutdown
I0625 03:22:30.362962 3229 hierarchical_allocator_process.hpp:367] Removed framework 201306250322-143311683-38651-3181-0000
I0625 03:22:30.364258 3235 master.cpp:228] Master started on 67.195.138.8:38651
I0625 03:22:30.364326 3235 master.cpp:243] Master ID: 201306250322-143311683-38651-3181
I0625 03:22:30.364691 3234 detector.cpp:420] Master detector (slave(100)@67.195.138.8:38651) found 0 registered masters
I0625 03:22:30.369676 3234 detector.cpp:441] Master detector (slave(100)@67.195.138.8:38651) couldn't find any masters
I0625 03:22:30.365847 3230 detector.cpp:420] Master detector (scheduler(91)@67.195.138.8:38651) found 0 registered masters
I0625 03:22:30.365643 3229 detector.cpp:234] Master detector (master@67.195.138.8:38651) connected to ZooKeeper ...
W0625 03:22:30.369700 3227 master.cpp:83] No whitelist given. Advertising offers for all slaves
I0625 03:22:30.369796 3234 slave.cpp:562] Lost master(s) ... waiting
I0625 03:22:30.369846 3230 detector.cpp:441] Master detector (scheduler(91)@67.195.138.8:38651) couldn't find any masters
I0625 03:22:30.369880 3232 hierarchical_allocator_process.hpp:295] Initializing hierarchical allocator process with master : master@67.195.138.8:38651
I0625 03:22:30.369911 3229 detector.cpp:251] Trying to create path '/znode' in ZooKeeper
I0625 03:22:30.370239 3231 sched.cpp:194] No master detected, waiting for another master
I0625 03:22:30.372005 3229 detector.cpp:281] Created ephemeral/sequence znode at '/znode/0000000006'
I0625 03:22:30.372347 3230 detector.cpp:420] Master detector (scheduler(91)@67.195.138.8:38651) found 1 registered masters
I0625 03:22:30.372625 3231 detector.cpp:420] Master detector (slave(100)@67.195.138.8:38651) found 1 registered masters
I0625 03:22:30.372782 3229 detector.cpp:420] Master detector (master@67.195.138.8:38651) found 1 registered masters
I0625 03:22:30.378393 3230 detector.cpp:467] Master detector (scheduler(91)@67.195.138.8:38651) got new master pid: master@67.195.138.8:38651
I0625 03:22:30.378545 3231 detector.cpp:467] Master detector (slave(100)@67.195.138.8:38651) got new master pid: master@67.195.138.8:38651
I0625 03:22:30.378576 3227 sched.cpp:177] New master at master@67.195.138.8:38651
I0625 03:22:30.378742 3229 detector.cpp:467] Master detector (master@67.195.138.8:38651) got new master pid: master@67.195.138.8:38651
I0625 03:22:30.378751 3231 slave.cpp:528] New master detected at master@67.195.138.8:38651
I0625 03:22:30.378860 3229 master.cpp:526] Elected as master!
I0625 03:22:30.378978 3227 status_update_manager.cpp:155] New master detected at master@67.195.138.8:38651
I0625 03:22:30.379142 3230 master.cpp:963] Attempting to re-register slave 201306250322-143311683-38651-3181-0 at slave(100)@67.195.138.8:38651 (minerva.apache.org)
I0625 03:22:30.379176 3230 master.cpp:1851] Adding slave 201306250322-143311683-38651-3181-0 at minerva.apache.org with cpus=2; mem=1024; ports=[31000-32000]; disk=20030
I0625 03:22:30.379307 3231 slave.cpp:624] Re-registered with master master@67.195.138.8:38651
I0625 03:22:30.379339 3230 master.hpp:291] Adding task 0 with resources cpus=1; mem=500 on slave 201306250322-143311683-38651-3181-0
W0625 03:22:30.379477 3230 master.cpp:1943] Possibly orphaned task 0 of framework 201306250322-143311683-38651-3181-0000 running on slave 201306250322-143311683-38651-3181-0 (minerva.apache.org)
I0625 03:22:30.379811 3231 hierarchical_allocator_process.hpp:449] Added slave 201306250322-143311683-38651-3181-0 (minerva.apache.org) with cpus=2; mem=1024; ports=[31000-32000]; disk=20030 (and cpus=1; mem=524; ports=[31000-32000]; disk=20030 available)
I0625 03:22:30.379892 3231 hierarchical_allocator_process.hpp:700] No users to allocate resources!
I0625 03:22:30.379976 3231 hierarchical_allocator_process.hpp:687] Performed allocation for slave 201306250322-143311683-38651-3181-0 in 83.75us
I0625 03:22:31.355250 3234 master.cpp:604] Re-registering framework 201306250322-143311683-38651-3181-0000 at scheduler(91)@67.195.138.8:38651
I0625 03:22:31.355597 3229 sched.cpp:246] Framework re-registered with 201306250322-143311683-38651-3181-0000
W0625 03:22:31.355679 3229 slave.cpp:1262] Ignoring updating pid for framework 201306250322-143311683-38651-3181-0000 because it is terminating
I0625 03:22:31.355736 3234 hierarchical_allocator_process.hpp:327] Added framework 201306250322-143311683-38651-3181-0000
I0625 03:22:31.355856 3234 hierarchical_allocator_process.hpp:727] Offering cpus=1; mem=524; ports=[31000-32000]; disk=20030 on slave 201306250322-143311683-38651-3181-0 to framework 201306250322-143311683-38651-3181-0000
I0625 03:22:31.356024 3234 hierarchical_allocator_process.hpp:667] Performed allocation for 1 slaves in 201.093us
I0625 03:22:31.356078 3229 master.hpp:313] Adding offer 201306250322-143311683-38651-3181-0 with resources cpus=1; mem=524; ports=[31000-32000]; disk=20030 on slave 201306250322-143311683-38651-3181-0
I0625 03:22:31.356163 3229 master.cpp:1239] Sending 1 offers to framework 201306250322-143311683-38651-3181-0000
I0625 03:22:31.356504 3234 sched.cpp:427] Stopping framework '201306250322-143311683-38651-3181-0000'
I0625 03:22:31.356523 3181 master.cpp:385] Master terminating
I0625 03:22:31.356669 3181 master.cpp:207] Shutting down master
I0625 03:22:31.356685 3235 slave.cpp:484] Slave asked to shut down by master@67.195.138.8:38651
I0625 03:22:31.356801 3235 slave.cpp:1101] Asked to shut down framework 201306250322-143311683-38651-3181-0000 by master@67.195.138.8:38651
I0625 03:22:31.356803 3181 master.hpp:303] Removing task 0 with resources cpus=1; mem=500 on slave 201306250322-143311683-38651-3181-0
W0625 03:22:31.356860 3235 slave.cpp:1122] Ignoring shutdown framework 201306250322-143311683-38651-3181-0000 because it is terminating
I0625 03:22:31.356978 3235 slave.cpp:1873] master@67.195.138.8:38651 exited
W0625 03:22:31.357110 3235 slave.cpp:1876] Master disconnected! Waiting for a new master to be elected
I0625 03:22:31.357084 3181 master.hpp:323] Removing offer 201306250322-143311683-38651-3181-0 with resources cpus=1; mem=524; ports=[31000-32000]; disk=20030 on slave 201306250322-143311683-38651-3181-0
I0625 03:22:31.356905 3230 hierarchical_allocator_process.hpp:412] Deactivated framework 201306250322-143311683-38651-3181-0000
I0625 03:22:31.357594 3230 hierarchical_allocator_process.hpp:616] Recovered cpus=1; mem=500 (total allocatable: cpus=1; mem=500; ports=[]; disk=0) on slave 201306250322-143311683-38651-3181-0 from framework 201306250322-143311683-38651-3181-0000
I0625 03:22:31.357720 3230 hierarchical_allocator_process.hpp:616] Recovered cpus=1; mem=524; ports=[31000-32000]; disk=20030 (total allocatable: cpus=2; mem=1024; ports=[31000-32000]; disk=20030) on slave 201306250322-143311683-38651-3181-0 from framework 201306250322-143311683-38651-3181-0000
I0625 03:22:31.357189 3235 slave.cpp:1101] Asked to shut down framework 201306250322-143311683-38651-3181-0000 by master@67.195.138.8:38651
I0625 03:22:31.359207 3233 detector.cpp:420] Master detector (slave(100)@67.195.138.8:38651) found 0 registered masters
W0625 03:22:31.365700 3235 slave.cpp:1122] Ignoring shutdown framework 201306250322-143311683-38651-3181-0000 because it is terminating
I0625 03:22:31.365845 3233 detector.cpp:441] Master detector (slave(100)@67.195.138.8:38651) couldn't find any masters
I0625 03:22:31.365957 3235 slave.cpp:439] Slave terminating
I0625 03:22:31.366111 3235 slave.cpp:1101] Asked to shut down framework 201306250322-143311683-38651-3181-0000 by @0.0.0.0:0
W0625 03:22:31.366178 3235 slave.cpp:1122] Ignoring shutdown framework 201306250322-143311683-38651-3181-0000 because it is terminating
[ OK ] AllocatorZooKeeperTest/0.SlaveReregistersFirst (2036 ms)
I0625 03:22:31.368284 3181 zookeeper_test_server.cpp:93] Shutdown ZooKeeperTestServer on port 50724
[----------] 2 tests from AllocatorZooKeeperTest/0 (4091 ms total)
[----------] Global test environment tear-down
[==========] 196 tests from 37 test cases ran. (71853 ms total)
[ PASSED ] 195 tests.
[ FAILED ] 1 test, listed below:
[ FAILED ] AllocatorTest/0.SchedulerFailover, where TypeParam = mesos::internal::master::allocator::HierarchicalAllocatorProcess<mesos::internal::master::allocator::DRFSorter, mesos::internal::master::allocator::DRFSorter>
1 FAILED TEST
make[3]: *** [check-local] 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
Jenkins build is back to normal :
Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Set-JAVA_HOME #1245
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Set-JAVA_HOME/1245/>