2025-01-03T21:40:44.980Z,1735940444.980 [Supervisor](DEBUG): Initializing supervisor. 2025-01-03T21:40:44.985Z,1735940444.985 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2025-01-03T21:40:44.985Z,1735940444.985 [SyncHandler](INFO): Protected caller Thread ID is 322 2025-01-03T21:40:44.986Z,1735940444.986 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2025-01-03T21:40:44.987Z,1735940444.987 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2025-01-03T21:40:44.987Z,1735940444.987 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 323 2025-01-03T21:40:44.991Z,1735940444.991 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2025-01-03T21:40:45.008Z,1735940445.008 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread. 2025-01-03T21:40:45.009Z,1735940445.009 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2025-01-03T21:40:45.010Z,1735940445.010 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 324 2025-01-03T21:40:45.014Z,1735940445.014 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2025-01-03T21:40:45.015Z,1735940445.015 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2025-01-03T21:40:45.015Z,1735940445.015 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 325 2025-01-03T21:40:45.017Z,1735940445.017 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2025-01-03T21:40:45.018Z,1735940445.018 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0 2025-01-03T21:40:45.018Z,1735940445.018 [logger ThreadHandler](INFO): Protected caller Thread ID is 326 2025-01-03T21:40:45.022Z,1735940445.022 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2025-01-03T21:40:45.022Z,1735940445.022 [Supervisor](INFO): Looking for Config files in directory: Config/ 2025-01-03T21:40:45.024Z,1735940445.024 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2025-01-03T21:40:45.296Z,1735940445.296 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2025-01-03T21:40:45.296Z,1735940445.296 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2025-01-03T21:40:45.387Z,1735940445.387 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2025-01-03T21:40:45.902Z,1735940445.902 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2025-01-03T21:40:45.902Z,1735940445.902 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2025-01-03T21:40:46.244Z,1735940446.244 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2025-01-03T21:40:46.244Z,1735940446.244 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2025-01-03T21:40:46.421Z,1735940446.421 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2025-01-03T21:40:46.421Z,1735940446.421 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2025-01-03T21:40:47.138Z,1735940447.138 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2025-01-03T21:40:47.138Z,1735940447.138 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2025-01-03T21:40:47.359Z,1735940447.359 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2025-01-03T21:40:47.360Z,1735940447.360 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2025-01-03T21:40:47.879Z,1735940447.879 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2025-01-03T21:40:47.880Z,1735940447.880 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2025-01-03T21:40:48.025Z,1735940448.025 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2025-01-03T21:40:48.025Z,1735940448.025 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2025-01-03T21:40:48.115Z,1735940448.115 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2025-01-03T21:40:48.939Z,1735940448.939 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2025-01-03T21:40:48.939Z,1735940448.939 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2025-01-03T21:40:49.325Z,1735940449.325 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2025-01-03T21:40:49.325Z,1735940449.325 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2025-01-03T21:40:49.515Z,1735940449.515 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2025-01-03T21:40:49.516Z,1735940449.516 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2025-01-03T21:40:49.637Z,1735940449.637 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2025-01-03T21:40:49.637Z,1735940449.637 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2025-01-03T21:40:49.869Z,1735940449.869 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2025-01-03T21:40:49.870Z,1735940449.870 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg 2025-01-03T21:40:50.124Z,1735940450.124 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock 2025-01-03T21:40:50.126Z,1735940450.126 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-daphne/ 2025-01-03T21:40:50.126Z,1735940450.126 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Simulator.cfg 2025-01-03T21:40:50.223Z,1735940450.223 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Control.cfg 2025-01-03T21:40:50.335Z,1735940450.335 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/secure.cfg 2025-01-03T21:40:50.429Z,1735940450.429 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Servo.cfg 2025-01-03T21:40:50.541Z,1735940450.541 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/BIT.cfg 2025-01-03T21:40:50.644Z,1735940450.644 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/vehicle.cfg 2025-01-03T21:40:50.769Z,1735940450.769 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Sensor.cfg 2025-01-03T21:40:50.929Z,1735940450.929 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Science.cfg 2025-01-03T21:40:51.085Z,1735940451.085 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/logger.cfg 2025-01-03T21:40:51.203Z,1735940451.203 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Battery.cfg 2025-01-03T21:40:51.478Z,1735940451.478 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2025-01-03T21:40:51.480Z,1735940451.480 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-daphne/root/ 2025-01-03T21:40:51.480Z,1735940451.480 [Supervisor](IMPORTANT): Reloading configuration overrides from Data/persisted.cfg 2025-01-03T21:40:51.488Z,1735940451.488 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2025-01-03T21:40:51.785Z,1735940451.785 [VerticalControl](DEBUG): Construct VerticalControl. 2025-01-03T21:40:51.923Z,1735940451.923 [VerticalControl] Loaded 2025-01-03T21:40:51.923Z,1735940451.923 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2025-01-03T21:40:51.926Z,1735940451.926 [HorizontalControl](DEBUG): Construct HorizontalControl. 2025-01-03T21:40:52.061Z,1735940452.061 [HorizontalControl] Loaded 2025-01-03T21:40:52.061Z,1735940452.061 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2025-01-03T21:40:52.076Z,1735940452.076 [SpeedControl](DEBUG): Construct SpeedControl. 2025-01-03T21:40:52.117Z,1735940452.117 [SpeedControl] Loaded 2025-01-03T21:40:52.117Z,1735940452.117 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2025-01-03T21:40:52.120Z,1735940452.120 [LoopControl](DEBUG): Construct LoopControl. 2025-01-03T21:40:52.120Z,1735940452.120 [LoopControl] Loaded 2025-01-03T21:40:52.121Z,1735940452.121 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2025-01-03T21:40:52.121Z,1735940452.121 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2025-01-03T21:40:52.121Z,1735940452.121 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2025-01-03T21:40:52.131Z,1735940452.131 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2025-01-03T21:40:52.132Z,1735940452.132 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2025-01-03T21:40:52.451Z,1735940452.451 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2025-01-03T21:40:52.451Z,1735940452.451 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2025-01-03T21:40:52.606Z,1735940452.606 [BuoyancyServo] Loaded 2025-01-03T21:40:52.607Z,1735940452.607 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2025-01-03T21:40:52.628Z,1735940452.628 [ElevatorServo] Loaded 2025-01-03T21:40:52.629Z,1735940452.629 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2025-01-03T21:40:52.649Z,1735940452.649 [MassServo] Loaded 2025-01-03T21:40:52.649Z,1735940452.649 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2025-01-03T21:40:52.669Z,1735940452.669 [RudderServo] Loaded 2025-01-03T21:40:52.670Z,1735940452.670 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2025-01-03T21:40:52.686Z,1735940452.686 [ThrusterHE] Loaded 2025-01-03T21:40:52.686Z,1735940452.686 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread. 2025-01-03T21:40:52.686Z,1735940452.686 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2025-01-03T21:40:52.687Z,1735940452.687 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2025-01-03T21:40:52.798Z,1735940452.798 [DeadReckonUsingMultipleVelocitySources] Loaded 2025-01-03T21:40:52.798Z,1735940452.798 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2025-01-03T21:40:52.811Z,1735940452.811 [NavChart] Loaded 2025-01-03T21:40:52.812Z,1735940452.812 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2025-01-03T21:40:52.817Z,1735940452.817 [UniversalFixResidualReporter] Loaded 2025-01-03T21:40:52.817Z,1735940452.817 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2025-01-03T21:40:52.818Z,1735940452.818 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2025-01-03T21:40:52.818Z,1735940452.818 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2025-01-03T21:40:52.874Z,1735940452.874 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2025-01-03T21:40:52.874Z,1735940452.874 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2025-01-03T21:40:53.322Z,1735940453.322 [AHRS_M2] Loaded 2025-01-03T21:40:53.322Z,1735940453.322 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread. 2025-01-03T21:40:54.140Z,1735940454.140 [BPC1] Loaded 2025-01-03T21:40:54.140Z,1735940454.140 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2025-01-03T21:40:54.211Z,1735940454.211 [DataOverHttps] Loaded 2025-01-03T21:40:54.212Z,1735940454.212 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread. 2025-01-03T21:40:54.213Z,1735940454.213 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 409454E0 2025-01-03T21:40:54.213Z,1735940454.213 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 407 2025-01-03T21:40:54.236Z,1735940454.236 [Depth_Keller] Loaded 2025-01-03T21:40:54.236Z,1735940454.236 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2025-01-03T21:40:54.241Z,1735940454.241 [DropWeight] Loaded 2025-01-03T21:40:54.241Z,1735940454.241 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread. 2025-01-03T21:40:54.304Z,1735940454.304 [NAL9602] Loaded 2025-01-03T21:40:54.304Z,1735940454.304 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2025-01-03T21:40:54.333Z,1735940454.333 [Onboard] Loaded 2025-01-03T21:40:54.334Z,1735940454.334 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread. 2025-01-03T21:40:54.335Z,1735940454.335 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 409754E0 2025-01-03T21:40:54.335Z,1735940454.335 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 408 2025-01-03T21:40:54.350Z,1735940454.350 [Power24vConverter] Loaded 2025-01-03T21:40:54.350Z,1735940454.350 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread. 2025-01-03T21:40:54.366Z,1735940454.366 [Radio_Surface] Loaded 2025-01-03T21:40:54.366Z,1735940454.366 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2025-01-03T21:40:54.367Z,1735940454.367 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 409A54E0 2025-01-03T21:40:54.368Z,1735940454.368 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 409 2025-01-03T21:40:54.382Z,1735940454.382 [Sonardyne_Nano] Loaded 2025-01-03T21:40:54.383Z,1735940454.383 [ComponentRegistry](DEBUG): SyncComponent "Sonardyne_Nano" handled in the control thread. 2025-01-03T21:40:54.383Z,1735940454.383 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2025-01-03T21:40:54.384Z,1735940454.384 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2025-01-03T21:40:54.434Z,1735940454.434 [DepthRateCalculator] Loaded 2025-01-03T21:40:54.434Z,1735940454.434 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2025-01-03T21:40:54.439Z,1735940454.439 [PitchRateCalculator] Loaded 2025-01-03T21:40:54.439Z,1735940454.439 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2025-01-03T21:40:54.448Z,1735940454.448 [SpeedCalculator] Loaded 2025-01-03T21:40:54.448Z,1735940454.448 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2025-01-03T21:40:54.452Z,1735940454.452 [YawRateCalculator] Loaded 2025-01-03T21:40:54.452Z,1735940454.452 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2025-01-03T21:40:54.471Z,1735940454.471 [ElevatorOffsetCalculator] Loaded 2025-01-03T21:40:54.471Z,1735940454.471 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread. 2025-01-03T21:40:54.472Z,1735940454.472 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2025-01-03T21:40:54.472Z,1735940454.472 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2025-01-03T21:40:54.605Z,1735940454.605 [CANONSampler] Loaded 2025-01-03T21:40:54.606Z,1735940454.606 [ComponentRegistry](DEBUG): SyncComponent "CANONSampler" handled in the control thread. 2025-01-03T21:40:54.668Z,1735940454.668 [CTD_Seabird] Loaded 2025-01-03T21:40:54.668Z,1735940454.668 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread. 2025-01-03T21:40:54.669Z,1735940454.669 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40A614E0 2025-01-03T21:40:54.670Z,1735940454.670 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 410 2025-01-03T21:40:54.692Z,1735940454.692 [PAR_Licor] Loaded 2025-01-03T21:40:54.692Z,1735940454.692 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread. 2025-01-03T21:40:54.736Z,1735940454.736 [WetLabsBB2FL] Loaded 2025-01-03T21:40:54.737Z,1735940454.737 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread. 2025-01-03T21:40:54.738Z,1735940454.738 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40A914E0 2025-01-03T21:40:54.738Z,1735940454.738 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 411 2025-01-03T21:40:54.739Z,1735940454.739 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2025-01-03T21:40:54.739Z,1735940454.739 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2025-01-03T21:40:54.765Z,1735940454.765 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2025-01-03T21:40:54.766Z,1735940454.766 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2025-01-03T21:40:55.096Z,1735940455.096 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2025-01-03T21:40:55.097Z,1735940455.097 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2025-01-03T21:40:55.236Z,1735940455.236 [SBIT](DEBUG): Construct Startup Built In Test. 2025-01-03T21:40:55.245Z,1735940455.245 [SBIT] Loaded 2025-01-03T21:40:55.245Z,1735940455.245 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2025-01-03T21:40:55.248Z,1735940455.248 [IBIT](DEBUG): Construct Initiated Built In Test. 2025-01-03T21:40:55.260Z,1735940455.260 [IBIT] Loaded 2025-01-03T21:40:55.260Z,1735940455.260 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2025-01-03T21:40:55.266Z,1735940455.266 [CBIT](DEBUG): Construct Continuous Built In Test. 2025-01-03T21:40:55.368Z,1735940455.368 [CBIT] Loaded 2025-01-03T21:40:55.369Z,1735940455.369 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2025-01-03T21:40:55.369Z,1735940455.369 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2025-01-03T21:40:55.370Z,1735940455.370 [Module Loader](DEBUG): Loading Module at Modules/Dock.so 2025-01-03T21:40:55.500Z,1735940455.500 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking) 2025-01-03T21:40:55.506Z,1735940455.506 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2025-01-03T21:40:55.509Z,1735940455.509 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2025-01-03T21:40:55.520Z,1735940455.520 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2025-01-03T21:40:55.521Z,1735940455.521 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40BF04E0 2025-01-03T21:40:55.522Z,1735940455.522 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 412 2025-01-03T21:40:55.526Z,1735940455.526 [Supervisor](INFO): Main Thread ID is 9859 2025-01-03T21:40:55.526Z,1735940455.526 [Supervisor](DEBUG): Running supervisor. 2025-01-03T21:40:55.527Z,1735940455.527 [CommandExec ThreadHandler](INFO): Handler Thread ID is 413 2025-01-03T21:40:55.527Z,1735940455.527 [CommandExec](INFO): Initializing the command executive. 2025-01-03T21:40:55.529Z,1735940455.529 [CommandLine ThreadHandler](INFO): Handler Thread ID is 414 2025-01-03T21:40:55.531Z,1735940455.531 [controlThread ThreadHandler](INFO): Handler Thread ID is 416 2025-01-03T21:40:55.531Z,1735940455.531 [controlThread](DEBUG): Initializing ControlThread 2025-01-03T21:40:55.532Z,1735940455.532 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2025-01-03T21:40:55.534Z,1735940455.534 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2025-01-03T21:40:55.535Z,1735940455.535 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2025-01-03T21:40:55.535Z,1735940455.535 [LoopControl](DEBUG): Initialize LoopControlComponent. 2025-01-03T21:40:55.537Z,1735940455.537 [NavChart](DEBUG): Initialize NavChart Navigation. 2025-01-03T21:40:55.537Z,1735940455.537 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2025-01-03T21:40:55.541Z,1735940455.541 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2025-01-03T21:40:55.542Z,1735940455.542 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2025-01-03T21:40:55.542Z,1735940455.542 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2025-01-03T21:40:55.542Z,1735940455.542 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2025-01-03T21:40:55.542Z,1735940455.542 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator. 2025-01-03T21:40:55.548Z,1735940455.548 [SBIT](INFO): Initialize SBIT Component. 2025-01-03T21:40:55.548Z,1735940455.548 [SBIT](IMPORTANT): git: 2024-12-16_A 2025-01-03T21:40:55.548Z,1735940455.548 [SBIT](INFO): git hash: a38fa438d441bb7a1ccbf8550a844b4104921e5e 2025-01-03T21:40:55.549Z,1735940455.549 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2025-01-03T21:40:55.550Z,1735940455.550 [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 2025-01-03T21:40:55.551Z,1735940455.551 [SBIT](INFO): Beginning SBIT in 49.000000 seconds. 2025-01-03T21:40:55.552Z,1735940455.552 [IBIT](INFO): Initialize IBIT Component. 2025-01-03T21:40:55.552Z,1735940455.552 [CBIT](DEBUG): Initialize CBIT Component. 2025-01-03T21:40:55.553Z,1735940455.553 [logger ThreadHandler](INFO): Handler Thread ID is 417 2025-01-03T21:40:55.563Z,1735940455.563 [CBIT](DEBUG): Initialized mux pins. 2025-01-03T21:40:55.563Z,1735940455.563 [CBIT](DEBUG): Initializing the watchdog timer. 2025-01-03T21:40:55.572Z,1735940455.572 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 418 2025-01-03T21:40:55.574Z,1735940455.574 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2025-01-03T21:40:55.584Z,1735940455.584 [Onboard ThreadHandler](INFO): Handler Thread ID is 419 2025-01-03T21:40:55.588Z,1735940455.588 [CBIT](INFO): Last reboot was NOT due to watchdog timer. 2025-01-03T21:40:55.588Z,1735940455.588 [CBIT](DEBUG): Initializing heartbeat. 2025-01-03T21:40:55.604Z,1735940455.604 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 420 2025-01-03T21:40:55.620Z,1735940455.620 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 421 2025-01-03T21:40:55.620Z,1735940455.620 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2025-01-03T21:40:55.625Z,1735940455.625 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 423 2025-01-03T21:40:55.628Z,1735940455.628 [WetLabsBB2FL](INFO): Powering up 2025-01-03T21:40:55.629Z,1735940455.629 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 425 2025-01-03T21:40:55.633Z,1735940455.633 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000 2025-01-03T21:40:55.633Z,1735940455.633 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000 2025-01-03T21:40:55.633Z,1735940455.633 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000 2025-01-03T21:40:55.633Z,1735940455.633 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000 2025-01-03T21:40:55.633Z,1735940455.633 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000 2025-01-03T21:40:55.634Z,1735940455.634 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000 2025-01-03T21:40:55.634Z,1735940455.634 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000 2025-01-03T21:40:55.634Z,1735940455.634 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000 2025-01-03T21:40:55.659Z,1735940455.659 [CBIT](DEBUG): Deactivating GF circuits. 2025-01-03T21:40:55.660Z,1735940455.660 [CBIT](DEBUG): Deactivating emergency mode. 2025-01-03T21:40:55.699Z,1735940455.699 [CBIT](DEBUG): Backplane powered. 2025-01-03T21:40:55.700Z,1735940455.700 [MissionManager](IMPORTANT): Using TethysL tl-to-tx parser 2025-01-03T21:40:55.701Z,1735940455.701 [MissionManager](INFO): Loading Mission from file: Missions/Startup.tl 2025-01-03T21:40:55.701Z,1735940455.701 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Startup.tl 2025-01-03T21:40:55.702Z,1735940455.702 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Startup.tl 2025-01-03T21:40:55.746Z,1735940455.746 [MissionManager](DEBUG): TethyslAPI: Missions/Startup.tl translated into: 2025-01-03T21:40:55.752Z,1735940455.752 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2025-01-03T21:40:55.772Z,1735940455.772 [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 } } } 2025-01-03T21:40:55.773Z,1735940455.773 [MissionManager](INFO): Loading Mission from file: Missions/Default.tl 2025-01-03T21:40:55.773Z,1735940455.773 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Default.tl 2025-01-03T21:40:55.774Z,1735940455.774 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Default.tl 2025-01-03T21:40:56.007Z,1735940456.007 [Radio_Surface](INFO): Powering up 2025-01-03T21:40:56.127Z,1735940456.127 [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 2025-01-03T21:40:56.156Z,1735940456.156 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min 2025-01-03T21:40:56.158Z,1735940456.158 [Default:A.Wait](DEBUG): Construct Wait. 2025-01-03T21:40:56.160Z,1735940456.160 [Default:B.GoToSurface](DEBUG): Construct GoToSurface. 2025-01-03T21:40:56.206Z,1735940456.206 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2025-01-03T21:40:56.225Z,1735940456.225 [Default:CheckIn:C.Wait](DEBUG): Construct Wait. 2025-01-03T21:40:56.235Z,1735940456.235 [Default:E.Execute](DEBUG): Construct Execute. 2025-01-03T21:40:56.238Z,1735940456.238 [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" } } 2025-01-03T21:40:56.243Z,1735940456.243 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,DropWeight,NAL9602,Power24vConverter,Sonardyne_Nano,CANONSampler,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,Reporter,LogSplitter, 2025-01-03T21:40:56.256Z,1735940456.256 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2025-01-03T21:40:56.326Z,1735940456.326 [Power24vConverter](INFO): Powering up. 2025-01-03T21:40:56.326Z,1735940456.326 [Sonardyne_Nano](INFO): Initializing. 2025-01-03T21:40:56.344Z,1735940456.344 [CANONSampler](INFO): Powering down 2025-01-03T21:40:56.382Z,1735940456.382 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2025-01-03T21:40:56.388Z,1735940456.388 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2025-01-03T21:40:56.389Z,1735940456.389 [ElevatorServo](DEBUG): Initializing EZServoServo. 2025-01-03T21:40:56.396Z,1735940456.396 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2025-01-03T21:40:56.397Z,1735940456.397 [MassServo](DEBUG): Initializing EZServoServo. 2025-01-03T21:40:56.404Z,1735940456.404 [MassServo](DEBUG): Initializing MassServo. 2025-01-03T21:40:56.404Z,1735940456.404 [RudderServo](DEBUG): Initializing EZServoServo. 2025-01-03T21:40:56.412Z,1735940456.412 [RudderServo](DEBUG): Initializing RudderServo. 2025-01-03T21:40:56.413Z,1735940456.413 [ThrusterHE](DEBUG): Initializing EZServoServo. 2025-01-03T21:40:56.420Z,1735940456.420 [ThrusterHE](DEBUG): Initializing ThrusterHE. 2025-01-03T21:40:56.694Z,1735940456.694 [DropWeight](CRITICAL): DROP WEIGHT MISSING. 2025-01-03T21:40:56.695Z,1735940456.695 [DropWeight] Hardware Fault, FailCount= 1 2025-01-03T21:40:56.695Z,1735940456.695 [DropWeight](ERROR): Hardware Fault 2025-01-03T21:40:56.733Z,1735940456.733 [CommandExec](FAULT): Scheduling is paused 2025-01-03T21:40:56.733Z,1735940456.733 [CBIT](INFO): Critical error at 20250103T214056 2025-01-03T21:40:56.733Z,1735940456.733 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals 2025-01-03T21:40:56.744Z,1735940456.744 [CBIT](ERROR): Hardware Fault in component: DropWeight 2025-01-03T21:40:56.744Z,1735940456.744 [CBIT](CRITICAL): Hardware Fault in component: DropWeight 2025-01-03T21:40:57.080Z,1735940457.080 [CBIT](INFO): Critical error at 20250103T214056 2025-01-03T21:40:58.240Z,1735940458.240 [WetLabsBB2FL](INFO): Powering down 2025-01-03T21:40:58.273Z,1735940458.273 [Sonardyne_Nano](ERROR): Failed to get valid response or reached max queue size, flushing UART 2025-01-03T21:40:59.560Z,1735940459.560 [Sonardyne_Nano](IMPORTANT): Found beacon with acoustic ID 2109 2025-01-03T21:41:24.593Z,1735940484.593 [NAL9602](INFO): Powering up NAL9602 2025-01-03T21:41:35.501Z,1735940495.501 [NAL9602](INFO): NAL9602 initialized 2025-01-03T21:41:38.057Z,1735940498.057 [CommandExec](IMPORTANT): got command strobe off 2025-01-03T21:41:38.057Z,1735940498.057 [CommandExec](IMPORTANT): Deactivating strobe 2025-01-03T21:41:45.231Z,1735940505.231 [SBIT](IMPORTANT): Beginning Startup BIT 2025-01-03T21:41:45.251Z,1735940505.251 [CBIT](IMPORTANT): Beginning ground fault scan 2025-01-03T21:41:46.281Z,1735940506.281 [CommandExec](IMPORTANT): got command strobe off 2025-01-03T21:41:46.281Z,1735940506.281 [CommandExec](IMPORTANT): Deactivating strobe 2025-01-03T21:41:50.341Z,1735940510.341 [CommandExec](IMPORTANT): got command strobe off 2025-01-03T21:41:50.341Z,1735940510.341 [CommandExec](IMPORTANT): Deactivating strobe 2025-01-03T21:41:56.975Z,1735940516.975 [CBIT](ERROR): Ground fault scan returned out of bounds value. Re-running scan. 2025-01-03T21:41:57.377Z,1735940517.377 [CBIT](IMPORTANT): Beginning ground fault scan 2025-01-03T21:42:08.045Z,1735940528.045 [CBIT](ERROR): Ground fault scan returned out of bounds value. Re-running scan. 2025-01-03T21:42:08.453Z,1735940528.453 [CBIT](IMPORTANT): Beginning ground fault scan 2025-01-03T21:42:12.197Z,1735940532.197 [CommandExec](IMPORTANT): got command strobe off 2025-01-03T21:42:12.197Z,1735940532.197 [CommandExec](IMPORTANT): Deactivating strobe 2025-01-03T21:42:15.422Z,1735940535.422 [CommandExec](IMPORTANT): got command strobe off 2025-01-03T21:42:15.422Z,1735940535.422 [CommandExec](IMPORTANT): Deactivating strobe 2025-01-03T21:42:19.197Z,1735940539.197 [CBIT](IMPORTANT): No ground fault detected mA: CHAN A0 (Batt): 0.001494 CHAN A1 (24V): 0.000587 CHAN A2 (12V): -0.002469 CHAN A3 (5V): -0.001569 CHAN B0 (3.3V): -0.000293 CHAN B1 (3.15aV): -0.000069 CHAN B2 (3.15bV): -0.000173 CHAN B3 (GND): -0.000241 OPEN: -0.000145 Full Scale: +/- 1 mA 2025-01-03T21:42:22.605Z,1735940542.605 [CommandExec](IMPORTANT): got command strobe off 2025-01-03T21:42:22.605Z,1735940542.605 [CommandExec](IMPORTANT): Deactivating strobe 2025-01-03T21:42:39.402Z,1735940559.402 [SBIT](IMPORTANT): SBIT PASSED 2025-01-03T21:42:39.402Z,1735940559.402 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg 2025-01-03T21:42:39.403Z,1735940559.403 [SBIT](IMPORTANT): BPC1.batteryMissingStickThreshold=11 count; 2025-01-03T21:42:39.403Z,1735940559.403 [SBIT](IMPORTANT): DAT.loadAtStartup=0 bool; 2025-01-03T21:42:39.403Z,1735940559.403 [SBIT](IMPORTANT): DATMMP.loadAtStartup=1 bool; 2025-01-03T21:42:39.404Z,1735940559.404 [SBIT](IMPORTANT): DATMMP.simulateHardware=0 bool; 2025-01-03T21:42:39.404Z,1735940559.404 [SBIT](IMPORTANT): DATMMP.surfaceThreshold=2 meter; 2025-01-03T21:42:39.404Z,1735940559.404 [SBIT](IMPORTANT): Express linearApproximation DATMMP.acoustic_contact_range 15.000000 meter; 2025-01-03T21:42:39.404Z,1735940559.404 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=292.731903 cubic_centimeter; 2025-01-03T21:42:39.404Z,1735940559.404 [SBIT](IMPORTANT): VerticalControl.massDefault=7.465234 millimeter; 2025-01-03T21:42:39.805Z,1735940559.805 [MissionManager](IMPORTANT): Started mission Startup 2025-01-03T21:42:39.805Z,1735940559.805 [Startup] Running Loop=1 2025-01-03T21:42:39.805Z,1735940559.805 [Startup](DEBUG): Aggregate::initialize Startup 2025-01-03T21:42:39.805Z,1735940559.805 [Startup:A.GoToSurface] Running Loop=1 2025-01-03T21:42:39.805Z,1735940559.805 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2025-01-03T21:42:39.806Z,1735940559.806 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2025-01-03T21:42:39.806Z,1735940559.806 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2025-01-03T21:42:39.807Z,1735940559.807 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2025-01-03T21:42:39.807Z,1735940559.807 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2025-01-03T21:42:39.807Z,1735940559.807 [Startup:A.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds. 2025-01-03T21:42:39.808Z,1735940559.808 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2025-01-03T21:42:39.810Z,1735940559.810 [Startup:StartupSatComms] Running Loop=1 2025-01-03T21:42:39.810Z,1735940559.810 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms 2025-01-03T21:42:39.810Z,1735940559.810 [Startup:StartupSatComms:A] Running Loop=1 2025-01-03T21:42:40.207Z,1735940560.207 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix 2025-01-03T21:43:38.569Z,1735940618.569 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004610 2025-01-03T21:43:40.009Z,1735940620.009 [Startup:StartupSatComms:A](INFO): Timed out from 2025-01-03T21:42:39.8Z 2025-01-03T21:43:40.009Z,1735940620.009 [Startup:StartupSatComms:A] Stopped 2025-01-03T21:43:40.009Z,1735940620.009 [Startup:StartupSatComms:B] Running Loop=1 2025-01-03T21:43:40.402Z,1735940620.402 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications 2025-01-03T21:43:46.509Z,1735940626.509 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-01-03T21:43:46.807Z,1735940626.807 [DataOverHttps](INFO): Sending 50 bytes from file Logs/20250103T184756/Courier0052.lzma 2025-01-03T21:43:47.809Z,1735940627.809 [DataOverHttps](INFO): Moved sent file to Logs/20250103T184756/Courier0052.lzma.bak 2025-01-03T21:43:47.810Z,1735940627.810 [DataOverHttps](INFO): SBD MOMSN=23875495 2025-01-03T21:43:55.779Z,1735940635.779 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1 2025-01-03T21:43:55.779Z,1735940635.779 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-01-03T21:43:55.806Z,1735940635.806 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-01-03T21:43:56.174Z,1735940636.174 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-01-03T21:43:56.174Z,1735940636.174 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1 2025-01-03T21:43:59.483Z,1735940639.483 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-01-03T21:44:03.379Z,1735940643.379 [DataOverHttps](INFO): Sending 244 bytes from file Logs/20250103T214044/Courier0000.lzma 2025-01-03T21:44:04.381Z,1735940644.381 [DataOverHttps](INFO): Moved sent file to Logs/20250103T214044/Courier0000.lzma.bak 2025-01-03T21:44:04.381Z,1735940644.381 [DataOverHttps](INFO): SBD MOMSN=23875497 2025-01-03T21:44:19.939Z,1735940659.939 [DataOverHttps](INFO): Sending 144 bytes from file Logs/20250103T184756/Express0053.lzma 2025-01-03T21:44:20.946Z,1735940660.946 [DataOverHttps](INFO): Moved sent file to Logs/20250103T184756/Express0053.lzma.bak 2025-01-03T21:44:20.946Z,1735940660.946 [DataOverHttps](INFO): SBD MOMSN=23875502 2025-01-03T21:44:36.480Z,1735940676.480 [DataOverHttps](INFO): Sending 987 bytes from file Logs/20250103T214044/Express0001.lzma 2025-01-03T21:44:37.481Z,1735940677.481 [DataOverHttps](INFO): Moved sent file to Logs/20250103T214044/Express0001.lzma.bak 2025-01-03T21:44:37.481Z,1735940677.481 [DataOverHttps](INFO): SBD MOMSN=23875506 2025-01-03T21:44:39.001Z,1735940679.001 [Startup:StartupSatComms:B] Stopped 2025-01-03T21:44:39.002Z,1735940679.002 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms 2025-01-03T21:44:39.002Z,1735940679.002 [Startup:StartupSatComms] Stopped 2025-01-03T21:44:39.002Z,1735940679.002 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms 2025-01-03T21:44:39.003Z,1735940679.003 [Startup](INFO): Completed Startup 2025-01-03T21:44:39.003Z,1735940679.003 [MissionManager](INFO): Startup is completed. 2025-01-03T21:44:39.003Z,1735940679.003 [MissionManager](INFO): Uninitializing Mission Startup 2025-01-03T21:44:39.003Z,1735940679.003 [Startup] Stopped 2025-01-03T21:44:39.003Z,1735940679.003 [Startup](DEBUG): Aggregate::uninitialize Startup 2025-01-03T21:44:39.004Z,1735940679.004 [Startup:A.GoToSurface] Stopped 2025-01-03T21:44:39.004Z,1735940679.004 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2025-01-03T21:44:39.405Z,1735940679.405 [MissionManager](IMPORTANT): Started mission Default 2025-01-03T21:44:39.405Z,1735940679.405 [Default] Running Loop=1 2025-01-03T21:44:39.405Z,1735940679.405 [Default](DEBUG): Aggregate::initialize Default 2025-01-03T21:44:39.405Z,1735940679.405 [Default:B.GoToSurface] Running Loop=1 2025-01-03T21:44:39.405Z,1735940679.405 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2025-01-03T21:44:39.405Z,1735940679.405 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2025-01-03T21:44:39.406Z,1735940679.406 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2025-01-03T21:44:39.406Z,1735940679.406 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2025-01-03T21:44:39.406Z,1735940679.406 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2025-01-03T21:44:39.407Z,1735940679.407 [Default:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds. 2025-01-03T21:44:39.407Z,1735940679.407 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2025-01-03T21:44:39.407Z,1735940679.407 [Default:A.Wait] Running Loop=1 2025-01-03T21:44:39.407Z,1735940679.407 [Default:A.Wait](DEBUG): Initialize Wait Component. 2025-01-03T21:44:52.724Z,1735940692.724 [Default:A.Wait](INFO): Done Waiting. 2025-01-03T21:44:52.724Z,1735940692.724 [Default:A.Wait] Stopped 2025-01-03T21:44:52.724Z,1735940692.724 [Default:A.Wait](DEBUG): Uninitialize Wait Component. 2025-01-03T21:44:53.122Z,1735940693.122 [Default:CheckIn] Running Loop=1 2025-01-03T21:44:53.122Z,1735940693.122 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-01-03T21:44:53.122Z,1735940693.122 [Default:CheckIn:Read_GPS] Running Loop=1 2025-01-03T21:44:53.525Z,1735940693.525 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix 2025-01-03T21:46:30.917Z,1735940790.917 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-01-03T21:46:39.365Z,1735940799.365 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2025-01-03T21:46:41.910Z,1735940801.910 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-01-03T21:46:52.758Z,1735940812.758 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-01-03T21:46:56.761Z,1735940816.761 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2 2025-01-03T21:46:56.761Z,1735940816.761 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-01-03T21:46:56.772Z,1735940816.772 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-01-03T21:46:57.185Z,1735940817.185 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-01-03T21:46:57.185Z,1735940817.185 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2 2025-01-03T21:47:03.670Z,1735940823.670 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-01-03T21:47:14.633Z,1735940834.633 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-01-03T21:47:25.490Z,1735940845.490 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-01-03T21:47:36.391Z,1735940856.391 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-01-03T21:47:47.704Z,1735940867.704 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-01-03T21:47:49.309Z,1735940869.309 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-01-03T21:47:58.604Z,1735940878.604 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-01-03T21:48:00.237Z,1735940880.237 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-01-03T21:48:09.520Z,1735940889.520 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-01-03T21:48:11.139Z,1735940891.139 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-01-03T21:48:20.430Z,1735940900.430 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-01-03T21:48:22.047Z,1735940902.047 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-01-03T21:48:31.337Z,1735940911.337 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-01-03T21:48:32.954Z,1735940912.954 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-01-03T21:48:42.245Z,1735940922.245 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-01-03T21:48:43.908Z,1735940923.908 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-01-03T21:48:54.755Z,1735940934.755 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-01-03T21:48:55.173Z,1735940935.173 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-01-03T21:49:06.097Z,1735940946.097 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-01-03T21:49:06.098Z,1735940946.098 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7). 2025-01-03T21:49:12.068Z,1735940952.068 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7). 2025-01-03T21:49:16.993Z,1735940956.993 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-01-03T21:49:27.894Z,1735940967.894 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-01-03T21:49:31.063Z,1735940971.063 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7). 2025-01-03T21:49:39.209Z,1735940979.209 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-01-03T21:49:50.114Z,1735940990.114 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-01-03T21:49:50.465Z,1735940990.465 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7). 2025-01-03T21:49:53.310Z,1735940993.310 [Default:CheckIn:Read_GPS](INFO): Timed out from 2025-01-03T21:44:53.1Z 2025-01-03T21:49:53.310Z,1735940993.310 [Default:CheckIn:Read_GPS] Stopped 2025-01-03T21:49:53.310Z,1735940993.310 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-01-03T21:49:53.702Z,1735940993.702 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications 2025-01-03T21:49:57.745Z,1735940997.745 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3 2025-01-03T21:49:57.745Z,1735940997.745 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-01-03T21:49:57.800Z,1735940997.800 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-01-03T21:49:58.169Z,1735940998.169 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-01-03T21:49:58.170Z,1735940998.170 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3 2025-01-03T21:50:00.443Z,1735941000.443 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20250103T214044/Courier0004.lzma 2025-01-03T21:50:01.026Z,1735941001.026 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-01-03T21:50:01.445Z,1735941001.445 [DataOverHttps](INFO): Moved sent file to Logs/20250103T214044/Courier0004.lzma.bak 2025-01-03T21:50:01.446Z,1735941001.446 [DataOverHttps](INFO): SBD MOMSN=23875549 2025-01-03T21:50:07.856Z,1735941007.856 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7). 2025-01-03T21:50:12.022Z,1735941012.022 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-01-03T21:50:22.631Z,1735941022.631 [DataOverHttps](INFO): Sending 187 bytes from file Logs/20250103T214044/Express0005.lzma 2025-01-03T21:50:23.633Z,1735941023.633 [DataOverHttps](INFO): Moved sent file to Logs/20250103T214044/Express0005.lzma.bak 2025-01-03T21:50:23.633Z,1735941023.633 [DataOverHttps](INFO): SBD MOMSN=23875553 2025-01-03T21:50:24.870Z,1735941024.870 [Default:CheckIn:Read_Iridium] Stopped 2025-01-03T21:50:24.870Z,1735941024.870 [Default:CheckIn:C.Wait] Running Loop=1 2025-01-03T21:50:24.870Z,1735941024.870 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-01-03T21:50:27.269Z,1735941027.269 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7). 2025-01-03T21:50:47.064Z,1735941047.064 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7). 2025-01-03T21:50:57.200Z,1735941057.200 [Power24vConverter](INFO): Powering down. 2025-01-03T21:51:05.244Z,1735941065.244 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7). 2025-01-03T21:51:37.573Z,1735941097.573 [NAL9602](FAULT): GPS failed to acquire within timeout. 2025-01-03T21:51:37.573Z,1735941097.573 [NAL9602] Data Fault, FailCount= 1 2025-01-03T21:51:37.573Z,1735941097.573 [NAL9602](ERROR): Data Fault 2025-01-03T21:51:37.619Z,1735941097.619 [CBIT](ERROR): Data Fault in component: NAL9602 2025-01-03T21:51:37.976Z,1735941097.976 [NAL9602](INFO): Powering down 2025-01-03T21:51:38.807Z,1735941098.807 [CBIT](INFO): Clearing failed state for component NAL9602 2025-01-03T21:51:38.807Z,1735941098.807 [NAL9602] No Fault, FailCount= 1 2025-01-03T21:52:08.277Z,1735941128.277 [NAL9602](INFO): Powering up NAL9602 2025-01-03T21:52:19.189Z,1735941139.189 [NAL9602](INFO): NAL9602 initialized 2025-01-03T21:52:58.797Z,1735941178.797 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4 2025-01-03T21:52:58.797Z,1735941178.797 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-01-03T21:52:58.816Z,1735941178.816 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-01-03T21:52:59.222Z,1735941179.222 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-01-03T21:52:59.222Z,1735941179.222 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4 2025-01-03T21:52:59.655Z,1735941179.655 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-01-03T21:53:11.356Z,1735941191.356 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-01-03T21:53:57.812Z,1735941237.812 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-01-03T21:55:25.436Z,1735941325.436 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2025-01-03T21:55:25.437Z,1735941325.437 [Default:CheckIn:C.Wait] Stopped 2025-01-03T21:55:25.437Z,1735941325.437 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-01-03T21:55:25.437Z,1735941325.437 [Default:CheckIn:D] Running Loop=1 2025-01-03T21:55:25.841Z,1735941325.841 [Default:CheckIn:D] Stopped 2025-01-03T21:55:25.842Z,1735941325.842 [Default:CheckIn:E] Running Loop=1 2025-01-03T21:55:26.258Z,1735941326.258 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 10.773941 min 2025-01-03T21:55:26.259Z,1735941326.259 [Default:CheckIn:E] Stopped 2025-01-03T21:55:26.259Z,1735941326.259 [Default:CheckIn](INFO): Completed Default:CheckIn 2025-01-03T21:55:26.259Z,1735941326.259 [Default:CheckIn] Stopped 2025-01-03T21:55:26.259Z,1735941326.259 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-01-03T21:55:26.259Z,1735941326.259 [Default:CheckIn](INFO): Running loop #2 2025-01-03T21:55:26.259Z,1735941326.259 [Default:CheckIn] Running Loop=2 2025-01-03T21:55:26.260Z,1735941326.260 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-01-03T21:55:26.260Z,1735941326.260 [Default:CheckIn:Read_GPS] Running Loop=1 2025-01-03T21:55:56.980Z,1735941356.980 [CBIT](INFO): Clearing failed state for component DropWeight 2025-01-03T21:55:56.980Z,1735941356.980 [DropWeight] No Fault, FailCount= 1 2025-01-03T21:55:59.776Z,1735941359.776 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 5 2025-01-03T21:55:59.776Z,1735941359.776 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-01-03T21:55:59.787Z,1735941359.787 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-01-03T21:56:00.277Z,1735941360.277 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-01-03T21:56:00.277Z,1735941360.277 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 5 2025-01-03T21:56:11.553Z,1735941371.553 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-01-03T21:56:22.482Z,1735941382.482 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-01-03T21:56:33.447Z,1735941393.447 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-01-03T21:56:44.355Z,1735941404.355 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-01-03T21:56:55.263Z,1735941415.263 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-01-03T21:57:06.532Z,1735941426.532 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-01-03T21:57:17.420Z,1735941437.420 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-01-03T21:57:20.658Z,1735941440.658 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-01-03T21:57:28.338Z,1735941448.338 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-01-03T21:57:31.563Z,1735941451.563 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-01-03T21:57:39.642Z,1735941459.642 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-01-03T21:57:42.875Z,1735941462.875 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-01-03T21:57:50.957Z,1735941470.957 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-01-03T21:57:54.184Z,1735941474.184 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-01-03T21:58:02.297Z,1735941482.297 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-01-03T21:58:05.129Z,1735941485.129 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-01-03T21:58:13.177Z,1735941493.177 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-01-03T21:58:16.405Z,1735941496.405 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-01-03T21:58:23.682Z,1735941503.682 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-01-03T21:58:27.323Z,1735941507.323 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-01-03T21:58:36.190Z,1735941516.190 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-01-03T21:58:38.221Z,1735941518.221 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-01-03T21:58:49.133Z,1735941529.133 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-01-03T21:59:00.038Z,1735941540.038 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-01-03T21:59:00.384Z,1735941540.384 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7). 2025-01-03T21:59:00.812Z,1735941540.812 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 6 2025-01-03T21:59:00.812Z,1735941540.812 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-01-03T21:59:00.846Z,1735941540.846 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-01-03T21:59:01.210Z,1735941541.210 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-01-03T21:59:01.210Z,1735941541.210 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 6 2025-01-03T21:59:11.355Z,1735941551.355 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-01-03T21:59:19.765Z,1735941559.765 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7). 2025-01-03T21:59:21.858Z,1735941561.858 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-01-03T21:59:32.362Z,1735941572.362 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-01-03T21:59:39.560Z,1735941579.560 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7). 2025-01-03T21:59:56.990Z,1735941596.990 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-01-03T21:59:57.352Z,1735941597.352 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7). 2025-01-03T22:00:15.561Z,1735941615.561 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7). 2025-01-03T22:00:26.486Z,1735941626.486 [Default:CheckIn:Read_GPS](INFO): Timed out from 2025-01-03T21:55:26.3Z 2025-01-03T22:00:26.486Z,1735941626.486 [Default:CheckIn:Read_GPS] Stopped 2025-01-03T22:00:26.486Z,1735941626.486 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-01-03T22:00:33.899Z,1735941633.899 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20250103T214044/Courier0007.lzma 2025-01-03T22:00:34.901Z,1735941634.901 [DataOverHttps](INFO): Moved sent file to Logs/20250103T214044/Courier0007.lzma.bak 2025-01-03T22:00:34.901Z,1735941634.901 [DataOverHttps](INFO): SBD MOMSN=23875568 2025-01-03T22:00:34.964Z,1735941634.964 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7). 2025-01-03T22:00:50.335Z,1735941650.335 [DataOverHttps](INFO): Sending 183 bytes from file Logs/20250103T214044/Express0008.lzma 2025-01-03T22:00:51.337Z,1735941651.337 [DataOverHttps](INFO): Moved sent file to Logs/20250103T214044/Express0008.lzma.bak 2025-01-03T22:00:51.337Z,1735941651.337 [DataOverHttps](INFO): SBD MOMSN=23875570 2025-01-03T22:00:52.728Z,1735941652.728 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7). 2025-01-03T22:00:52.782Z,1735941652.782 [Default:CheckIn:Read_Iridium] Stopped 2025-01-03T22:00:52.782Z,1735941652.782 [Default:CheckIn:C.Wait] Running Loop=1 2025-01-03T22:00:52.782Z,1735941652.782 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-01-03T22:02:01.876Z,1735941721.876 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 7 2025-01-03T22:02:01.876Z,1735941721.876 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-01-03T22:02:01.887Z,1735941721.887 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-01-03T22:02:02.276Z,1735941722.276 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-01-03T22:02:02.276Z,1735941722.276 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 7 2025-01-03T22:02:21.214Z,1735941741.214 [NAL9602](FAULT): GPS failed to acquire within timeout. 2025-01-03T22:02:21.214Z,1735941741.214 [NAL9602] Data Fault, FailCount= 2 2025-01-03T22:02:21.214Z,1735941741.214 [NAL9602](ERROR): Data Fault 2025-01-03T22:02:21.232Z,1735941741.232 [CBIT](ERROR): Data Fault in component: NAL9602 2025-01-03T22:02:21.617Z,1735941741.617 [NAL9602](INFO): Powering down 2025-01-03T22:02:22.470Z,1735941742.470 [CBIT](INFO): Clearing failed state for component NAL9602 2025-01-03T22:02:22.470Z,1735941742.470 [NAL9602] No Fault, FailCount= 2 2025-01-03T22:02:51.934Z,1735941771.934 [NAL9602](INFO): Powering up NAL9602 2025-01-03T22:03:02.829Z,1735941782.829 [NAL9602](INFO): NAL9602 initialized 2025-01-03T22:03:29.538Z,1735941809.538 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-01-03T22:05:02.843Z,1735941902.843 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 8 2025-01-03T22:05:02.843Z,1735941902.843 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-01-03T22:05:02.854Z,1735941902.854 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-01-03T22:05:03.269Z,1735941903.269 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-01-03T22:05:03.269Z,1735941903.269 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 8 2025-01-03T22:05:51.767Z,1735941951.767 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-01-03T22:05:53.345Z,1735941953.345 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2025-01-03T22:05:53.345Z,1735941953.345 [Default:CheckIn:C.Wait] Stopped 2025-01-03T22:05:53.345Z,1735941953.345 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-01-03T22:05:53.345Z,1735941953.345 [Default:CheckIn:D] Running Loop=1 2025-01-03T22:05:53.749Z,1735941953.749 [Default:CheckIn:D] Stopped 2025-01-03T22:05:53.749Z,1735941953.749 [Default:CheckIn:E] Running Loop=1 2025-01-03T22:05:54.150Z,1735941954.150 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 21.239075 min 2025-01-03T22:05:54.150Z,1735941954.150 [Default:CheckIn:E] Stopped 2025-01-03T22:05:54.150Z,1735941954.150 [Default:CheckIn](INFO): Completed Default:CheckIn 2025-01-03T22:05:54.150Z,1735941954.150 [Default:CheckIn] Stopped 2025-01-03T22:05:54.150Z,1735941954.150 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-01-03T22:05:54.150Z,1735941954.150 [Default:CheckIn](INFO): Running loop #3 2025-01-03T22:05:54.150Z,1735941954.150 [Default:CheckIn] Running Loop=3 2025-01-03T22:05:54.150Z,1735941954.150 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-01-03T22:05:54.150Z,1735941954.150 [Default:CheckIn:Read_GPS] Running Loop=1 2025-01-03T22:06:02.689Z,1735941962.689 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-01-03T22:06:13.601Z,1735941973.601 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-01-03T22:06:24.505Z,1735941984.505 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-01-03T22:06:35.827Z,1735941995.827 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-01-03T22:06:40.764Z,1735942000.764 [CommandExec](IMPORTANT): got command failComponent 2025-01-03T22:06:40.764Z,1735942000.764 [CommandExec](IMPORTANT): Failed components: 2025-01-03T22:06:40.765Z,1735942000.765 [CommandExec](IMPORTANT): No failed Components. 2025-01-03T22:06:46.692Z,1735942006.692 [CommandExec](IMPORTANT): got command gfscan 2025-01-03T22:06:46.728Z,1735942006.728 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-01-03T22:06:46.764Z,1735942006.764 [CBIT](IMPORTANT): Beginning ground fault scan 2025-01-03T22:06:49.512Z,1735942009.512 [CBIT](ERROR): Error reading 24V bus power status. Assuming off for scan purposes. 2025-01-03T22:06:49.947Z,1735942009.947 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-01-03T22:06:57.638Z,1735942017.638 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-01-03T22:06:57.693Z,1735942017.693 [CBIT](IMPORTANT): No ground fault detected mA: CHAN A0 (Batt): 0.001512 CHAN A1 (24V) N/A reporting off CHAN A2 (12V): -0.002207 CHAN A3 (5V): -0.001880 CHAN B0 (3.3V): 0.000054 CHAN B1 (3.15aV): -0.000242 CHAN B2 (3.15bV): -0.000011 CHAN B3 (GND): 0.000377 OPEN: -0.000406 Full Scale: +/- 1 mA 2025-01-03T22:07:00.902Z,1735942020.902 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-01-03T22:07:08.542Z,1735942028.542 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-01-03T22:07:11.777Z,1735942031.777 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-01-03T22:07:19.454Z,1735942039.454 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-01-03T22:07:22.286Z,1735942042.286 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-01-03T22:07:29.996Z,1735942049.996 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-01-03T22:07:33.597Z,1735942053.597 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-01-03T22:07:40.870Z,1735942060.870 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-01-03T22:07:44.902Z,1735942064.902 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-01-03T22:07:52.174Z,1735942072.174 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-01-03T22:07:56.218Z,1735942076.218 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-01-03T22:08:03.490Z,1735942083.490 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-01-03T22:08:03.868Z,1735942083.868 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 9 2025-01-03T22:08:03.868Z,1735942083.868 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-01-03T22:08:03.903Z,1735942083.903 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-01-03T22:08:04.282Z,1735942084.282 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-01-03T22:08:04.282Z,1735942084.282 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 9 2025-01-03T22:08:07.122Z,1735942087.122 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-01-03T22:08:16.398Z,1735942096.398 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-01-03T22:08:18.034Z,1735942098.034 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-01-03T22:08:21.028Z,1735942101.028 [CommandExec](IMPORTANT): got command get Sonardyne_Nano.chargePercent 2025-01-03T22:08:21.029Z,1735942101.029 [CommandExec](IMPORTANT): Sonardyne_Nano.chargePercent 67.000000 % 2025-01-03T22:08:29.396Z,1735942109.396 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-01-03T22:08:39.796Z,1735942119.796 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7). 2025-01-03T22:08:40.271Z,1735942120.271 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-01-03T22:08:51.178Z,1735942131.178 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-01-03T22:08:58.784Z,1735942138.784 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7). 2025-01-03T22:09:02.180Z,1735942142.180 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-01-03T22:09:13.401Z,1735942153.401 [CommandExec](IMPORTANT): got command configSet list 2025-01-03T22:09:13.401Z,1735942153.401 [CommandExec](IMPORTANT): Listing configuration overrides from Data/persisted.cfg 2025-01-03T22:09:13.402Z,1735942153.402 [CommandExec](IMPORTANT): BPC1.batteryMissingStickThreshold=11 count; 2025-01-03T22:09:13.402Z,1735942153.402 [CommandExec](IMPORTANT): DAT.loadAtStartup=0 bool; 2025-01-03T22:09:13.435Z,1735942153.435 [CommandExec](IMPORTANT): DATMMP.loadAtStartup=1 bool; 2025-01-03T22:09:13.436Z,1735942153.436 [CommandExec](IMPORTANT): DATMMP.simulateHardware=0 bool; 2025-01-03T22:09:13.437Z,1735942153.437 [CommandExec](IMPORTANT): DATMMP.surfaceThreshold=2 meter; 2025-01-03T22:09:13.437Z,1735942153.437 [CommandExec](IMPORTANT): Express linearApproximation DATMMP.acoustic_contact_range 15.000000 meter; 2025-01-03T22:09:13.438Z,1735942153.438 [CommandExec](IMPORTANT): VerticalControl.buoyancyNeutral=292.731903 cubic_centimeter; 2025-01-03T22:09:13.439Z,1735942153.439 [CommandExec](IMPORTANT): VerticalControl.massDefault=7.465234 millimeter; 2025-01-03T22:09:18.176Z,1735942158.176 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7). 2025-01-03T22:09:37.573Z,1735942177.573 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7). 2025-01-03T22:09:56.960Z,1735942196.960 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7). 2025-01-03T22:09:58.636Z,1735942198.636 [CommandExec](IMPORTANT): got command failComponent 2025-01-03T22:09:58.636Z,1735942198.636 [CommandExec](IMPORTANT): Failed components: 2025-01-03T22:09:58.637Z,1735942198.637 [CommandExec](IMPORTANT): No failed Components. 2025-01-03T22:10:16.378Z,1735942216.378 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7). 2025-01-03T22:10:54.366Z,1735942254.366 [Default:CheckIn:Read_GPS](INFO): Timed out from 2025-01-03T22:05:54.2Z 2025-01-03T22:10:54.366Z,1735942254.366 [Default:CheckIn:Read_GPS] Stopped 2025-01-03T22:10:54.366Z,1735942254.366 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-01-03T22:11:01.655Z,1735942261.655 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20250103T214044/Courier0010.lzma 2025-01-03T22:11:02.657Z,1735942262.657 [DataOverHttps](INFO): Moved sent file to Logs/20250103T214044/Courier0010.lzma.bak 2025-01-03T22:11:02.657Z,1735942262.657 [DataOverHttps](INFO): SBD MOMSN=23875588 2025-01-03T22:11:04.883Z,1735942264.883 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 10 2025-01-03T22:11:04.883Z,1735942264.883 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-01-03T22:11:04.894Z,1735942264.894 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-01-03T22:11:05.286Z,1735942265.286 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-01-03T22:11:05.286Z,1735942265.286 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 10 2025-01-03T22:11:18.377Z,1735942278.377 [DataOverHttps](INFO): Sending 736 bytes from file Logs/20250103T214044/Express0011.lzma 2025-01-03T22:11:19.249Z,1735942279.249 [DataOverHttps](INFO): Moved sent file to Logs/20250103T214044/Express0011.lzma.bak 2025-01-03T22:11:19.249Z,1735942279.249 [DataOverHttps](INFO): SBD MOMSN=23875590 2025-01-03T22:11:20.625Z,1735942280.625 [Default:CheckIn:Read_Iridium] Stopped 2025-01-03T22:11:20.625Z,1735942280.625 [Default:CheckIn:C.Wait] Running Loop=1 2025-01-03T22:11:20.626Z,1735942280.626 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-01-03T22:11:56.553Z,1735942316.553 [BPC1](INFO): Calculating totals. Valid battery stick count: 32. Valid reserve battery stick count: 2. 2025-01-03T22:11:56.556Z,1735942316.556 [BPC1](ERROR): Failed to receive data from all sticks prior to timeout. Will not retry this scan cycle. 2025-01-03T22:13:04.429Z,1735942384.429 [NAL9602](FAULT): GPS failed to acquire within timeout. 2025-01-03T22:13:04.429Z,1735942384.429 [NAL9602] Data Fault, FailCount= 3 2025-01-03T22:13:04.429Z,1735942384.429 [NAL9602](ERROR): Data Fault 2025-01-03T22:13:04.474Z,1735942384.474 [CBIT](ERROR): Data Fault in component: NAL9602 2025-01-03T22:13:04.837Z,1735942384.837 [NAL9602](INFO): Powering down 2025-01-03T22:13:05.661Z,1735942385.661 [CBIT](INFO): Clearing failed state for component NAL9602 2025-01-03T22:13:05.661Z,1735942385.661 [NAL9602] No Fault, FailCount= 3 2025-01-03T22:13:35.137Z,1735942415.137 [NAL9602](INFO): Powering up NAL9602 2025-01-03T22:13:46.045Z,1735942426.045 [NAL9602](INFO): NAL9602 initialized 2025-01-03T22:14:05.858Z,1735942445.858 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 11 2025-01-03T22:14:05.858Z,1735942445.858 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-01-03T22:14:05.869Z,1735942445.869 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-01-03T22:14:06.272Z,1735942446.272 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-01-03T22:14:06.272Z,1735942446.272 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 11 2025-01-03T22:16:21.190Z,1735942581.190 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2025-01-03T22:16:21.190Z,1735942581.190 [Default:CheckIn:C.Wait] Stopped 2025-01-03T22:16:21.190Z,1735942581.190 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-01-03T22:16:21.190Z,1735942581.190 [Default:CheckIn:D] Running Loop=1 2025-01-03T22:16:21.599Z,1735942581.599 [Default:CheckIn:D] Stopped 2025-01-03T22:16:21.599Z,1735942581.599 [Default:CheckIn:E] Running Loop=1 2025-01-03T22:16:21.998Z,1735942581.998 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 31.703231 min 2025-01-03T22:16:21.998Z,1735942581.998 [Default:CheckIn:E] Stopped 2025-01-03T22:16:21.998Z,1735942581.998 [Default:CheckIn](INFO): Completed Default:CheckIn 2025-01-03T22:16:21.998Z,1735942581.998 [Default:CheckIn] Stopped 2025-01-03T22:16:21.998Z,1735942581.998 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-01-03T22:16:21.999Z,1735942581.999 [Default:CheckIn](INFO): Running loop #4 2025-01-03T22:16:21.999Z,1735942581.999 [Default:CheckIn] Running Loop=4 2025-01-03T22:16:21.999Z,1735942581.999 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-01-03T22:16:21.999Z,1735942581.999 [Default:CheckIn:Read_GPS] Running Loop=1 2025-01-03T22:17:06.841Z,1735942626.841 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 12 2025-01-03T22:17:06.841Z,1735942626.841 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-01-03T22:17:06.852Z,1735942626.852 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-01-03T22:17:07.254Z,1735942627.254 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-01-03T22:17:07.254Z,1735942627.254 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 12 2025-01-03T22:18:39.789Z,1735942719.789 [CommandExec](IMPORTANT): got command restart application 2025-01-03T22:18:40.792Z,1735942720.792 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread. 2025-01-03T22:18:40.792Z,1735942720.792 [CommandExec](INFO): Uninitializing the command executive. 2025-01-03T22:18:40.792Z,1735942720.792 [CommandExec](INFO): Uninitializing the command scheduler. 2025-01-03T22:18:40.792Z,1735942720.792 [CommandExec ThreadHandler](INFO): Thread cancelled. 2025-01-03T22:18:40.979Z,1735942720.979 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2025-01-03T22:18:40.979Z,1735942720.979 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2025-01-03T22:18:40.980Z,1735942720.980 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2025-01-03T22:18:40.980Z,1735942720.980 [NavChartDb](INFO): Join timeout helper Thread ID is 457 2025-01-03T22:18:41.236Z,1735942721.236 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2025-01-03T22:18:41.236Z,1735942721.236 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2025-01-03T22:18:41.247Z,1735942721.247 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler 2025-01-03T22:18:41.247Z,1735942721.247 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2025-01-03T22:18:41.248Z,1735942721.248 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 458 2025-01-03T22:18:41.327Z,1735942721.327 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread. 2025-01-03T22:18:41.328Z,1735942721.328 [WetLabsBB2FL](INFO): Powering down 2025-01-03T22:18:41.328Z,1735942721.328 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2025-01-03T22:18:41.335Z,1735942721.335 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler 2025-01-03T22:18:41.335Z,1735942721.335 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2025-01-03T22:18:41.336Z,1735942721.336 [CTD_Seabird](INFO): Join timeout helper Thread ID is 459 2025-01-03T22:18:42.011Z,1735942722.011 [CTD_Seabird](INFO): Powering down 2025-01-03T22:18:42.024Z,1735942722.024 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread. 2025-01-03T22:18:42.024Z,1735942722.024 [CTD_Seabird](INFO): Powering down 2025-01-03T22:18:42.035Z,1735942722.035 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2025-01-03T22:18:42.039Z,1735942722.039 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2025-01-03T22:18:42.039Z,1735942722.039 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2025-01-03T22:18:42.040Z,1735942722.040 [Radio_Surface](INFO): Join timeout helper Thread ID is 460 2025-01-03T22:18:42.323Z,1735942722.323 [Radio_Surface](INFO): Powering down 2025-01-03T22:18:42.324Z,1735942722.324 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2025-01-03T22:18:42.325Z,1735942722.325 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2025-01-03T22:18:42.338Z,1735942722.338 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler 2025-01-03T22:18:42.338Z,1735942722.338 [Onboard ThreadHandler](INFO): Thread cancelled. 2025-01-03T22:18:42.339Z,1735942722.339 [Onboard](INFO): Join timeout helper Thread ID is 461 2025-01-03T22:18:42.488Z,1735942722.488 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread. 2025-01-03T22:18:42.488Z,1735942722.488 [Onboard ThreadHandler](INFO): Thread cancelled. 2025-01-03T22:18:42.504Z,1735942722.504 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler 2025-01-03T22:18:42.504Z,1735942722.504 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2025-01-03T22:18:42.505Z,1735942722.505 [DataOverHttps](INFO): Join timeout helper Thread ID is 462 2025-01-03T22:18:43.199Z,1735942723.199 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread. 2025-01-03T22:18:43.200Z,1735942723.200 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2025-01-03T22:18:43.204Z,1735942723.204 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2025-01-03T22:18:43.204Z,1735942723.204 [logger ThreadHandler](INFO): Thread cancelled. 2025-01-03T22:18:43.205Z,1735942723.205 [logger](INFO): Join timeout helper Thread ID is 463 2025-01-03T22:18:43.215Z,1735942723.215 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2025-01-03T22:18:43.216Z,1735942723.216 [logger ThreadHandler](INFO): Thread cancelled. 2025-01-03T22:18:43.224Z,1735942723.224 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2025-01-03T22:18:43.224Z,1735942723.224 [CommandLine ThreadHandler](INFO): Thread cancelled. 2025-01-03T22:18:43.224Z,1735942723.224 [CommandLine](INFO): Join timeout helper Thread ID is 464 2025-01-03T22:18:43.304Z,1735942723.304 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2025-01-03T22:18:43.304Z,1735942723.304 [CommandLine ThreadHandler](INFO): Thread cancelled. 2025-01-03T22:18:43.324Z,1735942723.324 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler 2025-01-03T22:18:43.324Z,1735942723.324 [CommandExec ThreadHandler](INFO): Thread cancelled. 2025-01-03T22:18:43.324Z,1735942723.324 [CommandExec](INFO): Join timeout helper Thread ID is 465 2025-01-03T22:18:43.326Z,1735942723.326 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2025-01-03T22:18:43.326Z,1735942723.326 [controlThread ThreadHandler](INFO): Thread cancelled. 2025-01-03T22:18:43.326Z,1735942723.326 [controlThread](INFO): Join timeout helper Thread ID is 466 2025-01-03T22:18:43.371Z,1735942723.371 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2025-01-03T22:18:43.372Z,1735942723.372 [controlThread](DEBUG): Uninitializing ControlThread 2025-01-03T22:18:43.372Z,1735942723.372 [AHRS_M2](INFO): Powering down 2025-01-03T22:18:43.444Z,1735942723.444 [NAL9602](INFO): Powering down 2025-01-03T22:18:43.445Z,1735942723.445 [Sonardyne_Nano](INFO): Powering down 2025-01-03T22:18:43.565Z,1735942723.565 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator. 2025-01-03T22:18:43.566Z,1735942723.566 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator. 2025-01-03T22:18:43.566Z,1735942723.566 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2025-01-03T22:18:43.567Z,1735942723.567 [MissionManager](INFO): Uninitializing Mission Default 2025-01-03T22:18:43.567Z,1735942723.567 [Default] Stopped 2025-01-03T22:18:43.567Z,1735942723.567 [Default](DEBUG): Aggregate::uninitialize Default 2025-01-03T22:18:43.567Z,1735942723.567 [Default:B.GoToSurface] Stopped 2025-01-03T22:18:43.567Z,1735942723.567 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2025-01-03T22:18:43.567Z,1735942723.567 [Default:CheckIn] Stopped 2025-01-03T22:18:43.567Z,1735942723.567 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-01-03T22:18:43.567Z,1735942723.567 [Default:CheckIn:Read_GPS] Stopped 2025-01-03T22:18:43.570Z,1735942723.570 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2025-01-03T22:18:43.571Z,1735942723.571 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2025-01-03T22:18:43.571Z,1735942723.571 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2025-01-03T22:18:43.571Z,1735942723.571 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2025-01-03T22:18:43.572Z,1735942723.572 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2025-01-03T22:18:43.572Z,1735942723.572 [BuoyancyServo](INFO): Powering down 2025-01-03T22:18:43.584Z,1735942723.584 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2025-01-03T22:18:43.584Z,1735942723.584 [ElevatorServo](INFO): Powering down 2025-01-03T22:18:43.584Z,1735942723.584 [MassServo](DEBUG): Uninitialize Mass Servo. 2025-01-03T22:18:43.585Z,1735942723.585 [MassServo](INFO): Powering down 2025-01-03T22:18:43.585Z,1735942723.585 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2025-01-03T22:18:43.585Z,1735942723.585 [RudderServo](INFO): Powering down 2025-01-03T22:18:43.586Z,1735942723.586 [ThrusterHE](DEBUG): Uninitialize Thruster Servo. 2025-01-03T22:18:43.586Z,1735942723.586 [ThrusterHE](INFO): Powering down 2025-01-03T22:18:43.587Z,1735942723.587 [SBIT](DEBUG): Uninitialize SBIT Component. 2025-01-03T22:18:43.588Z,1735942723.588 [IBIT](DEBUG): Uninitialize IBIT Component. 2025-01-03T22:18:43.588Z,1735942723.588 [CBIT](DEBUG): Uninitialize CBIT Component. 2025-01-03T22:18:43.588Z,1735942723.588 [CBIT](DEBUG): Powering off loads. 2025-01-03T22:18:43.599Z,1735942723.599 [CBIT](DEBUG): Disabling WDT. 2025-01-03T22:18:43.611Z,1735942723.611 [CBIT](DEBUG): Opening all GF detection circuits. 2025-01-03T22:18:43.612Z,1735942723.612 [controlThread ThreadHandler](INFO): Thread cancelled. 2025-01-03T22:18:43.663Z,1735942723.663 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2025-01-03T22:18:43.666Z,1735942723.666 [Onboard ThreadHandler](INFO): Thread cancelled. 2025-01-03T22:18:43.672Z,1735942723.672 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2025-01-03T22:18:43.744Z,1735942723.744 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2025-01-03T22:18:43.749Z,1735942723.749 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2025-01-03T22:18:43.791Z,1735942723.791 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2025-01-03T22:18:43.855Z,1735942723.855 [logger ThreadHandler](INFO): Thread cancelled.