2024-04-22T20:26:00.777Z,1713817560.777 [Supervisor](DEBUG): Initializing supervisor. 2024-04-22T20:26:00.789Z,1713817560.789 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2024-04-22T20:26:00.790Z,1713817560.790 [SyncHandler](INFO): Protected caller Thread ID is 3812 2024-04-22T20:26:00.790Z,1713817560.790 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2024-04-22T20:26:00.809Z,1713817560.809 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2024-04-22T20:26:00.809Z,1713817560.809 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 3813 2024-04-22T20:26:00.849Z,1713817560.849 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2024-04-22T20:26:00.881Z,1713817560.881 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread. 2024-04-22T20:26:00.885Z,1713817560.885 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2024-04-22T20:26:00.886Z,1713817560.886 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 3814 2024-04-22T20:26:00.890Z,1713817560.890 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2024-04-22T20:26:00.891Z,1713817560.891 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2024-04-22T20:26:00.891Z,1713817560.891 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 3815 2024-04-22T20:26:00.894Z,1713817560.894 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2024-04-22T20:26:00.895Z,1713817560.895 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0 2024-04-22T20:26:00.895Z,1713817560.895 [logger ThreadHandler](INFO): Protected caller Thread ID is 3816 2024-04-22T20:26:00.899Z,1713817560.899 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2024-04-22T20:26:00.899Z,1713817560.899 [Supervisor](INFO): Looking for Config files in directory: Config/ 2024-04-22T20:26:00.904Z,1713817560.904 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2024-04-22T20:26:01.354Z,1713817561.354 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2024-04-22T20:26:01.356Z,1713817561.356 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2024-04-22T20:26:02.127Z,1713817562.127 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2024-04-22T20:26:02.128Z,1713817562.128 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2024-04-22T20:26:02.250Z,1713817562.250 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2024-04-22T20:26:02.252Z,1713817562.252 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2024-04-22T20:26:02.816Z,1713817562.816 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2024-04-22T20:26:02.816Z,1713817562.816 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2024-04-22T20:26:02.928Z,1713817562.928 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2024-04-22T20:26:02.930Z,1713817562.930 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2024-04-22T20:26:03.024Z,1713817563.024 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2024-04-22T20:26:03.457Z,1713817563.457 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2024-04-22T20:26:03.459Z,1713817563.459 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2024-04-22T20:26:03.701Z,1713817563.701 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2024-04-22T20:26:03.702Z,1713817563.702 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2024-04-22T20:26:03.853Z,1713817563.853 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2024-04-22T20:26:03.855Z,1713817563.855 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg 2024-04-22T20:26:04.123Z,1713817564.123 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock 2024-04-22T20:26:04.124Z,1713817564.124 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2024-04-22T20:26:05.059Z,1713817565.059 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2024-04-22T20:26:05.060Z,1713817565.060 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2024-04-22T20:26:05.458Z,1713817565.458 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2024-04-22T20:26:05.459Z,1713817565.459 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2024-04-22T20:26:05.551Z,1713817565.551 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2024-04-22T20:26:05.761Z,1713817565.761 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2024-04-22T20:26:05.763Z,1713817565.763 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2024-04-22T20:26:06.014Z,1713817566.014 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2024-04-22T20:26:06.015Z,1713817566.015 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2024-04-22T20:26:06.333Z,1713817566.333 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2024-04-22T20:26:06.335Z,1713817566.335 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-brizo/ 2024-04-22T20:26:06.338Z,1713817566.338 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Control.cfg 2024-04-22T20:26:06.467Z,1713817566.467 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Sensor.cfg 2024-04-22T20:26:06.640Z,1713817566.640 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Simulator.cfg 2024-04-22T20:26:06.741Z,1713817566.741 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/secure.cfg 2024-04-22T20:26:06.842Z,1713817566.842 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Servo.cfg 2024-04-22T20:26:06.970Z,1713817566.970 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/vehicle.cfg 2024-04-22T20:26:07.093Z,1713817567.093 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Battery.cfg 2024-04-22T20:26:07.373Z,1713817567.373 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2024-04-22T20:26:07.374Z,1713817567.374 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Science.cfg 2024-04-22T20:26:07.522Z,1713817567.522 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/logger.cfg 2024-04-22T20:26:07.629Z,1713817567.629 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/BIT.cfg 2024-04-22T20:26:07.735Z,1713817567.735 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Navigation.cfg 2024-04-22T20:26:07.853Z,1713817567.853 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-brizo/root/ 2024-04-22T20:26:07.854Z,1713817567.854 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg 2024-04-22T20:26:07.867Z,1713817567.867 [Module Loader](DEBUG): Loading Module at Modules/Dock.so 2024-04-22T20:26:08.015Z,1713817568.015 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking) 2024-04-22T20:26:08.016Z,1713817568.016 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2024-04-22T20:26:08.032Z,1713817568.032 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2024-04-22T20:26:08.034Z,1713817568.034 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2024-04-22T20:26:08.108Z,1713817568.108 [DepthRateCalculator] Loaded 2024-04-22T20:26:08.109Z,1713817568.109 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2024-04-22T20:26:08.114Z,1713817568.114 [PitchRateCalculator] Loaded 2024-04-22T20:26:08.115Z,1713817568.115 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2024-04-22T20:26:08.125Z,1713817568.125 [SpeedCalculator] Loaded 2024-04-22T20:26:08.125Z,1713817568.125 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2024-04-22T20:26:08.130Z,1713817568.130 [YawRateCalculator] Loaded 2024-04-22T20:26:08.131Z,1713817568.131 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2024-04-22T20:26:08.152Z,1713817568.152 [ElevatorOffsetCalculator] Loaded 2024-04-22T20:26:08.153Z,1713817568.153 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread. 2024-04-22T20:26:08.153Z,1713817568.153 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2024-04-22T20:26:08.155Z,1713817568.155 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2024-04-22T20:26:08.224Z,1713817568.224 [VerticalControl](DEBUG): Construct VerticalControl. 2024-04-22T20:26:08.285Z,1713817568.285 [VerticalControl] Loaded 2024-04-22T20:26:08.285Z,1713817568.285 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2024-04-22T20:26:08.288Z,1713817568.288 [HorizontalControl](DEBUG): Construct HorizontalControl. 2024-04-22T20:26:08.331Z,1713817568.331 [HorizontalControl] Loaded 2024-04-22T20:26:08.331Z,1713817568.331 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2024-04-22T20:26:08.334Z,1713817568.334 [SpeedControl](DEBUG): Construct SpeedControl. 2024-04-22T20:26:08.337Z,1713817568.337 [SpeedControl] Loaded 2024-04-22T20:26:08.337Z,1713817568.337 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2024-04-22T20:26:08.340Z,1713817568.340 [LoopControl](DEBUG): Construct LoopControl. 2024-04-22T20:26:08.340Z,1713817568.340 [LoopControl] Loaded 2024-04-22T20:26:08.340Z,1713817568.340 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2024-04-22T20:26:08.341Z,1713817568.341 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2024-04-22T20:26:08.341Z,1713817568.341 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2024-04-22T20:26:08.480Z,1713817568.480 [DeadReckonUsingMultipleVelocitySources] Loaded 2024-04-22T20:26:08.481Z,1713817568.481 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2024-04-22T20:26:08.495Z,1713817568.495 [NavChart] Loaded 2024-04-22T20:26:08.495Z,1713817568.495 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2024-04-22T20:26:08.501Z,1713817568.501 [UniversalFixResidualReporter] Loaded 2024-04-22T20:26:08.501Z,1713817568.501 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2024-04-22T20:26:08.501Z,1713817568.501 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2024-04-22T20:26:08.502Z,1713817568.502 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2024-04-22T20:26:08.722Z,1713817568.722 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2024-04-22T20:26:08.723Z,1713817568.723 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2024-04-22T20:26:09.578Z,1713817569.578 [AHRS_M2] Loaded 2024-04-22T20:26:09.579Z,1713817569.579 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread. 2024-04-22T20:26:09.833Z,1713817569.833 [BackseatComponent] Loaded 2024-04-22T20:26:09.834Z,1713817569.834 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread. 2024-04-22T20:26:09.835Z,1713817569.835 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 409204E0 2024-04-22T20:26:09.835Z,1713817569.835 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 3898 2024-04-22T20:26:09.838Z,1713817569.838 [LcmUniversalReporter] Loaded 2024-04-22T20:26:09.838Z,1713817569.838 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread. 2024-04-22T20:26:11.153Z,1713817571.153 [BPC1] Loaded 2024-04-22T20:26:11.153Z,1713817571.153 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2024-04-22T20:26:11.487Z,1713817571.487 [DataOverHttps] Loaded 2024-04-22T20:26:11.487Z,1713817571.487 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread. 2024-04-22T20:26:11.491Z,1713817571.491 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 409504E0 2024-04-22T20:26:11.492Z,1713817571.492 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 3899 2024-04-22T20:26:11.513Z,1713817571.513 [Depth_Keller] Loaded 2024-04-22T20:26:11.513Z,1713817571.513 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2024-04-22T20:26:11.518Z,1713817571.518 [DropWeight] Loaded 2024-04-22T20:26:11.518Z,1713817571.518 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread. 2024-04-22T20:26:11.557Z,1713817571.557 [DVL_micro] Loaded 2024-04-22T20:26:11.557Z,1713817571.557 [ComponentRegistry](DEBUG): SyncComponent "DVL_micro" handled in the control thread. 2024-04-22T20:26:11.620Z,1713817571.620 [NAL9602] Loaded 2024-04-22T20:26:11.620Z,1713817571.620 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2024-04-22T20:26:11.651Z,1713817571.651 [Onboard] Loaded 2024-04-22T20:26:11.651Z,1713817571.651 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread. 2024-04-22T20:26:11.652Z,1713817571.652 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 409804E0 2024-04-22T20:26:11.653Z,1713817571.653 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 3900 2024-04-22T20:26:11.665Z,1713817571.665 [Power24vConverter] Loaded 2024-04-22T20:26:11.665Z,1713817571.665 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread. 2024-04-22T20:26:11.678Z,1713817571.678 [Radio_Surface] Loaded 2024-04-22T20:26:11.679Z,1713817571.679 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2024-04-22T20:26:11.680Z,1713817571.680 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 409B04E0 2024-04-22T20:26:11.680Z,1713817571.680 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 3901 2024-04-22T20:26:11.694Z,1713817571.694 [Sonardyne_Nano] Loaded 2024-04-22T20:26:11.694Z,1713817571.694 [ComponentRegistry](DEBUG): SyncComponent "Sonardyne_Nano" handled in the control thread. 2024-04-22T20:26:11.789Z,1713817571.789 [DAT] Loaded 2024-04-22T20:26:11.789Z,1713817571.789 [ComponentRegistry](DEBUG): Component "DAT" handled in its own thread. 2024-04-22T20:26:11.790Z,1713817571.790 [DAT ThreadHandler](DEBUG): Created PCaller Thread at 409E04E0 2024-04-22T20:26:11.790Z,1713817571.790 [DAT ThreadHandler](INFO): Protected caller Thread ID is 3902 2024-04-22T20:26:11.791Z,1713817571.791 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2024-04-22T20:26:11.792Z,1713817571.792 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2024-04-22T20:26:11.957Z,1713817571.957 [BuoyancyServo] Loaded 2024-04-22T20:26:11.957Z,1713817571.957 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2024-04-22T20:26:11.978Z,1713817571.978 [ElevatorServo] Loaded 2024-04-22T20:26:11.978Z,1713817571.978 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2024-04-22T20:26:11.998Z,1713817571.998 [MassServo] Loaded 2024-04-22T20:26:11.998Z,1713817571.998 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2024-04-22T20:26:12.017Z,1713817572.017 [RudderServo] Loaded 2024-04-22T20:26:12.018Z,1713817572.018 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2024-04-22T20:26:12.033Z,1713817572.033 [ThrusterHE] Loaded 2024-04-22T20:26:12.033Z,1713817572.033 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread. 2024-04-22T20:26:12.034Z,1713817572.034 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2024-04-22T20:26:12.034Z,1713817572.034 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2024-04-22T20:26:12.119Z,1713817572.119 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2024-04-22T20:26:12.120Z,1713817572.120 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2024-04-22T20:26:12.166Z,1713817572.166 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2024-04-22T20:26:12.166Z,1713817572.166 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2024-04-22T20:26:12.573Z,1713817572.573 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2024-04-22T20:26:12.574Z,1713817572.574 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2024-04-22T20:26:12.804Z,1713817572.804 [CTD_Seabird] Loaded 2024-04-22T20:26:12.805Z,1713817572.805 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread. 2024-04-22T20:26:12.806Z,1713817572.806 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40B964E0 2024-04-22T20:26:12.806Z,1713817572.806 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 3903 2024-04-22T20:26:12.840Z,1713817572.840 [ESPComponent] Loaded 2024-04-22T20:26:12.841Z,1713817572.841 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread. 2024-04-22T20:26:12.861Z,1713817572.861 [PAR_Licor] Loaded 2024-04-22T20:26:12.861Z,1713817572.861 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread. 2024-04-22T20:26:12.906Z,1713817572.906 [WetLabsBB2FL] Loaded 2024-04-22T20:26:12.907Z,1713817572.907 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread. 2024-04-22T20:26:12.908Z,1713817572.908 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40BC64E0 2024-04-22T20:26:12.908Z,1713817572.908 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 3904 2024-04-22T20:26:12.909Z,1713817572.909 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2024-04-22T20:26:12.909Z,1713817572.909 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2024-04-22T20:26:13.084Z,1713817573.084 [SBIT](DEBUG): Construct Startup Built In Test. 2024-04-22T20:26:13.093Z,1713817573.093 [SBIT] Loaded 2024-04-22T20:26:13.094Z,1713817573.094 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2024-04-22T20:26:13.097Z,1713817573.097 [IBIT](DEBUG): Construct Initiated Built In Test. 2024-04-22T20:26:13.110Z,1713817573.110 [IBIT] Loaded 2024-04-22T20:26:13.110Z,1713817573.110 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2024-04-22T20:26:13.116Z,1713817573.116 [CBIT](DEBUG): Construct Continuous Built In Test. 2024-04-22T20:26:13.224Z,1713817573.224 [CBIT] Loaded 2024-04-22T20:26:13.224Z,1713817573.224 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2024-04-22T20:26:13.224Z,1713817573.224 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2024-04-22T20:26:13.231Z,1713817573.231 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2024-04-22T20:26:13.234Z,1713817573.234 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2024-04-22T20:26:13.245Z,1713817573.245 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2024-04-22T20:26:13.246Z,1713817573.246 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40C354E0 2024-04-22T20:26:13.247Z,1713817573.247 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 3905 2024-04-22T20:26:13.253Z,1713817573.253 [Supervisor](INFO): Main Thread ID is 3810 2024-04-22T20:26:13.253Z,1713817573.253 [Supervisor](DEBUG): Running supervisor. 2024-04-22T20:26:13.256Z,1713817573.256 [CommandExec ThreadHandler](INFO): Handler Thread ID is 3906 2024-04-22T20:26:13.257Z,1713817573.257 [CommandExec](INFO): Initializing the command executive. 2024-04-22T20:26:13.259Z,1713817573.259 [CommandLine ThreadHandler](INFO): Handler Thread ID is 3907 2024-04-22T20:26:13.261Z,1713817573.261 [controlThread ThreadHandler](INFO): Handler Thread ID is 3908 2024-04-22T20:26:13.261Z,1713817573.261 [controlThread](DEBUG): Initializing ControlThread 2024-04-22T20:26:13.262Z,1713817573.262 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2024-04-22T20:26:13.262Z,1713817573.262 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2024-04-22T20:26:13.263Z,1713817573.263 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2024-04-22T20:26:13.263Z,1713817573.263 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2024-04-22T20:26:13.263Z,1713817573.263 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator. 2024-04-22T20:26:13.264Z,1713817573.264 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2024-04-22T20:26:13.266Z,1713817573.266 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2024-04-22T20:26:13.267Z,1713817573.267 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2024-04-22T20:26:13.267Z,1713817573.267 [LoopControl](DEBUG): Initialize LoopControlComponent. 2024-04-22T20:26:13.268Z,1713817573.268 [NavChart](DEBUG): Initialize NavChart Navigation. 2024-04-22T20:26:13.268Z,1713817573.268 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2024-04-22T20:26:13.277Z,1713817573.277 [SBIT](INFO): Initialize SBIT Component. 2024-04-22T20:26:13.277Z,1713817573.277 [SBIT](IMPORTANT): git: 2024-04-11 2024-04-22T20:26:13.278Z,1713817573.278 [SBIT](INFO): git hash: 8b14ac3cbe1df2c95d6505c0066306c41245f1d7 2024-04-22T20:26:13.278Z,1713817573.278 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2024-04-22T20:26:13.279Z,1713817573.279 [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-04-22T20:26:13.280Z,1713817573.280 [SBIT](INFO): Beginning SBIT in 148.000000 seconds. 2024-04-22T20:26:13.281Z,1713817573.281 [IBIT](INFO): Initialize IBIT Component. 2024-04-22T20:26:13.282Z,1713817573.282 [CBIT](DEBUG): Initialize CBIT Component. 2024-04-22T20:26:13.282Z,1713817573.282 [logger ThreadHandler](INFO): Handler Thread ID is 3909 2024-04-22T20:26:13.293Z,1713817573.293 [CBIT](DEBUG): Initialized mux pins. 2024-04-22T20:26:13.293Z,1713817573.293 [CBIT](DEBUG): Initializing the watchdog timer. 2024-04-22T20:26:13.301Z,1713817573.301 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 3910 2024-04-22T20:26:13.313Z,1713817573.313 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 3911 2024-04-22T20:26:13.315Z,1713817573.315 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2024-04-22T20:26:13.317Z,1713817573.317 [CBIT](INFO): Last reboot was NOT due to watchdog timer. 2024-04-22T20:26:13.317Z,1713817573.317 [CBIT](DEBUG): Initializing heartbeat. 2024-04-22T20:26:13.325Z,1713817573.325 [Onboard ThreadHandler](INFO): Handler Thread ID is 3912 2024-04-22T20:26:13.343Z,1713817573.343 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 3913 2024-04-22T20:26:13.361Z,1713817573.361 [DAT ThreadHandler](INFO): Handler Thread ID is 3914 2024-04-22T20:26:13.362Z,1713817573.362 [DAT](INFO): Powering up 2024-04-22T20:26:13.362Z,1713817573.362 [DAT](DEBUG): Initializing DAT. 2024-04-22T20:26:13.366Z,1713817573.366 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 3916 2024-04-22T20:26:13.367Z,1713817573.367 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2024-04-22T20:26:13.370Z,1713817573.370 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 3918 2024-04-22T20:26:13.373Z,1713817573.373 [WetLabsBB2FL](INFO): Powering up 2024-04-22T20:26:13.374Z,1713817573.374 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 3920 2024-04-22T20:26:13.383Z,1713817573.383 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000 2024-04-22T20:26:13.383Z,1713817573.383 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000 2024-04-22T20:26:13.383Z,1713817573.383 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000 2024-04-22T20:26:13.383Z,1713817573.383 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000 2024-04-22T20:26:13.384Z,1713817573.384 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000 2024-04-22T20:26:13.384Z,1713817573.384 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000 2024-04-22T20:26:13.384Z,1713817573.384 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000 2024-04-22T20:26:13.384Z,1713817573.384 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000 2024-04-22T20:26:13.389Z,1713817573.389 [CBIT](DEBUG): Deactivating GF circuits. 2024-04-22T20:26:13.389Z,1713817573.389 [CBIT](DEBUG): Deactivating emergency mode. 2024-04-22T20:26:13.428Z,1713817573.428 [CBIT](DEBUG): Backplane powered. 2024-04-22T20:26:13.430Z,1713817573.430 [MissionManager](INFO): Loading Mission from file: Missions/Startup.tl 2024-04-22T20:26:13.430Z,1713817573.430 [MissionManager](IMPORTANT): Loading Compiled TethysL script from file Missions/Startup.tx 2024-04-22T20:26:13.475Z,1713817573.475 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2024-04-22T20:26:13.507Z,1713817573.507 [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-04-22T20:26:13.508Z,1713817573.508 [MissionManager](INFO): Loading Mission from file: Missions/Default.tl 2024-04-22T20:26:13.508Z,1713817573.508 [MissionManager](IMPORTANT): Loading Compiled TethysL script from file Missions/Default.tx 2024-04-22T20:26:13.601Z,1713817573.601 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min 2024-04-22T20:26:13.603Z,1713817573.603 [Default:A.Wait](DEBUG): Construct Wait. 2024-04-22T20:26:13.621Z,1713817573.621 [Default:B.GoToSurface](DEBUG): Construct GoToSurface. 2024-04-22T20:26:13.664Z,1713817573.664 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2024-04-22T20:26:13.681Z,1713817573.681 [Default:CheckIn:C.Wait](DEBUG): Construct Wait. 2024-04-22T20:26:13.687Z,1713817573.687 [Default:E.Execute](DEBUG): Construct Execute. 2024-04-22T20:26:13.708Z,1713817573.708 [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-04-22T20:26:13.713Z,1713817573.713 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,DropWeight,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-04-22T20:26:13.737Z,1713817573.737 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2024-04-22T20:26:13.749Z,1713817573.749 [Radio_Surface](INFO): Powering up 2024-04-22T20:26:14.034Z,1713817574.034 [Power24vConverter](INFO): Powering up. 2024-04-22T20:26:14.035Z,1713817574.035 [Sonardyne_Nano](INFO): Initializing. 2024-04-22T20:26:14.120Z,1713817574.120 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2024-04-22T20:26:14.129Z,1713817574.129 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2024-04-22T20:26:14.130Z,1713817574.130 [ElevatorServo](DEBUG): Initializing EZServoServo. 2024-04-22T20:26:14.137Z,1713817574.137 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2024-04-22T20:26:14.138Z,1713817574.138 [MassServo](DEBUG): Initializing EZServoServo. 2024-04-22T20:26:14.145Z,1713817574.145 [MassServo](DEBUG): Initializing MassServo. 2024-04-22T20:26:14.146Z,1713817574.146 [RudderServo](DEBUG): Initializing EZServoServo. 2024-04-22T20:26:14.153Z,1713817574.153 [RudderServo](DEBUG): Initializing RudderServo. 2024-04-22T20:26:14.154Z,1713817574.154 [ThrusterHE](DEBUG): Initializing EZServoServo. 2024-04-22T20:26:14.161Z,1713817574.161 [ThrusterHE](DEBUG): Initializing ThrusterHE. 2024-04-22T20:26:14.358Z,1713817574.358 [DropWeight](CRITICAL): DROP WEIGHT MISSING. 2024-04-22T20:26:14.358Z,1713817574.358 [DropWeight] Hardware Fault, FailCount= 1 2024-04-22T20:26:14.358Z,1713817574.358 [DropWeight](ERROR): Hardware Fault 2024-04-22T20:26:14.430Z,1713817574.430 [CommandExec](FAULT): Scheduling is paused 2024-04-22T20:26:14.431Z,1713817574.431 [CBIT](INFO): Critical error at 20240422T202614 2024-04-22T20:26:14.431Z,1713817574.431 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals 2024-04-22T20:26:14.442Z,1713817574.442 [CBIT](ERROR): Hardware Fault in component: DropWeight 2024-04-22T20:26:14.449Z,1713817574.449 [CBIT](CRITICAL): Hardware Fault in component: DropWeight 2024-04-22T20:26:14.611Z,1713817574.611 [CBIT](INFO): Critical error at 20240422T202614 2024-04-22T20:26:15.985Z,1713817575.985 [WetLabsBB2FL](INFO): Powering down 2024-04-22T20:26:16.199Z,1713817576.199 [Sonardyne_Nano](ERROR): Failed to get valid response or reached max queue size, flushing UART 2024-04-22T20:26:17.441Z,1713817577.441 [Sonardyne_Nano](IMPORTANT): Found beacon with acoustic ID 2207 2024-04-22T20:26:19.697Z,1713817579.697 [ThrusterHE](ERROR): Zero Speed Commanded. 2024-04-22T20:26:20.397Z,1713817580.397 [CTD_Seabird](ERROR): Device message queue exceeded the allowed limit. 2024-04-22T20:26:25.217Z,1713817585.217 [DAT](INFO): DAT read: 2024-04-22T20:26:25.218Z,1713817585.218 [DAT](INFO): DAT read: Teledyne Benthos DAT-900 Series 2024-04-22T20:26:26.459Z,1713817586.459 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004658 2024-04-22T20:26:26.982Z,1713817586.982 [DAT](INFO): DAT read: MF Frequency Band 2024-04-22T20:26:26.983Z,1713817586.983 [DAT](INFO): DAT read: Directional Acoustic Transponder version 8.15.0 2024-04-22T20:26:26.983Z,1713817586.983 [DAT](INFO): DAT read: Apr 22 2024 20:26:46 2024-04-22T20:26:27.990Z,1713817587.990 [DAT](INFO): DAT read: Features enabled [Bearing] 2024-04-22T20:26:27.991Z,1713817587.991 [DAT](INFO): DAT read: CONNECT 00800 bits/sec 1 of 4, Rate 1/2 CC 12.50ms MGP 2024-04-22T20:26:27.992Z,1713817587.992 [DAT](INFO): commRate: 800 2024-04-22T20:26:30.057Z,1713817590.057 [DAT](INFO): entering command mode 2024-04-22T20:26:30.257Z,1713817590.257 [DAT](INFO): DAT read: 2024-04-22T20:26:30.258Z,1713817590.258 [DAT](INFO): DAT read: user:1> 2024-04-22T20:26:30.258Z,1713817590.258 [DAT](INFO): setting verbose to 3 2024-04-22T20:26:30.509Z,1713817590.509 [DAT](INFO): DAT read: user:1> 2024-04-22T20:26:30.510Z,1713817590.510 [DAT](INFO): DAT read: Verbose | 3 2024-04-22T20:26:30.511Z,1713817590.511 [DAT](INFO): set verbose to 3 2024-04-22T20:26:30.511Z,1713817590.511 [DAT](INFO): setting DatVerbose to 27440 2024-04-22T20:26:30.761Z,1713817590.761 [DAT](INFO): DAT read: user:2> 2024-04-22T20:26:30.762Z,1713817590.762 [DAT](INFO): DAT read: DatVerbose | 27440 2024-04-22T20:26:30.763Z,1713817590.763 [DAT](INFO): set DatVerbose to 27440 2024-04-22T20:26:30.763Z,1713817590.763 [DAT](INFO): setting transmit power to 8 2024-04-22T20:26:31.013Z,1713817591.013 [DAT](INFO): DAT read: user:3> 2024-04-22T20:26:31.014Z,1713817591.014 [DAT](INFO): DAT read: TxPower | 8 (Max) 2024-04-22T20:26:31.015Z,1713817591.015 [DAT](INFO): set transmit power to 8 2024-04-22T20:26:31.015Z,1713817591.015 [DAT](INFO): setting local address to 11 2024-04-22T20:26:31.265Z,1713817591.265 [DAT](INFO): DAT read: user:4> 2024-04-22T20:26:31.267Z,1713817591.267 [DAT](INFO): DAT read: LocalAddr | 11 2024-04-22T20:26:31.267Z,1713817591.267 [DAT](INFO): set local address to 11 2024-04-22T20:26:31.268Z,1713817591.268 [DAT](INFO): Setting time to: 20:26:31 And date to:4/22/2024 2024-04-22T20:26:31.517Z,1713817591.517 [DAT](INFO): DAT read: user:5> 2024-04-22T20:26:31.518Z,1713817591.518 [DAT](INFO): DAT read: Mon Apr 22, 2024 20:26:31 2024-04-22T20:26:31.519Z,1713817591.519 [DAT](INFO): Local DAT time set to Mon Apr 22, 2024 20:26:31 2024-04-22T20:26:41.654Z,1713817601.654 [NAL9602](INFO): Powering up NAL9602 2024-04-22T20:26:52.562Z,1713817612.562 [NAL9602](INFO): NAL9602 initialized 2024-04-22T20:28:41.714Z,1713817721.714 [SBIT](IMPORTANT): Beginning Startup BIT 2024-04-22T20:28:41.722Z,1713817721.722 [CBIT](IMPORTANT): Beginning ground fault scan 2024-04-22T20:28:52.604Z,1713817732.604 [CBIT](IMPORTANT): No ground fault detected mA: CHAN A0 (Batt): 0.015678 CHAN A1 (24V): -0.001503 CHAN A2 (12V): -0.000408 CHAN A3 (5V): 0.000211 CHAN B0 (3.3V): 0.000302 CHAN B1 (3.15aV): 0.000488 CHAN B2 (3.15bV): -0.000329 CHAN B3 (GND): 0.000402 OPEN: -0.002631 Full Scale: +/- 1 mA 2024-04-22T20:29:13.633Z,1713817753.633 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1 2024-04-22T20:29:13.633Z,1713817753.633 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-04-22T20:29:13.690Z,1713817753.690 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-04-22T20:29:14.041Z,1713817754.041 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-04-22T20:29:14.042Z,1713817754.042 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1 2024-04-22T20:29:17.974Z,1713817757.974 [CommandExec](IMPORTANT): got command failComponent 2024-04-22T20:29:17.974Z,1713817757.974 [CommandExec](IMPORTANT): Failed components: 2024-04-22T20:29:17.974Z,1713817757.974 [CommandExec](IMPORTANT): DropWeight: Hardware Fault 2024-04-22T20:29:35.823Z,1713817775.823 [SBIT](IMPORTANT): SBIT PASSED 2024-04-22T20:29:35.823Z,1713817775.823 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg 2024-04-22T20:29:35.824Z,1713817775.824 [SBIT](IMPORTANT): AHRS_M2.loadAtStartup=1 bool; 2024-04-22T20:29:35.840Z,1713817775.840 [SBIT](IMPORTANT): BPC1.batteryMissingStickThreshold=12 count; 2024-04-22T20:29:35.841Z,1713817775.841 [SBIT](IMPORTANT): DVL_micro.baud=19200 bit_per_second; 2024-04-22T20:29:35.841Z,1713817775.841 [SBIT](IMPORTANT): Depth_Keller.offset=3.6 decibar; 2024-04-22T20:29:35.841Z,1713817775.841 [SBIT](IMPORTANT): ESPComponent.sampleTimeout=3 minute; 2024-04-22T20:29:35.841Z,1713817775.841 [SBIT](IMPORTANT): ESPComponent.simulateHardware=0 bool; 2024-04-22T20:29:35.841Z,1713817775.841 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=410.582899 cubic_centimeter; 2024-04-22T20:29:35.841Z,1713817775.841 [SBIT](IMPORTANT): VerticalControl.massDefault=3.2 centimeter; 2024-04-22T20:29:36.227Z,1713817776.227 [MissionManager](IMPORTANT): Started mission Startup 2024-04-22T20:29:36.227Z,1713817776.227 [Startup] Running Loop=1 2024-04-22T20:29:36.227Z,1713817776.227 [Startup](DEBUG): Aggregate::initialize Startup 2024-04-22T20:29:36.227Z,1713817776.227 [Startup:A.GoToSurface] Running Loop=1 2024-04-22T20:29:36.227Z,1713817776.227 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2024-04-22T20:29:36.228Z,1713817776.228 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2024-04-22T20:29:36.229Z,1713817776.229 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2024-04-22T20:29:36.229Z,1713817776.229 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2024-04-22T20:29:36.229Z,1713817776.229 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2024-04-22T20:29:36.230Z,1713817776.230 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2024-04-22T20:29:36.232Z,1713817776.232 [Startup:StartupSatComms] Running Loop=1 2024-04-22T20:29:36.232Z,1713817776.232 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms 2024-04-22T20:29:36.232Z,1713817776.232 [Startup:StartupSatComms:A] Running Loop=1 2024-04-22T20:29:36.630Z,1713817776.630 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix 2024-04-22T20:30:36.455Z,1713817836.455 [Startup:StartupSatComms:A](INFO): Timed out from 2024-04-22T20:29:36.2Z 2024-04-22T20:30:36.455Z,1713817836.455 [Startup:StartupSatComms:A] Stopped 2024-04-22T20:30:36.456Z,1713817836.456 [Startup:StartupSatComms:B] Running Loop=1 2024-04-22T20:30:36.842Z,1713817836.842 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications 2024-04-22T20:30:44.824Z,1713817844.824 [DataOverHttps](INFO): Sending 18 bytes from file Logs/20240421T051436/Courier0660.lzma 2024-04-22T20:30:45.827Z,1713817845.827 [DataOverHttps](INFO): Moved sent file to Logs/20240421T051436/Courier0660.lzma.bak 2024-04-22T20:30:45.827Z,1713817845.827 [DataOverHttps](INFO): SBD MOMSN=19421300 2024-04-22T20:31:06.521Z,1713817866.521 [DataOverHttps](INFO): Sending 241 bytes from file Logs/20240422T194926/Courier0000.lzma 2024-04-22T20:31:07.523Z,1713817867.523 [DataOverHttps](INFO): Moved sent file to Logs/20240422T194926/Courier0000.lzma.bak 2024-04-22T20:31:07.523Z,1713817867.523 [DataOverHttps](INFO): SBD MOMSN=19421302 2024-04-22T20:31:26.317Z,1713817886.317 [DataOverHttps](INFO): Sending 241 bytes from file Logs/20240422T202600/Courier0000.lzma 2024-04-22T20:31:27.318Z,1713817887.318 [DataOverHttps](INFO): Moved sent file to Logs/20240422T202600/Courier0000.lzma.bak 2024-04-22T20:31:27.318Z,1713817887.318 [DataOverHttps](INFO): SBD MOMSN=19421307 2024-04-22T20:31:36.791Z,1713817896.791 [Startup:StartupSatComms:B](INFO): Timed out from 2024-04-22T20:30:36.5Z 2024-04-22T20:31:36.791Z,1713817896.791 [Startup:StartupSatComms:B] Stopped 2024-04-22T20:31:36.791Z,1713817896.791 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms 2024-04-22T20:31:36.791Z,1713817896.791 [Startup:StartupSatComms] Stopped 2024-04-22T20:31:36.792Z,1713817896.792 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms 2024-04-22T20:31:36.793Z,1713817896.793 [Startup](INFO): Completed Startup 2024-04-22T20:31:36.793Z,1713817896.793 [MissionManager](INFO): Startup is completed. 2024-04-22T20:31:36.793Z,1713817896.793 [MissionManager](INFO): Uninitializing Mission Startup 2024-04-22T20:31:36.793Z,1713817896.793 [Startup] Stopped 2024-04-22T20:31:36.793Z,1713817896.793 [Startup](DEBUG): Aggregate::uninitialize Startup 2024-04-22T20:31:36.793Z,1713817896.793 [Startup:A.GoToSurface] Stopped 2024-04-22T20:31:36.793Z,1713817896.793 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2024-04-22T20:31:37.115Z,1713817897.115 [MissionManager](IMPORTANT): Started mission Default 2024-04-22T20:31:37.115Z,1713817897.115 [Default] Running Loop=1 2024-04-22T20:31:37.115Z,1713817897.115 [Default](DEBUG): Aggregate::initialize Default 2024-04-22T20:31:37.115Z,1713817897.115 [Default:B.GoToSurface] Running Loop=1 2024-04-22T20:31:37.115Z,1713817897.115 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2024-04-22T20:31:37.116Z,1713817897.115 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2024-04-22T20:31:37.116Z,1713817897.116 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2024-04-22T20:31:37.116Z,1713817897.116 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2024-04-22T20:31:37.117Z,1713817897.117 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2024-04-22T20:31:37.117Z,1713817897.117 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2024-04-22T20:31:37.117Z,1713817897.117 [Default:A.Wait] Running Loop=1 2024-04-22T20:31:37.117Z,1713817897.117 [Default:A.Wait](DEBUG): Initialize Wait Component. 2024-04-22T20:31:44.832Z,1713817904.832 [DataOverHttps](INFO): Sending 18 bytes from file Logs/20240421T051436/Express0661.lzma 2024-04-22T20:31:45.835Z,1713817905.835 [DataOverHttps](INFO): Moved sent file to Logs/20240421T051436/Express0661.lzma.bak 2024-04-22T20:31:45.835Z,1713817905.835 [DataOverHttps](INFO): SBD MOMSN=19421312 2024-04-22T20:31:50.436Z,1713817910.436 [Default:A.Wait](INFO): Done Waiting. 2024-04-22T20:31:50.436Z,1713817910.436 [Default:A.Wait] Stopped 2024-04-22T20:31:50.436Z,1713817910.436 [Default:A.Wait](DEBUG): Uninitialize Wait Component. 2024-04-22T20:31:50.831Z,1713817910.831 [Default:CheckIn] Running Loop=1 2024-04-22T20:31:50.831Z,1713817910.831 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-04-22T20:31:50.831Z,1713817910.831 [Default:CheckIn:Read_GPS] Running Loop=1 2024-04-22T20:31:51.230Z,1713817911.230 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix 2024-04-22T20:31:56.479Z,1713817916.479 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2024-04-22T20:32:14.682Z,1713817934.682 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2 2024-04-22T20:32:14.682Z,1713817934.682 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-04-22T20:32:14.693Z,1713817934.693 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-04-22T20:32:15.102Z,1713817935.102 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-04-22T20:32:15.102Z,1713817935.102 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2 2024-04-22T20:32:24.925Z,1713817944.925 [CommandExec](IMPORTANT): got command gfscan 2024-04-22T20:32:25.179Z,1713817945.179 [CBIT](IMPORTANT): Beginning ground fault scan 2024-04-22T20:32:36.151Z,1713817956.151 [CBIT](IMPORTANT): No ground fault detected mA: CHAN A0 (Batt): 0.016792 CHAN A1 (24V): -0.002323 CHAN A2 (12V): 0.000290 CHAN A3 (5V): 0.000401 CHAN B0 (3.3V): 0.000919 CHAN B1 (3.15aV): 0.000282 CHAN B2 (3.15bV): 0.000344 CHAN B3 (GND): 0.000600 OPEN: 0.005236 Full Scale: +/- 1 mA 2024-04-22T20:33:50.400Z,1713818030.400 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-04-22T20:34:05.348Z,1713818045.348 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-04-22T20:34:20.294Z,1713818060.294 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-04-22T20:34:35.646Z,1713818075.646 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-04-22T20:34:50.595Z,1713818090.595 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-04-22T20:35:05.542Z,1713818105.542 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-04-22T20:35:15.666Z,1713818115.666 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3 2024-04-22T20:35:15.666Z,1713818115.666 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-04-22T20:35:15.709Z,1713818115.709 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-04-22T20:35:16.129Z,1713818116.129 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-04-22T20:35:16.129Z,1713818116.129 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3 2024-04-22T20:35:20.086Z,1713818120.086 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-04-22T20:35:35.049Z,1713818135.049 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-04-22T20:35:49.580Z,1713818149.580 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-04-22T20:36:04.526Z,1713818164.526 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-04-22T20:36:51.011Z,1713818211.011 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-04-22T20:31:50.8Z 2024-04-22T20:36:51.012Z,1713818211.012 [Default:CheckIn:Read_GPS] Stopped 2024-04-22T20:36:51.012Z,1713818211.012 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-04-22T20:36:51.438Z,1713818211.438 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications 2024-04-22T20:36:54.626Z,1713818214.626 [NAL9602](FAULT): GPS failed to acquire within timeout. 2024-04-22T20:36:54.626Z,1713818214.626 [NAL9602] Data Fault, FailCount= 1 2024-04-22T20:36:54.626Z,1713818214.626 [NAL9602](ERROR): Data Fault 2024-04-22T20:36:54.709Z,1713818214.709 [CBIT](ERROR): Data Fault in component: NAL9602 2024-04-22T20:36:55.030Z,1713818215.030 [NAL9602](INFO): Powering down 2024-04-22T20:36:55.888Z,1713818215.888 [CBIT](INFO): Clearing failed state for component NAL9602 2024-04-22T20:36:55.888Z,1713818215.888 [NAL9602] No Fault, FailCount= 1 2024-04-22T20:36:58.640Z,1713818218.640 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20240422T202600/Courier0004.lzma 2024-04-22T20:36:59.642Z,1713818219.642 [DataOverHttps](INFO): Moved sent file to Logs/20240422T202600/Courier0004.lzma.bak 2024-04-22T20:36:59.642Z,1713818219.642 [DataOverHttps](INFO): SBD MOMSN=19421357 2024-04-22T20:37:18.629Z,1713818238.629 [DataOverHttps](INFO): Sending 465 bytes from file Logs/20240422T194926/Express0001.lzma 2024-04-22T20:37:19.631Z,1713818239.631 [DataOverHttps](INFO): Moved sent file to Logs/20240422T194926/Express0001.lzma.bak 2024-04-22T20:37:19.631Z,1713818239.631 [DataOverHttps](INFO): SBD MOMSN=19421359 2024-04-22T20:37:25.330Z,1713818245.330 [NAL9602](INFO): Powering up NAL9602 2024-04-22T20:37:36.256Z,1713818256.256 [NAL9602](INFO): NAL9602 initialized 2024-04-22T20:37:37.148Z,1713818257.148 [DataOverHttps](INFO): Sending 998 bytes from file Logs/20240422T202600/Express0001.lzma 2024-04-22T20:37:38.146Z,1713818258.146 [DataOverHttps](INFO): Moved sent file to Logs/20240422T202600/Express0001.lzma.bak 2024-04-22T20:37:38.146Z,1713818258.146 [DataOverHttps](INFO): SBD MOMSN=19421369 2024-04-22T20:37:55.573Z,1713818275.573 [DataOverHttps](INFO): Sending 376 bytes from file Logs/20240422T202600/Express0005.lzma 2024-04-22T20:37:56.574Z,1713818276.574 [DataOverHttps](INFO): Moved sent file to Logs/20240422T202600/Express0005.lzma.bak 2024-04-22T20:37:56.574Z,1713818276.574 [DataOverHttps](INFO): SBD MOMSN=19421395 2024-04-22T20:37:59.706Z,1713818279.706 [Default:CheckIn:Read_Iridium] Stopped 2024-04-22T20:37:59.706Z,1713818279.706 [Default:CheckIn:C.Wait] Running Loop=1 2024-04-22T20:37:59.706Z,1713818279.706 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-04-22T20:38:16.654Z,1713818296.654 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4 2024-04-22T20:38:16.654Z,1713818296.654 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-04-22T20:38:16.690Z,1713818296.690 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-04-22T20:38:17.098Z,1713818297.098 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-04-22T20:38:17.098Z,1713818297.098 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4 2024-04-22T20:40:57.478Z,1713818457.478 [CommandExec](IMPORTANT): got command strobe off 2024-04-22T20:40:57.478Z,1713818457.478 [CommandExec](IMPORTANT): Deactivating strobe 2024-04-22T20:41:14.440Z,1713818474.440 [CBIT](INFO): Clearing failed state for component DropWeight 2024-04-22T20:41:14.440Z,1713818474.440 [DropWeight] No Fault, FailCount= 1 2024-04-22T20:41:17.646Z,1713818477.646 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 5 2024-04-22T20:41:17.646Z,1713818477.646 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-04-22T20:41:17.656Z,1713818477.656 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-04-22T20:41:18.079Z,1713818478.079 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-04-22T20:41:18.079Z,1713818478.079 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 5 2024-04-22T20:43:00.263Z,1713818580.263 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-04-22T20:43:00.263Z,1713818580.263 [Default:CheckIn:C.Wait] Stopped 2024-04-22T20:43:00.263Z,1713818580.263 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-04-22T20:43:00.263Z,1713818580.263 [Default:CheckIn:D] Running Loop=1 2024-04-22T20:43:00.662Z,1713818580.662 [Default:CheckIn:D] Stopped 2024-04-22T20:43:00.662Z,1713818580.662 [Default:CheckIn:E] Running Loop=1 2024-04-22T20:43:01.071Z,1713818581.071 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 11.392448 min 2024-04-22T20:43:01.071Z,1713818581.071 [Default:CheckIn:E] Stopped 2024-04-22T20:43:01.071Z,1713818581.071 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-04-22T20:43:01.071Z,1713818581.071 [Default:CheckIn] Stopped 2024-04-22T20:43:01.071Z,1713818581.071 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-04-22T20:43:01.072Z,1713818581.072 [Default:CheckIn](INFO): Running loop #2 2024-04-22T20:43:01.072Z,1713818581.072 [Default:CheckIn] Running Loop=2 2024-04-22T20:43:01.072Z,1713818581.072 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-04-22T20:43:01.072Z,1713818581.072 [Default:CheckIn:Read_GPS] Running Loop=1 2024-04-22T20:43:34.587Z,1713818614.587 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-04-22T20:43:39.839Z,1713818619.839 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-04-22T20:43:55.197Z,1713818635.197 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-04-22T20:44:10.138Z,1713818650.138 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-04-22T20:44:18.637Z,1713818658.637 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 6 2024-04-22T20:44:18.637Z,1713818658.637 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-04-22T20:44:18.675Z,1713818658.675 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-04-22T20:44:19.103Z,1713818659.103 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-04-22T20:44:19.103Z,1713818659.103 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 6 2024-04-22T20:44:25.086Z,1713818665.086 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-04-22T20:44:40.035Z,1713818680.035 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-04-22T20:44:54.982Z,1713818694.982 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-04-22T20:45:10.337Z,1713818710.337 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-04-22T20:45:25.283Z,1713818725.283 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-04-22T20:45:40.232Z,1713818740.232 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-04-22T20:45:55.180Z,1713818755.180 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-04-22T20:47:19.632Z,1713818839.632 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 7 2024-04-22T20:47:19.632Z,1713818839.632 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-04-22T20:47:19.644Z,1713818839.644 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-04-22T20:47:20.064Z,1713818840.064 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-04-22T20:47:20.064Z,1713818840.064 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 7 2024-04-22T20:47:37.398Z,1713818857.398 [NAL9602](FAULT): GPS failed to acquire within timeout. 2024-04-22T20:47:37.399Z,1713818857.399 [NAL9602] Data Fault, FailCount= 2 2024-04-22T20:47:37.399Z,1713818857.399 [NAL9602](ERROR): Data Fault 2024-04-22T20:47:37.416Z,1713818857.416 [CBIT](ERROR): Data Fault in component: NAL9602 2024-04-22T20:47:37.808Z,1713818857.808 [NAL9602](INFO): Powering down 2024-04-22T20:47:38.638Z,1713818858.638 [CBIT](INFO): Clearing failed state for component NAL9602 2024-04-22T20:47:38.639Z,1713818858.639 [NAL9602] No Fault, FailCount= 2 2024-04-22T20:48:01.250Z,1713818881.250 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-04-22T20:43:01.1Z 2024-04-22T20:48:01.250Z,1713818881.250 [Default:CheckIn:Read_GPS] Stopped 2024-04-22T20:48:01.250Z,1713818881.250 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-04-22T20:48:08.104Z,1713818888.104 [NAL9602](INFO): Powering up NAL9602 2024-04-22T20:48:08.832Z,1713818888.832 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20240422T202600/Courier0007.lzma 2024-04-22T20:48:09.834Z,1713818889.834 [DataOverHttps](INFO): Moved sent file to Logs/20240422T202600/Courier0007.lzma.bak 2024-04-22T20:48:09.834Z,1713818889.834 [DataOverHttps](INFO): SBD MOMSN=19421448 2024-04-22T20:48:19.011Z,1713818899.011 [NAL9602](INFO): NAL9602 initialized 2024-04-22T20:48:27.517Z,1713818907.517 [DataOverHttps](INFO): Sending 230 bytes from file Logs/20240422T202600/Express0008.lzma 2024-04-22T20:48:28.519Z,1713818908.519 [DataOverHttps](INFO): Moved sent file to Logs/20240422T202600/Express0008.lzma.bak 2024-04-22T20:48:28.519Z,1713818908.519 [DataOverHttps](INFO): SBD MOMSN=19421450 2024-04-22T20:48:31.582Z,1713818911.582 [Default:CheckIn:Read_Iridium] Stopped 2024-04-22T20:48:31.582Z,1713818911.582 [Default:CheckIn:C.Wait] Running Loop=1 2024-04-22T20:48:31.582Z,1713818911.582 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-04-22T20:50:20.642Z,1713819020.642 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 8 2024-04-22T20:50:20.642Z,1713819020.642 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-04-22T20:50:20.665Z,1713819020.665 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-04-22T20:50:21.056Z,1713819021.056 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-04-22T20:50:21.056Z,1713819021.056 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 8 2024-04-22T20:53:21.645Z,1713819201.645 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 9 2024-04-22T20:53:21.645Z,1713819201.645 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-04-22T20:53:21.655Z,1713819201.655 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-04-22T20:53:22.053Z,1713819202.053 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-04-22T20:53:22.053Z,1713819202.053 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 9 2024-04-22T20:53:29.679Z,1713819209.679 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-04-22T20:53:32.135Z,1713819212.135 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-04-22T20:53:32.135Z,1713819212.135 [Default:CheckIn:C.Wait] Stopped 2024-04-22T20:53:32.135Z,1713819212.135 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-04-22T20:53:32.135Z,1713819212.135 [Default:CheckIn:D] Running Loop=1 2024-04-22T20:53:32.551Z,1713819212.551 [Default:CheckIn:D] Stopped 2024-04-22T20:53:32.551Z,1713819212.551 [Default:CheckIn:E] Running Loop=1 2024-04-22T20:53:32.947Z,1713819212.947 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 21.923932 min 2024-04-22T20:53:32.947Z,1713819212.947 [Default:CheckIn:E] Stopped 2024-04-22T20:53:32.947Z,1713819212.947 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-04-22T20:53:32.948Z,1713819212.948 [Default:CheckIn] Stopped 2024-04-22T20:53:32.948Z,1713819212.948 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-04-22T20:53:32.948Z,1713819212.948 [Default:CheckIn](INFO): Running loop #3 2024-04-22T20:53:32.948Z,1713819212.948 [Default:CheckIn] Running Loop=3 2024-04-22T20:53:32.948Z,1713819212.948 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-04-22T20:53:32.948Z,1713819212.948 [Default:CheckIn:Read_GPS] Running Loop=1 2024-04-22T20:53:35.740Z,1713819215.740 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-04-22T20:53:55.130Z,1713819235.130 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-04-22T20:54:14.523Z,1713819254.523 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-04-22T20:54:33.117Z,1713819273.117 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-04-22T20:54:51.693Z,1713819291.693 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-04-22T20:55:10.276Z,1713819310.276 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-04-22T20:55:28.858Z,1713819328.858 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-04-22T20:55:47.446Z,1713819347.446 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-04-22T20:56:22.630Z,1713819382.630 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 10 2024-04-22T20:56:22.630Z,1713819382.630 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-04-22T20:56:22.641Z,1713819382.641 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-04-22T20:56:23.021Z,1713819383.021 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-04-22T20:56:23.021Z,1713819383.021 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 10 2024-04-22T20:57:14.709Z,1713819434.709 [BPC1](ERROR): Battery stick #3 (s/n: 00BF) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x4AD0. 2024-04-22T20:57:14.710Z,1713819434.710 [BPC1](INFO): Calculating totals. Valid battery stick count: 41. Valid reserve battery stick count: 4. 2024-04-22T20:57:14.713Z,1713819434.713 [BPC1](ERROR): Failed to receive data from all sticks prior to timeout. Will not retry this scan cycle. 2024-04-22T20:58:20.163Z,1713819500.163 [NAL9602](FAULT): GPS failed to acquire within timeout. 2024-04-22T20:58:20.163Z,1713819500.163 [NAL9602] Data Fault, FailCount= 3 2024-04-22T20:58:20.163Z,1713819500.163 [NAL9602](ERROR): Data Fault 2024-04-22T20:58:20.208Z,1713819500.208 [CBIT](ERROR): Data Fault in component: NAL9602 2024-04-22T20:58:20.566Z,1713819500.566 [NAL9602](INFO): Powering down 2024-04-22T20:58:21.402Z,1713819501.402 [CBIT](INFO): Clearing failed state for component NAL9602 2024-04-22T20:58:21.402Z,1713819501.402 [NAL9602] No Fault, FailCount= 3 2024-04-22T20:58:33.107Z,1713819513.107 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-04-22T20:53:32.9Z 2024-04-22T20:58:33.107Z,1713819513.107 [Default:CheckIn:Read_GPS] Stopped 2024-04-22T20:58:33.107Z,1713819513.107 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-04-22T20:58:40.437Z,1713819520.437 [DataOverHttps](INFO): Sending 169 bytes from file Logs/20240422T202600/Courier0010.lzma 2024-04-22T20:58:42.385Z,1713819522.385 [DataOverHttps](INFO): Moved sent file to Logs/20240422T202600/Courier0010.lzma.bak 2024-04-22T20:58:42.386Z,1713819522.386 [DataOverHttps](INFO): SBD MOMSN=19421526 2024-04-22T20:58:50.868Z,1713819530.868 [NAL9602](INFO): Powering up NAL9602 2024-04-22T20:58:58.832Z,1713819538.832 [DataOverHttps](INFO): Sending 147 bytes from file Logs/20240422T202600/Express0011.lzma 2024-04-22T20:58:59.834Z,1713819539.834 [DataOverHttps](INFO): Moved sent file to Logs/20240422T202600/Express0011.lzma.bak 2024-04-22T20:58:59.835Z,1713819539.835 [DataOverHttps](INFO): SBD MOMSN=19421528 2024-04-22T20:59:01.770Z,1713819541.770 [NAL9602](INFO): NAL9602 initialized 2024-04-22T20:59:02.610Z,1713819542.610 [Default:CheckIn:Read_Iridium] Stopped 2024-04-22T20:59:02.610Z,1713819542.610 [Default:CheckIn:C.Wait] Running Loop=1 2024-04-22T20:59:02.610Z,1713819542.610 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-04-22T20:59:23.605Z,1713819563.605 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 11 2024-04-22T20:59:23.605Z,1713819563.605 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-04-22T20:59:23.617Z,1713819563.617 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-04-22T20:59:24.028Z,1713819564.028 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-04-22T20:59:24.028Z,1713819564.028 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 11 2024-04-22T21:02:24.625Z,1713819744.625 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 12 2024-04-22T21:02:24.625Z,1713819744.625 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-04-22T21:02:24.641Z,1713819744.641 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-04-22T21:02:25.050Z,1713819745.050 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-04-22T21:02:25.050Z,1713819745.050 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 12 2024-04-22T21:04:03.166Z,1713819843.166 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-04-22T21:04:03.166Z,1713819843.166 [Default:CheckIn:C.Wait] Stopped 2024-04-22T21:04:03.167Z,1713819843.167 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-04-22T21:04:03.167Z,1713819843.167 [Default:CheckIn:D] Running Loop=1 2024-04-22T21:04:03.591Z,1713819843.591 [Default:CheckIn:D] Stopped 2024-04-22T21:04:03.591Z,1713819843.591 [Default:CheckIn:E] Running Loop=1 2024-04-22T21:04:03.995Z,1713819843.995 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 32.441264 min 2024-04-22T21:04:03.995Z,1713819843.995 [Default:CheckIn:E] Stopped 2024-04-22T21:04:03.995Z,1713819843.995 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-04-22T21:04:03.995Z,1713819843.995 [Default:CheckIn] Stopped 2024-04-22T21:04:03.995Z,1713819843.995 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-04-22T21:04:03.996Z,1713819843.996 [Default:CheckIn](INFO): Running loop #4 2024-04-22T21:04:03.996Z,1713819843.996 [Default:CheckIn] Running Loop=4 2024-04-22T21:04:03.996Z,1713819843.996 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-04-22T21:04:03.996Z,1713819843.996 [Default:CheckIn:Read_GPS] Running Loop=1 2024-04-22T21:05:01.822Z,1713819901.822 [CommandLine](INFO): End of History 2024-04-22T21:05:01.823Z,1713819901.823 [CommandLine](INFO): End of History 2024-04-22T21:05:13.545Z,1713819913.545 [CommandExec](IMPORTANT): got command failComponent 2024-04-22T21:05:13.545Z,1713819913.545 [CommandExec](IMPORTANT): Failed components: 2024-04-22T21:05:13.545Z,1713819913.545 [CommandExec](IMPORTANT): No failed Components. 2024-04-22T21:05:25.602Z,1713819925.602 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 13 2024-04-22T21:05:25.602Z,1713819925.602 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-04-22T21:05:25.613Z,1713819925.613 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-04-22T21:05:26.015Z,1713819926.015 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-04-22T21:05:26.015Z,1713819926.015 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 13 2024-04-22T21:05:26.457Z,1713819926.457 [CommandExec](IMPORTANT): got command failComponent 2024-04-22T21:05:26.457Z,1713819926.457 [CommandExec](IMPORTANT): Failed components: 2024-04-22T21:05:26.457Z,1713819926.457 [CommandExec](IMPORTANT): No failed Components. 2024-04-22T21:05:54.874Z,1713819954.874 [CommandExec](IMPORTANT): got command restart application 2024-04-22T21:05:55.877Z,1713819955.877 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread. 2024-04-22T21:05:55.877Z,1713819955.877 [CommandExec](INFO): Uninitializing the command executive. 2024-04-22T21:05:55.877Z,1713819955.877 [CommandExec](INFO): Uninitializing the command scheduler. 2024-04-22T21:05:55.877Z,1713819955.877 [CommandExec ThreadHandler](INFO): Thread cancelled. 2024-04-22T21:05:56.013Z,1713819956.013 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2024-04-22T21:05:56.013Z,1713819956.013 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2024-04-22T21:05:56.013Z,1713819956.013 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-04-22T21:05:56.014Z,1713819956.014 [NavChartDb](INFO): Join timeout helper Thread ID is 3958 2024-04-22T21:05:56.073Z,1713819956.073 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2024-04-22T21:05:56.073Z,1713819956.073 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-04-22T21:05:56.092Z,1713819956.092 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler 2024-04-22T21:05:56.093Z,1713819956.093 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2024-04-22T21:05:56.093Z,1713819956.093 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 3959 2024-04-22T21:05:56.209Z,1713819956.209 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread. 2024-04-22T21:05:56.209Z,1713819956.209 [WetLabsBB2FL](INFO): Powering down 2024-04-22T21:05:56.210Z,1713819956.210 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2024-04-22T21:05:56.213Z,1713819956.213 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler 2024-04-22T21:05:56.213Z,1713819956.213 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2024-04-22T21:05:56.213Z,1713819956.213 [CTD_Seabird](INFO): Join timeout helper Thread ID is 3960 2024-04-22T21:05:56.245Z,1713819956.245 [CTD_Seabird](INFO): Powering down 2024-04-22T21:05:56.257Z,1713819956.257 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread. 2024-04-22T21:05:56.257Z,1713819956.257 [CTD_Seabird](INFO): Powering down 2024-04-22T21:05:56.269Z,1713819956.269 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2024-04-22T21:05:56.277Z,1713819956.277 [ComponentRegistry](INFO): Shutting down DAT ThreadHandler 2024-04-22T21:05:56.277Z,1713819956.277 [DAT ThreadHandler](INFO): Thread cancelled. 2024-04-22T21:05:56.277Z,1713819956.277 [DAT](INFO): Join timeout helper Thread ID is 3961 2024-04-22T21:05:56.469Z,1713819956.469 [DAT](INFO): Powering down 2024-04-22T21:05:56.541Z,1713819956.541 [DAT ThreadHandler](INFO): Uninitializing protected caller thread. 2024-04-22T21:05:56.541Z,1713819956.541 [DAT](INFO): Powering down 2024-04-22T21:05:56.542Z,1713819956.542 [DAT ThreadHandler](INFO): Thread cancelled. 2024-04-22T21:05:56.561Z,1713819956.561 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2024-04-22T21:05:56.561Z,1713819956.561 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-04-22T21:05:56.561Z,1713819956.561 [Radio_Surface](INFO): Join timeout helper Thread ID is 3962 2024-04-22T21:05:56.601Z,1713819956.601 [Radio_Surface](INFO): Powering down 2024-04-22T21:05:56.602Z,1713819956.602 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2024-04-22T21:05:56.602Z,1713819956.602 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-04-22T21:05:56.621Z,1713819956.621 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler 2024-04-22T21:05:56.621Z,1713819956.621 [Onboard ThreadHandler](INFO): Thread cancelled. 2024-04-22T21:05:56.622Z,1713819956.622 [Onboard](INFO): Join timeout helper Thread ID is 3963 2024-04-22T21:05:56.909Z,1713819956.909 [DataOverHttps](INFO): Radio surface powered OFF, will not connect. 2024-04-22T21:06:00.377Z,1713819960.377 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread. 2024-04-22T21:06:00.377Z,1713819960.377 [Onboard ThreadHandler](INFO): Thread cancelled. 2024-04-22T21:06:00.381Z,1713819960.381 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler 2024-04-22T21:06:00.381Z,1713819960.381 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2024-04-22T21:06:00.382Z,1713819960.382 [DataOverHttps](INFO): Join timeout helper Thread ID is 3964 2024-04-22T21:06:00.925Z,1713819960.925 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread. 2024-04-22T21:06:00.925Z,1713819960.925 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2024-04-22T21:06:00.941Z,1713819960.941 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler 2024-04-22T21:06:00.941Z,1713819960.941 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2024-04-22T21:06:00.942Z,1713819960.942 [BackseatComponent](INFO): Join timeout helper Thread ID is 3965 2024-04-22T21:06:00.982Z,1713819960.982 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread. 2024-04-22T21:06:00.982Z,1713819960.982 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2024-04-22T21:06:01.001Z,1713819961.001 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2024-04-22T21:06:01.001Z,1713819961.001 [logger ThreadHandler](INFO): Thread cancelled. 2024-04-22T21:06:01.002Z,1713819961.002 [logger](INFO): Join timeout helper Thread ID is 3966 2024-04-22T21:06:01.027Z,1713819961.027 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2024-04-22T21:06:01.028Z,1713819961.028 [logger ThreadHandler](INFO): Thread cancelled. 2024-04-22T21:06:01.045Z,1713819961.045 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2024-04-22T21:06:01.045Z,1713819961.045 [CommandLine ThreadHandler](INFO): Thread cancelled. 2024-04-22T21:06:01.046Z,1713819961.046 [CommandLine](INFO): Join timeout helper Thread ID is 3967 2024-04-22T21:06:01.121Z,1713819961.121 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2024-04-22T21:06:01.121Z,1713819961.121 [CommandLine ThreadHandler](INFO): Thread cancelled. 2024-04-22T21:06:01.125Z,1713819961.125 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler 2024-04-22T21:06:01.125Z,1713819961.125 [CommandExec ThreadHandler](INFO): Thread cancelled. 2024-04-22T21:06:01.126Z,1713819961.126 [CommandExec](INFO): Join timeout helper Thread ID is 3968 2024-04-22T21:06:01.133Z,1713819961.133 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2024-04-22T21:06:01.134Z,1713819961.134 [controlThread ThreadHandler](INFO): Thread cancelled. 2024-04-22T21:06:01.134Z,1713819961.134 [controlThread](INFO): Join timeout helper Thread ID is 3969 2024-04-22T21:06:01.152Z,1713819961.152 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2024-04-22T21:06:01.153Z,1713819961.153 [controlThread](DEBUG): Uninitializing ControlThread 2024-04-22T21:06:01.153Z,1713819961.153 [AHRS_M2](INFO): Powering down 2024-04-22T21:06:01.321Z,1713819961.321 [DVL_micro](INFO): Powering down 2024-04-22T21:06:01.322Z,1713819961.322 [NAL9602](INFO): Powering down 2024-04-22T21:06:01.323Z,1713819961.323 [Sonardyne_Nano](INFO): Powering down 2024-04-22T21:06:01.443Z,1713819961.443 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator. 2024-04-22T21:06:01.443Z,1713819961.443 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator. 2024-04-22T21:06:01.444Z,1713819961.444 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2024-04-22T21:06:01.444Z,1713819961.444 [MissionManager](INFO): Uninitializing Mission Default 2024-04-22T21:06:01.444Z,1713819961.444 [Default] Stopped 2024-04-22T21:06:01.445Z,1713819961.445 [Default](DEBUG): Aggregate::uninitialize Default 2024-04-22T21:06:01.445Z,1713819961.445 [Default:B.GoToSurface] Stopped 2024-04-22T21:06:01.445Z,1713819961.445 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2024-04-22T21:06:01.445Z,1713819961.445 [Default:CheckIn] Stopped 2024-04-22T21:06:01.445Z,1713819961.445 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-04-22T21:06:01.445Z,1713819961.445 [Default:CheckIn:Read_GPS] Stopped 2024-04-22T21:06:01.448Z,1713819961.448 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2024-04-22T21:06:01.448Z,1713819961.448 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2024-04-22T21:06:01.448Z,1713819961.448 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2024-04-22T21:06:01.449Z,1713819961.449 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2024-04-22T21:06:01.449Z,1713819961.449 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2024-04-22T21:06:01.449Z,1713819961.449 [BuoyancyServo](INFO): Powering down 2024-04-22T21:06:01.461Z,1713819961.461 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2024-04-22T21:06:01.461Z,1713819961.461 [ElevatorServo](INFO): Powering down 2024-04-22T21:06:01.462Z,1713819961.462 [MassServo](DEBUG): Uninitialize Mass Servo. 2024-04-22T21:06:01.462Z,1713819961.462 [MassServo](INFO): Powering down 2024-04-22T21:06:01.463Z,1713819961.463 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2024-04-22T21:06:01.463Z,1713819961.463 [RudderServo](INFO): Powering down 2024-04-22T21:06:01.463Z,1713819961.463 [ThrusterHE](DEBUG): Uninitialize Thruster Servo. 2024-04-22T21:06:01.464Z,1713819961.464 [ThrusterHE](INFO): Powering down 2024-04-22T21:06:01.465Z,1713819961.465 [SBIT](DEBUG): Uninitialize SBIT Component. 2024-04-22T21:06:01.465Z,1713819961.465 [IBIT](DEBUG): Uninitialize IBIT Component. 2024-04-22T21:06:01.465Z,1713819961.465 [CBIT](DEBUG): Uninitialize CBIT Component. 2024-04-22T21:06:01.465Z,1713819961.465 [CBIT](DEBUG): Powering off loads. 2024-04-22T21:06:01.476Z,1713819961.476 [CBIT](DEBUG): Disabling WDT. 2024-04-22T21:06:01.488Z,1713819961.488 [CBIT](DEBUG): Opening all GF detection circuits. 2024-04-22T21:06:01.490Z,1713819961.490 [controlThread ThreadHandler](INFO): Thread cancelled. 2024-04-22T21:06:01.533Z,1713819961.533 [DAT ThreadHandler](INFO): Thread cancelled. 2024-04-22T21:06:01.539Z,1713819961.539 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-04-22T21:06:01.541Z,1713819961.541 [Onboard ThreadHandler](INFO): Thread cancelled. 2024-04-22T21:06:01.547Z,1713819961.547 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2024-04-22T21:06:01.590Z,1713819961.590 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2024-04-22T21:06:01.643Z,1713819961.643 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2024-04-22T21:06:01.649Z,1713819961.649 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2024-04-22T21:06:01.670Z,1713819961.670 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-04-22T21:06:01.733Z,1713819961.733 [logger ThreadHandler](INFO): Thread cancelled.