2023-12-20T02:34:48.324Z,1703039688.324 [Supervisor](DEBUG): Initializing supervisor. 2023-12-20T02:34:48.328Z,1703039688.328 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2023-12-20T02:34:48.329Z,1703039688.329 [SyncHandler](INFO): Protected caller Thread ID is 837 2023-12-20T02:34:48.329Z,1703039688.329 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2023-12-20T02:34:48.330Z,1703039688.330 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2023-12-20T02:34:48.331Z,1703039688.331 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 838 2023-12-20T02:34:48.335Z,1703039688.335 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2023-12-20T02:34:48.353Z,1703039688.353 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread. 2023-12-20T02:34:48.354Z,1703039688.354 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2023-12-20T02:34:48.355Z,1703039688.355 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 839 2023-12-20T02:34:48.359Z,1703039688.359 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2023-12-20T02:34:48.360Z,1703039688.360 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2023-12-20T02:34:48.360Z,1703039688.360 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 840 2023-12-20T02:34:48.374Z,1703039688.374 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2023-12-20T02:34:48.375Z,1703039688.375 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0 2023-12-20T02:34:48.376Z,1703039688.376 [logger ThreadHandler](INFO): Protected caller Thread ID is 841 2023-12-20T02:34:48.379Z,1703039688.379 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2023-12-20T02:34:48.380Z,1703039688.380 [Supervisor](INFO): Looking for Config files in directory: Config/ 2023-12-20T02:34:48.384Z,1703039688.384 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2023-12-20T02:34:48.602Z,1703039688.602 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2023-12-20T02:34:48.604Z,1703039688.604 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2023-12-20T02:34:48.713Z,1703039688.713 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2023-12-20T02:34:48.715Z,1703039688.715 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2023-12-20T02:34:48.811Z,1703039688.811 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2023-12-20T02:34:48.813Z,1703039688.813 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2023-12-20T02:34:49.307Z,1703039689.307 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2023-12-20T02:34:49.309Z,1703039689.309 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2023-12-20T02:34:49.669Z,1703039689.669 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2023-12-20T02:34:49.670Z,1703039689.670 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2023-12-20T02:34:50.019Z,1703039690.019 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2023-12-20T02:34:50.020Z,1703039690.020 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2023-12-20T02:34:50.219Z,1703039690.219 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2023-12-20T02:34:50.220Z,1703039690.220 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2023-12-20T02:34:50.301Z,1703039690.301 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2023-12-20T02:34:50.383Z,1703039690.383 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2023-12-20T02:34:50.806Z,1703039690.806 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2023-12-20T02:34:50.807Z,1703039690.807 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2023-12-20T02:34:51.098Z,1703039691.098 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2023-12-20T02:34:51.099Z,1703039691.099 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2023-12-20T02:34:51.656Z,1703039691.656 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2023-12-20T02:34:52.480Z,1703039692.480 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2023-12-20T02:34:52.812Z,1703039692.812 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2023-12-20T02:34:52.814Z,1703039692.814 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg 2023-12-20T02:34:53.068Z,1703039693.068 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock 2023-12-20T02:34:53.070Z,1703039693.070 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2023-12-20T02:34:53.212Z,1703039693.212 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2023-12-20T02:34:53.213Z,1703039693.213 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2023-12-20T02:34:54.070Z,1703039694.070 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2023-12-20T02:34:54.072Z,1703039694.072 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-galene/ 2023-12-20T02:34:54.075Z,1703039694.075 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/secure.cfg 2023-12-20T02:34:54.161Z,1703039694.161 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/vehicle.cfg 2023-12-20T02:34:54.296Z,1703039694.296 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Battery.cfg 2023-12-20T02:34:54.566Z,1703039694.566 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2023-12-20T02:34:54.567Z,1703039694.567 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Science.cfg 2023-12-20T02:34:54.696Z,1703039694.696 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Control.cfg 2023-12-20T02:34:54.799Z,1703039694.799 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/logger.cfg 2023-12-20T02:34:54.894Z,1703039694.894 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Servo.cfg 2023-12-20T02:34:55.005Z,1703039695.005 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Navigation.cfg 2023-12-20T02:34:55.102Z,1703039695.102 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Simulator.cfg 2023-12-20T02:34:55.190Z,1703039695.190 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/BIT.cfg 2023-12-20T02:34:55.293Z,1703039695.293 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Sensor.cfg 2023-12-20T02:34:55.467Z,1703039695.467 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-galene/root/ 2023-12-20T02:34:55.468Z,1703039695.468 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg 2023-12-20T02:34:55.493Z,1703039695.493 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2023-12-20T02:34:55.563Z,1703039695.563 [DepthRateCalculator] Loaded 2023-12-20T02:34:55.563Z,1703039695.563 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2023-12-20T02:34:55.569Z,1703039695.569 [PitchRateCalculator] Loaded 2023-12-20T02:34:55.569Z,1703039695.569 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2023-12-20T02:34:55.579Z,1703039695.579 [SpeedCalculator] Loaded 2023-12-20T02:34:55.580Z,1703039695.580 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2023-12-20T02:34:55.585Z,1703039695.585 [YawRateCalculator] Loaded 2023-12-20T02:34:55.585Z,1703039695.585 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2023-12-20T02:34:55.607Z,1703039695.607 [ElevatorOffsetCalculator] Loaded 2023-12-20T02:34:55.607Z,1703039695.607 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread. 2023-12-20T02:34:55.607Z,1703039695.607 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2023-12-20T02:34:55.608Z,1703039695.608 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2023-12-20T02:34:55.651Z,1703039695.651 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2023-12-20T02:34:55.651Z,1703039695.651 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2023-12-20T02:34:55.667Z,1703039695.667 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2023-12-20T02:34:55.668Z,1703039695.668 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2023-12-20T02:34:56.444Z,1703039696.444 [AHRS_M2] Loaded 2023-12-20T02:34:56.445Z,1703039696.445 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread. 2023-12-20T02:34:56.803Z,1703039696.803 [BackseatComponent] Loaded 2023-12-20T02:34:56.804Z,1703039696.804 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread. 2023-12-20T02:34:56.812Z,1703039696.812 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 4084F4E0 2023-12-20T02:34:56.812Z,1703039696.812 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 924 2023-12-20T02:34:56.867Z,1703039696.867 [LcmUniversalReporter] Loaded 2023-12-20T02:34:56.867Z,1703039696.867 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread. 2023-12-20T02:34:58.069Z,1703039698.069 [BPC1] Loaded 2023-12-20T02:34:58.069Z,1703039698.069 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2023-12-20T02:34:58.216Z,1703039698.216 [DataOverHttps] Loaded 2023-12-20T02:34:58.216Z,1703039698.216 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread. 2023-12-20T02:34:58.217Z,1703039698.217 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 4087F4E0 2023-12-20T02:34:58.218Z,1703039698.218 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 925 2023-12-20T02:34:58.238Z,1703039698.238 [Depth_Keller] Loaded 2023-12-20T02:34:58.238Z,1703039698.238 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2023-12-20T02:34:58.243Z,1703039698.243 [DropWeight] Loaded 2023-12-20T02:34:58.243Z,1703039698.243 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread. 2023-12-20T02:34:58.305Z,1703039698.305 [NAL9602] Loaded 2023-12-20T02:34:58.305Z,1703039698.305 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2023-12-20T02:34:58.335Z,1703039698.335 [Onboard] Loaded 2023-12-20T02:34:58.335Z,1703039698.335 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread. 2023-12-20T02:34:58.336Z,1703039698.336 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 408AF4E0 2023-12-20T02:34:58.337Z,1703039698.337 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 926 2023-12-20T02:34:58.348Z,1703039698.348 [Power24vConverter] Loaded 2023-12-20T02:34:58.349Z,1703039698.349 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread. 2023-12-20T02:34:58.363Z,1703039698.363 [Radio_Surface] Loaded 2023-12-20T02:34:58.364Z,1703039698.364 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2023-12-20T02:34:58.365Z,1703039698.365 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 408DF4E0 2023-12-20T02:34:58.365Z,1703039698.365 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 927 2023-12-20T02:34:58.455Z,1703039698.455 [DAT] Loaded 2023-12-20T02:34:58.455Z,1703039698.455 [ComponentRegistry](DEBUG): Component "DAT" handled in its own thread. 2023-12-20T02:34:58.456Z,1703039698.456 [DAT ThreadHandler](DEBUG): Created PCaller Thread at 4090F4E0 2023-12-20T02:34:58.456Z,1703039698.456 [DAT ThreadHandler](INFO): Protected caller Thread ID is 928 2023-12-20T02:34:58.457Z,1703039698.457 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2023-12-20T02:34:58.458Z,1703039698.458 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2023-12-20T02:34:58.595Z,1703039698.595 [DeadReckonUsingMultipleVelocitySources] Loaded 2023-12-20T02:34:58.595Z,1703039698.595 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2023-12-20T02:34:58.636Z,1703039698.636 [DeadReckonUsingSpeedCalculator] Loaded 2023-12-20T02:34:58.637Z,1703039698.637 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread. 2023-12-20T02:34:58.651Z,1703039698.651 [NavChart] Loaded 2023-12-20T02:34:58.651Z,1703039698.651 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2023-12-20T02:34:58.657Z,1703039698.657 [UniversalFixResidualReporter] Loaded 2023-12-20T02:34:58.658Z,1703039698.658 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2023-12-20T02:34:58.658Z,1703039698.658 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2023-12-20T02:34:58.659Z,1703039698.659 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2023-12-20T02:34:58.827Z,1703039698.827 [SBIT](DEBUG): Construct Startup Built In Test. 2023-12-20T02:34:58.841Z,1703039698.841 [SBIT] Loaded 2023-12-20T02:34:58.842Z,1703039698.842 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2023-12-20T02:34:58.845Z,1703039698.845 [IBIT](DEBUG): Construct Initiated Built In Test. 2023-12-20T02:34:58.858Z,1703039698.858 [IBIT] Loaded 2023-12-20T02:34:58.858Z,1703039698.858 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2023-12-20T02:34:58.864Z,1703039698.864 [CBIT](DEBUG): Construct Continuous Built In Test. 2023-12-20T02:34:59.016Z,1703039699.016 [CBIT] Loaded 2023-12-20T02:34:59.016Z,1703039699.016 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2023-12-20T02:34:59.016Z,1703039699.016 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2023-12-20T02:34:59.017Z,1703039699.017 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2023-12-20T02:34:59.237Z,1703039699.237 [CTD_Seabird] Loaded 2023-12-20T02:34:59.238Z,1703039699.238 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread. 2023-12-20T02:34:59.239Z,1703039699.239 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40A164E0 2023-12-20T02:34:59.239Z,1703039699.239 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 930 2023-12-20T02:34:59.260Z,1703039699.260 [PAR_Licor] Loaded 2023-12-20T02:34:59.260Z,1703039699.260 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread. 2023-12-20T02:34:59.301Z,1703039699.301 [WetLabsBB2FL] Loaded 2023-12-20T02:34:59.301Z,1703039699.301 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread. 2023-12-20T02:34:59.302Z,1703039699.302 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40A464E0 2023-12-20T02:34:59.302Z,1703039699.302 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 931 2023-12-20T02:34:59.303Z,1703039699.303 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2023-12-20T02:34:59.304Z,1703039699.304 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2023-12-20T02:34:59.465Z,1703039699.465 [BuoyancyServo] Loaded 2023-12-20T02:34:59.465Z,1703039699.465 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2023-12-20T02:34:59.487Z,1703039699.487 [ElevatorServo] Loaded 2023-12-20T02:34:59.487Z,1703039699.487 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2023-12-20T02:34:59.508Z,1703039699.508 [MassServo] Loaded 2023-12-20T02:34:59.508Z,1703039699.508 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2023-12-20T02:34:59.529Z,1703039699.529 [RudderServo] Loaded 2023-12-20T02:34:59.529Z,1703039699.529 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2023-12-20T02:34:59.545Z,1703039699.545 [ThrusterHE] Loaded 2023-12-20T02:34:59.545Z,1703039699.545 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread. 2023-12-20T02:34:59.546Z,1703039699.546 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2023-12-20T02:34:59.546Z,1703039699.546 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2023-12-20T02:34:59.613Z,1703039699.613 [VerticalControl](DEBUG): Construct VerticalControl. 2023-12-20T02:34:59.665Z,1703039699.665 [VerticalControl] Loaded 2023-12-20T02:34:59.665Z,1703039699.665 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2023-12-20T02:34:59.668Z,1703039699.668 [HorizontalControl](DEBUG): Construct HorizontalControl. 2023-12-20T02:34:59.706Z,1703039699.706 [HorizontalControl] Loaded 2023-12-20T02:34:59.707Z,1703039699.707 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2023-12-20T02:34:59.709Z,1703039699.709 [SpeedControl](DEBUG): Construct SpeedControl. 2023-12-20T02:34:59.711Z,1703039699.711 [SpeedControl] Loaded 2023-12-20T02:34:59.711Z,1703039699.711 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2023-12-20T02:34:59.714Z,1703039699.714 [LoopControl](DEBUG): Construct LoopControl. 2023-12-20T02:34:59.715Z,1703039699.715 [LoopControl] Loaded 2023-12-20T02:34:59.715Z,1703039699.715 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2023-12-20T02:34:59.715Z,1703039699.715 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2023-12-20T02:34:59.716Z,1703039699.716 [Module Loader](DEBUG): Loading Module at Modules/Dock.so 2023-12-20T02:34:59.857Z,1703039699.857 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking) 2023-12-20T02:34:59.857Z,1703039699.857 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2023-12-20T02:35:00.038Z,1703039700.038 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2023-12-20T02:35:00.039Z,1703039700.039 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2023-12-20T02:35:00.443Z,1703039700.443 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2023-12-20T02:35:00.444Z,1703039700.444 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2023-12-20T02:35:00.544Z,1703039700.544 [StratificationFrontDetector](INFO): thresholdVTHI set to: 0.399988 degC 2023-12-20T02:35:00.544Z,1703039700.544 [StratificationFrontDetector](DEBUG): (re)initializing 2023-12-20T02:35:00.544Z,1703039700.544 [StratificationFrontDetector] Loaded 2023-12-20T02:35:00.544Z,1703039700.544 [ComponentRegistry](DEBUG): SyncComponent "StratificationFrontDetector" handled in the control thread. 2023-12-20T02:35:00.545Z,1703039700.545 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2023-12-20T02:35:00.551Z,1703039700.551 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2023-12-20T02:35:00.554Z,1703039700.554 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2023-12-20T02:35:00.566Z,1703039700.566 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2023-12-20T02:35:00.567Z,1703039700.567 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40C104E0 2023-12-20T02:35:00.567Z,1703039700.567 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 932 2023-12-20T02:35:00.572Z,1703039700.572 [Supervisor](INFO): Main Thread ID is 829 2023-12-20T02:35:00.572Z,1703039700.572 [Supervisor](DEBUG): Running supervisor. 2023-12-20T02:35:00.572Z,1703039700.572 [CommandExec ThreadHandler](INFO): Handler Thread ID is 933 2023-12-20T02:35:00.573Z,1703039700.573 [CommandExec](INFO): Initializing the command executive. 2023-12-20T02:35:00.574Z,1703039700.574 [CommandLine ThreadHandler](INFO): Handler Thread ID is 934 2023-12-20T02:35:00.577Z,1703039700.577 [controlThread ThreadHandler](INFO): Handler Thread ID is 935 2023-12-20T02:35:00.577Z,1703039700.577 [controlThread](DEBUG): Initializing ControlThread 2023-12-20T02:35:00.578Z,1703039700.578 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2023-12-20T02:35:00.578Z,1703039700.578 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2023-12-20T02:35:00.579Z,1703039700.579 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2023-12-20T02:35:00.579Z,1703039700.579 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2023-12-20T02:35:00.579Z,1703039700.579 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator. 2023-12-20T02:35:00.587Z,1703039700.587 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2023-12-20T02:35:00.588Z,1703039700.588 [NavChart](DEBUG): Initialize NavChart Navigation. 2023-12-20T02:35:00.588Z,1703039700.588 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2023-12-20T02:35:00.588Z,1703039700.588 [SBIT](INFO): Initialize SBIT Component. 2023-12-20T02:35:00.589Z,1703039700.589 [SBIT](IMPORTANT): git: 2023-12-14 2023-12-20T02:35:00.589Z,1703039700.589 [SBIT](INFO): git hash: 83eaf5b798064236ed38181756e01e1e1e718f00 2023-12-20T02:35:00.589Z,1703039700.589 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2023-12-20T02:35:00.591Z,1703039700.591 [SBIT](INFO): Kernel Reporting Different Version From Configuration. Kernel Expected: #2 PREEMPT Thu Jan 11 20:13:48 PST 2018 Kernel Reported: #1 PREEMPT Wed Mar 17 08:23:48 PDT 2021 2023-12-20T02:35:00.592Z,1703039700.592 [SBIT](INFO): Beginning SBIT in 47.000000 seconds. 2023-12-20T02:35:00.592Z,1703039700.592 [IBIT](INFO): Initialize IBIT Component. 2023-12-20T02:35:00.593Z,1703039700.593 [CBIT](DEBUG): Initialize CBIT Component. 2023-12-20T02:35:00.594Z,1703039700.594 [logger ThreadHandler](INFO): Handler Thread ID is 936 2023-12-20T02:35:00.605Z,1703039700.605 [CBIT](DEBUG): Initialized mux pins. 2023-12-20T02:35:00.605Z,1703039700.605 [CBIT](DEBUG): Initializing the watchdog timer. 2023-12-20T02:35:00.613Z,1703039700.613 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 937 2023-12-20T02:35:00.625Z,1703039700.625 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 938 2023-12-20T02:35:00.627Z,1703039700.627 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2023-12-20T02:35:00.629Z,1703039700.629 [CBIT](INFO): Last reboot was NOT due to watchdog timer. 2023-12-20T02:35:00.630Z,1703039700.630 [CBIT](DEBUG): Initializing heartbeat. 2023-12-20T02:35:00.637Z,1703039700.637 [Onboard ThreadHandler](INFO): Handler Thread ID is 939 2023-12-20T02:35:00.654Z,1703039700.654 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 940 2023-12-20T02:35:00.674Z,1703039700.674 [DAT ThreadHandler](INFO): Handler Thread ID is 941 2023-12-20T02:35:00.674Z,1703039700.674 [DAT](INFO): Powering up 2023-12-20T02:35:00.675Z,1703039700.675 [DAT](DEBUG): Initializing DAT. 2023-12-20T02:35:00.679Z,1703039700.679 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 943 2023-12-20T02:35:00.679Z,1703039700.679 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2023-12-20T02:35:00.685Z,1703039700.685 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 945 2023-12-20T02:35:00.691Z,1703039700.691 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 947 2023-12-20T02:35:00.694Z,1703039700.694 [WetLabsBB2FL](INFO): Powering up 2023-12-20T02:35:00.698Z,1703039700.698 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000 2023-12-20T02:35:00.698Z,1703039700.698 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000 2023-12-20T02:35:00.698Z,1703039700.698 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000 2023-12-20T02:35:00.698Z,1703039700.698 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000 2023-12-20T02:35:00.698Z,1703039700.698 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000 2023-12-20T02:35:00.699Z,1703039700.699 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000 2023-12-20T02:35:00.699Z,1703039700.699 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000 2023-12-20T02:35:00.699Z,1703039700.699 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000 2023-12-20T02:35:00.701Z,1703039700.701 [CBIT](DEBUG): Deactivating GF circuits. 2023-12-20T02:35:00.701Z,1703039700.701 [CBIT](DEBUG): Deactivating emergency mode. 2023-12-20T02:35:00.741Z,1703039700.741 [CBIT](DEBUG): Backplane powered. 2023-12-20T02:35:00.746Z,1703039700.746 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2023-12-20T02:35:00.748Z,1703039700.748 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2023-12-20T02:35:00.749Z,1703039700.749 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2023-12-20T02:35:00.750Z,1703039700.750 [LoopControl](DEBUG): Initialize LoopControlComponent. 2023-12-20T02:35:00.751Z,1703039700.751 [MissionManager](INFO): Loading Mission from file: Missions/Startup.xml 2023-12-20T02:35:00.804Z,1703039700.804 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2023-12-20T02:35:00.831Z,1703039700.831 [MissionManager](DEBUG): 2023-12-20T02:35:00.832Z,1703039700.832 [MissionManager](INFO): Loading Mission from file: Missions/Default.xml 2023-12-20T02:35:00.876Z,1703039700.876 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min 2023-12-20T02:35:00.878Z,1703039700.878 [Default:A.Wait](DEBUG): Construct Wait. 2023-12-20T02:35:00.880Z,1703039700.880 [Default:B.GoToSurface](DEBUG): Construct GoToSurface. 2023-12-20T02:35:00.903Z,1703039700.903 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2023-12-20T02:35:00.906Z,1703039700.906 [Default:CheckIn:C.Wait](DEBUG): Construct Wait. 2023-12-20T02:35:00.937Z,1703039700.937 [Default:E.Execute](DEBUG): Construct Execute. 2023-12-20T02:35:00.940Z,1703039700.940 [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-12-20T02:35:00.959Z,1703039700.959 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,DropWeight,NAL9602,Power24vConverter,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,StratificationFrontDetector,DeadReckonUsingMultipleVelocitySources,DeadReckonUsingSpeedCalculator,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter, 2023-12-20T02:35:00.971Z,1703039700.971 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2023-12-20T02:35:01.061Z,1703039701.061 [Radio_Surface](INFO): Powering up 2023-12-20T02:35:01.120Z,1703039701.120 [Power24vConverter](INFO): Powering up. 2023-12-20T02:35:01.184Z,1703039701.184 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2023-12-20T02:35:01.185Z,1703039701.185 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2023-12-20T02:35:01.187Z,1703039701.187 [ElevatorServo](DEBUG): Initializing EZServoServo. 2023-12-20T02:35:01.193Z,1703039701.193 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2023-12-20T02:35:01.194Z,1703039701.194 [MassServo](DEBUG): Initializing EZServoServo. 2023-12-20T02:35:01.201Z,1703039701.201 [MassServo](DEBUG): Initializing MassServo. 2023-12-20T02:35:01.202Z,1703039701.202 [RudderServo](DEBUG): Initializing EZServoServo. 2023-12-20T02:35:01.209Z,1703039701.209 [RudderServo](DEBUG): Initializing RudderServo. 2023-12-20T02:35:01.210Z,1703039701.210 [ThrusterHE](DEBUG): Initializing EZServoServo. 2023-12-20T02:35:01.217Z,1703039701.217 [ThrusterHE](DEBUG): Initializing ThrusterHE. 2023-12-20T02:35:03.301Z,1703039703.301 [WetLabsBB2FL](INFO): Powering down 2023-12-20T02:35:06.850Z,1703039706.850 [ThrusterHE](ERROR): Zero Speed Commanded. 2023-12-20T02:35:13.274Z,1703039713.274 [DAT](INFO): DAT read: 2023-12-20T02:35:13.275Z,1703039713.275 [DAT](INFO): DAT read: Teledyne Benthos DAT-900 Series 2023-12-20T02:35:15.040Z,1703039715.040 [DAT](INFO): DAT read: MF Frequency Band 2023-12-20T02:35:15.041Z,1703039715.041 [DAT](INFO): DAT read: Directional Acoustic Transponder version 8.15.0 2023-12-20T02:35:15.042Z,1703039715.042 [DAT](INFO): DAT read: Dec 20 2023 02:34:40 2023-12-20T02:35:16.298Z,1703039716.298 [DAT](INFO): DAT read: Features enabled [Bearing] 2023-12-20T02:35:16.299Z,1703039716.299 [DAT](INFO): DAT read: CONNECT 00800 bits/sec 1 of 4, Rate 1/2 CC 12.50ms MGP 2023-12-20T02:35:16.300Z,1703039716.300 [DAT](INFO): commRate: 800 2023-12-20T02:35:18.365Z,1703039718.365 [DAT](INFO): entering command mode 2023-12-20T02:35:18.565Z,1703039718.565 [DAT](INFO): DAT read: 2023-12-20T02:35:18.566Z,1703039718.566 [DAT](INFO): DAT read: user:1> 2023-12-20T02:35:18.566Z,1703039718.566 [DAT](INFO): setting verbose to 3 2023-12-20T02:35:18.822Z,1703039718.822 [DAT](INFO): DAT read: user:1> 2023-12-20T02:35:18.823Z,1703039718.823 [DAT](INFO): DAT read: Verbose | 3 2023-12-20T02:35:18.823Z,1703039718.823 [DAT](INFO): set verbose to 3 2023-12-20T02:35:18.823Z,1703039718.823 [DAT](INFO): setting DatVerbose to 27440 2023-12-20T02:35:19.074Z,1703039719.074 [DAT](INFO): DAT read: user:2> 2023-12-20T02:35:19.075Z,1703039719.075 [DAT](INFO): DAT read: DatVerbose | 27440 2023-12-20T02:35:19.075Z,1703039719.075 [DAT](INFO): set DatVerbose to 27440 2023-12-20T02:35:19.075Z,1703039719.075 [DAT](INFO): setting transmit power to 8 2023-12-20T02:35:19.326Z,1703039719.326 [DAT](INFO): DAT read: user:3> 2023-12-20T02:35:19.327Z,1703039719.327 [DAT](INFO): DAT read: TxPower | 8 (Max) 2023-12-20T02:35:19.327Z,1703039719.327 [DAT](INFO): set transmit power to 8 2023-12-20T02:35:19.327Z,1703039719.327 [DAT](INFO): setting local address to 9 2023-12-20T02:35:19.580Z,1703039719.580 [DAT](INFO): DAT read: user:4> 2023-12-20T02:35:19.581Z,1703039719.581 [DAT](INFO): DAT read: LocalAddr | 9 2023-12-20T02:35:19.581Z,1703039719.581 [DAT](INFO): set local address to 9 2023-12-20T02:35:19.582Z,1703039719.582 [DAT](INFO): Setting time to: 2:35:19 And date to:12/20/2023 2023-12-20T02:35:19.830Z,1703039719.830 [DAT](INFO): DAT read: user:5> 2023-12-20T02:35:19.831Z,1703039719.831 [DAT](INFO): DAT read: Wed Dec 20, 2023 02:35:19 2023-12-20T02:35:19.831Z,1703039719.831 [DAT](INFO): Local DAT time set to Wed Dec 20, 2023 02:35:19 2023-12-20T02:35:28.447Z,1703039728.447 [NAL9602](INFO): Powering up NAL9602 2023-12-20T02:35:39.351Z,1703039739.351 [NAL9602](INFO): NAL9602 initialized 2023-12-20T02:35:48.273Z,1703039748.273 [SBIT](IMPORTANT): Beginning Startup BIT 2023-12-20T02:35:48.278Z,1703039748.278 [CBIT](IMPORTANT): Beginning ground fault scan 2023-12-20T02:35:59.240Z,1703039759.240 [CBIT](IMPORTANT): No ground fault detected mA: CHAN A0 (Batt): 0.016062 CHAN A1 (24V): 0.000616 CHAN A2 (12V): -0.004884 CHAN A3 (5V): -0.002646 CHAN B0 (3.3V): -0.000922 CHAN B1 (3.15aV): -0.001085 CHAN B2 (3.15bV): -0.001232 CHAN B3 (GND): -0.000238 OPEN: 0.006260 Full Scale: +/- 1 mA 2023-12-20T02:36:21.422Z,1703039781.422 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2023-12-20T02:36:34.756Z,1703039794.756 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2023-12-20T02:36:41.988Z,1703039801.988 [SBIT](IMPORTANT): SBIT PASSED 2023-12-20T02:36:41.988Z,1703039801.988 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg 2023-12-20T02:36:41.989Z,1703039801.989 [SBIT](IMPORTANT): BackseatComponent.missionCritical=1 bool; 2023-12-20T02:36:41.990Z,1703039801.990 [SBIT](IMPORTANT): CBIT.gfScanTimeout=1 hour; 2023-12-20T02:36:41.990Z,1703039801.990 [SBIT](IMPORTANT): DropWeight.loadAtStartup=1 bool; 2023-12-20T02:36:41.990Z,1703039801.990 [SBIT](IMPORTANT): ESPComponent.sampleTimeout=2 minute; 2023-12-20T02:36:41.990Z,1703039801.990 [SBIT](IMPORTANT): Express none CTD_Seabird.bin_median_sea_water_salinity; 2023-12-20T02:36:41.990Z,1703039801.990 [SBIT](IMPORTANT): Express none CTD_Seabird.bin_median_sea_water_temperature; 2023-12-20T02:36:41.990Z,1703039801.990 [SBIT](IMPORTANT): Express none WetLabsBB2FL.bin_mean_mass_concentration_of_chlorophyll_in_sea_water; 2023-12-20T02:36:41.990Z,1703039801.990 [SBIT](IMPORTANT): Express none WetLabsBB2FL.bin_median_mass_concentration_of_chlorophyll_in_sea_water; 2023-12-20T02:36:41.990Z,1703039801.990 [SBIT](IMPORTANT): Express linearApproximation _.ayeris_disk_space 100.000000 gigabyte; 2023-12-20T02:36:41.991Z,1703039801.991 [SBIT](IMPORTANT): Express linearApproximation _.ayeris_particle_counts 300.000000 count_per_second; 2023-12-20T02:36:41.991Z,1703039801.991 [SBIT](IMPORTANT): Express none _.ayeris_particle_shape; 2023-12-20T02:36:41.991Z,1703039801.991 [SBIT](IMPORTANT): Express none _.ayeris_particle_slope; 2023-12-20T02:36:41.991Z,1703039801.991 [SBIT](IMPORTANT): Express linearApproximation depth 5.000000 meter; 2023-12-20T02:36:41.991Z,1703039801.991 [SBIT](IMPORTANT): Express linearApproximation latitude 0.005000 degree; 2023-12-20T02:36:41.991Z,1703039801.991 [SBIT](IMPORTANT): Express linearApproximation longitude 0.005000 degree; 2023-12-20T02:36:41.991Z,1703039801.991 [SBIT](IMPORTANT): PowerOnly.loadAtStartup=0 bool; 2023-12-20T02:36:41.991Z,1703039801.991 [SBIT](IMPORTANT): StratificationFrontDetector.loadAtStartup=1 bool; 2023-12-20T02:36:41.991Z,1703039801.991 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=200.005958 cubic_centimeter; 2023-12-20T02:36:41.992Z,1703039801.992 [SBIT](IMPORTANT): VerticalControl.kdPitchMass=0 second; 2023-12-20T02:36:41.992Z,1703039801.992 [SBIT](IMPORTANT): VerticalControl.kiPitchMass=0.0015 reciprocal_second; 2023-12-20T02:36:41.992Z,1703039801.992 [SBIT](IMPORTANT): VerticalControl.kpPitchMass=0.01 none; 2023-12-20T02:36:41.992Z,1703039801.992 [SBIT](IMPORTANT): VerticalControl.massDeadband=1 millimeter; 2023-12-20T02:36:41.992Z,1703039801.992 [SBIT](IMPORTANT): VerticalControl.massDefault=6.920555 millimeter; 2023-12-20T02:36:41.992Z,1703039801.992 [SBIT](IMPORTANT): VerticalHomogeneityIndexCalculator.depth3=20 meter; 2023-12-20T02:36:41.992Z,1703039801.992 [SBIT](IMPORTANT): VerticalHomogeneityIndexCalculator.depth4=30 meter; 2023-12-20T02:36:42.396Z,1703039802.396 [MissionManager](IMPORTANT): Started mission Startup 2023-12-20T02:36:42.396Z,1703039802.396 [Startup] Running Loop=1 2023-12-20T02:36:42.396Z,1703039802.396 [Startup](DEBUG): Aggregate::initialize Startup 2023-12-20T02:36:42.396Z,1703039802.396 [Startup:A.GoToSurface] Running Loop=1 2023-12-20T02:36:42.396Z,1703039802.396 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2023-12-20T02:36:42.397Z,1703039802.397 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2023-12-20T02:36:42.397Z,1703039802.397 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2023-12-20T02:36:42.398Z,1703039802.398 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2023-12-20T02:36:42.398Z,1703039802.398 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2023-12-20T02:36:42.398Z,1703039802.398 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2023-12-20T02:36:42.400Z,1703039802.400 [Startup:StartupSatComms] Running Loop=1 2023-12-20T02:36:42.400Z,1703039802.400 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms 2023-12-20T02:36:42.400Z,1703039802.400 [Startup:StartupSatComms:A] Running Loop=1 2023-12-20T02:36:42.788Z,1703039802.788 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix 2023-12-20T02:36:48.516Z,1703039808.516 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2023-12-20T02:37:01.826Z,1703039821.826 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2023-12-20T02:37:26.476Z,1703039846.476 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004673 2023-12-20T02:36:59.424Z,1703039819.424 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2023-12-20T02:37:13.172Z,1703039833.172 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2023-12-20T02:37:25.683Z,1703039845.683 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2023-12-20T02:37:42.605Z,1703039862.605 [Startup:StartupSatComms:A](INFO): Timed out from 2023-12-20T02:36:42.4Z 2023-12-20T02:37:42.605Z,1703039862.605 [Startup:StartupSatComms:A] Stopped 2023-12-20T02:37:42.605Z,1703039862.605 [Startup:StartupSatComms:B] Running Loop=1 2023-12-20T02:37:43.010Z,1703039863.010 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications 2023-12-20T02:37:50.004Z,1703039870.004 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20231220T022923/Courier0004.lzma 2023-12-20T02:37:51.005Z,1703039871.005 [DataOverHttps](INFO): Moved sent file to Logs/20231220T022923/Courier0004.lzma.bak 2023-12-20T02:37:51.005Z,1703039871.005 [DataOverHttps](INFO): SBD MOMSN=19123141 2023-12-20T02:37:52.749Z,1703039872.749 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2023-12-20T02:38:00.777Z,1703039880.777 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1 2023-12-20T02:38:00.777Z,1703039880.777 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-12-20T02:38:00.778Z,1703039880.778 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 1 2023-12-20T02:38:00.778Z,1703039880.778 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2023-12-20T02:38:00.789Z,1703039880.789 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-12-20T02:38:00.789Z,1703039880.789 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2023-12-20T02:38:01.218Z,1703039881.218 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-12-20T02:38:01.218Z,1703039881.218 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1 2023-12-20T02:38:01.219Z,1703039881.219 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2023-12-20T02:38:01.219Z,1703039881.219 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 1 2023-12-20T02:38:01.613Z,1703039881.613 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2023-12-20T02:38:06.085Z,1703039886.085 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2023-12-20T02:38:06.611Z,1703039886.611 [DataOverHttps](INFO): Sending 151 bytes from file Logs/20231220T023448/Courier0000.lzma 2023-12-20T02:38:07.613Z,1703039887.613 [DataOverHttps](INFO): Moved sent file to Logs/20231220T023448/Courier0000.lzma.bak 2023-12-20T02:38:07.613Z,1703039887.613 [DataOverHttps](INFO): SBD MOMSN=19123143 2023-12-20T02:38:23.545Z,1703039903.545 [DataOverHttps](INFO): Sending 1129 bytes from file Logs/20231220T022923/Express0001.lzma 2023-12-20T02:38:24.541Z,1703039904.541 [DataOverHttps](INFO): Moved sent file to Logs/20231220T022923/Express0001.lzma.bak 2023-12-20T02:38:24.541Z,1703039904.541 [DataOverHttps](INFO): SBD MOMSN=19123146 2023-12-20T02:38:40.088Z,1703039920.088 [DataOverHttps](INFO): Sending 85 bytes from file Logs/20231220T022923/Express0005.lzma 2023-12-20T02:38:41.089Z,1703039921.089 [DataOverHttps](INFO): Moved sent file to Logs/20231220T022923/Express0005.lzma.bak 2023-12-20T02:38:41.089Z,1703039921.089 [DataOverHttps](INFO): SBD MOMSN=19123183 2023-12-20T02:38:42.803Z,1703039922.803 [Startup:StartupSatComms:B](INFO): Timed out from 2023-12-20T02:37:42.6Z 2023-12-20T02:38:42.803Z,1703039922.803 [Startup:StartupSatComms:B] Stopped 2023-12-20T02:38:42.803Z,1703039922.803 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms 2023-12-20T02:38:42.803Z,1703039922.803 [Startup:StartupSatComms] Stopped 2023-12-20T02:38:42.803Z,1703039922.803 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms 2023-12-20T02:38:42.804Z,1703039922.804 [Startup](INFO): Completed Startup 2023-12-20T02:38:42.804Z,1703039922.804 [MissionManager](INFO): Startup is completed. 2023-12-20T02:38:42.804Z,1703039922.804 [MissionManager](INFO): Uninitializing Mission Startup 2023-12-20T02:38:42.804Z,1703039922.804 [Startup] Stopped 2023-12-20T02:38:42.805Z,1703039922.805 [Startup](DEBUG): Aggregate::uninitialize Startup 2023-12-20T02:38:42.805Z,1703039922.805 [Startup:A.GoToSurface] Stopped 2023-12-20T02:38:42.805Z,1703039922.805 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2023-12-20T02:38:43.230Z,1703039923.230 [MissionManager](IMPORTANT): Started mission Default 2023-12-20T02:38:43.230Z,1703039923.230 [Default] Running Loop=1 2023-12-20T02:38:43.231Z,1703039923.231 [Default](DEBUG): Aggregate::initialize Default 2023-12-20T02:38:43.231Z,1703039923.231 [Default:B.GoToSurface] Running Loop=1 2023-12-20T02:38:43.231Z,1703039923.231 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2023-12-20T02:38:43.232Z,1703039923.232 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2023-12-20T02:38:43.232Z,1703039923.232 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2023-12-20T02:38:43.232Z,1703039923.232 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2023-12-20T02:38:43.233Z,1703039923.233 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2023-12-20T02:38:43.233Z,1703039923.233 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2023-12-20T02:38:43.233Z,1703039923.233 [Default:A.Wait] Running Loop=1 2023-12-20T02:38:43.233Z,1703039923.233 [Default:A.Wait](DEBUG): Initialize Wait Component. 2023-12-20T02:38:56.541Z,1703039936.541 [Default:A.Wait](INFO): Done Waiting. 2023-12-20T02:38:56.541Z,1703039936.541 [Default:A.Wait] Stopped 2023-12-20T02:38:56.541Z,1703039936.541 [Default:A.Wait](DEBUG): Uninitialize Wait Component. 2023-12-20T02:38:56.961Z,1703039936.961 [Default:CheckIn] Running Loop=1 2023-12-20T02:38:56.961Z,1703039936.961 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2023-12-20T02:38:56.961Z,1703039936.961 [Default:CheckIn:Read_GPS] Running Loop=1 2023-12-20T02:38:57.347Z,1703039937.347 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix 2023-12-20T02:38:59.411Z,1703039939.411 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2023-12-20T02:39:15.975Z,1703039955.975 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2023-12-20T02:39:23.829Z,1703039963.829 [DataOverHttps](INFO): Sending 1106 bytes from file Logs/20231220T023448/Express0001.lzma 2023-12-20T02:39:24.829Z,1703039964.829 [DataOverHttps](INFO): Moved sent file to Logs/20231220T023448/Express0001.lzma.bak 2023-12-20T02:39:24.829Z,1703039964.829 [DataOverHttps](INFO): SBD MOMSN=19123186 2023-12-20T02:39:56.419Z,1703039996.419 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2023-12-20T02:40:43.189Z,1703040043.189 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2023-12-20T02:41:01.828Z,1703040061.828 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2 2023-12-20T02:41:01.828Z,1703040061.828 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-12-20T02:41:01.829Z,1703040061.829 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 2 2023-12-20T02:41:01.830Z,1703040061.830 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2023-12-20T02:41:01.876Z,1703040061.876 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-12-20T02:41:01.876Z,1703040061.876 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2023-12-20T02:41:02.268Z,1703040062.268 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-12-20T02:41:02.268Z,1703040062.268 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2 2023-12-20T02:41:02.289Z,1703040062.289 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2023-12-20T02:41:02.289Z,1703040062.289 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 2 2023-12-20T02:41:02.608Z,1703040062.608 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2023-12-20T02:41:31.718Z,1703040091.718 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2023-12-20T02:42:25.800Z,1703040145.800 [BPC1](INFO): Calculating totals. Valid battery stick count: 56. Valid reserve battery stick count: 6. 2023-12-20T02:42:25.803Z,1703040145.803 [BPC1](INFO): Received data from all battery sticks. 2023-12-20T02:43:47.605Z,1703040227.605 [CommandExec](IMPORTANT): got command configSet PowerOnly.loadAtStartup 1 bool persist 2023-12-20T02:43:47.605Z,1703040227.605 [CommandExec](IMPORTANT): configSet PowerOnly.loadAtStartup requires a restart to take effect. 2023-12-20T02:43:47.609Z,1703040227.609 [CommandExec](IMPORTANT): got command restart application 2023-12-20T02:43:48.611Z,1703040228.611 [Supervisor](INFO): Stop Mission called by Supervisor::terminate 2023-12-20T02:43:48.612Z,1703040228.612 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread. 2023-12-20T02:43:48.612Z,1703040228.612 [CommandExec](INFO): Uninitializing the command executive. 2023-12-20T02:43:48.612Z,1703040228.612 [CommandExec](INFO): Uninitializing the command scheduler. 2023-12-20T02:43:48.612Z,1703040228.612 [CommandExec ThreadHandler](INFO): Thread cancelled. 2023-12-20T02:43:48.803Z,1703040228.803 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2023-12-20T02:43:48.803Z,1703040228.803 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2023-12-20T02:43:48.803Z,1703040228.803 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2023-12-20T02:43:48.804Z,1703040228.804 [NavChartDb](INFO): Join timeout helper Thread ID is 976 2023-12-20T02:43:48.855Z,1703040228.855 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2023-12-20T02:43:48.856Z,1703040228.856 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2023-12-20T02:43:48.867Z,1703040228.867 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler 2023-12-20T02:43:48.867Z,1703040228.867 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2023-12-20T02:43:48.868Z,1703040228.868 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 977 2023-12-20T02:43:49.279Z,1703040229.279 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread. 2023-12-20T02:43:49.280Z,1703040229.280 [WetLabsBB2FL](INFO): Powering down 2023-12-20T02:43:49.280Z,1703040229.280 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2023-12-20T02:43:49.289Z,1703040229.289 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler 2023-12-20T02:43:49.290Z,1703040229.290 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2023-12-20T02:43:49.290Z,1703040229.290 [CTD_Seabird](INFO): Join timeout helper Thread ID is 978 2023-12-20T02:43:49.987Z,1703040229.987 [CTD_Seabird](INFO): Powering down 2023-12-20T02:43:49.999Z,1703040229.999 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread. 2023-12-20T02:43:49.999Z,1703040229.999 [CTD_Seabird](INFO): Powering down 2023-12-20T02:43:50.017Z,1703040230.017 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2023-12-20T02:43:50.035Z,1703040230.035 [ComponentRegistry](INFO): Shutting down DAT ThreadHandler 2023-12-20T02:43:50.035Z,1703040230.035 [DAT ThreadHandler](INFO): Thread cancelled. 2023-12-20T02:43:50.036Z,1703040230.036 [DAT](INFO): Join timeout helper Thread ID is 979 2023-12-20T02:43:50.263Z,1703040230.263 [DAT](INFO): Powering down 2023-12-20T02:43:50.336Z,1703040230.336 [DAT ThreadHandler](INFO): Uninitializing protected caller thread. 2023-12-20T02:43:50.336Z,1703040230.336 [DAT](INFO): Powering down 2023-12-20T02:43:50.337Z,1703040230.337 [DAT ThreadHandler](INFO): Thread cancelled. 2023-12-20T02:43:50.351Z,1703040230.351 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2023-12-20T02:43:50.351Z,1703040230.351 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2023-12-20T02:43:50.352Z,1703040230.352 [Radio_Surface](INFO): Join timeout helper Thread ID is 980 2023-12-20T02:43:50.383Z,1703040230.383 [Radio_Surface](INFO): Powering down 2023-12-20T02:43:50.384Z,1703040230.384 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2023-12-20T02:43:50.384Z,1703040230.384 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2023-12-20T02:43:50.394Z,1703040230.394 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler 2023-12-20T02:43:50.394Z,1703040230.394 [Onboard ThreadHandler](INFO): Thread cancelled. 2023-12-20T02:43:50.394Z,1703040230.394 [Onboard](INFO): Join timeout helper Thread ID is 981 2023-12-20T02:43:50.644Z,1703040230.644 [DataOverHttps](INFO): Radio surface powered OFF, will not connect. 2023-12-20T02:43:52.059Z,1703040232.059 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread. 2023-12-20T02:43:52.060Z,1703040232.060 [Onboard ThreadHandler](INFO): Thread cancelled. 2023-12-20T02:43:52.068Z,1703040232.068 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler 2023-12-20T02:43:52.068Z,1703040232.068 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2023-12-20T02:43:52.068Z,1703040232.068 [DataOverHttps](INFO): Join timeout helper Thread ID is 982 2023-12-20T02:43:52.651Z,1703040232.651 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread. 2023-12-20T02:43:52.652Z,1703040232.652 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2023-12-20T02:43:52.660Z,1703040232.660 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler 2023-12-20T02:43:52.660Z,1703040232.660 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2023-12-20T02:43:52.660Z,1703040232.660 [BackseatComponent](INFO): Join timeout helper Thread ID is 983 2023-12-20T02:43:52.779Z,1703040232.779 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread. 2023-12-20T02:43:52.780Z,1703040232.780 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2023-12-20T02:43:52.797Z,1703040232.797 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2023-12-20T02:43:52.797Z,1703040232.797 [logger ThreadHandler](INFO): Thread cancelled. 2023-12-20T02:43:52.798Z,1703040232.798 [logger](INFO): Join timeout helper Thread ID is 984 2023-12-20T02:43:52.827Z,1703040232.827 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2023-12-20T02:43:52.828Z,1703040232.828 [logger ThreadHandler](INFO): Thread cancelled. 2023-12-20T02:43:52.836Z,1703040232.836 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2023-12-20T02:43:52.836Z,1703040232.836 [CommandLine ThreadHandler](INFO): Thread cancelled. 2023-12-20T02:43:52.836Z,1703040232.836 [CommandLine](INFO): Join timeout helper Thread ID is 985 2023-12-20T02:43:52.915Z,1703040232.915 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2023-12-20T02:43:52.916Z,1703040232.916 [CommandLine ThreadHandler](INFO): Thread cancelled. 2023-12-20T02:43:52.936Z,1703040232.936 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler 2023-12-20T02:43:52.936Z,1703040232.936 [CommandExec ThreadHandler](INFO): Thread cancelled. 2023-12-20T02:43:52.936Z,1703040232.936 [CommandExec](INFO): Join timeout helper Thread ID is 986 2023-12-20T02:43:52.937Z,1703040232.937 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2023-12-20T02:43:52.938Z,1703040232.938 [controlThread ThreadHandler](INFO): Thread cancelled. 2023-12-20T02:43:52.938Z,1703040232.938 [controlThread](INFO): Join timeout helper Thread ID is 987 2023-12-20T02:43:53.047Z,1703040233.047 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2023-12-20T02:43:53.048Z,1703040233.048 [controlThread](DEBUG): Uninitializing ControlThread 2023-12-20T02:43:53.048Z,1703040233.048 [AHRS_M2](INFO): Powering down 2023-12-20T02:43:53.120Z,1703040233.120 [NAL9602](INFO): Powering down 2023-12-20T02:43:53.122Z,1703040233.122 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator. 2023-12-20T02:43:53.123Z,1703040233.123 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator. 2023-12-20T02:43:53.124Z,1703040233.124 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2023-12-20T02:43:53.124Z,1703040233.124 [MissionManager](INFO): Uninitializing Mission Default 2023-12-20T02:43:53.124Z,1703040233.124 [Default] Stopped 2023-12-20T02:43:53.124Z,1703040233.124 [Default](DEBUG): Aggregate::uninitialize Default 2023-12-20T02:43:53.124Z,1703040233.124 [Default:B.GoToSurface] Stopped 2023-12-20T02:43:53.124Z,1703040233.124 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2023-12-20T02:43:53.124Z,1703040233.124 [Default:CheckIn] Stopped 2023-12-20T02:43:53.125Z,1703040233.125 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2023-12-20T02:43:53.125Z,1703040233.125 [Default:CheckIn:Read_GPS] Stopped 2023-12-20T02:43:53.127Z,1703040233.127 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2023-12-20T02:43:53.128Z,1703040233.128 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2023-12-20T02:43:53.128Z,1703040233.128 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2023-12-20T02:43:53.128Z,1703040233.128 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2023-12-20T02:43:53.129Z,1703040233.129 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2023-12-20T02:43:53.129Z,1703040233.129 [BuoyancyServo](INFO): Powering down 2023-12-20T02:43:53.143Z,1703040233.143 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2023-12-20T02:43:53.143Z,1703040233.143 [ElevatorServo](INFO): Powering down 2023-12-20T02:43:53.144Z,1703040233.144 [MassServo](DEBUG): Uninitialize Mass Servo. 2023-12-20T02:43:53.144Z,1703040233.144 [MassServo](INFO): Powering down 2023-12-20T02:43:53.145Z,1703040233.145 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2023-12-20T02:43:53.145Z,1703040233.145 [RudderServo](INFO): Powering down 2023-12-20T02:43:53.146Z,1703040233.146 [ThrusterHE](DEBUG): Uninitialize Thruster Servo. 2023-12-20T02:43:53.146Z,1703040233.146 [ThrusterHE](INFO): Powering down 2023-12-20T02:43:53.147Z,1703040233.147 [SBIT](DEBUG): Uninitialize SBIT Component. 2023-12-20T02:43:53.148Z,1703040233.148 [IBIT](DEBUG): Uninitialize IBIT Component. 2023-12-20T02:43:53.148Z,1703040233.148 [CBIT](DEBUG): Uninitialize CBIT Component. 2023-12-20T02:43:53.148Z,1703040233.148 [CBIT](DEBUG): Powering off loads. 2023-12-20T02:43:53.159Z,1703040233.159 [CBIT](DEBUG): Disabling WDT. 2023-12-20T02:43:53.171Z,1703040233.171 [CBIT](DEBUG): Opening all GF detection circuits. 2023-12-20T02:43:53.172Z,1703040233.172 [controlThread ThreadHandler](INFO): Thread cancelled. 2023-12-20T02:43:53.189Z,1703040233.189 [DAT ThreadHandler](INFO): Thread cancelled. 2023-12-20T02:43:53.194Z,1703040233.194 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2023-12-20T02:43:53.197Z,1703040233.197 [Onboard ThreadHandler](INFO): Thread cancelled. 2023-12-20T02:43:53.203Z,1703040233.203 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2023-12-20T02:43:53.249Z,1703040233.249 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2023-12-20T02:43:53.299Z,1703040233.299 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2023-12-20T02:43:53.304Z,1703040233.304 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2023-12-20T02:43:53.357Z,1703040233.357 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2023-12-20T02:43:53.406Z,1703040233.406 [logger ThreadHandler](INFO): Thread cancelled.