2021-12-07T15:19:58.028Z,1638890398.028 [Supervisor](DEBUG): Initializing supervisor.
2021-12-07T15:19:58.032Z,1638890398.032 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2021-12-07T15:19:58.033Z,1638890398.033 [SyncHandler](INFO): Protected caller Thread ID is 1713
2021-12-07T15:19:58.033Z,1638890398.033 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2021-12-07T15:19:58.034Z,1638890398.034 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2021-12-07T15:19:58.035Z,1638890398.035 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 1714
2021-12-07T15:19:58.039Z,1638890398.039 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2021-12-07T15:19:58.058Z,1638890398.058 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread.
2021-12-07T15:19:58.059Z,1638890398.059 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2021-12-07T15:19:58.059Z,1638890398.059 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 1715
2021-12-07T15:19:58.063Z,1638890398.063 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2021-12-07T15:19:58.064Z,1638890398.064 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2021-12-07T15:19:58.064Z,1638890398.064 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 1716
2021-12-07T15:19:58.066Z,1638890398.066 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2021-12-07T15:19:58.067Z,1638890398.067 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0
2021-12-07T15:19:58.068Z,1638890398.068 [logger ThreadHandler](INFO): Protected caller Thread ID is 1717
2021-12-07T15:19:58.071Z,1638890398.071 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2021-12-07T15:19:58.072Z,1638890398.072 [Supervisor](INFO): Looking for Config files in directory: Config/
2021-12-07T15:19:58.073Z,1638890398.073 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2021-12-07T15:19:58.578Z,1638890398.578 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2021-12-07T15:19:58.579Z,1638890398.579 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2021-12-07T15:19:58.660Z,1638890398.660 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2021-12-07T15:19:58.983Z,1638890398.983 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2021-12-07T15:19:58.983Z,1638890398.983 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2021-12-07T15:19:59.091Z,1638890399.091 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2021-12-07T15:19:59.092Z,1638890399.092 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2021-12-07T15:19:59.288Z,1638890399.288 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2021-12-07T15:19:59.288Z,1638890399.288 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2021-12-07T15:19:59.796Z,1638890399.796 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2021-12-07T15:19:59.797Z,1638890399.797 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2021-12-07T15:20:00.060Z,1638890400.060 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2021-12-07T15:20:00.061Z,1638890400.061 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2021-12-07T15:20:00.208Z,1638890400.208 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2021-12-07T15:20:00.209Z,1638890400.209 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2021-12-07T15:20:00.399Z,1638890400.399 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2021-12-07T15:20:00.399Z,1638890400.399 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2021-12-07T15:20:00.497Z,1638890400.497 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2021-12-07T15:20:00.498Z,1638890400.498 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg
2021-12-07T15:20:00.717Z,1638890400.717 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock
2021-12-07T15:20:00.718Z,1638890400.718 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2021-12-07T15:20:01.101Z,1638890401.101 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2021-12-07T15:20:01.101Z,1638890401.101 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2021-12-07T15:20:01.183Z,1638890401.183 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2021-12-07T15:20:01.309Z,1638890401.309 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2021-12-07T15:20:01.310Z,1638890401.310 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2021-12-07T15:20:01.997Z,1638890401.997 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2021-12-07T15:20:01.997Z,1638890401.997 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2021-12-07T15:20:02.356Z,1638890402.356 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2021-12-07T15:20:02.358Z,1638890402.358 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-polaris/
2021-12-07T15:20:02.359Z,1638890402.359 [Supervisor](INFO): Opening Config file at: Config/lrauv-polaris/vehicle.cfg
2021-12-07T15:20:02.657Z,1638890402.657 [Supervisor](INFO): Opening Config file at: Config/lrauv-polaris/Control.cfg
2021-12-07T15:20:03.180Z,1638890403.180 [Supervisor](INFO): Opening Config file at: Config/lrauv-polaris/Estimation.cfg
2021-12-07T15:20:03.508Z,1638890403.508 [Supervisor](INFO): Opening Config file at: Config/lrauv-polaris/BIT.cfg
2021-12-07T15:20:03.689Z,1638890403.689 [Supervisor](INFO): Opening Config file at: Config/lrauv-polaris/Battery.cfg
2021-12-07T15:20:03.946Z,1638890403.946 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2021-12-07T15:20:03.946Z,1638890403.946 [Supervisor](INFO): Opening Config file at: Config/lrauv-polaris/Simulator.cfg
2021-12-07T15:20:04.032Z,1638890404.032 [Supervisor](INFO): Opening Config file at: Config/lrauv-polaris/Navigation.cfg
2021-12-07T15:20:04.135Z,1638890404.135 [Supervisor](INFO): Opening Config file at: Config/lrauv-polaris/Derivation.cfg
2021-12-07T15:20:04.260Z,1638890404.260 [Supervisor](INFO): Opening Config file at: Config/lrauv-polaris/logger.cfg
2021-12-07T15:20:04.372Z,1638890404.372 [Supervisor](INFO): Opening Config file at: Config/lrauv-polaris/secure.cfg
2021-12-07T15:20:04.457Z,1638890404.457 [Supervisor](INFO): Opening Config file at: Config/lrauv-polaris/Dock.cfg
2021-12-07T15:20:04.544Z,1638890404.544 [Supervisor](INFO): Opening Config file at: Config/lrauv-polaris/Servo.cfg
2021-12-07T15:20:04.656Z,1638890404.656 [Supervisor](INFO): Opening Config file at: Config/lrauv-polaris/workSite.cfg
2021-12-07T15:20:04.756Z,1638890404.756 [Supervisor](INFO): Opening Config file at: Config/lrauv-polaris/Sensor.cfg
2021-12-07T15:20:04.962Z,1638890404.962 [Supervisor](INFO): Opening Config file at: Config/lrauv-polaris/Science.cfg
2021-12-07T15:20:05.124Z,1638890405.124 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg
2021-12-07T15:20:05.137Z,1638890405.137 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2021-12-07T15:20:05.712Z,1638890405.712 [AHRS_M2] Loaded
2021-12-07T15:20:05.713Z,1638890405.713 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread.
2021-12-07T15:20:05.742Z,1638890405.742 [BackseatComponent] Loaded
2021-12-07T15:20:05.742Z,1638890405.742 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread.
2021-12-07T15:20:05.743Z,1638890405.743 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 407DD4E0
2021-12-07T15:20:05.743Z,1638890405.743 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 1811
2021-12-07T15:20:05.746Z,1638890405.746 [LcmUniversalReporter] Loaded
2021-12-07T15:20:05.746Z,1638890405.746 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread.
2021-12-07T15:20:06.498Z,1638890406.498 [BPC1] Loaded
2021-12-07T15:20:06.499Z,1638890406.499 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2021-12-07T15:20:06.571Z,1638890406.571 [DataOverHttps] Loaded
2021-12-07T15:20:06.571Z,1638890406.571 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2021-12-07T15:20:06.572Z,1638890406.572 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 4080D4E0
2021-12-07T15:20:06.572Z,1638890406.572 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 1812
2021-12-07T15:20:06.595Z,1638890406.595 [DDM] Loaded
2021-12-07T15:20:06.596Z,1638890406.596 [ComponentRegistry](DEBUG): SyncComponent "DDM" handled in the control thread.
2021-12-07T15:20:06.614Z,1638890406.614 [Depth_Keller] Loaded
2021-12-07T15:20:06.615Z,1638890406.615 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2021-12-07T15:20:06.619Z,1638890406.619 [DropWeight] Loaded
2021-12-07T15:20:06.619Z,1638890406.619 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2021-12-07T15:20:06.662Z,1638890406.662 [DUSBL_Hydroid] Loaded
2021-12-07T15:20:06.662Z,1638890406.662 [ComponentRegistry](DEBUG): SyncComponent "DUSBL_Hydroid" handled in the control thread.
2021-12-07T15:20:06.709Z,1638890406.709 [Micromodem] Loaded
2021-12-07T15:20:06.709Z,1638890406.709 [ComponentRegistry](DEBUG): SyncComponent "Micromodem" handled in the control thread.
2021-12-07T15:20:06.765Z,1638890406.765 [NAL9602] Loaded
2021-12-07T15:20:06.765Z,1638890406.765 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2021-12-07T15:20:06.793Z,1638890406.793 [Onboard] Loaded
2021-12-07T15:20:06.793Z,1638890406.793 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread.
2021-12-07T15:20:06.794Z,1638890406.794 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 4083D4E0
2021-12-07T15:20:06.794Z,1638890406.794 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 1813
2021-12-07T15:20:06.805Z,1638890406.805 [Power24vConverter] Loaded
2021-12-07T15:20:06.806Z,1638890406.806 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread.
2021-12-07T15:20:06.819Z,1638890406.819 [Radio_Surface] Loaded
2021-12-07T15:20:06.819Z,1638890406.819 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2021-12-07T15:20:06.820Z,1638890406.820 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 4086D4E0
2021-12-07T15:20:06.820Z,1638890406.820 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 1814
2021-12-07T15:20:06.861Z,1638890406.861 [RDI_Pathfinder] Loaded
2021-12-07T15:20:06.862Z,1638890406.862 [ComponentRegistry](DEBUG): SyncComponent "RDI_Pathfinder" handled in the control thread.
2021-12-07T15:20:06.886Z,1638890406.886 [RDI_PathfinderUp] Loaded
2021-12-07T15:20:06.887Z,1638890406.887 [ComponentRegistry](DEBUG): SyncComponent "RDI_PathfinderUp" handled in the control thread.
2021-12-07T15:20:06.887Z,1638890406.887 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2021-12-07T15:20:06.888Z,1638890406.888 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2021-12-07T15:20:06.904Z,1638890406.904 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2021-12-07T15:20:06.905Z,1638890406.905 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2021-12-07T15:20:07.040Z,1638890407.040 [DeadReckonUsingMultipleVelocitySources] Loaded
2021-12-07T15:20:07.040Z,1638890407.040 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2021-12-07T15:20:07.063Z,1638890407.063 [LBLNavigation] Loaded
2021-12-07T15:20:07.064Z,1638890407.064 [ComponentRegistry](DEBUG): SyncComponent "LBLNavigation" handled in the control thread.
2021-12-07T15:20:07.076Z,1638890407.076 [NavChart] Loaded
2021-12-07T15:20:07.076Z,1638890407.076 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2021-12-07T15:20:07.082Z,1638890407.082 [UniversalFixResidualReporter] Loaded
2021-12-07T15:20:07.082Z,1638890407.082 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2021-12-07T15:20:07.092Z,1638890407.092 [WorkSite] Loaded
2021-12-07T15:20:07.092Z,1638890407.092 [ComponentRegistry](DEBUG): SyncComponent "WorkSite" handled in the control thread.
2021-12-07T15:20:07.093Z,1638890407.093 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2021-12-07T15:20:07.093Z,1638890407.093 [Module Loader](DEBUG): Loading Module at Modules/Dock.so
2021-12-07T15:20:07.208Z,1638890407.208 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking)
2021-12-07T15:20:07.209Z,1638890407.209 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2021-12-07T15:20:07.364Z,1638890407.364 [BuoyancyServo] Loaded
2021-12-07T15:20:07.364Z,1638890407.364 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2021-12-07T15:20:07.385Z,1638890407.385 [ElevatorServo] Loaded
2021-12-07T15:20:07.385Z,1638890407.385 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2021-12-07T15:20:07.405Z,1638890407.405 [MassServo] Loaded
2021-12-07T15:20:07.405Z,1638890407.405 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2021-12-07T15:20:07.425Z,1638890407.425 [RudderServo] Loaded
2021-12-07T15:20:07.425Z,1638890407.425 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2021-12-07T15:20:07.440Z,1638890407.440 [ThrusterHE] Loaded
2021-12-07T15:20:07.441Z,1638890407.441 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread.
2021-12-07T15:20:07.441Z,1638890407.441 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2021-12-07T15:20:07.442Z,1638890407.442 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2021-12-07T15:20:07.632Z,1638890407.632 [WetLabsSeaOWL_UV_A] Loaded
2021-12-07T15:20:07.632Z,1638890407.632 [ComponentRegistry](DEBUG): Component "WetLabsSeaOWL_UV_A" handled in its own thread.
2021-12-07T15:20:07.633Z,1638890407.633 [WetLabsSeaOWL_UV_A ThreadHandler](DEBUG): Created PCaller Thread at 409AA4E0
2021-12-07T15:20:07.633Z,1638890407.633 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Protected caller Thread ID is 1815
2021-12-07T15:20:07.634Z,1638890407.634 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2021-12-07T15:20:07.635Z,1638890407.635 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2021-12-07T15:20:08.002Z,1638890408.002 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2021-12-07T15:20:08.002Z,1638890408.002 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2021-12-07T15:20:08.420Z,1638890408.420 [DepthRateCalculator] Loaded
2021-12-07T15:20:08.420Z,1638890408.420 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2021-12-07T15:20:08.426Z,1638890408.426 [PitchRateCalculator] Loaded
2021-12-07T15:20:08.426Z,1638890408.426 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2021-12-07T15:20:08.446Z,1638890408.446 [SpeedCalculator] Loaded
2021-12-07T15:20:08.446Z,1638890408.446 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2021-12-07T15:20:08.507Z,1638890408.507 [TempGradientCalculator] Loaded
2021-12-07T15:20:08.508Z,1638890408.508 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread.
2021-12-07T15:20:08.579Z,1638890408.579 [VerticalHomogeneityIndexCalculator] Loaded
2021-12-07T15:20:08.579Z,1638890408.579 [ComponentRegistry](DEBUG): SyncComponent "VerticalHomogeneityIndexCalculator" handled in the control thread.
2021-12-07T15:20:08.596Z,1638890408.596 [YawRateCalculator] Loaded
2021-12-07T15:20:08.596Z,1638890408.596 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2021-12-07T15:20:08.665Z,1638890408.665 [ElevatorOffsetCalculator] Loaded
2021-12-07T15:20:08.665Z,1638890408.665 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2021-12-07T15:20:08.665Z,1638890408.665 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2021-12-07T15:20:08.666Z,1638890408.666 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2021-12-07T15:20:09.087Z,1638890409.087 [SBIT](DEBUG): Construct Startup Built In Test.
2021-12-07T15:20:09.099Z,1638890409.099 [SBIT] Loaded
2021-12-07T15:20:09.099Z,1638890409.099 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2021-12-07T15:20:09.102Z,1638890409.102 [IBIT](DEBUG): Construct Initiated Built In Test.
2021-12-07T15:20:09.114Z,1638890409.114 [IBIT] Loaded
2021-12-07T15:20:09.115Z,1638890409.115 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2021-12-07T15:20:09.120Z,1638890409.120 [CBIT](DEBUG): Construct Continuous Built In Test.
2021-12-07T15:20:09.221Z,1638890409.221 [CBIT] Loaded
2021-12-07T15:20:09.221Z,1638890409.221 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2021-12-07T15:20:09.221Z,1638890409.221 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2021-12-07T15:20:09.222Z,1638890409.222 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2021-12-07T15:20:09.301Z,1638890409.301 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2021-12-07T15:20:09.301Z,1638890409.301 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2021-12-07T15:20:09.431Z,1638890409.431 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2021-12-07T15:20:09.432Z,1638890409.432 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2021-12-07T15:20:09.500Z,1638890409.500 [VerticalControl](DEBUG): Construct VerticalControl.
2021-12-07T15:20:09.550Z,1638890409.550 [VerticalControl] Loaded
2021-12-07T15:20:09.551Z,1638890409.551 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2021-12-07T15:20:09.553Z,1638890409.553 [HorizontalControl](DEBUG): Construct HorizontalControl.
2021-12-07T15:20:09.589Z,1638890409.589 [HorizontalControl] Loaded
2021-12-07T15:20:09.589Z,1638890409.589 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2021-12-07T15:20:09.591Z,1638890409.591 [SpeedControl](DEBUG): Construct SpeedControl.
2021-12-07T15:20:09.593Z,1638890409.593 [SpeedControl] Loaded
2021-12-07T15:20:09.593Z,1638890409.593 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2021-12-07T15:20:09.596Z,1638890409.596 [LoopControl](DEBUG): Construct LoopControl.
2021-12-07T15:20:09.596Z,1638890409.596 [LoopControl] Loaded
2021-12-07T15:20:09.597Z,1638890409.597 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2021-12-07T15:20:09.597Z,1638890409.597 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2021-12-07T15:20:09.598Z,1638890409.598 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2021-12-07T15:20:09.639Z,1638890409.639 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2021-12-07T15:20:09.645Z,1638890409.645 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2021-12-07T15:20:09.648Z,1638890409.648 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2021-12-07T15:20:09.659Z,1638890409.659 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2021-12-07T15:20:09.660Z,1638890409.660 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40B594E0
2021-12-07T15:20:09.660Z,1638890409.660 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 1816
2021-12-07T15:20:09.665Z,1638890409.665 [Supervisor](INFO): Main Thread ID is 828
2021-12-07T15:20:09.665Z,1638890409.665 [Supervisor](DEBUG): Running supervisor.
2021-12-07T15:20:09.665Z,1638890409.665 [CommandExec ThreadHandler](INFO): Handler Thread ID is 1817
2021-12-07T15:20:09.666Z,1638890409.666 [CommandExec](INFO): Initializing the command executive.
2021-12-07T15:20:09.668Z,1638890409.668 [CommandLine ThreadHandler](INFO): Handler Thread ID is 1818
2021-12-07T15:20:09.670Z,1638890409.670 [controlThread ThreadHandler](INFO): Handler Thread ID is 1819
2021-12-07T15:20:09.670Z,1638890409.670 [controlThread](DEBUG): Initializing ControlThread
2021-12-07T15:20:09.679Z,1638890409.679 [NavChart](DEBUG): Initialize NavChart Navigation.
2021-12-07T15:20:09.680Z,1638890409.680 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2021-12-07T15:20:09.680Z,1638890409.680 [WorkSite](DEBUG): Initializing WorkSite component.
2021-12-07T15:20:09.681Z,1638890409.681 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2021-12-07T15:20:09.682Z,1638890409.682 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2021-12-07T15:20:09.682Z,1638890409.682 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2021-12-07T15:20:09.682Z,1638890409.682 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator.
2021-12-07T15:20:09.683Z,1638890409.683 [VerticalHomogeneityIndexCalculator](DEBUG): (re)initializing
2021-12-07T15:20:09.684Z,1638890409.684 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2021-12-07T15:20:09.684Z,1638890409.684 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2021-12-07T15:20:09.685Z,1638890409.685 [SBIT](INFO): Initialize SBIT Component.
2021-12-07T15:20:09.685Z,1638890409.685 [SBIT](IMPORTANT): git: 2021-11-30-lbl-5-gf0c1fef04
2021-12-07T15:20:09.685Z,1638890409.685 [SBIT](INFO): git hash: f0c1fef0405c218674516adacb78469a675e0547
2021-12-07T15:20:09.686Z,1638890409.686 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2021-12-07T15:20:09.687Z,1638890409.687 [SBIT](INFO): Kernel Reporting Different Version From Configuration.
Kernel Expected: #2 PREEMPT Thu Jan 11 20:13:48 PST 2018
Kernel Reported: #1 PREEMPT Thu Aug 6 12:04:53 PDT 2020
2021-12-07T15:20:09.688Z,1638890409.688 [SBIT](INFO): Beginning SBIT in 32.000000 seconds.
2021-12-07T15:20:09.688Z,1638890409.688 [IBIT](INFO): Initialize IBIT Component.
2021-12-07T15:20:09.689Z,1638890409.689 [CBIT](DEBUG): Initialize CBIT Component.
2021-12-07T15:20:09.690Z,1638890409.690 [logger ThreadHandler](INFO): Handler Thread ID is 1820
2021-12-07T15:20:09.703Z,1638890409.703 [CBIT](DEBUG): Initialized mux pins.
2021-12-07T15:20:09.703Z,1638890409.703 [CBIT](DEBUG): Initializing the watchdog timer.
2021-12-07T15:20:09.708Z,1638890409.708 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 1821
2021-12-07T15:20:09.716Z,1638890409.716 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 1822
2021-12-07T15:20:09.717Z,1638890409.717 [DataOverHttps](DEBUG): dashIP=128.128.181.226 starts with a digit so assuming it is a numeric IP
2021-12-07T15:20:09.727Z,1638890409.727 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2021-12-07T15:20:09.728Z,1638890409.728 [CBIT](DEBUG): Initializing heartbeat.
2021-12-07T15:20:09.728Z,1638890409.728 [Onboard ThreadHandler](INFO): Handler Thread ID is 1823
2021-12-07T15:20:09.749Z,1638890409.749 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 1824
2021-12-07T15:20:09.764Z,1638890409.764 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Handler Thread ID is 1825
2021-12-07T15:20:09.764Z,1638890409.764 [WetLabsSeaOWL_UV_A](INFO): Powering down
2021-12-07T15:20:09.784Z,1638890409.784 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 1826
2021-12-07T15:20:09.792Z,1638890409.792 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2021-12-07T15:20:09.792Z,1638890409.792 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2021-12-07T15:20:09.792Z,1638890409.792 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2021-12-07T15:20:09.793Z,1638890409.793 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2021-12-07T15:20:09.793Z,1638890409.793 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2021-12-07T15:20:09.793Z,1638890409.793 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2021-12-07T15:20:09.793Z,1638890409.793 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000
2021-12-07T15:20:09.793Z,1638890409.793 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000
2021-12-07T15:20:09.793Z,1638890409.793 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2021-12-07T15:20:09.794Z,1638890409.794 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2021-12-07T15:20:09.794Z,1638890409.794 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000
2021-12-07T15:20:09.794Z,1638890409.794 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000
2021-12-07T15:20:09.794Z,1638890409.794 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000
2021-12-07T15:20:09.794Z,1638890409.794 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000
2021-12-07T15:20:09.794Z,1638890409.794 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000
2021-12-07T15:20:09.794Z,1638890409.794 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000
2021-12-07T15:20:09.799Z,1638890409.799 [CBIT](DEBUG): Deactivating GF circuits.
2021-12-07T15:20:09.799Z,1638890409.799 [CBIT](DEBUG): Deactivating emergency mode.
2021-12-07T15:20:09.835Z,1638890409.835 [CBIT](DEBUG): Backplane powered.
2021-12-07T15:20:09.836Z,1638890409.836 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2021-12-07T15:20:09.837Z,1638890409.837 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2021-12-07T15:20:09.838Z,1638890409.838 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2021-12-07T15:20:09.838Z,1638890409.838 [LoopControl](DEBUG): Initialize LoopControlComponent.
2021-12-07T15:20:09.839Z,1638890409.839 [MissionManager](INFO): Loading Mission: Missions/Startup.xml
2021-12-07T15:20:09.855Z,1638890409.855 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2021-12-07T15:20:09.886Z,1638890409.886 [MissionManager](DEBUG): 
<?xml version="1.0" encoding="UTF-8"?>
<Mission xmlns="Tethys"
       xmlns:Control="Tethys/Control"
       xmlns:Guidance="Tethys/Guidance" 
       xmlns:Units="Tethys/Units"
       xmlns:Universal="Tethys/Universal"
       xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"
       xsi:schemaLocation="Tethys http://okeanids.mbari.org/tethys/Xml/Tethys.xsd
                           Tethys/Control http://okeanids.mbari.org/tethys/Xml/Control.xsd
                           Tethys/Guidance http://okeanids.mbari.org/tethys/Xml/Guidance.xsd
                           Tethys/Units http://okeanids.mbari.org/tethys/Xml/Units.xsd
                           Tethys/Universal http://okeanids.mbari.org/tethys/Xml/Universal.xsd"
       Id="Startup">

    <Guidance:GoToSurface>
        <Progression/>
    </Guidance:GoToSurface>

    <Aggregate Id="StartupSatComms">

        <Sequence/>

        <ReadDatum>
            <Timeout Duration="P1M" />
            <Universal:latitude_fix/>
        </ReadDatum>

        <ReadDatum>
            <Timeout Duration="P1M" />
            <Universal:platform_communications/>
        </ReadDatum>

    </Aggregate>

