2019-10-30T22:21:49.687Z,1572474109.687 [CommandLine](IMPORTANT): got command restart logs
2019-10-30T22:21:51.193Z,1572474111.193 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:21:51.603Z,1572474111.603 [DataOverHttps](IMPORTANT): SBD MTMSN=20191030T222046
2019-10-30T22:21:54.021Z,1572474114.021 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:21:56.849Z,1572474116.849 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:22:00.081Z,1572474120.081 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:22:02.084Z,1572474122.084 [DataOverHttps](INFO): Received command:load Maintenance/DUSBL_Tracking.xml;set DUSBL.TrackingUpdatePeriod 7 second;run 
2019-10-30T22:22:02.111Z,1572474122.111 [CommandLine](IMPORTANT): got command load ./Missions/Maintenance/DUSBL_Tracking.xml
2019-10-30T22:22:02.112Z,1572474122.112 [MissionManager](INFO): Loading Mission: ./Missions/Maintenance/DUSBL_Tracking.xml
2019-10-30T22:22:02.227Z,1572474122.227 [MissionManager](INFO): DefineArg DUSBL.MissionTimeout = 10.000000 min
2019-10-30T22:22:02.250Z,1572474122.250 [MissionManager](INFO): DefineArg DUSBL.TransponderCode = 2.000000 count
2019-10-30T22:22:02.262Z,1572474122.262 [MissionManager](INFO): DefineArg DUSBL.TrackingUpdatePeriod = 4.000000 s
2019-10-30T22:22:02.288Z,1572474122.288 [MissionManager](INFO): DefineArg DUSBL.NumberOfPings = 1.000000 count
2019-10-30T22:22:02.300Z,1572474122.300 [MissionManager](INFO): DefineArg DUSBL.EnabledDUSBL = DUSBL_Hydroid.loadAtStartup
2019-10-30T22:22:02.310Z,1572474122.310 [DUSBL:A.Pitch](DEBUG): Construct.
2019-10-30T22:22:02.348Z,1572474122.348 [DUSBL:B.SetSpeed](DEBUG): Construct.
2019-10-30T22:22:02.752Z,1572474122.752 [DUSBL:RequestRepeater:A.Wait](DEBUG): Construct Wait.
2019-10-30T22:22:02.768Z,1572474122.768 [MissionManager](DEBUG): 
<?xml version="1.0" encoding="UTF-8"?>
<!-- ====================
     Generated by TethysL
     ==================== -->
<Mission xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"
         xmlns="Tethys"
         xmlns:Units="Tethys/Units"
         xmlns:Guidance="Tethys/Guidance"
         xmlns:Control="Tethys/Control"
         xsi:schemaLocation="Tethys http://okeanids.mbari.org/tethys/Xml/Tethys.xsd
                             Tethys/Units http://okeanids.mbari.org/tethys/Xml/Units.xsd
                             Tethys/Guidance http://okeanids.mbari.org/tethys/Xml/Guidance.xsd
                             Tethys/Control http://okeanids.mbari.org/tethys/Xml/Control.xsd"
       Id="DUSBL">

    <Description>
        This mission is requests a DUSBL arming.
    </Description>

    <DefineArg Name="MissionTimeout"><Description>
        How long to let the mission run.
    </Description><Units:minute/><Value>10</Value></DefineArg>

    <DefineArg Name="TransponderCode"><Description>
        Transponder Address.
    </Description><Units:count/><Value>2</Value></DefineArg>
    
    <DefineArg Name="TrackingUpdatePeriod"><Description>
        How long to wait between acoustic queries
    </Description><Units:second/><Value>4</Value></DefineArg>
    
    <DefineArg Name="NumberOfPings"><Description>
        Number of pings requested each time.
    </Description><Units:count/><Value>1</Value></DefineArg>
    
    <DefineArg Name="EnabledDUSBL"><Description>
        Automatically set to true if the DUSBL is enabled. Set to false to disable
        reading from the DUSBL.
    </Description><Sensor:DUSBL_Hydroid.loadAtStartup/></DefineArg>    

    <Timeout Duration="MissionTimeout"/>

    <Guidance:Pitch>
        <Parallel/>
        <Setting><Guidance:Pitch.massPosition/><Control:VerticalControl.massDefault/></Setting>
    </Guidance:Pitch>

    <Guidance:SetSpeed>
        <Parallel/>
        <Setting><Guidance:SetSpeed.speed/><Units:meter_per_second/><Value>0</Value></Setting>
    </Guidance:SetSpeed>

    
    <Estimation:TrackAcousticContact>
        <Parallel/>
        <Setting><Estimation:TrackAcousticContact.contactLabelSetting/><Arg Name="TransponderCode"/></Setting>
        <Setting><Estimation:TrackAcousticContact.numberOfSamplesSetting/><Arg Name="NumberOfPings"/></Setting>
        <Setting><Estimation:TrackAcousticContact.updatePeriodSetting/><Arg Name="TrackingUpdatePeriod"/></Setting>
    </Estimation:TrackAcousticContact>
    
      <Aggregate Id="RequestRepeater">

        <Sequence/>
        
          <Guidance:Wait>
            <Sequence/>
            <Setting><Guidance:Wait.duration/><Arg Name="MissionTimeout"/></Setting>            
          </Guidance:Wait>
      </Aggregate>

</Mission>


