2023-10-02T17:53:39.117Z,1696269219.117 [Supervisor](DEBUG): Initializing supervisor. 2023-10-02T17:53:39.121Z,1696269219.121 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2023-10-02T17:53:39.122Z,1696269219.122 [SyncHandler](INFO): Protected caller Thread ID is 9648 2023-10-02T17:53:39.123Z,1696269219.123 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2023-10-02T17:53:39.123Z,1696269219.123 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2023-10-02T17:53:39.124Z,1696269219.124 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 9649 2023-10-02T17:53:39.128Z,1696269219.128 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2023-10-02T17:53:39.145Z,1696269219.145 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread. 2023-10-02T17:53:39.145Z,1696269219.145 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2023-10-02T17:53:39.146Z,1696269219.146 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 9650 2023-10-02T17:53:39.150Z,1696269219.150 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2023-10-02T17:53:39.151Z,1696269219.151 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2023-10-02T17:53:39.151Z,1696269219.151 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 9651 2023-10-02T17:53:39.153Z,1696269219.153 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2023-10-02T17:53:39.154Z,1696269219.154 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0 2023-10-02T17:53:39.154Z,1696269219.154 [logger ThreadHandler](INFO): Protected caller Thread ID is 9652 2023-10-02T17:53:39.158Z,1696269219.158 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2023-10-02T17:53:39.158Z,1696269219.158 [Supervisor](INFO): Looking for Config files in directory: Config/ 2023-10-02T17:53:39.160Z,1696269219.160 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2023-10-02T17:53:39.462Z,1696269219.462 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2023-10-02T17:53:39.463Z,1696269219.463 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2023-10-02T17:53:39.543Z,1696269219.543 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2023-10-02T17:53:39.648Z,1696269219.648 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2023-10-02T17:53:39.648Z,1696269219.648 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2023-10-02T17:53:39.773Z,1696269219.773 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2023-10-02T17:53:39.774Z,1696269219.774 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2023-10-02T17:53:40.099Z,1696269220.099 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2023-10-02T17:53:40.100Z,1696269220.100 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2023-10-02T17:53:40.195Z,1696269220.195 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2023-10-02T17:53:40.196Z,1696269220.196 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2023-10-02T17:53:40.641Z,1696269220.641 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2023-10-02T17:53:40.642Z,1696269220.642 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2023-10-02T17:53:40.842Z,1696269220.842 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2023-10-02T17:53:40.842Z,1696269220.842 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2023-10-02T17:53:40.921Z,1696269220.921 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg 2023-10-02T17:53:41.136Z,1696269221.136 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock 2023-10-02T17:53:41.137Z,1696269221.137 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2023-10-02T17:53:41.344Z,1696269221.344 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2023-10-02T17:53:41.344Z,1696269221.344 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2023-10-02T17:53:41.823Z,1696269221.823 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2023-10-02T17:53:41.824Z,1696269221.824 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2023-10-02T17:53:42.002Z,1696269222.002 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2023-10-02T17:53:42.002Z,1696269222.002 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2023-10-02T17:53:42.271Z,1696269222.271 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2023-10-02T17:53:42.271Z,1696269222.271 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2023-10-02T17:53:43.068Z,1696269223.068 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2023-10-02T17:53:43.068Z,1696269223.068 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2023-10-02T17:53:43.557Z,1696269223.557 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2023-10-02T17:53:43.559Z,1696269223.559 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-ahi/ 2023-10-02T17:53:43.560Z,1696269223.560 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Control.cfg 2023-10-02T17:53:43.656Z,1696269223.656 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Science.cfg 2023-10-02T17:53:43.772Z,1696269223.772 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/secure.cfg 2023-10-02T17:53:43.857Z,1696269223.857 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Servo.cfg 2023-10-02T17:53:43.964Z,1696269223.964 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/BIT.cfg 2023-10-02T17:53:44.062Z,1696269224.062 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Battery.cfg 2023-10-02T17:53:44.318Z,1696269224.318 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2023-10-02T17:53:44.319Z,1696269224.319 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/vehicle.cfg 2023-10-02T17:53:44.427Z,1696269224.427 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/logger.cfg 2023-10-02T17:53:44.520Z,1696269224.520 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Navigation.cfg 2023-10-02T17:53:44.622Z,1696269224.622 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Sensor.cfg 2023-10-02T17:53:44.750Z,1696269224.750 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Simulator.cfg 2023-10-02T17:53:44.836Z,1696269224.836 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-ahi/root/ 2023-10-02T17:53:44.836Z,1696269224.836 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg 2023-10-02T17:53:44.845Z,1696269224.845 [Module Loader](DEBUG): Loading Module at Modules/Dock.so 2023-10-02T17:53:44.941Z,1696269224.941 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking) 2023-10-02T17:53:44.941Z,1696269224.941 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2023-10-02T17:53:44.990Z,1696269224.990 [VerticalControl](DEBUG): Construct VerticalControl. 2023-10-02T17:53:45.048Z,1696269225.048 [VerticalControl] Loaded 2023-10-02T17:53:45.048Z,1696269225.048 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2023-10-02T17:53:45.051Z,1696269225.051 [HorizontalControl](DEBUG): Construct HorizontalControl. 2023-10-02T17:53:45.091Z,1696269225.091 [HorizontalControl] Loaded 2023-10-02T17:53:45.091Z,1696269225.091 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2023-10-02T17:53:45.093Z,1696269225.093 [SpeedControl](DEBUG): Construct SpeedControl. 2023-10-02T17:53:45.096Z,1696269225.096 [SpeedControl] Loaded 2023-10-02T17:53:45.097Z,1696269225.097 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2023-10-02T17:53:45.099Z,1696269225.099 [LoopControl](DEBUG): Construct LoopControl. 2023-10-02T17:53:45.100Z,1696269225.100 [LoopControl] Loaded 2023-10-02T17:53:45.100Z,1696269225.100 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2023-10-02T17:53:45.100Z,1696269225.100 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2023-10-02T17:53:45.101Z,1696269225.101 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2023-10-02T17:53:45.154Z,1696269225.154 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2023-10-02T17:53:45.155Z,1696269225.155 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2023-10-02T17:53:45.561Z,1696269225.561 [AHRS_M2] Loaded 2023-10-02T17:53:45.561Z,1696269225.561 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread. 2023-10-02T17:53:45.596Z,1696269225.596 [BackseatComponent] Loaded 2023-10-02T17:53:45.596Z,1696269225.596 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread. 2023-10-02T17:53:45.597Z,1696269225.597 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 408814E0 2023-10-02T17:53:45.598Z,1696269225.598 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 9735 2023-10-02T17:53:45.601Z,1696269225.601 [LcmUniversalReporter] Loaded 2023-10-02T17:53:45.601Z,1696269225.601 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread. 2023-10-02T17:53:46.396Z,1696269226.396 [BPC1] Loaded 2023-10-02T17:53:46.396Z,1696269226.396 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2023-10-02T17:53:46.468Z,1696269226.468 [DataOverHttps] Loaded 2023-10-02T17:53:46.468Z,1696269226.468 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread. 2023-10-02T17:53:46.469Z,1696269226.469 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 408B14E0 2023-10-02T17:53:46.469Z,1696269226.469 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 9736 2023-10-02T17:53:46.489Z,1696269226.489 [Depth_Keller] Loaded 2023-10-02T17:53:46.490Z,1696269226.490 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2023-10-02T17:53:46.494Z,1696269226.494 [DropWeight] Loaded 2023-10-02T17:53:46.495Z,1696269226.495 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread. 2023-10-02T17:53:46.556Z,1696269226.556 [NAL9602] Loaded 2023-10-02T17:53:46.556Z,1696269226.556 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2023-10-02T17:53:46.585Z,1696269226.585 [Onboard] Loaded 2023-10-02T17:53:46.585Z,1696269226.585 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread. 2023-10-02T17:53:46.586Z,1696269226.586 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 408E14E0 2023-10-02T17:53:46.587Z,1696269226.587 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 9737 2023-10-02T17:53:46.598Z,1696269226.598 [Power24vConverter] Loaded 2023-10-02T17:53:46.599Z,1696269226.599 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread. 2023-10-02T17:53:46.611Z,1696269226.611 [Radio_Surface] Loaded 2023-10-02T17:53:46.612Z,1696269226.612 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2023-10-02T17:53:46.613Z,1696269226.613 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 409114E0 2023-10-02T17:53:46.613Z,1696269226.613 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 9738 2023-10-02T17:53:46.702Z,1696269226.702 [DAT] Loaded 2023-10-02T17:53:46.702Z,1696269226.702 [ComponentRegistry](DEBUG): Component "DAT" handled in its own thread. 2023-10-02T17:53:46.703Z,1696269226.703 [DAT ThreadHandler](DEBUG): Created PCaller Thread at 409414E0 2023-10-02T17:53:46.704Z,1696269226.704 [DAT ThreadHandler](INFO): Protected caller Thread ID is 9739 2023-10-02T17:53:46.704Z,1696269226.704 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2023-10-02T17:53:46.705Z,1696269226.705 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2023-10-02T17:53:46.715Z,1696269226.715 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2023-10-02T17:53:46.715Z,1696269226.715 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2023-10-02T17:53:46.741Z,1696269226.741 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2023-10-02T17:53:46.742Z,1696269226.742 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2023-10-02T17:53:46.871Z,1696269226.871 [SBIT](DEBUG): Construct Startup Built In Test. 2023-10-02T17:53:46.880Z,1696269226.880 [SBIT] Loaded 2023-10-02T17:53:46.880Z,1696269226.880 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2023-10-02T17:53:46.883Z,1696269226.883 [IBIT](DEBUG): Construct Initiated Built In Test. 2023-10-02T17:53:46.895Z,1696269226.895 [IBIT] Loaded 2023-10-02T17:53:46.895Z,1696269226.895 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2023-10-02T17:53:46.901Z,1696269226.901 [CBIT](DEBUG): Construct Continuous Built In Test. 2023-10-02T17:53:47.001Z,1696269227.001 [CBIT] Loaded 2023-10-02T17:53:47.002Z,1696269227.002 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2023-10-02T17:53:47.002Z,1696269227.002 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2023-10-02T17:53:47.003Z,1696269227.003 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2023-10-02T17:53:47.294Z,1696269227.294 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2023-10-02T17:53:47.295Z,1696269227.295 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2023-10-02T17:53:47.342Z,1696269227.342 [DepthRateCalculator] Loaded 2023-10-02T17:53:47.343Z,1696269227.343 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2023-10-02T17:53:47.348Z,1696269227.348 [PitchRateCalculator] Loaded 2023-10-02T17:53:47.348Z,1696269227.348 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2023-10-02T17:53:47.358Z,1696269227.358 [SpeedCalculator] Loaded 2023-10-02T17:53:47.358Z,1696269227.358 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2023-10-02T17:53:47.362Z,1696269227.362 [YawRateCalculator] Loaded 2023-10-02T17:53:47.363Z,1696269227.363 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2023-10-02T17:53:47.381Z,1696269227.381 [ElevatorOffsetCalculator] Loaded 2023-10-02T17:53:47.381Z,1696269227.381 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread. 2023-10-02T17:53:47.381Z,1696269227.381 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2023-10-02T17:53:47.382Z,1696269227.382 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2023-10-02T17:53:47.522Z,1696269227.522 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2023-10-02T17:53:47.522Z,1696269227.522 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2023-10-02T17:53:47.630Z,1696269227.630 [DeadReckonUsingMultipleVelocitySources] Loaded 2023-10-02T17:53:47.631Z,1696269227.631 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2023-10-02T17:53:47.673Z,1696269227.673 [DeadReckonUsingSpeedCalculator] Loaded 2023-10-02T17:53:47.673Z,1696269227.673 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread. 2023-10-02T17:53:47.714Z,1696269227.714 [DeadReckonWithRespectToSeafloor] Loaded 2023-10-02T17:53:47.715Z,1696269227.715 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonWithRespectToSeafloor" handled in the control thread. 2023-10-02T17:53:47.728Z,1696269227.728 [NavChart] Loaded 2023-10-02T17:53:47.728Z,1696269227.728 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2023-10-02T17:53:47.734Z,1696269227.734 [UniversalFixResidualReporter] Loaded 2023-10-02T17:53:47.734Z,1696269227.734 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2023-10-02T17:53:47.735Z,1696269227.735 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2023-10-02T17:53:47.735Z,1696269227.735 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2023-10-02T17:53:47.862Z,1696269227.862 [BuoyancyServo] Loaded 2023-10-02T17:53:47.862Z,1696269227.862 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2023-10-02T17:53:47.882Z,1696269227.882 [ElevatorServo] Loaded 2023-10-02T17:53:47.882Z,1696269227.882 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2023-10-02T17:53:47.902Z,1696269227.902 [MassServo] Loaded 2023-10-02T17:53:47.902Z,1696269227.902 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2023-10-02T17:53:47.920Z,1696269227.920 [RudderServo] Loaded 2023-10-02T17:53:47.920Z,1696269227.920 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2023-10-02T17:53:47.935Z,1696269227.935 [ThrusterHE] Loaded 2023-10-02T17:53:47.935Z,1696269227.935 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread. 2023-10-02T17:53:47.935Z,1696269227.935 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2023-10-02T17:53:47.936Z,1696269227.936 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2023-10-02T17:53:48.105Z,1696269228.105 [CTD_Seabird] Loaded 2023-10-02T17:53:48.106Z,1696269228.106 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread. 2023-10-02T17:53:48.107Z,1696269228.107 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40B9B4E0 2023-10-02T17:53:48.107Z,1696269228.107 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 9740 2023-10-02T17:53:48.140Z,1696269228.140 [ESPComponent] Loaded 2023-10-02T17:53:48.140Z,1696269228.140 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread. 2023-10-02T17:53:48.160Z,1696269228.160 [PAR_Licor] Loaded 2023-10-02T17:53:48.160Z,1696269228.160 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread. 2023-10-02T17:53:48.199Z,1696269228.199 [WetLabsBB2FL] Loaded 2023-10-02T17:53:48.200Z,1696269228.200 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread. 2023-10-02T17:53:48.201Z,1696269228.201 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40BCB4E0 2023-10-02T17:53:48.201Z,1696269228.201 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 9741 2023-10-02T17:53:48.202Z,1696269228.202 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2023-10-02T17:53:48.216Z,1696269228.216 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2023-10-02T17:53:48.224Z,1696269228.224 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2023-10-02T17:53:48.237Z,1696269228.237 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2023-10-02T17:53:48.238Z,1696269228.238 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40BFB4E0 2023-10-02T17:53:48.238Z,1696269228.238 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 9742 2023-10-02T17:53:48.243Z,1696269228.243 [Supervisor](INFO): Main Thread ID is 9647 2023-10-02T17:53:48.243Z,1696269228.243 [Supervisor](DEBUG): Running supervisor. 2023-10-02T17:53:48.244Z,1696269228.244 [CommandExec ThreadHandler](INFO): Handler Thread ID is 9743 2023-10-02T17:53:48.244Z,1696269228.244 [CommandExec](INFO): Initializing the command executive. 2023-10-02T17:53:48.246Z,1696269228.246 [CommandLine ThreadHandler](INFO): Handler Thread ID is 9744 2023-10-02T17:53:48.248Z,1696269228.248 [controlThread ThreadHandler](INFO): Handler Thread ID is 9745 2023-10-02T17:53:48.248Z,1696269228.248 [controlThread](DEBUG): Initializing ControlThread 2023-10-02T17:53:48.249Z,1696269228.249 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2023-10-02T17:53:48.251Z,1696269228.251 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2023-10-02T17:53:48.252Z,1696269228.252 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2023-10-02T17:53:48.252Z,1696269228.252 [LoopControl](DEBUG): Initialize LoopControlComponent. 2023-10-02T17:53:48.256Z,1696269228.256 [SBIT](INFO): Initialize SBIT Component. 2023-10-02T17:53:48.257Z,1696269228.257 [SBIT](IMPORTANT): git: 2023-09-18-3-g7ee55e0de 2023-10-02T17:53:48.257Z,1696269228.257 [SBIT](INFO): git hash: 7ee55e0ded82548f5c252ba0d9a41930617440e4 2023-10-02T17:53:48.257Z,1696269228.257 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2023-10-02T17:53:48.258Z,1696269228.258 [SBIT](INFO): Kernel Reporting Different Version From Configuration. Kernel Expected: #639 PREEMPT Wed Mar 12 12:53:33 PDT 2014 Kernel Reported: #1 PREEMPT Wed Mar 17 08:23:48 PDT 2021 2023-10-02T17:53:48.259Z,1696269228.259 [SBIT](INFO): Beginning SBIT in 60.000000 seconds. 2023-10-02T17:53:48.260Z,1696269228.260 [IBIT](INFO): Initialize IBIT Component. 2023-10-02T17:53:48.261Z,1696269228.261 [CBIT](DEBUG): Initialize CBIT Component. 2023-10-02T17:53:48.262Z,1696269228.262 [logger ThreadHandler](INFO): Handler Thread ID is 9746 2023-10-02T17:53:48.274Z,1696269228.274 [CBIT](DEBUG): Initialized mux pins. 2023-10-02T17:53:48.274Z,1696269228.274 [CBIT](DEBUG): Initializing the watchdog timer. 2023-10-02T17:53:48.279Z,1696269228.279 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 9747 2023-10-02T17:53:48.287Z,1696269228.287 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 9748 2023-10-02T17:53:48.288Z,1696269228.288 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2023-10-02T17:53:48.295Z,1696269228.295 [Onboard ThreadHandler](INFO): Handler Thread ID is 9749 2023-10-02T17:53:48.299Z,1696269228.299 [CBIT](INFO): Last reboot was NOT due to watchdog timer. 2023-10-02T17:53:48.299Z,1696269228.299 [CBIT](DEBUG): Initializing heartbeat. 2023-10-02T17:53:48.315Z,1696269228.315 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 9750 2023-10-02T17:53:48.331Z,1696269228.331 [DAT ThreadHandler](INFO): Handler Thread ID is 9751 2023-10-02T17:53:48.331Z,1696269228.331 [DAT](INFO): Powering up 2023-10-02T17:53:48.332Z,1696269228.332 [DAT](DEBUG): Initializing DAT. 2023-10-02T17:53:48.336Z,1696269228.336 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 9753 2023-10-02T17:53:48.336Z,1696269228.336 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2023-10-02T17:53:48.340Z,1696269228.340 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 9755 2023-10-02T17:53:48.343Z,1696269228.343 [WetLabsBB2FL](INFO): Powering up 2023-10-02T17:53:48.344Z,1696269228.344 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 9757 2023-10-02T17:53:48.347Z,1696269228.347 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2HA05M.000 2023-10-02T17:53:48.348Z,1696269228.348 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2HA05M.000 2023-10-02T17:53:48.348Z,1696269228.348 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3HA20M.000 2023-10-02T17:53:48.348Z,1696269228.348 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3HA20M.000 2023-10-02T17:53:48.348Z,1696269228.348 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4HA51M.000 2023-10-02T17:53:48.348Z,1696269228.348 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4HA51M.000 2023-10-02T17:53:48.348Z,1696269228.348 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4HA51M.000 2023-10-02T17:53:48.349Z,1696269228.349 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4HA51M.000 2023-10-02T17:53:48.349Z,1696269228.349 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5HA53M.000 2023-10-02T17:53:48.349Z,1696269228.349 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5HA53M.000 2023-10-02T17:53:48.349Z,1696269228.349 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5HA55M.000 2023-10-02T17:53:48.349Z,1696269228.349 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5HA55M.000 2023-10-02T17:53:48.370Z,1696269228.370 [CBIT](DEBUG): Deactivating GF circuits. 2023-10-02T17:53:48.370Z,1696269228.370 [CBIT](DEBUG): Deactivating emergency mode. 2023-10-02T17:53:48.410Z,1696269228.410 [CBIT](DEBUG): Backplane powered. 2023-10-02T17:53:48.411Z,1696269228.411 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2023-10-02T17:53:48.411Z,1696269228.411 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2023-10-02T17:53:48.411Z,1696269228.411 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2023-10-02T17:53:48.412Z,1696269228.412 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2023-10-02T17:53:48.412Z,1696269228.412 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator. 2023-10-02T17:53:48.413Z,1696269228.413 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2023-10-02T17:53:48.414Z,1696269228.414 [NavChart](DEBUG): Initialize NavChart Navigation. 2023-10-02T17:53:48.414Z,1696269228.414 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2023-10-02T17:53:48.419Z,1696269228.419 [MissionManager](INFO): Loading Mission from file: Missions/Startup.xml 2023-10-02T17:53:48.441Z,1696269228.441 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2023-10-02T17:53:48.483Z,1696269228.483 [MissionManager](DEBUG): 2023-10-02T17:53:48.483Z,1696269228.483 [MissionManager](INFO): Loading Mission from file: Missions/Default.xml 2023-10-02T17:53:48.537Z,1696269228.537 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min 2023-10-02T17:53:48.538Z,1696269228.538 [Default:A.Wait](DEBUG): Construct Wait. 2023-10-02T17:53:48.540Z,1696269228.540 [Default:B.GoToSurface](DEBUG): Construct GoToSurface. 2023-10-02T17:53:48.568Z,1696269228.568 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2023-10-02T17:53:48.571Z,1696269228.571 [Default:CheckIn:C.Wait](DEBUG): Construct Wait. 2023-10-02T17:53:48.591Z,1696269228.591 [Default:E.Execute](DEBUG): Construct Execute. 2023-10-02T17:53:48.594Z,1696269228.594 [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 2023-10-02T17:53:48.607Z,1696269228.607 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,DropWeight,NAL9602,Power24vConverter,ESPComponent,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,DeadReckonUsingSpeedCalculator,DeadReckonWithRespectToSeafloor,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter, 2023-10-02T17:53:48.622Z,1696269228.622 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2023-10-02T17:53:48.677Z,1696269228.677 [Depth_Keller](ERROR): Pressure or depth reading out of range: -1.140412 decibar, -1.132002 m 2023-10-02T17:53:48.678Z,1696269228.678 [Power24vConverter](INFO): Powering up. 2023-10-02T17:53:48.689Z,1696269228.689 [DepthRateCalculator](ERROR): Depth measurement is not active 2023-10-02T17:53:48.721Z,1696269228.721 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2023-10-02T17:53:48.722Z,1696269228.722 [Radio_Surface](INFO): Powering up 2023-10-02T17:53:48.727Z,1696269228.727 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2023-10-02T17:53:48.728Z,1696269228.728 [ElevatorServo](DEBUG): Initializing EZServoServo. 2023-10-02T17:53:48.735Z,1696269228.735 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2023-10-02T17:53:48.736Z,1696269228.736 [MassServo](DEBUG): Initializing EZServoServo. 2023-10-02T17:53:48.743Z,1696269228.743 [MassServo](DEBUG): Initializing MassServo. 2023-10-02T17:53:48.743Z,1696269228.743 [RudderServo](DEBUG): Initializing EZServoServo. 2023-10-02T17:53:48.751Z,1696269228.751 [RudderServo](DEBUG): Initializing RudderServo. 2023-10-02T17:53:48.751Z,1696269228.751 [ThrusterHE](DEBUG): Initializing EZServoServo. 2023-10-02T17:53:48.759Z,1696269228.759 [ThrusterHE](DEBUG): Initializing ThrusterHE. 2023-10-02T17:53:49.049Z,1696269229.049 [DropWeight](CRITICAL): DROP WEIGHT MISSING. 2023-10-02T17:53:49.049Z,1696269229.049 [DropWeight] Hardware Fault, FailCount= 1 2023-10-02T17:53:49.049Z,1696269229.049 [DropWeight](ERROR): Hardware Fault 2023-10-02T17:53:49.077Z,1696269229.077 [CommandExec](FAULT): Scheduling is paused 2023-10-02T17:53:49.077Z,1696269229.077 [CBIT](INFO): Critical error at 20231002T175349 2023-10-02T17:53:49.078Z,1696269229.078 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals 2023-10-02T17:53:49.084Z,1696269229.084 [CBIT](ERROR): Hardware Fault in component: DropWeight 2023-10-02T17:53:49.085Z,1696269229.085 [CBIT](CRITICAL): Hardware Fault in component: DropWeight 2023-10-02T17:53:49.460Z,1696269229.460 [CBIT](INFO): Critical error at 20231002T175349 2023-10-02T17:53:50.450Z,1696269230.450 [WetLabsBB2FL](INFO): Powering down 2023-10-02T17:53:54.547Z,1696269234.547 [ThrusterHE](ERROR): Zero Speed Commanded. 2023-10-02T17:53:55.367Z,1696269235.367 [CTD_Seabird](ERROR): Device message queue exceeded the allowed limit. 2023-10-02T17:53:58.159Z,1696269238.159 [DAT](INFO): DAT read: 2023-10-02T17:53:58.161Z,1696269238.161 [DAT](INFO): DAT read: Teledyne Benthos DAT-900 Series 2023-10-02T17:53:58.813Z,1696269238.813 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004788 2023-10-02T17:53:59.170Z,1696269239.170 [DAT](INFO): DAT read: MF Frequency Band 2023-10-02T17:53:59.174Z,1696269239.174 [DAT](INFO): DAT read: Directional Acoustic Transponder version 8.10.9 2023-10-02T17:53:59.175Z,1696269239.175 [DAT](INFO): DAT read: Oct 2 2023 17:48:03 2023-10-02T17:54:00.175Z,1696269240.175 [DAT](INFO): DAT read: Features enabled [Bearing] 2023-10-02T17:54:00.177Z,1696269240.177 [DAT](INFO): DAT read: CONNECT 00800 bits/sec 1 of 4, Rate 1/2 CC 12.50ms MGP 2023-10-02T17:54:00.177Z,1696269240.177 [DAT](INFO): commRate: 800 2023-10-02T17:54:02.242Z,1696269242.242 [DAT](INFO): entering command mode 2023-10-02T17:54:02.443Z,1696269242.443 [DAT](INFO): DAT read: 2023-10-02T17:54:02.443Z,1696269242.443 [DAT](INFO): DAT read: user:1> 2023-10-02T17:54:02.444Z,1696269242.444 [DAT](INFO): setting verbose to 3 2023-10-02T17:54:02.695Z,1696269242.695 [DAT](INFO): DAT read: user:1> 2023-10-02T17:54:02.696Z,1696269242.696 [DAT](INFO): DAT read: Verbose | 3 2023-10-02T17:54:02.696Z,1696269242.696 [DAT](INFO): set verbose to 3 2023-10-02T17:54:02.697Z,1696269242.697 [DAT](INFO): setting DatVerbose to 27440 2023-10-02T17:54:02.947Z,1696269242.947 [DAT](INFO): DAT read: user:2> 2023-10-02T17:54:02.948Z,1696269242.948 [DAT](INFO): DAT read: DatVerbose | 27440 2023-10-02T17:54:02.949Z,1696269242.949 [DAT](INFO): set DatVerbose to 27440 2023-10-02T17:54:02.949Z,1696269242.949 [DAT](INFO): setting transmit power to 8 2023-10-02T17:54:03.199Z,1696269243.199 [DAT](INFO): DAT read: user:3> 2023-10-02T17:54:03.200Z,1696269243.200 [DAT](INFO): DAT read: TxPower | 8 (Max) 2023-10-02T17:54:03.200Z,1696269243.200 [DAT](INFO): set transmit power to 8 2023-10-02T17:54:03.201Z,1696269243.201 [DAT](INFO): setting local address to 1 2023-10-02T17:54:03.451Z,1696269243.451 [DAT](INFO): DAT read: user:4> 2023-10-02T17:54:03.452Z,1696269243.452 [DAT](INFO): DAT read: LocalAddr | 1 2023-10-02T17:54:03.452Z,1696269243.452 [DAT](INFO): set local address to 1 2023-10-02T17:54:03.453Z,1696269243.453 [DAT](INFO): Setting time to: 17:54:3 And date to:10/2/2023 2023-10-02T17:54:03.703Z,1696269243.703 [DAT](INFO): DAT read: user:5> 2023-10-02T17:54:03.704Z,1696269243.704 [DAT](INFO): DAT read: Mon Oct 2, 2023 17:54:03 2023-10-02T17:54:03.704Z,1696269243.704 [DAT](INFO): Local DAT time set to Mon Oct 2, 2023 17:54:03 2023-10-02T17:54:03.705Z,1696269243.705 [DAT](INFO): DAT read: Ok 2023-10-02T17:54:03.705Z,1696269243.705 [DAT](INFO): unknown deviceResponse_: Ok 2023-10-02T17:54:16.900Z,1696269256.900 [NAL9602](INFO): Powering up NAL9602 2023-10-02T17:54:27.812Z,1696269267.812 [NAL9602](INFO): NAL9602 initialized 2023-10-02T17:54:48.831Z,1696269288.831 [SBIT](IMPORTANT): Beginning Startup BIT 2023-10-02T17:54:48.835Z,1696269288.835 [CBIT](IMPORTANT): Beginning ground fault scan 2023-10-02T17:54:59.979Z,1696269299.979 [CBIT](IMPORTANT): No ground fault detected mA: CHAN A0 (Batt): 0.021468 CHAN A1 (24V): -0.000176 CHAN A2 (12V): -0.000102 CHAN A3 (5V): -0.001512 CHAN B0 (3.3V): -0.000319 CHAN B1 (3.15aV): -0.000137 CHAN B2 (3.15bV): -0.000455 CHAN B3 (GND): -0.000129 OPEN: 0.006721 Full Scale: +/- 1 mA 2023-10-02T17:55:42.573Z,1696269342.573 [SBIT](IMPORTANT): SBIT PASSED 2023-10-02T17:55:42.573Z,1696269342.573 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg 2023-10-02T17:55:42.574Z,1696269342.574 [SBIT](IMPORTANT): BackseatComponent.loadAtStartup=1 bool; 2023-10-02T17:55:42.574Z,1696269342.574 [SBIT](IMPORTANT): BackseatComponent.needs24v=1 bool; 2023-10-02T17:55:42.575Z,1696269342.575 [SBIT](IMPORTANT): CBIT.gf24Offset=158.5 microampere; 2023-10-02T17:55:42.575Z,1696269342.575 [SBIT](IMPORTANT): PowerOnly.sampleTime1=1 second; 2023-10-02T17:55:42.575Z,1696269342.575 [SBIT](IMPORTANT): Rowe_600.loadAtStartup=0 bool; 2023-10-02T17:55:42.575Z,1696269342.575 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=159.679458 cubic_centimeter; 2023-10-02T17:55:42.575Z,1696269342.575 [SBIT](IMPORTANT): VerticalControl.massDefault=10.000082 millimeter; 2023-10-02T17:55:42.575Z,1696269342.575 [SBIT](IMPORTANT): Waterlinked.loadAtStartup=0 bool; 2023-10-02T17:55:42.984Z,1696269342.984 [MissionManager](IMPORTANT): Started mission Startup 2023-10-02T17:55:42.985Z,1696269342.985 [Startup] Running Loop=1 2023-10-02T17:55:42.986Z,1696269342.986 [Startup](DEBUG): Aggregate::initialize Startup 2023-10-02T17:55:42.986Z,1696269342.986 [Startup:A.GoToSurface] Running Loop=1 2023-10-02T17:55:42.987Z,1696269342.987 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2023-10-02T17:55:42.989Z,1696269342.989 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2023-10-02T17:55:42.991Z,1696269342.991 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2023-10-02T17:55:42.991Z,1696269342.991 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2023-10-02T17:55:42.991Z,1696269342.991 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2023-10-02T17:55:42.992Z,1696269342.992 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2023-10-02T17:55:42.994Z,1696269342.994 [Startup:StartupSatComms] Running Loop=1 2023-10-02T17:55:42.994Z,1696269342.994 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms 2023-10-02T17:55:42.994Z,1696269342.994 [Startup:StartupSatComms:A] Running Loop=1 2023-10-02T17:55:43.373Z,1696269343.373 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix 2023-10-02T17:56:43.182Z,1696269403.182 [Startup:StartupSatComms:A](INFO): Timed out from 2023-10-02T17:55:42.0Z 2023-10-02T17:56:43.182Z,1696269403.182 [Startup:StartupSatComms:A] Stopped 2023-10-02T17:56:43.183Z,1696269403.183 [Startup:StartupSatComms:B] Running Loop=1 2023-10-02T17:56:43.627Z,1696269403.627 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications 2023-10-02T17:56:48.427Z,1696269408.427 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1 2023-10-02T17:56:48.427Z,1696269408.427 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-10-02T17:56:48.428Z,1696269408.428 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 1 2023-10-02T17:56:48.428Z,1696269408.428 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2023-10-02T17:56:48.429Z,1696269408.429 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1 2023-10-02T17:56:48.429Z,1696269408.429 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2023-10-02T17:56:48.511Z,1696269408.511 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-10-02T17:56:48.511Z,1696269408.511 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2023-10-02T17:56:48.512Z,1696269408.512 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2023-10-02T17:56:48.830Z,1696269408.830 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-10-02T17:56:48.830Z,1696269408.830 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1 2023-10-02T17:56:48.860Z,1696269408.860 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2023-10-02T17:56:48.860Z,1696269408.860 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 1 2023-10-02T17:56:48.861Z,1696269408.861 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2023-10-02T17:56:48.861Z,1696269408.861 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1 2023-10-02T17:56:49.226Z,1696269409.226 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2023-10-02T17:56:50.558Z,1696269410.558 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20231002T174118/Courier0004.lzma 2023-10-02T17:56:51.560Z,1696269411.560 [DataOverHttps](INFO): Moved sent file to Logs/20231002T174118/Courier0004.lzma.bak 2023-10-02T17:56:51.560Z,1696269411.560 [DataOverHttps](INFO): SBD MOMSN=18974403 2023-10-02T17:57:07.119Z,1696269427.119 [DataOverHttps](INFO): Sending 243 bytes from file Logs/20231002T175339/Courier0000.lzma 2023-10-02T17:57:08.120Z,1696269428.120 [DataOverHttps](INFO): Moved sent file to Logs/20231002T175339/Courier0000.lzma.bak 2023-10-02T17:57:08.120Z,1696269428.120 [DataOverHttps](INFO): SBD MOMSN=18974405 2023-10-02T17:57:23.628Z,1696269443.628 [DataOverHttps](INFO): Sending 261 bytes from file Logs/20231002T174118/Express0005.lzma 2023-10-02T17:57:24.628Z,1696269444.628 [DataOverHttps](INFO): Moved sent file to Logs/20231002T174118/Express0005.lzma.bak 2023-10-02T17:57:24.628Z,1696269444.628 [DataOverHttps](INFO): SBD MOMSN=18974410 2023-10-02T17:57:25.619Z,1696269445.619 [CommandExec](IMPORTANT): got command gfscan 2023-10-02T17:57:26.028Z,1696269446.028 [CBIT](IMPORTANT): Beginning ground fault scan 2023-10-02T17:57:36.951Z,1696269456.951 [CBIT](IMPORTANT): No ground fault detected mA: CHAN A0 (Batt): 0.025076 CHAN A1 (24V): 0.000076 CHAN A2 (12V): 0.000128 CHAN A3 (5V): -0.001445 CHAN B0 (3.3V): -0.000039 CHAN B1 (3.15aV): -0.000037 CHAN B2 (3.15bV): -0.000378 CHAN B3 (GND): -0.000238 OPEN: 0.006525 Full Scale: +/- 1 mA 2023-10-02T17:57:40.507Z,1696269460.507 [DataOverHttps](INFO): Sending 813 bytes from file Logs/20231002T175339/Express0001.lzma 2023-10-02T17:57:41.500Z,1696269461.500 [DataOverHttps](INFO): Moved sent file to Logs/20231002T175339/Express0001.lzma.bak 2023-10-02T17:57:41.500Z,1696269461.500 [DataOverHttps](INFO): SBD MOMSN=18974418 2023-10-02T17:57:43.354Z,1696269463.354 [Startup:StartupSatComms:B](INFO): Timed out from 2023-10-02T17:56:43.2Z 2023-10-02T17:57:43.354Z,1696269463.354 [Startup:StartupSatComms:B] Stopped 2023-10-02T17:57:43.355Z,1696269463.355 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms 2023-10-02T17:57:43.355Z,1696269463.355 [Startup:StartupSatComms] Stopped 2023-10-02T17:57:43.355Z,1696269463.355 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms 2023-10-02T17:57:43.356Z,1696269463.356 [Startup](INFO): Completed Startup 2023-10-02T17:57:43.356Z,1696269463.356 [MissionManager](INFO): Startup is completed. 2023-10-02T17:57:43.356Z,1696269463.356 [MissionManager](INFO): Uninitializing Mission Startup 2023-10-02T17:57:43.356Z,1696269463.356 [Startup] Stopped 2023-10-02T17:57:43.356Z,1696269463.356 [Startup](DEBUG): Aggregate::uninitialize Startup 2023-10-02T17:57:43.356Z,1696269463.356 [Startup:A.GoToSurface] Stopped 2023-10-02T17:57:43.356Z,1696269463.356 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2023-10-02T17:57:43.763Z,1696269463.763 [MissionManager](IMPORTANT): Started mission Default 2023-10-02T17:57:43.763Z,1696269463.763 [Default] Running Loop=1 2023-10-02T17:57:43.764Z,1696269463.764 [Default](DEBUG): Aggregate::initialize Default 2023-10-02T17:57:43.764Z,1696269463.764 [Default:B.GoToSurface] Running Loop=1 2023-10-02T17:57:43.764Z,1696269463.764 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2023-10-02T17:57:43.764Z,1696269463.764 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2023-10-02T17:57:43.764Z,1696269463.764 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2023-10-02T17:57:43.764Z,1696269463.764 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2023-10-02T17:57:43.765Z,1696269463.765 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2023-10-02T17:57:43.765Z,1696269463.765 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2023-10-02T17:57:43.765Z,1696269463.765 [Default:A.Wait] Running Loop=1 2023-10-02T17:57:43.765Z,1696269463.765 [Default:A.Wait](DEBUG): Initialize Wait Component. 2023-10-02T17:57:57.097Z,1696269477.097 [Default:A.Wait](INFO): Done Waiting. 2023-10-02T17:57:57.097Z,1696269477.097 [Default:A.Wait] Stopped 2023-10-02T17:57:57.097Z,1696269477.097 [Default:A.Wait](DEBUG): Uninitialize Wait Component. 2023-10-02T17:57:57.509Z,1696269477.509 [Default:CheckIn] Running Loop=1 2023-10-02T17:57:57.509Z,1696269477.509 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2023-10-02T17:57:57.510Z,1696269477.510 [Default:CheckIn:Read_GPS] Running Loop=1 2023-10-02T17:57:57.902Z,1696269477.902 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix 2023-10-02T17:58:42.333Z,1696269522.333 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2023-10-02T17:58:48.794Z,1696269528.794 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2023-10-02T17:59:11.408Z,1696269551.408 [CommandExec](IMPORTANT): got command gfscan 2023-10-02T17:59:11.459Z,1696269551.459 [CBIT](IMPORTANT): Beginning ground fault scan 2023-10-02T17:59:22.343Z,1696269562.343 [CBIT](IMPORTANT): No ground fault detected mA: CHAN A0 (Batt): 0.027737 CHAN A1 (24V): 0.000350 CHAN A2 (12V): 0.000542 CHAN A3 (5V): -0.001213 CHAN B0 (3.3V): 0.000028 CHAN B1 (3.15aV): -0.000282 CHAN B2 (3.15bV): 0.000036 CHAN B3 (GND): -0.000257 OPEN: 0.006551 Full Scale: +/- 1 mA 2023-10-02T17:59:31.217Z,1696269571.217 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2023-10-02T17:59:49.414Z,1696269589.414 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2 2023-10-02T17:59:49.414Z,1696269589.414 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-10-02T17:59:49.416Z,1696269589.416 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 2 2023-10-02T17:59:49.416Z,1696269589.416 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2023-10-02T17:59:49.417Z,1696269589.417 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 2 2023-10-02T17:59:49.417Z,1696269589.417 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2023-10-02T17:59:49.480Z,1696269589.480 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-10-02T17:59:49.480Z,1696269589.480 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2023-10-02T17:59:49.480Z,1696269589.480 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2023-10-02T17:59:49.953Z,1696269589.953 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-10-02T17:59:49.953Z,1696269589.953 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2 2023-10-02T17:59:49.953Z,1696269589.953 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2023-10-02T17:59:49.954Z,1696269589.954 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 2 2023-10-02T17:59:49.958Z,1696269589.958 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2023-10-02T17:59:49.958Z,1696269589.958 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 2 2023-10-02T17:59:50.247Z,1696269590.247 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2023-10-02T18:00:12.379Z,1696269612.379 [CommandExec](IMPORTANT): got command failComponent 2023-10-02T18:00:12.379Z,1696269612.379 [CommandExec](IMPORTANT): Failed components: 2023-10-02T18:00:12.379Z,1696269612.379 [CommandExec](IMPORTANT): DropWeight: Hardware Fault 2023-10-02T18:00:20.631Z,1696269620.631 [CommandExec](IMPORTANT): got command quit 2023-10-02T18:00:21.634Z,1696269621.634 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread. 2023-10-02T18:00:21.635Z,1696269621.635 [CommandExec](INFO): Uninitializing the command executive. 2023-10-02T18:00:21.635Z,1696269621.635 [CommandExec](INFO): Uninitializing the command scheduler. 2023-10-02T18:00:21.635Z,1696269621.635 [CommandExec ThreadHandler](INFO): Thread cancelled. 2023-10-02T18:00:21.750Z,1696269621.750 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2023-10-02T18:00:21.750Z,1696269621.750 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2023-10-02T18:00:21.751Z,1696269621.751 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2023-10-02T18:00:21.751Z,1696269621.751 [NavChartDb](INFO): Join timeout helper Thread ID is 9769 2023-10-02T18:00:21.950Z,1696269621.950 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2023-10-02T18:00:21.951Z,1696269621.951 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2023-10-02T18:00:21.958Z,1696269621.958 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler 2023-10-02T18:00:21.959Z,1696269621.959 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2023-10-02T18:00:21.959Z,1696269621.959 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 9770 2023-10-02T18:00:22.195Z,1696269622.195 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread. 2023-10-02T18:00:22.195Z,1696269622.195 [WetLabsBB2FL](INFO): Powering down 2023-10-02T18:00:22.196Z,1696269622.196 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2023-10-02T18:00:22.206Z,1696269622.206 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler 2023-10-02T18:00:22.207Z,1696269622.207 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2023-10-02T18:00:22.207Z,1696269622.207 [CTD_Seabird](INFO): Join timeout helper Thread ID is 9771 2023-10-02T18:00:22.959Z,1696269622.959 [CTD_Seabird](INFO): Powering down 2023-10-02T18:00:22.970Z,1696269622.970 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread. 2023-10-02T18:00:22.971Z,1696269622.971 [CTD_Seabird](INFO): Powering down 2023-10-02T18:00:22.999Z,1696269622.999 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2023-10-02T18:00:23.002Z,1696269623.002 [ComponentRegistry](INFO): Shutting down DAT ThreadHandler 2023-10-02T18:00:23.002Z,1696269623.002 [DAT ThreadHandler](INFO): Thread cancelled. 2023-10-02T18:00:23.003Z,1696269623.003 [DAT](INFO): Join timeout helper Thread ID is 9772 2023-10-02T18:00:23.147Z,1696269623.147 [DAT](INFO): Powering down 2023-10-02T18:00:23.215Z,1696269623.215 [DAT ThreadHandler](INFO): Uninitializing protected caller thread. 2023-10-02T18:00:23.215Z,1696269623.215 [DAT](INFO): Powering down 2023-10-02T18:00:23.216Z,1696269623.216 [DAT ThreadHandler](INFO): Thread cancelled. 2023-10-02T18:00:23.218Z,1696269623.218 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2023-10-02T18:00:23.218Z,1696269623.218 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2023-10-02T18:00:23.219Z,1696269623.219 [Radio_Surface](INFO): Join timeout helper Thread ID is 9773 2023-10-02T18:00:23.451Z,1696269623.451 [Radio_Surface](INFO): Powering down 2023-10-02T18:00:23.458Z,1696269623.458 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2023-10-02T18:00:23.459Z,1696269623.459 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2023-10-02T18:00:23.467Z,1696269623.467 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler 2023-10-02T18:00:23.467Z,1696269623.467 [Onboard ThreadHandler](INFO): Thread cancelled. 2023-10-02T18:00:23.468Z,1696269623.468 [Onboard](INFO): Join timeout helper Thread ID is 9774 2023-10-02T18:00:23.647Z,1696269623.647 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread. 2023-10-02T18:00:23.647Z,1696269623.647 [Onboard ThreadHandler](INFO): Thread cancelled. 2023-10-02T18:00:23.651Z,1696269623.651 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler 2023-10-02T18:00:23.651Z,1696269623.651 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2023-10-02T18:00:23.651Z,1696269623.651 [DataOverHttps](INFO): Join timeout helper Thread ID is 9775 2023-10-02T18:00:23.954Z,1696269623.954 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread. 2023-10-02T18:00:23.955Z,1696269623.955 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2023-10-02T18:00:23.959Z,1696269623.959 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler 2023-10-02T18:00:23.959Z,1696269623.959 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2023-10-02T18:00:23.959Z,1696269623.959 [BackseatComponent](INFO): Join timeout helper Thread ID is 9776 2023-10-02T18:00:24.023Z,1696269624.023 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread. 2023-10-02T18:00:24.024Z,1696269624.024 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2023-10-02T18:00:24.039Z,1696269624.039 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2023-10-02T18:00:24.039Z,1696269624.039 [logger ThreadHandler](INFO): Thread cancelled. 2023-10-02T18:00:24.040Z,1696269624.040 [logger](INFO): Join timeout helper Thread ID is 9777 2023-10-02T18:00:24.074Z,1696269624.074 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2023-10-02T18:00:24.075Z,1696269624.075 [logger ThreadHandler](INFO): Thread cancelled. 2023-10-02T18:00:24.079Z,1696269624.079 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2023-10-02T18:00:24.079Z,1696269624.079 [CommandLine ThreadHandler](INFO): Thread cancelled. 2023-10-02T18:00:24.079Z,1696269624.079 [CommandLine](INFO): Join timeout helper Thread ID is 9778 2023-10-02T18:00:24.146Z,1696269624.146 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2023-10-02T18:00:24.147Z,1696269624.147 [CommandLine ThreadHandler](INFO): Thread cancelled. 2023-10-02T18:00:24.159Z,1696269624.159 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler 2023-10-02T18:00:24.159Z,1696269624.159 [CommandExec ThreadHandler](INFO): Thread cancelled. 2023-10-02T18:00:24.160Z,1696269624.160 [CommandExec](INFO): Join timeout helper Thread ID is 9779 2023-10-02T18:00:24.176Z,1696269624.176 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2023-10-02T18:00:24.176Z,1696269624.176 [controlThread ThreadHandler](INFO): Thread cancelled. 2023-10-02T18:00:24.176Z,1696269624.176 [controlThread](INFO): Join timeout helper Thread ID is 9780 2023-10-02T18:00:24.526Z,1696269624.526 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2023-10-02T18:00:24.527Z,1696269624.527 [controlThread](DEBUG): Uninitializing ControlThread 2023-10-02T18:00:24.527Z,1696269624.527 [AHRS_M2](INFO): Powering down 2023-10-02T18:00:24.600Z,1696269624.600 [NAL9602](INFO): Powering down 2023-10-02T18:00:24.603Z,1696269624.603 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator. 2023-10-02T18:00:24.603Z,1696269624.603 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator. 2023-10-02T18:00:24.604Z,1696269624.604 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2023-10-02T18:00:24.605Z,1696269624.605 [MissionManager](INFO): Uninitializing Mission Default 2023-10-02T18:00:24.605Z,1696269624.605 [Default] Stopped 2023-10-02T18:00:24.605Z,1696269624.605 [Default](DEBUG): Aggregate::uninitialize Default 2023-10-02T18:00:24.605Z,1696269624.605 [Default:B.GoToSurface] Stopped 2023-10-02T18:00:24.605Z,1696269624.605 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2023-10-02T18:00:24.605Z,1696269624.605 [Default:CheckIn] Stopped 2023-10-02T18:00:24.605Z,1696269624.605 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2023-10-02T18:00:24.605Z,1696269624.605 [Default:CheckIn:Read_GPS] Stopped 2023-10-02T18:00:24.608Z,1696269624.608 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2023-10-02T18:00:24.608Z,1696269624.608 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2023-10-02T18:00:24.609Z,1696269624.609 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2023-10-02T18:00:24.609Z,1696269624.609 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2023-10-02T18:00:24.609Z,1696269624.609 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2023-10-02T18:00:24.609Z,1696269624.609 [BuoyancyServo](INFO): Powering down 2023-10-02T18:00:24.622Z,1696269624.622 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2023-10-02T18:00:24.623Z,1696269624.623 [ElevatorServo](INFO): Powering down 2023-10-02T18:00:24.623Z,1696269624.623 [MassServo](DEBUG): Uninitialize Mass Servo. 2023-10-02T18:00:24.624Z,1696269624.624 [MassServo](INFO): Powering down 2023-10-02T18:00:24.624Z,1696269624.624 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2023-10-02T18:00:24.624Z,1696269624.624 [RudderServo](INFO): Powering down 2023-10-02T18:00:24.625Z,1696269624.625 [ThrusterHE](DEBUG): Uninitialize Thruster Servo. 2023-10-02T18:00:24.625Z,1696269624.625 [ThrusterHE](INFO): Powering down 2023-10-02T18:00:24.626Z,1696269624.626 [SBIT](DEBUG): Uninitialize SBIT Component. 2023-10-02T18:00:24.627Z,1696269624.627 [IBIT](DEBUG): Uninitialize IBIT Component. 2023-10-02T18:00:24.627Z,1696269624.627 [CBIT](DEBUG): Uninitialize CBIT Component. 2023-10-02T18:00:24.627Z,1696269624.627 [CBIT](DEBUG): Powering off loads. 2023-10-02T18:00:24.638Z,1696269624.638 [CBIT](DEBUG): Disabling WDT. 2023-10-02T18:00:24.650Z,1696269624.650 [CBIT](DEBUG): Opening all GF detection circuits. 2023-10-02T18:00:24.651Z,1696269624.651 [controlThread ThreadHandler](INFO): Thread cancelled. 2023-10-02T18:00:24.673Z,1696269624.673 [DAT ThreadHandler](INFO): Thread cancelled. 2023-10-02T18:00:24.679Z,1696269624.679 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2023-10-02T18:00:24.680Z,1696269624.680 [Onboard ThreadHandler](INFO): Thread cancelled. 2023-10-02T18:00:24.686Z,1696269624.686 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2023-10-02T18:00:24.729Z,1696269624.729 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2023-10-02T18:00:24.814Z,1696269624.814 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2023-10-02T18:00:24.820Z,1696269624.820 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2023-10-02T18:00:24.828Z,1696269624.828 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2023-10-02T18:00:24.874Z,1696269624.874 [logger ThreadHandler](INFO): Thread cancelled.