</Mission>


2021-12-07T15:20:09.887Z,1638890409.887 [MissionManager](INFO): Loading Mission: Missions/underIce/DefaultWithUndock.xml
2021-12-07T15:20:10.034Z,1638890410.034 [MissionManager](INFO): DefineArg DefaultWithUndock.ElapsedSinceDefaultStarted = 0.000000 min
2021-12-07T15:20:10.041Z,1638890410.041 [MissionManager](INFO): DefineArg DefaultWithUndock.DetachTimeout = 30.000000 min
2021-12-07T15:20:10.045Z,1638890410.045 [MissionManager](INFO): DefineArg DefaultWithUndock.TransponderCode = 2 count
2021-12-07T15:20:10.064Z,1638890410.064 [MissionManager](INFO): DefineArg DefaultWithUndock.TrackingUpdatePeriod = 2.500000 s
2021-12-07T15:20:10.076Z,1638890410.076 [MissionManager](INFO): DefineArg DefaultWithUndock.NumberOfPings = 1.000000 count
2021-12-07T15:20:10.080Z,1638890410.080 [MissionManager](INFO): DefineArg DefaultWithUndock.DetachModeDDM = 2.000000 count
2021-12-07T15:20:10.081Z,1638890410.081 [DefaultWithUndock:A.Wait](DEBUG): Construct Wait.
2021-12-07T15:20:10.155Z,1638890410.155 [Radio_Surface](INFO): Powering up
2021-12-07T15:20:10.236Z,1638890410.236 [DefaultWithUndock:LeaveDock:B.Undock](DEBUG): Construct.
2021-12-07T15:20:10.237Z,1638890410.237 [DefaultWithUndock:LeaveDock:B.Undock](DEBUG): Initializing internal variables to default values.
2021-12-07T15:20:10.289Z,1638890410.289 [DefaultWithUndock:SurfaceDefault:B.GoToSurface](DEBUG): Construct GoToSurface.
2021-12-07T15:20:10.337Z,1638890410.337 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2021-12-07T15:20:10.340Z,1638890410.340 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](DEBUG): Construct Wait.
2021-12-07T15:20:10.355Z,1638890410.355 [DefaultWithUndock:E.Execute](DEBUG): Construct Execute.
2021-12-07T15:20:10.369Z,1638890410.369 [MissionManager](DEBUG): 
<?xml version="1.0" encoding="UTF-8"?>
<Mission xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"
         xmlns="Tethys"
         xmlns:Control="Tethys/Control"
         xmlns:Dock="Tethys/Dock"
         xmlns:Estimation="Tethys/Estimation"
         xmlns:Guidance="Tethys/Guidance"
         xmlns:Sensor="Tethys/Sensor"
         xmlns:Units="Tethys/Units"
         xmlns:Universal="Tethys/Universal"
         xsi:schemaLocation="Tethys http://okeanids.mbari.org/tethys/Xml/Tethys.xsd
                             Tethys/Control http://okeanids.mbari.org/tethys/Xml/Control.xsd
                             Tethys/Dock http://okeanids.mbari.org/tethys/Xml/Dock.xsd
                             Tethys/Estimation http://okeanids.mbari.org/tethys/Xml/Estimation.xsd
                             Tethys/Guidance http://okeanids.mbari.org/tethys/Xml/Guidance.xsd
                             Tethys/Sensor http://okeanids.mbari.org/tethys/Xml/Sensor.xsd
                             Tethys/Units http://okeanids.mbari.org/tethys/Xml/Units.xsd
                             Tethys/Universal http://okeanids.mbari.org/tethys/Xml/Universal.xsd"
         Id="DefaultWithUndock">

    <DefineArg Name="ElapsedSinceDefaultStarted"><Units:minute/><Value>0</Value></DefineArg>

    <DefineArg Name="DetachTimeout"><Description>
        Maximum time duration for the vehicle to detach form the dock.
    </Description><Units:minute/><Value>30</Value></DefineArg>

    <DefineArg Name="TransponderCode"><Description>
        Dock transponder address.
    </Description><Dock:Dock.transponderCode/></DefineArg>

    <DefineArg Name="TrackingUpdatePeriod"><Description>
        Time duration between acoustic range queries while the mission is
        detaching from the dock.
    </Description><Units:second/><Value>2.5</Value></DefineArg>

    <DefineArg Name="NumberOfPings"><Description>
        Number of pings requested each time.
    </Description><Units:count/><Value>1</Value></DefineArg>

    <DefineArg Name="DetachModeDDM"><Description>
        DDM DETACH mode enumeration (whiskers retracted, latch open).
    </Description><Units:count/><Value>2</Value></DefineArg>

    <Guidance:Wait>
        <Description>
            Wait a moment to see if the scheduler starts a new mission before
            starting to actually run Default.
        </Description>
        <Sequence/>
        <Setting><Guidance:Wait.duration/><Units:second/><Value>30</Value></Setting>
    </Guidance:Wait>

    <Aggregate Id="LeaveDock">

        <Sequence/>

        <Timeout Duration="DetachTimeout">
            <Syslog Severity="Important">Timed out while trying to detach from dock at current depth of <Universal:depth/><Units:meter/>.</Syslog>
        </Timeout>

