2024-08-13T17:55:06.402Z,1723571706.402 [Supervisor](DEBUG): Initializing supervisor. 2024-08-13T17:55:06.407Z,1723571706.407 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2024-08-13T17:55:06.407Z,1723571706.407 [SyncHandler](INFO): Protected caller Thread ID is 970 2024-08-13T17:55:06.408Z,1723571706.408 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2024-08-13T17:55:06.408Z,1723571706.408 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2024-08-13T17:55:06.409Z,1723571706.409 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 971 2024-08-13T17:55:06.412Z,1723571706.412 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2024-08-13T17:55:06.430Z,1723571706.430 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread. 2024-08-13T17:55:06.431Z,1723571706.431 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2024-08-13T17:55:06.431Z,1723571706.431 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 972 2024-08-13T17:55:06.435Z,1723571706.435 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2024-08-13T17:55:06.436Z,1723571706.436 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2024-08-13T17:55:06.436Z,1723571706.436 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 973 2024-08-13T17:55:06.438Z,1723571706.438 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2024-08-13T17:55:06.439Z,1723571706.439 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0 2024-08-13T17:55:06.440Z,1723571706.440 [logger ThreadHandler](INFO): Protected caller Thread ID is 974 2024-08-13T17:55:06.443Z,1723571706.443 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2024-08-13T17:55:06.443Z,1723571706.443 [Supervisor](INFO): Looking for Config files in directory: Config/ 2024-08-13T17:55:06.449Z,1723571706.449 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2024-08-13T17:55:06.940Z,1723571706.940 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2024-08-13T17:55:06.941Z,1723571706.941 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2024-08-13T17:55:07.709Z,1723571707.709 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2024-08-13T17:55:07.711Z,1723571707.711 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2024-08-13T17:55:07.832Z,1723571707.832 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2024-08-13T17:55:07.834Z,1723571707.834 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2024-08-13T17:55:08.398Z,1723571708.398 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2024-08-13T17:55:08.400Z,1723571708.400 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2024-08-13T17:55:08.510Z,1723571708.510 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2024-08-13T17:55:08.512Z,1723571708.512 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2024-08-13T17:55:08.608Z,1723571708.608 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2024-08-13T17:55:09.035Z,1723571709.035 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2024-08-13T17:55:09.037Z,1723571709.037 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2024-08-13T17:55:09.274Z,1723571709.274 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2024-08-13T17:55:09.276Z,1723571709.276 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2024-08-13T17:55:09.428Z,1723571709.428 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2024-08-13T17:55:09.428Z,1723571709.428 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg 2024-08-13T17:55:09.686Z,1723571709.686 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock 2024-08-13T17:55:09.688Z,1723571709.688 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2024-08-13T17:55:10.252Z,1723571710.252 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2024-08-13T17:55:10.254Z,1723571710.254 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2024-08-13T17:55:11.385Z,1723571711.385 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2024-08-13T17:55:11.386Z,1723571711.386 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2024-08-13T17:55:11.480Z,1723571711.480 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2024-08-13T17:55:11.687Z,1723571711.687 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2024-08-13T17:55:11.688Z,1723571711.688 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2024-08-13T17:55:11.934Z,1723571711.934 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2024-08-13T17:55:11.936Z,1723571711.936 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2024-08-13T17:55:12.250Z,1723571712.250 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2024-08-13T17:55:12.252Z,1723571712.252 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-brizo/ 2024-08-13T17:55:12.257Z,1723571712.257 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Control.cfg 2024-08-13T17:55:12.378Z,1723571712.378 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Sensor.cfg 2024-08-13T17:55:12.543Z,1723571712.543 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Simulator.cfg 2024-08-13T17:55:12.642Z,1723571712.642 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/secure.cfg 2024-08-13T17:55:12.739Z,1723571712.739 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Servo.cfg 2024-08-13T17:55:12.862Z,1723571712.862 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/workSite.cfg 2024-08-13T17:55:12.960Z,1723571712.960 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/vehicle.cfg 2024-08-13T17:55:13.078Z,1723571713.078 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Battery.cfg 2024-08-13T17:55:13.354Z,1723571713.354 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2024-08-13T17:55:13.355Z,1723571713.355 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Science.cfg 2024-08-13T17:55:13.504Z,1723571713.504 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/logger.cfg 2024-08-13T17:55:13.610Z,1723571713.610 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/BIT.cfg 2024-08-13T17:55:13.716Z,1723571713.716 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Navigation.cfg 2024-08-13T17:55:13.834Z,1723571713.834 [Supervisor](IMPORTANT): Reloading configuration overrides from Data/persisted.cfg 2024-08-13T17:55:13.853Z,1723571713.853 [Module Loader](DEBUG): Loading Module at Modules/Dock.so 2024-08-13T17:55:13.982Z,1723571713.982 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking) 2024-08-13T17:55:13.982Z,1723571713.982 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2024-08-13T17:55:13.997Z,1723571713.997 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2024-08-13T17:55:13.997Z,1723571713.997 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2024-08-13T17:55:14.061Z,1723571714.061 [DepthRateCalculator] Loaded 2024-08-13T17:55:14.062Z,1723571714.062 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2024-08-13T17:55:14.067Z,1723571714.067 [PitchRateCalculator] Loaded 2024-08-13T17:55:14.067Z,1723571714.067 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2024-08-13T17:55:14.077Z,1723571714.077 [SpeedCalculator] Loaded 2024-08-13T17:55:14.077Z,1723571714.077 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2024-08-13T17:55:14.082Z,1723571714.082 [YawRateCalculator] Loaded 2024-08-13T17:55:14.082Z,1723571714.082 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2024-08-13T17:55:14.103Z,1723571714.103 [ElevatorOffsetCalculator] Loaded 2024-08-13T17:55:14.103Z,1723571714.103 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread. 2024-08-13T17:55:14.104Z,1723571714.104 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2024-08-13T17:55:14.104Z,1723571714.104 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2024-08-13T17:55:14.165Z,1723571714.165 [VerticalControl](DEBUG): Construct VerticalControl. 2024-08-13T17:55:14.219Z,1723571714.219 [VerticalControl] Loaded 2024-08-13T17:55:14.219Z,1723571714.219 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2024-08-13T17:55:14.222Z,1723571714.222 [HorizontalControl](DEBUG): Construct HorizontalControl. 2024-08-13T17:55:14.267Z,1723571714.267 [HorizontalControl] Loaded 2024-08-13T17:55:14.267Z,1723571714.267 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2024-08-13T17:55:14.269Z,1723571714.269 [SpeedControl](DEBUG): Construct SpeedControl. 2024-08-13T17:55:14.272Z,1723571714.272 [SpeedControl] Loaded 2024-08-13T17:55:14.272Z,1723571714.272 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2024-08-13T17:55:14.275Z,1723571714.275 [LoopControl](DEBUG): Construct LoopControl. 2024-08-13T17:55:14.275Z,1723571714.275 [LoopControl] Loaded 2024-08-13T17:55:14.276Z,1723571714.276 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2024-08-13T17:55:14.276Z,1723571714.276 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2024-08-13T17:55:14.276Z,1723571714.276 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2024-08-13T17:55:14.403Z,1723571714.403 [DeadReckonUsingMultipleVelocitySources] Loaded 2024-08-13T17:55:14.404Z,1723571714.404 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2024-08-13T17:55:14.417Z,1723571714.417 [NavChart] Loaded 2024-08-13T17:55:14.417Z,1723571714.417 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2024-08-13T17:55:14.423Z,1723571714.423 [UniversalFixResidualReporter] Loaded 2024-08-13T17:55:14.423Z,1723571714.423 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2024-08-13T17:55:14.423Z,1723571714.423 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2024-08-13T17:55:14.424Z,1723571714.424 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2024-08-13T17:55:14.616Z,1723571714.616 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2024-08-13T17:55:14.617Z,1723571714.617 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2024-08-13T17:55:15.227Z,1723571715.227 [AHRS_M2] Loaded 2024-08-13T17:55:15.227Z,1723571715.227 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread. 2024-08-13T17:55:15.268Z,1723571715.268 [BackseatComponent] Loaded 2024-08-13T17:55:15.269Z,1723571715.269 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread. 2024-08-13T17:55:15.270Z,1723571715.270 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 409384E0 2024-08-13T17:55:15.270Z,1723571715.270 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 1059 2024-08-13T17:55:15.273Z,1723571715.273 [LcmUniversalReporter] Loaded 2024-08-13T17:55:15.273Z,1723571715.273 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread. 2024-08-13T17:55:16.093Z,1723571716.093 [BPC1] Loaded 2024-08-13T17:55:16.093Z,1723571716.093 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2024-08-13T17:55:16.180Z,1723571716.180 [DATMMP] Loaded 2024-08-13T17:55:16.181Z,1723571716.181 [ComponentRegistry](DEBUG): Component "DATMMP" handled in its own thread. 2024-08-13T17:55:16.182Z,1723571716.182 [DATMMP ThreadHandler](DEBUG): Created PCaller Thread at 409694E0 2024-08-13T17:55:16.182Z,1723571716.182 [DATMMP ThreadHandler](INFO): Protected caller Thread ID is 1060 2024-08-13T17:55:16.252Z,1723571716.252 [DataOverHttps] Loaded 2024-08-13T17:55:16.252Z,1723571716.252 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread. 2024-08-13T17:55:16.253Z,1723571716.253 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 409994E0 2024-08-13T17:55:16.254Z,1723571716.254 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 1061 2024-08-13T17:55:16.276Z,1723571716.276 [Depth_Keller] Loaded 2024-08-13T17:55:16.277Z,1723571716.277 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2024-08-13T17:55:16.316Z,1723571716.316 [DVL_micro] Loaded 2024-08-13T17:55:16.316Z,1723571716.316 [ComponentRegistry](DEBUG): SyncComponent "DVL_micro" handled in the control thread. 2024-08-13T17:55:16.387Z,1723571716.387 [NAL9602] Loaded 2024-08-13T17:55:16.387Z,1723571716.387 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2024-08-13T17:55:16.515Z,1723571716.515 [Onboard] Loaded 2024-08-13T17:55:16.515Z,1723571716.515 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread. 2024-08-13T17:55:16.516Z,1723571716.516 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 409C94E0 2024-08-13T17:55:16.516Z,1723571716.516 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 1062 2024-08-13T17:55:16.530Z,1723571716.530 [Power24vConverter] Loaded 2024-08-13T17:55:16.531Z,1723571716.531 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread. 2024-08-13T17:55:16.545Z,1723571716.545 [Radio_Surface] Loaded 2024-08-13T17:55:16.546Z,1723571716.546 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2024-08-13T17:55:16.547Z,1723571716.547 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 409F94E0 2024-08-13T17:55:16.547Z,1723571716.547 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 1063 2024-08-13T17:55:16.630Z,1723571716.630 [Sonardyne_Nano] Loaded 2024-08-13T17:55:16.637Z,1723571716.637 [ComponentRegistry](DEBUG): SyncComponent "Sonardyne_Nano" handled in the control thread. 2024-08-13T17:55:16.638Z,1723571716.638 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2024-08-13T17:55:16.638Z,1723571716.638 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2024-08-13T17:55:17.221Z,1723571717.221 [BuoyancyServo] Loaded 2024-08-13T17:55:17.221Z,1723571717.221 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2024-08-13T17:55:17.243Z,1723571717.243 [ElevatorServo] Loaded 2024-08-13T17:55:17.244Z,1723571717.244 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2024-08-13T17:55:17.265Z,1723571717.265 [MassServo] Loaded 2024-08-13T17:55:17.265Z,1723571717.265 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2024-08-13T17:55:17.285Z,1723571717.285 [RudderServo] Loaded 2024-08-13T17:55:17.286Z,1723571717.286 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2024-08-13T17:55:17.301Z,1723571717.301 [ThrusterHE] Loaded 2024-08-13T17:55:17.302Z,1723571717.302 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread. 2024-08-13T17:55:17.302Z,1723571717.302 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2024-08-13T17:55:17.303Z,1723571717.303 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2024-08-13T17:55:17.391Z,1723571717.391 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2024-08-13T17:55:17.392Z,1723571717.392 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2024-08-13T17:55:17.429Z,1723571717.429 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2024-08-13T17:55:17.429Z,1723571717.429 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2024-08-13T17:55:17.793Z,1723571717.793 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2024-08-13T17:55:17.794Z,1723571717.794 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2024-08-13T17:55:18.004Z,1723571718.004 [CTD_Seabird] Loaded 2024-08-13T17:55:18.004Z,1723571718.004 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread. 2024-08-13T17:55:18.005Z,1723571718.005 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40BB34E0 2024-08-13T17:55:18.006Z,1723571718.006 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 1064 2024-08-13T17:55:18.041Z,1723571718.041 [ESPComponent] Loaded 2024-08-13T17:55:18.042Z,1723571718.042 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread. 2024-08-13T17:55:18.063Z,1723571718.063 [PAR_Licor] Loaded 2024-08-13T17:55:18.063Z,1723571718.063 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread. 2024-08-13T17:55:18.107Z,1723571718.107 [WetLabsBB2FL] Loaded 2024-08-13T17:55:18.107Z,1723571718.107 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread. 2024-08-13T17:55:18.108Z,1723571718.108 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40BE34E0 2024-08-13T17:55:18.108Z,1723571718.109 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 1065 2024-08-13T17:55:18.109Z,1723571718.109 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2024-08-13T17:55:18.110Z,1723571718.110 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2024-08-13T17:55:18.267Z,1723571718.267 [SBIT](DEBUG): Construct Startup Built In Test. 2024-08-13T17:55:18.275Z,1723571718.275 [SBIT] Loaded 2024-08-13T17:55:18.276Z,1723571718.276 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2024-08-13T17:55:18.279Z,1723571718.279 [IBIT](DEBUG): Construct Initiated Built In Test. 2024-08-13T17:55:18.291Z,1723571718.291 [IBIT] Loaded 2024-08-13T17:55:18.291Z,1723571718.291 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2024-08-13T17:55:18.297Z,1723571718.297 [CBIT](DEBUG): Construct Continuous Built In Test. 2024-08-13T17:55:18.400Z,1723571718.400 [CBIT] Loaded 2024-08-13T17:55:18.401Z,1723571718.401 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2024-08-13T17:55:18.401Z,1723571718.401 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2024-08-13T17:55:18.407Z,1723571718.407 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2024-08-13T17:55:18.410Z,1723571718.410 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2024-08-13T17:55:18.421Z,1723571718.421 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2024-08-13T17:55:18.423Z,1723571718.423 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40C524E0 2024-08-13T17:55:18.423Z,1723571718.423 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 1066 2024-08-13T17:55:18.427Z,1723571718.427 [Supervisor](INFO): Main Thread ID is 7713 2024-08-13T17:55:18.427Z,1723571718.427 [Supervisor](DEBUG): Running supervisor. 2024-08-13T17:55:18.428Z,1723571718.428 [CommandExec ThreadHandler](INFO): Handler Thread ID is 1067 2024-08-13T17:55:18.428Z,1723571718.428 [CommandExec](INFO): Initializing the command executive. 2024-08-13T17:55:18.430Z,1723571718.430 [CommandLine ThreadHandler](INFO): Handler Thread ID is 1068 2024-08-13T17:55:18.432Z,1723571718.432 [controlThread ThreadHandler](INFO): Handler Thread ID is 1069 2024-08-13T17:55:18.432Z,1723571718.432 [controlThread](DEBUG): Initializing ControlThread 2024-08-13T17:55:18.433Z,1723571718.433 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2024-08-13T17:55:18.434Z,1723571718.434 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2024-08-13T17:55:18.434Z,1723571718.434 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2024-08-13T17:55:18.434Z,1723571718.434 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2024-08-13T17:55:18.435Z,1723571718.435 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator. 2024-08-13T17:55:18.435Z,1723571718.435 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2024-08-13T17:55:18.437Z,1723571718.437 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2024-08-13T17:55:18.438Z,1723571718.438 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2024-08-13T17:55:18.438Z,1723571718.438 [LoopControl](DEBUG): Initialize LoopControlComponent. 2024-08-13T17:55:18.439Z,1723571718.439 [NavChart](DEBUG): Initialize NavChart Navigation. 2024-08-13T17:55:18.439Z,1723571718.439 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2024-08-13T17:55:18.446Z,1723571718.446 [SBIT](INFO): Initialize SBIT Component. 2024-08-13T17:55:18.446Z,1723571718.446 [SBIT](IMPORTANT): git: 2024-08-12-95-g598b95f60 2024-08-13T17:55:18.446Z,1723571718.446 [SBIT](INFO): git hash: 598b95f6033d24136933a3d5d1ddac5d4570ac95 2024-08-13T17:55:18.447Z,1723571718.447 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2024-08-13T17:55:18.448Z,1723571718.448 [SBIT](INFO): Kernel Reporting Different Version From Configuration. Kernel Expected: #1 PREEMPT Tue Sep 24 11:12:27 PDT 2019 Kernel Reported: #1 PREEMPT Wed Mar 17 08:23:48 PDT 2021 2024-08-13T17:55:18.449Z,1723571718.449 [SBIT](INFO): Beginning SBIT in 68.000000 seconds. 2024-08-13T17:55:18.449Z,1723571718.449 [IBIT](INFO): Initialize IBIT Component. 2024-08-13T17:55:18.450Z,1723571718.450 [CBIT](DEBUG): Initialize CBIT Component. 2024-08-13T17:55:18.451Z,1723571718.451 [logger ThreadHandler](INFO): Handler Thread ID is 1070 2024-08-13T17:55:18.461Z,1723571718.461 [CBIT](DEBUG): Initialized mux pins. 2024-08-13T17:55:18.461Z,1723571718.461 [CBIT](DEBUG): Initializing the watchdog timer. 2024-08-13T17:55:18.470Z,1723571718.470 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 1071 2024-08-13T17:55:18.482Z,1723571718.482 [DATMMP ThreadHandler](INFO): Handler Thread ID is 1072 2024-08-13T17:55:18.482Z,1723571718.482 [DATMMP](INFO): Start 2024-08-13T17:55:18.482Z,1723571718.482 [DATMMP](INFO): Powering up 2024-08-13T17:55:18.483Z,1723571718.483 [DATMMP](DEBUG): Initializing DATMMP. 2024-08-13T17:55:18.485Z,1723571718.485 [CBIT](INFO): Last reboot was NOT due to watchdog timer. 2024-08-13T17:55:18.486Z,1723571718.486 [CBIT](DEBUG): Initializing heartbeat. 2024-08-13T17:55:18.488Z,1723571718.488 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 1074 2024-08-13T17:55:18.489Z,1723571718.489 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2024-08-13T17:55:18.498Z,1723571718.498 [Onboard ThreadHandler](INFO): Handler Thread ID is 1075 2024-08-13T17:55:18.515Z,1723571718.515 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 1076 2024-08-13T17:55:18.538Z,1723571718.538 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 1077 2024-08-13T17:55:18.538Z,1723571718.538 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2024-08-13T17:55:18.543Z,1723571718.543 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 1079 2024-08-13T17:55:18.546Z,1723571718.546 [WetLabsBB2FL](INFO): Powering up 2024-08-13T17:55:18.547Z,1723571718.547 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 1081 2024-08-13T17:55:18.555Z,1723571718.555 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/DK1NORSO.000 2024-08-13T17:55:18.555Z,1723571718.555 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from DK1NORSO.000 2024-08-13T17:55:18.556Z,1723571718.556 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/DK2NORS.000 2024-08-13T17:55:18.556Z,1723571718.556 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from DK2NORS.000 2024-08-13T17:55:18.556Z,1723571718.556 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/DK3HORRO.000 2024-08-13T17:55:18.556Z,1723571718.556 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from DK3HORRO.000 2024-08-13T17:55:18.557Z,1723571718.557 [CBIT](DEBUG): Deactivating GF circuits. 2024-08-13T17:55:18.558Z,1723571718.557 [CBIT](DEBUG): Deactivating emergency mode. 2024-08-13T17:55:18.597Z,1723571718.597 [CBIT](DEBUG): Backplane powered. 2024-08-13T17:55:18.598Z,1723571718.598 [MissionManager](IMPORTANT): Using TethysL tl-to-tx parser 2024-08-13T17:55:18.599Z,1723571718.599 [MissionManager](INFO): Loading Mission from file: Missions/Startup.tl 2024-08-13T17:55:18.599Z,1723571718.599 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Startup.tl 2024-08-13T17:55:18.604Z,1723571718.604 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Startup.tl 2024-08-13T17:55:18.658Z,1723571718.658 [MissionManager](DEBUG): TethyslAPI: Missions/Startup.tl translated into: 2024-08-13T17:55:18.662Z,1723571718.662 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2024-08-13T17:55:18.718Z,1723571718.718 [MissionManager](DEBUG): # Copyright (c) 2024 MBARI # MBARI Proprietary Information. Confidential. All Rights Reserved # Unauthorized copying or distribution of this file via any medium is strictly # prohibited. # # WARNING - This file contains information whose export is restricted by the # Export Administration Act of 1979 (Title 50, U.S.C., App. 2401 et seq.), as # amended. Violations of these export laws are subject to severe civil and/or # criminal penalties. mission Startup { behavior Guidance:GoToSurface { run in progression } aggregate StartupSatComms { run in sequence readDatum { timeout duration=P1M Universal:latitude_fix } readDatum { timeout duration=P1M Universal:platform_communications } } } 2024-08-13T17:55:18.719Z,1723571718.719 [MissionManager](INFO): Loading Mission from file: Missions/Default.tl 2024-08-13T17:55:18.719Z,1723571718.719 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Default.tl 2024-08-13T17:55:18.722Z,1723571718.722 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Default.tl 2024-08-13T17:55:18.733Z,1723571718.733 [DATMMP](INFO): Starting 2024-08-13T17:55:18.921Z,1723571718.921 [Radio_Surface](INFO): Powering up 2024-08-13T17:55:18.986Z,1723571718.986 [DATMMP](INFO): Starting 2024-08-13T17:55:19.001Z,1723571719.001 [MissionManager](DEBUG): TethyslAPI: Missions/Default.tl translated into: 0 13 Burn on Dropped weight due to communications timeout. 5 Default mission has been running for Restarting logs and Default mission. restart logs 2024-08-13T17:55:19.023Z,1723571719.023 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min 2024-08-13T17:55:19.024Z,1723571719.024 [Default:A.Wait](DEBUG): Construct Wait. 2024-08-13T17:55:19.027Z,1723571719.027 [Default:B.GoToSurface](DEBUG): Construct GoToSurface. 2024-08-13T17:55:19.055Z,1723571719.055 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2024-08-13T17:55:19.078Z,1723571719.078 [Default:CheckIn:C.Wait](DEBUG): Construct Wait. 2024-08-13T17:55:19.084Z,1723571719.084 [Default:E.Execute](DEBUG): Construct Execute. 2024-08-13T17:55:19.087Z,1723571719.087 [MissionManager](DEBUG): # Copyright (c) 2024 MBARI # MBARI Proprietary Information. Confidential. All Rights Reserved # Unauthorized copying or distribution of this file via any medium is strictly # prohibited. # # WARNING - This file contains information whose export is restricted by the # Export Administration Act of 1979 (Title 50, U.S.C., App. 2401 et seq.), as # amended. Violations of these export laws are subject to severe civil and/or # criminal penalties. mission Default { arguments { ElapsedSinceDefaultStarted = 0 minute } behavior Guidance:Wait { """ Wait a moment to see if the scheduler starts a new mission before starting to actually run Default. """ run in sequence set duration = 13 second } behavior Guidance:GoToSurface { run in progression } aggregate CheckIn { run in sequence repeat=288 readDatum id="Read_GPS" { timeout duration=P5M Universal:time_fix } readDatum id="Read_Iridium" { timeout duration=P4H { behavior Guidance:Execute { run in sequence set command = "Burn on" } syslog critical "Dropped weight due to communications timeout." } Universal:platform_communications } behavior Guidance:Wait { run in sequence set duration = 5 minute } assign in sequence ElapsedSinceDefaultStarted = elapsed ( Universal:mission_started ) syslog important "Default mission has been running for " + ElapsedSinceDefaultStarted~minute } syslog important "Restarting logs and Default mission." behavior Guidance:Execute { run in sequence set command = "restart logs" } } 2024-08-13T17:55:19.105Z,1723571719.105 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,DVL_micro,NAL9602,Power24vConverter,Sonardyne_Nano,ESPComponent,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter, 2024-08-13T17:55:19.112Z,1723571719.112 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2024-08-13T17:55:19.186Z,1723571719.186 [Power24vConverter](INFO): Powering up. 2024-08-13T17:55:19.187Z,1723571719.187 [Sonardyne_Nano](INFO): Initializing. 2024-08-13T17:55:19.231Z,1723571719.231 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2024-08-13T17:55:19.237Z,1723571719.237 [DATMMP](INFO): Starting 2024-08-13T17:55:19.238Z,1723571719.238 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2024-08-13T17:55:19.239Z,1723571719.239 [ElevatorServo](DEBUG): Initializing EZServoServo. 2024-08-13T17:55:19.244Z,1723571719.244 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2024-08-13T17:55:19.245Z,1723571719.245 [MassServo](DEBUG): Initializing EZServoServo. 2024-08-13T17:55:19.254Z,1723571719.254 [MassServo](DEBUG): Initializing MassServo. 2024-08-13T17:55:19.255Z,1723571719.255 [RudderServo](DEBUG): Initializing EZServoServo. 2024-08-13T17:55:19.262Z,1723571719.262 [RudderServo](DEBUG): Initializing RudderServo. 2024-08-13T17:55:19.263Z,1723571719.263 [ThrusterHE](DEBUG): Initializing EZServoServo. 2024-08-13T17:55:19.270Z,1723571719.270 [ThrusterHE](DEBUG): Initializing ThrusterHE. 2024-08-13T17:55:19.490Z,1723571719.490 [DATMMP](INFO): Starting 2024-08-13T17:55:19.741Z,1723571719.741 [DATMMP](INFO): Starting 2024-08-13T17:55:19.993Z,1723571719.993 [DATMMP](INFO): Starting 2024-08-13T17:55:20.246Z,1723571720.246 [DATMMP](INFO): Starting 2024-08-13T17:55:20.497Z,1723571720.497 [DATMMP](INFO): Starting 2024-08-13T17:55:20.750Z,1723571720.750 [DATMMP](INFO): Starting 2024-08-13T17:55:21.001Z,1723571721.001 [DATMMP](INFO): Starting 2024-08-13T17:55:21.136Z,1723571721.136 [Sonardyne_Nano](ERROR): Failed to get valid response or reached max queue size, flushing UART 2024-08-13T17:55:21.254Z,1723571721.254 [DATMMP](INFO): Starting 2024-08-13T17:55:21.506Z,1723571721.506 [DATMMP](INFO): Starting 2024-08-13T17:55:21.757Z,1723571721.757 [DATMMP](INFO): Starting 2024-08-13T17:55:22.010Z,1723571722.010 [DATMMP](INFO): Starting 2024-08-13T17:55:22.261Z,1723571722.261 [DATMMP](INFO): Starting 2024-08-13T17:55:22.513Z,1723571722.513 [DATMMP](INFO): Starting 2024-08-13T17:55:22.766Z,1723571722.766 [DATMMP](INFO): Starting 2024-08-13T17:55:22.778Z,1723571722.778 [Sonardyne_Nano](IMPORTANT): Found beacon with acoustic ID 2207 2024-08-13T17:55:23.017Z,1723571723.017 [DATMMP](INFO): Starting 2024-08-13T17:55:23.269Z,1723571723.269 [DATMMP](INFO): Starting 2024-08-13T17:55:23.522Z,1723571723.522 [DATMMP](INFO): Starting 2024-08-13T17:55:23.774Z,1723571723.774 [DATMMP](INFO): Starting 2024-08-13T17:55:23.833Z,1723571723.833 [WetLabsBB2FL] Communications Fault, FailCount= 1 2024-08-13T17:55:23.833Z,1723571723.833 [WetLabsBB2FL](ERROR): Communications Fault 2024-08-13T17:55:24.025Z,1723571724.025 [DATMMP](INFO): Starting 2024-08-13T17:55:24.191Z,1723571724.191 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2024-08-13T17:55:24.277Z,1723571724.277 [DATMMP](INFO): Starting 2024-08-13T17:55:24.333Z,1723571724.333 [WetLabsBB2FL](INFO): Powering down 2024-08-13T17:55:24.529Z,1723571724.529 [DATMMP](INFO): Starting 2024-08-13T17:55:24.783Z,1723571724.783 [DATMMP](INFO): Starting 2024-08-13T17:55:24.890Z,1723571724.890 [ThrusterHE](ERROR): Zero Speed Commanded. 2024-08-13T17:55:25.034Z,1723571725.034 [DATMMP](INFO): Starting 2024-08-13T17:55:25.286Z,1723571725.286 [DATMMP](INFO): Starting 2024-08-13T17:55:25.410Z,1723571725.410 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2024-08-13T17:55:25.410Z,1723571725.410 [WetLabsBB2FL] No Fault, FailCount= 1 2024-08-13T17:55:25.537Z,1723571725.537 [DATMMP](INFO): Starting 2024-08-13T17:55:25.555Z,1723571725.555 [WetLabsBB2FL](INFO): Powering up 2024-08-13T17:55:25.575Z,1723571725.575 [CTD_Seabird](ERROR): Device message queue exceeded the allowed limit. 2024-08-13T17:55:25.789Z,1723571725.789 [DATMMP](INFO): Starting 2024-08-13T17:55:26.041Z,1723571726.041 [DATMMP](INFO): Starting 2024-08-13T17:55:26.293Z,1723571726.293 [DATMMP](INFO): Starting 2024-08-13T17:55:26.545Z,1723571726.545 [DATMMP](INFO): Starting 2024-08-13T17:55:26.799Z,1723571726.799 [DATMMP](INFO): Starting 2024-08-13T17:55:27.049Z,1723571727.049 [DATMMP](INFO): Starting 2024-08-13T17:55:27.303Z,1723571727.303 [DATMMP](INFO): Starting 2024-08-13T17:55:27.553Z,1723571727.553 [DATMMP](INFO): Starting 2024-08-13T17:55:27.806Z,1723571727.806 [DATMMP](INFO): Starting 2024-08-13T17:55:28.058Z,1723571728.058 [DATMMP](INFO): Starting 2024-08-13T17:55:28.309Z,1723571728.309 [DATMMP](INFO): Starting 2024-08-13T17:55:28.561Z,1723571728.561 [DATMMP](INFO): Starting 2024-08-13T17:55:28.814Z,1723571728.814 [DATMMP](INFO): Starting 2024-08-13T17:55:29.066Z,1723571729.066 [DATMMP](INFO): Starting 2024-08-13T17:55:29.318Z,1723571729.318 [DATMMP](INFO): Starting 2024-08-13T17:55:29.569Z,1723571729.569 [DATMMP](INFO): Starting 2024-08-13T17:55:29.822Z,1723571729.822 [DATMMP](INFO): Starting 2024-08-13T17:55:30.074Z,1723571730.074 [DATMMP](INFO): Starting 2024-08-13T17:55:30.325Z,1723571730.325 [DATMMP](INFO): Starting 2024-08-13T17:55:30.577Z,1723571730.577 [DATMMP](INFO): Starting 2024-08-13T17:55:30.578Z,1723571730.578 [DATMMP](INFO): DAT read: 2024-08-13T17:55:30.579Z,1723571730.579 [DATMMP](INFO): DAT read: Teledyne Benthos DAT-900 Series 2024-08-13T17:55:30.830Z,1723571730.830 [DATMMP](INFO): Starting 2024-08-13T17:55:30.837Z,1723571730.837 [WetLabsBB2FL] Communications Fault, FailCount= 2 2024-08-13T17:55:30.837Z,1723571730.837 [WetLabsBB2FL](ERROR): Communications Fault 2024-08-13T17:55:30.925Z,1723571730.925 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2024-08-13T17:55:31.081Z,1723571731.081 [DATMMP](INFO): Starting 2024-08-13T17:55:31.333Z,1723571731.333 [DATMMP](INFO): Starting 2024-08-13T17:55:31.337Z,1723571731.337 [WetLabsBB2FL](INFO): Powering down 2024-08-13T17:55:31.585Z,1723571731.585 [DATMMP](INFO): Starting 2024-08-13T17:55:31.837Z,1723571731.837 [DATMMP](INFO): Starting 2024-08-13T17:55:32.090Z,1723571732.090 [DATMMP](INFO): Starting 2024-08-13T17:55:32.091Z,1723571732.091 [DATMMP](INFO): DAT read: MF Frequency Band 2024-08-13T17:55:32.092Z,1723571732.092 [DATMMP](INFO): DAT read: Directional Acoustic Transponder version 8.15.0 2024-08-13T17:55:32.093Z,1723571732.093 [DATMMP](INFO): DAT read: Jul 13 2000 17:55:26 2024-08-13T17:55:32.341Z,1723571732.341 [DATMMP](INFO): Starting 2024-08-13T17:55:32.545Z,1723571732.545 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2024-08-13T17:55:32.546Z,1723571732.546 [WetLabsBB2FL] No Fault, FailCount= 2 2024-08-13T17:55:32.579Z,1723571732.579 [WetLabsBB2FL](INFO): Powering up 2024-08-13T17:55:32.593Z,1723571732.593 [DATMMP](INFO): Starting 2024-08-13T17:55:32.865Z,1723571732.865 [DATMMP](INFO): Starting 2024-08-13T17:55:33.098Z,1723571733.098 [DATMMP](INFO): Starting 2024-08-13T17:55:33.350Z,1723571733.350 [DATMMP](INFO): Starting 2024-08-13T17:55:33.350Z,1723571733.350 [DATMMP](INFO): DAT read: Features enabled [Bearing] 2024-08-13T17:55:33.352Z,1723571733.352 [DATMMP](INFO): DAT read: CONNECT 00800 bits/sec 1 of 4, Rate 1/2 CC 12.50ms MGP 2024-08-13T17:55:33.352Z,1723571733.352 [DATMMP](INFO): commRate: 800 2024-08-13T17:55:33.601Z,1723571733.601 [DATMMP](INFO): Starting 2024-08-13T17:55:33.853Z,1723571733.853 [DATMMP](INFO): Starting 2024-08-13T17:55:34.106Z,1723571734.106 [DATMMP](INFO): Starting 2024-08-13T17:55:34.358Z,1723571734.358 [DATMMP](INFO): Starting 2024-08-13T17:55:34.609Z,1723571734.609 [DATMMP](INFO): Starting 2024-08-13T17:55:34.873Z,1723571734.873 [DATMMP](INFO): Starting 2024-08-13T17:55:35.113Z,1723571735.113 [DATMMP](INFO): Starting 2024-08-13T17:55:35.365Z,1723571735.365 [DATMMP](INFO): Starting 2024-08-13T17:55:35.417Z,1723571735.417 [DATMMP](INFO): entering command mode 2024-08-13T17:55:35.619Z,1723571735.619 [DATMMP](INFO): Starting 2024-08-13T17:55:35.620Z,1723571735.620 [DATMMP](INFO): DAT read: 2024-08-13T17:55:35.620Z,1723571735.620 [DATMMP](INFO): DAT read: user:1> 2024-08-13T17:55:35.621Z,1723571735.621 [DATMMP](DEBUG): read user prompt 1: user:1> 2024-08-13T17:55:35.621Z,1723571735.621 [DATMMP](INFO): entering MMP mode 2024-08-13T17:55:35.869Z,1723571735.869 [DATMMP](INFO): Starting 2024-08-13T17:55:35.870Z,1723571735.870 [DATMMP](INFO): GSXN notify for xid: 0 2024-08-13T17:55:35.872Z,1723571735.872 [DATMMP](INFO): status rx: x1 2024-08-13T17:55:35.872Z,1723571735.872 [DATMMP](INFO): MMP status: 1: started 2024-08-13T17:55:35.872Z,1723571735.872 [DATMMP](INFO): Received message type: status 2024-08-13T17:55:35.873Z,1723571735.873 [DATMMP](INFO): Handled 2024-08-13T17:55:36.121Z,1723571736.121 [DATMMP](INFO): Starting 2024-08-13T17:55:36.123Z,1723571736.123 [DATMMP](INFO): Sent Tx Power Config 8 2024-08-13T17:55:36.123Z,1723571736.123 [DATMMP](INFO): Setting local address: 11 2024-08-13T17:55:36.125Z,1723571736.125 [DATMMP](INFO): Setting time to: 17:55:36 And date to:8/13/2024 2024-08-13T17:55:36.373Z,1723571736.373 [DATMMP](INFO): Starting 2024-08-13T17:55:36.374Z,1723571736.374 [DATMMP](INFO): GSXN notify for xid: 0 2024-08-13T17:55:36.375Z,1723571736.375 [DATMMP](INFO): mdmpower rx: x8 x0 x5 x0 2024-08-13T17:55:36.375Z,1723571736.375 [DATMMP](INFO): Received message type: mdmpower 2024-08-13T17:55:36.375Z,1723571736.375 [DATMMP](INFO): Handled 2024-08-13T17:55:36.625Z,1723571736.625 [DATMMP](INFO): Starting 2024-08-13T17:55:36.626Z,1723571736.626 [DATMMP](INFO): GSXN notify for xid: 10 2024-08-13T17:55:36.626Z,1723571736.626 [DATMMP](INFO): sreg_txpower rx: x8 2024-08-13T17:55:36.627Z,1723571736.627 [DATMMP](INFO): Received message type: sreg_txpower 2024-08-13T17:55:36.627Z,1723571736.627 [DATMMP](INFO): Match for : sreg_txpower 2024-08-13T17:55:36.627Z,1723571736.627 [DATMMP](INFO): ACK 2024-08-13T17:55:36.877Z,1723571736.877 [DATMMP](INFO): Starting 2024-08-13T17:55:36.878Z,1723571736.878 [DATMMP](INFO): GSXN notify for xid: 0 2024-08-13T17:55:36.879Z,1723571736.879 [DATMMP](INFO): mdmlocal rx: xB x0 x0 x0 2024-08-13T17:55:36.879Z,1723571736.879 [DATMMP](INFO): Received message type: mdmlocal 2024-08-13T17:55:36.879Z,1723571736.879 [DATMMP](INFO): Handled 2024-08-13T17:55:37.129Z,1723571737.129 [DATMMP](INFO): Starting 2024-08-13T17:55:37.130Z,1723571737.130 [DATMMP](INFO): GSXN notify for xid: 11 2024-08-13T17:55:37.130Z,1723571737.130 [DATMMP](INFO): sreg_locaddr rx: xB 2024-08-13T17:55:37.131Z,1723571737.131 [DATMMP](INFO): Received message type: sreg_locaddr 2024-08-13T17:55:37.131Z,1723571737.131 [DATMMP](INFO): Match for : sreg_locaddr 2024-08-13T17:55:37.131Z,1723571737.131 [DATMMP](INFO): ACK 2024-08-13T17:55:37.381Z,1723571737.381 [DATMMP](INFO): Starting 2024-08-13T17:55:37.382Z,1723571737.382 [DATMMP](INFO): GSXN notify for xid: 12 2024-08-13T17:55:37.383Z,1723571737.383 [DATMMP](INFO): timedate rx: x0 x11 x37 x24 x7 xD x7C x0 2024-08-13T17:55:37.383Z,1723571737.383 [DATMMP](INFO): Received message type: timedate 2024-08-13T17:55:37.383Z,1723571737.383 [DATMMP](INFO): Match for : timedate 2024-08-13T17:55:37.383Z,1723571737.383 [DATMMP](INFO): ACK 2024-08-13T17:55:37.633Z,1723571737.633 [DATMMP](INFO): Starting 2024-08-13T17:55:37.634Z,1723571737.634 [DATMMP](INFO): GSXN notify for xid: 0 2024-08-13T17:55:37.635Z,1723571737.635 [DATMMP](INFO): sys_verb rx: x0 x0 x0 x0 2024-08-13T17:55:37.635Z,1723571737.635 [DATMMP](INFO): Received message type: sys_verb 2024-08-13T17:55:37.635Z,1723571737.635 [DATMMP](INFO): Handled 2024-08-13T17:55:37.845Z,1723571737.845 [WetLabsBB2FL] Communications Fault, FailCount= 3 2024-08-13T17:55:37.845Z,1723571737.845 [WetLabsBB2FL](ERROR): Communications Fault 2024-08-13T17:55:37.885Z,1723571737.885 [DATMMP](INFO): Starting 2024-08-13T17:55:37.886Z,1723571737.886 [DATMMP](INFO): GSXN notify for xid: 13 2024-08-13T17:55:37.886Z,1723571737.886 [DATMMP](INFO): sreg_verbosity rx: x0 2024-08-13T17:55:37.887Z,1723571737.887 [DATMMP](INFO): Received message type: sreg_verbosity 2024-08-13T17:55:37.887Z,1723571737.887 [DATMMP](INFO): Match for : sreg_verbosity 2024-08-13T17:55:37.887Z,1723571737.887 [DATMMP](INFO): ACK 2024-08-13T17:55:38.138Z,1723571738.138 [DATMMP](INFO): Starting 2024-08-13T17:55:38.138Z,1723571738.138 [DATMMP](INFO): GSXN notify for xid: 14 2024-08-13T17:55:38.139Z,1723571738.139 [DATMMP](INFO): version rx: x2 x5 2024-08-13T17:55:38.139Z,1723571738.139 [DATMMP](INFO): DatMMPVersion: 2.5 2024-08-13T17:55:38.140Z,1723571738.140 [DATMMP](INFO): Received message type: version 2024-08-13T17:55:38.140Z,1723571738.140 [DATMMP](INFO): Match for : version 2024-08-13T17:55:38.140Z,1723571738.140 [DATMMP](INFO): ACK 2024-08-13T17:55:38.140Z,1723571738.140 [DATMMP](INFO): in MMP mode: config complete going to runnable 2024-08-13T17:55:38.150Z,1723571738.150 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2024-08-13T17:55:38.346Z,1723571738.346 [WetLabsBB2FL](INFO): Powering down 2024-08-13T17:55:39.375Z,1723571739.375 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2024-08-13T17:55:39.375Z,1723571739.375 [WetLabsBB2FL] No Fault, FailCount= 3 2024-08-13T17:55:39.560Z,1723571739.560 [WetLabsBB2FL](INFO): Powering up 2024-08-13T17:55:44.849Z,1723571744.849 [WetLabsBB2FL] Communications Fault, FailCount= 4 2024-08-13T17:55:44.849Z,1723571744.849 [WetLabsBB2FL](ERROR): Communications Fault 2024-08-13T17:55:45.046Z,1723571745.046 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2024-08-13T17:55:45.350Z,1723571745.350 [WetLabsBB2FL](INFO): Powering down 2024-08-13T17:55:46.246Z,1723571746.246 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2024-08-13T17:55:46.246Z,1723571746.246 [WetLabsBB2FL] No Fault, FailCount= 4 2024-08-13T17:55:46.563Z,1723571746.563 [WetLabsBB2FL](INFO): Powering up 2024-08-13T17:55:46.591Z,1723571746.591 [NAL9602](INFO): Powering up NAL9602 2024-08-13T17:55:51.246Z,1723571751.246 [DATMMP](INFO): GSXN notify for xid: 0 2024-08-13T17:55:51.247Z,1723571751.247 [DATMMP](INFO): timesync rx: x0 x1 x1 x0 2024-08-13T17:55:51.247Z,1723571751.247 [DATMMP](INFO): Received message type: timesync 2024-08-13T17:55:51.247Z,1723571751.247 [DATMMP](INFO): Handled 2024-08-13T17:55:51.857Z,1723571751.857 [WetLabsBB2FL] Communications Fault, FailCount= 5 2024-08-13T17:55:51.857Z,1723571751.857 [WetLabsBB2FL](ERROR): Communications Fault 2024-08-13T17:55:51.894Z,1723571751.894 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2024-08-13T17:55:51.894Z,1723571751.894 [CBIT](FAULT): Communications Fault in component: WetLabsBB2FL 2024-08-13T17:55:52.354Z,1723571752.354 [WetLabsBB2FL](INFO): Powering down 2024-08-13T17:55:57.508Z,1723571757.508 [NAL9602](INFO): NAL9602 initialized 2024-08-13T17:56:01.330Z,1723571761.330 [DATMMP](INFO): GSXN notify for xid: 0 2024-08-13T17:56:01.331Z,1723571761.331 [DATMMP](INFO): timesync rx: x1 x0 x1 x0 2024-08-13T17:56:01.331Z,1723571761.331 [DATMMP](INFO): Received message type: timesync 2024-08-13T17:56:01.331Z,1723571761.331 [DATMMP](INFO): Handled 2024-08-13T17:56:27.024Z,1723571787.024 [SBIT](IMPORTANT): Beginning Startup BIT 2024-08-13T17:56:27.029Z,1723571787.029 [CBIT](IMPORTANT): Beginning ground fault scan 2024-08-13T17:56:37.982Z,1723571797.982 [CBIT](IMPORTANT): No ground fault detected mA: CHAN A0 (Batt): 0.003805 CHAN A1 (24V): -0.002156 CHAN A2 (12V): -0.000278 CHAN A3 (5V): 0.000510 CHAN B0 (3.3V): 0.000657 CHAN B1 (3.15aV): 0.000598 CHAN B2 (3.15bV): 0.000466 CHAN B3 (GND): 0.000949 OPEN: -0.001174 Full Scale: +/- 1 mA 2024-08-13T17:56:45.626Z,1723571805.626 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-08-13T17:57:09.106Z,1723571829.106 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-08-13T17:57:11.340Z,1723571831.340 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004954 2024-08-13T17:57:21.144Z,1723571841.144 [SBIT](IMPORTANT): SBIT PASSED 2024-08-13T17:57:21.145Z,1723571841.145 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg 2024-08-13T17:57:21.146Z,1723571841.146 [SBIT](IMPORTANT): BPC1.batteryMissingStickThreshold=20 count; 2024-08-13T17:57:21.146Z,1723571841.146 [SBIT](IMPORTANT): CBIT.abortDepth=40 meter; 2024-08-13T17:57:21.146Z,1723571841.146 [SBIT](IMPORTANT): CBIT.stopDepth=30 meter; 2024-08-13T17:57:21.146Z,1723571841.146 [SBIT](IMPORTANT): CBIT.vehicleOpen=1 bool; 2024-08-13T17:57:21.147Z,1723571841.147 [SBIT](IMPORTANT): Depth_Keller.offset=3.6 decibar; 2024-08-13T17:57:21.147Z,1723571841.147 [SBIT](IMPORTANT): DropWeight.loadAtStartup=0 bool; 2024-08-13T17:57:21.147Z,1723571841.147 [SBIT](IMPORTANT): ESPComponent.sampleTimeout=3 minute; 2024-08-13T17:57:21.147Z,1723571841.147 [SBIT](IMPORTANT): ElevatorServo.currLimit=75 percent; 2024-08-13T17:57:21.147Z,1723571841.147 [SBIT](IMPORTANT): ElevatorServo.limitHi=16369 count; 2024-08-13T17:57:21.147Z,1723571841.147 [SBIT](IMPORTANT): ElevatorServo.limitLo=0 count; 2024-08-13T17:57:21.147Z,1723571841.147 [SBIT](IMPORTANT): ElevatorServo.loadAtStartup=1 bool; 2024-08-13T17:57:21.147Z,1723571841.147 [SBIT](IMPORTANT): Express none CurrentEstimator.current_direction_navigation_frame; 2024-08-13T17:57:21.147Z,1723571841.147 [SBIT](IMPORTANT): Express none CurrentEstimator.current_speed_navigation_frame; 2024-08-13T17:57:21.148Z,1723571841.148 [SBIT](IMPORTANT): Express none WetLabsBB2FL.bin_mean_mass_concentration_of_chlorophyll_in_sea_water; 2024-08-13T17:57:21.148Z,1723571841.148 [SBIT](IMPORTANT): Express none height_above_sea_floor; 2024-08-13T17:57:21.148Z,1723571841.148 [SBIT](IMPORTANT): IBIT.batteryCapacityThreshold=20 ampere_hour; 2024-08-13T17:57:21.148Z,1723571841.148 [SBIT](IMPORTANT): IBIT.batteryVoltageThreshold=12 volt; 2024-08-13T17:57:21.148Z,1723571841.148 [SBIT](IMPORTANT): Radio_Surface.loadAtStartup=1 bool; 2024-08-13T17:57:21.148Z,1723571841.148 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=71.773548 cubic_centimeter; 2024-08-13T17:57:21.148Z,1723571841.148 [SBIT](IMPORTANT): VerticalControl.elevLimit=3.85 degree; 2024-08-13T17:57:21.148Z,1723571841.148 [SBIT](IMPORTANT): VerticalControl.massDefault=12.059213 millimeter; 2024-08-13T17:57:21.548Z,1723571841.548 [MissionManager](IMPORTANT): Started mission Startup 2024-08-13T17:57:21.548Z,1723571841.548 [Startup] Running Loop=1 2024-08-13T17:57:21.548Z,1723571841.548 [Startup](DEBUG): Aggregate::initialize Startup 2024-08-13T17:57:21.548Z,1723571841.548 [Startup:A.GoToSurface] Running Loop=1 2024-08-13T17:57:21.548Z,1723571841.548 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2024-08-13T17:57:21.549Z,1723571841.549 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2024-08-13T17:57:21.549Z,1723571841.549 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2024-08-13T17:57:21.550Z,1723571841.550 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2024-08-13T17:57:21.550Z,1723571841.550 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2024-08-13T17:57:21.550Z,1723571841.550 [Startup:A.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds. 2024-08-13T17:57:21.551Z,1723571841.551 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2024-08-13T17:57:21.552Z,1723571841.552 [Startup:StartupSatComms] Running Loop=1 2024-08-13T17:57:21.553Z,1723571841.553 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms 2024-08-13T17:57:21.553Z,1723571841.553 [Startup:StartupSatComms:A] Running Loop=1 2024-08-13T17:57:21.948Z,1723571841.948 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix 2024-08-13T17:57:23.207Z,1723571843.207 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-08-13T17:57:24.815Z,1723571844.815 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-08-13T17:58:18.520Z,1723571898.520 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1 2024-08-13T17:58:18.520Z,1723571898.520 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-08-13T17:58:18.574Z,1723571898.574 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-08-13T17:58:18.939Z,1723571898.939 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-08-13T17:58:18.939Z,1723571898.939 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1 2024-08-13T17:58:21.776Z,1723571901.776 [Startup:StartupSatComms:A](INFO): Timed out from 2024-08-13T17:57:21.6Z 2024-08-13T17:58:21.776Z,1723571901.776 [Startup:StartupSatComms:A] Stopped 2024-08-13T17:58:21.776Z,1723571901.776 [Startup:StartupSatComms:B] Running Loop=1 2024-08-13T17:58:22.184Z,1723571902.184 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications 2024-08-13T17:58:22.193Z,1723571902.193 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2024-08-13T17:58:22.193Z,1723571902.193 [WetLabsBB2FL] No Fault, FailCount= 5 2024-08-13T17:58:22.418Z,1723571902.418 [WetLabsBB2FL](INFO): Powering up 2024-08-13T17:58:27.565Z,1723571907.565 [WetLabsBB2FL] Communications Fault, FailCount= 1 2024-08-13T17:58:27.565Z,1723571907.565 [WetLabsBB2FL](ERROR): Communications Fault 2024-08-13T17:58:27.609Z,1723571907.609 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2024-08-13T17:58:28.065Z,1723571908.065 [WetLabsBB2FL](INFO): Powering down 2024-08-13T17:58:29.237Z,1723571909.237 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2024-08-13T17:58:29.237Z,1723571909.237 [WetLabsBB2FL] No Fault, FailCount= 1 2024-08-13T17:58:29.279Z,1723571909.279 [WetLabsBB2FL](INFO): Powering up 2024-08-13T17:58:30.849Z,1723571910.849 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20240812T202942/Courier0364.lzma 2024-08-13T17:58:31.852Z,1723571911.852 [DataOverHttps](INFO): Moved sent file to Logs/20240812T202942/Courier0364.lzma.bak 2024-08-13T17:58:31.852Z,1723571911.852 [DataOverHttps](INFO): SBD MOMSN=21496616 2024-08-13T17:58:34.577Z,1723571914.577 [WetLabsBB2FL] Communications Fault, FailCount= 2 2024-08-13T17:58:34.577Z,1723571914.577 [WetLabsBB2FL](ERROR): Communications Fault 2024-08-13T17:58:34.880Z,1723571914.880 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2024-08-13T17:58:35.078Z,1723571915.078 [WetLabsBB2FL](INFO): Powering down 2024-08-13T17:58:35.294Z,1723571915.294 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-08-13T17:58:36.133Z,1723571916.133 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2024-08-13T17:58:36.133Z,1723571916.133 [WetLabsBB2FL] No Fault, FailCount= 2 2024-08-13T17:58:36.291Z,1723571916.291 [WetLabsBB2FL](INFO): Powering up 2024-08-13T17:58:41.581Z,1723571921.581 [WetLabsBB2FL] Communications Fault, FailCount= 3 2024-08-13T17:58:41.581Z,1723571921.581 [WetLabsBB2FL](ERROR): Communications Fault 2024-08-13T17:58:41.758Z,1723571921.758 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2024-08-13T17:58:42.082Z,1723571922.082 [WetLabsBB2FL](INFO): Powering down 2024-08-13T17:58:43.046Z,1723571923.046 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2024-08-13T17:58:43.046Z,1723571923.046 [WetLabsBB2FL] No Fault, FailCount= 3 2024-08-13T17:58:43.326Z,1723571923.326 [WetLabsBB2FL](INFO): Powering up 2024-08-13T17:58:48.585Z,1723571928.585 [WetLabsBB2FL] Communications Fault, FailCount= 4 2024-08-13T17:58:48.585Z,1723571928.585 [WetLabsBB2FL](ERROR): Communications Fault 2024-08-13T17:58:48.609Z,1723571928.609 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2024-08-13T17:58:49.082Z,1723571929.082 [WetLabsBB2FL](INFO): Powering down 2024-08-13T17:58:49.813Z,1723571929.813 [DataOverHttps](INFO): Sending 151 bytes from file Logs/20240813T175506/Courier0000.lzma 2024-08-13T17:58:50.225Z,1723571930.225 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2024-08-13T17:58:50.225Z,1723571930.225 [WetLabsBB2FL] No Fault, FailCount= 4 2024-08-13T17:58:50.295Z,1723571930.295 [WetLabsBB2FL](INFO): Powering up 2024-08-13T17:58:50.815Z,1723571930.815 [DataOverHttps](INFO): Moved sent file to Logs/20240813T175506/Courier0000.lzma.bak 2024-08-13T17:58:50.815Z,1723571930.815 [DataOverHttps](INFO): SBD MOMSN=21496618 2024-08-13T17:58:55.593Z,1723571935.593 [WetLabsBB2FL] Communications Fault, FailCount= 5 2024-08-13T17:58:55.593Z,1723571935.593 [WetLabsBB2FL](ERROR): Communications Fault 2024-08-13T17:58:55.864Z,1723571935.864 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2024-08-13T17:58:55.864Z,1723571935.864 [CBIT](FAULT): Communications Fault in component: WetLabsBB2FL 2024-08-13T17:58:56.094Z,1723571936.094 [WetLabsBB2FL](INFO): Powering down 2024-08-13T17:59:09.187Z,1723571949.187 [DataOverHttps](INFO): Sending 420 bytes from file Logs/20240812T202942/Express0365.lzma 2024-08-13T17:59:10.180Z,1723571950.180 [DataOverHttps](INFO): Moved sent file to Logs/20240812T202942/Express0365.lzma.bak 2024-08-13T17:59:10.180Z,1723571950.180 [DataOverHttps](INFO): SBD MOMSN=21496621 2024-08-13T17:59:22.165Z,1723571962.165 [Startup:StartupSatComms:B](INFO): Timed out from 2024-08-13T17:58:21.8Z 2024-08-13T17:59:22.165Z,1723571962.165 [Startup:StartupSatComms:B] Stopped 2024-08-13T17:59:22.165Z,1723571962.165 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms 2024-08-13T17:59:22.165Z,1723571962.165 [Startup:StartupSatComms] Stopped 2024-08-13T17:59:22.166Z,1723571962.166 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms 2024-08-13T17:59:22.167Z,1723571962.167 [Startup](INFO): Completed Startup 2024-08-13T17:59:22.167Z,1723571962.167 [MissionManager](INFO): Startup is completed. 2024-08-13T17:59:22.167Z,1723571962.167 [MissionManager](INFO): Uninitializing Mission Startup 2024-08-13T17:59:22.167Z,1723571962.167 [Startup] Stopped 2024-08-13T17:59:22.167Z,1723571962.167 [Startup](DEBUG): Aggregate::uninitialize Startup 2024-08-13T17:59:22.167Z,1723571962.167 [Startup:A.GoToSurface] Stopped 2024-08-13T17:59:22.167Z,1723571962.167 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2024-08-13T17:59:22.543Z,1723571962.543 [MissionManager](IMPORTANT): Started mission Default 2024-08-13T17:59:22.543Z,1723571962.543 [Default] Running Loop=1 2024-08-13T17:59:22.544Z,1723571962.544 [Default](DEBUG): Aggregate::initialize Default 2024-08-13T17:59:22.544Z,1723571962.544 [Default:B.GoToSurface] Running Loop=1 2024-08-13T17:59:22.544Z,1723571962.544 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2024-08-13T17:59:22.544Z,1723571962.544 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2024-08-13T17:59:22.544Z,1723571962.544 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2024-08-13T17:59:22.545Z,1723571962.545 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2024-08-13T17:59:22.545Z,1723571962.545 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2024-08-13T17:59:22.545Z,1723571962.545 [Default:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds. 2024-08-13T17:59:22.546Z,1723571962.546 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2024-08-13T17:59:22.546Z,1723571962.546 [Default:A.Wait] Running Loop=1 2024-08-13T17:59:22.546Z,1723571962.546 [Default:A.Wait](DEBUG): Initialize Wait Component. 2024-08-13T17:59:32.603Z,1723571972.603 [DataOverHttps](INFO): Sending 1177 bytes from file Logs/20240813T175506/Express0001.lzma 2024-08-13T17:59:33.603Z,1723571973.603 [DataOverHttps](INFO): Moved sent file to Logs/20240813T175506/Express0001.lzma.bak 2024-08-13T17:59:33.603Z,1723571973.603 [DataOverHttps](INFO): SBD MOMSN=21496635 2024-08-13T17:59:35.872Z,1723571975.872 [Default:A.Wait](INFO): Done Waiting. 2024-08-13T17:59:35.872Z,1723571975.872 [Default:A.Wait] Stopped 2024-08-13T17:59:35.872Z,1723571975.872 [Default:A.Wait](DEBUG): Uninitialize Wait Component. 2024-08-13T17:59:36.284Z,1723571976.284 [Default:CheckIn] Running Loop=1 2024-08-13T17:59:36.284Z,1723571976.284 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-08-13T17:59:36.284Z,1723571976.284 [Default:CheckIn:Read_GPS] Running Loop=1 2024-08-13T17:59:36.680Z,1723571976.680 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix 2024-08-13T18:00:02.216Z,1723572002.216 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-08-13T18:00:36.054Z,1723572036.054 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-08-13T18:00:57.870Z,1723572057.870 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-08-13T18:01:00.303Z,1723572060.303 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2024-08-13T18:01:18.879Z,1723572078.879 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-08-13T18:01:19.354Z,1723572079.354 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2 2024-08-13T18:01:19.354Z,1723572079.354 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-08-13T18:01:19.381Z,1723572079.381 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-08-13T18:01:19.741Z,1723572079.741 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-08-13T18:01:19.741Z,1723572079.741 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2 2024-08-13T18:01:25.817Z,1723572085.817 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2024-08-13T18:01:25.818Z,1723572085.818 [WetLabsBB2FL] No Fault, FailCount= 5 2024-08-13T18:01:25.980Z,1723572085.980 [WetLabsBB2FL](INFO): Powering up 2024-08-13T18:01:31.273Z,1723572091.273 [WetLabsBB2FL] Communications Fault, FailCount= 1 2024-08-13T18:01:31.273Z,1723572091.273 [WetLabsBB2FL](ERROR): Communications Fault 2024-08-13T18:01:31.454Z,1723572091.454 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2024-08-13T18:01:31.773Z,1723572091.773 [WetLabsBB2FL](INFO): Powering down 2024-08-13T18:01:32.822Z,1723572092.822 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2024-08-13T18:01:32.822Z,1723572092.822 [WetLabsBB2FL] No Fault, FailCount= 1 2024-08-13T18:01:32.995Z,1723572092.995 [WetLabsBB2FL](INFO): Powering up 2024-08-13T18:01:38.277Z,1723572098.277 [WetLabsBB2FL] Communications Fault, FailCount= 2 2024-08-13T18:01:38.277Z,1723572098.277 [WetLabsBB2FL](ERROR): Communications Fault 2024-08-13T18:01:38.330Z,1723572098.330 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2024-08-13T18:01:38.778Z,1723572098.778 [WetLabsBB2FL](INFO): Powering down 2024-08-13T18:01:40.054Z,1723572100.054 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2024-08-13T18:01:40.054Z,1723572100.054 [WetLabsBB2FL] No Fault, FailCount= 2 2024-08-13T18:01:40.290Z,1723572100.290 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-08-13T18:01:40.396Z,1723572100.396 [WetLabsBB2FL](INFO): Powering up 2024-08-13T18:01:45.693Z,1723572105.693 [WetLabsBB2FL] Communications Fault, FailCount= 3 2024-08-13T18:01:45.693Z,1723572105.693 [WetLabsBB2FL](ERROR): Communications Fault 2024-08-13T18:01:45.977Z,1723572105.977 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2024-08-13T18:01:46.194Z,1723572106.194 [WetLabsBB2FL](INFO): Powering down 2024-08-13T18:01:47.229Z,1723572107.229 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2024-08-13T18:01:47.230Z,1723572107.230 [WetLabsBB2FL] No Fault, FailCount= 3 2024-08-13T18:01:47.407Z,1723572107.407 [WetLabsBB2FL](INFO): Powering up 2024-08-13T18:01:52.697Z,1723572112.697 [WetLabsBB2FL] Communications Fault, FailCount= 4 2024-08-13T18:01:52.697Z,1723572112.697 [WetLabsBB2FL](ERROR): Communications Fault 2024-08-13T18:01:52.869Z,1723572112.869 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2024-08-13T18:01:53.198Z,1723572113.198 [WetLabsBB2FL](INFO): Powering down 2024-08-13T18:01:54.065Z,1723572114.065 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2024-08-13T18:01:54.065Z,1723572114.065 [WetLabsBB2FL] No Fault, FailCount= 4 2024-08-13T18:01:54.411Z,1723572114.411 [WetLabsBB2FL](INFO): Powering up 2024-08-13T18:01:59.701Z,1723572119.701 [WetLabsBB2FL] Communications Fault, FailCount= 5 2024-08-13T18:01:59.701Z,1723572119.701 [WetLabsBB2FL](ERROR): Communications Fault 2024-08-13T18:01:59.710Z,1723572119.710 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2024-08-13T18:01:59.711Z,1723572119.711 [CBIT](FAULT): Communications Fault in component: WetLabsBB2FL 2024-08-13T18:02:00.202Z,1723572120.202 [WetLabsBB2FL](INFO): Powering down 2024-08-13T18:02:01.702Z,1723572121.702 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-08-13T18:02:22.710Z,1723572142.710 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-08-13T18:02:44.122Z,1723572164.122 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-08-13T18:02:49.386Z,1723572169.386 [CommandExec](IMPORTANT): got command failComponent 2024-08-13T18:02:49.386Z,1723572169.386 [CommandExec](IMPORTANT): Failed components: 2024-08-13T18:02:49.387Z,1723572169.387 [CommandExec](IMPORTANT): WetLabsBB2FL: Communications Fault 2024-08-13T18:02:55.107Z,1723572175.107 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-08-13T18:03:01.494Z,1723572181.494 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-08-13T18:03:09.582Z,1723572189.582 [BPC1](INFO): Calculating totals. Valid battery stick count: 39. Valid reserve battery stick count: 4. 2024-08-13T18:03:09.586Z,1723572189.586 [BPC1](INFO): Received data from all battery sticks. 2024-08-13T18:04:07.035Z,1723572247.035 [CommandExec](IMPORTANT): got command restart application 2024-08-13T18:04:08.038Z,1723572248.038 [Supervisor](INFO): Stop Mission called by Supervisor::terminate 2024-08-13T18:04:08.039Z,1723572248.039 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread. 2024-08-13T18:04:08.040Z,1723572248.040 [CommandExec](INFO): Uninitializing the command executive. 2024-08-13T18:04:08.040Z,1723572248.040 [CommandExec](INFO): Uninitializing the command scheduler. 2024-08-13T18:04:08.041Z,1723572248.041 [CommandExec ThreadHandler](INFO): Thread cancelled. 2024-08-13T18:04:08.221Z,1723572248.221 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2024-08-13T18:04:08.221Z,1723572248.221 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2024-08-13T18:04:08.221Z,1723572248.221 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-08-13T18:04:08.222Z,1723572248.222 [NavChartDb](INFO): Join timeout helper Thread ID is 1141 2024-08-13T18:04:08.501Z,1723572248.501 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2024-08-13T18:04:08.502Z,1723572248.502 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-08-13T18:04:08.509Z,1723572248.509 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler 2024-08-13T18:04:08.515Z,1723572248.515 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2024-08-13T18:04:08.516Z,1723572248.516 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 1142 2024-08-13T18:04:08.677Z,1723572248.677 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread. 2024-08-13T18:04:08.678Z,1723572248.678 [WetLabsBB2FL](INFO): Powering down 2024-08-13T18:04:08.678Z,1723572248.678 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2024-08-13T18:04:08.679Z,1723572248.679 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler 2024-08-13T18:04:08.679Z,1723572248.679 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2024-08-13T18:04:08.679Z,1723572248.679 [CTD_Seabird](INFO): Join timeout helper Thread ID is 1143 2024-08-13T18:04:08.777Z,1723572248.777 [CTD_Seabird](INFO): Powering down 2024-08-13T18:04:08.789Z,1723572248.789 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread. 2024-08-13T18:04:08.790Z,1723572248.790 [CTD_Seabird](INFO): Powering down 2024-08-13T18:04:08.801Z,1723572248.801 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2024-08-13T18:04:08.821Z,1723572248.821 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2024-08-13T18:04:08.821Z,1723572248.821 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-08-13T18:04:08.822Z,1723572248.822 [Radio_Surface](INFO): Join timeout helper Thread ID is 1144 2024-08-13T18:04:09.073Z,1723572249.073 [Radio_Surface](INFO): Powering down 2024-08-13T18:04:09.074Z,1723572249.074 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2024-08-13T18:04:09.075Z,1723572249.075 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-08-13T18:04:09.081Z,1723572249.081 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler 2024-08-13T18:04:09.081Z,1723572249.081 [Onboard ThreadHandler](INFO): Thread cancelled. 2024-08-13T18:04:09.082Z,1723572249.082 [Onboard](INFO): Join timeout helper Thread ID is 1145 2024-08-13T18:04:13.929Z,1723572253.929 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread. 2024-08-13T18:04:13.930Z,1723572253.930 [Onboard ThreadHandler](INFO): Thread cancelled. 2024-08-13T18:04:13.946Z,1723572253.946 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler 2024-08-13T18:04:13.946Z,1723572253.946 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2024-08-13T18:04:13.947Z,1723572253.947 [DataOverHttps](INFO): Join timeout helper Thread ID is 1146 2024-08-13T18:04:14.005Z,1723572254.005 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread. 2024-08-13T18:04:14.008Z,1723572254.008 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2024-08-13T18:04:14.026Z,1723572254.026 [ComponentRegistry](INFO): Shutting down DATMMP ThreadHandler 2024-08-13T18:04:14.026Z,1723572254.026 [DATMMP ThreadHandler](INFO): Thread cancelled. 2024-08-13T18:04:14.027Z,1723572254.027 [DATMMP](INFO): Join timeout helper Thread ID is 1147 2024-08-13T18:04:14.237Z,1723572254.237 [DATMMP](INFO): Stop 2024-08-13T18:04:14.237Z,1723572254.237 [DATMMP](INFO): uninitialize 2024-08-13T18:04:14.237Z,1723572254.237 [DATMMP](INFO): Powering down 2024-08-13T18:04:14.314Z,1723572254.314 [DATMMP ThreadHandler](INFO): Uninitializing protected caller thread. 2024-08-13T18:04:14.314Z,1723572254.314 [DATMMP](INFO): uninitialize 2024-08-13T18:04:14.314Z,1723572254.314 [DATMMP](INFO): Powering down 2024-08-13T18:04:14.315Z,1723572254.315 [DATMMP ThreadHandler](INFO): Thread cancelled. 2024-08-13T18:04:14.318Z,1723572254.318 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler 2024-08-13T18:04:14.318Z,1723572254.318 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2024-08-13T18:04:14.318Z,1723572254.318 [BackseatComponent](INFO): Join timeout helper Thread ID is 1148 2024-08-13T18:04:14.422Z,1723572254.422 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread. 2024-08-13T18:04:14.422Z,1723572254.422 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2024-08-13T18:04:14.447Z,1723572254.447 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2024-08-13T18:04:14.447Z,1723572254.447 [logger ThreadHandler](INFO): Thread cancelled. 2024-08-13T18:04:14.447Z,1723572254.447 [logger](INFO): Join timeout helper Thread ID is 1149 2024-08-13T18:04:14.464Z,1723572254.464 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2024-08-13T18:04:14.464Z,1723572254.464 [logger ThreadHandler](INFO): Thread cancelled. 2024-08-13T18:04:14.466Z,1723572254.466 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2024-08-13T18:04:14.466Z,1723572254.466 [CommandLine ThreadHandler](INFO): Thread cancelled. 2024-08-13T18:04:14.467Z,1723572254.467 [CommandLine](INFO): Join timeout helper Thread ID is 1150 2024-08-13T18:04:14.526Z,1723572254.526 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2024-08-13T18:04:14.526Z,1723572254.526 [CommandLine ThreadHandler](INFO): Thread cancelled. 2024-08-13T18:04:14.546Z,1723572254.546 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler 2024-08-13T18:04:14.546Z,1723572254.546 [CommandExec ThreadHandler](INFO): Thread cancelled. 2024-08-13T18:04:14.546Z,1723572254.546 [CommandExec](INFO): Join timeout helper Thread ID is 1151 2024-08-13T18:04:14.548Z,1723572254.548 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2024-08-13T18:04:14.548Z,1723572254.548 [controlThread ThreadHandler](INFO): Thread cancelled. 2024-08-13T18:04:14.548Z,1723572254.548 [controlThread](INFO): Join timeout helper Thread ID is 1152 2024-08-13T18:04:14.609Z,1723572254.609 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2024-08-13T18:04:14.610Z,1723572254.610 [controlThread](DEBUG): Uninitializing ControlThread 2024-08-13T18:04:14.610Z,1723572254.610 [AHRS_M2](INFO): Powering down 2024-08-13T18:04:14.778Z,1723572254.778 [DVL_micro](INFO): Powering down 2024-08-13T18:04:14.778Z,1723572254.778 [NAL9602](INFO): Powering down 2024-08-13T18:04:14.780Z,1723572254.780 [Sonardyne_Nano](INFO): Powering down 2024-08-13T18:04:14.899Z,1723572254.899 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator. 2024-08-13T18:04:14.900Z,1723572254.900 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator. 2024-08-13T18:04:14.900Z,1723572254.900 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2024-08-13T18:04:14.901Z,1723572254.901 [MissionManager](INFO): Uninitializing Mission Default 2024-08-13T18:04:14.901Z,1723572254.901 [Default] Stopped 2024-08-13T18:04:14.901Z,1723572254.901 [Default](DEBUG): Aggregate::uninitialize Default 2024-08-13T18:04:14.901Z,1723572254.901 [Default:B.GoToSurface] Stopped 2024-08-13T18:04:14.901Z,1723572254.901 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2024-08-13T18:04:14.901Z,1723572254.901 [Default:CheckIn] Stopped 2024-08-13T18:04:14.902Z,1723572254.902 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-08-13T18:04:14.902Z,1723572254.902 [Default:CheckIn:Read_GPS] Stopped 2024-08-13T18:04:14.904Z,1723572254.904 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2024-08-13T18:04:14.905Z,1723572254.905 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2024-08-13T18:04:14.905Z,1723572254.905 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2024-08-13T18:04:14.906Z,1723572254.906 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2024-08-13T18:04:14.906Z,1723572254.906 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2024-08-13T18:04:14.906Z,1723572254.906 [BuoyancyServo](INFO): Powering down 2024-08-13T18:04:14.917Z,1723572254.917 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2024-08-13T18:04:14.918Z,1723572254.918 [ElevatorServo](INFO): Powering down 2024-08-13T18:04:14.918Z,1723572254.918 [MassServo](DEBUG): Uninitialize Mass Servo. 2024-08-13T18:04:14.918Z,1723572254.918 [MassServo](INFO): Powering down 2024-08-13T18:04:14.919Z,1723572254.919 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2024-08-13T18:04:14.919Z,1723572254.919 [RudderServo](INFO): Powering down 2024-08-13T18:04:14.920Z,1723572254.920 [ThrusterHE](DEBUG): Uninitialize Thruster Servo. 2024-08-13T18:04:14.920Z,1723572254.920 [ThrusterHE](INFO): Powering down 2024-08-13T18:04:14.921Z,1723572254.921 [SBIT](DEBUG): Uninitialize SBIT Component. 2024-08-13T18:04:14.922Z,1723572254.922 [IBIT](DEBUG): Uninitialize IBIT Component. 2024-08-13T18:04:14.922Z,1723572254.922 [CBIT](DEBUG): Uninitialize CBIT Component. 2024-08-13T18:04:14.922Z,1723572254.922 [CBIT](DEBUG): Powering off loads. 2024-08-13T18:04:14.933Z,1723572254.933 [CBIT](DEBUG): Disabling WDT. 2024-08-13T18:04:14.945Z,1723572254.945 [CBIT](DEBUG): Opening all GF detection circuits. 2024-08-13T18:04:14.946Z,1723572254.946 [controlThread ThreadHandler](INFO): Thread cancelled. 2024-08-13T18:04:15.003Z,1723572255.003 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-08-13T18:04:15.006Z,1723572255.006 [Onboard ThreadHandler](INFO): Thread cancelled. 2024-08-13T18:04:15.013Z,1723572255.013 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2024-08-13T18:04:15.019Z,1723572255.019 [DATMMP ThreadHandler](INFO): Thread cancelled. 2024-08-13T18:04:15.059Z,1723572255.059 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2024-08-13T18:04:15.114Z,1723572255.114 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2024-08-13T18:04:15.120Z,1723572255.120 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2024-08-13T18:04:15.141Z,1723572255.141 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-08-13T18:04:15.189Z,1723572255.189 [logger ThreadHandler](INFO): Thread cancelled.