2022-09-02T10:43:58.521Z,1662115438.521 [Supervisor](DEBUG): Initializing supervisor. 2022-09-02T10:43:58.525Z,1662115438.525 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2022-09-02T10:43:58.526Z,1662115438.526 [SyncHandler](INFO): Protected caller Thread ID is 3444 2022-09-02T10:43:58.526Z,1662115438.526 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2022-09-02T10:43:58.527Z,1662115438.527 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2022-09-02T10:43:58.527Z,1662115438.527 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 3445 2022-09-02T10:43:58.531Z,1662115438.531 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2022-09-02T10:43:58.549Z,1662115438.549 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread. 2022-09-02T10:43:58.550Z,1662115438.550 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2022-09-02T10:43:58.550Z,1662115438.550 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 3446 2022-09-02T10:43:58.554Z,1662115438.554 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2022-09-02T10:43:58.555Z,1662115438.555 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2022-09-02T10:43:58.556Z,1662115438.556 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 3447 2022-09-02T10:43:58.558Z,1662115438.558 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2022-09-02T10:43:58.559Z,1662115438.559 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0 2022-09-02T10:43:58.559Z,1662115438.559 [logger ThreadHandler](INFO): Protected caller Thread ID is 3448 2022-09-02T10:43:58.563Z,1662115438.563 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2022-09-02T10:43:58.563Z,1662115438.563 [Supervisor](INFO): Looking for Config files in directory: Config/ 2022-09-02T10:43:58.565Z,1662115438.565 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2022-09-02T10:43:58.988Z,1662115438.988 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2022-09-02T10:43:58.989Z,1662115438.989 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2022-09-02T10:43:59.066Z,1662115439.066 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2022-09-02T10:43:59.409Z,1662115439.409 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2022-09-02T10:43:59.409Z,1662115439.409 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2022-09-02T10:43:59.515Z,1662115439.515 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2022-09-02T10:43:59.516Z,1662115439.516 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2022-09-02T10:43:59.714Z,1662115439.714 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2022-09-02T10:43:59.715Z,1662115439.715 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2022-09-02T10:44:00.208Z,1662115440.208 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2022-09-02T10:44:00.209Z,1662115440.209 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2022-09-02T10:44:00.486Z,1662115440.486 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2022-09-02T10:44:00.487Z,1662115440.487 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2022-09-02T10:44:00.706Z,1662115440.706 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2022-09-02T10:44:00.707Z,1662115440.707 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2022-09-02T10:44:00.900Z,1662115440.900 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2022-09-02T10:44:00.901Z,1662115440.901 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2022-09-02T10:44:00.999Z,1662115440.999 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2022-09-02T10:44:01.000Z,1662115441.000 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg 2022-09-02T10:44:01.230Z,1662115441.230 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock 2022-09-02T10:44:01.231Z,1662115441.231 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2022-09-02T10:44:01.616Z,1662115441.616 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2022-09-02T10:44:01.617Z,1662115441.617 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2022-09-02T10:44:01.697Z,1662115441.697 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2022-09-02T10:44:01.835Z,1662115441.835 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2022-09-02T10:44:01.835Z,1662115441.835 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2022-09-02T10:44:02.588Z,1662115442.588 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2022-09-02T10:44:02.589Z,1662115442.589 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2022-09-02T10:44:03.232Z,1662115443.232 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2022-09-02T10:44:03.235Z,1662115443.235 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-polaris/ 2022-09-02T10:44:03.235Z,1662115443.235 [Supervisor](INFO): Opening Config file at: Config/lrauv-polaris/vehicle.cfg 2022-09-02T10:44:03.443Z,1662115443.443 [Supervisor](INFO): Opening Config file at: Config/lrauv-polaris/Control.cfg 2022-09-02T10:44:03.544Z,1662115443.544 [Supervisor](INFO): Opening Config file at: Config/lrauv-polaris/Estimation.cfg 2022-09-02T10:44:03.644Z,1662115443.644 [Supervisor](INFO): Opening Config file at: Config/lrauv-polaris/BIT.cfg 2022-09-02T10:44:03.744Z,1662115443.744 [Supervisor](INFO): Opening Config file at: Config/lrauv-polaris/Battery.cfg 2022-09-02T10:44:04.007Z,1662115444.007 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2022-09-02T10:44:04.008Z,1662115444.008 [Supervisor](INFO): Opening Config file at: Config/lrauv-polaris/Simulator.cfg 2022-09-02T10:44:04.118Z,1662115444.118 [Supervisor](INFO): Opening Config file at: Config/lrauv-polaris/Navigation.cfg 2022-09-02T10:44:04.223Z,1662115444.223 [Supervisor](INFO): Opening Config file at: Config/lrauv-polaris/Derivation.cfg 2022-09-02T10:44:04.347Z,1662115444.347 [Supervisor](INFO): Opening Config file at: Config/lrauv-polaris/logger.cfg 2022-09-02T10:44:04.460Z,1662115444.460 [Supervisor](INFO): Opening Config file at: Config/lrauv-polaris/secure.cfg 2022-09-02T10:44:04.544Z,1662115444.544 [Supervisor](INFO): Opening Config file at: Config/lrauv-polaris/Dock.cfg 2022-09-02T10:44:04.629Z,1662115444.629 [Supervisor](INFO): Opening Config file at: Config/lrauv-polaris/Servo.cfg 2022-09-02T10:44:04.740Z,1662115444.740 [Supervisor](INFO): Opening Config file at: Config/lrauv-polaris/workSite.cfg 2022-09-02T10:44:04.846Z,1662115444.846 [Supervisor](INFO): Opening Config file at: Config/lrauv-polaris/Sensor.cfg 2022-09-02T10:44:05.054Z,1662115445.054 [Supervisor](INFO): Opening Config file at: Config/lrauv-polaris/Science.cfg 2022-09-02T10:44:05.217Z,1662115445.217 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg 2022-09-02T10:44:05.231Z,1662115445.231 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2022-09-02T10:44:05.620Z,1662115445.620 [AHRS_M2] Loaded 2022-09-02T10:44:05.620Z,1662115445.620 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread. 2022-09-02T10:44:06.392Z,1662115446.392 [BPC1] Loaded 2022-09-02T10:44:06.393Z,1662115446.393 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2022-09-02T10:44:06.472Z,1662115446.472 [DataOverHttps] Loaded 2022-09-02T10:44:06.472Z,1662115446.472 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread. 2022-09-02T10:44:06.474Z,1662115446.474 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 407E44E0 2022-09-02T10:44:06.474Z,1662115446.474 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 3542 2022-09-02T10:44:06.498Z,1662115446.498 [DDM] Loaded 2022-09-02T10:44:06.499Z,1662115446.499 [ComponentRegistry](DEBUG): SyncComponent "DDM" handled in the control thread. 2022-09-02T10:44:06.518Z,1662115446.518 [Depth_Keller] Loaded 2022-09-02T10:44:06.518Z,1662115446.518 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2022-09-02T10:44:06.523Z,1662115446.523 [DropWeight] Loaded 2022-09-02T10:44:06.523Z,1662115446.523 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread. 2022-09-02T10:44:06.572Z,1662115446.572 [Micromodem] Loaded 2022-09-02T10:44:06.572Z,1662115446.572 [ComponentRegistry](DEBUG): SyncComponent "Micromodem" handled in the control thread. 2022-09-02T10:44:06.633Z,1662115446.633 [NAL9602] Loaded 2022-09-02T10:44:06.633Z,1662115446.633 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2022-09-02T10:44:06.662Z,1662115446.662 [Onboard] Loaded 2022-09-02T10:44:06.663Z,1662115446.663 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread. 2022-09-02T10:44:06.664Z,1662115446.664 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 408144E0 2022-09-02T10:44:06.664Z,1662115446.664 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 3543 2022-09-02T10:44:06.670Z,1662115446.670 [PowerOnly](INFO): Adding load control power supply at /dev/loadC1 2022-09-02T10:44:06.681Z,1662115446.681 [PowerOnly] Loaded 2022-09-02T10:44:06.681Z,1662115446.681 [ComponentRegistry](DEBUG): SyncComponent "PowerOnly" handled in the control thread. 2022-09-02T10:44:06.692Z,1662115446.692 [Power24vConverter] Loaded 2022-09-02T10:44:06.693Z,1662115446.693 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread. 2022-09-02T10:44:06.706Z,1662115446.706 [Radio_Surface] Loaded 2022-09-02T10:44:06.707Z,1662115446.707 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2022-09-02T10:44:06.708Z,1662115446.708 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 408444E0 2022-09-02T10:44:06.708Z,1662115446.708 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 3544 2022-09-02T10:44:06.753Z,1662115446.753 [RDI_Pathfinder] Loaded 2022-09-02T10:44:06.753Z,1662115446.753 [ComponentRegistry](DEBUG): SyncComponent "RDI_Pathfinder" handled in the control thread. 2022-09-02T10:44:06.780Z,1662115446.780 [RDI_PathfinderUp] Loaded 2022-09-02T10:44:06.780Z,1662115446.780 [ComponentRegistry](DEBUG): SyncComponent "RDI_PathfinderUp" handled in the control thread. 2022-09-02T10:44:06.781Z,1662115446.781 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2022-09-02T10:44:06.781Z,1662115446.781 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2022-09-02T10:44:06.791Z,1662115446.791 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2022-09-02T10:44:06.792Z,1662115446.792 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2022-09-02T10:44:06.901Z,1662115446.901 [DeadReckonUsingMultipleVelocitySources] Loaded 2022-09-02T10:44:06.901Z,1662115446.901 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2022-09-02T10:44:06.925Z,1662115446.925 [LBLNavigation] Loaded 2022-09-02T10:44:06.925Z,1662115446.925 [ComponentRegistry](DEBUG): SyncComponent "LBLNavigation" handled in the control thread. 2022-09-02T10:44:06.938Z,1662115446.938 [NavChart] Loaded 2022-09-02T10:44:06.939Z,1662115446.939 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2022-09-02T10:44:06.944Z,1662115446.944 [UniversalFixResidualReporter] Loaded 2022-09-02T10:44:06.944Z,1662115446.944 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2022-09-02T10:44:06.955Z,1662115446.955 [WorkSite] Loaded 2022-09-02T10:44:06.955Z,1662115446.955 [ComponentRegistry](DEBUG): SyncComponent "WorkSite" handled in the control thread. 2022-09-02T10:44:06.955Z,1662115446.955 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2022-09-02T10:44:06.956Z,1662115446.956 [Module Loader](DEBUG): Loading Module at Modules/Dock.so 2022-09-02T10:44:07.049Z,1662115447.049 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking) 2022-09-02T10:44:07.049Z,1662115447.049 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2022-09-02T10:44:07.172Z,1662115447.172 [BuoyancyServo] Loaded 2022-09-02T10:44:07.173Z,1662115447.173 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2022-09-02T10:44:07.194Z,1662115447.194 [ElevatorServo] Loaded 2022-09-02T10:44:07.194Z,1662115447.194 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2022-09-02T10:44:07.215Z,1662115447.215 [MassServo] Loaded 2022-09-02T10:44:07.215Z,1662115447.215 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2022-09-02T10:44:07.235Z,1662115447.235 [RudderServo] Loaded 2022-09-02T10:44:07.236Z,1662115447.236 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2022-09-02T10:44:07.251Z,1662115447.251 [ThrusterHE] Loaded 2022-09-02T10:44:07.251Z,1662115447.251 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread. 2022-09-02T10:44:07.252Z,1662115447.252 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2022-09-02T10:44:07.252Z,1662115447.252 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2022-09-02T10:44:07.421Z,1662115447.421 [CTD_Seabird] Loaded 2022-09-02T10:44:07.421Z,1662115447.421 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread. 2022-09-02T10:44:07.422Z,1662115447.422 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 409824E0 2022-09-02T10:44:07.422Z,1662115447.422 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 3545 2022-09-02T10:44:07.454Z,1662115447.454 [WetLabsSeaOWL_UV_A] Loaded 2022-09-02T10:44:07.454Z,1662115447.454 [ComponentRegistry](DEBUG): Component "WetLabsSeaOWL_UV_A" handled in its own thread. 2022-09-02T10:44:07.455Z,1662115447.455 [WetLabsSeaOWL_UV_A ThreadHandler](DEBUG): Created PCaller Thread at 409B24E0 2022-09-02T10:44:07.456Z,1662115447.456 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Protected caller Thread ID is 3546 2022-09-02T10:44:07.456Z,1662115447.456 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2022-09-02T10:44:07.457Z,1662115447.457 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2022-09-02T10:44:07.758Z,1662115447.758 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2022-09-02T10:44:07.759Z,1662115447.759 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2022-09-02T10:44:07.905Z,1662115447.905 [DepthRateCalculator] Loaded 2022-09-02T10:44:07.905Z,1662115447.905 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2022-09-02T10:44:07.922Z,1662115447.922 [PitchRateCalculator] Loaded 2022-09-02T10:44:07.923Z,1662115447.923 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2022-09-02T10:44:07.991Z,1662115447.991 [SpeedCalculator] Loaded 2022-09-02T10:44:07.992Z,1662115447.992 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2022-09-02T10:44:08.055Z,1662115448.055 [TempGradientCalculator] Loaded 2022-09-02T10:44:08.055Z,1662115448.055 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread. 2022-09-02T10:44:08.089Z,1662115448.089 [VerticalHomogeneityIndexCalculator] Loaded 2022-09-02T10:44:08.089Z,1662115448.089 [ComponentRegistry](DEBUG): SyncComponent "VerticalHomogeneityIndexCalculator" handled in the control thread. 2022-09-02T10:44:08.094Z,1662115448.094 [YawRateCalculator] Loaded 2022-09-02T10:44:08.094Z,1662115448.094 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2022-09-02T10:44:08.116Z,1662115448.116 [ElevatorOffsetCalculator] Loaded 2022-09-02T10:44:08.116Z,1662115448.116 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread. 2022-09-02T10:44:08.117Z,1662115448.117 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2022-09-02T10:44:08.117Z,1662115448.117 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2022-09-02T10:44:08.456Z,1662115448.456 [SBIT](DEBUG): Construct Startup Built In Test. 2022-09-02T10:44:08.480Z,1662115448.480 [SBIT] Loaded 2022-09-02T10:44:08.481Z,1662115448.481 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2022-09-02T10:44:08.483Z,1662115448.483 [IBIT](DEBUG): Construct Initiated Built In Test. 2022-09-02T10:44:08.528Z,1662115448.528 [IBIT] Loaded 2022-09-02T10:44:08.528Z,1662115448.528 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2022-09-02T10:44:08.586Z,1662115448.586 [CBIT](DEBUG): Construct Continuous Built In Test. 2022-09-02T10:44:08.743Z,1662115448.743 [CBIT] Loaded 2022-09-02T10:44:08.744Z,1662115448.744 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2022-09-02T10:44:08.744Z,1662115448.744 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2022-09-02T10:44:08.745Z,1662115448.745 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2022-09-02T10:44:08.801Z,1662115448.801 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2022-09-02T10:44:08.801Z,1662115448.801 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2022-09-02T10:44:08.949Z,1662115448.949 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2022-09-02T10:44:08.949Z,1662115448.949 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2022-09-02T10:44:08.999Z,1662115448.999 [VerticalControl](DEBUG): Construct VerticalControl. 2022-09-02T10:44:09.049Z,1662115449.049 [VerticalControl] Loaded 2022-09-02T10:44:09.049Z,1662115449.049 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2022-09-02T10:44:09.052Z,1662115449.052 [HorizontalControl](DEBUG): Construct HorizontalControl. 2022-09-02T10:44:09.089Z,1662115449.089 [HorizontalControl] Loaded 2022-09-02T10:44:09.090Z,1662115449.090 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2022-09-02T10:44:09.092Z,1662115449.092 [SpeedControl](DEBUG): Construct SpeedControl. 2022-09-02T10:44:09.094Z,1662115449.094 [SpeedControl] Loaded 2022-09-02T10:44:09.094Z,1662115449.094 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2022-09-02T10:44:09.097Z,1662115449.097 [LoopControl](DEBUG): Construct LoopControl. 2022-09-02T10:44:09.097Z,1662115449.097 [LoopControl] Loaded 2022-09-02T10:44:09.097Z,1662115449.097 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2022-09-02T10:44:09.098Z,1662115449.098 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2022-09-02T10:44:09.098Z,1662115449.098 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2022-09-02T10:44:09.125Z,1662115449.125 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2022-09-02T10:44:09.131Z,1662115449.131 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2022-09-02T10:44:09.134Z,1662115449.134 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2022-09-02T10:44:09.146Z,1662115449.146 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2022-09-02T10:44:09.147Z,1662115449.147 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40B6E4E0 2022-09-02T10:44:09.147Z,1662115449.147 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 3547 2022-09-02T10:44:09.151Z,1662115449.151 [Supervisor](INFO): Main Thread ID is 3443 2022-09-02T10:44:09.152Z,1662115449.152 [Supervisor](DEBUG): Running supervisor. 2022-09-02T10:44:09.152Z,1662115449.152 [CommandExec ThreadHandler](INFO): Handler Thread ID is 3548 2022-09-02T10:44:09.153Z,1662115449.153 [CommandExec](INFO): Initializing the command executive. 2022-09-02T10:44:09.154Z,1662115449.154 [CommandLine ThreadHandler](INFO): Handler Thread ID is 3549 2022-09-02T10:44:09.156Z,1662115449.156 [controlThread ThreadHandler](INFO): Handler Thread ID is 3550 2022-09-02T10:44:09.157Z,1662115449.157 [controlThread](DEBUG): Initializing ControlThread 2022-09-02T10:44:09.163Z,1662115449.163 [NavChart](DEBUG): Initialize NavChart Navigation. 2022-09-02T10:44:09.163Z,1662115449.163 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2022-09-02T10:44:09.164Z,1662115449.164 [WorkSite](DEBUG): Initializing WorkSite component. 2022-09-02T10:44:09.165Z,1662115449.165 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2022-09-02T10:44:09.165Z,1662115449.165 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2022-09-02T10:44:09.166Z,1662115449.166 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2022-09-02T10:44:09.166Z,1662115449.166 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator. 2022-09-02T10:44:09.167Z,1662115449.167 [VerticalHomogeneityIndexCalculator](DEBUG): (re)initializing 2022-09-02T10:44:09.167Z,1662115449.167 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2022-09-02T10:44:09.168Z,1662115449.168 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator. 2022-09-02T10:44:09.168Z,1662115449.168 [SBIT](INFO): Initialize SBIT Component. 2022-09-02T10:44:09.169Z,1662115449.169 [SBIT](IMPORTANT): git: 2022-08-25 2022-09-02T10:44:09.169Z,1662115449.169 [SBIT](INFO): git hash: e1ddd60859d931066d70c4e9618f9367e52a6cfe 2022-09-02T10:44:09.169Z,1662115449.169 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2022-09-02T10:44:09.171Z,1662115449.171 [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 2022-09-02T10:44:09.172Z,1662115449.172 [SBIT](INFO): Beginning SBIT in 55.000000 seconds. 2022-09-02T10:44:09.172Z,1662115449.172 [IBIT](INFO): Initialize IBIT Component. 2022-09-02T10:44:09.173Z,1662115449.173 [CBIT](DEBUG): Initialize CBIT Component. 2022-09-02T10:44:09.174Z,1662115449.174 [logger ThreadHandler](INFO): Handler Thread ID is 3551 2022-09-02T10:44:09.188Z,1662115449.188 [CBIT](DEBUG): Initialized mux pins. 2022-09-02T10:44:09.188Z,1662115449.188 [CBIT](DEBUG): Initializing the watchdog timer. 2022-09-02T10:44:09.192Z,1662115449.192 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 3552 2022-09-02T10:44:09.193Z,1662115449.193 [DataOverHttps](DEBUG): dashIP=128.128.181.226 starts with a digit so assuming it is a numeric IP 2022-09-02T10:44:09.200Z,1662115449.200 [Onboard ThreadHandler](INFO): Handler Thread ID is 3553 2022-09-02T10:44:09.212Z,1662115449.212 [CBIT](INFO): Last reboot was NOT due to watchdog timer. 2022-09-02T10:44:09.212Z,1662115449.212 [CBIT](DEBUG): Initializing heartbeat. 2022-09-02T10:44:09.218Z,1662115449.218 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 3554 2022-09-02T10:44:09.240Z,1662115449.240 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 3555 2022-09-02T10:44:09.241Z,1662115449.241 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2022-09-02T10:44:09.245Z,1662115449.245 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Handler Thread ID is 3557 2022-09-02T10:44:09.257Z,1662115449.257 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 3558 2022-09-02T10:44:09.259Z,1662115449.259 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000 2022-09-02T10:44:09.260Z,1662115449.260 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000 2022-09-02T10:44:09.260Z,1662115449.260 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000 2022-09-02T10:44:09.260Z,1662115449.260 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000 2022-09-02T10:44:09.260Z,1662115449.260 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000 2022-09-02T10:44:09.260Z,1662115449.260 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000 2022-09-02T10:44:09.260Z,1662115449.260 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000 2022-09-02T10:44:09.261Z,1662115449.261 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000 2022-09-02T10:44:09.284Z,1662115449.284 [CBIT](DEBUG): Deactivating GF circuits. 2022-09-02T10:44:09.284Z,1662115449.284 [CBIT](DEBUG): Deactivating emergency mode. 2022-09-02T10:44:09.320Z,1662115449.320 [CBIT](DEBUG): Backplane powered. 2022-09-02T10:44:09.320Z,1662115449.320 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2022-09-02T10:44:09.322Z,1662115449.322 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2022-09-02T10:44:09.323Z,1662115449.323 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2022-09-02T10:44:09.323Z,1662115449.323 [LoopControl](DEBUG): Initialize LoopControlComponent. 2022-09-02T10:44:09.324Z,1662115449.324 [MissionManager](INFO): Loading Mission from file: Missions/Startup.xml 2022-09-02T10:44:09.337Z,1662115449.337 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2022-09-02T10:44:09.364Z,1662115449.364 [MissionManager](DEBUG): 2022-09-02T10:44:09.365Z,1662115449.365 [MissionManager](INFO): Loading Mission from file: Missions/Default.xml 2022-09-02T10:44:09.438Z,1662115449.438 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min 2022-09-02T10:44:09.440Z,1662115449.440 [Default:A.Wait](DEBUG): Construct Wait. 2022-09-02T10:44:09.454Z,1662115449.454 [Default:B.GoToSurface](DEBUG): Construct GoToSurface. 2022-09-02T10:44:09.498Z,1662115449.498 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2022-09-02T10:44:09.500Z,1662115449.500 [Default:CheckIn:C.Wait](DEBUG): Construct Wait. 2022-09-02T10:44:09.518Z,1662115449.518 [Default:E.Execute](DEBUG): Construct Execute. 2022-09-02T10:44:09.521Z,1662115449.521 [MissionManager](DEBUG): 0 Wait a moment to see if the scheduler starts a new mission before starting to actually run Default. 13 Burn on Dropped weight due to communications timeout. 5 Default mission has been running for Restarting logs and Default mission. restart logs 2022-09-02T10:44:09.532Z,1662115449.532 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,DDM,Depth_Keller,DropWeight,Micromodem,NAL9602,PowerOnly,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,Reporter,LogSplitter, 2022-09-02T10:44:09.544Z,1662115449.544 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2022-09-02T10:44:09.604Z,1662115449.604 [DDM](INFO): Powering up 2022-09-02T10:44:09.605Z,1662115449.605 [DDM](DEBUG): Initializing DDM. 2022-09-02T10:44:09.624Z,1662115449.624 [Radio_Surface](INFO): Powering up 2022-09-02T10:44:09.631Z,1662115449.631 [Power24vConverter](INFO): Powering up. 2022-09-02T10:44:09.632Z,1662115449.632 [RDI_Pathfinder](IMPORTANT): Expecting PD13 message format 2022-09-02T10:44:09.680Z,1662115449.680 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2022-09-02T10:44:09.688Z,1662115449.688 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2022-09-02T10:44:09.689Z,1662115449.689 [ElevatorServo](DEBUG): Initializing EZServoServo. 2022-09-02T10:44:09.700Z,1662115449.700 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2022-09-02T10:44:09.701Z,1662115449.701 [MassServo](DEBUG): Initializing EZServoServo. 2022-09-02T10:44:09.708Z,1662115449.708 [MassServo](DEBUG): Initializing MassServo. 2022-09-02T10:44:09.709Z,1662115449.709 [RudderServo](DEBUG): Initializing EZServoServo. 2022-09-02T10:44:09.716Z,1662115449.716 [RudderServo](DEBUG): Initializing RudderServo. 2022-09-02T10:44:09.717Z,1662115449.717 [ThrusterHE](DEBUG): Initializing EZServoServo. 2022-09-02T10:44:09.724Z,1662115449.724 [ThrusterHE](DEBUG): Initializing ThrusterHE. 2022-09-02T10:44:09.986Z,1662115449.986 [Micromodem](INFO): Powering up 2022-09-02T10:44:09.987Z,1662115449.987 [Micromodem](DEBUG): Initializing Micromodem. 2022-09-02T10:44:10.672Z,1662115450.672 [RudderServo](ERROR): Rudder initialization uart error serial timeout 2022-09-02T10:44:10.672Z,1662115450.672 [RudderServo](FAULT): Rudder failed to initialize 2022-09-02T10:44:10.672Z,1662115450.672 [RudderServo] Communications Fault, FailCount= 1 2022-09-02T10:44:10.672Z,1662115450.672 [RudderServo](ERROR): Communications Fault 2022-09-02T10:44:10.676Z,1662115450.676 [CBIT](ERROR): Communications Fault in component: RudderServo 2022-09-02T10:44:10.889Z,1662115450.889 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2022-09-02T10:44:10.889Z,1662115450.889 [RudderServo](INFO): Powering down 2022-09-02T10:44:11.572Z,1662115451.572 [RudderServo](DEBUG): Initializing EZServoServo. 2022-09-02T10:44:11.693Z,1662115451.693 [RudderServo](DEBUG): Initializing RudderServo. 2022-09-02T10:44:11.697Z,1662115451.697 [CBIT](INFO): Clearing failed state for component RudderServo 2022-09-02T10:44:11.697Z,1662115451.697 [RudderServo] No Fault, FailCount= 1 2022-09-02T10:44:14.836Z,1662115454.836 [Micromodem](INFO): Nmea out: $CCCFG,ALL,0*33 2022-09-02T10:44:15.242Z,1662115455.242 [Micromodem](INFO): Nmea in: $CATMG,2022-09-02T10:44:15.378437Z,RTC,RTC*50 2022-09-02T10:44:15.243Z,1662115455.243 [Micromodem](ERROR): CFG response from modem unexpected: $CATMG,2022-09-02T10:44:15.378437Z,RTC,RTC*50 2022-09-02T10:44:15.556Z,1662115455.556 [ThrusterHE](ERROR): Zero Speed Commanded. 2022-09-02T10:44:15.670Z,1662115455.670 [Micromodem](INFO): Nmea in: $CACFG,ALL,0*31 2022-09-02T10:44:15.670Z,1662115455.670 [Micromodem](INFO): Nmea out: $CCCFG,POW,20*08 2022-09-02T10:44:16.070Z,1662115456.070 [Micromodem](INFO): Nmea in: $CACFG,POW,20*0A 2022-09-02T10:44:16.070Z,1662115456.070 [Micromodem](INFO): Nmea out: $CCCFG,SRC,0*30 2022-09-02T10:44:16.273Z,1662115456.273 [CTD_Seabird](ERROR): Device message queue exceeded the allowed limit. 2022-09-02T10:44:16.478Z,1662115456.478 [Micromodem](INFO): Nmea in: $CACFG,SRC,0*32 2022-09-02T10:44:16.478Z,1662115456.478 [Micromodem](INFO): Nmea out: $CCCFG,nav.dt.txtrig_gpio4,1*64 2022-09-02T10:44:16.882Z,1662115456.882 [Micromodem](INFO): Nmea in: $CACFG,nav.dt.txtrig_gpio4,1*66 2022-09-02T10:44:16.882Z,1662115456.882 [Micromodem](INFO): Nmea out: $CCCFG,pwramp.txlevel,0*2F 2022-09-02T10:44:17.286Z,1662115457.286 [Micromodem](INFO): Nmea in: $CACFG,pwramp.txlevel,0*2D 2022-09-02T10:44:17.286Z,1662115457.286 [Micromodem](INFO): Nmea out: $CCCFG,DTO,30*1E 2022-09-02T10:44:17.674Z,1662115457.674 [Micromodem](INFO): Nmea in: $CACFG,DTO,30*1C 2022-09-02T10:44:17.674Z,1662115457.674 [Micromodem](INFO): Nmea out: $CCCFG,FC0,14500*47 2022-09-02T10:44:18.082Z,1662115458.082 [Micromodem](INFO): Nmea in: $CACFG,FC0,14500*45 2022-09-02T10:44:18.082Z,1662115458.082 [Micromodem](INFO): Nmea out: $CCCFG,BW0,4000*63 2022-09-02T10:44:18.474Z,1662115458.474 [Micromodem](INFO): Nmea in: $CACFG,BW0,4000*61 2022-09-02T10:44:18.474Z,1662115458.474 [Micromodem](INFO): Nmea out: $CCCFG,BND,0*3A 2022-09-02T10:44:18.870Z,1662115458.870 [Micromodem](INFO): Nmea in: $CACFG,BND,0*38 2022-09-02T10:44:18.870Z,1662115458.870 [Micromodem](INFO): Nmea out: $CCCLK,2022,09,02,10,44,19*44 2022-09-02T10:44:19.274Z,1662115459.274 [Micromodem](INFO): Nmea in: $CACLK,2022,9,2,10,44,19*46 2022-09-02T10:44:19.678Z,1662115459.678 [Micromodem](INFO): Nmea in: $CATMS,0,2022-09-02T10:44:20Z*7C 2022-09-02T10:44:19.679Z,1662115459.679 [Micromodem](INFO): Nmea in: $CATMG,2022-09-02T10:44:20.026079Z,USER_CMD,RTC*11 2022-09-02T10:44:25.326Z,1662115465.326 [DDM](INFO): Latch/Whisker Boards:V1,H_RECOVERY_LATCH !V2,H_RECOVERY_WHISKERS 2022-09-02T10:44:25.428Z,1662115465.428 [DDM](INFO): Dynamic Docking Module:C REMUS Capture Rev 1.1 2022-09-02T10:44:36.642Z,1662115476.642 [NAL9602](INFO): Powering up NAL9602 2022-09-02T10:44:47.554Z,1662115487.554 [NAL9602](INFO): NAL9602 initialized 2022-09-02T10:45:04.549Z,1662115504.549 [SBIT](IMPORTANT): Beginning Startup BIT 2022-09-02T10:45:04.553Z,1662115504.553 [CBIT](IMPORTANT): Beginning ground fault scan 2022-09-02T10:45:14.222Z,1662115514.222 [NAL9602](INFO): SBD MO Status=0, MOMSN=44992, MT Status=0, MTMSN=0 2022-09-02T10:45:14.222Z,1662115514.222 [NAL9602](INFO): No messages in MT queue 2022-09-02T10:45:15.596Z,1662115515.596 [CBIT](IMPORTANT): Ground fault detected mA: CHAN A0 (Batt): 0.066071 CHAN A1 (24V): 0.001450 CHAN A2 (12V): 0.003479 CHAN A3 (5V): -0.001110 CHAN B0 (3.3V): 0.001025 CHAN B1 (3.15aV): -0.000379 CHAN B2 (3.15bV): 0.000220 CHAN B3 (GND): -0.000527 OPEN: 0.006027 Full Scale: +/- 1 mA 2022-09-02T10:45:18.269Z,1662115518.269 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,104525.00,A,4009.42147,N,07050.41643,W,0.836,323.85,020922,,,A*7D 2022-09-02T10:45:18.272Z,1662115518.272 [NAL9602](INFO): GPS fix at 20220902T104525: (40.157024, -70.840274) 2022-09-02T10:45:18.285Z,1662115518.285 [LBLNavigation](INFO): Reset ping filters 2022-09-02T10:45:18.285Z,1662115518.285 [LBLNavigation](INFO): Reset fix filter 2022-09-02T10:45:50.982Z,1662115550.982 [NAL9602](INFO): Not Powering down - fast GPS 2022-09-02T10:45:58.326Z,1662115558.326 [SBIT](IMPORTANT): SBIT PASSED 2022-09-02T10:45:58.326Z,1662115558.326 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg 2022-09-02T10:45:58.327Z,1662115558.327 [SBIT](IMPORTANT): CBIT.abortDepth=250 meter; 2022-09-02T10:45:58.327Z,1662115558.327 [SBIT](IMPORTANT): CBIT.gfScanTimeout=2 hour; 2022-09-02T10:45:58.327Z,1662115558.327 [SBIT](IMPORTANT): CBIT.stopDepth=200 meter; 2022-09-02T10:45:58.327Z,1662115558.327 [SBIT](IMPORTANT): DDM.loadAtStartup=1 bool; 2022-09-02T10:45:58.327Z,1662115558.327 [SBIT](IMPORTANT): DockingServo.loadAtStartup=0 bool; 2022-09-02T10:45:58.327Z,1662115558.327 [SBIT](IMPORTANT): Express linearApproximation CTD_Seabird.bin_median_sea_water_salinity 0.050000 practical_salinity_unit; 2022-09-02T10:45:58.327Z,1662115558.327 [SBIT](IMPORTANT): Express linearApproximation CTD_Seabird.bin_median_sea_water_temperature 0.500000 celsius; 2022-09-02T10:45:58.327Z,1662115558.327 [SBIT](IMPORTANT): LineCapture.armSpeed=1.2 meter_per_second; 2022-09-02T10:45:58.332Z,1662115558.332 [SBIT](IMPORTANT): LineCapture.midcourseSpeed=1.2 meter_per_second; 2022-09-02T10:45:58.332Z,1662115558.332 [SBIT](IMPORTANT): LineCapture.rolloutTimeout=6 minute; 2022-09-02T10:45:58.332Z,1662115558.332 [SBIT](IMPORTANT): LineCapture.shortFinalRange=-1 meter; 2022-09-02T10:45:58.332Z,1662115558.332 [SBIT](IMPORTANT): LineCapture.terminalRange=300 meter; 2022-09-02T10:45:58.332Z,1662115558.332 [SBIT](IMPORTANT): LineCapture.verbose=1 bool; 2022-09-02T10:45:58.332Z,1662115558.332 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=152.268921 cubic_centimeter; 2022-09-02T10:45:58.333Z,1662115558.333 [SBIT](IMPORTANT): VerticalControl.massDefault=8.973020 millimeter; 2022-09-02T10:45:58.700Z,1662115558.700 [WorkSite](INFO): Already have valid position. Ignoring workSite position from Data/workSite.cfg 2022-09-02T10:45:58.705Z,1662115558.705 [MissionManager](IMPORTANT): Started mission Startup 2022-09-02T10:45:58.705Z,1662115558.705 [Startup] Running Loop=1 2022-09-02T10:45:58.705Z,1662115558.705 [Startup](DEBUG): Aggregate::initialize Startup 2022-09-02T10:45:58.705Z,1662115558.705 [Startup:A.GoToSurface] Running Loop=1 2022-09-02T10:45:58.705Z,1662115558.705 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2022-09-02T10:45:58.706Z,1662115558.706 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2022-09-02T10:45:58.706Z,1662115558.706 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2022-09-02T10:45:58.706Z,1662115558.706 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2022-09-02T10:45:58.707Z,1662115558.707 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2022-09-02T10:45:58.707Z,1662115558.707 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2022-09-02T10:45:58.725Z,1662115558.725 [Startup:StartupSatComms] Running Loop=1 2022-09-02T10:45:58.725Z,1662115558.725 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms 2022-09-02T10:45:58.725Z,1662115558.725 [Startup:StartupSatComms:A] Running Loop=1 2022-09-02T10:45:59.122Z,1662115559.122 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix 2022-09-02T10:46:00.692Z,1662115560.692 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,104608.00,A,4009.42112,N,07050.42486,W,0.641,231.97,020922,,,A*76 2022-09-02T10:46:00.695Z,1662115560.695 [NAL9602](INFO): GPS fix at 20220902T104608: (40.157019, -70.840414) 2022-09-02T10:46:00.716Z,1662115560.716 [Startup:StartupSatComms:A] Stopped 2022-09-02T10:46:00.716Z,1662115560.716 [Startup:StartupSatComms:B] Running Loop=1 2022-09-02T10:46:01.125Z,1662115561.125 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications 2022-09-02T10:46:15.547Z,1662115575.547 [NAL9602](INFO): SBD MO Status=1, MOMSN=44993, MT Status=0, MTMSN=0 2022-09-02T10:46:15.600Z,1662115575.600 [NAL9602](INFO): Sent 52 bytes from file Logs/20220902T013526/Courier0007.lzma 2022-09-02T10:46:15.600Z,1662115575.600 [NAL9602](INFO): Packets left to send: 0 2022-09-02T10:46:25.471Z,1662115585.471 [NAL9602](INFO): SBD MO Status=1, MOMSN=44994, MT Status=0, MTMSN=0 2022-09-02T10:46:25.532Z,1662115585.532 [NAL9602](INFO): Sent 184 bytes from file Logs/20220902T104358/Courier0000.lzma 2022-09-02T10:46:25.532Z,1662115585.532 [NAL9602](INFO): Packets left to send: 1 2022-09-02T10:46:37.155Z,1662115597.155 [NAL9602](INFO): SBD MO Status=1, MOMSN=44995, MT Status=0, MTMSN=0 2022-09-02T10:46:37.212Z,1662115597.212 [NAL9602](INFO): Sent 66 bytes from file Logs/20220902T104358/Courier0000.lzma 2022-09-02T10:46:37.212Z,1662115597.212 [NAL9602](INFO): Packets left to send: 0 2022-09-02T10:46:48.235Z,1662115608.235 [NAL9602](INFO): SBD MO Status=1, MOMSN=44996, MT Status=0, MTMSN=0 2022-09-02T10:46:48.296Z,1662115608.296 [NAL9602](INFO): Sent 165 bytes from file Logs/20220902T013526/Express0008.lzma 2022-09-02T10:46:48.296Z,1662115608.296 [NAL9602](INFO): Packets left to send: 0 2022-09-02T10:46:57.212Z,1662115617.212 [NAL9602](INFO): SBD MO Status=1, MOMSN=44997, MT Status=0, MTMSN=0 2022-09-02T10:46:57.260Z,1662115617.260 [NAL9602](INFO): Sent 184 bytes from file Logs/20220902T104358/Express0001.lzma 2022-09-02T10:46:57.260Z,1662115617.260 [NAL9602](INFO): Packets left to send: 5 2022-09-02T10:47:01.710Z,1662115621.710 [Startup:StartupSatComms:B](INFO): Timed out from 2022-09-02T10:46:00.7Z 2022-09-02T10:47:01.710Z,1662115621.710 [Startup:StartupSatComms:B] Stopped 2022-09-02T10:47:01.711Z,1662115621.711 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms 2022-09-02T10:47:01.711Z,1662115621.711 [Startup:StartupSatComms] Stopped 2022-09-02T10:47:01.711Z,1662115621.711 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms 2022-09-02T10:47:01.711Z,1662115621.711 [Startup](INFO): Completed Startup 2022-09-02T10:47:01.744Z,1662115621.744 [MissionManager](INFO): Startup is completed. 2022-09-02T10:47:01.744Z,1662115621.744 [MissionManager](INFO): Uninitializing Mission Startup 2022-09-02T10:47:01.744Z,1662115621.744 [Startup] Stopped 2022-09-02T10:47:01.744Z,1662115621.744 [Startup](DEBUG): Aggregate::uninitialize Startup 2022-09-02T10:47:01.744Z,1662115621.744 [Startup:A.GoToSurface] Stopped 2022-09-02T10:47:01.744Z,1662115621.744 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2022-09-02T10:47:01.937Z,1662115621.937 [MissionManager](IMPORTANT): Started mission Default 2022-09-02T10:47:01.937Z,1662115621.937 [Default] Running Loop=1 2022-09-02T10:47:01.937Z,1662115621.937 [Default](DEBUG): Aggregate::initialize Default 2022-09-02T10:47:01.937Z,1662115621.937 [Default:B.GoToSurface] Running Loop=1 2022-09-02T10:47:01.937Z,1662115621.937 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2022-09-02T10:47:01.937Z,1662115621.937 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2022-09-02T10:47:01.938Z,1662115621.938 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2022-09-02T10:47:01.938Z,1662115621.938 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2022-09-02T10:47:01.938Z,1662115621.938 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2022-09-02T10:47:01.939Z,1662115621.939 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2022-09-02T10:47:01.939Z,1662115621.939 [Default:A.Wait] Running Loop=1 2022-09-02T10:47:01.939Z,1662115621.939 [Default:A.Wait](DEBUG): Initialize Wait Component. 2022-09-02T10:47:08.399Z,1662115628.399 [NAL9602](INFO): SBD MO Status=1, MOMSN=44998, MT Status=0, MTMSN=0 2022-09-02T10:47:08.456Z,1662115628.456 [NAL9602](INFO): Sent 184 bytes from file Logs/20220902T104358/Express0001.lzma 2022-09-02T10:47:08.456Z,1662115628.456 [NAL9602](INFO): Packets left to send: 4 2022-09-02T10:47:15.129Z,1662115635.129 [Default:A.Wait](INFO): Done Waiting. 2022-09-02T10:47:15.129Z,1662115635.129 [Default:A.Wait] Stopped 2022-09-02T10:47:15.129Z,1662115635.129 [Default:A.Wait](DEBUG): Uninitialize Wait Component. 2022-09-02T10:47:15.521Z,1662115635.521 [Default:CheckIn] Running Loop=1 2022-09-02T10:47:15.521Z,1662115635.521 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2022-09-02T10:47:15.521Z,1662115635.521 [Default:CheckIn:Read_GPS] Running Loop=1 2022-09-02T10:47:15.980Z,1662115635.980 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix 2022-09-02T10:47:17.524Z,1662115637.524 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,104725.00,A,4009.41303,N,07050.43400,W,0.369,156.34,020922,,,A*72 2022-09-02T10:47:17.527Z,1662115637.527 [NAL9602](INFO): GPS fix at 20220902T104725: (40.156884, -70.840567) 2022-09-02T10:47:17.542Z,1662115637.542 [Default:CheckIn:Read_GPS] Stopped 2022-09-02T10:47:17.542Z,1662115637.542 [Default:CheckIn:Read_Iridium] Running Loop=1 2022-09-02T10:47:18.013Z,1662115638.013 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications 2022-09-02T10:47:41.248Z,1662115661.248 [NAL9602](INFO): SBD MO Status=2, MOMSN=44999, MT Status=2, MTMSN=0 2022-09-02T10:47:41.248Z,1662115661.248 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2022-09-02T10:48:01.240Z,1662115681.240 [NAL9602](INFO): SBD MO Status=1, MOMSN=44999, MT Status=0, MTMSN=0 2022-09-02T10:48:01.288Z,1662115681.288 [NAL9602](INFO): Sent 72 bytes from file Logs/20220902T104358/Courier0004.lzma 2022-09-02T10:48:01.288Z,1662115681.288 [NAL9602](INFO): Packets left to send: 0 2022-09-02T10:48:10.384Z,1662115690.384 [NAL9602](INFO): SBD MO Status=1, MOMSN=45000, MT Status=0, MTMSN=0 2022-09-02T10:48:10.444Z,1662115690.444 [NAL9602](INFO): Sent 184 bytes from file Logs/20220902T104358/Express0001.lzma 2022-09-02T10:48:10.444Z,1662115690.444 [NAL9602](INFO): Packets left to send: 3 2022-09-02T10:48:18.192Z,1662115698.192 [NAL9602](INFO): SBD MO Status=1, MOMSN=45001, MT Status=0, MTMSN=0 2022-09-02T10:48:18.252Z,1662115698.252 [NAL9602](INFO): Sent 184 bytes from file Logs/20220902T104358/Express0001.lzma 2022-09-02T10:48:18.252Z,1662115698.252 [NAL9602](INFO): Packets left to send: 2 2022-09-02T10:48:27.679Z,1662115707.679 [NAL9602](INFO): SBD MO Status=1, MOMSN=45002, MT Status=0, MTMSN=0 2022-09-02T10:48:27.740Z,1662115707.740 [NAL9602](INFO): Sent 184 bytes from file Logs/20220902T104358/Express0001.lzma 2022-09-02T10:48:27.740Z,1662115707.740 [NAL9602](INFO): Packets left to send: 1 2022-09-02T10:48:35.156Z,1662115715.156 [NAL9602](INFO): SBD MO Status=1, MOMSN=45003, MT Status=0, MTMSN=0 2022-09-02T10:48:35.212Z,1662115715.212 [NAL9602](INFO): Sent 129 bytes from file Logs/20220902T104358/Express0001.lzma 2022-09-02T10:48:35.212Z,1662115715.212 [NAL9602](INFO): Packets left to send: 0 2022-09-02T10:48:42.903Z,1662115722.903 [NAL9602](INFO): SBD MO Status=1, MOMSN=45004, MT Status=0, MTMSN=0 2022-09-02T10:48:42.964Z,1662115722.964 [NAL9602](INFO): Sent 94 bytes from file Logs/20220902T104358/Express0005.lzma 2022-09-02T10:48:42.965Z,1662115722.965 [NAL9602](INFO): Packets left to send: 0 2022-09-02T10:48:59.093Z,1662115739.093 [NAL9602](INFO): SBD MO Status=2, MOMSN=45005, MT Status=2, MTMSN=0 2022-09-02T10:48:59.093Z,1662115739.093 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2022-09-02T10:49:09.727Z,1662115749.727 [NAL9602](INFO): SBD MO Status=0, MOMSN=45005, MT Status=0, MTMSN=0 2022-09-02T10:49:09.878Z,1662115749.878 [Default:CheckIn:Read_Iridium] Stopped 2022-09-02T10:49:09.878Z,1662115749.878 [Default:CheckIn:C.Wait] Running Loop=1 2022-09-02T10:49:09.878Z,1662115749.878 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2022-09-02T10:49:40.266Z,1662115780.266 [NAL9602](INFO): Not Powering down - fast GPS 2022-09-02T10:51:33.406Z,1662115893.406 [BPC1](ERROR): Battery stick #62 (s/n: 0138) reported TERMINATE_CHARGE_ALARM. Status code: 0x40C0. 2022-09-02T10:51:33.406Z,1662115893.406 [BPC1](INFO): Calculating totals. Valid battery stick count: 55. Valid reserve battery stick count: 6. 2022-09-02T10:51:33.410Z,1662115893.410 [BPC1](INFO): Received data from all battery sticks. 2022-09-02T10:54:02.024Z,1662116042.024 [CommandExec](IMPORTANT): got command restart application 2022-09-02T10:54:03.027Z,1662116043.027 [Supervisor](INFO): Stop Mission called by Supervisor::terminate 2022-09-02T10:54:03.027Z,1662116043.027 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread. 2022-09-02T10:54:03.027Z,1662116043.027 [CommandExec](INFO): Uninitializing the command executive. 2022-09-02T10:54:03.027Z,1662116043.027 [CommandExec](INFO): Uninitializing the command scheduler. 2022-09-02T10:54:03.028Z,1662116043.028 [CommandExec ThreadHandler](INFO): Thread cancelled. 2022-09-02T10:54:03.139Z,1662116043.139 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2022-09-02T10:54:03.139Z,1662116043.139 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2022-09-02T10:54:03.139Z,1662116043.139 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2022-09-02T10:54:03.140Z,1662116043.140 [NavChartDb](INFO): Join timeout helper Thread ID is 3611 2022-09-02T10:54:03.243Z,1662116043.243 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2022-09-02T10:54:03.243Z,1662116043.243 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2022-09-02T10:54:03.259Z,1662116043.259 [ComponentRegistry](INFO): Shutting down WetLabsSeaOWL_UV_A ThreadHandler 2022-09-02T10:54:03.259Z,1662116043.259 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Thread cancelled. 2022-09-02T10:54:03.260Z,1662116043.260 [WetLabsSeaOWL_UV_A](INFO): Join timeout helper Thread ID is 3612 2022-09-02T10:54:03.339Z,1662116043.339 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Uninitializing protected caller thread. 2022-09-02T10:54:03.340Z,1662116043.340 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Thread cancelled. 2022-09-02T10:54:03.359Z,1662116043.359 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler 2022-09-02T10:54:03.359Z,1662116043.359 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2022-09-02T10:54:03.359Z,1662116043.359 [CTD_Seabird](INFO): Join timeout helper Thread ID is 3613 2022-09-02T10:54:04.047Z,1662116044.047 [CTD_Seabird](INFO): Powering down 2022-09-02T10:54:04.059Z,1662116044.059 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread. 2022-09-02T10:54:04.060Z,1662116044.060 [CTD_Seabird](INFO): Powering down 2022-09-02T10:54:04.076Z,1662116044.076 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2022-09-02T10:54:04.087Z,1662116044.087 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2022-09-02T10:54:04.087Z,1662116044.087 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2022-09-02T10:54:04.088Z,1662116044.088 [Radio_Surface](INFO): Join timeout helper Thread ID is 3614 2022-09-02T10:54:04.131Z,1662116044.131 [Radio_Surface](INFO): Powering down 2022-09-02T10:54:04.132Z,1662116044.132 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2022-09-02T10:54:04.132Z,1662116044.132 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2022-09-02T10:54:04.147Z,1662116044.147 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler 2022-09-02T10:54:04.147Z,1662116044.147 [Onboard ThreadHandler](INFO): Thread cancelled. 2022-09-02T10:54:04.148Z,1662116044.148 [Onboard](INFO): Join timeout helper Thread ID is 3615 2022-09-02T10:54:05.011Z,1662116045.011 [DataOverHttps](INFO): Radio surface powered OFF, will not connect. 2022-09-02T10:54:09.063Z,1662116049.063 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread. 2022-09-02T10:54:09.063Z,1662116049.063 [Onboard ThreadHandler](INFO): Thread cancelled. 2022-09-02T10:54:09.076Z,1662116049.076 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler 2022-09-02T10:54:09.076Z,1662116049.076 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2022-09-02T10:54:09.076Z,1662116049.076 [DataOverHttps](INFO): Join timeout helper Thread ID is 3617 2022-09-02T10:54:10.031Z,1662116050.031 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread. 2022-09-02T10:54:10.031Z,1662116050.031 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2022-09-02T10:54:10.048Z,1662116050.048 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2022-09-02T10:54:10.048Z,1662116050.048 [logger ThreadHandler](INFO): Thread cancelled. 2022-09-02T10:54:10.048Z,1662116050.048 [logger](INFO): Join timeout helper Thread ID is 3618 2022-09-02T10:54:10.064Z,1662116050.064 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2022-09-02T10:54:10.064Z,1662116050.064 [logger ThreadHandler](INFO): Thread cancelled. 2022-09-02T10:54:10.084Z,1662116050.084 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2022-09-02T10:54:10.084Z,1662116050.084 [CommandLine ThreadHandler](INFO): Thread cancelled. 2022-09-02T10:54:10.084Z,1662116050.084 [CommandLine](INFO): Join timeout helper Thread ID is 3619 2022-09-02T10:54:10.099Z,1662116050.099 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2022-09-02T10:54:10.099Z,1662116050.099 [CommandLine ThreadHandler](INFO): Thread cancelled. 2022-09-02T10:54:10.104Z,1662116050.104 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler 2022-09-02T10:54:10.104Z,1662116050.104 [CommandExec ThreadHandler](INFO): Thread cancelled. 2022-09-02T10:54:10.104Z,1662116050.104 [CommandExec](INFO): Join timeout helper Thread ID is 3620 2022-09-02T10:54:10.105Z,1662116050.105 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2022-09-02T10:54:10.106Z,1662116050.106 [controlThread ThreadHandler](INFO): Thread cancelled. 2022-09-02T10:54:10.106Z,1662116050.106 [controlThread](INFO): Join timeout helper Thread ID is 3621 2022-09-02T10:54:10.291Z,1662116050.291 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2022-09-02T10:54:10.291Z,1662116050.291 [controlThread](DEBUG): Uninitializing ControlThread 2022-09-02T10:54:10.292Z,1662116050.292 [AHRS_M2](INFO): Powering down 2022-09-02T10:54:10.364Z,1662116050.364 [DDM](INFO): Powering down 2022-09-02T10:54:10.436Z,1662116050.436 [Micromodem](INFO): Powering down 2022-09-02T10:54:10.531Z,1662116050.531 [NAL9602](INFO): Powering down 2022-09-02T10:54:10.603Z,1662116050.603 [RDI_Pathfinder](INFO): Powering down 2022-09-02T10:54:10.675Z,1662116050.675 [RDI_PathfinderUp](INFO): Powering down 2022-09-02T10:54:10.676Z,1662116050.676 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator. 2022-09-02T10:54:10.677Z,1662116050.677 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator. 2022-09-02T10:54:10.678Z,1662116050.678 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2022-09-02T10:54:10.679Z,1662116050.679 [MissionManager](INFO): Uninitializing Mission Default 2022-09-02T10:54:10.679Z,1662116050.679 [Default] Stopped 2022-09-02T10:54:10.679Z,1662116050.679 [Default](DEBUG): Aggregate::uninitialize Default 2022-09-02T10:54:10.679Z,1662116050.679 [Default:B.GoToSurface] Stopped 2022-09-02T10:54:10.679Z,1662116050.679 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2022-09-02T10:54:10.679Z,1662116050.679 [Default:CheckIn] Stopped 2022-09-02T10:54:10.679Z,1662116050.679 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2022-09-02T10:54:10.679Z,1662116050.679 [Default:CheckIn:C.Wait] Stopped 2022-09-02T10:54:10.679Z,1662116050.679 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2022-09-02T10:54:10.682Z,1662116050.682 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2022-09-02T10:54:10.682Z,1662116050.682 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2022-09-02T10:54:10.683Z,1662116050.683 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2022-09-02T10:54:10.683Z,1662116050.683 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2022-09-02T10:54:10.684Z,1662116050.684 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2022-09-02T10:54:10.684Z,1662116050.684 [BuoyancyServo](INFO): Powering down 2022-09-02T10:54:10.695Z,1662116050.695 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2022-09-02T10:54:10.695Z,1662116050.695 [ElevatorServo](INFO): Powering down 2022-09-02T10:54:10.696Z,1662116050.696 [MassServo](DEBUG): Uninitialize Mass Servo. 2022-09-02T10:54:10.696Z,1662116050.696 [MassServo](INFO): Powering down 2022-09-02T10:54:10.697Z,1662116050.697 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2022-09-02T10:54:10.697Z,1662116050.697 [RudderServo](INFO): Powering down 2022-09-02T10:54:10.698Z,1662116050.698 [ThrusterHE](DEBUG): Uninitialize Thruster Servo. 2022-09-02T10:54:10.698Z,1662116050.698 [ThrusterHE](INFO): Powering down 2022-09-02T10:54:10.699Z,1662116050.699 [SBIT](DEBUG): Uninitialize SBIT Component. 2022-09-02T10:54:10.699Z,1662116050.699 [IBIT](DEBUG): Uninitialize IBIT Component. 2022-09-02T10:54:10.700Z,1662116050.700 [CBIT](DEBUG): Uninitialize CBIT Component. 2022-09-02T10:54:10.700Z,1662116050.700 [CBIT](DEBUG): Powering off loads. 2022-09-02T10:54:10.711Z,1662116050.711 [CBIT](DEBUG): Disabling WDT. 2022-09-02T10:54:10.723Z,1662116050.723 [CBIT](DEBUG): Opening all GF detection circuits. 2022-09-02T10:54:10.724Z,1662116050.724 [controlThread ThreadHandler](INFO): Thread cancelled. 2022-09-02T10:54:10.747Z,1662116050.747 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2022-09-02T10:54:10.751Z,1662116050.751 [Onboard ThreadHandler](INFO): Thread cancelled. 2022-09-02T10:54:10.760Z,1662116050.760 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2022-09-02T10:54:10.849Z,1662116050.849 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Thread cancelled. 2022-09-02T10:54:10.851Z,1662116050.851 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2022-09-02T10:54:10.911Z,1662116050.911 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2022-09-02T10:54:10.975Z,1662116050.975 [logger ThreadHandler](INFO): Thread cancelled.