<!-- Acoustic tracking directives -->

        <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>

<!-- Leave the dock -->

        <Dock:Undock>
            <Sequence/>
        </Dock:Undock>

    </Aggregate>

    <Aggregate Id="SurfaceDefault">

        <Sequence/>

        <Aggregate Id="HoldLatchOpen">

            <While>
                <Universal:depth/>
                <Gt><Control:VerticalControl.surfaceThreshold/></Gt>
            </While>

<!-- Power the Docking Module -->

            <ReadData>
                <Dock:Dock.docking_state/>
            </ReadData>

<!-- Hold the DDM in DETACH mode (whiskers retracted, latch open) -->

            <Assign><Parallel/><Dock:Dock.docking_state_cmd/><Arg Name="DetachModeDDM"/></Assign>

        </Aggregate>

<!-- This mission assumes open water so from here on it's the same old default that's always used -->

        <Guidance:GoToSurface>
            <Progression/>
        </Guidance:GoToSurface>

        <Aggregate Id="CheckIn">

            <Sequence Repeat="288"/>

            <ReadDatum Id="Read_GPS">
                <Timeout Duration="P5M"/>
                <Universal:time_fix/>
            </ReadDatum>

            <ReadDatum Id="Read_Iridium">
                <Timeout Duration="P2H">
                    <Guidance:Execute>
                        <Sequence/>
                        <Setting><Guidance:Execute.command/><String>Burn on</String></Setting>
                    </Guidance:Execute>
                    <Syslog Severity="Critical">Dropped weight due to communications timeout.</Syslog>
                </Timeout>
                <Universal:platform_communications/>
            </ReadDatum>

            <Guidance:Wait>
                <Sequence/>
                <Setting><Guidance:Wait.duration/><Units:minute/><Value>5</Value></Setting>
            </Guidance:Wait>

            <Assign><Sequence/><Arg Name="ElapsedSinceDefaultStarted"/><Elapsed><Universal:mission_started/></Elapsed></Assign>

            <Syslog Severity="Important">Default mission has been running for <Arg Name="ElapsedSinceDefaultStarted"/><Units:minute/></Syslog>

        </Aggregate>

    </Aggregate>

    <Syslog Severity="Important">Restarting logs and Default mission.</Syslog>

    <Guidance:Execute>
        <Sequence/>
        <Setting><Guidance:Execute.command/><String>restart logs</String></Setting>
    </Guidance:Execute>

</Mission>


2021-12-07T15:20:10.374Z,1638890410.374 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,DDM,Depth_Keller,DropWeight,DUSBL_Hydroid,Micromodem,NAL9602,Power24vConverter,RDI_Pathfinder,RDI_PathfinderUp,Depth_Keller,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,VerticalHomogeneityIndexCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,WorkSite,LBLNavigation,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter,
2021-12-07T15:20:10.387Z,1638890410.387 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2021-12-07T15:20:10.448Z,1638890410.448 [DDM](INFO): Powering up
2021-12-07T15:20:10.448Z,1638890410.448 [DDM](DEBUG): Initializing DDM.
2021-12-07T15:20:10.562Z,1638890410.562 [DUSBL_Hydroid](INFO): Powering up
2021-12-07T15:20:10.562Z,1638890410.562 [DUSBL_Hydroid](DEBUG): Initializing DUSBL_Hydroid.
2021-12-07T15:20:10.580Z,1638890410.580 [Power24vConverter](INFO): Powering up.
2021-12-07T15:20:10.628Z,1638890410.628 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2021-12-07T15:20:10.635Z,1638890410.635 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2021-12-07T15:20:10.637Z,1638890410.637 [ElevatorServo](DEBUG): Initializing EZServoServo.
2021-12-07T15:20:10.643Z,1638890410.643 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2021-12-07T15:20:10.644Z,1638890410.644 [MassServo](DEBUG): Initializing EZServoServo.
2021-12-07T15:20:10.651Z,1638890410.651 [MassServo](DEBUG): Initializing MassServo.
2021-12-07T15:20:10.652Z,1638890410.652 [RudderServo](DEBUG): Initializing EZServoServo.
2021-12-07T15:20:10.659Z,1638890410.659 [RudderServo](DEBUG): Initializing RudderServo.
2021-12-07T15:20:10.660Z,1638890410.660 [ThrusterHE](DEBUG): Initializing EZServoServo.
2021-12-07T15:20:10.667Z,1638890410.667 [ThrusterHE](DEBUG): Initializing ThrusterHE.
2021-12-07T15:20:10.802Z,1638890410.802 [Micromodem](INFO): Powering up
2021-12-07T15:20:10.802Z,1638890410.802 [Micromodem](DEBUG): Initializing Micromodem.
2021-12-07T15:20:11.511Z,1638890411.511 [RudderServo](ERROR): Rudder initialization uart error serial timeout
2021-12-07T15:20:11.511Z,1638890411.511 [RudderServo](FAULT): Rudder failed to initialize
2021-12-07T15:20:11.511Z,1638890411.511 [RudderServo] Communications Fault, FailCount= 1
2021-12-07T15:20:11.511Z,1638890411.511 [RudderServo](ERROR): Communications Fault
2021-12-07T15:20:11.515Z,1638890411.515 [CBIT](ERROR): Communications Fault in component: RudderServo
2021-12-07T15:20:11.731Z,1638890411.731 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2021-12-07T15:20:11.732Z,1638890411.732 [RudderServo](INFO): Powering down
2021-12-07T15:20:12.412Z,1638890412.412 [RudderServo](DEBUG): Initializing EZServoServo.
2021-12-07T15:20:12.532Z,1638890412.532 [RudderServo](DEBUG): Initializing RudderServo.
2021-12-07T15:20:12.536Z,1638890412.536 [CBIT](INFO): Clearing failed state for component RudderServo
2021-12-07T15:20:12.536Z,1638890412.536 [RudderServo] No Fault, FailCount= 1
2021-12-07T15:20:14.935Z,1638890414.935 [Micromodem](INFO): Nmea in: $CAREV,152016,INIT,2.1.4000*73

2021-12-07T15:20:15.270Z,1638890415.270 [Micromodem](INFO): Nmea in: $CAREV,152016,SLOT1,2.1.4000*5C

2021-12-07T15:20:15.675Z,1638890415.675 [Micromodem](INFO): Nmea in: $CAREV,152016,AUV,2.1.4000*2B

2021-12-07T15:20:15.676Z,1638890415.676 [Micromodem](INFO): Nmea in: $CAREV,152016,COPROC,0.20.0.39330*7A

2021-12-07T15:20:15.677Z,1638890415.677 [Micromodem](INFO): Nmea out: $CCCFG,ALL,0*33

2021-12-07T15:20:16.082Z,1638890416.082 [Micromodem](INFO): Nmea in: $CATMG,2021-12-07T15:20:16.075060Z,RTC,RTC*50

2021-12-07T15:20:16.083Z,1638890416.083 [Micromodem](ERROR): CFG response from modem unexpected: $CATMG,2021-12-07T15:20:16.075060Z,RTC,RTC*50

2021-12-07T15:20:16.482Z,1638890416.482 [Micromodem](INFO): Nmea in: $CACFG,ALL,0*31

2021-12-07T15:20:16.482Z,1638890416.482 [Micromodem](INFO): Nmea out: $CCCFG,POW,20*08

2021-12-07T15:20:16.882Z,1638890416.882 [Micromodem](INFO): Nmea in: $CACFG,POW,20*0A

2021-12-07T15:20:16.882Z,1638890416.882 [Micromodem](INFO): Nmea out: $CCCFG,SRC,1*31

2021-12-07T15:20:17.290Z,1638890417.290 [Micromodem](INFO): Nmea in: $CACFG,SRC,1*33

2021-12-07T15:20:17.290Z,1638890417.290 [Micromodem](INFO): Nmea out: $CCCFG,nav.dt.txtrig_gpio4,1*64

2021-12-07T15:20:17.698Z,1638890417.698 [Micromodem](INFO): Nmea in: $CACFG,nav.dt.txtrig_gpio4,1*66

2021-12-07T15:20:17.698Z,1638890417.698 [Micromodem](INFO): Nmea out: $CCCFG,pwramp.txlevel,0*2F

2021-12-07T15:20:18.098Z,1638890418.098 [Micromodem](INFO): Nmea in: $CACFG,pwramp.txlevel,0*2D

2021-12-07T15:20:18.098Z,1638890418.098 [Micromodem](INFO): Nmea out: $CCCFG,DTO,30*1E

2021-12-07T15:20:18.498Z,1638890418.498 [Micromodem](INFO): Nmea in: $CACFG,DTO,30*1C

2021-12-07T15:20:18.498Z,1638890418.498 [Micromodem](INFO): Nmea out: $CCCFG,FC0,14500*47

2021-12-07T15:20:18.894Z,1638890418.894 [Micromodem](INFO): Nmea in: $CACFG,FC0,14500*45

2021-12-07T15:20:18.894Z,1638890418.894 [Micromodem](INFO): Nmea out: $CCCFG,BW0,4000*63

2021-12-07T15:20:19.286Z,1638890419.286 [Micromodem](INFO): Nmea in: $CACFG,BW0,4000*61

2021-12-07T15:20:19.286Z,1638890419.286 [Micromodem](INFO): Nmea out: $CCCFG,BND,0*3A

2021-12-07T15:20:19.682Z,1638890419.682 [Micromodem](INFO): Nmea in: $CACFG,BND,0*38

2021-12-07T15:20:19.683Z,1638890419.683 [Micromodem](INFO): Nmea out: $CCCLK,2021,12,07,15,20,20*45

2021-12-07T15:20:20.086Z,1638890420.086 [Micromodem](INFO): Nmea in: $CACLK,2021,12,7,15,20,20*77

2021-12-07T15:20:20.894Z,1638890420.894 [Micromodem](INFO): Nmea in: $CATMS,0,2021-12-07T15:20:21Z*76

2021-12-07T15:20:20.896Z,1638890420.896 [Micromodem](INFO): Nmea in: $CATMG,2021-12-07T15:20:21.027630Z,USER_CMD,RTC*11

2021-12-07T15:20:24.937Z,1638890424.937 [Micromodem](INFO): Nmea in: $CAREV,152025,AUV,2.1.4000*2B

2021-12-07T15:20:24.940Z,1638890424.940 [Micromodem](INFO): Nmea in: $CAREV,152025,COPROC,0.20.0.39330*7A

2021-12-07T15:20:26.136Z,1638890426.136 [DDM](INFO): Latch/Whisker Boards:V1,H_RECOVERY_LATCH
!V2,H_RECOVERY_WHISKERS
2021-12-07T15:20:26.236Z,1638890426.236 [DDM](INFO): Dynamic Docking Module:C REMUS Capture Rev 1.1
2021-12-07T15:20:28.589Z,1638890428.589 [DUSBL_Hydroid](INFO): DUSBL Version:O
2021-12-07T15:20:35.030Z,1638890435.030 [Micromodem](INFO): Nmea in: $CAREV,152035,AUV,2.1.4000*2A

2021-12-07T15:20:35.031Z,1638890435.031 [Micromodem](INFO): Nmea in: $CAREV,152035,COPROC,0.20.0.39330*7B

2021-12-07T15:20:35.039Z,1638890435.039 [RDI_Pathfinder](ERROR): only read 3 of 4 data items
2021-12-07T15:20:37.050Z,1638890437.050 [NAL9602](INFO): Powering up NAL9602
2021-12-07T15:20:42.373Z,1638890442.373 [SBIT](IMPORTANT): Beginning Startup BIT
2021-12-07T15:20:42.378Z,1638890442.378 [CBIT](IMPORTANT): Beginning ground fault scan
2021-12-07T15:20:45.142Z,1638890445.142 [Micromodem](INFO): Nmea in: $CAREV,152045,AUV,2.1.4000*2D

2021-12-07T15:20:45.143Z,1638890445.143 [Micromodem](INFO): Nmea in: $CAREV,152045,COPROC,0.20.0.39330*7C

