2025-02-21T04:51:25.438Z,1740113485.438 [CommandExec](IMPORTANT): got command set sci2_slowyo_test.Speed SpeedControl.rollOptimum
2025-02-21T04:51:25.440Z,1740113485.441 [CommandExec](IMPORTANT): got command restart logs
2025-02-21T04:52:14.226Z,1740113534.226 [CommandExec](IMPORTANT): got command set sci2_slowyo_test.SlowYoDiveAngle 10 degree
2025-02-21T04:52:14.227Z,1740113534.227 [CommandExec](IMPORTANT): got command set sci2_slowyo_test.Speed SpeedControl.rollOptimum
2025-02-21T04:52:14.232Z,1740113534.232 [CommandExec](IMPORTANT): got command set sci2_slowyo_test.SlowYoMaxDepth 150 meter
2025-02-21T04:52:14.232Z,1740113534.232 [CommandExec](IMPORTANT): got command set sci2_slowyo_test.SlowYoTurningWindow 30 meter
2025-02-21T04:52:14.233Z,1740113534.233 [CommandExec](IMPORTANT): got command set sci2_slowyo_test.MassDefault 
2025-02-21T04:52:14.233Z,1740113534.233 [CommandExec](FAULT): Incomplete syntax. Try: help set
2025-02-21T04:52:37.032Z,1740113557.032 [CommandExec](IMPORTANT): got command set sci2_slowyo_test.MinAltitude 20 meter
2025-02-21T04:52:37.032Z,1740113557.032 [CommandExec](IMPORTANT): got command set sci2_slowyo_test.MaxDepth 190 meter
2025-02-21T04:52:37.033Z,1740113557.033 [CommandExec](IMPORTANT): got command set sci2_slowyo_test:BackseatDriver.EnableBackseat 1 bool
2025-02-21T04:52:37.034Z,1740113557.034 [CommandExec](IMPORTANT): got command run
2025-02-21T04:52:37.112Z,1740113557.112 [Default] Stopped
2025-02-21T04:52:37.112Z,1740113557.112 [Default](DEBUG): Aggregate::uninitialize Default
2025-02-21T04:52:37.112Z,1740113557.112 [Default:B.GoToSurface] Stopped
2025-02-21T04:52:37.112Z,1740113557.112 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2025-02-21T04:52:37.112Z,1740113557.112 [Default:CheckIn] Stopped
2025-02-21T04:52:37.113Z,1740113557.113 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-02-21T04:52:37.113Z,1740113557.113 [Default:CheckIn:C.Wait] Stopped
2025-02-21T04:52:37.113Z,1740113557.113 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-02-21T04:52:37.113Z,1740113557.113 [MissionManager](IMPORTANT): Started mission sci2_slowyo_test
2025-02-21T04:52:37.113Z,1740113557.113 [sci2_slowyo_test] Running Loop=1
2025-02-21T04:52:37.113Z,1740113557.113 [sci2_slowyo_test](DEBUG): Aggregate::initialize sci2_slowyo_test
2025-02-21T04:52:37.113Z,1740113557.113 [sci2_slowyo_test:Science] Running Loop=1
2025-02-21T04:52:37.113Z,1740113557.113 [sci2_slowyo_test:Science](DEBUG): Aggregate::initialize sci2_slowyo_test:Science
2025-02-21T04:52:37.114Z,1740113557.114 [sci2_slowyo_test:Science:A] Running Loop=1
2025-02-21T04:52:37.114Z,1740113557.114 [sci2_slowyo_test:Science:B] Running Loop=1
2025-02-21T04:52:37.114Z,1740113557.114 [sci2_slowyo_test:Science:C] Running Loop=1
2025-02-21T04:52:37.114Z,1740113557.114 [sci2_slowyo_test:Science:D] Running Loop=1
2025-02-21T04:52:37.114Z,1740113557.114 [sci2_slowyo_test:Science:E] Running Loop=1
2025-02-21T04:52:37.114Z,1740113557.114 [sci2_slowyo_test:Science:F] Running Loop=1
2025-02-21T04:52:37.114Z,1740113557.114 [sci2_slowyo_test:Science:Read_Oil] Running Loop=1
2025-02-21T04:52:37.114Z,1740113557.114 [sci2_slowyo_test:Science:PeakDetectChl] Running Loop=1
2025-02-21T04:52:37.114Z,1740113557.114 [sci2_slowyo_test:Science:PeakDetectChl](DEBUG): Aggregate::initialize sci2_slowyo_test:Science:PeakDetectChl
2025-02-21T04:52:37.114Z,1740113557.114 [sci2_slowyo_test:Science:PeakDetectChl:A] Running Loop=1
2025-02-21T04:52:37.114Z,1740113557.114 [sci2_slowyo_test:Science:EdgeDetectChl] Running Loop=1
2025-02-21T04:52:37.114Z,1740113557.114 [sci2_slowyo_test:Science:EdgeDetectChl](DEBUG): Aggregate::initialize sci2_slowyo_test:Science:EdgeDetectChl
2025-02-21T04:52:37.114Z,1740113557.114 [sci2_slowyo_test:Science:EdgeDetectChl:A] Running Loop=1
2025-02-21T04:52:37.115Z,1740113557.115 [sci2_slowyo_test:Science:HighestChlPeakReport] Running Loop=1
2025-02-21T04:52:37.115Z,1740113557.115 [sci2_slowyo_test:Science:HighestChlPeakReport](DEBUG): Aggregate::initialize sci2_slowyo_test:Science:HighestChlPeakReport
2025-02-21T04:52:37.115Z,1740113557.115 [sci2_slowyo_test:Science:HighestChlPeakReport:A.PeakDetectHorizontal] Running Loop=1
2025-02-21T04:52:37.115Z,1740113557.115 [sci2_slowyo_test:Science:HighestChlPeakReport:A.PeakDetectHorizontal](INFO): Initialize.
2025-02-21T04:52:37.115Z,1740113557.115 [sci2_slowyo_test:Science:PeakDetectNO3] Running Loop=1
2025-02-21T04:52:37.116Z,1740113557.116 [sci2_slowyo_test:Science:PeakDetectNO3](DEBUG): Aggregate::initialize sci2_slowyo_test:Science:PeakDetectNO3
2025-02-21T04:52:37.116Z,1740113557.116 [sci2_slowyo_test:Science:PeakDetectNO3:A] Running Loop=1
2025-02-21T04:52:37.116Z,1740113557.116 [sci2_slowyo_test:Science:PeakDetectOil] Running Loop=1
2025-02-21T04:52:37.116Z,1740113557.116 [sci2_slowyo_test:Science:PeakDetectOil](DEBUG): Aggregate::initialize sci2_slowyo_test:Science:PeakDetectOil
2025-02-21T04:52:37.116Z,1740113557.116 [sci2_slowyo_test:Science:PeakDetectOil:A] Running Loop=1
2025-02-21T04:52:37.116Z,1740113557.116 [sci2_slowyo_test:Science:HighestOilPeakReport] Running Loop=1
2025-02-21T04:52:37.116Z,1740113557.116 [sci2_slowyo_test:Science:HighestOilPeakReport](DEBUG): Aggregate::initialize sci2_slowyo_test:Science:HighestOilPeakReport
2025-02-21T04:52:37.116Z,1740113557.116 [sci2_slowyo_test:Science:HighestOilPeakReport:A.PeakDetectHorizontal] Running Loop=1
2025-02-21T04:52:37.116Z,1740113557.116 [sci2_slowyo_test:Science:HighestOilPeakReport:A.PeakDetectHorizontal](INFO): Initialize.
2025-02-21T04:52:37.117Z,1740113557.117 [sci2_slowyo_test:Science:PeakDetectFDOM] Running Loop=1
2025-02-21T04:52:37.117Z,1740113557.117 [sci2_slowyo_test:Science:PeakDetectFDOM](DEBUG): Aggregate::initialize sci2_slowyo_test:Science:PeakDetectFDOM
2025-02-21T04:52:37.117Z,1740113557.117 [sci2_slowyo_test:Science:PeakDetectFDOM:A] Running Loop=1
2025-02-21T04:52:37.117Z,1740113557.117 [sci2_slowyo_test:Science:PeakDetectSalinity] Running Loop=1
2025-02-21T04:52:37.117Z,1740113557.117 [sci2_slowyo_test:Science:PeakDetectSalinity](DEBUG): Aggregate::initialize sci2_slowyo_test:Science:PeakDetectSalinity
2025-02-21T04:52:37.117Z,1740113557.117 [sci2_slowyo_test:Science:PeakDetectSalinity:A] Running Loop=1
2025-02-21T04:52:37.117Z,1740113557.117 [sci2_slowyo_test:Science:HighestSaltPeakReport] Running Loop=1
2025-02-21T04:52:37.117Z,1740113557.117 [sci2_slowyo_test:Science:HighestSaltPeakReport](DEBUG): Aggregate::initialize sci2_slowyo_test:Science:HighestSaltPeakReport
2025-02-21T04:52:37.117Z,1740113557.117 [sci2_slowyo_test:Science:HighestSaltPeakReport:A.PeakDetectHorizontal] Running Loop=1
2025-02-21T04:52:37.117Z,1740113557.117 [sci2_slowyo_test:Science:HighestSaltPeakReport:A.PeakDetectHorizontal](INFO): Initialize.
2025-02-21T04:52:37.118Z,1740113557.118 [sci2_slowyo_test:Science:PeakDetectPlanktivoreLMavgROI] Running Loop=1
2025-02-21T04:52:37.118Z,1740113557.118 [sci2_slowyo_test:Science:PeakDetectPlanktivoreLMavgROI](DEBUG): Aggregate::initialize sci2_slowyo_test:Science:PeakDetectPlanktivoreLMavgROI
2025-02-21T04:52:37.118Z,1740113557.118 [sci2_slowyo_test:Science:PeakDetectPlanktivoreLMavgROI:A] Running Loop=1
2025-02-21T04:52:37.118Z,1740113557.118 [sci2_slowyo_test:Science:EdgeDetectPlanktivoreLMavgROI] Running Loop=1
2025-02-21T04:52:37.118Z,1740113557.118 [sci2_slowyo_test:Science:EdgeDetectPlanktivoreLMavgROI](DEBUG): Aggregate::initialize sci2_slowyo_test:Science:EdgeDetectPlanktivoreLMavgROI
2025-02-21T04:52:37.118Z,1740113557.118 [sci2_slowyo_test:Science:EdgeDetectPlanktivoreLMavgROI:A] Running Loop=1
2025-02-21T04:52:37.118Z,1740113557.118 [sci2_slowyo_test:Science:PeakDetectPlanktivoreHMavgROI] Running Loop=1
2025-02-21T04:52:37.119Z,1740113557.119 [sci2_slowyo_test:Science:PeakDetectPlanktivoreHMavgROI](DEBUG): Aggregate::initialize sci2_slowyo_test:Science:PeakDetectPlanktivoreHMavgROI
2025-02-21T04:52:37.119Z,1740113557.119 [sci2_slowyo_test:Science:PeakDetectPlanktivoreHMavgROI:A] Running Loop=1
2025-02-21T04:52:37.119Z,1740113557.119 [sci2_slowyo_test:Science:PeakDetectPlanktivoreDiatoms] Running Loop=1
2025-02-21T04:52:37.119Z,1740113557.119 [sci2_slowyo_test:Science:PeakDetectPlanktivoreDiatoms](DEBUG): Aggregate::initialize sci2_slowyo_test:Science:PeakDetectPlanktivoreDiatoms
2025-02-21T04:52:37.135Z,1740113557.135 [sci2_slowyo_test:Science:PeakDetectPlanktivoreDiatoms:A] Running Loop=1
2025-02-21T04:52:37.135Z,1740113557.135 [sci2_slowyo_test:Science:PeakDetectPlanktivoreDinoflagellates] Running Loop=1
2025-02-21T04:52:37.135Z,1740113557.135 [sci2_slowyo_test:Science:PeakDetectPlanktivoreDinoflagellates](DEBUG): Aggregate::initialize sci2_slowyo_test:Science:PeakDetectPlanktivoreDinoflagellates
2025-02-21T04:52:37.135Z,1740113557.135 [sci2_slowyo_test:Science:PeakDetectPlanktivoreDinoflagellates:A] Running Loop=1
2025-02-21T04:52:37.136Z,1740113557.136 [sci2_slowyo_test:Science:ChlThreshTrigger] Running Loop=1
2025-02-21T04:52:37.136Z,1740113557.136 [sci2_slowyo_test:Science:ChlThreshTrigger](DEBUG): Aggregate::initialize sci2_slowyo_test:Science:ChlThreshTrigger
2025-02-21T04:52:37.136Z,1740113557.136 [sci2_slowyo_test:Science:ChlThreshTrigger:A.ValueDetect] Running Loop=1
2025-02-21T04:52:37.136Z,1740113557.136 [sci2_slowyo_test:Science:ChlThreshTrigger:A.ValueDetect](INFO): Initialize.
2025-02-21T04:52:37.136Z,1740113557.136 [sci2_slowyo_test:Science:OceanCurrent] Running Loop=1
2025-02-21T04:52:37.136Z,1740113557.136 [sci2_slowyo_test:Science:OceanCurrent](DEBUG): Aggregate::initialize sci2_slowyo_test:Science:OceanCurrent
2025-02-21T04:52:37.136Z,1740113557.136 [sci2_slowyo_test:Science:OceanCurrent:A.] Running Loop=1
2025-02-21T04:52:37.136Z,1740113557.136 [sci2_slowyo_test:Science:OceanCurrent:A.](INFO): Initializing CurrentEstimator.
2025-02-21T04:52:37.136Z,1740113557.136 [sci2_slowyo_test:StandardEnvelopes] Running Loop=1
2025-02-21T04:52:37.137Z,1740113557.137 [sci2_slowyo_test:StandardEnvelopes](DEBUG): Aggregate::initialize sci2_slowyo_test:StandardEnvelopes
2025-02-21T04:52:37.137Z,1740113557.137 [sci2_slowyo_test:StandardEnvelopes:A.AltitudeEnvelope] Running Loop=1
2025-02-21T04:52:37.137Z,1740113557.137 [sci2_slowyo_test:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Initialize AltitudeEnvelopeComponent.
2025-02-21T04:52:37.137Z,1740113557.137 [sci2_slowyo_test:StandardEnvelopes:B.DepthEnvelope] Running Loop=1
2025-02-21T04:52:37.137Z,1740113557.137 [sci2_slowyo_test:StandardEnvelopes:B.DepthEnvelope](DEBUG): Initialize DepthEnvelopeComponent.
2025-02-21T04:52:37.137Z,1740113557.137 [sci2_slowyo_test:StandardEnvelopes:C.OffshoreEnvelope] Running Loop=1
2025-02-21T04:52:37.137Z,1740113557.137 [sci2_slowyo_test:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Initialize OffshoreEnvelopeComponent.
2025-02-21T04:52:37.137Z,1740113557.137 [sci2_slowyo_test:BackseatDriver] Running Loop=1
2025-02-21T04:52:37.137Z,1740113557.137 [sci2_slowyo_test:BackseatDriver](DEBUG): Aggregate::initialize sci2_slowyo_test:BackseatDriver
2025-02-21T04:52:37.137Z,1740113557.137 [sci2_slowyo_test:BackseatDriver:A.BackseatDriver] Running Loop=1
2025-02-21T04:52:37.138Z,1740113557.138 [sci2_slowyo_test:PowerOnly] Running Loop=1
2025-02-21T04:52:37.138Z,1740113557.138 [sci2_slowyo_test:PowerOnly](DEBUG): Aggregate::initialize sci2_slowyo_test:PowerOnly
2025-02-21T04:52:37.138Z,1740113557.138 [sci2_slowyo_test:PowerOnly:A] Running Loop=1
2025-02-21T04:52:37.138Z,1740113557.138 [sci2_slowyo_test:PowerOnly:B] Running Loop=1
2025-02-21T04:52:37.138Z,1740113557.138 [sci2_slowyo_test:PowerOnly:C] Running Loop=1
2025-02-21T04:52:37.138Z,1740113557.138 [sci2_slowyo_test:PowerOnly:D] Running Loop=1
2025-02-21T04:52:37.138Z,1740113557.138 [sci2_slowyo_test:PowerOnly:E.Wait] Running Loop=1
2025-02-21T04:52:37.138Z,1740113557.138 [sci2_slowyo_test:PowerOnly:E.Wait](DEBUG): Initialize Wait Component.
2025-02-21T04:52:37.138Z,1740113557.138 [sci2_slowyo_test:C] Running Loop=1
2025-02-21T04:52:37.143Z,1740113557.143 [sci2_slowyo_test:PowerOnly] Running Loop=1
2025-02-21T04:52:37.144Z,1740113557.144 [sci2_slowyo_test:PowerOnly:D] Stopped
2025-02-21T04:52:37.144Z,1740113557.144 [sci2_slowyo_test:PowerOnly:C] Stopped
2025-02-21T04:52:37.144Z,1740113557.144 [sci2_slowyo_test:PowerOnly:B] Stopped
2025-02-21T04:52:37.144Z,1740113557.144 [sci2_slowyo_test:PowerOnly:A] Stopped
2025-02-21T04:52:37.144Z,1740113557.144 [sci2_slowyo_test:BackseatDriver] Running Loop=1
2025-02-21T04:52:37.144Z,1740113557.144 [sci2_slowyo_test:BackseatDriver:A.BackseatDriver](INFO): Initializing backseat
2025-02-21T04:52:37.185Z,1740113557.185 [sci2_slowyo_test:StandardEnvelopes] Running Loop=1
2025-02-21T04:52:37.185Z,1740113557.185 [sci2_slowyo_test:StandardEnvelopes:C.OffshoreEnvelope] Running Loop=1
2025-02-21T04:52:37.186Z,1740113557.186 [sci2_slowyo_test:StandardEnvelopes:B.DepthEnvelope] Running Loop=1
2025-02-21T04:52:37.186Z,1740113557.186 [sci2_slowyo_test:StandardEnvelopes:A.AltitudeEnvelope] Running Loop=1
2025-02-21T04:52:37.186Z,1740113557.186 [sci2_slowyo_test:C] Stopped
2025-02-21T04:52:37.187Z,1740113557.187 [sci2_slowyo_test:E] Running Loop=1
2025-02-21T04:52:37.187Z,1740113557.187 [sci2_slowyo_test:Science] Running Loop=1
2025-02-21T04:52:37.194Z,1740113557.194 [sci2_slowyo_test:Science:ChlThreshTrigger] Stopped
2025-02-21T04:52:37.194Z,1740113557.194 [sci2_slowyo_test:Science:ChlThreshTrigger](DEBUG): Aggregate::uninitialize sci2_slowyo_test:Science:ChlThreshTrigger
2025-02-21T04:52:37.194Z,1740113557.194 [sci2_slowyo_test:Science:ChlThreshTrigger:A.ValueDetect] Stopped
2025-02-21T04:52:37.194Z,1740113557.194 [sci2_slowyo_test:Science:ChlThreshTrigger:A.ValueDetect](DEBUG): Uninitialize.
2025-02-21T04:52:37.194Z,1740113557.194 [sci2_slowyo_test:Science:PeakDetectPlanktivoreDinoflagellates] Stopped
2025-02-21T04:52:37.194Z,1740113557.194 [sci2_slowyo_test:Science:PeakDetectPlanktivoreDinoflagellates](DEBUG): Aggregate::uninitialize sci2_slowyo_test:Science:PeakDetectPlanktivoreDinoflagellates
2025-02-21T04:52:37.194Z,1740113557.194 [sci2_slowyo_test:Science:PeakDetectPlanktivoreDinoflagellates:A] Stopped
2025-02-21T04:52:37.194Z,1740113557.194 [sci2_slowyo_test:Science:PeakDetectPlanktivoreDiatoms] Stopped
2025-02-21T04:52:37.194Z,1740113557.194 [sci2_slowyo_test:Science:PeakDetectPlanktivoreDiatoms](DEBUG): Aggregate::uninitialize sci2_slowyo_test:Science:PeakDetectPlanktivoreDiatoms
2025-02-21T04:52:37.194Z,1740113557.194 [sci2_slowyo_test:Science:PeakDetectPlanktivoreDiatoms:A] Stopped
2025-02-21T04:52:37.195Z,1740113557.195 [sci2_slowyo_test:Science:PeakDetectPlanktivoreHMavgROI] Stopped
2025-02-21T04:52:37.195Z,1740113557.195 [sci2_slowyo_test:Science:PeakDetectPlanktivoreHMavgROI](DEBUG): Aggregate::uninitialize sci2_slowyo_test:Science:PeakDetectPlanktivoreHMavgROI
2025-02-21T04:52:37.195Z,1740113557.195 [sci2_slowyo_test:Science:PeakDetectPlanktivoreHMavgROI:A] Stopped
2025-02-21T04:52:37.195Z,1740113557.195 [sci2_slowyo_test:Science:EdgeDetectPlanktivoreLMavgROI] Stopped
2025-02-21T04:52:37.212Z,1740113557.212 [sci2_slowyo_test:Science:EdgeDetectPlanktivoreLMavgROI](DEBUG): Aggregate::uninitialize sci2_slowyo_test:Science:EdgeDetectPlanktivoreLMavgROI
2025-02-21T04:52:37.212Z,1740113557.212 [sci2_slowyo_test:Science:EdgeDetectPlanktivoreLMavgROI:A] Stopped
2025-02-21T04:52:37.212Z,1740113557.212 [sci2_slowyo_test:Science:PeakDetectPlanktivoreLMavgROI] Stopped
2025-02-21T04:52:37.213Z,1740113557.213 [sci2_slowyo_test:Science:PeakDetectPlanktivoreLMavgROI](DEBUG): Aggregate::uninitialize sci2_slowyo_test:Science:PeakDetectPlanktivoreLMavgROI
2025-02-21T04:52:37.213Z,1740113557.213 [sci2_slowyo_test:Science:PeakDetectPlanktivoreLMavgROI:A] Stopped
2025-02-21T04:52:37.213Z,1740113557.213 [sci2_slowyo_test:Science:HighestSaltPeakReport] Stopped
2025-02-21T04:52:37.213Z,1740113557.213 [sci2_slowyo_test:Science:HighestSaltPeakReport](DEBUG): Aggregate::uninitialize sci2_slowyo_test:Science:HighestSaltPeakReport
2025-02-21T04:52:37.213Z,1740113557.213 [sci2_slowyo_test:Science:HighestSaltPeakReport:A.PeakDetectHorizontal] Stopped
2025-02-21T04:52:37.213Z,1740113557.213 [sci2_slowyo_test:Science:HighestSaltPeakReport:A.PeakDetectHorizontal](DEBUG): Uninitialize.
2025-02-21T04:52:37.213Z,1740113557.213 [sci2_slowyo_test:Science:PeakDetectSalinity] Stopped
2025-02-21T04:52:37.213Z,1740113557.213 [sci2_slowyo_test:Science:PeakDetectSalinity](DEBUG): Aggregate::uninitialize sci2_slowyo_test:Science:PeakDetectSalinity
2025-02-21T04:52:37.213Z,1740113557.213 [sci2_slowyo_test:Science:PeakDetectSalinity:A] Stopped
2025-02-21T04:52:37.213Z,1740113557.213 [sci2_slowyo_test:Science:PeakDetectFDOM] Stopped
2025-02-21T04:52:37.213Z,1740113557.213 [sci2_slowyo_test:Science:PeakDetectFDOM](DEBUG): Aggregate::uninitialize sci2_slowyo_test:Science:PeakDetectFDOM
2025-02-21T04:52:37.213Z,1740113557.213 [sci2_slowyo_test:Science:PeakDetectFDOM:A] Stopped
2025-02-21T04:52:37.213Z,1740113557.213 [sci2_slowyo_test:Science:HighestOilPeakReport] Stopped
2025-02-21T04:52:37.214Z,1740113557.214 [sci2_slowyo_test:Science:HighestOilPeakReport](DEBUG): Aggregate::uninitialize sci2_slowyo_test:Science:HighestOilPeakReport
2025-02-21T04:52:37.214Z,1740113557.214 [sci2_slowyo_test:Science:HighestOilPeakReport:A.PeakDetectHorizontal] Stopped
2025-02-21T04:52:37.214Z,1740113557.214 [sci2_slowyo_test:Science:HighestOilPeakReport:A.PeakDetectHorizontal](DEBUG): Uninitialize.
2025-02-21T04:52:37.214Z,1740113557.214 [sci2_slowyo_test:Science:PeakDetectOil] Stopped
2025-02-21T04:52:37.214Z,1740113557.214 [sci2_slowyo_test:Science:PeakDetectOil](DEBUG): Aggregate::uninitialize sci2_slowyo_test:Science:PeakDetectOil
2025-02-21T04:52:37.214Z,1740113557.214 [sci2_slowyo_test:Science:PeakDetectOil:A] Stopped
2025-02-21T04:52:37.214Z,1740113557.214 [sci2_slowyo_test:Science:PeakDetectNO3] Stopped
2025-02-21T04:52:37.214Z,1740113557.214 [sci2_slowyo_test:Science:PeakDetectNO3](DEBUG): Aggregate::uninitialize sci2_slowyo_test:Science:PeakDetectNO3
2025-02-21T04:52:37.214Z,1740113557.214 [sci2_slowyo_test:Science:PeakDetectNO3:A] Stopped
2025-02-21T04:52:37.214Z,1740113557.214 [sci2_slowyo_test:Science:HighestChlPeakReport] Stopped
2025-02-21T04:52:37.214Z,1740113557.214 [sci2_slowyo_test:Science:HighestChlPeakReport](DEBUG): Aggregate::uninitialize sci2_slowyo_test:Science:HighestChlPeakReport
2025-02-21T04:52:37.214Z,1740113557.214 [sci2_slowyo_test:Science:HighestChlPeakReport:A.PeakDetectHorizontal] Stopped
2025-02-21T04:52:37.214Z,1740113557.214 [sci2_slowyo_test:Science:HighestChlPeakReport:A.PeakDetectHorizontal](DEBUG): Uninitialize.
2025-02-21T04:52:37.215Z,1740113557.215 [sci2_slowyo_test:Science:EdgeDetectChl] Stopped
2025-02-21T04:52:37.215Z,1740113557.215 [sci2_slowyo_test:Science:EdgeDetectChl](DEBUG): Aggregate::uninitialize sci2_slowyo_test:Science:EdgeDetectChl
2025-02-21T04:52:37.215Z,1740113557.215 [sci2_slowyo_test:Science:EdgeDetectChl:A] Stopped
2025-02-21T04:52:37.215Z,1740113557.215 [sci2_slowyo_test:Science:PeakDetectChl] Stopped
2025-02-21T04:52:37.219Z,1740113557.219 [sci2_slowyo_test:Science:PeakDetectChl](DEBUG): Aggregate::uninitialize sci2_slowyo_test:Science:PeakDetectChl
2025-02-21T04:52:37.219Z,1740113557.219 [sci2_slowyo_test:Science:PeakDetectChl:A] Stopped
2025-02-21T04:52:37.219Z,1740113557.219 [sci2_slowyo_test:Science:OceanCurrent:A.] Running Loop=1
2025-02-21T04:52:37.219Z,1740113557.219 [sci2_slowyo_test:Science:Read_Oil] Stopped
2025-02-21T04:52:37.220Z,1740113557.220 [sci2_slowyo_test:Science:F] Stopped
2025-02-21T04:52:37.220Z,1740113557.220 [sci2_slowyo_test:Science:E] Running Loop=1
2025-02-21T04:52:37.220Z,1740113557.220 [sci2_slowyo_test:Science:E](DEBUG): Initialize ReadDataComponent to sense mass_concentration_of_chlorophyll_in_sea_water
2025-02-21T04:52:37.220Z,1740113557.220 [sci2_slowyo_test:Science:D] Stopped
2025-02-21T04:52:37.220Z,1740113557.220 [sci2_slowyo_test:Science:C] Running Loop=1
2025-02-21T04:52:37.221Z,1740113557.221 [sci2_slowyo_test:Science:C](DEBUG): Initialize ReadDataComponent to sense CTD_Seabird.sea_water_temperature
2025-02-21T04:52:37.221Z,1740113557.221 [sci2_slowyo_test:Science:C](DEBUG): Initialize ReadDataComponent to sense CTD_Seabird.sea_water_salinity
2025-02-21T04:52:37.221Z,1740113557.221 [sci2_slowyo_test:Science:B] Running Loop=1
2025-02-21T04:52:37.222Z,1740113557.222 [sci2_slowyo_test:Science:B](DEBUG): Initialize ReadDataComponent to sense sea_water_temperature
2025-02-21T04:52:37.222Z,1740113557.222 [sci2_slowyo_test:Science:B](DEBUG): Initialize ReadDataComponent to sense sea_water_salinity
2025-02-21T04:52:37.222Z,1740113557.222 [sci2_slowyo_test:Science:A] Stopped
2025-02-21T04:52:37.235Z,1740113557.235 [BackseatComponent](INFO): Powering up
2025-02-21T04:52:37.236Z,1740113557.236 [BackseatComponent](INFO): Subscribing to LCM channels.
2025-02-21T04:52:37.483Z,1740113557.483 [sci2_slowyo_test:E] Stopped
2025-02-21T04:52:37.483Z,1740113557.483 [sci2_slowyo_test:F] Running Loop=1
2025-02-21T04:52:37.665Z,1740113557.665 [WetLabsBB2FL](INFO): Powering up
2025-02-21T04:52:37.734Z,1740113557.734 [CommandExec](IMPORTANT): Running 
2025-02-21T04:52:37.904Z,1740113557.904 [sci2_slowyo_test:F] Stopped
2025-02-21T04:52:37.904Z,1740113557.904 [sci2_slowyo_test:G] Running Loop=1
2025-02-21T04:52:38.299Z,1740113558.299 [sci2_slowyo_test:G] Stopped
2025-02-21T04:52:38.299Z,1740113558.299 [sci2_slowyo_test:StartingMission] Running Loop=1
2025-02-21T04:52:38.300Z,1740113558.300 [sci2_slowyo_test:StartingMission](DEBUG): Aggregate::initialize sci2_slowyo_test:StartingMission
2025-02-21T04:52:38.698Z,1740113558.698 [sci2_slowyo_test:SurfaceComms] Running Loop=1
2025-02-21T04:52:38.698Z,1740113558.698 [sci2_slowyo_test:SurfaceComms](DEBUG): Aggregate::initialize sci2_slowyo_test:SurfaceComms
2025-02-21T04:52:38.698Z,1740113558.698 [sci2_slowyo_test:SurfaceComms:A] Running Loop=1
2025-02-21T04:52:38.699Z,1740113558.699 [sci2_slowyo_test:SurfaceComms:A] Stopped
2025-02-21T04:52:38.699Z,1740113558.699 [sci2_slowyo_test:SurfaceComms:B] Running Loop=1
2025-02-21T04:52:38.699Z,1740113558.699 [sci2_slowyo_test:SurfaceComms:B](DEBUG): Aggregate::initialize sci2_slowyo_test:SurfaceComms:B
2025-02-21T04:52:38.704Z,1740113558.704 [sci2_slowyo_test:StandardEnvelopes:A.AltitudeEnvelope](ERROR): Altitude Measurement is not Active.
2025-02-21T04:52:39.116Z,1740113559.116 [sci2_slowyo_test:NeedComms] Running Loop=1
2025-02-21T04:52:39.116Z,1740113559.116 [sci2_slowyo_test:NeedComms](DEBUG): Aggregate::initialize sci2_slowyo_test:NeedComms
2025-02-21T04:52:39.116Z,1740113559.116 [sci2_slowyo_test:NeedComms:B.GoToSurface] Running Loop=1
2025-02-21T04:52:39.116Z,1740113559.116 [sci2_slowyo_test:NeedComms:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2025-02-21T04:52:39.117Z,1740113559.117 [sci2_slowyo_test:NeedComms:B.GoToSurface](INFO): Received depth rate setting 0.300000 m/s.
2025-02-21T04:52:39.117Z,1740113559.117 [sci2_slowyo_test:NeedComms:B.GoToSurface](INFO): Received pitch setting 19.999999 degrees.
2025-02-21T04:52:39.117Z,1740113559.117 [sci2_slowyo_test:NeedComms:B.GoToSurface](INFO): Received speed setting 1.000000 m/s.
2025-02-21T04:52:39.118Z,1740113559.118 [sci2_slowyo_test:NeedComms:B.GoToSurface](INFO): Received surface timeout setting 1000.000000 seconds.
2025-02-21T04:52:39.118Z,1740113559.118 [sci2_slowyo_test:NeedComms:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds.
2025-02-21T04:52:39.118Z,1740113559.118 [sci2_slowyo_test:NeedComms:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2025-02-21T04:52:39.119Z,1740113559.119 [sci2_slowyo_test:NeedComms:A] Running Loop=1
2025-02-21T04:52:39.120Z,1740113559.120 [sci2_slowyo_test:NeedComms:A](INFO): last time_fix was:  1740113254.000000 second since 1970/01/01T00:00:00Z 
2025-02-21T04:52:39.120Z,1740113559.120 [sci2_slowyo_test:NeedComms:A] Stopped
2025-02-21T04:52:39.509Z,1740113559.509 [sci2_slowyo_test:NeedComms:C] Running Loop=1
2025-02-21T04:52:39.908Z,1740113559.908 [sci2_slowyo_test:NeedComms:C](DEBUG): Initialize ReadDataComponent to sense time_fix
2025-02-21T04:52:41.195Z,1740113561.195 [CTD_Seabird](ERROR): Failed to parse device response: <!--startlogging-->
2025-02-21T04:52:41.513Z,1740113561.513 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,045240.00,A,3647.70616,N,12152.13397,W,1.322,174.28,210225,,,A*7D
2025-02-21T04:52:41.516Z,1740113561.516 [NAL9602](INFO): GPS fix at 20250221T045240: (36.795103, -121.868899)
2025-02-21T04:52:41.532Z,1740113561.532 [sci2_slowyo_test:NeedComms:C] Stopped
2025-02-21T04:52:41.532Z,1740113561.532 [sci2_slowyo_test:NeedComms:D] Running Loop=1
2025-02-21T04:52:41.956Z,1740113561.956 [sci2_slowyo_test:NeedComms:D](DEBUG): Initialize ReadDataComponent to sense platform_communications
2025-02-21T04:52:50.223Z,1740113570.223 [DataOverHttps](INFO): Sending 168 bytes from file Logs/20250221T044001/Courier0006.lzma
2025-02-21T04:52:52.994Z,1740113572.994 [DataOverHttps](INFO): Moved sent file to Logs/20250221T044001/Courier0006.lzma.bak
2025-02-21T04:52:52.994Z,1740113572.994 [DataOverHttps](INFO): SBD MOMSN=23970605
2025-02-21T04:53:05.134Z,1740113585.134 [NAL9602](INFO): SBD MO Status=1, MOMSN=13007, MT Status=0, MTMSN=0
2025-02-21T04:53:05.134Z,1740113585.134 [NAL9602](INFO): No messages in MT queue
2025-02-21T04:53:13.375Z,1740113593.375 [DataOverHttps](INFO): Sending 267 bytes from file Logs/20250221T045125/Courier0000.lzma
2025-02-21T04:53:14.377Z,1740113594.377 [DataOverHttps](INFO): Moved sent file to Logs/20250221T045125/Courier0000.lzma.bak
2025-02-21T04:53:14.377Z,1740113594.377 [DataOverHttps](INFO): SBD MOMSN=23970607
2025-02-21T04:53:31.916Z,1740113611.916 [DataOverHttps](INFO): Sending 660 bytes from file Logs/20250221T044001/Express0007.lzma
2025-02-21T04:53:32.917Z,1740113612.917 [DataOverHttps](INFO): Moved sent file to Logs/20250221T044001/Express0007.lzma.bak
2025-02-21T04:53:32.917Z,1740113612.917 [DataOverHttps](INFO): SBD MOMSN=23970611
2025-02-21T04:53:35.875Z,1740113615.875 [NAL9602](INFO): Not Powering down - fast GPS
2025-02-21T04:53:45.339Z,1740113625.339 [BackseatComponent](IMPORTANT): IBASE811F-02: Running bioacoustics backseat app. Logging to: 20250221T045349
2025-02-21T04:53:50.364Z,1740113630.364 [DataOverHttps](INFO): Sending 587 bytes from file Logs/20250221T045125/Express0001.lzma
2025-02-21T04:53:51.365Z,1740113631.365 [DataOverHttps](INFO): Moved sent file to Logs/20250221T045125/Express0001.lzma.bak
2025-02-21T04:53:51.365Z,1740113631.365 [DataOverHttps](INFO): SBD MOMSN=23970634
2025-02-21T04:54:09.343Z,1740113649.343 [DataOverHttps](INFO): Sending 63 bytes from file Logs/20250221T045125/Express0004.lzma
2025-02-21T04:54:10.349Z,1740113650.349 [DataOverHttps](INFO): Moved sent file to Logs/20250221T045125/Express0004.lzma.bak
2025-02-21T04:54:10.349Z,1740113650.349 [DataOverHttps](INFO): SBD MOMSN=23970650
2025-02-21T04:54:12.256Z,1740113652.256 [sci2_slowyo_test:NeedComms:D] Stopped
2025-02-21T04:54:12.256Z,1740113652.256 [sci2_slowyo_test:NeedComms:E] Running Loop=1
2025-02-21T04:54:12.677Z,1740113652.677 [sci2_slowyo_test:NeedComms:E](DEBUG): Initialize ReadDataComponent to sense time_fix
2025-02-21T04:54:14.262Z,1740113654.262 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,045413.00,A,3647.70239,N,12152.12758,W,1.341,113.54,210225,,,A*7D
2025-02-21T04:54:14.271Z,1740113654.271 [NAL9602](INFO): GPS fix at 20250221T045413: (36.795040, -121.868793)
2025-02-21T04:54:14.292Z,1740113654.292 [sci2_slowyo_test:NeedComms:E] Stopped
2025-02-21T04:54:14.293Z,1740113654.293 [sci2_slowyo_test:NeedComms](INFO): Completed sci2_slowyo_test:NeedComms
2025-02-21T04:54:14.293Z,1740113654.293 [sci2_slowyo_test:NeedComms] Stopped
2025-02-21T04:54:14.293Z,1740113654.293 [sci2_slowyo_test:NeedComms](DEBUG): Aggregate::uninitialize sci2_slowyo_test:NeedComms
2025-02-21T04:54:14.293Z,1740113654.293 [sci2_slowyo_test:NeedComms:B.GoToSurface] Stopped
2025-02-21T04:54:14.293Z,1740113654.293 [sci2_slowyo_test:NeedComms:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2025-02-21T04:54:14.720Z,1740113654.720 [sci2_slowyo_test:SurfaceComms:B](INFO): Completed sci2_slowyo_test:SurfaceComms:B
2025-02-21T04:54:14.720Z,1740113654.720 [sci2_slowyo_test:SurfaceComms:B] Stopped
2025-02-21T04:54:14.720Z,1740113654.720 [sci2_slowyo_test:SurfaceComms:B](DEBUG): Aggregate::uninitialize sci2_slowyo_test:SurfaceComms:B
2025-02-21T04:54:14.720Z,1740113654.720 [sci2_slowyo_test:SurfaceComms:setInitial] Running Loop=1
2025-02-21T04:54:14.720Z,1740113654.720 [sci2_slowyo_test:SurfaceComms:setInitial](DEBUG): Aggregate::initialize sci2_slowyo_test:SurfaceComms:setInitial
2025-02-21T04:54:14.721Z,1740113654.721 [sci2_slowyo_test:SurfaceComms:setInitial:A] Running Loop=1
2025-02-21T04:54:15.117Z,1740113655.117 [sci2_slowyo_test:SurfaceComms:setInitial:A] Stopped
2025-02-21T04:54:15.118Z,1740113655.118 [sci2_slowyo_test:SurfaceComms:setInitial](INFO): Completed sci2_slowyo_test:SurfaceComms:setInitial
2025-02-21T04:54:15.118Z,1740113655.118 [sci2_slowyo_test:SurfaceComms:setInitial] Stopped
2025-02-21T04:54:15.118Z,1740113655.118 [sci2_slowyo_test:SurfaceComms:setInitial](DEBUG): Aggregate::uninitialize sci2_slowyo_test:SurfaceComms:setInitial
2025-02-21T04:54:15.118Z,1740113655.118 [sci2_slowyo_test:SurfaceComms:setSink] Running Loop=1
2025-02-21T04:54:15.118Z,1740113655.118 [sci2_slowyo_test:SurfaceComms:setSink](DEBUG): Aggregate::initialize sci2_slowyo_test:SurfaceComms:setSink
2025-02-21T04:54:15.118Z,1740113655.118 [sci2_slowyo_test:SurfaceComms:setSink:A] Running Loop=1
2025-02-21T04:54:15.549Z,1740113655.549 [sci2_slowyo_test:SurfaceComms:setSink] Stopped
2025-02-21T04:54:15.550Z,1740113655.550 [sci2_slowyo_test:SurfaceComms:setSink](DEBUG): Aggregate::uninitialize sci2_slowyo_test:SurfaceComms:setSink
2025-02-21T04:54:15.550Z,1740113655.550 [sci2_slowyo_test:SurfaceComms:setSink:A] Stopped
2025-02-21T04:54:15.550Z,1740113655.550 [sci2_slowyo_test:SurfaceComms](INFO): Completed sci2_slowyo_test:SurfaceComms
2025-02-21T04:54:15.550Z,1740113655.550 [sci2_slowyo_test:SurfaceComms] Stopped
2025-02-21T04:54:15.550Z,1740113655.550 [sci2_slowyo_test:SurfaceComms](DEBUG): Aggregate::uninitialize sci2_slowyo_test:SurfaceComms
2025-02-21T04:54:15.925Z,1740113655.925 [sci2_slowyo_test:StartingMission](INFO): Completed sci2_slowyo_test:StartingMission
2025-02-21T04:54:15.925Z,1740113655.925 [sci2_slowyo_test:StartingMission] Stopped
2025-02-21T04:54:15.925Z,1740113655.925 [sci2_slowyo_test:StartingMission](DEBUG): Aggregate::uninitialize sci2_slowyo_test:StartingMission
2025-02-21T04:54:15.926Z,1740113655.926 [sci2_slowyo_test:Lap] Running Loop=1
2025-02-21T04:54:15.926Z,1740113655.926 [sci2_slowyo_test:Lap](DEBUG): Aggregate::initialize sci2_slowyo_test:Lap
2025-02-21T04:54:15.926Z,1740113655.926 [sci2_slowyo_test:Lap:Dive] Running Loop=1
2025-02-21T04:54:15.926Z,1740113655.926 [sci2_slowyo_test:Lap:Dive](DEBUG): Aggregate::initialize sci2_slowyo_test:Lap:Dive
2025-02-21T04:54:15.926Z,1740113655.926 [sci2_slowyo_test:Lap:Dive:A] Running Loop=1
2025-02-21T04:54:15.926Z,1740113655.926 [sci2_slowyo_test:Lap:Dive:A](DEBUG): Aggregate::initialize sci2_slowyo_test:Lap:Dive:A
2025-02-21T04:54:15.926Z,1740113655.926 [sci2_slowyo_test:Lap:Wpt1] Running Loop=1
2025-02-21T04:54:15.926Z,1740113655.926 [sci2_slowyo_test:Lap:Wpt1](DEBUG): Aggregate::initialize sci2_slowyo_test:Lap:Wpt1
2025-02-21T04:54:15.927Z,1740113655.927 [sci2_slowyo_test:Lap:Wpt1:A.Waypoint] Running Loop=1
2025-02-21T04:54:15.927Z,1740113655.927 [sci2_slowyo_test:Lap:Wpt1:A.Waypoint](DEBUG): Initialize WaypointComponent.
2025-02-21T04:54:15.932Z,1740113655.932 [sci2_slowyo_test:Lap:Wpt1:A.Waypoint](IMPORTANT): Navigating to waypoint: 36.797001,-121.847000
2025-02-21T04:54:16.341Z,1740113656.341 [sci2_slowyo_test:Lap:Wpt1:A.Waypoint](INFO): Navigating to waypoint: 36.797001,-121.847000
2025-02-21T04:54:16.341Z,1740113656.341 [sci2_slowyo_test:Lap:Dive] Running Loop=1
2025-02-21T04:54:16.341Z,1740113656.341 [sci2_slowyo_test:DiveCmd] Running Loop=1
2025-02-21T04:54:16.341Z,1740113656.341 [sci2_slowyo_test:DiveCmd](DEBUG): Aggregate::initialize sci2_slowyo_test:DiveCmd
2025-02-21T04:54:16.341Z,1740113656.341 [sci2_slowyo_test:DiveCmd:SurfaceSink] Running Loop=1
2025-02-21T04:54:16.342Z,1740113656.342 [sci2_slowyo_test:DiveCmd:SurfaceSink](DEBUG): Aggregate::initialize sci2_slowyo_test:DiveCmd:SurfaceSink
2025-02-21T04:54:16.342Z,1740113656.342 [sci2_slowyo_test:DiveCmd:SurfaceSink:sink] Running Loop=1
2025-02-21T04:54:16.342Z,1740113656.342 [sci2_slowyo_test:DiveCmd:SurfaceSink:sink](DEBUG): Aggregate::initialize sci2_slowyo_test:DiveCmd:SurfaceSink:sink
2025-02-21T04:54:16.342Z,1740113656.342 [sci2_slowyo_test:DiveCmd:SurfaceSink:sink:BuoyancyHold.Buoyancy] Running Loop=1
2025-02-21T04:54:16.342Z,1740113656.342 [sci2_slowyo_test:DiveCmd:SurfaceSink:sink:BuoyancyHold.Buoyancy](DEBUG): Initialize Buoyancy Component.
2025-02-21T04:54:16.342Z,1740113656.342 [sci2_slowyo_test:DiveCmd:SurfaceSink:sink:B.SetSpeed] Running Loop=1
2025-02-21T04:54:16.342Z,1740113656.342 [sci2_slowyo_test:DiveCmd:SurfaceSink:sink:B.SetSpeed](DEBUG): Initialize.
2025-02-21T04:54:16.342Z,1740113656.342 [sci2_slowyo_test:DiveCmd:SurfaceSink:sink:C] Running Loop=1
2025-02-21T04:54:16.342Z,1740113656.342 [sci2_slowyo_test:DiveCmd:InitialDive] Running Loop=1
2025-02-21T04:54:16.342Z,1740113656.342 [sci2_slowyo_test:DiveCmd:InitialDive](DEBUG): Aggregate::initialize sci2_slowyo_test:DiveCmd:InitialDive
2025-02-21T04:54:16.343Z,1740113656.343 [sci2_slowyo_test:DiveCmd:InitialDive:dive] Running Loop=1
2025-02-21T04:54:16.343Z,1740113656.343 [sci2_slowyo_test:DiveCmd:InitialDive:dive](DEBUG): Aggregate::initialize sci2_slowyo_test:DiveCmd:InitialDive:dive
2025-02-21T04:54:16.347Z,1740113656.347 [sci2_slowyo_test:DiveCmd:InitialDive:dive:A.Mass] Running Loop=1
2025-02-21T04:54:16.347Z,1740113656.347 [sci2_slowyo_test:DiveCmd:InitialDive:dive:A.Mass](DEBUG): Initialize.
2025-02-21T04:54:16.347Z,1740113656.347 [sci2_slowyo_test:DiveCmd:InitialDive:dive:B.Buoyancy] Running Loop=1
2025-02-21T04:54:16.347Z,1740113656.347 [sci2_slowyo_test:DiveCmd:InitialDive:dive:B.Buoyancy](DEBUG): Initialize Buoyancy Component.
2025-02-21T04:54:16.348Z,1740113656.348 [sci2_slowyo_test:DiveCmd:InitialDive:dive:C] Running Loop=1
2025-02-21T04:54:16.348Z,1740113656.348 [sci2_slowyo_test:DiveCmd:SlowYoToWaypoint] Running Loop=1
2025-02-21T04:54:16.348Z,1740113656.348 [sci2_slowyo_test:DiveCmd:SlowYoToWaypoint](DEBUG): Aggregate::initialize sci2_slowyo_test:DiveCmd:SlowYoToWaypoint
2025-02-21T04:54:16.348Z,1740113656.348 [sci2_slowyo_test:DiveCmd:SlowYoToWaypoint:SlowYoTask] Running Loop=1
2025-02-21T04:54:16.348Z,1740113656.348 [sci2_slowyo_test:DiveCmd:SlowYoToWaypoint:SlowYoTask](DEBUG): Aggregate::initialize sci2_slowyo_test:DiveCmd:SlowYoToWaypoint:SlowYoTask
2025-02-21T04:54:16.348Z,1740113656.348 [sci2_slowyo_test:DiveCmd:SlowYoToWaypoint:SlowYoTask:A.Buoyancy] Running Loop=1
2025-02-21T04:54:16.348Z,1740113656.348 [sci2_slowyo_test:DiveCmd:SlowYoToWaypoint:SlowYoTask:A.Buoyancy](DEBUG): Initialize Buoyancy Component.
2025-02-21T04:54:16.348Z,1740113656.348 [sci2_slowyo_test:DiveCmd:SlowYoToWaypoint:SlowYoTask:B.Pitch] Running Loop=1
2025-02-21T04:54:16.348Z,1740113656.348 [sci2_slowyo_test:DiveCmd:SlowYoToWaypoint:SlowYoTask:B.Pitch](DEBUG): Initialize.
2025-02-21T04:54:16.348Z,1740113656.348 [sci2_slowyo_test:DiveCmd:SlowYoToWaypoint:SlowYoTask:C.SetSpeed] Running Loop=1
2025-02-21T04:54:16.349Z,1740113656.349 [sci2_slowyo_test:DiveCmd:SlowYoToWaypoint:SlowYoTask:C.SetSpeed](DEBUG): Initialize.
2025-02-21T04:54:16.349Z,1740113656.349 [sci2_slowyo_test:DiveCmd:SlowYoToWaypoint:SlowYoTask:SlowYoLoop] Running Loop=1
2025-02-21T04:54:16.349Z,1740113656.349 [sci2_slowyo_test:DiveCmd:SlowYoToWaypoint:SlowYoTask:SlowYoLoop](DEBUG): Aggregate::initialize sci2_slowyo_test:DiveCmd:SlowYoToWaypoint:SlowYoTask:SlowYoLoop
2025-02-21T04:54:16.349Z,1740113656.349 [sci2_slowyo_test:DiveCmd:SlowYoToWaypoint:SlowYoTask:SlowYoLoop:A.SlowYo] Running Loop=1
2025-02-21T04:54:16.349Z,1740113656.349 [sci2_slowyo_test:DiveCmd:SlowYoToWaypoint:SlowYoTask:SlowYoLoop:A.SlowYo](DEBUG): Initialize SlowYoComponent.
2025-02-21T04:54:16.350Z,1740113656.350 [sci2_slowyo_test:DiveCmd:SlowYoToWaypoint] Stopped
2025-02-21T04:54:16.350Z,1740113656.350 [sci2_slowyo_test:DiveCmd:SlowYoToWaypoint](DEBUG): Aggregate::uninitialize sci2_slowyo_test:DiveCmd:SlowYoToWaypoint
2025-02-21T04:54:16.350Z,1740113656.350 [sci2_slowyo_test:DiveCmd:SlowYoToWaypoint:SlowYoTask] Stopped
2025-02-21T04:54:16.350Z,1740113656.350 [sci2_slowyo_test:DiveCmd:SlowYoToWaypoint:SlowYoTask](DEBUG): Aggregate::uninitialize sci2_slowyo_test:DiveCmd:SlowYoToWaypoint:SlowYoTask
2025-02-21T04:54:16.350Z,1740113656.350 [sci2_slowyo_test:DiveCmd:SlowYoToWaypoint:SlowYoTask:A.Buoyancy] Stopped
2025-02-21T04:54:16.350Z,1740113656.350 [sci2_slowyo_test:DiveCmd:SlowYoToWaypoint:SlowYoTask:A.Buoyancy](DEBUG): Uninitialize Buoyancy Component.
2025-02-21T04:54:16.350Z,1740113656.350 [sci2_slowyo_test:DiveCmd:SlowYoToWaypoint:SlowYoTask:B.Pitch] Stopped
2025-02-21T04:54:16.350Z,1740113656.350 [sci2_slowyo_test:DiveCmd:SlowYoToWaypoint:SlowYoTask:C.SetSpeed] Stopped
2025-02-21T04:54:16.350Z,1740113656.350 [sci2_slowyo_test:DiveCmd:SlowYoToWaypoint:SlowYoTask:C.SetSpeed](DEBUG): Uninitialize.
2025-02-21T04:54:16.351Z,1740113656.351 [sci2_slowyo_test:DiveCmd:SlowYoToWaypoint:SlowYoTask:SlowYoLoop] Stopped
2025-02-21T04:54:16.351Z,1740113656.351 [sci2_slowyo_test:DiveCmd:SlowYoToWaypoint:SlowYoTask:SlowYoLoop](DEBUG): Aggregate::uninitialize sci2_slowyo_test:DiveCmd:SlowYoToWaypoint:SlowYoTask:SlowYoLoop
2025-02-21T04:54:16.351Z,1740113656.351 [sci2_slowyo_test:DiveCmd:SlowYoToWaypoint:SlowYoTask:SlowYoLoop:A.SlowYo] Stopped
2025-02-21T04:54:16.351Z,1740113656.351 [sci2_slowyo_test:DiveCmd:SlowYoToWaypoint:SlowYoTask:SlowYoLoop:A.SlowYo](DEBUG): Uninitialize SlowYoComponent.
2025-02-21T04:54:16.379Z,1740113656.379 [sci2_slowyo_test:DiveCmd:InitialDive] Running Loop=1
2025-02-21T04:54:16.379Z,1740113656.379 [sci2_slowyo_test:DiveCmd:InitialDive:dive:C](INFO): Waiting for 1 minute while pumping down to neutral.
2025-02-21T04:54:16.379Z,1740113656.379 [sci2_slowyo_test:DiveCmd:InitialDive:dive:C] Stopped
2025-02-21T04:54:16.380Z,1740113656.380 [sci2_slowyo_test:DiveCmd:InitialDive:dive:D.Wait] Running Loop=1
2025-02-21T04:54:16.380Z,1740113656.380 [sci2_slowyo_test:DiveCmd:InitialDive:dive:D.Wait](DEBUG): Initialize Wait Component.
2025-02-21T04:54:16.380Z,1740113656.380 [sci2_slowyo_test:DiveCmd:InitialDive:dive:B.Buoyancy] Running Loop=1
2025-02-21T04:54:16.381Z,1740113656.381 [sci2_slowyo_test:DiveCmd:InitialDive:dive:A.Mass] Running Loop=1
2025-02-21T04:54:16.381Z,1740113656.381 [sci2_slowyo_test:DiveCmd:SurfaceSink] Stopped
2025-02-21T04:54:16.381Z,1740113656.381 [sci2_slowyo_test:DiveCmd:SurfaceSink](DEBUG): Aggregate::uninitialize sci2_slowyo_test:DiveCmd:SurfaceSink
2025-02-21T04:54:16.381Z,1740113656.381 [sci2_slowyo_test:DiveCmd:SurfaceSink:sink] Stopped
2025-02-21T04:54:16.381Z,1740113656.381 [sci2_slowyo_test:DiveCmd:SurfaceSink:sink](DEBUG): Aggregate::uninitialize sci2_slowyo_test:DiveCmd:SurfaceSink:sink
2025-02-21T04:54:16.381Z,1740113656.381 [sci2_slowyo_test:DiveCmd:SurfaceSink:sink:BuoyancyHold.Buoyancy] Stopped
2025-02-21T04:54:16.381Z,1740113656.381 [sci2_slowyo_test:DiveCmd:SurfaceSink:sink:BuoyancyHold.Buoyancy](DEBUG): Uninitialize Buoyancy Component.
2025-02-21T04:54:16.381Z,1740113656.381 [sci2_slowyo_test:DiveCmd:SurfaceSink:sink:B.SetSpeed] Stopped
2025-02-21T04:54:16.382Z,1740113656.382 [sci2_slowyo_test:DiveCmd:SurfaceSink:sink:B.SetSpeed](DEBUG): Uninitialize.
2025-02-21T04:54:16.382Z,1740113656.382 [sci2_slowyo_test:DiveCmd:SurfaceSink:sink:C] Stopped
2025-02-21T04:54:20.409Z,1740113660.409 [DataOverHttps](IMPORTANT): SBD MTMSN=20250221T045419
2025-02-21T04:54:28.876Z,1740113668.876 [NAL9602](INFO): SBD MO Status=1, MOMSN=13008, MT Status=0, MTMSN=0
2025-02-21T04:54:28.877Z,1740113668.877 [NAL9602](INFO): No messages in MT queue
2025-02-21T04:54:29.395Z,1740113669.395 [DataOverHttps](INFO): Received command: set sci2_slowyo_test.speed SpeedControl.rollOptimum m/s
2025-02-21T04:54:34.083Z,1740113674.083 [CommandExec](IMPORTANT): got command set sci2_slowyo_test.Speed SpeedControl.rollOptimum
2025-02-21T04:54:44.732Z,1740113684.732 [sci2_slowyo_test:BackseatDriver:A.BackseatDriver](INFO): Created data writer for _.height_above_sea_floor with code: 1975
2025-02-21T04:54:59.665Z,1740113699.665 [NAL9602](INFO): Not Powering down - fast GPS
2025-02-21T04:55:16.884Z,1740113716.884 [sci2_slowyo_test:DiveCmd:InitialDive:dive:D.Wait](INFO): Done Waiting.
2025-02-21T04:55:16.884Z,1740113716.884 [sci2_slowyo_test:DiveCmd:InitialDive:dive:D.Wait] Stopped
2025-02-21T04:55:16.885Z,1740113716.885 [sci2_slowyo_test:DiveCmd:InitialDive:dive:D.Wait](DEBUG): Uninitialize Wait Component.
2025-02-21T04:55:16.885Z,1740113716.885 [sci2_slowyo_test:DiveCmd:InitialDive:dive:E] Running Loop=1
2025-02-21T04:55:17.269Z,1740113717.269 [sci2_slowyo_test:DiveCmd:InitialDive:dive:E](INFO): Moving to  10.000000 m 
2025-02-21T04:55:17.269Z,1740113717.269 [sci2_slowyo_test:DiveCmd:InitialDive:dive:E] Stopped
2025-02-21T04:55:17.269Z,1740113717.269 [sci2_slowyo_test:DiveCmd:InitialDive:dive:ApproachDepth] Running Loop=1
2025-02-21T04:55:17.270Z,1740113717.270 [sci2_slowyo_test:DiveCmd:InitialDive:dive:ApproachDepth](DEBUG): Aggregate::initialize sci2_slowyo_test:DiveCmd:InitialDive:dive:ApproachDepth
2025-02-21T04:55:17.270Z,1740113717.270 [sci2_slowyo_test:DiveCmd:InitialDive:dive:ApproachDepth:A.SetSpeed] Running Loop=1
2025-02-21T04:55:17.270Z,1740113717.270 [sci2_slowyo_test:DiveCmd:InitialDive:dive:ApproachDepth:A.SetSpeed](DEBUG): Initialize.
2025-02-21T04:55:17.270Z,1740113717.270 [sci2_slowyo_test:DiveCmd:InitialDive:dive:ApproachDepth:B.Pitch] Running Loop=1
2025-02-21T04:55:17.270Z,1740113717.270 [sci2_slowyo_test:DiveCmd:InitialDive:dive:ApproachDepth:B.Pitch](DEBUG): Initialize.
2025-02-21T04:55:17.718Z,1740113717.718 [sci2_slowyo_test:DiveCmd:InitialDive:dive:ApproachDepth:A.SetSpeed] Running Loop=1
2025-02-21T04:56:03.869Z,1740113763.869 [ElevatorOffsetCalculator](INFO): New estimator for commanded vars: speed 0.95 m/s, pitch 30.00 deg, mass-position 11.65 mm (3 active estimators).
2025-02-21T04:56:52.536Z,1740113812.536 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-02-21T04:57:04.243Z,1740113824.243 [Radio_Surface](INFO): Powering down
2025-02-21T04:57:23.660Z,1740113843.660 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-02-21T04:57:24.664Z,1740113844.664 [DataOverHttps](INFO): Radio surface powered OFF, will not connect.
2025-02-21T04:57:36.857Z,1740113856.857 [sci2_slowyo_test:DiveCmd:InitialDive:dive:ApproachDepth:B.Pitch] Stopped
2025-02-21T04:57:36.857Z,1740113856.857 [sci2_slowyo_test:DiveCmd:InitialDive:dive:ApproachDepth](INFO): Completed sci2_slowyo_test:DiveCmd:InitialDive:dive:ApproachDepth
2025-02-21T04:57:36.857Z,1740113856.857 [sci2_slowyo_test:DiveCmd:InitialDive:dive:ApproachDepth] Stopped
2025-02-21T04:57:36.858Z,1740113856.858 [sci2_slowyo_test:DiveCmd:InitialDive:dive:ApproachDepth](DEBUG): Aggregate::uninitialize sci2_slowyo_test:DiveCmd:InitialDive:dive:ApproachDepth
2025-02-21T04:57:36.858Z,1740113856.858 [sci2_slowyo_test:DiveCmd:InitialDive:dive:ApproachDepth:A.SetSpeed] Stopped
2025-02-21T04:57:36.858Z,1740113856.858 [sci2_slowyo_test:DiveCmd:InitialDive:dive:ApproachDepth:A.SetSpeed](DEBUG): Uninitialize.
2025-02-21T04:57:36.858Z,1740113856.858 [sci2_slowyo_test:DiveCmd:InitialDive:dive:G] Running Loop=1
2025-02-21T04:57:37.277Z,1740113857.277 [sci2_slowyo_test:DiveCmd:InitialDive:dive:G] Stopped
2025-02-21T04:57:37.278Z,1740113857.278 [sci2_slowyo_test:DiveCmd:InitialDive:dive](INFO): Completed sci2_slowyo_test:DiveCmd:InitialDive:dive
2025-02-21T04:57:37.278Z,1740113857.278 [sci2_slowyo_test:DiveCmd:InitialDive:dive] Stopped
2025-02-21T04:57:37.278Z,1740113857.278 [sci2_slowyo_test:DiveCmd:InitialDive:dive](DEBUG): Aggregate::uninitialize sci2_slowyo_test:DiveCmd:InitialDive:dive
2025-02-21T04:57:37.278Z,1740113857.278 [sci2_slowyo_test:DiveCmd:InitialDive:dive:A.Mass] Stopped
2025-02-21T04:57:37.278Z,1740113857.278 [sci2_slowyo_test:DiveCmd:InitialDive:dive:A.Mass](DEBUG): Uninitialize.
2025-02-21T04:57:37.278Z,1740113857.278 [sci2_slowyo_test:DiveCmd:InitialDive:dive:B.Buoyancy] Stopped
2025-02-21T04:57:37.278Z,1740113857.278 [sci2_slowyo_test:DiveCmd:InitialDive:dive:B.Buoyancy](DEBUG): Uninitialize Buoyancy Component.
2025-02-21T04:57:37.278Z,1740113857.278 [sci2_slowyo_test:DiveCmd:InitialDive](INFO): Completed sci2_slowyo_test:DiveCmd:InitialDive
2025-02-21T04:57:37.681Z,1740113857.681 [sci2_slowyo_test:DiveCmd:SlowYoToWaypoint] Running Loop=1
2025-02-21T04:57:37.681Z,1740113857.681 [sci2_slowyo_test:DiveCmd:SlowYoToWaypoint](DEBUG): Aggregate::initialize sci2_slowyo_test:DiveCmd:SlowYoToWaypoint
2025-02-21T04:57:37.682Z,1740113857.682 [sci2_slowyo_test:DiveCmd:SlowYoToWaypoint:SlowYoTask] Running Loop=1
2025-02-21T04:57:37.682Z,1740113857.682 [sci2_slowyo_test:DiveCmd:SlowYoToWaypoint:SlowYoTask](DEBUG): Aggregate::initialize sci2_slowyo_test:DiveCmd:SlowYoToWaypoint:SlowYoTask
2025-02-21T04:57:37.682Z,1740113857.682 [sci2_slowyo_test:DiveCmd:SlowYoToWaypoint:SlowYoTask:A.Buoyancy] Running Loop=1
2025-02-21T04:57:37.682Z,1740113857.682 [sci2_slowyo_test:DiveCmd:SlowYoToWaypoint:SlowYoTask:A.Buoyancy](DEBUG): Initialize Buoyancy Component.
2025-02-21T04:57:37.682Z,1740113857.682 [sci2_slowyo_test:DiveCmd:SlowYoToWaypoint:SlowYoTask:B.Pitch] Running Loop=1
2025-02-21T04:57:37.682Z,1740113857.682 [sci2_slowyo_test:DiveCmd:SlowYoToWaypoint:SlowYoTask:B.Pitch](DEBUG): Initialize.
2025-02-21T04:57:37.682Z,1740113857.682 [sci2_slowyo_test:DiveCmd:SlowYoToWaypoint:SlowYoTask:C.SetSpeed] Running Loop=1
2025-02-21T04:57:37.682Z,1740113857.682 [sci2_slowyo_test:DiveCmd:SlowYoToWaypoint:SlowYoTask:C.SetSpeed](DEBUG): Initialize.
2025-02-21T04:57:37.682Z,1740113857.682 [sci2_slowyo_test:DiveCmd:SlowYoToWaypoint:SlowYoTask:SlowYoLoop] Running Loop=1
2025-02-21T04:57:37.683Z,1740113857.683 [sci2_slowyo_test:DiveCmd:SlowYoToWaypoint:SlowYoTask:SlowYoLoop](DEBUG): Aggregate::initialize sci2_slowyo_test:DiveCmd:SlowYoToWaypoint:SlowYoTask:SlowYoLoop
2025-02-21T04:57:37.683Z,1740113857.683 [sci2_slowyo_test:DiveCmd:SlowYoToWaypoint:SlowYoTask:SlowYoLoop:A.SlowYo] Running Loop=1
2025-02-21T04:57:37.683Z,1740113857.683 [sci2_slowyo_test:DiveCmd:SlowYoToWaypoint:SlowYoTask:SlowYoLoop:A.SlowYo](DEBUG): Initialize SlowYoComponent.
2025-02-21T04:57:37.683Z,1740113857.683 [sci2_slowyo_test:DiveCmd:SlowYoToWaypoint] Running Loop=1
2025-02-21T04:57:37.683Z,1740113857.683 [sci2_slowyo_test:DiveCmd:SlowYoToWaypoint:SlowYoTask] Running Loop=1
2025-02-21T04:57:37.684Z,1740113857.684 [sci2_slowyo_test:DiveCmd:SlowYoToWaypoint:SlowYoTask:C.SetSpeed] Running Loop=1
2025-02-21T04:57:37.684Z,1740113857.684 [sci2_slowyo_test:DiveCmd:SlowYoToWaypoint:SlowYoTask:B.Pitch] Running Loop=1
2025-02-21T04:57:37.684Z,1740113857.684 [sci2_slowyo_test:DiveCmd:SlowYoToWaypoint:SlowYoTask:A.Buoyancy] Running Loop=1
2025-02-21T04:57:38.473Z,1740113858.473 [ElevatorOffsetCalculator](INFO): New estimator for commanded vars: speed 0.95 m/s, pitch -0.00 deg, mass-position 11.65 mm (4 active estimators).
2025-02-21T04:58:18.638Z,1740113898.638 [ElevatorOffsetCalculator](INFO): New estimator for commanded vars: speed 0.95 m/s, pitch -1.00 deg, mass-position 11.65 mm (5 active estimators).
2025-02-21T04:58:45.780Z,1740113925.780 [sci2_slowyo_test:BackseatDriver:A.BackseatDriver](INFO): Created data writer for _.simrad_data_logging_rate with code: 1976
2025-02-21T04:58:54.284Z,1740113934.284 [ElevatorOffsetCalculator](INFO): New estimator for commanded vars: speed 0.95 m/s, pitch -2.01 deg, mass-position 11.65 mm (6 active estimators).
2025-02-21T04:59:02.060Z,1740113942.060 [DataOverHttps](INFO): setting unavailable, lastComms_.elapsed()=180.727081
2025-02-21T04:59:29.856Z,1740113969.856 [ElevatorOffsetCalculator](INFO): New estimator for commanded vars: speed 0.95 m/s, pitch -3.01 deg, mass-position 11.65 mm (7 active estimators).
2025-02-21T05:00:05.684Z,1740114005.684 [ElevatorOffsetCalculator](INFO): New estimator for commanded vars: speed 0.95 m/s, pitch -4.02 deg, mass-position 11.65 mm (8 active estimators).
2025-02-21T05:00:41.231Z,1740114041.231 [ElevatorOffsetCalculator](INFO): New estimator for commanded vars: speed 0.95 m/s, pitch -5.03 deg, mass-position 11.65 mm (9 active estimators).
2025-02-21T05:01:16.919Z,1740114076.919 [ElevatorOffsetCalculator](INFO): New estimator for commanded vars: speed 0.95 m/s, pitch -6.04 deg, mass-position 11.65 mm (A active estimators).
2025-02-21T05:01:52.624Z,1740114112.624 [ElevatorOffsetCalculator](INFO): New estimator for commanded vars: speed 0.95 m/s, pitch -7.04 deg, mass-position 11.65 mm (B active estimators).
2025-02-21T05:10:11.574Z,1740114611.574 [CTD_Seabird](ERROR): Failed to parse device response: 3,3.63661,3411.80
2025-02-21T05:28:16.456Z,1740115696.456 [ThrusterHE](DEBUG): Uninitialize Thruster Servo.
2025-02-21T05:28:16.456Z,1740115696.456 [ThrusterHE](INFO): Powering down
2025-02-21T05:28:17.288Z,1740115697.288 [ThrusterHE](DEBUG): Initializing EZServoServo.
2025-02-21T05:28:17.409Z,1740115697.409 [ThrusterHE](DEBUG): Initializing ThrusterHE.
2025-02-21T05:30:34.945Z,1740115834.945 [sci2_slowyo_test:Lap:Wpt1:A.Waypoint](IMPORTANT): Reached waypoint: 36.797001,-121.847000
2025-02-21T05:30:34.945Z,1740115834.945 [sci2_slowyo_test:Lap:Wpt1:A.Waypoint] Stopped
2025-02-21T05:30:34.945Z,1740115834.945 [sci2_slowyo_test:Lap:Wpt1:A.Waypoint](DEBUG): Uninitialize WaypointComponent.
2025-02-21T05:30:34.946Z,1740115834.946 [sci2_slowyo_test:Lap:Wpt1](INFO): Completed sci2_slowyo_test:Lap:Wpt1
2025-02-21T05:30:34.946Z,1740115834.946 [sci2_slowyo_test:Lap:Wpt1] Stopped
2025-02-21T05:30:34.946Z,1740115834.946 [sci2_slowyo_test:Lap:Wpt1](DEBUG): Aggregate::uninitialize sci2_slowyo_test:Lap:Wpt1
2025-02-21T05:30:34.946Z,1740115834.946 [sci2_slowyo_test:Lap:Wpt2] Running Loop=1
2025-02-21T05:30:34.946Z,1740115834.946 [sci2_slowyo_test:Lap:Wpt2](DEBUG): Aggregate::initialize sci2_slowyo_test:Lap:Wpt2
2025-02-21T05:30:34.946Z,1740115834.946 [sci2_slowyo_test:Lap:Wpt2:A.Waypoint] Running Loop=1
2025-02-21T05:30:34.947Z,1740115834.947 [sci2_slowyo_test:Lap:Wpt2:A.Waypoint](DEBUG): Initialize WaypointComponent.
2025-02-21T05:30:35.342Z,1740115835.342 [sci2_slowyo_test:Lap:Wpt2:A.Waypoint] Stopped
2025-02-21T05:30:35.342Z,1740115835.342 [sci2_slowyo_test:Lap:Wpt2:A.Waypoint](DEBUG): Uninitialize WaypointComponent.
2025-02-21T05:30:35.342Z,1740115835.342 [sci2_slowyo_test:Lap:Wpt2](INFO): Completed sci2_slowyo_test:Lap:Wpt2
2025-02-21T05:30:35.342Z,1740115835.342 [sci2_slowyo_test:Lap:Wpt2] Stopped
2025-02-21T05:30:35.343Z,1740115835.343 [sci2_slowyo_test:Lap:Wpt2](DEBUG): Aggregate::uninitialize sci2_slowyo_test:Lap:Wpt2
2025-02-21T05:30:35.343Z,1740115835.343 [sci2_slowyo_test:Lap:Wpt3] Running Loop=1
2025-02-21T05:30:35.359Z,1740115835.359 [sci2_slowyo_test:Lap:Wpt3](DEBUG): Aggregate::initialize sci2_slowyo_test:Lap:Wpt3
2025-02-21T05:30:35.359Z,1740115835.359 [sci2_slowyo_test:Lap:Wpt3:A.Waypoint] Running Loop=1
2025-02-21T05:30:35.359Z,1740115835.359 [sci2_slowyo_test:Lap:Wpt3:A.Waypoint](DEBUG): Initialize WaypointComponent.
2025-02-21T05:30:35.746Z,1740115835.746 [sci2_slowyo_test:Lap:Wpt3:A.Waypoint] Stopped
2025-02-21T05:30:35.746Z,1740115835.746 [sci2_slowyo_test:Lap:Wpt3:A.Waypoint](DEBUG): Uninitialize WaypointComponent.
2025-02-21T05:30:35.746Z,1740115835.746 [sci2_slowyo_test:Lap:Wpt3](INFO): Completed sci2_slowyo_test:Lap:Wpt3
2025-02-21T05:30:35.746Z,1740115835.746 [sci2_slowyo_test:Lap:Wpt3] Stopped
2025-02-21T05:30:35.746Z,1740115835.746 [sci2_slowyo_test:Lap:Wpt3](DEBUG): Aggregate::uninitialize sci2_slowyo_test:Lap:Wpt3
2025-02-21T05:30:35.747Z,1740115835.747 [sci2_slowyo_test:Lap:Wpt4] Running Loop=1
2025-02-21T05:30:35.747Z,1740115835.747 [sci2_slowyo_test:Lap:Wpt4](DEBUG): Aggregate::initialize sci2_slowyo_test:Lap:Wpt4
2025-02-21T05:30:35.747Z,1740115835.747 [sci2_slowyo_test:Lap:Wpt4:A.Waypoint] Running Loop=1
2025-02-21T05:30:35.747Z,1740115835.747 [sci2_slowyo_test:Lap:Wpt4:A.Waypoint](DEBUG): Initialize WaypointComponent.
2025-02-21T05:30:36.161Z,1740115836.161 [sci2_slowyo_test:Lap:Wpt4:A.Waypoint] Stopped
2025-02-21T05:30:36.161Z,1740115836.161 [sci2_slowyo_test:Lap:Wpt4:A.Waypoint](DEBUG): Uninitialize WaypointComponent.
2025-02-21T05:30:36.161Z,1740115836.161 [sci2_slowyo_test:Lap:Wpt4](INFO): Completed sci2_slowyo_test:Lap:Wpt4
2025-02-21T05:30:36.162Z,1740115836.162 [sci2_slowyo_test:Lap:Wpt4] Stopped
2025-02-21T05:30:36.162Z,1740115836.162 [sci2_slowyo_test:Lap:Wpt4](DEBUG): Aggregate::uninitialize sci2_slowyo_test:Lap:Wpt4
2025-02-21T05:30:36.162Z,1740115836.162 [sci2_slowyo_test:Lap:Wpt5] Running Loop=1
2025-02-21T05:30:36.162Z,1740115836.162 [sci2_slowyo_test:Lap:Wpt5](DEBUG): Aggregate::initialize sci2_slowyo_test:Lap:Wpt5
2025-02-21T05:30:36.162Z,1740115836.162 [sci2_slowyo_test:Lap:Wpt5:A.Waypoint] Running Loop=1
2025-02-21T05:30:36.162Z,1740115836.162 [sci2_slowyo_test:Lap:Wpt5:A.Waypoint](DEBUG): Initialize WaypointComponent.
2025-02-21T05:30:36.564Z,1740115836.564 [sci2_slowyo_test:Lap:Wpt5:A.Waypoint] Stopped
2025-02-21T05:30:36.564Z,1740115836.564 [sci2_slowyo_test:Lap:Wpt5:A.Waypoint](DEBUG): Uninitialize WaypointComponent.
2025-02-21T05:30:36.564Z,1740115836.564 [sci2_slowyo_test:Lap:Wpt5](INFO): Completed sci2_slowyo_test:Lap:Wpt5
2025-02-21T05:30:36.564Z,1740115836.564 [sci2_slowyo_test:Lap:Wpt5] Stopped
2025-02-21T05:30:36.564Z,1740115836.564 [sci2_slowyo_test:Lap:Wpt5](DEBUG): Aggregate::uninitialize sci2_slowyo_test:Lap:Wpt5
2025-02-21T05:30:36.565Z,1740115836.565 [sci2_slowyo_test:Lap:Wpt6] Running Loop=1
2025-02-21T05:30:36.565Z,1740115836.565 [sci2_slowyo_test:Lap:Wpt6](DEBUG): Aggregate::initialize sci2_slowyo_test:Lap:Wpt6
2025-02-21T05:30:36.565Z,1740115836.565 [sci2_slowyo_test:Lap:Wpt6:A.Waypoint] Running Loop=1
2025-02-21T05:30:36.565Z,1740115836.565 [sci2_slowyo_test:Lap:Wpt6:A.Waypoint](DEBUG): Initialize WaypointComponent.
2025-02-21T05:30:36.955Z,1740115836.955 [sci2_slowyo_test:Lap:Wpt6:A.Waypoint] Stopped
2025-02-21T05:30:36.955Z,1740115836.955 [sci2_slowyo_test:Lap:Wpt6:A.Waypoint](DEBUG): Uninitialize WaypointComponent.
2025-02-21T05:30:36.955Z,1740115836.955 [sci2_slowyo_test:Lap:Wpt6](INFO): Completed sci2_slowyo_test:Lap:Wpt6
2025-02-21T05:30:36.955Z,1740115836.955 [sci2_slowyo_test:Lap:Wpt6] Stopped
2025-02-21T05:30:36.955Z,1740115836.955 [sci2_slowyo_test:Lap:Wpt6](DEBUG): Aggregate::uninitialize sci2_slowyo_test:Lap:Wpt6
2025-02-21T05:30:36.956Z,1740115836.956 [sci2_slowyo_test:Lap:Wpt7] Running Loop=1
2025-02-21T05:30:36.956Z,1740115836.956 [sci2_slowyo_test:Lap:Wpt7](DEBUG): Aggregate::initialize sci2_slowyo_test:Lap:Wpt7
2025-02-21T05:30:36.956Z,1740115836.956 [sci2_slowyo_test:Lap:Wpt7:A.Waypoint] Running Loop=1
2025-02-21T05:30:36.956Z,1740115836.956 [sci2_slowyo_test:Lap:Wpt7:A.Waypoint](DEBUG): Initialize WaypointComponent.
2025-02-21T05:30:37.373Z,1740115837.373 [sci2_slowyo_test:Lap:Wpt7:A.Waypoint] Stopped
2025-02-21T05:30:37.373Z,1740115837.373 [sci2_slowyo_test:Lap:Wpt7:A.Waypoint](DEBUG): Uninitialize WaypointComponent.
2025-02-21T05:30:37.374Z,1740115837.374 [sci2_slowyo_test:Lap:Wpt7](INFO): Completed sci2_slowyo_test:Lap:Wpt7
2025-02-21T05:30:37.374Z,1740115837.374 [sci2_slowyo_test:Lap:Wpt7] Stopped
2025-02-21T05:30:37.374Z,1740115837.374 [sci2_slowyo_test:Lap:Wpt7](DEBUG): Aggregate::uninitialize sci2_slowyo_test:Lap:Wpt7
2025-02-21T05:30:37.374Z,1740115837.374 [sci2_slowyo_test:Lap](INFO): Completed sci2_slowyo_test:Lap
2025-02-21T05:30:37.374Z,1740115837.374 [sci2_slowyo_test:Lap] Stopped
2025-02-21T05:30:37.374Z,1740115837.374 [sci2_slowyo_test:Lap](DEBUG): Aggregate::uninitialize sci2_slowyo_test:Lap
2025-02-21T05:30:37.374Z,1740115837.374 [sci2_slowyo_test:Lap:Dive] Stopped
2025-02-21T05:30:37.374Z,1740115837.374 [sci2_slowyo_test:Lap:Dive](DEBUG): Aggregate::uninitialize sci2_slowyo_test:Lap:Dive
2025-02-21T05:30:37.374Z,1740115837.374 [sci2_slowyo_test:Lap:Dive:A] Stopped
2025-02-21T05:30:37.374Z,1740115837.374 [sci2_slowyo_test:Lap:Dive:A](DEBUG): Aggregate::uninitialize sci2_slowyo_test:Lap:Dive:A
2025-02-21T05:30:37.382Z,1740115837.382 [sci2_slowyo_test](INFO): Completed sci2_slowyo_test
2025-02-21T05:30:37.382Z,1740115837.382 [MissionManager](INFO): sci2_slowyo_test is completed.
2025-02-21T05:30:37.382Z,1740115837.382 [MissionManager](INFO): Uninitializing Mission sci2_slowyo_test
2025-02-21T05:30:37.382Z,1740115837.382 [sci2_slowyo_test] Stopped
2025-02-21T05:30:37.382Z,1740115837.382 [sci2_slowyo_test](DEBUG): Aggregate::uninitialize sci2_slowyo_test
2025-02-21T05:30:37.382Z,1740115837.382 [sci2_slowyo_test:Science] Stopped
2025-02-21T05:30:37.383Z,1740115837.383 [sci2_slowyo_test:Science](DEBUG): Aggregate::uninitialize sci2_slowyo_test:Science
2025-02-21T05:30:37.383Z,1740115837.383 [sci2_slowyo_test:Science:B] Stopped
2025-02-21T05:30:37.383Z,1740115837.383 [sci2_slowyo_test:Science:C] Stopped
2025-02-21T05:30:37.383Z,1740115837.383 [sci2_slowyo_test:Science:E] Stopped
2025-02-21T05:30:37.383Z,1740115837.383 [sci2_slowyo_test:Science:OceanCurrent] Stopped
2025-02-21T05:30:37.403Z,1740115837.403 [sci2_slowyo_test:Science:OceanCurrent](DEBUG): Aggregate::uninitialize sci2_slowyo_test:Science:OceanCurrent
2025-02-21T05:30:37.403Z,1740115837.403 [sci2_slowyo_test:Science:OceanCurrent:A.] Stopped
2025-02-21T05:30:37.403Z,1740115837.403 [sci2_slowyo_test:StandardEnvelopes] Stopped
2025-02-21T05:30:37.403Z,1740115837.403 [sci2_slowyo_test:StandardEnvelopes](DEBUG): Aggregate::uninitialize sci2_slowyo_test:StandardEnvelopes
2025-02-21T05:30:37.403Z,1740115837.403 [sci2_slowyo_test:StandardEnvelopes:A.AltitudeEnvelope] Stopped
2025-02-21T05:30:37.404Z,1740115837.404 [sci2_slowyo_test:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Uninitialize AltitudeEnvelopeComponent.
2025-02-21T05:30:37.404Z,1740115837.404 [sci2_slowyo_test:StandardEnvelopes:B.DepthEnvelope] Stopped
2025-02-21T05:30:37.404Z,1740115837.404 [sci2_slowyo_test:StandardEnvelopes:B.DepthEnvelope](DEBUG): Uninitialize.
2025-02-21T05:30:37.404Z,1740115837.404 [sci2_slowyo_test:StandardEnvelopes:C.OffshoreEnvelope] Stopped
2025-02-21T05:30:37.404Z,1740115837.404 [sci2_slowyo_test:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Uninitialize OffshoreEnvelopeComponent.
2025-02-21T05:30:37.404Z,1740115837.404 [sci2_slowyo_test:BackseatDriver] Stopped
2025-02-21T05:30:37.404Z,1740115837.404 [sci2_slowyo_test:BackseatDriver](DEBUG): Aggregate::uninitialize sci2_slowyo_test:BackseatDriver
2025-02-21T05:30:37.404Z,1740115837.404 [sci2_slowyo_test:BackseatDriver:A.BackseatDriver] Stopped
2025-02-21T05:30:37.404Z,1740115837.404 [sci2_slowyo_test:PowerOnly] Stopped
2025-02-21T05:30:37.404Z,1740115837.404 [sci2_slowyo_test:PowerOnly](DEBUG): Aggregate::uninitialize sci2_slowyo_test:PowerOnly
2025-02-21T05:30:37.404Z,1740115837.404 [sci2_slowyo_test:PowerOnly:E.Wait] Stopped
2025-02-21T05:30:37.404Z,1740115837.404 [sci2_slowyo_test:PowerOnly:E.Wait](DEBUG): Uninitialize Wait Component.
2025-02-21T05:30:37.405Z,1740115837.405 [sci2_slowyo_test:DiveCmd] Stopped
2025-02-21T05:30:37.405Z,1740115837.405 [sci2_slowyo_test:DiveCmd](DEBUG): Aggregate::uninitialize sci2_slowyo_test:DiveCmd
2025-02-21T05:30:37.405Z,1740115837.405 [sci2_slowyo_test:DiveCmd:InitialDive] Stopped
2025-02-21T05:30:37.405Z,1740115837.405 [sci2_slowyo_test:DiveCmd:InitialDive](DEBUG): Aggregate::uninitialize sci2_slowyo_test:DiveCmd:InitialDive
2025-02-21T05:30:37.405Z,1740115837.405 [sci2_slowyo_test:DiveCmd:SlowYoToWaypoint] Stopped
2025-02-21T05:30:37.405Z,1740115837.405 [sci2_slowyo_test:DiveCmd:SlowYoToWaypoint](DEBUG): Aggregate::uninitialize sci2_slowyo_test:DiveCmd:SlowYoToWaypoint
2025-02-21T05:30:37.405Z,1740115837.405 [sci2_slowyo_test:DiveCmd:SlowYoToWaypoint:SlowYoTask] Stopped
2025-02-21T05:30:37.405Z,1740115837.405 [sci2_slowyo_test:DiveCmd:SlowYoToWaypoint:SlowYoTask](DEBUG): Aggregate::uninitialize sci2_slowyo_test:DiveCmd:SlowYoToWaypoint:SlowYoTask
2025-02-21T05:30:37.405Z,1740115837.405 [sci2_slowyo_test:DiveCmd:SlowYoToWaypoint:SlowYoTask:A.Buoyancy] Stopped
2025-02-21T05:30:37.405Z,1740115837.405 [sci2_slowyo_test:DiveCmd:SlowYoToWaypoint:SlowYoTask:A.Buoyancy](DEBUG): Uninitialize Buoyancy Component.
2025-02-21T05:30:37.405Z,1740115837.405 [sci2_slowyo_test:DiveCmd:SlowYoToWaypoint:SlowYoTask:B.Pitch] Stopped
2025-02-21T05:30:37.405Z,1740115837.405 [sci2_slowyo_test:DiveCmd:SlowYoToWaypoint:SlowYoTask:C.SetSpeed] Stopped
2025-02-21T05:30:37.406Z,1740115837.406 [sci2_slowyo_test:DiveCmd:SlowYoToWaypoint:SlowYoTask:C.SetSpeed](DEBUG): Uninitialize.
2025-02-21T05:30:37.406Z,1740115837.406 [sci2_slowyo_test:DiveCmd:SlowYoToWaypoint:SlowYoTask:SlowYoLoop] Stopped
2025-02-21T05:30:37.406Z,1740115837.406 [sci2_slowyo_test:DiveCmd:SlowYoToWaypoint:SlowYoTask:SlowYoLoop](DEBUG): Aggregate::uninitialize sci2_slowyo_test:DiveCmd:SlowYoToWaypoint:SlowYoTask:SlowYoLoop
2025-02-21T05:30:37.406Z,1740115837.406 [sci2_slowyo_test:DiveCmd:SlowYoToWaypoint:SlowYoTask:SlowYoLoop:A.SlowYo] Stopped
2025-02-21T05:30:37.406Z,1740115837.406 [sci2_slowyo_test:DiveCmd:SlowYoToWaypoint:SlowYoTask:SlowYoLoop:A.SlowYo](DEBUG): Uninitialize SlowYoComponent.
2025-02-21T05:30:37.816Z,1740115837.816 [WetLabsBB2FL](INFO): Powering down
2025-02-21T05:30:37.967Z,1740115837.967 [BackseatComponent](INFO): Sent LCM shutdown request.
2025-02-21T05:30:37.968Z,1740115837.968 [BackseatComponent](INFO): Shutdown requested. Waiting (18.00 sec to power down.).
2025-02-21T05:30:38.010Z,1740115838.010 [MissionManager](IMPORTANT): Started mission Default
2025-02-21T05:30:38.010Z,1740115838.010 [Default] Running Loop=1
2025-02-21T05:30:38.011Z,1740115838.011 [Default](DEBUG): Aggregate::initialize Default
2025-02-21T05:30:38.011Z,1740115838.011 [Default:B.GoToSurface] Running Loop=1
2025-02-21T05:30:38.011Z,1740115838.011 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2025-02-21T05:30:38.011Z,1740115838.011 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2025-02-21T05:30:38.012Z,1740115838.012 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2025-02-21T05:30:38.012Z,1740115838.012 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2025-02-21T05:30:38.012Z,1740115838.012 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2025-02-21T05:30:38.012Z,1740115838.012 [Default:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds.
2025-02-21T05:30:38.013Z,1740115838.013 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2025-02-21T05:30:38.013Z,1740115838.013 [Default:A.Wait] Running Loop=1
2025-02-21T05:30:38.013Z,1740115838.013 [Default:A.Wait](DEBUG): Initialize Wait Component.
2025-02-21T05:30:38.709Z,1740115838.709 [Radio_Surface](INFO): Powering up
2025-02-21T05:30:44.931Z,1740115844.931 [DataOverHttps](INFO): Radio surface powered ON.
2025-02-21T05:30:51.320Z,1740115851.320 [Default:A.Wait](INFO): Done Waiting.
2025-02-21T05:30:51.320Z,1740115851.320 [Default:A.Wait] Stopped
2025-02-21T05:30:51.320Z,1740115851.320 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2025-02-21T05:30:55.980Z,1740115855.980 [BackseatComponent](INFO): Powering down and starting shutdown timer (18.00 sec).
2025-02-21T05:30:55.980Z,1740115855.980 [BackseatComponent](INFO): Unsubscribing from LCM channels.
2025-02-21T05:30:55.981Z,1740115855.981 [LcmUniversalReporter](INFO): Deactivating messaging.
2025-02-21T05:31:15.060Z,1740115875.060 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-02-21T05:31:46.183Z,1740115906.183 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-02-21T05:32:17.309Z,1740115937.309 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-02-21T05:32:48.432Z,1740115968.432 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-02-21T05:33:14.019Z,1740115994.019 [ElevatorOffsetCalculator](INFO): Removing expired estimator for commanded vars: speed 0.75 m/s, pitch 20.00 deg, mass-position 11.65 mm.
2025-02-21T05:33:14.025Z,1740115994.025 [Default:CheckIn] Running Loop=1
2025-02-21T05:33:14.025Z,1740115994.025 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-02-21T05:33:14.025Z,1740115994.025 [Default:CheckIn:Read_GPS] Running Loop=1
2025-02-21T05:33:19.555Z,1740115999.555 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-02-21T05:33:30.578Z,1740116010.578 [NAL9602](INFO): SBD MO Status=1, MOMSN=13009, MT Status=0, MTMSN=0
2025-02-21T05:33:30.578Z,1740116010.578 [NAL9602](INFO): No messages in MT queue
2025-02-21T05:33:31.785Z,1740116011.785 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,053331.00,A,3647.73393,N,12150.89895,W,0.719,232.60,210225,,,A*7E
2025-02-21T05:33:31.788Z,1740116011.788 [NAL9602](INFO): GPS fix at 20250221T053331: (36.795566, -121.848316)
2025-02-21T05:33:31.800Z,1740116011.800 [UniversalFixResidualReporter](INFO): Fix residual: 7.3 %DT, over the last 2096.6 m. Residual distance 153.0 m at bearing 66.3 degrees. Fix at (36.7956, -121.8483) with 1824.3 m made good.
2025-02-21T05:33:31.801Z,1740116011.801 [Default:CheckIn:Read_GPS] Stopped
2025-02-21T05:33:31.801Z,1740116011.801 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-02-21T05:33:48.728Z,1740116028.728 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.006186
2025-02-21T05:33:50.099Z,1740116030.099 [NAL9602](INFO): SBD MO Status=1, MOMSN=13010, MT Status=0, MTMSN=0
2025-02-21T05:33:50.152Z,1740116030.152 [NAL9602](INFO): Sent 207 bytes from file Logs/20250221T045125/Courier0006.lzma
2025-02-21T05:33:50.152Z,1740116030.152 [NAL9602](INFO): Packets left to send: 0
2025-02-21T05:33:56.976Z,1740116036.976 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20250221T045125/Courier0009.lzma
2025-02-21T05:33:57.977Z,1740116037.977 [DataOverHttps](INFO): Moved sent file to Logs/20250221T045125/Courier0009.lzma.bak
2025-02-21T05:33:57.977Z,1740116037.977 [DataOverHttps](INFO): SBD MOMSN=23970657
2025-02-21T05:34:20.590Z,1740116060.590 [NAL9602](INFO): Not Powering down - fast GPS
2025-02-21T05:34:35.817Z,1740116075.817 [DataOverHttps](INFO): Sending 788 bytes from file Logs/20250221T045125/Express0007.lzma
2025-02-21T05:34:36.817Z,1740116076.817 [DataOverHttps](INFO): Moved sent file to Logs/20250221T045125/Express0007.lzma.bak
2025-02-21T05:34:36.817Z,1740116076.817 [DataOverHttps](INFO): SBD MOMSN=23970662
2025-02-21T05:34:55.571Z,1740116095.571 [DataOverHttps](INFO): Sending 62 bytes from file Logs/20250221T045125/Express0010.lzma
2025-02-21T05:34:56.573Z,1740116096.573 [DataOverHttps](INFO): Moved sent file to Logs/20250221T045125/Express0010.lzma.bak
2025-02-21T05:34:56.574Z,1740116096.574 [DataOverHttps](INFO): SBD MOMSN=23970670
2025-02-21T05:34:58.343Z,1740116098.343 [Default:CheckIn:Read_Iridium] Stopped
2025-02-21T05:34:58.343Z,1740116098.343 [Default:CheckIn:C.Wait] Running Loop=1
2025-02-21T05:34:58.344Z,1740116098.344 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-02-21T05:35:09.977Z,1740116109.977 [DataOverHttps](IMPORTANT): SBD MTMSN=20250221T053509
2025-02-21T05:35:22.151Z,1740116122.151 [DataOverHttps](INFO): Received command: restart logs