2019-10-30T22:22:02.777Z,1572474122.777 [CommandLine](IMPORTANT): Loaded ./Missions/Maintenance/DUSBL_Tracking.xml
2019-10-30T22:22:02.913Z,1572474122.913 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:22:06.141Z,1572474126.141 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:22:06.274Z,1572474126.274 [CommandLine](IMPORTANT): got command set DUSBL.TrackingUpdatePeriod 7.000000 second
2019-10-30T22:22:06.277Z,1572474126.277 [CommandLine](IMPORTANT): got command run 
2019-10-30T22:22:06.287Z,1572474126.287 [CommandLine](IMPORTANT): Running 
2019-10-30T22:22:06.576Z,1572474126.576 [Default] Stopped
2019-10-30T22:22:06.576Z,1572474126.576 [Default](DEBUG): Aggregate::uninitialize Default
2019-10-30T22:22:06.577Z,1572474126.577 [Default:B.GoToSurface] Stopped
2019-10-30T22:22:06.577Z,1572474126.577 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2019-10-30T22:22:06.577Z,1572474126.577 [Default:CheckIn] Stopped
2019-10-30T22:22:06.577Z,1572474126.577 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2019-10-30T22:22:06.577Z,1572474126.577 [Default:CheckIn:C.Wait] Stopped
2019-10-30T22:22:06.577Z,1572474126.577 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2019-10-30T22:22:06.577Z,1572474126.577 [MissionManager](IMPORTANT): Started mission DUSBL
2019-10-30T22:22:06.578Z,1572474126.578 [DUSBL] Running Loop=1
2019-10-30T22:22:06.578Z,1572474126.578 [DUSBL](DEBUG): Aggregate::initialize DUSBL
2019-10-30T22:22:06.578Z,1572474126.578 [DUSBL:A.Pitch] Running Loop=1
2019-10-30T22:22:06.578Z,1572474126.578 [DUSBL:A.Pitch](DEBUG): Initialize.
2019-10-30T22:22:06.578Z,1572474126.578 [DUSBL:B.SetSpeed] Running Loop=1
2019-10-30T22:22:06.578Z,1572474126.578 [DUSBL:B.SetSpeed](DEBUG): Initialize.
2019-10-30T22:22:06.578Z,1572474126.578 [DUSBL:C.] Running Loop=1
2019-10-30T22:22:06.578Z,1572474126.578 [DUSBL:C.](INFO): Initializing TrackAcousticContact.
2019-10-30T22:22:06.579Z,1572474126.579 [DUSBL:RequestRepeater] Running Loop=1
2019-10-30T22:22:06.579Z,1572474126.579 [DUSBL:RequestRepeater](DEBUG): Aggregate::initialize DUSBL:RequestRepeater
2019-10-30T22:22:06.579Z,1572474126.579 [DUSBL:RequestRepeater:A.Wait] Running Loop=1
2019-10-30T22:22:06.579Z,1572474126.579 [DUSBL:RequestRepeater:A.Wait](DEBUG): Initialize Wait Component.
2019-10-30T22:22:06.579Z,1572474126.579 [DUSBL:C.] Running Loop=1
2019-10-30T22:22:06.580Z,1572474126.580 [DUSBL:B.SetSpeed] Running Loop=1
2019-10-30T22:22:06.580Z,1572474126.580 [DUSBL:A.Pitch] Running Loop=1
2019-10-30T22:22:08.973Z,1572474128.973 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:22:11.415Z,1572474131.415 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 41
2019-10-30T22:22:11.416Z,1572474131.416 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-10-30T22:22:11.437Z,1572474131.437 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-10-30T22:22:11.797Z,1572474131.797 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:22:11.834Z,1572474131.834 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-10-30T22:22:11.834Z,1572474131.834 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 41
2019-10-30T22:22:13.817Z,1572474133.817 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:22:13.863Z,1572474133.863 [DUSBL:C.](INFO): *** querying acoustic contact ***
2019-10-30T22:22:14.202Z,1572474134.202 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-10-30T22:22:14.202Z,1572474134.202 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-10-30T22:22:14.203Z,1572474134.203 [DUSBL_Hydroid](INFO): Arming DUSBL. detectThresh: 25
2019-10-30T22:22:14.204Z,1572474134.204 [DUSBL_Hydroid](INFO): ****** ping requested ******
2019-10-30T22:22:14.631Z,1572474134.631 [DUSBL_Hydroid](INFO): DUSBL response received:
2019-10-30T22:22:14.633Z,1572474134.633 [DUSBL_Hydroid](ERROR): unknown deviceResponse_: 
2019-10-30T22:22:17.062Z,1572474137.062 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:22:19.877Z,1572474139.877 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:22:20.291Z,1572474140.291 [DUSBL_Hydroid](INFO): Setting waiting for range response to false due to timeout. Elapsed:6.087693
2019-10-30T22:22:21.107Z,1572474141.107 [DUSBL:C.](INFO): *** querying acoustic contact ***
2019-10-30T22:22:21.474Z,1572474141.474 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-10-30T22:22:21.474Z,1572474141.474 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-10-30T22:22:21.474Z,1572474141.474 [DUSBL_Hydroid](INFO): Arming DUSBL. detectThresh: 25
2019-10-30T22:22:21.475Z,1572474141.475 [DUSBL_Hydroid](INFO): ****** ping requested ******
2019-10-30T22:22:21.878Z,1572474141.878 [DUSBL_Hydroid](INFO): DUSBL response received:!U1,P


2019-10-30T22:22:21.878Z,1572474141.878 [DUSBL_Hydroid](INFO): Command Ack
2019-10-30T22:22:21.879Z,1572474141.879 [DUSBL_Hydroid](INFO): Requesting micromodem ping code 2
2019-10-30T22:22:21.881Z,1572474141.881 [Micromodem](INFO): Nmea out: $CCPGT,0,10000,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,2000,4000,0*70

2019-10-30T22:22:22.288Z,1572474142.288 [Micromodem](INFO): Nmea in: $SNPGT,0,10000,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,2000,4000,0*6D

2019-10-30T22:22:23.099Z,1572474143.099 [Micromodem](INFO): Nmea in: $SNTTA,0.393058,,,,222222.88*44

2019-10-30T22:22:23.113Z,1572474143.113 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:22:25.524Z,1572474145.524 [DUSBL_Hydroid](INFO): DUSBL response received:!U1,N,80,80,63,E4
2019-10-30T22:22:25.524Z,1572474145.524 [DUSBL_Hydroid](INFO): No reply:!U1,N,80,80,63,E4
2019-10-30T22:22:25.524Z,1572474145.524 [DUSBL_Hydroid](ERROR): No response from remote modem.
2019-10-30T22:22:25.524Z,1572474145.524 [DUSBL_Hydroid](INFO): Failure count cleared after critical for DUSBL_Hydroid
2019-10-30T22:22:25.933Z,1572474145.933 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:22:28.388Z,1572474148.388 [DUSBL:C.](INFO): *** querying acoustic contact ***
2019-10-30T22:22:28.747Z,1572474148.747 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-10-30T22:22:28.747Z,1572474148.747 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-10-30T22:22:28.747Z,1572474148.747 [DUSBL_Hydroid](INFO): Arming DUSBL. detectThresh: 25
2019-10-30T22:22:28.748Z,1572474148.748 [DUSBL_Hydroid](INFO): ****** ping requested ******
2019-10-30T22:22:29.155Z,1572474149.155 [DUSBL_Hydroid](INFO): DUSBL response received:!U1,P
80,80,63,E4
2019-10-30T22:22:29.155Z,1572474149.155 [DUSBL_Hydroid](INFO): Command Ack
2019-10-30T22:22:29.155Z,1572474149.155 [DUSBL_Hydroid](INFO): Requesting micromodem ping code 2
2019-10-30T22:22:29.157Z,1572474149.157 [Micromodem](INFO): Nmea out: $CCPGT,0,10000,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,2000,4000,0*70

2019-10-30T22:22:29.173Z,1572474149.173 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:22:29.562Z,1572474149.562 [Micromodem](INFO): Nmea in: $SNPGT,0,10000,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,2000,4000,0*6D

2019-10-30T22:22:30.371Z,1572474150.371 [Micromodem](INFO): Nmea in: $SNTTA,,,,,222230.15*59