2021-12-07T15:20:45.155Z,1638890445.155 [RDI_Pathfinder](ERROR): only read 3 of 4 data items
2021-12-07T15:20:47.954Z,1638890447.954 [NAL9602](INFO): NAL9602 initialized
2021-12-07T15:20:53.300Z,1638890453.300 [CBIT](IMPORTANT): Ground fault detected
mA:
CHAN A0 (Batt): 0.333480
CHAN A1 (24V): 0.720909
CHAN A2 (12V): 0.152172
CHAN A3 (5V): -0.001668
CHAN B0 (3.3V): 0.000875
CHAN B1 (3.15aV): -0.000187
CHAN B2 (3.15bV): 0.000158
CHAN B3 (GND): 0.002141
OPEN: 0.006577
Full Scale: +/- 1 mA
2021-12-07T15:20:54.838Z,1638890454.838 [Micromodem](INFO): Nmea in: $CAREV,152055,AUV,2.1.4000*2C

2021-12-07T15:20:54.839Z,1638890454.839 [Micromodem](INFO): Nmea in: $CAREV,152055,COPROC,0.20.0.39330*7D

2021-12-07T15:20:54.857Z,1638890454.857 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for water mass range.
2021-12-07T15:21:04.926Z,1638890464.926 [Micromodem](INFO): Nmea in: $CAREV,152105,AUV,2.1.4000*28

2021-12-07T15:21:04.927Z,1638890464.927 [Micromodem](INFO): Nmea in: $CAREV,152105,COPROC,0.20.0.39330*79

2021-12-07T15:21:05.335Z,1638890465.335 [NAL9602](INFO): SBD MO Status=0, MOMSN=30348, MT Status=0, MTMSN=0
2021-12-07T15:21:05.335Z,1638890465.335 [NAL9602](INFO): No messages in MT queue
2021-12-07T15:21:15.026Z,1638890475.026 [Micromodem](INFO): Nmea in: $CAREV,152115,AUV,2.1.4000*29

2021-12-07T15:21:15.027Z,1638890475.027 [Micromodem](INFO): Nmea in: $CAREV,152115,COPROC,0.20.0.39330*78

2021-12-07T15:21:25.144Z,1638890485.144 [Micromodem](INFO): Nmea in: $CAREV,152125,AUV,2.1.4000*2A

2021-12-07T15:21:25.145Z,1638890485.145 [Micromodem](INFO): Nmea in: $CAREV,152125,COPROC,0.20.0.39330*7B

2021-12-07T15:21:34.838Z,1638890494.838 [Micromodem](INFO): Nmea in: $CAREV,152135,AUV,2.1.4000*2B

2021-12-07T15:21:34.839Z,1638890494.839 [Micromodem](INFO): Nmea in: $CAREV,152135,COPROC,0.20.0.39330*7A

2021-12-07T15:21:36.478Z,1638890496.478 [SBIT](IMPORTANT): SBIT PASSED
2021-12-07T15:21:36.478Z,1638890496.478 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2021-12-07T15:21:36.479Z,1638890496.479 [SBIT](IMPORTANT): CBIT.gfScanTimeout=2 hour;

2021-12-07T15:21:36.480Z,1638890496.480 [SBIT](IMPORTANT): CTD_Seabird.loadAtStartup=0 bool;

2021-12-07T15:21:36.480Z,1638890496.480 [SBIT](IMPORTANT): Express linearApproximation platform_average_current 0.500000 ampere;

2021-12-07T15:21:36.480Z,1638890496.480 [SBIT](IMPORTANT): LineCapture.latchDelayTimeout=10 second;

2021-12-07T15:21:36.480Z,1638890496.480 [SBIT](IMPORTANT): LineCapture.navigationGain=3 none;

2021-12-07T15:21:36.480Z,1638890496.480 [SBIT](IMPORTANT): LineCapture.rolloutDistance=250 meter;

2021-12-07T15:21:36.480Z,1638890496.480 [SBIT](IMPORTANT): LineCapture.rolloutSpeed=0 meter_per_second;

2021-12-07T15:21:36.480Z,1638890496.480 [SBIT](IMPORTANT): LineCapture.rolloutTimeout=25 minute;

2021-12-07T15:21:36.480Z,1638890496.480 [SBIT](IMPORTANT): PowerOnly.loadAtStartup=0 bool;

2021-12-07T15:21:36.480Z,1638890496.480 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=216.317193 cubic_centimeter;

2021-12-07T15:21:36.481Z,1638890496.481 [SBIT](IMPORTANT): VerticalControl.massDefault=-3.152899 millimeter;

2021-12-07T15:21:36.891Z,1638890496.891 [WorkSite](IMPORTANT): Reading workSite position from Data/workSite.cfg
2021-12-07T15:21:36.894Z,1638890496.894 [WorkSite](IMPORTANT): WorkSite fix at 20211207T151908: (41.552175, -70.703511)
2021-12-07T15:21:36.896Z,1638890496.896 [MissionManager](IMPORTANT): Started mission Startup
2021-12-07T15:21:36.896Z,1638890496.896 [Startup] Running Loop=1
2021-12-07T15:21:36.896Z,1638890496.896 [Startup](DEBUG): Aggregate::initialize Startup
2021-12-07T15:21:36.896Z,1638890496.896 [Startup:A.GoToSurface] Running Loop=1
2021-12-07T15:21:36.897Z,1638890496.897 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2021-12-07T15:21:36.897Z,1638890496.897 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2021-12-07T15:21:36.898Z,1638890496.898 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2021-12-07T15:21:36.898Z,1638890496.898 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2021-12-07T15:21:36.898Z,1638890496.898 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2021-12-07T15:21:36.899Z,1638890496.899 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2021-12-07T15:21:36.901Z,1638890496.901 [Startup:StartupSatComms] Running Loop=1
2021-12-07T15:21:36.901Z,1638890496.901 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2021-12-07T15:21:36.901Z,1638890496.901 [Startup:StartupSatComms:A] Running Loop=1
2021-12-07T15:21:37.287Z,1638890497.287 [LBLNavigation](INFO): Reset ping filters
2021-12-07T15:21:37.287Z,1638890497.287 [LBLNavigation](INFO): Reset fix filter
2021-12-07T15:21:37.289Z,1638890497.289 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2021-12-07T15:21:44.974Z,1638890504.974 [Micromodem](INFO): Nmea in: $CAREV,152145,AUV,2.1.4000*2C

2021-12-07T15:21:44.991Z,1638890504.991 [Micromodem](INFO): Nmea in: $CAREV,152145,COPROC,0.20.0.39330*7D

2021-12-07T15:21:45.024Z,1638890505.024 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for altitude
2021-12-07T15:21:55.029Z,1638890515.029 [Micromodem](INFO): Nmea in: $CAREV,152155,AUV,2.1.4000*2D

2021-12-07T15:21:55.030Z,1638890515.030 [Micromodem](INFO): Nmea in: $CAREV,152155,COPROC,0.20.0.39330*7C

2021-12-07T15:22:04.735Z,1638890524.735 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,152203.00,A,4133.12541,N,07042.18296,W,0.894,46.42,071221,,,A*4E
2021-12-07T15:22:04.738Z,1638890524.738 [NAL9602](INFO): GPS fix at 20211207T152203: (41.552090, -70.703049)
2021-12-07T15:22:04.787Z,1638890524.787 [Startup:StartupSatComms:A] Stopped
2021-12-07T15:22:04.788Z,1638890524.788 [Startup:StartupSatComms:B] Running Loop=1
2021-12-07T15:22:05.132Z,1638890525.132 [Micromodem](INFO): Nmea in: $CAREV,152205,AUV,2.1.4000*2B

2021-12-07T15:22:05.134Z,1638890525.134 [Micromodem](INFO): Nmea in: $CAREV,152205,COPROC,0.20.0.39330*7A

2021-12-07T15:22:05.207Z,1638890525.207 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2021-12-07T15:22:15.358Z,1638890535.358 [Micromodem](INFO): Nmea in: $CAREV,152215,AUV,2.1.4000*2A

2021-12-07T15:22:15.749Z,1638890535.749 [Micromodem](INFO): Nmea in: $CAREV,152215,COPROC,0.20.0.39330*7B

2021-12-07T15:22:25.074Z,1638890545.074 [Micromodem](INFO): Nmea in: $CAREV,152225,AUV,2.1.4000*29

2021-12-07T15:22:25.457Z,1638890545.457 [Micromodem](INFO): Nmea in: $CAREV,152225,COPROC,0.20.0.39330*78

2021-12-07T15:22:26.272Z,1638890546.272 [NAL9602](INFO): SBD MO Status=1, MOMSN=30349, MT Status=0, MTMSN=0
2021-12-07T15:22:26.316Z,1638890546.316 [NAL9602](INFO): Sent 52 bytes from file Logs/20211207T014828/Courier0129.lzma
2021-12-07T15:22:26.316Z,1638890546.316 [NAL9602](INFO): Packets left to send: 0
2021-12-07T15:22:34.884Z,1638890554.884 [Micromodem](INFO): Nmea in: $CAREV,152235,AUV,2.1.4000*28

2021-12-07T15:22:35.274Z,1638890555.274 [Micromodem](INFO): Nmea in: $CAREV,152235,COPROC,0.20.0.39330*79

2021-12-07T15:22:35.276Z,1638890555.276 [NAL9602](INFO): SBD MO Status=1, MOMSN=30350, MT Status=0, MTMSN=0
2021-12-07T15:22:35.340Z,1638890555.340 [NAL9602](INFO): Sent 184 bytes from file Logs/20211207T151957/Courier0000.lzma
2021-12-07T15:22:35.340Z,1638890555.340 [NAL9602](INFO): Packets left to send: 1
2021-12-07T15:22:43.431Z,1638890563.431 [NAL9602](INFO): SBD MO Status=1, MOMSN=30351, MT Status=0, MTMSN=0
2021-12-07T15:22:43.479Z,1638890563.479 [NAL9602](INFO): Sent 69 bytes from file Logs/20211207T151957/Courier0000.lzma
2021-12-07T15:22:43.480Z,1638890563.480 [NAL9602](INFO): Packets left to send: 0
2021-12-07T15:22:46.897Z,1638890566.897 [Micromodem](INFO): Nmea in: $CAREV,152245,AUV,2.1.4000*2F

2021-12-07T15:22:47.278Z,1638890567.278 [Micromodem](INFO): Nmea in: $CAREV,152245,COPROC,0.20.0.39330*7E

2021-12-07T15:22:52.537Z,1638890572.537 [NAL9602](INFO): SBD MO Status=1, MOMSN=30352, MT Status=0, MTMSN=0
2021-12-07T15:22:52.584Z,1638890572.584 [NAL9602](INFO): Sent 142 bytes from file Logs/20211207T014828/Express0130.lzma
2021-12-07T15:22:52.584Z,1638890572.584 [NAL9602](INFO): Packets left to send: 0
2021-12-07T15:22:56.079Z,1638890576.079 [Micromodem](INFO): Nmea in: $CAREV,152255,AUV,2.1.4000*2E

2021-12-07T15:22:56.434Z,1638890576.434 [Micromodem](INFO): Nmea in: $CAREV,152255,COPROC,0.20.0.39330*7F

2021-12-07T15:23:04.106Z,1638890584.106 [NAL9602](INFO): SBD MO Status=1, MOMSN=30353, MT Status=0, MTMSN=0
2021-12-07T15:23:04.155Z,1638890584.155 [NAL9602](INFO): Sent 184 bytes from file Logs/20211207T151957/Express0001.lzma
2021-12-07T15:23:04.156Z,1638890584.156 [NAL9602](INFO): Packets left to send: 5
2021-12-07T15:23:04.996Z,1638890584.996 [Startup:StartupSatComms:B](INFO): Timed out from 2021-12-07T15:22:04.8Z
2021-12-07T15:23:04.996Z,1638890584.996 [Startup:StartupSatComms:B] Stopped
2021-12-07T15:23:04.997Z,1638890584.997 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2021-12-07T15:23:04.997Z,1638890584.997 [Startup:StartupSatComms] Stopped
2021-12-07T15:23:04.997Z,1638890584.997 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2021-12-07T15:23:04.997Z,1638890584.997 [Startup](INFO): Completed Startup
2021-12-07T15:23:04.998Z,1638890584.998 [MissionManager](INFO): Startup is completed.
2021-12-07T15:23:04.998Z,1638890584.998 [MissionManager](INFO): Uninitializing Mission Startup
2021-12-07T15:23:04.998Z,1638890584.998 [Startup] Stopped
2021-12-07T15:23:04.998Z,1638890584.998 [Startup](DEBUG): Aggregate::uninitialize Startup
2021-12-07T15:23:04.998Z,1638890584.998 [Startup:A.GoToSurface] Stopped
2021-12-07T15:23:04.998Z,1638890584.998 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2021-12-07T15:23:05.073Z,1638890585.073 [Micromodem](INFO): Nmea in: $CAREV,152305,AUV,2.1.4000*2A

2021-12-07T15:23:05.074Z,1638890585.074 [Micromodem](INFO): Nmea in: $CAREV,152305,COPROC,0.20.0.39330*7B

