See <https://builds.apache.org/job/Mesos-Trunk-Ubuntu-Build-Out-Of-Src-Set-JAVA_HOME/1055/changes>
Changes: [vinod] Added a new 'statistics.json' endpoint to the ResourceMonitor, this ------------------------------------------ [...truncated 13971 lines...] I0608 00:03:01.709997 27504 exec.cpp:194] Executor registered on slave 201306080002-1015726915-38418-27298-0 I0608 00:03:01.710888 27504 exec.cpp:258] Executor asked to run task '0' I0608 00:03:01.712851 27504 exec.cpp:404] Executor sending status update TASK_RUNNING (UUID: 51e1c588-fe55-434d-b1b1-d08d1c6298ec) for task 0 of framework 201306080002-1015726915-38418-27298-0000 I0608 00:03:01.712924 27502 slave.cpp:1740] Handling status update TASK_RUNNING (UUID: 51e1c588-fe55-434d-b1b1-d08d1c6298ec) for task 0 of framework 201306080002-1015726915-38418-27298-0000 I0608 00:03:01.713325 27504 status_update_manager.cpp:290] Received status update TASK_RUNNING (UUID: 51e1c588-fe55-434d-b1b1-d08d1c6298ec) for task 0 of framework 201306080002-1015726915-38418-27298-0000 with checkpoint=false I0608 00:03:01.713707 27504 status_update_manager.cpp:450] Creating StatusUpdate stream for task 0 of framework 201306080002-1015726915-38418-27298-0000 I0608 00:03:01.714226 27504 status_update_manager.cpp:336] Forwarding status update TASK_RUNNING (UUID: 51e1c588-fe55-434d-b1b1-d08d1c6298ec) for task 0 of framework 201306080002-1015726915-38418-27298-0000 to [email protected]:38418 I0608 00:03:01.714763 27502 master.cpp:1022] Status update from slave(97)@67.195.138.60:38418: task 0 of framework 201306080002-1015726915-38418-27298-0000 is now in state TASK_RUNNING I0608 00:03:01.714766 27504 slave.cpp:1796] Status update manager successfully handled status update TASK_RUNNING (UUID: 51e1c588-fe55-434d-b1b1-d08d1c6298ec) for task 0 of framework 201306080002-1015726915-38418-27298-0000 I0608 00:03:01.715719 27509 sched.cpp:332] Received status update TASK_RUNNING (UUID: 51e1c588-fe55-434d-b1b1-d08d1c6298ec) for task 0 of framework 201306080002-1015726915-38418-27298-0000 from slave(97)@67.195.138.60:38418 I0608 00:03:01.717136 27504 slave.cpp:1802] Sending acknowledgement for status update TASK_RUNNING (UUID: 51e1c588-fe55-434d-b1b1-d08d1c6298ec) for task 0 of framework 201306080002-1015726915-38418-27298-0000 to executor(35)@67.195.138.60:38418 I0608 00:03:01.717761 27509 sched.cpp:365] Sending ACK for status update TASK_RUNNING (UUID: 51e1c588-fe55-434d-b1b1-d08d1c6298ec) for task 0 of framework 201306080002-1015726915-38418-27298-0000 to slave(97)@67.195.138.60:38418 I0608 00:03:01.718230 27507 exec.cpp:290] Executor received status update acknowledgement 51e1c588-fe55-434d-b1b1-d08d1c6298ec for task 0 of framework 201306080002-1015726915-38418-27298-0000 I0608 00:03:01.718322 27298 master.cpp:385] Master terminating I0608 00:03:01.731214 27504 status_update_manager.cpp:360] Received status update acknowledgement 51e1c588-fe55-434d-b1b1-d08d1c6298ec for task 0 of framework 201306080002-1015726915-38418-27298-0000 I0608 00:03:01.732141 27298 master.cpp:207] Shutting down master I0608 00:03:01.732208 27508 slave.cpp:1877] [email protected]:38418 exited I0608 00:03:01.733000 27507 hierarchical_allocator_process.hpp:412] Deactivated framework 201306080002-1015726915-38418-27298-0000 I0608 00:03:01.733021 27298 master.hpp:303] Removing task 0 with resources cpus=1; mem=500 on slave 201306080002-1015726915-38418-27298-0 W0608 00:03:01.733703 27508 slave.cpp:1880] Master disconnected! Waiting for a new master to be elected I0608 00:03:01.734858 27502 hierarchical_allocator_process.hpp:616] Recovered cpus=1; mem=500 (total allocatable: cpus=2; mem=1024; ports=[31000-32000]; disk=20689) on slave 201306080002-1015726915-38418-27298-0 from framework 201306080002-1015726915-38418-27298-0000 I0608 00:03:01.735154 27508 slave.cpp:1341] Status update manager successfully handled status update acknowledgement 51e1c588-fe55-434d-b1b1-d08d1c6298ec for task 0 of framework 201306080002-1015726915-38418-27298-0000 I0608 00:03:01.736152 27508 slave.cpp:1110] Asked to shut down framework 201306080002-1015726915-38418-27298-0000 by [email protected]:38418 I0608 00:03:01.736654 27508 slave.cpp:1135] Shutting down framework 201306080002-1015726915-38418-27298-0000 I0608 00:03:01.736776 27506 master.cpp:228] Master started on 67.195.138.60:38418 I0608 00:03:01.737916 27508 slave.cpp:2312] Shutting down executor 'default' of framework 201306080002-1015726915-38418-27298-0000 I0608 00:03:01.743073 27506 master.cpp:243] Master ID: 201306080003-1015726915-38418-27298 I0608 00:03:01.743562 27507 exec.cpp:323] Executor asked to shutdown W0608 00:03:01.744184 27502 master.cpp:83] No whitelist given. Advertising offers for all slaves I0608 00:03:01.744308 27506 hierarchical_allocator_process.hpp:295] Initializing hierarchical allocator process with master : [email protected]:38418 I0608 00:03:01.941098 27503 detector.cpp:234] Master detector ([email protected]:38418) connected to ZooKeeper ... I0608 00:03:01.941200 27503 detector.cpp:251] Trying to create path '/znode' in ZooKeeper I0608 00:03:01.941346 27508 detector.cpp:420] Master detector (scheduler(88)@67.195.138.60:38418) found 0 registered masters I0608 00:03:01.941545 27507 detector.cpp:420] Master detector (slave(97)@67.195.138.60:38418) found 0 registered masters I0608 00:03:01.947983 27507 detector.cpp:441] Master detector (slave(97)@67.195.138.60:38418) couldn't find any masters I0608 00:03:01.948557 27507 slave.cpp:571] Lost master(s) ... waiting I0608 00:03:01.947499 27508 detector.cpp:441] Master detector (scheduler(88)@67.195.138.60:38418) couldn't find any masters I0608 00:03:02.051586 27508 sched.cpp:194] No master detected, waiting for another master I0608 00:03:02.236891 27503 detector.cpp:281] Created ephemeral/sequence znode at '/znode/0000000002' I0608 00:03:02.237560 27507 detector.cpp:420] Master detector (slave(97)@67.195.138.60:38418) found 1 registered masters I0608 00:03:02.237680 27504 detector.cpp:420] Master detector (scheduler(88)@67.195.138.60:38418) found 1 registered masters I0608 00:03:02.237822 27503 detector.cpp:420] Master detector ([email protected]:38418) found 1 registered masters I0608 00:03:02.277456 27507 detector.cpp:467] Master detector (slave(97)@67.195.138.60:38418) got new master pid: [email protected]:38418 I0608 00:03:02.278729 27503 detector.cpp:467] Master detector ([email protected]:38418) got new master pid: [email protected]:38418 I0608 00:03:02.279213 27503 master.cpp:526] Elected as master! I0608 00:03:02.278378 27504 detector.cpp:467] Master detector (scheduler(88)@67.195.138.60:38418) got new master pid: [email protected]:38418 I0608 00:03:02.280163 27504 sched.cpp:177] New master at [email protected]:38418 I0608 00:03:02.278797 27507 slave.cpp:537] New master detected at [email protected]:38418 I0608 00:03:02.280647 27506 master.cpp:604] Re-registering framework 201306080002-1015726915-38418-27298-0000 at scheduler(88)@67.195.138.60:38418 I0608 00:03:02.281086 27509 status_update_manager.cpp:155] New master detected at [email protected]:38418 I0608 00:03:02.281677 27504 sched.cpp:246] Framework re-registered with 201306080002-1015726915-38418-27298-0000 I0608 00:03:02.281795 27502 hierarchical_allocator_process.hpp:327] Added framework 201306080002-1015726915-38418-27298-0000 I0608 00:03:02.407138 27502 hierarchical_allocator_process.hpp:705] No resources available to allocate! I0608 00:03:02.407498 27502 hierarchical_allocator_process.hpp:667] Performed allocation for 0 slaves in 375.978us I0608 00:03:02.490393 27505 master.cpp:963] Attempting to re-register slave 201306080002-1015726915-38418-27298-0 at slave(97)@67.195.138.60:38418 (janus.apache.org) I0608 00:03:02.490485 27505 master.cpp:1851] Adding slave 201306080002-1015726915-38418-27298-0 at janus.apache.org with cpus=2; mem=1024; ports=[31000-32000]; disk=20689 I0608 00:03:02.524056 27508 slave.cpp:633] Re-registered with master [email protected]:38418 I0608 00:03:02.524118 27505 master.hpp:291] Adding task 0 with resources cpus=1; mem=500 on slave 201306080002-1015726915-38418-27298-0 W0608 00:03:02.713510 27505 slave.cpp:1271] Ignoring updating pid for framework 201306080002-1015726915-38418-27298-0000 because it is terminating I0608 00:03:02.713646 27508 hierarchical_allocator_process.hpp:449] Added slave 201306080002-1015726915-38418-27298-0 (janus.apache.org) with cpus=2; mem=1024; ports=[31000-32000]; disk=20689 (and cpus=1; mem=524; ports=[31000-32000]; disk=20689 available) I0608 00:03:02.714148 27508 hierarchical_allocator_process.hpp:727] Offering cpus=1; mem=524; ports=[31000-32000]; disk=20689 on slave 201306080002-1015726915-38418-27298-0 to framework 201306080002-1015726915-38418-27298-0000 I0608 00:03:02.714736 27508 hierarchical_allocator_process.hpp:687] Performed allocation for slave 201306080002-1015726915-38418-27298-0 in 602.232us I0608 00:03:02.714897 27506 master.hpp:313] Adding offer 201306080003-1015726915-38418-27298-0 with resources cpus=1; mem=524; ports=[31000-32000]; disk=20689 on slave 201306080002-1015726915-38418-27298-0 I0608 00:03:02.734005 27506 master.cpp:1239] Sending 1 offers to framework 201306080002-1015726915-38418-27298-0000 I0608 00:03:02.734534 27507 sched.cpp:287] Received 1 offers I0608 00:03:02.735398 27507 sched.cpp:427] Stopping framework '201306080002-1015726915-38418-27298-0000' I0608 00:03:02.735406 27298 master.cpp:385] Master terminating I0608 00:03:02.735952 27508 slave.cpp:493] Slave asked to shut down by [email protected]:38418 I0608 00:03:02.735962 27298 master.cpp:207] Shutting down master I0608 00:03:02.737854 27505 hierarchical_allocator_process.hpp:412] Deactivated framework 201306080002-1015726915-38418-27298-0000 I0608 00:03:02.737851 27298 master.hpp:303] Removing task 0 with resources cpus=1; mem=500 on slave 201306080002-1015726915-38418-27298-0 I0608 00:03:02.737097 27508 slave.cpp:1110] Asked to shut down framework 201306080002-1015726915-38418-27298-0000 by [email protected]:38418 W0608 00:03:02.759508 27508 slave.cpp:1131] Ignoring shutdown framework 201306080002-1015726915-38418-27298-0000 because it is terminating I0608 00:03:02.759281 27506 hierarchical_allocator_process.hpp:616] Recovered cpus=1; mem=500 (total allocatable: cpus=1; mem=500; ports=[]; disk=0) on slave 201306080002-1015726915-38418-27298-0 from framework 201306080002-1015726915-38418-27298-0000 I0608 00:03:02.819244 27506 hierarchical_allocator_process.hpp:616] Recovered cpus=1; mem=524; ports=[31000-32000]; disk=20689 (total allocatable: cpus=2; mem=1024; ports=[31000-32000]; disk=20689) on slave 201306080002-1015726915-38418-27298-0 from framework 201306080002-1015726915-38418-27298-0000 I0608 00:03:02.771090 27508 slave.cpp:1877] [email protected]:38418 exited W0608 00:03:02.820026 27508 slave.cpp:1880] Master disconnected! Waiting for a new master to be elected I0608 00:03:02.820505 27508 slave.cpp:1110] Asked to shut down framework 201306080002-1015726915-38418-27298-0000 by [email protected]:38418 W0608 00:03:02.820998 27508 slave.cpp:1131] Ignoring shutdown framework 201306080002-1015726915-38418-27298-0000 because it is terminating I0608 00:03:02.819553 27506 hierarchical_allocator_process.hpp:667] Performed allocation for 1 slaves in 15.75us I0608 00:03:02.759197 27298 master.hpp:323] Removing offer 201306080003-1015726915-38418-27298-0 with resources cpus=1; mem=524; ports=[31000-32000]; disk=20689 on slave 201306080002-1015726915-38418-27298-0 I0608 00:03:02.891270 27509 hierarchical_allocator_process.hpp:367] Removed framework 201306080002-1015726915-38418-27298-0000 I0608 00:03:02.891443 27509 hierarchical_allocator_process.hpp:477] Removed slave 201306080002-1015726915-38418-27298-0 I0608 00:03:02.891732 27507 slave.cpp:448] Slave terminating I0608 00:03:02.892343 27507 slave.cpp:1110] Asked to shut down framework 201306080002-1015726915-38418-27298-0000 by @0.0.0.0:0 W0608 00:03:02.892897 27507 slave.cpp:1131] Ignoring shutdown framework 201306080002-1015726915-38418-27298-0000 because it is terminating [ OK ] AllocatorZooKeeperTest/0.FrameworkReregistersFirst (2899 ms) [ RUN ] AllocatorZooKeeperTest/0.SlaveReregistersFirst I0608 00:03:02.894899 27506 master.cpp:228] Master started on 67.195.138.60:38418 I0608 00:03:02.894979 27506 master.cpp:243] Master ID: 201306080003-1015726915-38418-27298 I0608 00:03:02.895391 27507 hierarchical_allocator_process.hpp:295] Initializing hierarchical allocator process with master : [email protected]:38418 W0608 00:03:02.895421 27505 master.cpp:83] No whitelist given. Advertising offers for all slaves I0608 00:03:02.947440 27503 slave.cpp:216] Slave started on 98)@67.195.138.60:38418 I0608 00:03:03.011751 27504 detector.cpp:234] Master detector ([email protected]:38418) connected to ZooKeeper ... I0608 00:03:03.027788 27504 detector.cpp:251] Trying to create path '/znode' in ZooKeeper I0608 00:03:03.027356 27503 slave.cpp:217] Slave resources: cpus=2; mem=1024; ports=[31000-32000]; disk=20689 I0608 00:03:03.029537 27508 slave.cpp:398] Finished recovery I0608 00:03:03.102347 27502 detector.cpp:234] Master detector (scheduler(89)@67.195.138.60:38418) connected to ZooKeeper ... I0608 00:03:03.102481 27502 detector.cpp:251] Trying to create path '/znode' in ZooKeeper I0608 00:03:03.103034 27505 detector.cpp:234] Master detector (slave(98)@67.195.138.60:38418) connected to ZooKeeper ... I0608 00:03:03.235477 27505 detector.cpp:251] Trying to create path '/znode' in ZooKeeper I0608 00:03:03.258492 27504 detector.cpp:281] Created ephemeral/sequence znode at '/znode/0000000004' I0608 00:03:03.259282 27502 detector.cpp:420] Master detector (scheduler(89)@67.195.138.60:38418) found 1 registered masters I0608 00:03:03.259546 27504 detector.cpp:420] Master detector ([email protected]:38418) found 1 registered masters I0608 00:03:03.259579 27505 detector.cpp:420] Master detector (slave(98)@67.195.138.60:38418) found 1 registered masters I0608 00:03:03.260649 27504 detector.cpp:467] Master detector ([email protected]:38418) got new master pid: [email protected]:38418 I0608 00:03:03.261160 27504 master.cpp:526] Elected as master! I0608 00:03:03.261212 27505 detector.cpp:467] Master detector (slave(98)@67.195.138.60:38418) got new master pid: [email protected]:38418 I0608 00:03:03.262070 27505 slave.cpp:537] New master detected at [email protected]:38418 I0608 00:03:03.262553 27503 status_update_manager.cpp:155] New master detected at [email protected]:38418 I0608 00:03:03.259873 27502 detector.cpp:467] Master detector (scheduler(89)@67.195.138.60:38418) got new master pid: [email protected]:38418 I0608 00:03:03.262611 27508 master.cpp:891] Attempting to register slave on janus.apache.org at slave(98)@67.195.138.60:38418 I0608 00:03:03.263919 27508 master.cpp:1851] Adding slave 201306080003-1015726915-38418-27298-0 at janus.apache.org with cpus=2; mem=1024; ports=[31000-32000]; disk=20689 I0608 00:03:03.264411 27505 slave.cpp:597] Registered with master [email protected]:38418; given slave ID 201306080003-1015726915-38418-27298-0 I0608 00:03:03.263485 27502 sched.cpp:177] New master at [email protected]:38418 I0608 00:03:03.264508 27506 hierarchical_allocator_process.hpp:449] Added slave 201306080003-1015726915-38418-27298-0 (janus.apache.org) with cpus=2; mem=1024; ports=[31000-32000]; disk=20689 (and cpus=2; mem=1024; ports=[31000-32000]; disk=20689 available) I0608 00:03:03.265830 27506 hierarchical_allocator_process.hpp:700] No users to allocate resources! I0608 00:03:03.266273 27506 hierarchical_allocator_process.hpp:687] Performed allocation for slave 201306080003-1015726915-38418-27298-0 in 450.498us I0608 00:03:03.265424 27505 master.cpp:569] Registering framework 201306080003-1015726915-38418-27298-0000 at scheduler(89)@67.195.138.60:38418 I0608 00:03:03.267266 27502 sched.cpp:222] Framework registered with 201306080003-1015726915-38418-27298-0000 I0608 00:03:03.267277 27505 hierarchical_allocator_process.hpp:327] Added framework 201306080003-1015726915-38418-27298-0000 I0608 00:03:03.268941 27505 hierarchical_allocator_process.hpp:727] Offering cpus=2; mem=1024; ports=[31000-32000]; disk=20689 on slave 201306080003-1015726915-38418-27298-0 to framework 201306080003-1015726915-38418-27298-0000 I0608 00:03:03.269458 27505 hierarchical_allocator_process.hpp:667] Performed allocation for 1 slaves in 533.333us I0608 00:03:03.269526 27509 master.hpp:313] Adding offer 201306080003-1015726915-38418-27298-0 with resources cpus=2; mem=1024; ports=[31000-32000]; disk=20689 on slave 201306080003-1015726915-38418-27298-0 I0608 00:03:03.270395 27509 master.cpp:1239] Sending 1 offers to framework 201306080003-1015726915-38418-27298-0000 I0608 00:03:03.270875 27508 sched.cpp:287] Received 1 offers I0608 00:03:03.271471 27509 master.cpp:1472] Processing reply for offer 201306080003-1015726915-38418-27298-0 on slave 201306080003-1015726915-38418-27298-0 (janus.apache.org) for framework 201306080003-1015726915-38418-27298-0000 I0608 00:03:03.271875 27509 master.hpp:291] Adding task 0 with resources cpus=1; mem=500 on slave 201306080003-1015726915-38418-27298-0 I0608 00:03:03.272310 27509 master.cpp:1591] Launching task 0 of framework 201306080003-1015726915-38418-27298-0000 with resources cpus=1; mem=500 on slave 201306080003-1015726915-38418-27298-0 (janus.apache.org) I0608 00:03:03.272824 27508 slave.cpp:737] Got assigned task 0 for framework 201306080003-1015726915-38418-27298-0000 I0608 00:03:03.273447 27508 slave.cpp:835] Launching task 0 for framework 201306080003-1015726915-38418-27298-0000 I0608 00:03:03.272933 27503 hierarchical_allocator_process.hpp:526] Framework 201306080003-1015726915-38418-27298-0000 left cpus=1; mem=524; ports=[31000-32000]; disk=20689 unused on slave 201306080003-1015726915-38418-27298-0 I0608 00:03:03.274409 27503 hierarchical_allocator_process.hpp:569] Framework 201306080003-1015726915-38418-27298-0000 filtered slave 201306080003-1015726915-38418-27298-0 for 5secs I0608 00:03:03.272873 27509 master.hpp:323] Removing offer 201306080003-1015726915-38418-27298-0 with resources cpus=2; mem=1024; ports=[31000-32000]; disk=20689 on slave 201306080003-1015726915-38418-27298-0 I0608 00:03:03.275236 27508 paths.hpp:303] Created executor directory '/tmp/AllocatorZooKeeperTest_0_SlaveReregistersFirst_nJJarR/slaves/201306080003-1015726915-38418-27298-0/frameworks/201306080003-1015726915-38418-27298-0000/executors/default/runs/cff1db3b-1e1f-47f7-87dd-5983f0c9e00a' I0608 00:03:03.276643 27508 slave.cpp:946] Queuing task '0' for executor default of framework '201306080003-1015726915-38418-27298-0000 I0608 00:03:03.276999 27508 slave.cpp:519] Successfully attached file '/tmp/AllocatorZooKeeperTest_0_SlaveReregistersFirst_nJJarR/slaves/201306080003-1015726915-38418-27298-0/frameworks/201306080003-1015726915-38418-27298-0000/executors/default/runs/cff1db3b-1e1f-47f7-87dd-5983f0c9e00a' I0608 00:03:03.276823 27506 exec.cpp:170] Executor started at: executor(36)@67.195.138.60:38418 with pid 27298 I0608 00:03:03.277958 27506 slave.cpp:1393] Got registration for executor 'default' of framework 201306080003-1015726915-38418-27298-0000 I0608 00:03:03.291708 27506 slave.cpp:1508] Flushing queued task 0 for executor 'default' of framework 201306080003-1015726915-38418-27298-0000 I0608 00:03:03.291740 27503 exec.cpp:194] Executor registered on slave 201306080003-1015726915-38418-27298-0 I0608 00:03:03.292603 27503 exec.cpp:258] Executor asked to run task '0' I0608 00:03:03.294296 27503 exec.cpp:404] Executor sending status update TASK_RUNNING (UUID: 6f8aa40f-939b-46eb-833b-ba89167cd25f) for task 0 of framework 201306080003-1015726915-38418-27298-0000 I0608 00:03:03.294358 27503 slave.cpp:1740] Handling status update TASK_RUNNING (UUID: 6f8aa40f-939b-46eb-833b-ba89167cd25f) for task 0 of framework 201306080003-1015726915-38418-27298-0000 I0608 00:03:03.294751 27503 status_update_manager.cpp:290] Received status update TASK_RUNNING (UUID: 6f8aa40f-939b-46eb-833b-ba89167cd25f) for task 0 of framework 201306080003-1015726915-38418-27298-0000 with checkpoint=false I0608 00:03:03.295148 27503 status_update_manager.cpp:450] Creating StatusUpdate stream for task 0 of framework 201306080003-1015726915-38418-27298-0000 I0608 00:03:03.295673 27503 status_update_manager.cpp:336] Forwarding status update TASK_RUNNING (UUID: 6f8aa40f-939b-46eb-833b-ba89167cd25f) for task 0 of framework 201306080003-1015726915-38418-27298-0000 to [email protected]:38418 I0608 00:03:03.296180 27508 master.cpp:1022] Status update from slave(98)@67.195.138.60:38418: task 0 of framework 201306080003-1015726915-38418-27298-0000 is now in state TASK_RUNNING I0608 00:03:03.296653 27508 sched.cpp:332] Received status update TASK_RUNNING (UUID: 6f8aa40f-939b-46eb-833b-ba89167cd25f) for task 0 of framework 201306080003-1015726915-38418-27298-0000 from slave(98)@67.195.138.60:38418 I0608 00:03:03.296233 27503 slave.cpp:1796] Status update manager successfully handled status update TASK_RUNNING (UUID: 6f8aa40f-939b-46eb-833b-ba89167cd25f) for task 0 of framework 201306080003-1015726915-38418-27298-0000 I0608 00:03:03.297545 27503 slave.cpp:1802] Sending acknowledgement for status update TASK_RUNNING (UUID: 6f8aa40f-939b-46eb-833b-ba89167cd25f) for task 0 of framework 201306080003-1015726915-38418-27298-0000 to executor(36)@67.195.138.60:38418 I0608 00:03:03.297150 27508 sched.cpp:365] Sending ACK for status update TASK_RUNNING (UUID: 6f8aa40f-939b-46eb-833b-ba89167cd25f) for task 0 of framework 201306080003-1015726915-38418-27298-0000 to slave(98)@67.195.138.60:38418 I0608 00:03:03.297550 27298 master.cpp:385] Master terminating I0608 00:03:03.298069 27505 exec.cpp:290] Executor received status update acknowledgement 6f8aa40f-939b-46eb-833b-ba89167cd25f for task 0 of framework 201306080003-1015726915-38418-27298-0000 I0608 00:03:03.298655 27508 status_update_manager.cpp:360] Received status update acknowledgement 6f8aa40f-939b-46eb-833b-ba89167cd25f for task 0 of framework 201306080003-1015726915-38418-27298-0000 I0608 00:03:03.308362 27298 master.cpp:207] Shutting down master I0608 00:03:03.308476 27507 slave.cpp:1877] [email protected]:38418 exited W0608 00:03:03.310652 27507 slave.cpp:1880] Master disconnected! Waiting for a new master to be elected I0608 00:03:03.311132 27507 slave.cpp:1341] Status update manager successfully handled status update acknowledgement 6f8aa40f-939b-46eb-833b-ba89167cd25f for task 0 of framework 201306080003-1015726915-38418-27298-0000 I0608 00:03:03.311631 27507 slave.cpp:1110] Asked to shut down framework 201306080003-1015726915-38418-27298-0000 by [email protected]:38418 I0608 00:03:03.312093 27507 slave.cpp:1135] Shutting down framework 201306080003-1015726915-38418-27298-0000 I0608 00:03:03.312584 27507 slave.cpp:2312] Shutting down executor 'default' of framework 201306080003-1015726915-38418-27298-0000 I0608 00:03:03.310233 27298 master.hpp:303] Removing task 0 with resources cpus=1; mem=500 on slave 201306080003-1015726915-38418-27298-0 I0608 00:03:03.310214 27508 hierarchical_allocator_process.hpp:412] Deactivated framework 201306080003-1015726915-38418-27298-0000 I0608 00:03:03.316735 27504 exec.cpp:323] Executor asked to shutdown I0608 00:03:03.319079 27503 master.cpp:228] Master started on 67.195.138.60:38418 I0608 00:03:03.319356 27503 master.cpp:243] Master ID: 201306080003-1015726915-38418-27298 W0608 00:03:03.320034 27504 master.cpp:83] No whitelist given. Advertising offers for all slaves I0608 00:03:03.320179 27502 hierarchical_allocator_process.hpp:295] Initializing hierarchical allocator process with master : [email protected]:38418 I0608 00:03:03.433267 27503 detector.cpp:234] Master detector ([email protected]:38418) connected to ZooKeeper ... I0608 00:03:03.433379 27503 detector.cpp:251] Trying to create path '/znode' in ZooKeeper I0608 00:03:03.433581 27508 detector.cpp:420] Master detector (slave(98)@67.195.138.60:38418) found 0 registered masters I0608 00:03:03.449795 27508 detector.cpp:441] Master detector (slave(98)@67.195.138.60:38418) couldn't find any masters I0608 00:03:03.450305 27508 slave.cpp:571] Lost master(s) ... waiting I0608 00:03:03.433702 27507 detector.cpp:420] Master detector (scheduler(89)@67.195.138.60:38418) found 0 registered masters I0608 00:03:03.512802 27507 detector.cpp:441] Master detector (scheduler(89)@67.195.138.60:38418) couldn't find any masters I0608 00:03:03.477186 27502 detector.cpp:420] Master detector (slave(98)@67.195.138.60:38418) found 1 registered masters I0608 00:03:03.476714 27503 detector.cpp:281] Created ephemeral/sequence znode at '/znode/0000000006' I0608 00:03:03.548115 27508 sched.cpp:194] No master detected, waiting for another master I0608 00:03:03.548959 27507 detector.cpp:420] Master detector (scheduler(89)@67.195.138.60:38418) found 1 registered masters I0608 00:03:03.567216 27502 detector.cpp:467] Master detector (slave(98)@67.195.138.60:38418) got new master pid: [email protected]:38418 I0608 00:03:03.567524 27503 detector.cpp:420] Master detector ([email protected]:38418) found 1 registered masters I0608 00:03:03.568542 27502 slave.cpp:537] New master detected at [email protected]:38418 I0608 00:03:03.568590 27507 detector.cpp:467] Master detector (scheduler(89)@67.195.138.60:38418) got new master pid: [email protected]:38418 I0608 00:03:03.569442 27504 status_update_manager.cpp:155] New master detected at [email protected]:38418 I0608 00:03:03.569543 27503 detector.cpp:467] Master detector ([email protected]:38418) got new master pid: [email protected]:38418 W0608 00:03:03.569589 27506 master.cpp:918] Ignoring re-register slave message from janus.apache.org since not elected yet I0608 00:03:03.569952 27507 sched.cpp:177] New master at [email protected]:38418 I0608 00:03:03.575427 27506 master.cpp:526] Elected as master! I0608 00:03:04.263591 27505 master.cpp:963] Attempting to re-register slave 201306080003-1015726915-38418-27298-0 at slave(98)@67.195.138.60:38418 (janus.apache.org) I0608 00:03:04.263720 27505 master.cpp:1851] Adding slave 201306080003-1015726915-38418-27298-0 at janus.apache.org with cpus=2; mem=1024; ports=[31000-32000]; disk=20689 I0608 00:03:04.327236 27502 slave.cpp:633] Re-registered with master [email protected]:38418 I0608 00:03:04.327268 27505 master.hpp:291] Adding task 0 with resources cpus=1; mem=500 on slave 201306080003-1015726915-38418-27298-0 W0608 00:03:04.327960 27505 master.cpp:1943] Possibly orphaned task 0 of framework 201306080003-1015726915-38418-27298-0000 running on slave 201306080003-1015726915-38418-27298-0 (janus.apache.org) I0608 00:03:04.328721 27502 hierarchical_allocator_process.hpp:449] Added slave 201306080003-1015726915-38418-27298-0 (janus.apache.org) with cpus=2; mem=1024; ports=[31000-32000]; disk=20689 (and cpus=1; mem=524; ports=[31000-32000]; disk=20689 available) I0608 00:03:04.328928 27502 hierarchical_allocator_process.hpp:700] No users to allocate resources! I0608 00:03:04.329375 27502 hierarchical_allocator_process.hpp:687] Performed allocation for slave 201306080003-1015726915-38418-27298-0 in 447.435us I0608 00:03:04.330559 27506 hierarchical_allocator_process.hpp:700] No users to allocate resources! I0608 00:03:04.330624 27506 hierarchical_allocator_process.hpp:667] Performed allocation for 1 slaves in 82.148us I0608 00:03:04.577111 27503 master.cpp:604] Re-registering framework 201306080003-1015726915-38418-27298-0000 at scheduler(89)@67.195.138.60:38418 I0608 00:03:04.577419 27509 sched.cpp:246] Framework re-registered with 201306080003-1015726915-38418-27298-0000 W0608 00:03:04.577466 27503 slave.cpp:1271] Ignoring updating pid for framework 201306080003-1015726915-38418-27298-0000 because it is terminating I0608 00:03:04.577520 27507 hierarchical_allocator_process.hpp:327] Added framework 201306080003-1015726915-38418-27298-0000 I0608 00:03:04.584053 27507 hierarchical_allocator_process.hpp:727] Offering cpus=1; mem=524; ports=[31000-32000]; disk=20689 on slave 201306080003-1015726915-38418-27298-0 to framework 201306080003-1015726915-38418-27298-0000 I0608 00:03:04.584601 27507 hierarchical_allocator_process.hpp:667] Performed allocation for 1 slaves in 575.034us I0608 00:03:04.584698 27502 master.hpp:313] Adding offer 201306080003-1015726915-38418-27298-0 with resources cpus=1; mem=524; ports=[31000-32000]; disk=20689 on slave 201306080003-1015726915-38418-27298-0 I0608 00:03:04.586539 27502 master.cpp:1239] Sending 1 offers to framework 201306080003-1015726915-38418-27298-0000 I0608 00:03:04.587071 27506 sched.cpp:287] Received 1 offers I0608 00:03:04.587836 27502 sched.cpp:427] Stopping framework '201306080003-1015726915-38418-27298-0000' I0608 00:03:04.587882 27505 master.cpp:385] Master terminating I0608 00:03:04.588584 27506 slave.cpp:493] Slave asked to shut down by [email protected]:38418 I0608 00:03:04.588616 27298 master.cpp:207] Shutting down master I0608 00:03:04.589067 27506 slave.cpp:1110] Asked to shut down framework 201306080003-1015726915-38418-27298-0000 by [email protected]:38418 W0608 00:03:04.662782 27506 slave.cpp:1131] Ignoring shutdown framework 201306080003-1015726915-38418-27298-0000 because it is terminating I0608 00:03:04.662551 27505 hierarchical_allocator_process.hpp:412] Deactivated framework 201306080003-1015726915-38418-27298-0000 I0608 00:03:04.662464 27298 master.hpp:303] Removing task 0 with resources cpus=1; mem=500 on slave 201306080003-1015726915-38418-27298-0 I0608 00:03:04.663244 27506 slave.cpp:1877] [email protected]:38418 exited I0608 00:03:04.664295 27298 master.hpp:323] Removing offer 201306080003-1015726915-38418-27298-0 with resources cpus=1; mem=524; ports=[31000-32000]; disk=20689 on slave 201306080003-1015726915-38418-27298-0 I0608 00:03:04.664358 27508 hierarchical_allocator_process.hpp:616] Recovered cpus=1; mem=500 (total allocatable: cpus=1; mem=500; ports=[]; disk=0) on slave 201306080003-1015726915-38418-27298-0 from framework 201306080003-1015726915-38418-27298-0000 W0608 00:03:04.664675 27506 slave.cpp:1880] Master disconnected! Waiting for a new master to be elected I0608 00:03:04.691684 27508 hierarchical_allocator_process.hpp:616] Recovered cpus=1; mem=524; ports=[31000-32000]; disk=20689 (total allocatable: cpus=2; mem=1024; ports=[31000-32000]; disk=20689) on slave 201306080003-1015726915-38418-27298-0 from framework 201306080003-1015726915-38418-27298-0000 I0608 00:03:04.692462 27506 slave.cpp:448] Slave terminating I0608 00:03:04.699514 27506 slave.cpp:1110] Asked to shut down framework 201306080003-1015726915-38418-27298-0000 by @0.0.0.0:0 W0608 00:03:04.699983 27506 slave.cpp:1131] Ignoring shutdown framework 201306080003-1015726915-38418-27298-0000 because it is terminating I0608 00:03:04.699116 27508 hierarchical_allocator_process.hpp:367] Removed framework 201306080003-1015726915-38418-27298-0000 I0608 00:03:04.724853 27508 hierarchical_allocator_process.hpp:477] Removed slave 201306080003-1015726915-38418-27298-0 [ OK ] AllocatorZooKeeperTest/0.SlaveReregistersFirst (1831 ms) I0608 00:03:04.881582 27298 zookeeper_test_server.cpp:93] Shutdown ZooKeeperTestServer on port 51933 [----------] 2 tests from AllocatorZooKeeperTest/0 (4730 ms total) [----------] Global test environment tear-down [==========] 193 tests from 38 test cases ran. (219933 ms total) [ PASSED ] 192 tests. [ FAILED ] 1 test, listed below: [ FAILED ] CoordinatorTest.TruncateNotLearnedFill 1 FAILED TEST 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