2019-10-30T22:22:31.997Z,1572474151.997 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:22:32.790Z,1572474152.790 [DUSBL_Hydroid](INFO): DUSBL response received:!U1,N,80,80,63,E4
2019-10-30T22:22:32.790Z,1572474152.790 [DUSBL_Hydroid](INFO): No reply:!U1,N,80,80,63,E4
2019-10-30T22:22:32.790Z,1572474152.790 [DUSBL_Hydroid](ERROR): No response from remote modem.
2019-10-30T22:22:34.821Z,1572474154.821 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:22:35.698Z,1572474155.698 [DUSBL:C.](INFO): *** querying acoustic contact ***
2019-10-30T22:22:36.022Z,1572474156.022 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-10-30T22:22:36.022Z,1572474156.022 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-10-30T22:22:36.022Z,1572474156.022 [DUSBL_Hydroid](INFO): Arming DUSBL. detectThresh: 25
2019-10-30T22:22:36.023Z,1572474156.023 [DUSBL_Hydroid](INFO): ****** ping requested ******
2019-10-30T22:22:36.422Z,1572474156.422 [DUSBL_Hydroid](INFO): DUSBL response received:!U1,P
80,80,63,E4
2019-10-30T22:22:36.422Z,1572474156.422 [DUSBL_Hydroid](INFO): Command Ack
2019-10-30T22:22:36.423Z,1572474156.423 [DUSBL_Hydroid](INFO): Requesting micromodem ping code 2
2019-10-30T22:22:36.424Z,1572474156.424 [Micromodem](INFO): Nmea out: $CCPGT,0,10000,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,2000,4000,0*70

2019-10-30T22:22:36.833Z,1572474156.833 [Micromodem](INFO): Nmea in: $SNPGT,0,10000,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,2000,4000,0*6D

2019-10-30T22:22:37.643Z,1572474157.643 [Micromodem](INFO): Nmea in: $SNTTA,,0.194371,,,222237.42*4B

2019-10-30T22:22:38.053Z,1572474158.053 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:22:40.064Z,1572474160.064 [DUSBL_Hydroid](INFO): DUSBL response received:!U1,N,80,80,63,E4
2019-10-30T22:22:40.064Z,1572474160.064 [DUSBL_Hydroid](INFO): No reply:!U1,N,80,80,63,E4
2019-10-30T22:22:40.064Z,1572474160.064 [DUSBL_Hydroid](ERROR): No response from remote modem.
2019-10-30T22:22:40.881Z,1572474160.881 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:22:42.935Z,1572474162.935 [DUSBL:C.](INFO): *** querying acoustic contact ***
2019-10-30T22:22:43.298Z,1572474163.298 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-10-30T22:22:43.298Z,1572474163.298 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-10-30T22:22:43.298Z,1572474163.298 [DUSBL_Hydroid](INFO): Arming DUSBL. detectThresh: 25
2019-10-30T22:22:43.299Z,1572474163.299 [DUSBL_Hydroid](INFO): ****** ping requested ******
2019-10-30T22:22:43.708Z,1572474163.708 [DUSBL_Hydroid](INFO): DUSBL response received:!U1,P
80,80,63,E4
2019-10-30T22:22:43.708Z,1572474163.708 [DUSBL_Hydroid](INFO): Command Ack
2019-10-30T22:22:43.708Z,1572474163.708 [DUSBL_Hydroid](INFO): Requesting micromodem ping code 2
2019-10-30T22:22:43.710Z,1572474163.710 [Micromodem](INFO): Nmea out: $CCPGT,0,10000,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,2000,4000,0*70

2019-10-30T22:22:44.101Z,1572474164.101 [Micromodem](INFO): Nmea in: $SNPGT,0,10000,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,2000,4000,0*6D

2019-10-30T22:22:44.129Z,1572474164.129 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:22:44.917Z,1572474164.917 [Micromodem](INFO): Nmea in: $SNTTA,,,,,222244.71*58

2019-10-30T22:22:46.947Z,1572474166.947 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:22:47.330Z,1572474167.330 [DUSBL_Hydroid](INFO): DUSBL response received:!U1,N,80,80,63,E4
2019-10-30T22:22:47.331Z,1572474167.331 [DUSBL_Hydroid](INFO): No reply:!U1,N,80,80,63,E4
2019-10-30T22:22:47.331Z,1572474167.331 [DUSBL_Hydroid](ERROR): No response from remote modem.
2019-10-30T22:22:50.177Z,1572474170.177 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:22:50.211Z,1572474170.211 [DUSBL:C.](INFO): *** querying acoustic contact ***
2019-10-30T22:22:50.578Z,1572474170.578 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-10-30T22:22:50.578Z,1572474170.578 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-10-30T22:22:50.578Z,1572474170.578 [DUSBL_Hydroid](INFO): Arming DUSBL. detectThresh: 25
2019-10-30T22:22:50.579Z,1572474170.579 [DUSBL_Hydroid](INFO): ****** ping requested ******
2019-10-30T22:22:50.974Z,1572474170.974 [DUSBL_Hydroid](INFO): DUSBL response received:!U1,P
80,80,63,E4
2019-10-30T22:22:50.975Z,1572474170.975 [DUSBL_Hydroid](INFO): Command Ack
2019-10-30T22:22:50.975Z,1572474170.975 [DUSBL_Hydroid](INFO): Requesting micromodem ping code 2
2019-10-30T22:22:50.976Z,1572474170.976 [Micromodem](INFO): Nmea out: $CCPGT,0,10000,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,2000,4000,0*70

2019-10-30T22:22:51.389Z,1572474171.389 [Micromodem](INFO): Nmea in: $SNPGT,0,10000,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,2000,4000,0*6D

2019-10-30T22:22:52.186Z,1572474172.186 [Micromodem](INFO): Nmea in: $SNTTA,,,,,222251.97*54

2019-10-30T22:22:53.001Z,1572474173.001 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:22:54.622Z,1572474174.622 [DUSBL_Hydroid](INFO): DUSBL response received:!U1,N,80,80,63,E4
2019-10-30T22:22:54.623Z,1572474174.623 [DUSBL_Hydroid](INFO): No reply:!U1,N,80,80,63,E4
2019-10-30T22:22:54.623Z,1572474174.623 [DUSBL_Hydroid](ERROR): No response from remote modem.
2019-10-30T22:22:55.833Z,1572474175.833 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:22:57.477Z,1572474177.477 [DUSBL:C.](INFO): *** querying acoustic contact ***
2019-10-30T22:22:57.834Z,1572474177.834 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-10-30T22:22:57.834Z,1572474177.834 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-10-30T22:22:57.834Z,1572474177.834 [DUSBL_Hydroid](INFO): Arming DUSBL. detectThresh: 25
2019-10-30T22:22:57.835Z,1572474177.835 [DUSBL_Hydroid](INFO): ****** ping requested ******
2019-10-30T22:22:58.249Z,1572474178.249 [DUSBL_Hydroid](INFO): DUSBL response received:!U1,P
80,80,63,E4
2019-10-30T22:22:58.249Z,1572474178.249 [DUSBL_Hydroid](INFO): Command Ack
2019-10-30T22:22:58.249Z,1572474178.249 [DUSBL_Hydroid](INFO): Requesting micromodem ping code 2
2019-10-30T22:22:58.256Z,1572474178.256 [Micromodem](INFO): Nmea out: $CCPGT,0,10000,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,2000,4000,0*70

2019-10-30T22:22:58.645Z,1572474178.645 [Micromodem](INFO): Nmea in: $SNPGT,0,10000,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,2000,4000,0*6D