2021-12-07T15:23:05.101Z,1638890585.101 [MissionManager](IMPORTANT): Started mission DefaultWithUndock
2021-12-07T15:23:05.102Z,1638890585.102 [DefaultWithUndock] Running Loop=1
2021-12-07T15:23:05.102Z,1638890585.102 [DefaultWithUndock](DEBUG): Aggregate::initialize DefaultWithUndock
2021-12-07T15:23:05.102Z,1638890585.102 [DefaultWithUndock:A.Wait] Running Loop=1
2021-12-07T15:23:05.102Z,1638890585.102 [DefaultWithUndock:A.Wait](DEBUG): Initialize Wait Component.
2021-12-07T15:23:12.388Z,1638890592.388 [NAL9602](INFO): SBD MO Status=1, MOMSN=30354, MT Status=0, MTMSN=0
2021-12-07T15:23:12.434Z,1638890592.434 [NAL9602](INFO): Sent 184 bytes from file Logs/20211207T151957/Express0001.lzma
2021-12-07T15:23:12.435Z,1638890592.435 [NAL9602](INFO): Packets left to send: 4
2021-12-07T15:23:14.821Z,1638890594.821 [Micromodem](INFO): Nmea in: $CAREV,152315,AUV,2.1.4000*2B

2021-12-07T15:23:14.822Z,1638890594.822 [Micromodem](INFO): Nmea in: $CAREV,152315,COPROC,0.20.0.39330*7A

2021-12-07T15:23:24.957Z,1638890604.957 [Micromodem](INFO): Nmea in: $CAREV,152325,AUV,2.1.4000*28

2021-12-07T15:23:24.964Z,1638890604.964 [Micromodem](INFO): Nmea in: $CAREV,152325,COPROC,0.20.0.39330*79

2021-12-07T15:23:29.581Z,1638890609.581 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004196
2021-12-07T15:23:35.022Z,1638890615.022 [Micromodem](INFO): Nmea in: $CAREV,152335,AUV,2.1.4000*29

2021-12-07T15:23:35.023Z,1638890615.023 [Micromodem](INFO): Nmea in: $CAREV,152335,COPROC,0.20.0.39330*78

2021-12-07T15:23:35.494Z,1638890615.494 [DefaultWithUndock:A.Wait](INFO): Done Waiting.
2021-12-07T15:23:35.494Z,1638890615.494 [DefaultWithUndock:A.Wait] Stopped
2021-12-07T15:23:35.494Z,1638890615.494 [DefaultWithUndock:A.Wait](DEBUG): Uninitialize Wait Component.
2021-12-07T15:23:35.494Z,1638890615.494 [DefaultWithUndock:LeaveDock] Running Loop=1
2021-12-07T15:23:35.495Z,1638890615.495 [DefaultWithUndock:LeaveDock](DEBUG): Aggregate::initialize DefaultWithUndock:LeaveDock
2021-12-07T15:23:35.495Z,1638890615.495 [DefaultWithUndock:LeaveDock:A.] Running Loop=1
2021-12-07T15:23:35.495Z,1638890615.495 [DefaultWithUndock:LeaveDock:A.](INFO): Initializing TrackAcousticContact.
2021-12-07T15:23:35.495Z,1638890615.495 [DefaultWithUndock:LeaveDock:B.Undock] Running Loop=1
2021-12-07T15:23:35.495Z,1638890615.495 [DefaultWithUndock:LeaveDock:B.Undock](DEBUG): Initialize.
2021-12-07T15:23:35.496Z,1638890615.496 [DefaultWithUndock:LeaveDock:B.Undock](DEBUG): Initializing internal variables to default values.
2021-12-07T15:23:35.830Z,1638890615.830 [DefaultWithUndock:LeaveDock:A.] Running Loop=1
2021-12-07T15:23:38.320Z,1638890618.320 [DefaultWithUndock:LeaveDock:B.Undock](INFO): Detaching from dock.
2021-12-07T15:23:38.321Z,1638890618.321 [DefaultWithUndock:LeaveDock:A.](INFO): *** querying acoustic contact ***
2021-12-07T15:23:38.695Z,1638890618.695 [DefaultWithUndock:LeaveDock:B.Undock](INFO): Detected possible detachment. Starting timer.
2021-12-07T15:23:39.083Z,1638890619.083 [Micromodem](INFO): Nmea out: $CCPGT,1,14500,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*76

2021-12-07T15:23:39.484Z,1638890619.484 [Micromodem](INFO): Nmea in: $SNPGT,1,14500,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*6B

2021-12-07T15:23:40.310Z,1638890620.310 [Micromodem](INFO): Nmea in: $SNTTA,,,,,152339.51*55

2021-12-07T15:23:40.311Z,1638890620.311 [Micromodem](INFO): Nmea in: $CAREV,152340,AUV,2.1.4000*2B

2021-12-07T15:23:40.702Z,1638890620.702 [Micromodem](INFO): Nmea in: $CAREV,152340,COPROC,0.20.0.39330*7A

2021-12-07T15:23:41.134Z,1638890621.134 [DefaultWithUndock:LeaveDock:A.](INFO): *** querying acoustic contact ***
2021-12-07T15:23:42.712Z,1638890622.712 [DUSBL_Hydroid](ERROR): No response from remote modem.
2021-12-07T15:23:43.122Z,1638890623.122 [NAL9602](INFO): Not Powering down - fast GPS
2021-12-07T15:23:43.988Z,1638890623.988 [DefaultWithUndock:LeaveDock:A.](INFO): *** querying acoustic contact ***
2021-12-07T15:23:44.738Z,1638890624.738 [Micromodem](INFO): Nmea out: $CCPGT,1,14500,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*76

2021-12-07T15:23:45.144Z,1638890625.144 [Micromodem](INFO): Nmea in: $SNPGT,1,14500,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*6B

2021-12-07T15:23:45.186Z,1638890625.186 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error
2021-12-07T15:23:45.989Z,1638890625.989 [Micromodem](INFO): Nmea in: $SNTTA,,,,,152345.16*5D

2021-12-07T15:23:45.990Z,1638890625.990 [Micromodem](INFO): Nmea in: $CAREV,152346,AUV,2.1.4000*2D

2021-12-07T15:23:46.360Z,1638890626.360 [Micromodem](INFO): Nmea in: $CAREV,152346,COPROC,0.20.0.39330*7C

2021-12-07T15:23:46.823Z,1638890626.823 [DefaultWithUndock:LeaveDock:A.](INFO): *** querying acoustic contact ***
2021-12-07T15:23:48.381Z,1638890628.381 [DUSBL_Hydroid](ERROR): No response from remote modem.
2021-12-07T15:23:49.614Z,1638890629.614 [DefaultWithUndock:LeaveDock:A.](INFO): *** querying acoustic contact ***
2021-12-07T15:23:50.390Z,1638890630.390 [Micromodem](INFO): Nmea out: $CCPGT,1,14500,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*76

2021-12-07T15:23:50.824Z,1638890630.824 [Micromodem](INFO): Nmea in: $SNPGT,1,14500,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*6B

2021-12-07T15:23:51.614Z,1638890631.614 [Micromodem](INFO): Nmea in: $SNTTA,,,,,152350.82*54

2021-12-07T15:23:51.630Z,1638890631.630 [Micromodem](INFO): Nmea in: $CAREV,152351,AUV,2.1.4000*2B

2021-12-07T15:23:52.014Z,1638890632.014 [Micromodem](INFO): Nmea in: $CAREV,152351,COPROC,0.20.0.39330*7A

2021-12-07T15:23:52.421Z,1638890632.421 [DefaultWithUndock:LeaveDock:A.](INFO): *** querying acoustic contact ***
2021-12-07T15:23:54.025Z,1638890634.025 [DUSBL_Hydroid](ERROR): No response from remote modem.
2021-12-07T15:23:55.250Z,1638890635.250 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error
2021-12-07T15:23:55.260Z,1638890635.260 [DefaultWithUndock:LeaveDock:A.](INFO): *** querying acoustic contact ***
2021-12-07T15:23:56.078Z,1638890636.078 [Micromodem](INFO): Nmea out: $CCPGT,1,14500,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*76

2021-12-07T15:23:56.456Z,1638890636.456 [Micromodem](INFO): Nmea in: $SNPGT,1,14500,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*6B

2021-12-07T15:23:57.257Z,1638890637.257 [Micromodem](INFO): Nmea in: $SNTTA,,,,,152356.51*5C

2021-12-07T15:23:57.662Z,1638890637.662 [Micromodem](INFO): Nmea in: $CAREV,152357,AUV,2.1.4000*2D

2021-12-07T15:23:57.665Z,1638890637.665 [Micromodem](INFO): Nmea in: $CAREV,152357,COPROC,0.20.0.39330*7C

