Aha. Thanks Ian. @vinodkone
> On Nov 5, 2014, at 9:00 PM, Ian Downes <[email protected]> wrote: > > Appears this was from that commit which introduced glog into the fetcher and > changed some expected output to include the initial glog message: > > Value of: (os::read(path::join(directory, "stderr"))).get() > Actual: "I1106 02:30:53.472061 21707 logging.cpp:177] Logging to > STDERR\nthis is stderr\n" > Expected: errMsg + "\n" > Which is: "this is stderr\n" > > I'll file a ticket in the morning. > > Ian > > > >> On Wed, Nov 5, 2014 at 8:48 PM, Vinod Kone <[email protected]> wrote: >> @ian: can you triage this? >> >>> On Wed, Nov 5, 2014 at 6:37 PM, Apache Jenkins Server >>> <[email protected]> wrote: >>> See >>> <https://builds.apache.org/job/Mesos-Trunk-Ubuntu-Build-In-Src-Set-JAVA_HOME/2254/changes> >>> >>> Changes: >>> >>> [vinodkone] Fetcher uses Hadoop to fetch URIs with unknown schemes. >>> >>> ------------------------------------------ >>> [...truncated 70150 lines...] >>> I1106 02:35:19.677485 21521 master.cpp:1337] Authorizing framework >>> principal 'test-principal' to receive offers for role '*' >>> I1106 02:35:19.678004 21530 master.cpp:1442] Registering framework >>> 20141106-023518-3125920579-59951-21504-0000 (default) at >>> [email protected]:59951 >>> I1106 02:35:19.678170 21526 group.cpp:717] Found non-sequence node >>> 'log_replicas' at '/znode' in ZooKeeper >>> I1106 02:35:19.678387 21520 hierarchical_allocator_process.hpp:329] Added >>> framework 20141106-023518-3125920579-59951-21504-0000 >>> I1106 02:35:19.678413 21533 detector.cpp:138] Detected a new leader: >>> (id='1') >>> I1106 02:35:19.678422 21520 hierarchical_allocator_process.hpp:697] No >>> resources available to allocate! >>> I1106 02:35:19.678447 21520 hierarchical_allocator_process.hpp:659] >>> Performed allocation for 0 slaves in 24461ns >>> I1106 02:35:19.678532 21531 sched.cpp:407] Framework registered with >>> 20141106-023518-3125920579-59951-21504-0000 >>> I1106 02:35:19.678622 21531 sched.cpp:421] Scheduler::registered took >>> 56953ns >>> I1106 02:35:19.678834 21523 group.cpp:659] Trying to get >>> '/znode/info_0000000001' in ZooKeeper >>> I1106 02:35:19.680326 21528 detector.cpp:433] A new leading master >>> ([email protected]:59951) is detected >>> I1106 02:35:19.680634 21531 status_update_manager.cpp:171] Pausing sending >>> status updates >>> I1106 02:35:19.680631 21526 slave.cpp:602] New master detected at >>> [email protected]:59951 >>> I1106 02:35:19.680694 21526 slave.cpp:665] Authenticating with master >>> [email protected]:59951 >>> I1106 02:35:19.680857 21526 slave.cpp:638] Detecting new master >>> I1106 02:35:19.680910 21529 authenticatee.hpp:133] Creating new client SASL >>> connection >>> I1106 02:35:19.681162 21529 master.cpp:3896] Authenticating >>> slave(223)@67.195.81.186:59951 >>> I1106 02:35:19.681206 21529 master.cpp:3907] Using default CRAM-MD5 >>> authenticator >>> I1106 02:35:19.681447 21533 authenticator.hpp:169] Creating new server SASL >>> connection >>> I1106 02:35:19.681614 21533 authenticatee.hpp:224] Received SASL >>> authentication mechanisms: CRAM-MD5 >>> I1106 02:35:19.681641 21533 authenticatee.hpp:250] Attempting to >>> authenticate with mechanism 'CRAM-MD5' >>> I1106 02:35:19.681825 21525 authenticator.hpp:275] Received SASL >>> authentication start >>> I1106 02:35:19.681977 21525 authenticator.hpp:397] Authentication requires >>> more steps >>> I1106 02:35:19.682062 21525 authenticatee.hpp:270] Received SASL >>> authentication step >>> I1106 02:35:19.682153 21525 authenticator.hpp:303] Received SASL >>> authentication step >>> I1106 02:35:19.682185 21525 auxprop.cpp:99] Request to lookup properties >>> for user: 'test-principal' realm: 'penates.apache.org' server FQDN: >>> 'penates.apache.org' SASL_AUXPROP_VERIFY_AGAINST_HASH: false >>> SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false >>> I1106 02:35:19.682199 21525 auxprop.cpp:171] Looking up auxiliary property >>> '*userPassword' >>> I1106 02:35:19.682230 21525 auxprop.cpp:171] Looking up auxiliary property >>> '*cmusaslsecretCRAM-MD5' >>> I1106 02:35:19.682255 21525 auxprop.cpp:99] Request to lookup properties >>> for user: 'test-principal' realm: 'penates.apache.org' server FQDN: >>> 'penates.apache.org' SASL_AUXPROP_VERIFY_AGAINST_HASH: false >>> SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true >>> I1106 02:35:19.682266 21525 auxprop.cpp:121] Skipping auxiliary property >>> '*userPassword' since SASL_AUXPROP_AUTHZID == true >>> I1106 02:35:19.682276 21525 auxprop.cpp:121] Skipping auxiliary property >>> '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true >>> I1106 02:35:19.682291 21525 authenticator.hpp:389] Authentication success >>> I1106 02:35:19.682391 21529 authenticatee.hpp:310] Authentication success >>> I1106 02:35:19.682451 21525 master.cpp:3957] Successfully authenticated >>> principal 'test-principal' at slave(223)@67.195.81.186:59951 >>> I1106 02:35:19.682914 21522 slave.cpp:722] Successfully authenticated with >>> master [email protected]:59951 >>> I1106 02:35:19.683043 21522 slave.cpp:1052] Will retry registration in >>> 8.637662ms if necessary >>> I1106 02:35:19.683217 21525 master.cpp:3063] Registering slave at >>> slave(223)@67.195.81.186:59951 (penates.apache.org) with id >>> 20141106-023518-3125920579-59951-21504-S0 >>> I1106 02:35:19.683784 21528 registrar.cpp:445] Applied 1 operations in >>> 67790ns; attempting to update the 'registry' >>> I1106 02:35:19.687147 21525 log.cpp:680] Attempting to append 318 bytes to >>> the log >>> I1106 02:35:19.687314 21522 coordinator.cpp:340] Coordinator attempting to >>> write APPEND action at position 3 >>> I1106 02:35:19.688436 21519 replica.cpp:508] Replica received write request >>> for position 3 >>> I1106 02:35:19.689483 21519 leveldb.cpp:343] Persisting action (337 bytes) >>> to leveldb took 1.009715ms >>> I1106 02:35:19.801269 21519 replica.cpp:676] Persisted action at 3 >>> I1106 02:35:19.692602 21527 slave.cpp:1052] Will retry registration in >>> 11.225828ms if necessary >>> I1106 02:35:19.692770 21528 master.cpp:3051] Ignoring register slave >>> message from slave(223)@67.195.81.186:59951 (penates.apache.org) as >>> admission is already in progress >>> I1106 02:35:19.801956 21520 replica.cpp:655] Replica received learned >>> notice for position 3 >>> I1106 02:35:19.802827 21520 leveldb.cpp:343] Persisting action (339 bytes) >>> to leveldb took 837275ns >>> I1106 02:35:19.802858 21520 replica.cpp:676] Persisted action at 3 >>> I1106 02:35:19.802888 21520 replica.cpp:661] Replica learned APPEND action >>> at position 3 >>> I1106 02:35:19.804822 21528 registrar.cpp:490] Successfully updated the >>> 'registry' in 120.967936ms >>> I1106 02:35:19.805101 21528 log.cpp:699] Attempting to truncate the log to 3 >>> I1106 02:35:19.805261 21530 coordinator.cpp:340] Coordinator attempting to >>> write TRUNCATE action at position 4 >>> I1106 02:35:19.805433 21523 slave.cpp:2538] Received ping from >>> slave-observer(203)@67.195.81.186:59951 >>> I1106 02:35:19.805608 21527 master.cpp:3117] Registered slave >>> 20141106-023518-3125920579-59951-21504-S0 at slave(223)@67.195.81.186:59951 >>> (penates.apache.org) with cpus(*):2; mem(*):1024; disk(*):1024; >>> ports(*):[31000-32000] >>> I1106 02:35:19.805665 21528 slave.cpp:756] Registered with master >>> [email protected]:59951; given slave ID >>> 20141106-023518-3125920579-59951-21504-S0 >>> I1106 02:35:19.805800 21523 status_update_manager.cpp:178] Resuming sending >>> status updates >>> I1106 02:35:19.805836 21531 hierarchical_allocator_process.hpp:442] Added >>> slave 20141106-023518-3125920579-59951-21504-S0 (penates.apache.org) with >>> cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] (and >>> cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] available) >>> I1106 02:35:19.806083 21531 hierarchical_allocator_process.hpp:734] >>> Offering cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] on >>> slave 20141106-023518-3125920579-59951-21504-S0 to framework >>> 20141106-023518-3125920579-59951-21504-0000 >>> I1106 02:35:19.806409 21533 replica.cpp:508] Replica received write request >>> for position 4 >>> I1106 02:35:19.806556 21531 hierarchical_allocator_process.hpp:679] >>> Performed allocation for slave 20141106-023518-3125920579-59951-21504-S0 in >>> 624870ns >>> I1106 02:35:19.806942 21529 master.cpp:3838] Sending 1 offers to framework >>> 20141106-023518-3125920579-59951-21504-0000 (default) at >>> [email protected]:59951 >>> I1106 02:35:19.807315 21529 sched.cpp:544] Scheduler::resourceOffers took >>> 75375ns >>> I1106 02:35:19.807927 21533 leveldb.cpp:343] Persisting action (16 bytes) >>> to leveldb took 1.481968ms >>> I1106 02:35:19.807965 21533 replica.cpp:676] Persisted action at 4 >>> I1106 02:35:19.808697 21531 replica.cpp:655] Replica received learned >>> notice for position 4 >>> I1106 02:35:19.809350 21531 leveldb.cpp:343] Persisting action (18 bytes) >>> to leveldb took 622381ns >>> I1106 02:35:19.809403 21531 leveldb.cpp:401] Deleting ~2 keys from leveldb >>> took 27616ns >>> I1106 02:35:19.809424 21531 replica.cpp:676] Persisted action at 4 >>> I1106 02:35:19.809445 21531 replica.cpp:661] Replica learned TRUNCATE >>> action at position 4 >>> I1106 02:35:19.811794 21529 master.cpp:2339] Processing reply for offers: [ >>> 20141106-023518-3125920579-59951-21504-O0 ] on slave >>> 20141106-023518-3125920579-59951-21504-S0 at slave(223)@67.195.81.186:59951 >>> (penates.apache.org) for framework >>> 20141106-023518-3125920579-59951-21504-0000 (default) at >>> [email protected]:59951 >>> W1106 02:35:19.811928 21529 master.cpp:1985] Executor default for task >>> ca2f9330-28ef-463c-8f7e-ed28a72e9e6b uses less CPUs (None) than the minimum >>> required (0.01). Please update your executor, as this will be mandatory in >>> future releases. >>> W1106 02:35:19.811960 21529 master.cpp:1996] Executor default for task >>> ca2f9330-28ef-463c-8f7e-ed28a72e9e6b uses less memory (None) than the >>> minimum required (32MB). Please update your executor, as this will be >>> mandatory in future releases. >>> I1106 02:35:19.812067 21529 master.cpp:2435] Authorizing framework >>> principal 'test-principal' to launch task >>> ca2f9330-28ef-463c-8f7e-ed28a72e9e6b as user 'jenkins' >>> I1106 02:35:19.813295 21520 master.hpp:877] Adding task >>> ca2f9330-28ef-463c-8f7e-ed28a72e9e6b with resources cpus(*):2; mem(*):1024; >>> disk(*):1024; ports(*):[31000-32000] on slave >>> 20141106-023518-3125920579-59951-21504-S0 (penates.apache.org) >>> I1106 02:35:19.813422 21520 master.cpp:2498] Launching task >>> ca2f9330-28ef-463c-8f7e-ed28a72e9e6b of framework >>> 20141106-023518-3125920579-59951-21504-0000 (default) at >>> [email protected]:59951 with >>> resources cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] on >>> slave 20141106-023518-3125920579-59951-21504-S0 at >>> slave(223)@67.195.81.186:59951 (penates.apache.org) >>> I1106 02:35:19.813807 21527 slave.cpp:1083] Got assigned task >>> ca2f9330-28ef-463c-8f7e-ed28a72e9e6b for framework >>> 20141106-023518-3125920579-59951-21504-0000 >>> I1106 02:35:19.814404 21527 slave.cpp:1193] Launching task >>> ca2f9330-28ef-463c-8f7e-ed28a72e9e6b for framework >>> 20141106-023518-3125920579-59951-21504-0000 >>> I1106 02:35:19.817266 21527 slave.cpp:3913] Launching executor default of >>> framework 20141106-023518-3125920579-59951-21504-0000 in work directory >>> '/tmp/RegistrarZooKeeperTest_TaskRunning_myfb0x/slaves/20141106-023518-3125920579-59951-21504-S0/frameworks/20141106-023518-3125920579-59951-21504-0000/executors/default/runs/25754bef-81a0-4ec5-a84a-5d4dcfbe1ffc' >>> I1106 02:35:19.820420 21527 exec.cpp:132] Version: 0.22.0 >>> I1106 02:35:19.820749 21532 exec.cpp:182] Executor started at: >>> executor(74)@67.195.81.186:59951 with pid 21504 >>> I1106 02:35:19.820863 21527 slave.cpp:1316] Queuing task >>> 'ca2f9330-28ef-463c-8f7e-ed28a72e9e6b' for executor default of framework >>> '20141106-023518-3125920579-59951-21504-0000 >>> I1106 02:35:19.820993 21527 slave.cpp:555] Successfully attached file >>> '/tmp/RegistrarZooKeeperTest_TaskRunning_myfb0x/slaves/20141106-023518-3125920579-59951-21504-S0/frameworks/20141106-023518-3125920579-59951-21504-0000/executors/default/runs/25754bef-81a0-4ec5-a84a-5d4dcfbe1ffc' >>> I1106 02:35:19.821120 21527 slave.cpp:2840] Monitoring executor 'default' >>> of framework '20141106-023518-3125920579-59951-21504-0000' in container >>> '25754bef-81a0-4ec5-a84a-5d4dcfbe1ffc' >>> I1106 02:35:19.821310 21527 slave.cpp:1860] Got registration for executor >>> 'default' of framework 20141106-023518-3125920579-59951-21504-0000 from >>> executor(74)@67.195.81.186:59951 >>> I1106 02:35:19.821779 21527 slave.cpp:1979] Flushing queued task >>> ca2f9330-28ef-463c-8f7e-ed28a72e9e6b for executor 'default' of framework >>> 20141106-023518-3125920579-59951-21504-0000 >>> I1106 02:35:19.821835 21519 exec.cpp:206] Executor registered on slave >>> 20141106-023518-3125920579-59951-21504-S0 >>> I1106 02:35:19.824235 21519 exec.cpp:218] Executor::registered took 26946ns >>> I1106 02:35:19.824427 21519 exec.cpp:293] Executor asked to run task >>> 'ca2f9330-28ef-463c-8f7e-ed28a72e9e6b' >>> I1106 02:35:19.824503 21519 exec.cpp:302] Executor::launchTask took 54591ns >>> I1106 02:35:19.826918 21519 exec.cpp:525] Executor sending status update >>> TASK_RUNNING (UUID: 66b72a5c-f49f-412a-86cc-342f20ddf5fb) for task >>> ca2f9330-28ef-463c-8f7e-ed28a72e9e6b of framework >>> 20141106-023518-3125920579-59951-21504-0000 >>> I1106 02:35:19.827165 21519 slave.cpp:2215] Handling status update >>> TASK_RUNNING (UUID: 66b72a5c-f49f-412a-86cc-342f20ddf5fb) for task >>> ca2f9330-28ef-463c-8f7e-ed28a72e9e6b of framework >>> 20141106-023518-3125920579-59951-21504-0000 from >>> executor(74)@67.195.81.186:59951 >>> I1106 02:35:19.827452 21531 status_update_manager.cpp:317] Received status >>> update TASK_RUNNING (UUID: 66b72a5c-f49f-412a-86cc-342f20ddf5fb) for task >>> ca2f9330-28ef-463c-8f7e-ed28a72e9e6b of framework >>> 20141106-023518-3125920579-59951-21504-0000 >>> I1106 02:35:19.827500 21531 status_update_manager.cpp:494] Creating >>> StatusUpdate stream for task ca2f9330-28ef-463c-8f7e-ed28a72e9e6b of >>> framework 20141106-023518-3125920579-59951-21504-0000 >>> I1106 02:35:19.922338 21531 status_update_manager.cpp:371] Forwarding >>> update TASK_RUNNING (UUID: 66b72a5c-f49f-412a-86cc-342f20ddf5fb) for task >>> ca2f9330-28ef-463c-8f7e-ed28a72e9e6b of framework >>> 20141106-023518-3125920579-59951-21504-0000 to the slave >>> I1106 02:35:19.922687 21532 slave.cpp:2458] Forwarding the update >>> TASK_RUNNING (UUID: 66b72a5c-f49f-412a-86cc-342f20ddf5fb) for task >>> ca2f9330-28ef-463c-8f7e-ed28a72e9e6b of framework >>> 20141106-023518-3125920579-59951-21504-0000 to [email protected]:59951 >>> I1106 02:35:19.922837 21532 slave.cpp:2385] Status update manager >>> successfully handled status update TASK_RUNNING (UUID: >>> 66b72a5c-f49f-412a-86cc-342f20ddf5fb) for task >>> ca2f9330-28ef-463c-8f7e-ed28a72e9e6b of framework >>> 20141106-023518-3125920579-59951-21504-0000 >>> I1106 02:35:19.922868 21532 slave.cpp:2391] Sending acknowledgement for >>> status update TASK_RUNNING (UUID: 66b72a5c-f49f-412a-86cc-342f20ddf5fb) for >>> task ca2f9330-28ef-463c-8f7e-ed28a72e9e6b of framework >>> 20141106-023518-3125920579-59951-21504-0000 to >>> executor(74)@67.195.81.186:59951 >>> I1106 02:35:19.923007 21521 master.cpp:3441] Forwarding status update >>> TASK_RUNNING (UUID: 66b72a5c-f49f-412a-86cc-342f20ddf5fb) for task >>> ca2f9330-28ef-463c-8f7e-ed28a72e9e6b of framework >>> 20141106-023518-3125920579-59951-21504-0000 >>> I1106 02:35:19.923130 21524 exec.cpp:339] Executor received status update >>> acknowledgement 66b72a5c-f49f-412a-86cc-342f20ddf5fb for task >>> ca2f9330-28ef-463c-8f7e-ed28a72e9e6b of framework >>> 20141106-023518-3125920579-59951-21504-0000 >>> I1106 02:35:19.923187 21521 master.cpp:3413] Status update TASK_RUNNING >>> (UUID: 66b72a5c-f49f-412a-86cc-342f20ddf5fb) for task >>> ca2f9330-28ef-463c-8f7e-ed28a72e9e6b of framework >>> 20141106-023518-3125920579-59951-21504-0000 from slave >>> 20141106-023518-3125920579-59951-21504-S0 at slave(223)@67.195.81.186:59951 >>> (penates.apache.org) >>> I1106 02:35:19.923243 21521 master.cpp:4691] Updating the latest state of >>> task ca2f9330-28ef-463c-8f7e-ed28a72e9e6b of framework >>> 20141106-023518-3125920579-59951-21504-0000 to TASK_RUNNING >>> I1106 02:35:19.923346 21524 sched.cpp:635] Scheduler::statusUpdate took >>> 54588ns >>> I1106 02:35:19.923681 21523 master.cpp:2913] Forwarding status update >>> acknowledgement 66b72a5c-f49f-412a-86cc-342f20ddf5fb for task >>> ca2f9330-28ef-463c-8f7e-ed28a72e9e6b of framework >>> 20141106-023518-3125920579-59951-21504-0000 (default) at >>> [email protected]:59951 to slave >>> 20141106-023518-3125920579-59951-21504-S0 at slave(223)@67.195.81.186:59951 >>> (penates.apache.org) >>> I1106 02:35:19.923825 21520 sched.cpp:745] Stopping framework >>> '20141106-023518-3125920579-59951-21504-0000' >>> I1106 02:35:19.923882 21523 master.cpp:693] Master terminating >>> I1106 02:35:19.924026 21533 status_update_manager.cpp:389] Received status >>> update acknowledgement (UUID: 66b72a5c-f49f-412a-86cc-342f20ddf5fb) for >>> task ca2f9330-28ef-463c-8f7e-ed28a72e9e6b of framework >>> 20141106-023518-3125920579-59951-21504-0000 >>> W1106 02:35:19.924034 21523 master.cpp:4736] Removing task >>> ca2f9330-28ef-463c-8f7e-ed28a72e9e6b with resources cpus(*):2; mem(*):1024; >>> disk(*):1024; ports(*):[31000-32000] of framework >>> 20141106-023518-3125920579-59951-21504-0000 on slave >>> 20141106-023518-3125920579-59951-21504-S0 at slave(223)@67.195.81.186:59951 >>> (penates.apache.org) in non-terminal state TASK_RUNNING >>> I1106 02:35:19.924293 21533 slave.cpp:1800] Status update manager >>> successfully handled status update acknowledgement (UUID: >>> 66b72a5c-f49f-412a-86cc-342f20ddf5fb) for task >>> ca2f9330-28ef-463c-8f7e-ed28a72e9e6b of framework >>> 20141106-023518-3125920579-59951-21504-0000 >>> I1106 02:35:19.924562 21532 hierarchical_allocator_process.hpp:563] >>> Recovered cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] >>> (total allocatable: cpus(*):2; mem(*):1024; disk(*):1024; >>> ports(*):[31000-32000]) on slave 20141106-023518-3125920579-59951-21504-S0 >>> from framework 20141106-023518-3125920579-59951-21504-0000 >>> I1106 02:35:19.924645 21523 master.cpp:4779] Removing executor 'default' >>> with resources of framework 20141106-023518-3125920579-59951-21504-0000 on >>> slave 20141106-023518-3125920579-59951-21504-S0 at >>> slave(223)@67.195.81.186:59951 (penates.apache.org) >>> I1106 02:35:19.925286 21527 slave.cpp:2623] [email protected]:59951 >>> exited >>> W1106 02:35:19.925314 21527 slave.cpp:2626] Master disconnected! Waiting >>> for a new master to be elected >>> 2014-11-06 >>> 02:35:19,928:21504(0x2b3bbd38a080):ZOO_INFO@zookeeper_close@2505: Closing >>> zookeeper sessionId=0x14982f4bed50002 to [127.0.0.1:39207] >>> >>> I1106 02:35:19.929152 21528 contender.cpp:186] Now cancelling the >>> membership: 1 >>> I1106 02:35:19.929462 21519 group.cpp:619] Trying to remove >>> '/znode/info_0000000001' in ZooKeeper >>> 2014-11-06 >>> 02:35:19,931:21504(0x2b3bbd38a080):ZOO_INFO@zookeeper_close@2505: Closing >>> zookeeper sessionId=0x14982f4bed50003 to [127.0.0.1:39207] >>> >>> I1106 02:35:19.932983 21522 group.cpp:717] Found non-sequence node >>> 'log_replicas' at '/znode' in ZooKeeper >>> I1106 02:35:19.933161 21523 detector.cpp:126] The current leader (id=1) is >>> lost >>> I1106 02:35:19.933188 21523 detector.cpp:138] Detected a new leader: None >>> 2014-11-06 >>> 02:35:19,933:21504(0x2b3bc4fce700):ZOO_INFO@zookeeper_close@2505: Closing >>> zookeeper sessionId=0x14982f4bed50001 to [127.0.0.1:39207] >>> >>> I1106 02:35:19.933496 21524 slave.cpp:595] Lost leading master >>> I1106 02:35:19.933542 21524 slave.cpp:638] Detecting new master >>> I1106 02:35:19.933581 21525 status_update_manager.cpp:171] Pausing sending >>> status updates >>> 2014-11-06 >>> 02:35:19,934:21504(0x2b3bc5dd5700):ZOO_INFO@zookeeper_close@2505: Closing >>> zookeeper sessionId=0x14982f4bed50000 to [127.0.0.1:39207] >>> >>> I1106 02:35:19.935349 21520 slave.cpp:2898] Executor 'default' of framework >>> 20141106-023518-3125920579-59951-21504-0000 exited with status 0 >>> I1106 02:35:19.937865 21520 slave.cpp:2215] Handling status update >>> TASK_LOST (UUID: 47f6113a-2320-4eeb-b817-3f3777b1ba52) for task >>> ca2f9330-28ef-463c-8f7e-ed28a72e9e6b of framework >>> 20141106-023518-3125920579-59951-21504-0000 from @0.0.0.0:0 >>> I1106 02:35:19.937963 21520 slave.cpp:4221] Terminating task >>> ca2f9330-28ef-463c-8f7e-ed28a72e9e6b >>> I1106 02:35:19.938361 21520 slave.cpp:484] Slave terminating >>> I1106 02:35:19.938448 21520 slave.cpp:1533] Asked to shut down framework >>> 20141106-023518-3125920579-59951-21504-0000 by @0.0.0.0:0 >>> W1106 02:35:19.938467 21520 slave.cpp:1541] Ignoring shutdown framework >>> message for 20141106-023518-3125920579-59951-21504-0000 because the slave >>> has not yet registered with the master >>> 2014-11-06 >>> 02:35:19,940:21504(0x2b3bbd38a080):ZOO_INFO@zookeeper_close@2505: Closing >>> zookeeper sessionId=0x14982f4bed50004 to [127.0.0.1:39207] >>> >>> [ OK ] RegistrarZooKeeperTest.TaskRunning (1840 ms) >>> I1106 02:35:19.942129 21504 zookeeper_test_server.cpp:118] Shutting down >>> ZooKeeperTestServer on port 39207 >>> [----------] 1 test from RegistrarZooKeeperTest (1840 ms total) >>> >>> [----------] 7 tests from LevelDBStateTest >>> [ RUN ] LevelDBStateTest.FetchAndStoreAndStoreAndFetch >>> [ OK ] LevelDBStateTest.FetchAndStoreAndStoreAndFetch (15 ms) >>> [ RUN ] LevelDBStateTest.FetchAndStoreAndStoreFailAndFetch >>> [ OK ] LevelDBStateTest.FetchAndStoreAndStoreFailAndFetch (15 ms) >>> [ RUN ] LevelDBStateTest.FetchAndStoreAndExpungeAndFetch >>> [ OK ] LevelDBStateTest.FetchAndStoreAndExpungeAndFetch (14 ms) >>> [ RUN ] LevelDBStateTest.FetchAndStoreAndExpungeAndExpunge >>> [ OK ] LevelDBStateTest.FetchAndStoreAndExpungeAndExpunge (12 ms) >>> [ RUN ] LevelDBStateTest.FetchAndStoreAndExpungeAndStoreAndFetch >>> [ OK ] LevelDBStateTest.FetchAndStoreAndExpungeAndStoreAndFetch (15 >>> ms) >>> [ RUN ] LevelDBStateTest.FetchAndStoreAndFetch >>> [ OK ] LevelDBStateTest.FetchAndStoreAndFetch (11 ms) >>> [ RUN ] LevelDBStateTest.Names >>> [ OK ] LevelDBStateTest.Names (12 ms) >>> [----------] 7 tests from LevelDBStateTest (94 ms total) >>> >>> [----------] 23 tests from ModuleTest >>> [ RUN ] ModuleTest.UnknownLibraryTest >>> Using temporary directory '/tmp/ModuleTest_UnknownLibraryTest_yjZBJs' >>> [ OK ] ModuleTest.UnknownLibraryTest (1 ms) >>> [ RUN ] ModuleTest.UnknownModuleTest >>> Using temporary directory '/tmp/ModuleTest_UnknownModuleTest_si4dwn' >>> [ OK ] ModuleTest.UnknownModuleTest (1 ms) >>> [ RUN ] ModuleTest.ModuleKindMismatch >>> Using temporary directory '/tmp/ModuleTest_ModuleKindMismatch_aIJUii' >>> [ OK ] ModuleTest.ModuleKindMismatch (0 ms) >>> [ RUN ] ModuleTest.LibraryNameWithoutExtension >>> Using temporary directory >>> '/tmp/ModuleTest_LibraryNameWithoutExtension_GgQI5c' >>> [ OK ] ModuleTest.LibraryNameWithoutExtension (1 ms) >>> [ RUN ] ModuleTest.ParameterWithoutValue >>> Using temporary directory '/tmp/ModuleTest_ParameterWithoutValue_GBqAS7' >>> [ OK ] ModuleTest.ParameterWithoutValue (0 ms) >>> [ RUN ] ModuleTest.UnknownModuleInstantiationTest >>> Using temporary directory >>> '/tmp/ModuleTest_UnknownModuleInstantiationTest_qMAvF2' >>> [ OK ] ModuleTest.UnknownModuleInstantiationTest (0 ms) >>> [ RUN ] ModuleTest.LibraryNameWithExtension >>> Using temporary directory '/tmp/ModuleTest_LibraryNameWithExtension_gpCusX' >>> [ OK ] ModuleTest.LibraryNameWithExtension (1 ms) >>> [ RUN ] ModuleTest.DifferentApiVersion >>> Using temporary directory '/tmp/ModuleTest_DifferentApiVersion_gXuxfS' >>> [ OK ] ModuleTest.DifferentApiVersion (0 ms) >>> [ RUN ] ModuleTest.ParameterWithInvalidKey >>> Using temporary directory '/tmp/ModuleTest_ParameterWithInvalidKey_g2oE2M' >>> [ OK ] ModuleTest.ParameterWithInvalidKey (1 ms) >>> [ RUN ] ModuleTest.NonModuleLibrary >>> Using temporary directory '/tmp/ModuleTest_NonModuleLibrary_uMtPPH' >>> [ OK ] ModuleTest.NonModuleLibrary (0 ms) >>> [ RUN ] ModuleTest.ParameterWithInvalidValue >>> Using temporary directory '/tmp/ModuleTest_ParameterWithInvalidValue_GHh5CC' >>> [ OK ] ModuleTest.ParameterWithInvalidValue (0 ms) >>> [ RUN ] ModuleTest.EmptyLibraryFilename >>> Using temporary directory '/tmp/ModuleTest_EmptyLibraryFilename_KDqoqx' >>> [ OK ] ModuleTest.EmptyLibraryFilename (1 ms) >>> [ RUN ] ModuleTest.ParameterWithoutKey >>> Using temporary directory '/tmp/ModuleTest_ParameterWithoutKey_KjPLds' >>> [ OK ] ModuleTest.ParameterWithoutKey (0 ms) >>> [ RUN ] ModuleTest.DuplicateModule >>> Using temporary directory '/tmp/ModuleTest_DuplicateModule_AMxd1m' >>> [ OK ] ModuleTest.DuplicateModule (1 ms) >>> [ RUN ] ModuleTest.ValidParameters >>> Using temporary directory '/tmp/ModuleTest_ValidParameters_mfPIOh' >>> [ OK ] ModuleTest.ValidParameters (0 ms) >>> [ RUN ] ModuleTest.EmptyModuleName >>> Using temporary directory '/tmp/ModuleTest_EmptyModuleName_iPUiCc' >>> [ OK ] ModuleTest.EmptyModuleName (0 ms) >>> [ RUN ] ModuleTest.ExampleModuleUnloadTest >>> Using temporary directory '/tmp/ModuleTest_ExampleModuleUnloadTest_C3TVp7' >>> [ OK ] ModuleTest.ExampleModuleUnloadTest (1 ms) >>> [ RUN ] ModuleTest.InvalidModuleKind >>> Using temporary directory '/tmp/ModuleTest_InvalidModuleKind_ubuCd2' >>> [ OK ] ModuleTest.InvalidModuleKind (0 ms) >>> [ RUN ] ModuleTest.ExampleModuleLoadTest >>> Using temporary directory '/tmp/ModuleTest_ExampleModuleLoadTest_Myjm1W' >>> [ OK ] ModuleTest.ExampleModuleLoadTest (0 ms) >>> [ RUN ] ModuleTest.NewerModuleLibrary >>> Using temporary directory '/tmp/ModuleTest_NewerModuleLibrary_EGx9OR' >>> [ OK ] ModuleTest.NewerModuleLibrary (1 ms) >>> [ RUN ] ModuleTest.OlderModuleLibrary >>> Using temporary directory '/tmp/ModuleTest_OlderModuleLibrary_2G1ZCM' >>> [ OK ] ModuleTest.OlderModuleLibrary (0 ms) >>> [ RUN ] ModuleTest.AuthorInfoTest >>> Using temporary directory '/tmp/ModuleTest_AuthorInfoTest_yL9TqH' >>> [ OK ] ModuleTest.AuthorInfoTest (0 ms) >>> [ RUN ] ModuleTest.JsonParseTest >>> Using temporary directory '/tmp/ModuleTest_JsonParseTest_cgYQeC' >>> [ OK ] ModuleTest.JsonParseTest (1 ms) >>> [----------] 23 tests from ModuleTest (29 ms total) >>> >>> [----------] Global test environment tear-down >>> [==========] 456 tests from 71 test cases ran. (269337 ms total) >>> [ PASSED ] 455 tests. >>> [ FAILED ] 1 test, listed below: >>> [ FAILED ] MesosContainerizerExecuteTest.IoRedirection >>> >>> 1 FAILED TEST >>> YOU HAVE 6 DISABLED TESTS >>> >>> make[3]: *** [check-local] Error 1 >>> make[3]: Leaving directory >>> `<https://builds.apache.org/job/Mesos-Trunk-Ubuntu-Build-In-Src-Set-JAVA_HOME/ws/src'> >>> make[2]: *** [check-am] Error 2 >>> make[2]: Leaving directory >>> `<https://builds.apache.org/job/Mesos-Trunk-Ubuntu-Build-In-Src-Set-JAVA_HOME/ws/src'> >>> make[1]: *** [check] Error 2 >>> make[1]: Leaving directory >>> `<https://builds.apache.org/job/Mesos-Trunk-Ubuntu-Build-In-Src-Set-JAVA_HOME/ws/src'> >>> make: *** [check-recursive] Error 1 >>> Test finished >>> Exit status: 2 >>> Build step 'Execute shell' marked build as failure >>> Recording test results >