2019-10-30T22:22:59.065Z,1572474179.065 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:22:59.458Z,1572474179.458 [Micromodem](INFO): Nmea in: $SNTTA,,,,,222259.25*55

2019-10-30T22:23:01.878Z,1572474181.878 [DUSBL_Hydroid](INFO): DUSBL response received:!U1,N,80,80,63,E4
2019-10-30T22:23:01.879Z,1572474181.879 [DUSBL_Hydroid](INFO): No reply:!U1,N,80,80,63,E4
2019-10-30T22:23:01.879Z,1572474181.879 [DUSBL_Hydroid](ERROR): No response from remote modem.
2019-10-30T22:23:01.897Z,1572474181.897 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:23:04.742Z,1572474184.742 [DUSBL:C.](INFO): *** querying acoustic contact ***
2019-10-30T22:23:05.110Z,1572474185.110 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-10-30T22:23:05.110Z,1572474185.110 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-10-30T22:23:05.111Z,1572474185.111 [DUSBL_Hydroid](INFO): Arming DUSBL. detectThresh: 25
2019-10-30T22:23:05.111Z,1572474185.111 [DUSBL_Hydroid](INFO): ****** ping requested ******
2019-10-30T22:23:05.130Z,1572474185.130 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:23:05.511Z,1572474185.511 [DUSBL_Hydroid](INFO): DUSBL response received:!U1,P
80,80,63,E4
2019-10-30T22:23:05.511Z,1572474185.511 [DUSBL_Hydroid](INFO): Command Ack
2019-10-30T22:23:05.511Z,1572474185.511 [DUSBL_Hydroid](INFO): Requesting micromodem ping code 2
2019-10-30T22:23:05.513Z,1572474185.513 [Micromodem](INFO): Nmea out: $CCPGT,0,10000,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,2000,4000,0*70

2019-10-30T22:23:05.921Z,1572474185.921 [Micromodem](INFO): Nmea in: $SNPGT,0,10000,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,2000,4000,0*6D

2019-10-30T22:23:06.727Z,1572474186.727 [Micromodem](INFO): Nmea in: $SNTTA,,,,,222306.51*5D

2019-10-30T22:23:07.961Z,1572474187.961 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:23:09.150Z,1572474189.150 [DUSBL_Hydroid](INFO): DUSBL response received:!U1,N,80,80,63,E4
2019-10-30T22:23:09.150Z,1572474189.150 [DUSBL_Hydroid](INFO): No reply:!U1,N,80,80,63,E4
2019-10-30T22:23:09.151Z,1572474189.151 [DUSBL_Hydroid](ERROR): No response from remote modem.
2019-10-30T22:23:11.183Z,1572474191.183 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:23:12.025Z,1572474192.025 [DUSBL:C.](INFO): *** querying acoustic contact ***
2019-10-30T22:23:12.386Z,1572474192.386 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-10-30T22:23:12.386Z,1572474192.386 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-10-30T22:23:12.387Z,1572474192.387 [DUSBL_Hydroid](INFO): Arming DUSBL. detectThresh: 25
2019-10-30T22:23:12.387Z,1572474192.387 [DUSBL_Hydroid](INFO): ****** ping requested ******
2019-10-30T22:23:12.782Z,1572474192.782 [DUSBL_Hydroid](INFO): DUSBL response received:!U1,P
80,80,63,E4
2019-10-30T22:23:12.782Z,1572474192.782 [DUSBL_Hydroid](INFO): Command Ack
2019-10-30T22:23:12.783Z,1572474192.783 [DUSBL_Hydroid](INFO): Requesting micromodem ping code 2
2019-10-30T22:23:12.784Z,1572474192.784 [Micromodem](INFO): Nmea out: $CCPGT,0,10000,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,2000,4000,0*70

2019-10-30T22:23:13.193Z,1572474193.193 [Micromodem](INFO): Nmea in: $SNPGT,0,10000,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,2000,4000,0*6D

2019-10-30T22:23:14.003Z,1572474194.003 [Micromodem](INFO): Nmea in: $SNTTA,,,,,222313.78*52

2019-10-30T22:23:14.017Z,1572474194.017 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:23:16.418Z,1572474196.418 [DUSBL_Hydroid](INFO): DUSBL response received:!U1,N,80,80,63,E4
2019-10-30T22:23:16.419Z,1572474196.419 [DUSBL_Hydroid](INFO): No reply:!U1,N,80,80,63,E4
2019-10-30T22:23:16.419Z,1572474196.419 [DUSBL_Hydroid](ERROR): No response from remote modem.
2019-10-30T22:23:16.841Z,1572474196.841 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:23:19.316Z,1572474199.316 [DUSBL:C.](INFO): *** querying acoustic contact ***
2019-10-30T22:23:19.654Z,1572474199.654 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-10-30T22:23:19.654Z,1572474199.654 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-10-30T22:23:19.654Z,1572474199.654 [DUSBL_Hydroid](INFO): Arming DUSBL. detectThresh: 25
2019-10-30T22:23:19.655Z,1572474199.655 [DUSBL_Hydroid](INFO): ****** ping requested ******
2019-10-30T22:23:20.054Z,1572474200.054 [DUSBL_Hydroid](INFO): DUSBL response received:!U1,P
80,80,63,E4
2019-10-30T22:23:20.054Z,1572474200.054 [DUSBL_Hydroid](INFO): Command Ack
2019-10-30T22:23:20.055Z,1572474200.055 [DUSBL_Hydroid](INFO): Requesting micromodem ping code 2
2019-10-30T22:23:20.056Z,1572474200.056 [Micromodem](INFO): Nmea out: $CCPGT,0,10000,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,2000,4000,0*70

2019-10-30T22:23:20.073Z,1572474200.073 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:23:20.465Z,1572474200.465 [Micromodem](INFO): Nmea in: $SNPGT,0,10000,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,2000,4000,0*6D

2019-10-30T22:23:21.291Z,1572474201.291 [Micromodem](INFO): Nmea in: $SNTTA,0.414958,,,0.489521,222321.05*5F

2019-10-30T22:23:22.897Z,1572474202.897 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:23:23.694Z,1572474203.694 [DUSBL_Hydroid](INFO): DUSBL response received:!U1,N,80,80,63,E4
2019-10-30T22:23:23.694Z,1572474203.694 [DUSBL_Hydroid](INFO): No reply:!U1,N,80,80,63,E4
2019-10-30T22:23:23.695Z,1572474203.695 [DUSBL_Hydroid](ERROR): No response from remote modem.
2019-10-30T22:23:26.133Z,1572474206.133 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:23:26.572Z,1572474206.572 [DUSBL:C.](INFO): *** querying acoustic contact ***
2019-10-30T22:23:26.938Z,1572474206.938 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-10-30T22:23:26.938Z,1572474206.938 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-10-30T22:23:26.938Z,1572474206.938 [DUSBL_Hydroid](INFO): Arming DUSBL. detectThresh: 25
2019-10-30T22:23:26.939Z,1572474206.939 [DUSBL_Hydroid](INFO): ****** ping requested ******
2019-10-30T22:23:27.334Z,1572474207.334 [DUSBL_Hydroid](INFO): DUSBL response received:!U1,P
80,80,63,E4
2019-10-30T22:23:27.334Z,1572474207.334 [DUSBL_Hydroid](INFO): Command Ack
2019-10-30T22:23:27.334Z,1572474207.334 [DUSBL_Hydroid](INFO): Requesting micromodem ping code 2
2019-10-30T22:23:27.336Z,1572474207.336 [Micromodem](INFO): Nmea out: $CCPGT,0,10000,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,2000,4000,0*70