2021-12-07T15:23:58.081Z,1638890638.081 [DefaultWithUndock:LeaveDock:A.](INFO): *** querying acoustic contact ***
2021-12-07T15:23:58.907Z,1638890638.907 [DefaultWithUndock:LeaveDock:B.Undock](INFO): Detached at range: nan m. Transitioning DDM to standby.
2021-12-07T15:23:59.685Z,1638890639.685 [DUSBL_Hydroid](ERROR): No response from remote modem.
2021-12-07T15:24:01.003Z,1638890641.003 [DefaultWithUndock:LeaveDock:B.Undock](INFO): DDM at standby.
2021-12-07T15:24:01.004Z,1638890641.004 [DefaultWithUndock:LeaveDock:A.](INFO): *** querying acoustic contact ***
2021-12-07T15:24:01.385Z,1638890641.385 [DefaultWithUndock:LeaveDock:B.Undock](IMPORTANT): Undocking sequence complete.
2021-12-07T15:24:01.385Z,1638890641.385 [DefaultWithUndock:LeaveDock:B.Undock] Stopped
2021-12-07T15:24:01.385Z,1638890641.385 [DefaultWithUndock:LeaveDock](INFO): Completed DefaultWithUndock:LeaveDock
2021-12-07T15:24:01.385Z,1638890641.385 [DefaultWithUndock:LeaveDock] Stopped
2021-12-07T15:24:01.386Z,1638890641.386 [DefaultWithUndock:LeaveDock](DEBUG): Aggregate::uninitialize DefaultWithUndock:LeaveDock
2021-12-07T15:24:01.386Z,1638890641.386 [DefaultWithUndock:LeaveDock:A.] Stopped
2021-12-07T15:24:01.386Z,1638890641.386 [DefaultWithUndock:SurfaceDefault] Running Loop=1
2021-12-07T15:24:01.386Z,1638890641.386 [DefaultWithUndock:SurfaceDefault](DEBUG): Aggregate::initialize DefaultWithUndock:SurfaceDefault
2021-12-07T15:24:01.386Z,1638890641.386 [DefaultWithUndock:SurfaceDefault:HoldLatchOpen] Running Loop=1
2021-12-07T15:24:01.386Z,1638890641.386 [DefaultWithUndock:SurfaceDefault:HoldLatchOpen](DEBUG): Aggregate::initialize DefaultWithUndock:SurfaceDefault:HoldLatchOpen
2021-12-07T15:24:01.386Z,1638890641.386 [DefaultWithUndock:SurfaceDefault:HoldLatchOpen:A] Running Loop=1
2021-12-07T15:24:01.386Z,1638890641.386 [DefaultWithUndock:SurfaceDefault:HoldLatchOpen:B] Running Loop=1
2021-12-07T15:24:01.386Z,1638890641.386 [DefaultWithUndock:SurfaceDefault:B.GoToSurface] Running Loop=1
2021-12-07T15:24:01.386Z,1638890641.386 [DefaultWithUndock:SurfaceDefault:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2021-12-07T15:24:01.387Z,1638890641.387 [DefaultWithUndock:SurfaceDefault:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2021-12-07T15:24:01.387Z,1638890641.387 [DefaultWithUndock:SurfaceDefault:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2021-12-07T15:24:01.387Z,1638890641.387 [DefaultWithUndock:SurfaceDefault:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2021-12-07T15:24:01.388Z,1638890641.388 [DefaultWithUndock:SurfaceDefault:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2021-12-07T15:24:01.388Z,1638890641.388 [DefaultWithUndock:SurfaceDefault:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2021-12-07T15:24:01.688Z,1638890641.688 [DefaultWithUndock:SurfaceDefault:CheckIn] Running Loop=1
2021-12-07T15:24:01.688Z,1638890641.688 [DefaultWithUndock:SurfaceDefault:CheckIn](DEBUG): Aggregate::initialize DefaultWithUndock:SurfaceDefault:CheckIn
2021-12-07T15:24:01.688Z,1638890641.688 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_GPS] Running Loop=1
2021-12-07T15:24:01.688Z,1638890641.688 [DefaultWithUndock:SurfaceDefault:HoldLatchOpen] Stopped
2021-12-07T15:24:01.688Z,1638890641.688 [DefaultWithUndock:SurfaceDefault:HoldLatchOpen](DEBUG): Aggregate::uninitialize DefaultWithUndock:SurfaceDefault:HoldLatchOpen
2021-12-07T15:24:01.688Z,1638890641.688 [DefaultWithUndock:SurfaceDefault:HoldLatchOpen:A] Stopped
2021-12-07T15:24:01.688Z,1638890641.688 [DefaultWithUndock:SurfaceDefault:HoldLatchOpen:B] Stopped
2021-12-07T15:24:02.199Z,1638890642.199 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2021-12-07T15:24:03.690Z,1638890643.690 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,152402.00,A,4133.12211,N,07042.16848,W,0.253,103.66,071221,,,A*7B
2021-12-07T15:24:03.693Z,1638890643.693 [NAL9602](INFO): GPS fix at 20211207T152402: (41.552035, -70.702808)
2021-12-07T15:24:03.704Z,1638890643.704 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_GPS] Stopped
2021-12-07T15:24:03.704Z,1638890643.704 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_Iridium] Running Loop=1
2021-12-07T15:24:04.146Z,1638890644.146 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications
2021-12-07T15:24:07.329Z,1638890647.329 [Micromodem](INFO): Nmea in: $CAREV,152407,AUV,2.1.4000*2F

2021-12-07T15:24:07.737Z,1638890647.737 [Micromodem](INFO): Nmea in: $CAREV,152407,COPROC,0.20.0.39330*7E

2021-12-07T15:24:07.743Z,1638890647.743 [DataOverHttps](INFO): Sending 80 bytes from file Logs/20211207T151957/Courier0004.lzma
2021-12-07T15:24:08.747Z,1638890648.747 [DataOverHttps](INFO): Moved sent file to Logs/20211207T151957/Courier0004.lzma.bak
2021-12-07T15:24:08.748Z,1638890648.748 [DataOverHttps](INFO): SBD MOMSN=625276
2021-12-07T15:24:17.429Z,1638890657.429 [Micromodem](INFO): Nmea in: $CAREV,152417,AUV,2.1.4000*2E

2021-12-07T15:24:17.784Z,1638890657.784 [DataOverHttps](INFO): Sending 1066 bytes from file Logs/20211207T151957/Express0001.lzma
2021-12-07T15:24:17.833Z,1638890657.833 [Micromodem](INFO): Nmea in: $CAREV,152417,COPROC,0.20.0.39330*7F

2021-12-07T15:24:18.789Z,1638890658.789 [DataOverHttps](INFO): Moved sent file to Logs/20211207T151957/Express0001.lzma.bak
2021-12-07T15:24:18.790Z,1638890658.790 [DataOverHttps](INFO): SBD MOMSN=625279
2021-12-07T15:24:19.043Z,1638890659.043 [NAL9602](INFO): SBD MO Status=0, MOMSN=30355, MT Status=0, MTMSN=0
2021-12-07T15:24:19.043Z,1638890659.043 [NAL9602](INFO): No messages in MT queue
2021-12-07T15:24:27.529Z,1638890667.529 [Micromodem](INFO): Nmea in: $CAREV,152427,AUV,2.1.4000*2D

2021-12-07T15:24:27.824Z,1638890667.824 [DataOverHttps](INFO): Sending 178 bytes from file Logs/20211207T151957/Express0005.lzma
2021-12-07T15:24:27.940Z,1638890667.940 [Micromodem](INFO): Nmea in: $CAREV,152427,COPROC,0.20.0.39330*7C

2021-12-07T15:24:28.825Z,1638890668.825 [DataOverHttps](INFO): Moved sent file to Logs/20211207T151957/Express0005.lzma.bak
2021-12-07T15:24:28.825Z,1638890668.825 [DataOverHttps](INFO): SBD MOMSN=625304
2021-12-07T15:24:30.384Z,1638890670.384 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_Iridium] Stopped
2021-12-07T15:24:30.384Z,1638890670.384 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait] Running Loop=1
2021-12-07T15:24:30.384Z,1638890670.384 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2021-12-07T15:24:37.634Z,1638890677.634 [Micromodem](INFO): Nmea in: $CAREV,152437,AUV,2.1.4000*2C

2021-12-07T15:24:37.635Z,1638890677.635 [Micromodem](INFO): Nmea in: $CAREV,152437,COPROC,0.20.0.39330*7D

2021-12-07T15:24:47.325Z,1638890687.325 [Micromodem](INFO): Nmea in: $CAREV,152447,AUV,2.1.4000*2B

2021-12-07T15:24:47.326Z,1638890687.326 [Micromodem](INFO): Nmea in: $CAREV,152447,COPROC,0.20.0.39330*7A

2021-12-07T15:24:49.749Z,1638890689.749 [NAL9602](INFO): Not Powering down - fast GPS
2021-12-07T15:24:57.420Z,1638890697.420 [Micromodem](INFO): Nmea in: $CAREV,152457,AUV,2.1.4000*2A

2021-12-07T15:24:57.421Z,1638890697.421 [Micromodem](INFO): Nmea in: $CAREV,152457,COPROC,0.20.0.39330*7B

2021-12-07T15:25:07.521Z,1638890707.521 [Micromodem](INFO): Nmea in: $CAREV,152507,AUV,2.1.4000*2E

2021-12-07T15:25:07.523Z,1638890707.523 [Micromodem](INFO): Nmea in: $CAREV,152507,COPROC,0.20.0.39330*7F

2021-12-07T15:25:17.630Z,1638890717.630 [Micromodem](INFO): Nmea in: $CAREV,152517,AUV,2.1.4000*2F

2021-12-07T15:25:17.631Z,1638890717.631 [Micromodem](INFO): Nmea in: $CAREV,152517,COPROC,0.20.0.39330*7E

2021-12-07T15:25:27.334Z,1638890727.334 [Micromodem](INFO): Nmea in: $CAREV,152527,AUV,2.1.4000*2C

2021-12-07T15:25:27.335Z,1638890727.335 [Micromodem](INFO): Nmea in: $CAREV,152527,COPROC,0.20.0.39330*7D

2021-12-07T15:25:37.416Z,1638890737.416 [Micromodem](INFO): Nmea in: $CAREV,152537,AUV,2.1.4000*2D

2021-12-07T15:25:37.420Z,1638890737.420 [Micromodem](INFO): Nmea in: $CAREV,152537,COPROC,0.20.0.39330*7C

2021-12-07T15:25:47.526Z,1638890747.526 [Micromodem](INFO): Nmea in: $CAREV,152547,AUV,2.1.4000*2A

2021-12-07T15:25:47.527Z,1638890747.527 [Micromodem](INFO): Nmea in: $CAREV,152547,COPROC,0.20.0.39330*7B

2021-12-07T15:25:57.621Z,1638890757.621 [Micromodem](INFO): Nmea in: $CAREV,152557,AUV,2.1.4000*2B

2021-12-07T15:25:57.622Z,1638890757.622 [Micromodem](INFO): Nmea in: $CAREV,152557,COPROC,0.20.0.39330*7A

2021-12-07T15:26:07.314Z,1638890767.314 [Micromodem](INFO): Nmea in: $CAREV,152607,AUV,2.1.4000*2D

2021-12-07T15:26:07.314Z,1638890767.314 [Micromodem](INFO): Nmea in: $CAREV,152607,COPROC,0.20.0.39330*7C

2021-12-07T15:26:17.413Z,1638890777.413 [Micromodem](INFO): Nmea in: $CAREV,152617,AUV,2.1.4000*2C

2021-12-07T15:26:17.414Z,1638890777.414 [Micromodem](INFO): Nmea in: $CAREV,152617,COPROC,0.20.0.39330*7D

2021-12-07T15:26:27.517Z,1638890787.517 [Micromodem](INFO): Nmea in: $CAREV,152627,AUV,2.1.4000*2F

2021-12-07T15:26:27.518Z,1638890787.518 [Micromodem](INFO): Nmea in: $CAREV,152627,COPROC,0.20.0.39330*7E

2021-12-07T15:26:37.618Z,1638890797.618 [Micromodem](INFO): Nmea in: $CAREV,152637,AUV,2.1.4000*2E

2021-12-07T15:26:37.619Z,1638890797.619 [Micromodem](INFO): Nmea in: $CAREV,152637,COPROC,0.20.0.39330*7F

2021-12-07T15:26:47.313Z,1638890807.313 [Micromodem](INFO): Nmea in: $CAREV,152647,AUV,2.1.4000*29

2021-12-07T15:26:47.314Z,1638890807.314 [Micromodem](INFO): Nmea in: $CAREV,152647,COPROC,0.20.0.39330*78

2021-12-07T15:26:57.426Z,1638890817.426 [Micromodem](INFO): Nmea in: $CAREV,152657,AUV,2.1.4000*28

2021-12-07T15:26:57.427Z,1638890817.427 [Micromodem](INFO): Nmea in: $CAREV,152657,COPROC,0.20.0.39330*79

2021-12-07T15:27:07.513Z,1638890827.513 [Micromodem](INFO): Nmea in: $CAREV,152707,AUV,2.1.4000*2C

2021-12-07T15:27:07.514Z,1638890827.514 [Micromodem](INFO): Nmea in: $CAREV,152707,COPROC,0.20.0.39330*7D

2021-12-07T15:27:17.618Z,1638890837.618 [Micromodem](INFO): Nmea in: $CAREV,152717,AUV,2.1.4000*2D

2021-12-07T15:27:17.619Z,1638890837.619 [Micromodem](INFO): Nmea in: $CAREV,152717,COPROC,0.20.0.39330*7C

2021-12-07T15:27:27.312Z,1638890847.312 [Micromodem](INFO): Nmea in: $CAREV,152727,AUV,2.1.4000*2E

2021-12-07T15:27:27.313Z,1638890847.313 [Micromodem](INFO): Nmea in: $CAREV,152727,COPROC,0.20.0.39330*7F

2021-12-07T15:27:35.794Z,1638890855.794 [BPC1](INFO): Calculating totals. Valid battery stick count: 56. Valid reserve battery stick count: 6.
2021-12-07T15:27:35.797Z,1638890855.797 [BPC1](INFO): Received data from all battery sticks.
2021-12-07T15:27:37.406Z,1638890857.406 [Micromodem](INFO): Nmea in: $CAREV,152737,AUV,2.1.4000*2F

2021-12-07T15:27:37.408Z,1638890857.408 [Micromodem](INFO): Nmea in: $CAREV,152737,COPROC,0.20.0.39330*7E

2021-12-07T15:27:47.504Z,1638890867.504 [Micromodem](INFO): Nmea in: $CAREV,152747,AUV,2.1.4000*28

2021-12-07T15:27:47.505Z,1638890867.505 [Micromodem](INFO): Nmea in: $CAREV,152747,COPROC,0.20.0.39330*79

2021-12-07T15:27:57.609Z,1638890877.609 [Micromodem](INFO): Nmea in: $CAREV,152757,AUV,2.1.4000*29

2021-12-07T15:27:57.610Z,1638890877.610 [Micromodem](INFO): Nmea in: $CAREV,152757,COPROC,0.20.0.39330*78

2021-12-07T15:28:07.314Z,1638890887.314 [Micromodem](INFO): Nmea in: $CAREV,152807,AUV,2.1.4000*23

2021-12-07T15:28:07.710Z,1638890887.710 [Micromodem](INFO): Nmea in: $CAREV,152807,COPROC,0.20.0.39330*72

2021-12-07T15:28:17.401Z,1638890897.401 [Micromodem](INFO): Nmea in: $CAREV,152817,AUV,2.1.4000*22

2021-12-07T15:28:17.402Z,1638890897.402 [Micromodem](INFO): Nmea in: $CAREV,152817,COPROC,0.20.0.39330*73

2021-12-07T15:28:27.505Z,1638890907.505 [Micromodem](INFO): Nmea in: $CAREV,152827,AUV,2.1.4000*21

2021-12-07T15:28:27.506Z,1638890907.506 [Micromodem](INFO): Nmea in: $CAREV,152827,COPROC,0.20.0.39330*70

2021-12-07T15:28:37.605Z,1638890917.605 [Micromodem](INFO): Nmea in: $CAREV,152837,AUV,2.1.4000*20

2021-12-07T15:28:37.606Z,1638890917.606 [Micromodem](INFO): Nmea in: $CAREV,152837,COPROC,0.20.0.39330*71

2021-12-07T15:28:47.701Z,1638890927.701 [Micromodem](INFO): Nmea in: $CAREV,152847,AUV,2.1.4000*27

2021-12-07T15:28:47.702Z,1638890927.702 [Micromodem](INFO): Nmea in: $CAREV,152847,COPROC,0.20.0.39330*76

2021-12-07T15:28:57.406Z,1638890937.406 [Micromodem](INFO): Nmea in: $CAREV,152857,AUV,2.1.4000*26

2021-12-07T15:28:57.407Z,1638890937.407 [Micromodem](INFO): Nmea in: $CAREV,152857,COPROC,0.20.0.39330*77

2021-12-07T15:29:07.498Z,1638890947.498 [Micromodem](INFO): Nmea in: $CAREV,152907,AUV,2.1.4000*22

2021-12-07T15:29:07.499Z,1638890947.499 [Micromodem](INFO): Nmea in: $CAREV,152907,COPROC,0.20.0.39330*73

2021-12-07T15:29:17.601Z,1638890957.601 [Micromodem](INFO): Nmea in: $CAREV,152917,AUV,2.1.4000*23

2021-12-07T15:29:17.602Z,1638890957.602 [Micromodem](INFO): Nmea in: $CAREV,152917,COPROC,0.20.0.39330*72

2021-12-07T15:29:27.701Z,1638890967.701 [Micromodem](INFO): Nmea in: $CAREV,152927,AUV,2.1.4000*20

2021-12-07T15:29:27.703Z,1638890967.703 [Micromodem](INFO): Nmea in: $CAREV,152927,COPROC,0.20.0.39330*71

2021-12-07T15:29:30.956Z,1638890970.956 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](INFO): Done Waiting.
2021-12-07T15:29:30.956Z,1638890970.956 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait] Stopped
2021-12-07T15:29:30.956Z,1638890970.956 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2021-12-07T15:29:30.956Z,1638890970.956 [DefaultWithUndock:SurfaceDefault:CheckIn:D] Running Loop=1
2021-12-07T15:29:31.346Z,1638890971.346 [DefaultWithUndock:SurfaceDefault:CheckIn:D] Stopped
2021-12-07T15:29:31.346Z,1638890971.346 [DefaultWithUndock:SurfaceDefault:CheckIn:E] Running Loop=1
2021-12-07T15:29:31.769Z,1638890971.769 [DefaultWithUndock:SurfaceDefault:CheckIn:E](IMPORTANT): Default mission has been running for 6.437396 min 
2021-12-07T15:29:31.769Z,1638890971.769 [DefaultWithUndock:SurfaceDefault:CheckIn:E] Stopped
2021-12-07T15:29:31.769Z,1638890971.769 [DefaultWithUndock:SurfaceDefault:CheckIn](INFO): Completed DefaultWithUndock:SurfaceDefault:CheckIn
2021-12-07T15:29:31.769Z,1638890971.769 [DefaultWithUndock:SurfaceDefault:CheckIn] Stopped
2021-12-07T15:29:31.769Z,1638890971.769 [DefaultWithUndock:SurfaceDefault:CheckIn](DEBUG): Aggregate::uninitialize DefaultWithUndock:SurfaceDefault:CheckIn
2021-12-07T15:29:31.770Z,1638890971.770 [DefaultWithUndock:SurfaceDefault:CheckIn](INFO): Running loop #2
2021-12-07T15:29:31.770Z,1638890971.770 [DefaultWithUndock:SurfaceDefault:CheckIn] Running Loop=2
2021-12-07T15:29:31.770Z,1638890971.770 [DefaultWithUndock:SurfaceDefault:CheckIn](DEBUG): Aggregate::initialize DefaultWithUndock:SurfaceDefault:CheckIn
2021-12-07T15:29:31.770Z,1638890971.770 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_GPS] Running Loop=1
2021-12-07T15:29:33.763Z,1638890973.763 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,152933.00,A,4133.11058,N,07042.12207,W,0.486,88.20,071221,,,A*43
2021-12-07T15:29:33.766Z,1638890973.766 [NAL9602](INFO): GPS fix at 20211207T152933: (41.551843, -70.702034)
2021-12-07T15:29:33.797Z,1638890973.797 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_GPS] Stopped
2021-12-07T15:29:33.797Z,1638890973.797 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_Iridium] Running Loop=1
2021-12-07T15:29:37.394Z,1638890977.394 [Micromodem](INFO): Nmea in: $CAREV,152937,AUV,2.1.4000*21

2021-12-07T15:29:37.799Z,1638890977.799 [Micromodem](INFO): Nmea in: $CAREV,152937,COPROC,0.20.0.39330*70

2021-12-07T15:29:38.179Z,1638890978.179 [DataOverHttps](INFO): Sending 202 bytes from file Logs/20211207T151957/Courier0007.lzma
2021-12-07T15:29:39.181Z,1638890979.181 [DataOverHttps](INFO): Moved sent file to Logs/20211207T151957/Courier0007.lzma.bak
2021-12-07T15:29:39.181Z,1638890979.181 [DataOverHttps](INFO): SBD MOMSN=625309
2021-12-07T15:29:46.284Z,1638890986.284 [NAL9602](INFO): SBD MO Status=0, MOMSN=30356, MT Status=0, MTMSN=0
2021-12-07T15:29:46.284Z,1638890986.284 [NAL9602](INFO): No messages in MT queue
2021-12-07T15:29:47.493Z,1638890987.493 [Micromodem](INFO): Nmea in: $CAREV,152947,AUV,2.1.4000*26

2021-12-07T15:29:47.896Z,1638890987.896 [Micromodem](INFO): Nmea in: $CAREV,152947,COPROC,0.20.0.39330*77

2021-12-07T15:29:48.219Z,1638890988.219 [DataOverHttps](INFO): Sending 180 bytes from file Logs/20211207T151957/Express0008.lzma
2021-12-07T15:29:49.221Z,1638890989.221 [DataOverHttps](INFO): Moved sent file to Logs/20211207T151957/Express0008.lzma.bak
2021-12-07T15:29:49.221Z,1638890989.221 [DataOverHttps](INFO): SBD MOMSN=625312
2021-12-07T15:29:50.817Z,1638890990.817 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_Iridium] Stopped
2021-12-07T15:29:50.817Z,1638890990.817 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait] Running Loop=1
2021-12-07T15:29:50.818Z,1638890990.818 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2021-12-07T15:29:57.613Z,1638890997.613 [Micromodem](INFO): Nmea in: $CAREV,152957,AUV,2.1.4000*27

2021-12-07T15:29:57.614Z,1638890997.614 [Micromodem](INFO): Nmea in: $CAREV,152957,COPROC,0.20.0.39330*76

2021-12-07T15:30:07.713Z,1638891007.713 [Micromodem](INFO): Nmea in: $CAREV,153007,AUV,2.1.4000*2A

2021-12-07T15:30:07.715Z,1638891007.715 [Micromodem](INFO): Nmea in: $CAREV,153007,COPROC,0.20.0.39330*7B

2021-12-07T15:30:16.999Z,1638891016.999 [NAL9602](INFO): Not Powering down - fast GPS
2021-12-07T15:30:17.409Z,1638891017.409 [Micromodem](INFO): Nmea in: $CAREV,153017,AUV,2.1.4000*2B

2021-12-07T15:30:17.411Z,1638891017.411 [Micromodem](INFO): Nmea in: $CAREV,153017,COPROC,0.20.0.39330*7A

2021-12-07T15:30:27.506Z,1638891027.506 [Micromodem](INFO): Nmea in: $CAREV,153027,AUV,2.1.4000*28

2021-12-07T15:30:27.507Z,1638891027.507 [Micromodem](INFO): Nmea in: $CAREV,153027,COPROC,0.20.0.39330*79

2021-12-07T15:30:37.612Z,1638891037.612 [Micromodem](INFO): Nmea in: $CAREV,153037,AUV,2.1.4000*29

2021-12-07T15:30:37.613Z,1638891037.613 [Micromodem](INFO): Nmea in: $CAREV,153037,COPROC,0.20.0.39330*78

2021-12-07T15:30:47.709Z,1638891047.709 [Micromodem](INFO): Nmea in: $CAREV,153047,AUV,2.1.4000*2E

2021-12-07T15:30:47.711Z,1638891047.711 [Micromodem](INFO): Nmea in: $CAREV,153047,COPROC,0.20.0.39330*7F

2021-12-07T15:30:57.405Z,1638891057.405 [Micromodem](INFO): Nmea in: $CAREV,153057,AUV,2.1.4000*2F

2021-12-07T15:30:57.407Z,1638891057.407 [Micromodem](INFO): Nmea in: $CAREV,153057,COPROC,0.20.0.39330*7E

2021-12-07T15:31:07.502Z,1638891067.502 [Micromodem](INFO): Nmea in: $CAREV,153107,AUV,2.1.4000*2B

2021-12-07T15:31:07.503Z,1638891067.503 [Micromodem](INFO): Nmea in: $CAREV,153107,COPROC,0.20.0.39330*7A

2021-12-07T15:31:17.610Z,1638891077.610 [Micromodem](INFO): Nmea in: $CAREV,153117,AUV,2.1.4000*2A

2021-12-07T15:31:17.611Z,1638891077.611 [Micromodem](INFO): Nmea in: $CAREV,153117,COPROC,0.20.0.39330*7B

2021-12-07T15:31:27.702Z,1638891087.702 [Micromodem](INFO): Nmea in: $CAREV,153127,AUV,2.1.4000*29

2021-12-07T15:31:27.703Z,1638891087.703 [Micromodem](INFO): Nmea in: $CAREV,153127,COPROC,0.20.0.39330*78

2021-12-07T15:31:37.398Z,1638891097.398 [Micromodem](INFO): Nmea in: $CAREV,153137,AUV,2.1.4000*28

2021-12-07T15:31:37.399Z,1638891097.399 [Micromodem](INFO): Nmea in: $CAREV,153137,COPROC,0.20.0.39330*79

2021-12-07T15:31:47.498Z,1638891107.498 [Micromodem](INFO): Nmea in: $CAREV,153147,AUV,2.1.4000*2F

2021-12-07T15:31:47.499Z,1638891107.499 [Micromodem](INFO): Nmea in: $CAREV,153147,COPROC,0.20.0.39330*7E

2021-12-07T15:31:57.601Z,1638891117.601 [Micromodem](INFO): Nmea in: $CAREV,153157,AUV,2.1.4000*2E

2021-12-07T15:31:57.602Z,1638891117.602 [Micromodem](INFO): Nmea in: $CAREV,153157,COPROC,0.20.0.39330*7F

2021-12-07T15:32:07.698Z,1638891127.698 [Micromodem](INFO): Nmea in: $CAREV,153207,AUV,2.1.4000*28

2021-12-07T15:32:07.699Z,1638891127.699 [Micromodem](INFO): Nmea in: $CAREV,153207,COPROC,0.20.0.39330*79

2021-12-07T15:32:17.394Z,1638891137.394 [Micromodem](INFO): Nmea in: $CAREV,153217,AUV,2.1.4000*29

2021-12-07T15:32:17.395Z,1638891137.395 [Micromodem](INFO): Nmea in: $CAREV,153217,COPROC,0.20.0.39330*78

2021-12-07T15:32:27.497Z,1638891147.497 [Micromodem](INFO): Nmea in: $CAREV,153227,AUV,2.1.4000*2A

2021-12-07T15:32:27.498Z,1638891147.498 [Micromodem](INFO): Nmea in: $CAREV,153227,COPROC,0.20.0.39330*7B

2021-12-07T15:32:37.591Z,1638891157.591 [Micromodem](INFO): Nmea in: $CAREV,153237,AUV,2.1.4000*2B

2021-12-07T15:32:37.592Z,1638891157.592 [Micromodem](INFO): Nmea in: $CAREV,153237,COPROC,0.20.0.39330*7A

2021-12-07T15:32:47.697Z,1638891167.697 [Micromodem](INFO): Nmea in: $CAREV,153247,AUV,2.1.4000*2C

2021-12-07T15:32:47.699Z,1638891167.699 [Micromodem](INFO): Nmea in: $CAREV,153247,COPROC,0.20.0.39330*7D

2021-12-07T15:32:57.393Z,1638891177.393 [Micromodem](INFO): Nmea in: $CAREV,153257,AUV,2.1.4000*2D

2021-12-07T15:32:57.395Z,1638891177.395 [Micromodem](INFO): Nmea in: $CAREV,153257,COPROC,0.20.0.39330*7C

2021-12-07T15:33:07.494Z,1638891187.494 [Micromodem](INFO): Nmea in: $CAREV,153307,AUV,2.1.4000*29

2021-12-07T15:33:07.495Z,1638891187.495 [Micromodem](INFO): Nmea in: $CAREV,153307,COPROC,0.20.0.39330*78

2021-12-07T15:33:17.608Z,1638891197.608 [Micromodem](INFO): Nmea in: $CAREV,153317,AUV,2.1.4000*28

2021-12-07T15:33:17.609Z,1638891197.609 [Micromodem](INFO): Nmea in: $CAREV,153317,COPROC,0.20.0.39330*79

2021-12-07T15:33:27.689Z,1638891207.689 [Micromodem](INFO): Nmea in: $CAREV,153327,AUV,2.1.4000*2B

2021-12-07T15:33:27.691Z,1638891207.691 [Micromodem](INFO): Nmea in: $CAREV,153327,COPROC,0.20.0.39330*7A

2021-12-07T15:33:37.393Z,1638891217.393 [Micromodem](INFO): Nmea in: $CAREV,153337,AUV,2.1.4000*2A

2021-12-07T15:33:37.395Z,1638891217.395 [Micromodem](INFO): Nmea in: $CAREV,153337,COPROC,0.20.0.39330*7B

2021-12-07T15:33:47.489Z,1638891227.489 [Micromodem](INFO): Nmea in: $CAREV,153347,AUV,2.1.4000*2D

2021-12-07T15:33:47.490Z,1638891227.490 [Micromodem](INFO): Nmea in: $CAREV,153347,COPROC,0.20.0.39330*7C

2021-12-07T15:33:57.586Z,1638891237.586 [Micromodem](INFO): Nmea in: $CAREV,153357,AUV,2.1.4000*2C

2021-12-07T15:33:57.587Z,1638891237.587 [Micromodem](INFO): Nmea in: $CAREV,153357,COPROC,0.20.0.39330*7D

2021-12-07T15:34:07.686Z,1638891247.686 [Micromodem](INFO): Nmea in: $CAREV,153407,AUV,2.1.4000*2E

2021-12-07T15:34:07.687Z,1638891247.687 [Micromodem](INFO): Nmea in: $CAREV,153407,COPROC,0.20.0.39330*7F

2021-12-07T15:34:17.394Z,1638891257.394 [Micromodem](INFO): Nmea in: $CAREV,153417,AUV,2.1.4000*2F

2021-12-07T15:34:17.396Z,1638891257.396 [Micromodem](INFO): Nmea in: $CAREV,153417,COPROC,0.20.0.39330*7E

2021-12-07T15:34:27.486Z,1638891267.486 [Micromodem](INFO): Nmea in: $CAREV,153427,AUV,2.1.4000*2C

2021-12-07T15:34:27.487Z,1638891267.487 [Micromodem](INFO): Nmea in: $CAREV,153427,COPROC,0.20.0.39330*7D

2021-12-07T15:34:37.585Z,1638891277.585 [Micromodem](INFO): Nmea in: $CAREV,153437,AUV,2.1.4000*2D

2021-12-07T15:34:37.586Z,1638891277.586 [Micromodem](INFO): Nmea in: $CAREV,153437,COPROC,0.20.0.39330*7C

2021-12-07T15:34:47.689Z,1638891287.689 [Micromodem](INFO): Nmea in: $CAREV,153447,AUV,2.1.4000*2A

2021-12-07T15:34:47.691Z,1638891287.691 [Micromodem](INFO): Nmea in: $CAREV,153447,COPROC,0.20.0.39330*7B