2019-10-30T22:23:27.737Z,1572474207.737 [Micromodem](INFO): Nmea in: $SNPGT,0,10000,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,2000,4000,0*6D

2019-10-30T22:23:28.559Z,1572474208.559 [Micromodem](INFO): Nmea in: $SNTTA,,,,,222328.33*55

2019-10-30T22:23:28.965Z,1572474208.965 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:23:30.962Z,1572474210.962 [DUSBL_Hydroid](INFO): DUSBL response received:!U1,N,80,80,63,E4
2019-10-30T22:23:30.963Z,1572474210.963 [DUSBL_Hydroid](INFO): No reply:!U1,N,80,80,63,E4
2019-10-30T22:23:30.963Z,1572474210.963 [DUSBL_Hydroid](ERROR): No response from remote modem.
2019-10-30T22:23:32.189Z,1572474212.189 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:23:33.833Z,1572474213.833 [DUSBL:C.](INFO): *** querying acoustic contact ***
2019-10-30T22:23:34.198Z,1572474214.198 [DUSBL_Hydroid](INFO): ****** received transponder code query ******
2019-10-30T22:23:34.198Z,1572474214.198 [DUSBL_Hydroid](INFO): ****** received ping request ******
2019-10-30T22:23:34.198Z,1572474214.198 [DUSBL_Hydroid](INFO): Arming DUSBL. detectThresh: 25
2019-10-30T22:23:34.199Z,1572474214.199 [DUSBL_Hydroid](INFO): ****** ping requested ******
2019-10-30T22:23:34.617Z,1572474214.617 [DUSBL_Hydroid](INFO): DUSBL response received:!U1,P
80,80,63,E4
2019-10-30T22:23:34.617Z,1572474214.617 [DUSBL_Hydroid](INFO): Command Ack
2019-10-30T22:23:34.618Z,1572474214.618 [DUSBL_Hydroid](INFO): Requesting micromodem ping code 2
2019-10-30T22:23:34.625Z,1572474214.625 [Micromodem](INFO): Nmea out: $CCPGT,0,10000,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,2000,4000,0*70

2019-10-30T22:23:35.013Z,1572474215.013 [Micromodem](INFO): Nmea in: $SNPGT,0,10000,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,2000,4000,0*6D

2019-10-30T22:23:35.053Z,1572474215.053 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:23:35.820Z,1572474215.820 [Micromodem](INFO): Nmea in: $SNTTA,,,,,222335.62*5D

2019-10-30T22:23:36.073Z,1572474216.073 [CommandLine](IMPORTANT): got command stop
2019-10-30T22:23:36.074Z,1572474216.074 [CommandLine](IMPORTANT): Scheduling is paused
2019-10-30T22:23:36.074Z,1572474216.074 [Supervisor](INFO): Stop Mission called by CommandLine::commandStop
2019-10-30T22:23:36.244Z,1572474216.244 [MissionManager](INFO): MissionManager is completed.
2019-10-30T22:23:36.244Z,1572474216.244 [MissionManager](INFO): Uninitializing Mission DUSBL
2019-10-30T22:23:36.244Z,1572474216.244 [DUSBL] Stopped
2019-10-30T22:23:36.244Z,1572474216.244 [DUSBL](DEBUG): Aggregate::uninitialize DUSBL
2019-10-30T22:23:36.244Z,1572474216.244 [DUSBL:A.Pitch] Stopped
2019-10-30T22:23:36.245Z,1572474216.245 [DUSBL:B.SetSpeed] Stopped
2019-10-30T22:23:36.245Z,1572474216.245 [DUSBL:B.SetSpeed](DEBUG): Uninitialize.
2019-10-30T22:23:36.245Z,1572474216.245 [DUSBL:C.] Stopped
2019-10-30T22:23:36.245Z,1572474216.245 [DUSBL:RequestRepeater] Stopped
2019-10-30T22:23:36.245Z,1572474216.245 [DUSBL:RequestRepeater](DEBUG): Aggregate::uninitialize DUSBL:RequestRepeater
2019-10-30T22:23:36.245Z,1572474216.245 [DUSBL:RequestRepeater:A.Wait] Stopped
2019-10-30T22:23:36.245Z,1572474216.245 [DUSBL:RequestRepeater:A.Wait](DEBUG): Uninitialize Wait Component.
2019-10-30T22:23:36.679Z,1572474216.679 [MissionManager](IMPORTANT): Started mission Default
2019-10-30T22:23:36.679Z,1572474216.679 [Default] Running Loop=1
2019-10-30T22:23:36.679Z,1572474216.679 [Default](DEBUG): Aggregate::initialize Default
2019-10-30T22:23:36.679Z,1572474216.679 [Default:B.GoToSurface] Running Loop=1
2019-10-30T22:23:36.679Z,1572474216.679 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2019-10-30T22:23:36.680Z,1572474216.680 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2019-10-30T22:23:36.680Z,1572474216.680 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2019-10-30T22:23:36.680Z,1572474216.680 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2019-10-30T22:23:36.685Z,1572474216.685 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2019-10-30T22:23:36.685Z,1572474216.685 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2019-10-30T22:23:36.686Z,1572474216.686 [Default:A.Wait] Running Loop=1
2019-10-30T22:23:36.686Z,1572474216.686 [Default:A.Wait](DEBUG): Initialize Wait Component.
2019-10-30T22:23:37.849Z,1572474217.849 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:23:41.089Z,1572474221.089 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:23:43.909Z,1572474223.909 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:23:47.145Z,1572474227.145 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:23:49.965Z,1572474229.965 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:23:50.003Z,1572474230.003 [Default:A.Wait](INFO): Done Waiting.
2019-10-30T22:23:50.003Z,1572474230.003 [Default:A.Wait] Stopped
2019-10-30T22:23:50.003Z,1572474230.003 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2019-10-30T22:23:50.435Z,1572474230.434 [Default:CheckIn] Running Loop=1
2019-10-30T22:23:50.435Z,1572474230.435 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2019-10-30T22:23:50.435Z,1572474230.435 [Default:CheckIn:Read_GPS] Running Loop=1
2019-10-30T22:23:52.797Z,1572474232.797 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:23:54.813Z,1572474234.813 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:23:56.841Z,1572474236.841 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:23:58.857Z,1572474238.857 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:24:02.089Z,1572474242.089 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:24:04.933Z,1572474244.933 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:24:08.149Z,1572474248.149 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:24:10.977Z,1572474250.977 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:24:13.805Z,1572474253.805 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:24:15.829Z,1572474255.829 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:24:19.057Z,1572474259.057 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:24:21.885Z,1572474261.885 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:24:25.115Z,1572474265.115 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:24:27.945Z,1572474267.945 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:24:31.177Z,1572474271.177 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:24:34.005Z,1572474274.005 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:24:34.402Z,1572474274.402 [NAL9602](FAULT): GPS failed to acquire within timeout.
2019-10-30T22:24:34.402Z,1572474274.402 [NAL9602] Data Fault, FailCount= 3
2019-10-30T22:24:34.402Z,1572474274.402 [NAL9602](ERROR): Data Fault
2019-10-30T22:24:34.439Z,1572474274.439 [CBIT](ERROR): Data Fault in component: NAL9602
2019-10-30T22:24:34.795Z,1572474274.795 [NAL9602](INFO): Powering down
2019-10-30T22:24:35.679Z,1572474275.679 [CBIT](INFO): Clearing failed state for component NAL9602
2019-10-30T22:24:35.679Z,1572474275.679 [NAL9602] No Fault, FailCount= 3
2019-10-30T22:25:05.101Z,1572474305.101 [NAL9602](INFO): Powering up NAL9602
2019-10-30T22:25:12.410Z,1572474312.410 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 42
2019-10-30T22:25:12.410Z,1572474312.410 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-10-30T22:25:12.424Z,1572474312.424 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-10-30T22:25:12.833Z,1572474312.833 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-10-30T22:25:12.833Z,1572474312.833 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 42
2019-10-30T22:25:16.005Z,1572474316.005 [NAL9602](INFO): NAL9602 initialized
2019-10-30T22:25:19.657Z,1572474319.657 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:25:22.485Z,1572474322.485 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:25:25.713Z,1572474325.713 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:25:28.545Z,1572474328.545 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:25:31.777Z,1572474331.777 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:25:34.605Z,1572474334.605 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:25:37.433Z,1572474337.433 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:25:40.661Z,1572474340.661 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:25:43.497Z,1572474343.497 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:25:46.725Z,1572474346.725 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:25:49.557Z,1572474349.557 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:25:52.789Z,1572474352.789 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:25:55.625Z,1572474355.625 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:25:58.437Z,1572474358.437 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:26:01.673Z,1572474361.673 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:26:04.512Z,1572474364.512 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:26:07.740Z,1572474367.740 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:26:10.565Z,1572474370.565 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:26:13.805Z,1572474373.805 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:26:16.625Z,1572474376.625 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:26:19.469Z,1572474379.469 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:26:22.677Z,1572474382.677 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:26:25.513Z,1572474385.513 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:26:28.753Z,1572474388.753 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:26:31.577Z,1572474391.577 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:26:34.397Z,1572474394.397 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:26:36.434Z,1572474396.434 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:26:37.639Z,1572474397.639 [RDI_Pathfinder](ERROR): only read 3 of 4 data items
2019-10-30T22:26:37.639Z,1572474397.639 [RDI_Pathfinder](ERROR): Failed to parse:
:RA,  0.00,   0.00,   0.00,   0.00
2019-10-30T22:26:38.441Z,1572474398.441 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:26:41.681Z,1572474401.681 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:26:44.497Z,1572474404.497 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:26:47.729Z,1572474407.729 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:26:50.557Z,1572474410.557 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:26:53.793Z,1572474413.793 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:26:56.621Z,1572474416.621 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:26:59.445Z,1572474419.445 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:27:02.681Z,1572474422.681 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:27:05.509Z,1572474425.509 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:27:08.733Z,1572474428.733 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:27:11.565Z,1572474431.565 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:27:14.793Z,1572474434.793 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:27:17.625Z,1572474437.625 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:27:20.451Z,1572474440.451 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:27:23.685Z,1572474443.685 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:27:26.517Z,1572474446.517 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:27:29.745Z,1572474449.745 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:27:32.569Z,1572474452.569 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:27:35.405Z,1572474455.405 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:27:37.425Z,1572474457.425 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:27:39.445Z,1572474459.445 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:27:42.673Z,1572474462.673 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:27:45.505Z,1572474465.505 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:27:48.733Z,1572474468.733 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:27:51.561Z,1572474471.561 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:27:54.389Z,1572474474.389 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:27:56.409Z,1572474476.409 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:27:58.433Z,1572474478.433 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:28:01.661Z,1572474481.661 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:28:04.489Z,1572474484.489 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:28:07.721Z,1572474487.721 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:28:10.549Z,1572474490.549 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:28:13.400Z,1572474493.400 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 43
2019-10-30T22:28:13.400Z,1572474493.400 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-10-30T22:28:13.420Z,1572474493.420 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-10-30T22:28:13.777Z,1572474493.777 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:28:13.846Z,1572474493.846 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-10-30T22:28:13.846Z,1572474493.846 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 43
2019-10-30T22:28:16.613Z,1572474496.613 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:28:19.437Z,1572474499.437 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:28:22.669Z,1572474502.669 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:28:25.497Z,1572474505.497 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:28:28.729Z,1572474508.729 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:28:31.553Z,1572474511.553 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:28:34.785Z,1572474514.785 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:28:35.639Z,1572474515.639 [RDI_Pathfinder](ERROR): only read 2 of 4 data items
2019-10-30T22:28:35.639Z,1572474515.639 [RDI_Pathfinder](ERROR): Failed to parse:
:BS,-32768,-3268,V
2019-10-30T22:28:37.617Z,1572474517.617 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:28:40.445Z,1572474520.445 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:28:43.677Z,1572474523.677 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:28:46.509Z,1572474526.509 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:28:49.737Z,1572474529.737 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:28:50.585Z,1572474530.585 [Default:CheckIn:Read_GPS](INFO): Timed out from 2019-10-30T22:23:50.4Z
2019-10-30T22:28:50.585Z,1572474530.585 [Default:CheckIn:Read_GPS] Stopped
2019-10-30T22:28:50.585Z,1572474530.585 [Default:CheckIn:Read_Iridium] Running Loop=1
2019-10-30T22:28:52.575Z,1572474532.575 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:28:54.643Z,1572474534.643 [RDI_Pathfinder](ERROR): only read 3 of 4 data items
2019-10-30T22:28:54.644Z,1572474534.644 [RDI_Pathfinder](ERROR): Failed to parse:
:RA,  0.00,   0.00,   0.00,   0.00
2019-10-30T22:28:55.413Z,1572474535.413 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:28:57.413Z,1572474537.413 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:28:59.429Z,1572474539.429 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:29:02.665Z,1572474542.665 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:29:04.356Z,1572474544.356 [DataOverHttps](INFO): Sending 119 bytes from file Logs/20191030T171632/Express0089.lzma
2019-10-30T22:29:05.493Z,1572474545.493 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:29:06.363Z,1572474546.363 [DataOverHttps](INFO): Moved sent file to Logs/20191030T171632/Express0089.lzma.bak
2019-10-30T22:29:06.363Z,1572474546.363 [DataOverHttps](INFO): SBD MOMSN=11963215
2019-10-30T22:29:08.733Z,1572474548.733 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:29:11.561Z,1572474551.561 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:29:14.781Z,1572474554.781 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:29:17.617Z,1572474557.617 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:29:20.441Z,1572474560.441 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:29:23.673Z,1572474563.673 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:29:26.497Z,1572474566.497 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:29:29.737Z,1572474569.737 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:29:32.573Z,1572474572.573 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:29:35.793Z,1572474575.793 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:29:36.365Z,1572474576.365 [DataOverHttps](INFO): Sending 465 bytes from file Logs/20191030T222149/Express0001.lzma
2019-10-30T22:29:38.370Z,1572474578.370 [DataOverHttps](INFO): Moved sent file to Logs/20191030T222149/Express0001.lzma.bak
2019-10-30T22:29:38.371Z,1572474578.371 [DataOverHttps](INFO): SBD MOMSN=11963218
2019-10-30T22:29:38.617Z,1572474578.617 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:29:41.449Z,1572474581.449 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:29:44.689Z,1572474584.689 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:29:47.521Z,1572474587.521 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:29:50.745Z,1572474590.745 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:29:53.565Z,1572474593.565 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:29:56.801Z,1572474596.801 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:29:59.629Z,1572474599.629 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:30:01.488Z,1572474601.488 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20191030T222149/Express0004.lzma
2019-10-30T22:30:02.457Z,1572474602.457 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:30:03.502Z,1572474603.502 [DataOverHttps](INFO): Moved sent file to Logs/20191030T222149/Express0004.lzma.bak
2019-10-30T22:30:03.502Z,1572474603.502 [DataOverHttps](INFO): SBD MOMSN=11963233
2019-10-30T22:30:05.693Z,1572474605.693 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:30:08.517Z,1572474608.517 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:30:10.974Z,1572474610.974 [Default:CheckIn:Read_Iridium] Stopped
2019-10-30T22:30:10.974Z,1572474610.974 [Default:CheckIn:C.Wait] Running Loop=1
2019-10-30T22:30:10.974Z,1572474610.974 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2019-10-30T22:30:11.749Z,1572474611.749 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:30:14.593Z,1572474614.593 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:30:17.409Z,1572474617.409 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:30:19.425Z,1572474619.425 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:30:21.445Z,1572474621.445 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:30:24.681Z,1572474624.681 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:30:27.505Z,1572474627.505 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:30:30.737Z,1572474630.737 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:30:33.577Z,1572474633.577 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:30:36.389Z,1572474636.389 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:30:38.421Z,1572474638.421 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:30:40.437Z,1572474640.437 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:30:42.449Z,1572474642.449 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:30:45.684Z,1572474645.684 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:30:48.513Z,1572474648.513 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:30:51.745Z,1572474651.745 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:30:54.577Z,1572474654.577 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:30:57.412Z,1572474657.412 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:30:59.421Z,1572474659.421 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:31:01.445Z,1572474661.445 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:31:04.677Z,1572474664.677 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:31:07.505Z,1572474667.505 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:31:10.737Z,1572474670.737 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:31:13.573Z,1572474673.573 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:31:14.410Z,1572474674.410 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 44
2019-10-30T22:31:14.410Z,1572474674.410 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-10-30T22:31:14.419Z,1572474674.419 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-10-30T22:31:14.810Z,1572474674.810 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-10-30T22:31:14.810Z,1572474674.810 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 44
2019-10-30T22:31:16.389Z,1572474676.389 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:31:18.409Z,1572474678.409 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:31:20.436Z,1572474680.436 [RDI_Pathfinder](ERROR): Failed to parse:
:BE,-32768,-32768,-32768,V
2019-10-30T22:31:21.653Z,1572474681.653 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:31:24.469Z,1572474684.469 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:31:27.701Z,1572474687.701 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:31:30.529Z,1572474690.529 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:31:33.765Z,1572474693.765 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:31:33.881Z,1572474693.881 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2019-10-30T22:31:36.593Z,1572474696.593 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:31:36.893Z,1572474696.893 [DataOverHttps](INFO): setting unavailable, lastComms_.elapsed()=60.247658
2019-10-30T22:31:39.417Z,1572474699.417 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:31:41.433Z,1572474701.433 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:31:44.673Z,1572474704.673 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:31:47.497Z,1572474707.497 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:31:50.733Z,1572474710.733 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:31:53.557Z,1572474713.557 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:31:56.793Z,1572474716.793 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:31:59.617Z,1572474719.617 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:32:02.445Z,1572474722.445 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:32:05.677Z,1572474725.677 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:32:08.513Z,1572474728.513 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:32:09.022Z,1572474729.022 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2019-10-30T22:32:11.735Z,1572474731.735 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:32:14.565Z,1572474734.565 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:32:17.797Z,1572474737.797 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:32:20.621Z,1572474740.621 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:32:23.464Z,1572474743.464 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:32:25.489Z,1572474745.489 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:32:28.705Z,1572474748.705 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:32:31.533Z,1572474751.533 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:32:34.761Z,1572474754.761 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:32:36.380Z,1572474756.380 [RDI_Pathfinder](ERROR): Failed to parse:
:BE,-32768,-32768,-32768,V
2019-10-30T22:32:37.593Z,1572474757.593 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:32:40.825Z,1572474760.825 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:32:43.657Z,1572474763.657 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:32:43.722Z,1572474763.722 [DataOverHttps](IMPORTANT): SBD MTMSN=20191030T223138
2019-10-30T22:32:43.727Z,1572474763.727 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004193
2019-10-30T22:32:46.889Z,1572474766.889 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:32:49.713Z,1572474769.713 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:32:51.308Z,1572474771.308 [DataOverHttps](INFO): Received command:restart app
2019-10-30T22:32:51.357Z,1572474771.357 [CommandLine](IMPORTANT): got command restart application
2019-10-30T22:32:52.361Z,1572474772.361 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2019-10-30T22:32:52.361Z,1572474772.361 [CommandLine ThreadHandler](INFO): Thread cancelled.
2019-10-30T22:32:52.389Z,1572474772.389 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup.  Bye!
2019-10-30T22:32:52.389Z,1572474772.389 [CommandLine ThreadHandler](INFO): Thread cancelled.
2019-10-30T22:32:52.390Z,1572474772.390 [CommandLine](INFO): Join timeout helper Thread ID is 2813
2019-10-30T22:32:52.397Z,1572474772.397 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2019-10-30T22:32:52.397Z,1572474772.397 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2019-10-30T22:32:52.398Z,1572474772.398 [NavChartDb](INFO): Join timeout helper Thread ID is 2814
2019-10-30T22:32:52.489Z,1572474772.489 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2019-10-30T22:32:52.489Z,1572474772.489 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2019-10-30T22:32:52.497Z,1572474772.497 [ComponentRegistry](INFO): Shutting down WetLabsSeaOWL_UV_A ThreadHandler
2019-10-30T22:32:52.497Z,1572474772.497 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Thread cancelled.
2019-10-30T22:32:52.497Z,1572474772.497 [WetLabsSeaOWL_UV_A](INFO): Join timeout helper Thread ID is 2815
2019-10-30T22:32:52.881Z,1572474772.881 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Uninitializing protected caller thread.
2019-10-30T22:32:52.881Z,1572474772.881 [WetLabsSeaOWL_UV_A](INFO): Powering down
2019-10-30T22:32:52.882Z,1572474772.882 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Thread cancelled.
2019-10-30T22:32:52.893Z,1572474772.893 [ComponentRegistry](INFO): Shutting down CTD_NeilBrown ThreadHandler
2019-10-30T22:32:52.893Z,1572474772.893 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled.
2019-10-30T22:32:52.893Z,1572474772.893 [CTD_NeilBrown](INFO): Join timeout helper Thread ID is 2816
2019-10-30T22:32:52.929Z,1572474772.929 [CTD_NeilBrown ThreadHandler](INFO): Uninitializing protected caller thread.
2019-10-30T22:32:52.930Z,1572474772.930 [CTD_NeilBrown](INFO): Powering down
2019-10-30T22:32:52.941Z,1572474772.941 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled.
2019-10-30T22:32:52.941Z,1572474772.941 [NAL9602](DEBUG): Fix Requested
2019-10-30T22:32:52.946Z,1572474772.946 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2019-10-30T22:32:52.946Z,1572474772.946 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2019-10-30T22:32:52.946Z,1572474772.946 [Radio_Surface](INFO): Join timeout helper Thread ID is 2817
2019-10-30T22:32:53.253Z,1572474773.253 [Radio_Surface](INFO): Powering down
2019-10-30T22:32:53.254Z,1572474773.254 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2019-10-30T22:32:53.254Z,1572474773.254 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2019-10-30T22:32:53.266Z,1572474773.266 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler
2019-10-30T22:32:53.266Z,1572474773.266 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2019-10-30T22:32:53.266Z,1572474773.266 [DataOverHttps](INFO): Join timeout helper Thread ID is 2818
2019-10-30T22:32:53.313Z,1572474773.313 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread.
2019-10-30T22:32:53.317Z,1572474773.317 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2019-10-30T22:32:53.338Z,1572474773.338 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2019-10-30T22:32:53.338Z,1572474773.338 [logger ThreadHandler](INFO): Thread cancelled.
2019-10-30T22:32:53.339Z,1572474773.339 [logger](INFO): Join timeout helper Thread ID is 2819
2019-10-30T22:32:53.355Z,1572474773.355 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2019-10-30T22:32:53.355Z,1572474773.355 [logger ThreadHandler](INFO): Thread cancelled.
2019-10-30T22:32:53.362Z,1572474773.362 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2019-10-30T22:32:53.362Z,1572474773.362 [CommandLine ThreadHandler](INFO): Thread cancelled.
2019-10-30T22:32:53.363Z,1572474773.363 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2019-10-30T22:32:53.363Z,1572474773.363 [controlThread ThreadHandler](INFO): Thread cancelled.
2019-10-30T22:32:53.363Z,1572474773.363 [controlThread](INFO): Join timeout helper Thread ID is 2820
2019-10-30T22:32:53.394Z,1572474773.394 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2019-10-30T22:32:53.394Z,1572474773.394 [controlThread](DEBUG): Uninitializing ControlThread
2019-10-30T22:32:53.395Z,1572474773.395 [AHRS_M2](INFO): Powering down
2019-10-30T22:32:53.465Z,1572474773.465 [DUSBL_Hydroid](INFO): Powering down
2019-10-30T22:32:53.537Z,1572474773.537 [Micromodem](INFO): Powering down
2019-10-30T22:32:53.633Z,1572474773.633 [NAL9602](INFO): Powering down
2019-10-30T22:32:53.705Z,1572474773.705 [RDI_Pathfinder](INFO): Powering down
2019-10-30T22:32:53.706Z,1572474773.706 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2019-10-30T22:32:53.707Z,1572474773.707 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2019-10-30T22:32:53.708Z,1572474773.708 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2019-10-30T22:32:53.708Z,1572474773.708 [MissionManager](INFO): Uninitializing Mission Default
2019-10-30T22:32:53.708Z,1572474773.708 [Default] Stopped
2019-10-30T22:32:53.708Z,1572474773.708 [Default](DEBUG): Aggregate::uninitialize Default
2019-10-30T22:32:53.709Z,1572474773.709 [Default:B.GoToSurface] Stopped
2019-10-30T22:32:53.709Z,1572474773.709 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2019-10-30T22:32:53.709Z,1572474773.709 [Default:CheckIn] Stopped
2019-10-30T22:32:53.709Z,1572474773.709 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2019-10-30T22:32:53.709Z,1572474773.709 [Default:CheckIn:C.Wait] Stopped
2019-10-30T22:32:53.709Z,1572474773.709 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2019-10-30T22:32:53.711Z,1572474773.711 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2019-10-30T22:32:53.712Z,1572474773.712 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2019-10-30T22:32:53.712Z,1572474773.712 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2019-10-30T22:32:53.712Z,1572474773.712 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2019-10-30T22:32:53.712Z,1572474773.712 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2019-10-30T22:32:53.712Z,1572474773.712 [BuoyancyServo](INFO): Powering down
2019-10-30T22:32:53.725Z,1572474773.725 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2019-10-30T22:32:53.725Z,1572474773.725 [ElevatorServo](INFO): Powering down
2019-10-30T22:32:53.726Z,1572474773.726 [MassServo](DEBUG): Uninitialize Mass Servo.
2019-10-30T22:32:53.726Z,1572474773.726 [MassServo](INFO): Powering down
2019-10-30T22:32:53.727Z,1572474773.727 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2019-10-30T22:32:53.727Z,1572474773.727 [RudderServo](INFO): Powering down
2019-10-30T22:32:53.728Z,1572474773.728 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2019-10-30T22:32:53.728Z,1572474773.728 [ThrusterServo](INFO): Powering down
2019-10-30T22:32:53.728Z,1572474773.728 [SBIT](DEBUG): Uninitialize SBIT Component.
2019-10-30T22:32:53.729Z,1572474773.729 [IBIT](DEBUG): Uninitialize IBIT Component.
2019-10-30T22:32:53.729Z,1572474773.729 [CBIT](DEBUG): Uninitialize CBIT Component.
2019-10-30T22:32:53.729Z,1572474773.729 [CBIT](DEBUG): Powering off loads.
2019-10-30T22:32:53.741Z,1572474773.741 [CBIT](DEBUG): Disabling WDT.
2019-10-30T22:32:53.753Z,1572474773.753 [CBIT](DEBUG): Opening all GF detection circuits.
2019-10-30T22:32:53.754Z,1572474773.754 [controlThread ThreadHandler](INFO): Thread cancelled.
2019-10-30T22:32:53.798Z,1572474773.798 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2019-10-30T22:32:53.807Z,1572474773.807 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2019-10-30T22:32:53.855Z,1572474773.855 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Thread cancelled.
2019-10-30T22:32:53.858Z,1572474773.858 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled.
2019-10-30T22:32:53.913Z,1572474773.913 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2019-10-30T22:32:53.969Z,1572474773.969 [logger ThreadHandler](INFO): Thread cancelled.