2021-12-07T15:34:51.340Z,1638891291.340 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](INFO): Done Waiting.
2021-12-07T15:34:51.340Z,1638891291.340 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait] Stopped
2021-12-07T15:34:51.341Z,1638891291.341 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2021-12-07T15:34:51.341Z,1638891291.341 [DefaultWithUndock:SurfaceDefault:CheckIn:D] Running Loop=1
2021-12-07T15:34:51.736Z,1638891291.736 [DefaultWithUndock:SurfaceDefault:CheckIn:D] Stopped
2021-12-07T15:34:51.736Z,1638891291.736 [DefaultWithUndock:SurfaceDefault:CheckIn:E] Running Loop=1
2021-12-07T15:34:52.150Z,1638891292.150 [DefaultWithUndock:SurfaceDefault:CheckIn:E](IMPORTANT): Default mission has been running for 11.777240 min 
2021-12-07T15:34:52.150Z,1638891292.150 [DefaultWithUndock:SurfaceDefault:CheckIn:E] Stopped
2021-12-07T15:34:52.150Z,1638891292.150 [DefaultWithUndock:SurfaceDefault:CheckIn](INFO): Completed DefaultWithUndock:SurfaceDefault:CheckIn
2021-12-07T15:34:52.150Z,1638891292.150 [DefaultWithUndock:SurfaceDefault:CheckIn] Stopped
2021-12-07T15:34:52.151Z,1638891292.151 [DefaultWithUndock:SurfaceDefault:CheckIn](DEBUG): Aggregate::uninitialize DefaultWithUndock:SurfaceDefault:CheckIn
2021-12-07T15:34:52.151Z,1638891292.151 [DefaultWithUndock:SurfaceDefault:CheckIn](INFO): Running loop #3
2021-12-07T15:34:52.151Z,1638891292.151 [DefaultWithUndock:SurfaceDefault:CheckIn] Running Loop=3
2021-12-07T15:34:52.151Z,1638891292.151 [DefaultWithUndock:SurfaceDefault:CheckIn](DEBUG): Aggregate::initialize DefaultWithUndock:SurfaceDefault:CheckIn
2021-12-07T15:34:52.151Z,1638891292.151 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_GPS] Running Loop=1
2021-12-07T15:34:54.176Z,1638891294.176 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,153453.00,A,4133.10116,N,07042.07628,W,0.311,92.55,071221,,,A*4E
2021-12-07T15:34:54.178Z,1638891294.178 [NAL9602](INFO): GPS fix at 20211207T153453: (41.551686, -70.701271)
2021-12-07T15:34:54.199Z,1638891294.199 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_GPS] Stopped
2021-12-07T15:34:54.200Z,1638891294.200 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_Iridium] Running Loop=1
2021-12-07T15:34:57.397Z,1638891297.397 [Micromodem](INFO): Nmea in: $CAREV,153457,AUV,2.1.4000*2B

2021-12-07T15:34:57.781Z,1638891297.781 [Micromodem](INFO): Nmea in: $CAREV,153457,COPROC,0.20.0.39330*7A

2021-12-07T15:34:58.495Z,1638891298.495 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20211207T151957/Courier0010.lzma
2021-12-07T15:34:59.497Z,1638891299.497 [DataOverHttps](INFO): Moved sent file to Logs/20211207T151957/Courier0010.lzma.bak
2021-12-07T15:34:59.497Z,1638891299.497 [DataOverHttps](INFO): SBD MOMSN=625316
2021-12-07T15:35:07.481Z,1638891307.481 [Micromodem](INFO): Nmea in: $CAREV,153507,AUV,2.1.4000*2F

2021-12-07T15:35:07.885Z,1638891307.885 [Micromodem](INFO): Nmea in: $CAREV,153507,COPROC,0.20.0.39330*7E

2021-12-07T15:35:08.535Z,1638891308.535 [DataOverHttps](INFO): Sending 130 bytes from file Logs/20211207T151957/Express0011.lzma
2021-12-07T15:35:09.537Z,1638891309.537 [DataOverHttps](INFO): Moved sent file to Logs/20211207T151957/Express0011.lzma.bak
2021-12-07T15:35:09.537Z,1638891309.537 [DataOverHttps](INFO): SBD MOMSN=625319
2021-12-07T15:35:10.311Z,1638891310.311 [NAL9602](INFO): SBD MO Status=0, MOMSN=30357, MT Status=0, MTMSN=0
2021-12-07T15:35:10.311Z,1638891310.311 [NAL9602](INFO): No messages in MT queue
2021-12-07T15:35:11.162Z,1638891311.162 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_Iridium] Stopped
2021-12-07T15:35:11.163Z,1638891311.163 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait] Running Loop=1
2021-12-07T15:35:11.163Z,1638891311.163 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2021-12-07T15:35:17.578Z,1638891317.578 [Micromodem](INFO): Nmea in: $CAREV,153517,AUV,2.1.4000*2E

2021-12-07T15:35:17.579Z,1638891317.579 [Micromodem](INFO): Nmea in: $CAREV,153517,COPROC,0.20.0.39330*7F

2021-12-07T15:35:27.681Z,1638891327.681 [Micromodem](INFO): Nmea in: $CAREV,153527,AUV,2.1.4000*2D

2021-12-07T15:35:27.683Z,1638891327.683 [Micromodem](INFO): Nmea in: $CAREV,153527,COPROC,0.20.0.39330*7C

2021-12-07T15:35:37.785Z,1638891337.785 [Micromodem](INFO): Nmea in: $CAREV,153537,AUV,2.1.4000*2C

2021-12-07T15:35:37.786Z,1638891337.786 [Micromodem](INFO): Nmea in: $CAREV,153537,COPROC,0.20.0.39330*7D

2021-12-07T15:35:41.013Z,1638891341.013 [NAL9602](INFO): Not Powering down - fast GPS
2021-12-07T15:35:47.477Z,1638891347.477 [Micromodem](INFO): Nmea in: $CAREV,153547,AUV,2.1.4000*2B

2021-12-07T15:35:47.478Z,1638891347.478 [Micromodem](INFO): Nmea in: $CAREV,153547,COPROC,0.20.0.39330*7A

2021-12-07T15:35:57.575Z,1638891357.575 [Micromodem](INFO): Nmea in: $CAREV,153557,AUV,2.1.4000*2A

2021-12-07T15:35:57.576Z,1638891357.576 [Micromodem](INFO): Nmea in: $CAREV,153557,COPROC,0.20.0.39330*7B

2021-12-07T15:36:07.674Z,1638891367.674 [Micromodem](INFO): Nmea in: $CAREV,153607,AUV,2.1.4000*2C

2021-12-07T15:36:07.675Z,1638891367.675 [Micromodem](INFO): Nmea in: $CAREV,153607,COPROC,0.20.0.39330*7D

2021-12-07T15:36:17.771Z,1638891377.771 [Micromodem](INFO): Nmea in: $CAREV,153617,AUV,2.1.4000*2D

2021-12-07T15:36:17.773Z,1638891377.773 [Micromodem](INFO): Nmea in: $CAREV,153617,COPROC,0.20.0.39330*7C

2021-12-07T15:36:27.470Z,1638891387.470 [Micromodem](INFO): Nmea in: $CAREV,153627,AUV,2.1.4000*2E

2021-12-07T15:36:27.471Z,1638891387.471 [Micromodem](INFO): Nmea in: $CAREV,153627,COPROC,0.20.0.39330*7F

2021-12-07T15:36:35.612Z,1638891395.612 [RDI_PathfinderUp](ERROR): only read 3 of 4 data items
2021-12-07T15:36:37.570Z,1638891397.570 [Micromodem](INFO): Nmea in: $CAREV,153637,AUV,2.1.4000*2F

2021-12-07T15:36:37.571Z,1638891397.571 [Micromodem](INFO): Nmea in: $CAREV,153637,COPROC,0.20.0.39330*7E

2021-12-07T15:36:47.674Z,1638891407.674 [Micromodem](INFO): Nmea in: $CAREV,153647,AUV,2.1.4000*28

2021-12-07T15:36:47.690Z,1638891407.690 [Micromodem](INFO): Nmea in: $CAREV,153647,COPROC,0.20.0.39330*79

2021-12-07T15:36:57.773Z,1638891417.773 [Micromodem](INFO): Nmea in: $CAREV,153657,AUV,2.1.4000*29

2021-12-07T15:36:57.774Z,1638891417.774 [Micromodem](INFO): Nmea in: $CAREV,153657,COPROC,0.20.0.39330*78

2021-12-07T15:37:07.469Z,1638891427.469 [Micromodem](INFO): Nmea in: $CAREV,153707,AUV,2.1.4000*2D

2021-12-07T15:37:07.470Z,1638891427.470 [Micromodem](INFO): Nmea in: $CAREV,153707,COPROC,0.20.0.39330*7C

2021-12-07T15:37:17.567Z,1638891437.567 [Micromodem](INFO): Nmea in: $CAREV,153717,AUV,2.1.4000*2C

2021-12-07T15:37:17.568Z,1638891437.568 [Micromodem](INFO): Nmea in: $CAREV,153717,COPROC,0.20.0.39330*7D

2021-12-07T15:37:27.666Z,1638891447.666 [Micromodem](INFO): Nmea in: $CAREV,153727,AUV,2.1.4000*2F

2021-12-07T15:37:27.667Z,1638891447.667 [Micromodem](INFO): Nmea in: $CAREV,153727,COPROC,0.20.0.39330*7E

2021-12-07T15:37:37.769Z,1638891457.769 [Micromodem](INFO): Nmea in: $CAREV,153737,AUV,2.1.4000*2E

2021-12-07T15:37:37.770Z,1638891457.770 [Micromodem](INFO): Nmea in: $CAREV,153737,COPROC,0.20.0.39330*7F

2021-12-07T15:37:47.462Z,1638891467.462 [Micromodem](INFO): Nmea in: $CAREV,153747,AUV,2.1.4000*29

2021-12-07T15:37:47.463Z,1638891467.463 [Micromodem](INFO): Nmea in: $CAREV,153747,COPROC,0.20.0.39330*78

2021-12-07T15:37:57.565Z,1638891477.565 [Micromodem](INFO): Nmea in: $CAREV,153757,AUV,2.1.4000*28

2021-12-07T15:37:57.566Z,1638891477.566 [Micromodem](INFO): Nmea in: $CAREV,153757,COPROC,0.20.0.39330*79

2021-12-07T15:38:07.662Z,1638891487.662 [Micromodem](INFO): Nmea in: $CAREV,153807,AUV,2.1.4000*22

2021-12-07T15:38:07.664Z,1638891487.664 [Micromodem](INFO): Nmea in: $CAREV,153807,COPROC,0.20.0.39330*73

2021-12-07T15:38:17.762Z,1638891497.762 [Micromodem](INFO): Nmea in: $CAREV,153817,AUV,2.1.4000*23

2021-12-07T15:38:17.763Z,1638891497.763 [Micromodem](INFO): Nmea in: $CAREV,153817,COPROC,0.20.0.39330*72

2021-12-07T15:38:27.461Z,1638891507.461 [Micromodem](INFO): Nmea in: $CAREV,153827,AUV,2.1.4000*20

2021-12-07T15:38:27.462Z,1638891507.462 [Micromodem](INFO): Nmea in: $CAREV,153827,COPROC,0.20.0.39330*71

2021-12-07T15:38:37.561Z,1638891517.561 [Micromodem](INFO): Nmea in: $CAREV,153837,AUV,2.1.4000*21

2021-12-07T15:38:37.562Z,1638891517.562 [Micromodem](INFO): Nmea in: $CAREV,153837,COPROC,0.20.0.39330*70

2021-12-07T15:38:47.664Z,1638891527.664 [Micromodem](INFO): Nmea in: $CAREV,153847,AUV,2.1.4000*26

2021-12-07T15:38:47.665Z,1638891527.665 [Micromodem](INFO): Nmea in: $CAREV,153847,COPROC,0.20.0.39330*77

2021-12-07T15:38:57.758Z,1638891537.758 [Micromodem](INFO): Nmea in: $CAREV,153857,AUV,2.1.4000*27

2021-12-07T15:38:57.759Z,1638891537.759 [Micromodem](INFO): Nmea in: $CAREV,153857,COPROC,0.20.0.39330*76

2021-12-07T15:39:07.482Z,1638891547.482 [Micromodem](INFO): Nmea in: $CAREV,153907,AUV,2.1.4000*23

2021-12-07T15:39:07.483Z,1638891547.483 [Micromodem](INFO): Nmea in: $CAREV,153907,COPROC,0.20.0.39330*72

2021-12-07T15:39:17.559Z,1638891557.559 [Micromodem](INFO): Nmea in: $CAREV,153917,AUV,2.1.4000*22

2021-12-07T15:39:17.565Z,1638891557.565 [Micromodem](INFO): Nmea in: $CAREV,153917,COPROC,0.20.0.39330*73

2021-12-07T15:39:27.655Z,1638891567.655 [Micromodem](INFO): Nmea in: $CAREV,153927,AUV,2.1.4000*21

2021-12-07T15:39:27.656Z,1638891567.656 [Micromodem](INFO): Nmea in: $CAREV,153927,COPROC,0.20.0.39330*70

2021-12-07T15:39:37.754Z,1638891577.754 [Micromodem](INFO): Nmea in: $CAREV,153937,AUV,2.1.4000*20

2021-12-07T15:39:37.755Z,1638891577.755 [Micromodem](INFO): Nmea in: $CAREV,153937,COPROC,0.20.0.39330*71

2021-12-07T15:39:47.463Z,1638891587.463 [Micromodem](INFO): Nmea in: $CAREV,153947,AUV,2.1.4000*27

2021-12-07T15:39:47.464Z,1638891587.464 [Micromodem](INFO): Nmea in: $CAREV,153947,COPROC,0.20.0.39330*76

2021-12-07T15:39:56.728Z,1638891596.728 [DataOverHttps](IMPORTANT): SBD MTMSN=20211207T153955
2021-12-07T15:39:57.550Z,1638891597.550 [Micromodem](INFO): Nmea in: $CAREV,153957,AUV,2.1.4000*26

2021-12-07T15:39:57.551Z,1638891597.551 [Micromodem](INFO): Nmea in: $CAREV,153957,COPROC,0.20.0.39330*77

2021-12-07T15:40:00.745Z,1638891600.745 [DataOverHttps](INFO): Received command: restart logs