2024-10-14T23:20:43.426Z,1728948043.426 [Supervisor](DEBUG): Initializing supervisor. 2024-10-14T23:20:43.430Z,1728948043.430 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2024-10-14T23:20:43.431Z,1728948043.431 [SyncHandler](INFO): Protected caller Thread ID is 1747 2024-10-14T23:20:43.431Z,1728948043.431 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2024-10-14T23:20:43.432Z,1728948043.432 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2024-10-14T23:20:43.433Z,1728948043.433 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 1748 2024-10-14T23:20:43.436Z,1728948043.436 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2024-10-14T23:20:43.454Z,1728948043.454 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread. 2024-10-14T23:20:43.455Z,1728948043.455 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2024-10-14T23:20:43.455Z,1728948043.455 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 1749 2024-10-14T23:20:43.459Z,1728948043.459 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2024-10-14T23:20:43.460Z,1728948043.460 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2024-10-14T23:20:43.460Z,1728948043.460 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 1750 2024-10-14T23:20:43.462Z,1728948043.462 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2024-10-14T23:20:43.463Z,1728948043.463 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0 2024-10-14T23:20:43.464Z,1728948043.464 [logger ThreadHandler](INFO): Protected caller Thread ID is 1751 2024-10-14T23:20:43.467Z,1728948043.467 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2024-10-14T23:20:43.468Z,1728948043.468 [Supervisor](INFO): Looking for Config files in directory: Config/ 2024-10-14T23:20:43.469Z,1728948043.469 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2024-10-14T23:20:43.814Z,1728948043.814 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2024-10-14T23:20:43.814Z,1728948043.814 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2024-10-14T23:20:43.906Z,1728948043.906 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2024-10-14T23:20:44.024Z,1728948044.024 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2024-10-14T23:20:44.024Z,1728948044.024 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2024-10-14T23:20:44.164Z,1728948044.164 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2024-10-14T23:20:44.165Z,1728948044.165 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2024-10-14T23:20:44.523Z,1728948044.523 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2024-10-14T23:20:44.523Z,1728948044.523 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2024-10-14T23:20:44.630Z,1728948044.630 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2024-10-14T23:20:44.631Z,1728948044.631 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2024-10-14T23:20:45.059Z,1728948045.059 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2024-10-14T23:20:45.059Z,1728948045.059 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2024-10-14T23:20:45.283Z,1728948045.283 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2024-10-14T23:20:45.284Z,1728948045.284 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2024-10-14T23:20:45.373Z,1728948045.373 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg 2024-10-14T23:20:45.622Z,1728948045.622 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock 2024-10-14T23:20:45.623Z,1728948045.623 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2024-10-14T23:20:45.856Z,1728948045.856 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2024-10-14T23:20:45.856Z,1728948045.856 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2024-10-14T23:20:46.395Z,1728948046.395 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2024-10-14T23:20:46.396Z,1728948046.396 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2024-10-14T23:20:46.595Z,1728948046.595 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2024-10-14T23:20:46.595Z,1728948046.595 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2024-10-14T23:20:46.894Z,1728948046.894 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2024-10-14T23:20:46.894Z,1728948046.894 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2024-10-14T23:20:47.778Z,1728948047.778 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2024-10-14T23:20:47.778Z,1728948047.778 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2024-10-14T23:20:48.377Z,1728948048.377 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2024-10-14T23:20:48.379Z,1728948048.379 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-ahi/ 2024-10-14T23:20:48.379Z,1728948048.379 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Control.cfg 2024-10-14T23:20:48.489Z,1728948048.489 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Science.cfg 2024-10-14T23:20:48.617Z,1728948048.617 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/secure.cfg 2024-10-14T23:20:48.711Z,1728948048.711 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Servo.cfg 2024-10-14T23:20:48.829Z,1728948048.829 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/BIT.cfg 2024-10-14T23:20:48.926Z,1728948048.926 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Battery.cfg 2024-10-14T23:20:49.195Z,1728948049.195 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2024-10-14T23:20:49.196Z,1728948049.196 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/vehicle.cfg 2024-10-14T23:20:49.316Z,1728948049.316 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/logger.cfg 2024-10-14T23:20:49.425Z,1728948049.425 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Navigation.cfg 2024-10-14T23:20:49.540Z,1728948049.540 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Sensor.cfg 2024-10-14T23:20:49.691Z,1728948049.691 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Simulator.cfg 2024-10-14T23:20:49.788Z,1728948049.788 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-ahi/root/ 2024-10-14T23:20:49.789Z,1728948049.789 [Supervisor](IMPORTANT): Reloading configuration overrides from Data/persisted.cfg 2024-10-14T23:20:49.808Z,1728948049.808 [Module Loader](DEBUG): Loading Module at Modules/Dock.so 2024-10-14T23:20:49.918Z,1728948049.918 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking) 2024-10-14T23:20:49.918Z,1728948049.918 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2024-10-14T23:20:49.971Z,1728948049.971 [VerticalControl](DEBUG): Construct VerticalControl. 2024-10-14T23:20:50.031Z,1728948050.031 [VerticalControl] Loaded 2024-10-14T23:20:50.031Z,1728948050.031 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2024-10-14T23:20:50.034Z,1728948050.034 [HorizontalControl](DEBUG): Construct HorizontalControl. 2024-10-14T23:20:50.081Z,1728948050.081 [HorizontalControl] Loaded 2024-10-14T23:20:50.082Z,1728948050.082 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2024-10-14T23:20:50.084Z,1728948050.084 [SpeedControl](DEBUG): Construct SpeedControl. 2024-10-14T23:20:50.087Z,1728948050.087 [SpeedControl] Loaded 2024-10-14T23:20:50.087Z,1728948050.087 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2024-10-14T23:20:50.090Z,1728948050.090 [LoopControl](DEBUG): Construct LoopControl. 2024-10-14T23:20:50.090Z,1728948050.090 [LoopControl] Loaded 2024-10-14T23:20:50.091Z,1728948050.091 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2024-10-14T23:20:50.091Z,1728948050.091 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2024-10-14T23:20:50.091Z,1728948050.091 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2024-10-14T23:20:50.145Z,1728948050.145 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2024-10-14T23:20:50.146Z,1728948050.146 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2024-10-14T23:20:50.597Z,1728948050.597 [AHRS_M2] Loaded 2024-10-14T23:20:50.597Z,1728948050.597 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread. 2024-10-14T23:20:50.636Z,1728948050.636 [BackseatComponent](INFO): Found secondary power supply at: /dev/loadC4 2024-10-14T23:20:50.636Z,1728948050.636 [BackseatComponent] Loaded 2024-10-14T23:20:50.637Z,1728948050.637 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread. 2024-10-14T23:20:50.638Z,1728948050.638 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 4089C4E0 2024-10-14T23:20:50.638Z,1728948050.638 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 1833 2024-10-14T23:20:50.641Z,1728948050.641 [LcmUniversalReporter] Loaded 2024-10-14T23:20:50.641Z,1728948050.641 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread. 2024-10-14T23:20:51.446Z,1728948051.446 [BPC1] Loaded 2024-10-14T23:20:51.447Z,1728948051.447 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2024-10-14T23:20:51.519Z,1728948051.519 [DataOverHttps] Loaded 2024-10-14T23:20:51.519Z,1728948051.519 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread. 2024-10-14T23:20:51.520Z,1728948051.520 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 408CC4E0 2024-10-14T23:20:51.520Z,1728948051.520 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 1834 2024-10-14T23:20:51.543Z,1728948051.543 [Depth_Keller] Loaded 2024-10-14T23:20:51.543Z,1728948051.543 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2024-10-14T23:20:51.548Z,1728948051.548 [DropWeight] Loaded 2024-10-14T23:20:51.548Z,1728948051.548 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread. 2024-10-14T23:20:51.612Z,1728948051.612 [NAL9602] Loaded 2024-10-14T23:20:51.612Z,1728948051.612 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2024-10-14T23:20:51.641Z,1728948051.641 [Onboard] Loaded 2024-10-14T23:20:51.642Z,1728948051.642 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread. 2024-10-14T23:20:51.643Z,1728948051.643 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 408FC4E0 2024-10-14T23:20:51.643Z,1728948051.643 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 1835 2024-10-14T23:20:51.657Z,1728948051.657 [Power24vConverter] Loaded 2024-10-14T23:20:51.657Z,1728948051.657 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread. 2024-10-14T23:20:51.672Z,1728948051.672 [Radio_Surface] Loaded 2024-10-14T23:20:51.672Z,1728948051.672 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2024-10-14T23:20:51.673Z,1728948051.673 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 4092C4E0 2024-10-14T23:20:51.674Z,1728948051.674 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 1836 2024-10-14T23:20:51.689Z,1728948051.689 [Sonardyne_Nano] Loaded 2024-10-14T23:20:51.689Z,1728948051.689 [ComponentRegistry](DEBUG): SyncComponent "Sonardyne_Nano" handled in the control thread. 2024-10-14T23:20:51.712Z,1728948051.712 [Waterlinked] Loaded 2024-10-14T23:20:51.713Z,1728948051.713 [ComponentRegistry](DEBUG): SyncComponent "Waterlinked" handled in the control thread. 2024-10-14T23:20:51.713Z,1728948051.713 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2024-10-14T23:20:51.714Z,1728948051.714 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2024-10-14T23:20:51.724Z,1728948051.724 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2024-10-14T23:20:51.724Z,1728948051.724 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2024-10-14T23:20:51.750Z,1728948051.750 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2024-10-14T23:20:51.750Z,1728948051.750 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2024-10-14T23:20:51.890Z,1728948051.890 [SBIT](DEBUG): Construct Startup Built In Test. 2024-10-14T23:20:51.899Z,1728948051.899 [SBIT] Loaded 2024-10-14T23:20:51.899Z,1728948051.899 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2024-10-14T23:20:51.902Z,1728948051.902 [IBIT](DEBUG): Construct Initiated Built In Test. 2024-10-14T23:20:51.914Z,1728948051.914 [IBIT] Loaded 2024-10-14T23:20:51.915Z,1728948051.915 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2024-10-14T23:20:51.920Z,1728948051.920 [CBIT](DEBUG): Construct Continuous Built In Test. 2024-10-14T23:20:52.025Z,1728948052.025 [CBIT] Loaded 2024-10-14T23:20:52.025Z,1728948052.025 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2024-10-14T23:20:52.025Z,1728948052.025 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2024-10-14T23:20:52.026Z,1728948052.026 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2024-10-14T23:20:52.360Z,1728948052.360 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2024-10-14T23:20:52.361Z,1728948052.361 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2024-10-14T23:20:52.411Z,1728948052.411 [DepthRateCalculator] Loaded 2024-10-14T23:20:52.411Z,1728948052.411 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2024-10-14T23:20:52.416Z,1728948052.416 [PitchRateCalculator] Loaded 2024-10-14T23:20:52.416Z,1728948052.416 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2024-10-14T23:20:52.426Z,1728948052.426 [SpeedCalculator] Loaded 2024-10-14T23:20:52.427Z,1728948052.427 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2024-10-14T23:20:52.431Z,1728948052.431 [YawRateCalculator] Loaded 2024-10-14T23:20:52.431Z,1728948052.431 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2024-10-14T23:20:52.450Z,1728948052.450 [ElevatorOffsetCalculator] Loaded 2024-10-14T23:20:52.450Z,1728948052.450 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread. 2024-10-14T23:20:52.450Z,1728948052.450 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2024-10-14T23:20:52.451Z,1728948052.451 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2024-10-14T23:20:52.622Z,1728948052.622 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2024-10-14T23:20:52.622Z,1728948052.622 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2024-10-14T23:20:52.731Z,1728948052.731 [DeadReckonUsingMultipleVelocitySources] Loaded 2024-10-14T23:20:52.731Z,1728948052.731 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2024-10-14T23:20:52.775Z,1728948052.775 [DeadReckonUsingSpeedCalculator] Loaded 2024-10-14T23:20:52.775Z,1728948052.775 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread. 2024-10-14T23:20:52.817Z,1728948052.817 [DeadReckonWithRespectToSeafloor] Loaded 2024-10-14T23:20:52.818Z,1728948052.818 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonWithRespectToSeafloor" handled in the control thread. 2024-10-14T23:20:52.831Z,1728948052.831 [NavChart] Loaded 2024-10-14T23:20:52.831Z,1728948052.831 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2024-10-14T23:20:52.837Z,1728948052.837 [UniversalFixResidualReporter] Loaded 2024-10-14T23:20:52.837Z,1728948052.837 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2024-10-14T23:20:52.838Z,1728948052.838 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2024-10-14T23:20:52.838Z,1728948052.838 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2024-10-14T23:20:52.984Z,1728948052.984 [BuoyancyServo] Loaded 2024-10-14T23:20:52.985Z,1728948052.985 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2024-10-14T23:20:53.007Z,1728948053.007 [ElevatorServo] Loaded 2024-10-14T23:20:53.008Z,1728948053.008 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2024-10-14T23:20:53.030Z,1728948053.030 [MassServo] Loaded 2024-10-14T23:20:53.030Z,1728948053.030 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2024-10-14T23:20:53.050Z,1728948053.050 [RudderServo] Loaded 2024-10-14T23:20:53.051Z,1728948053.051 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2024-10-14T23:20:53.067Z,1728948053.067 [ThrusterHE] Loaded 2024-10-14T23:20:53.067Z,1728948053.067 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread. 2024-10-14T23:20:53.067Z,1728948053.067 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2024-10-14T23:20:53.068Z,1728948053.068 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2024-10-14T23:20:53.241Z,1728948053.241 [CTD_Seabird] Loaded 2024-10-14T23:20:53.241Z,1728948053.241 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread. 2024-10-14T23:20:53.242Z,1728948053.242 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40BA74E0 2024-10-14T23:20:53.242Z,1728948053.242 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 1837 2024-10-14T23:20:53.278Z,1728948053.278 [ESPComponent] Loaded 2024-10-14T23:20:53.278Z,1728948053.278 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread. 2024-10-14T23:20:53.300Z,1728948053.300 [PAR_Licor] Loaded 2024-10-14T23:20:53.301Z,1728948053.301 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread. 2024-10-14T23:20:53.345Z,1728948053.345 [WetLabsBB2FL] Loaded 2024-10-14T23:20:53.345Z,1728948053.345 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread. 2024-10-14T23:20:53.346Z,1728948053.346 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40BD74E0 2024-10-14T23:20:53.347Z,1728948053.347 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 1838 2024-10-14T23:20:53.347Z,1728948053.347 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2024-10-14T23:20:53.354Z,1728948053.354 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2024-10-14T23:20:53.356Z,1728948053.356 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2024-10-14T23:20:53.368Z,1728948053.368 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2024-10-14T23:20:53.369Z,1728948053.369 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40C074E0 2024-10-14T23:20:53.369Z,1728948053.369 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 1839 2024-10-14T23:20:53.373Z,1728948053.373 [Supervisor](INFO): Main Thread ID is 827 2024-10-14T23:20:53.374Z,1728948053.374 [Supervisor](DEBUG): Running supervisor. 2024-10-14T23:20:53.374Z,1728948053.374 [CommandExec ThreadHandler](INFO): Handler Thread ID is 1840 2024-10-14T23:20:53.375Z,1728948053.375 [CommandExec](INFO): Initializing the command executive. 2024-10-14T23:20:53.376Z,1728948053.376 [CommandLine ThreadHandler](INFO): Handler Thread ID is 1841 2024-10-14T23:20:53.379Z,1728948053.379 [controlThread ThreadHandler](INFO): Handler Thread ID is 1842 2024-10-14T23:20:53.380Z,1728948053.380 [controlThread](DEBUG): Initializing ControlThread 2024-10-14T23:20:53.381Z,1728948053.381 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2024-10-14T23:20:53.382Z,1728948053.382 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2024-10-14T23:20:53.383Z,1728948053.383 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2024-10-14T23:20:53.383Z,1728948053.383 [LoopControl](DEBUG): Initialize LoopControlComponent. 2024-10-14T23:20:53.390Z,1728948053.390 [SBIT](INFO): Initialize SBIT Component. 2024-10-14T23:20:53.391Z,1728948053.391 [SBIT](IMPORTANT): git: 2024-10-14 2024-10-14T23:20:53.391Z,1728948053.391 [SBIT](INFO): git hash: 9dce2eadf13f2d8198d8ed7416351995a1f4c5f3 2024-10-14T23:20:53.391Z,1728948053.391 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2024-10-14T23:20:53.392Z,1728948053.392 [SBIT](INFO): Kernel Reporting Different Version From Configuration. Kernel Expected: #639 PREEMPT Wed Mar 12 12:53:33 PDT 2014 Kernel Reported: #1 PREEMPT Tue Nov 28 15:04:22 PST 2023 2024-10-14T23:20:53.394Z,1728948053.394 [SBIT](INFO): Beginning SBIT in 82.000000 seconds. 2024-10-14T23:20:53.394Z,1728948053.394 [IBIT](INFO): Initialize IBIT Component. 2024-10-14T23:20:53.395Z,1728948053.395 [CBIT](DEBUG): Initialize CBIT Component. 2024-10-14T23:20:53.396Z,1728948053.396 [logger ThreadHandler](INFO): Handler Thread ID is 1843 2024-10-14T23:20:53.408Z,1728948053.408 [CBIT](DEBUG): Initialized mux pins. 2024-10-14T23:20:53.408Z,1728948053.408 [CBIT](DEBUG): Initializing the watchdog timer. 2024-10-14T23:20:53.416Z,1728948053.416 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 1844 2024-10-14T23:20:53.428Z,1728948053.428 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 1845 2024-10-14T23:20:53.430Z,1728948053.430 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2024-10-14T23:20:53.432Z,1728948053.432 [CBIT](INFO): Last reboot was NOT due to watchdog timer. 2024-10-14T23:20:53.432Z,1728948053.432 [CBIT](DEBUG): Initializing heartbeat. 2024-10-14T23:20:53.440Z,1728948053.440 [Onboard ThreadHandler](INFO): Handler Thread ID is 1846 2024-10-14T23:20:53.458Z,1728948053.458 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 1847 2024-10-14T23:20:53.477Z,1728948053.477 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 1848 2024-10-14T23:20:53.477Z,1728948053.477 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2024-10-14T23:20:53.481Z,1728948053.481 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 1850 2024-10-14T23:20:53.484Z,1728948053.484 [WetLabsBB2FL](INFO): Powering up 2024-10-14T23:20:53.485Z,1728948053.485 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 1852 2024-10-14T23:20:53.488Z,1728948053.488 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2HA05M.000 2024-10-14T23:20:53.488Z,1728948053.488 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2HA05M.000 2024-10-14T23:20:53.488Z,1728948053.488 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3HA20M.000 2024-10-14T23:20:53.489Z,1728948053.489 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3HA20M.000 2024-10-14T23:20:53.489Z,1728948053.489 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4HA51M.000 2024-10-14T23:20:53.489Z,1728948053.489 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4HA51M.000 2024-10-14T23:20:53.489Z,1728948053.489 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4HA51M.000 2024-10-14T23:20:53.489Z,1728948053.489 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4HA51M.000 2024-10-14T23:20:53.489Z,1728948053.489 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5HA53M.000 2024-10-14T23:20:53.489Z,1728948053.489 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5HA53M.000 2024-10-14T23:20:53.490Z,1728948053.490 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5HA55M.000 2024-10-14T23:20:53.490Z,1728948053.490 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5HA55M.000 2024-10-14T23:20:53.504Z,1728948053.504 [CBIT](DEBUG): Deactivating GF circuits. 2024-10-14T23:20:53.504Z,1728948053.504 [CBIT](DEBUG): Deactivating emergency mode. 2024-10-14T23:20:53.544Z,1728948053.544 [CBIT](DEBUG): Backplane powered. 2024-10-14T23:20:53.544Z,1728948053.544 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2024-10-14T23:20:53.545Z,1728948053.545 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2024-10-14T23:20:53.545Z,1728948053.545 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2024-10-14T23:20:53.545Z,1728948053.545 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2024-10-14T23:20:53.546Z,1728948053.546 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator. 2024-10-14T23:20:53.547Z,1728948053.547 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-10-14T23:20:53.548Z,1728948053.548 [NavChart](DEBUG): Initialize NavChart Navigation. 2024-10-14T23:20:53.548Z,1728948053.548 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2024-10-14T23:20:53.552Z,1728948053.552 [MissionManager](IMPORTANT): Using TethysL tl-to-tx parser 2024-10-14T23:20:53.553Z,1728948053.553 [MissionManager](INFO): Loading Mission from file: Missions/Startup.tl 2024-10-14T23:20:53.553Z,1728948053.553 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Startup.tl 2024-10-14T23:20:53.554Z,1728948053.554 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Startup.tl 2024-10-14T23:20:53.622Z,1728948053.622 [MissionManager](DEBUG): TethyslAPI: Missions/Startup.tl translated into: 2024-10-14T23:20:53.627Z,1728948053.627 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2024-10-14T23:20:53.671Z,1728948053.671 [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-10-14T23:20:53.671Z,1728948053.671 [MissionManager](INFO): Loading Mission from file: Missions/Default.tl 2024-10-14T23:20:53.671Z,1728948053.671 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Default.tl 2024-10-14T23:20:53.673Z,1728948053.673 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Default.tl 2024-10-14T23:20:53.864Z,1728948053.864 [Radio_Surface](INFO): Powering up 2024-10-14T23:20:53.994Z,1728948053.994 [MissionManager](DEBUG): TethyslAPI: Missions/Default.tl translated into: 0 13 Burn on Dropped weight due to communications timeout. 5 Default mission has been running for Restarting logs and Default mission. restart logs 2024-10-14T23:20:54.016Z,1728948054.016 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min 2024-10-14T23:20:54.017Z,1728948054.017 [Default:A.Wait](DEBUG): Construct Wait. 2024-10-14T23:20:54.019Z,1728948054.019 [Default:B.GoToSurface](DEBUG): Construct GoToSurface. 2024-10-14T23:20:54.064Z,1728948054.064 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2024-10-14T23:20:54.066Z,1728948054.066 [Default:CheckIn:C.Wait](DEBUG): Construct Wait. 2024-10-14T23:20:54.092Z,1728948054.092 [Default:E.Execute](DEBUG): Construct Execute. 2024-10-14T23:20:54.095Z,1728948054.095 [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-10-14T23:20:54.100Z,1728948054.100 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,DropWeight,NAL9602,Power24vConverter,Sonardyne_Nano,Waterlinked,ESPComponent,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,DeadReckonUsingSpeedCalculator,DeadReckonWithRespectToSeafloor,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter, 2024-10-14T23:20:54.116Z,1728948054.116 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2024-10-14T23:20:54.186Z,1728948054.186 [Depth_Keller](ERROR): Pressure or depth reading out of range: -1.140412 decibar, -1.132002 m 2024-10-14T23:20:54.187Z,1728948054.187 [Power24vConverter](INFO): Powering up. 2024-10-14T23:20:54.188Z,1728948054.188 [Sonardyne_Nano](INFO): Initializing. 2024-10-14T23:20:54.256Z,1728948054.256 [DepthRateCalculator](ERROR): Depth measurement is not active 2024-10-14T23:20:54.278Z,1728948054.278 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2024-10-14T23:20:54.284Z,1728948054.284 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2024-10-14T23:20:54.285Z,1728948054.285 [ElevatorServo](DEBUG): Initializing EZServoServo. 2024-10-14T23:20:54.292Z,1728948054.292 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2024-10-14T23:20:54.293Z,1728948054.293 [MassServo](DEBUG): Initializing EZServoServo. 2024-10-14T23:20:54.300Z,1728948054.300 [MassServo](DEBUG): Initializing MassServo. 2024-10-14T23:20:54.301Z,1728948054.301 [RudderServo](DEBUG): Initializing EZServoServo. 2024-10-14T23:20:54.309Z,1728948054.309 [RudderServo](DEBUG): Initializing RudderServo. 2024-10-14T23:20:54.309Z,1728948054.309 [ThrusterHE](DEBUG): Initializing EZServoServo. 2024-10-14T23:20:54.316Z,1728948054.316 [ThrusterHE](DEBUG): Initializing ThrusterHE. 2024-10-14T23:20:55.592Z,1728948055.592 [WetLabsBB2FL](INFO): Powering down 2024-10-14T23:20:56.130Z,1728948056.130 [Sonardyne_Nano](ERROR): Failed to get valid response or reached max queue size, flushing UART 2024-10-14T23:20:57.416Z,1728948057.416 [Sonardyne_Nano](IMPORTANT): Found beacon with acoustic ID 2311 2024-10-14T23:21:00.009Z,1728948060.009 [ThrusterHE](ERROR): Zero Speed Commanded. 2024-10-14T23:21:22.002Z,1728948082.002 [NAL9602](INFO): Powering up NAL9602 2024-10-14T23:21:28.132Z,1728948088.132 [Waterlinked](INFO): Powering down 2024-10-14T23:21:32.902Z,1728948092.902 [NAL9602](INFO): NAL9602 initialized 2024-10-14T23:22:07.240Z,1728948127.240 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-10-14T23:22:16.145Z,1728948136.145 [SBIT](IMPORTANT): Beginning Startup BIT 2024-10-14T23:22:16.149Z,1728948136.149 [CBIT](IMPORTANT): Beginning ground fault scan 2024-10-14T23:22:19.758Z,1728948139.758 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-10-14T23:22:27.228Z,1728948147.228 [CBIT](IMPORTANT): No ground fault detected mA: CHAN A0 (Batt): 0.001429 CHAN A1 (24V): 0.003176 CHAN A2 (12V): 0.001123 CHAN A3 (5V): -0.001013 CHAN B0 (3.3V): 0.000419 CHAN B1 (3.15aV): 0.000434 CHAN B2 (3.15bV): 0.000507 CHAN B3 (GND): -0.000737 OPEN: 0.006719 Full Scale: +/- 1 mA 2024-10-14T23:22:32.281Z,1728948152.281 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-10-14T23:22:45.209Z,1728948165.209 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-10-14T23:23:10.297Z,1728948190.297 [SBIT](IMPORTANT): SBIT PASSED 2024-10-14T23:23:10.297Z,1728948190.297 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg 2024-10-14T23:23:10.298Z,1728948190.298 [SBIT](IMPORTANT): BPC1.batteryMissingStickThreshold=15 count; 2024-10-14T23:23:10.298Z,1728948190.298 [SBIT](IMPORTANT): DAT.loadAtStartup=0 bool; 2024-10-14T23:23:10.298Z,1728948190.298 [SBIT](IMPORTANT): DATMMP.loadAtStartup=1 bool; 2024-10-14T23:23:10.298Z,1728948190.298 [SBIT](IMPORTANT): DATMMP.simulateHardware=0 bool; 2024-10-14T23:23:10.298Z,1728948190.298 [SBIT](IMPORTANT): DATMMP.surfaceThreshold=2 meter; 2024-10-14T23:23:10.298Z,1728948190.298 [SBIT](IMPORTANT): ESPComponent.loadAtStartup=1 bool; 2024-10-14T23:23:10.299Z,1728948190.299 [SBIT](IMPORTANT): ESPComponent.sampleTimeout=30 minute; 2024-10-14T23:23:10.299Z,1728948190.299 [SBIT](IMPORTANT): ESPComponent.simulateHardware=1 bool; 2024-10-14T23:23:10.299Z,1728948190.299 [SBIT](IMPORTANT): Express linearApproximation TrackAcousticContact.range_to_contact 15.000000 meter; 2024-10-14T23:23:10.299Z,1728948190.299 [SBIT](IMPORTANT): Express linearApproximation _.planktivore_HM_AvgRois 0.600000 count_per_second; 2024-10-14T23:23:10.299Z,1728948190.299 [SBIT](IMPORTANT): Express linearApproximation _.planktivore_LM_AvgRois 0.600000 count_per_second; 2024-10-14T23:23:10.299Z,1728948190.299 [SBIT](IMPORTANT): Express linearApproximation _.planktivore_caseHumidity 10.000000 percent; 2024-10-14T23:23:10.299Z,1728948190.299 [SBIT](IMPORTANT): Express linearApproximation _.planktivore_diatoms 30.000000 count_per_milliliter; 2024-10-14T23:23:10.299Z,1728948190.299 [SBIT](IMPORTANT): Express linearApproximation _.planktivore_dinoflagellates 30.000000 count_per_milliliter; 2024-10-14T23:23:10.299Z,1728948190.299 [SBIT](IMPORTANT): Express linearApproximation _.predict_plankton_data_pct_dinos_sqerr 0.100000 none; 2024-10-14T23:23:10.300Z,1728948190.300 [SBIT](IMPORTANT): Express linearApproximation height_above_sea_floor 10.000000 meter; 2024-10-14T23:23:10.300Z,1728948190.300 [SBIT](IMPORTANT): IBIT.batteryCapacityThreshold=20 ampere_hour; 2024-10-14T23:23:10.300Z,1728948190.300 [SBIT](IMPORTANT): IBIT.batteryVoltageThreshold=12 volt; 2024-10-14T23:23:10.300Z,1728948190.300 [SBIT](IMPORTANT): Normal all _.predict_plankton_data_pct_dinos_sqerr; 2024-10-14T23:23:10.300Z,1728948190.300 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=175.568229 cubic_centimeter; 2024-10-14T23:23:10.300Z,1728948190.300 [SBIT](IMPORTANT): VerticalControl.massDefault=15.569106 millimeter; 2024-10-14T23:23:10.300Z,1728948190.300 [SBIT](IMPORTANT): Waterlinked.loadAtStartup=1 bool; 2024-10-14T23:23:10.712Z,1728948190.712 [MissionManager](IMPORTANT): Started mission Startup 2024-10-14T23:23:10.712Z,1728948190.712 [Startup] Running Loop=1 2024-10-14T23:23:10.712Z,1728948190.712 [Startup](DEBUG): Aggregate::initialize Startup 2024-10-14T23:23:10.713Z,1728948190.713 [Startup:A.GoToSurface] Running Loop=1 2024-10-14T23:23:10.713Z,1728948190.713 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2024-10-14T23:23:10.713Z,1728948190.713 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2024-10-14T23:23:10.714Z,1728948190.714 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2024-10-14T23:23:10.714Z,1728948190.714 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2024-10-14T23:23:10.714Z,1728948190.714 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2024-10-14T23:23:10.714Z,1728948190.714 [Startup:A.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds. 2024-10-14T23:23:10.715Z,1728948190.715 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2024-10-14T23:23:10.717Z,1728948190.717 [Startup:StartupSatComms] Running Loop=1 2024-10-14T23:23:10.717Z,1728948190.717 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms 2024-10-14T23:23:10.717Z,1728948190.717 [Startup:StartupSatComms:A] Running Loop=1 2024-10-14T23:23:11.104Z,1728948191.104 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix 2024-10-14T23:23:36.287Z,1728948216.287 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.005027 2024-10-14T23:23:53.908Z,1728948233.908 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1 2024-10-14T23:23:53.908Z,1728948233.908 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-10-14T23:23:53.909Z,1728948233.909 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 1 2024-10-14T23:23:53.909Z,1728948233.909 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-10-14T23:23:53.910Z,1728948233.910 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1 2024-10-14T23:23:53.910Z,1728948233.910 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-10-14T23:23:53.921Z,1728948233.921 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-10-14T23:23:53.922Z,1728948233.922 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-10-14T23:23:53.922Z,1728948233.922 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-10-14T23:23:54.335Z,1728948234.335 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-10-14T23:23:54.335Z,1728948234.335 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1 2024-10-14T23:23:54.347Z,1728948234.347 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-10-14T23:23:54.347Z,1728948234.347 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 1 2024-10-14T23:23:54.348Z,1728948234.348 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-10-14T23:23:54.348Z,1728948234.348 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1 2024-10-14T23:23:54.713Z,1728948234.713 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-10-14T23:24:10.872Z,1728948250.872 [Startup:StartupSatComms:A](INFO): Timed out from 2024-10-14T23:23:10.7Z 2024-10-14T23:24:10.872Z,1728948250.872 [Startup:StartupSatComms:A] Stopped 2024-10-14T23:24:10.872Z,1728948250.872 [Startup:StartupSatComms:B] Running Loop=1 2024-10-14T23:24:11.279Z,1728948251.279 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications 2024-10-14T23:24:17.847Z,1728948257.847 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20241014T214635/Courier0034.lzma 2024-10-14T23:24:18.850Z,1728948258.850 [DataOverHttps](INFO): Moved sent file to Logs/20241014T214635/Courier0034.lzma.bak 2024-10-14T23:24:18.850Z,1728948258.850 [DataOverHttps](INFO): SBD MOMSN=23296868 2024-10-14T23:25:03.695Z,1728948303.695 [DataOverHttps](INFO): Sending 151 bytes from file Logs/20241014T232043/Courier0000.lzma 2024-10-14T23:25:04.698Z,1728948304.698 [DataOverHttps](INFO): Moved sent file to Logs/20241014T232043/Courier0000.lzma.bak 2024-10-14T23:25:04.698Z,1728948304.698 [DataOverHttps](INFO): SBD MOMSN=23296875 2024-10-14T23:25:11.100Z,1728948311.100 [Startup:StartupSatComms:B](INFO): Timed out from 2024-10-14T23:24:10.9Z 2024-10-14T23:25:11.100Z,1728948311.100 [Startup:StartupSatComms:B] Stopped 2024-10-14T23:25:11.101Z,1728948311.101 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms 2024-10-14T23:25:11.101Z,1728948311.101 [Startup:StartupSatComms] Stopped 2024-10-14T23:25:11.101Z,1728948311.101 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms 2024-10-14T23:25:11.102Z,1728948311.102 [Startup](INFO): Completed Startup 2024-10-14T23:25:11.102Z,1728948311.102 [MissionManager](INFO): Startup is completed. 2024-10-14T23:25:11.102Z,1728948311.102 [MissionManager](INFO): Uninitializing Mission Startup 2024-10-14T23:25:11.102Z,1728948311.102 [Startup] Stopped 2024-10-14T23:25:11.102Z,1728948311.102 [Startup](DEBUG): Aggregate::uninitialize Startup 2024-10-14T23:25:11.102Z,1728948311.102 [Startup:A.GoToSurface] Stopped 2024-10-14T23:25:11.102Z,1728948311.102 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2024-10-14T23:25:11.487Z,1728948311.487 [MissionManager](IMPORTANT): Started mission Default 2024-10-14T23:25:11.487Z,1728948311.487 [Default] Running Loop=1 2024-10-14T23:25:11.488Z,1728948311.488 [Default](DEBUG): Aggregate::initialize Default 2024-10-14T23:25:11.488Z,1728948311.488 [Default:B.GoToSurface] Running Loop=1 2024-10-14T23:25:11.488Z,1728948311.488 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2024-10-14T23:25:11.488Z,1728948311.488 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2024-10-14T23:25:11.489Z,1728948311.489 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2024-10-14T23:25:11.489Z,1728948311.489 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2024-10-14T23:25:11.489Z,1728948311.489 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2024-10-14T23:25:11.489Z,1728948311.489 [Default:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds. 2024-10-14T23:25:11.490Z,1728948311.490 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2024-10-14T23:25:11.490Z,1728948311.490 [Default:A.Wait] Running Loop=1 2024-10-14T23:25:11.490Z,1728948311.490 [Default:A.Wait](DEBUG): Initialize Wait Component. 2024-10-14T23:25:18.728Z,1728948318.728 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-10-14T23:25:20.325Z,1728948320.325 [DataOverHttps](INFO): Sending 953 bytes from file Logs/20241014T214635/Express0035.lzma 2024-10-14T23:25:21.326Z,1728948321.326 [DataOverHttps](INFO): Moved sent file to Logs/20241014T214635/Express0035.lzma.bak 2024-10-14T23:25:21.326Z,1728948321.326 [DataOverHttps](INFO): SBD MOMSN=23296901 2024-10-14T23:25:24.864Z,1728948324.864 [Default:A.Wait](INFO): Done Waiting. 2024-10-14T23:25:24.864Z,1728948324.864 [Default:A.Wait] Stopped 2024-10-14T23:25:24.864Z,1728948324.864 [Default:A.Wait](DEBUG): Uninitialize Wait Component. 2024-10-14T23:25:25.229Z,1728948325.229 [Default:CheckIn] Running Loop=1 2024-10-14T23:25:25.229Z,1728948325.229 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-10-14T23:25:25.229Z,1728948325.229 [Default:CheckIn:Read_GPS] Running Loop=1 2024-10-14T23:25:25.645Z,1728948325.645 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix 2024-10-14T23:25:31.656Z,1728948331.656 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-10-14T23:25:35.913Z,1728948335.913 [CommandExec](IMPORTANT): got command failComponent 2024-10-14T23:25:35.913Z,1728948335.913 [CommandExec](IMPORTANT): Failed components: 2024-10-14T23:25:35.913Z,1728948335.913 [CommandExec](IMPORTANT): No failed Components. 2024-10-14T23:25:39.561Z,1728948339.561 [CommandExec](IMPORTANT): got command gfscan 2024-10-14T23:25:39.785Z,1728948339.785 [CBIT](IMPORTANT): Beginning ground fault scan 2024-10-14T23:25:44.585Z,1728948344.585 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-10-14T23:25:44.866Z,1728948344.866 [CommandExec](IMPORTANT): got command strobe off 2024-10-14T23:25:44.866Z,1728948344.866 [CommandExec](IMPORTANT): Deactivating strobe 2024-10-14T23:25:50.675Z,1728948350.675 [CBIT](IMPORTANT): Ground fault detected mA: CHAN A0 (Batt): 0.030395 CHAN A1 (24V): 0.005939 CHAN A2 (12V): 0.000789 CHAN A3 (5V): -0.003231 CHAN B0 (3.3V): -0.000248 CHAN B1 (3.15aV): -0.000272 CHAN B2 (3.15bV): -0.000229 CHAN B3 (GND): -0.001131 OPEN: 0.006707 Full Scale: +/- 1 mA 2024-10-14T23:25:56.857Z,1728948356.857 [CommandExec](IMPORTANT): got command gfscan 2024-10-14T23:25:57.137Z,1728948357.137 [CBIT](IMPORTANT): Beginning ground fault scan 2024-10-14T23:25:57.917Z,1728948357.917 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-10-14T23:26:08.087Z,1728948368.087 [CBIT](IMPORTANT): Ground fault detected mA: CHAN A0 (Batt): 0.030642 CHAN A1 (24V): 0.005550 CHAN A2 (12V): 0.000775 CHAN A3 (5V): -0.002195 CHAN B0 (3.3V): -0.000614 CHAN B1 (3.15aV): -0.000360 CHAN B2 (3.15bV): 0.000124 CHAN B3 (GND): -0.001360 OPEN: 0.006987 Full Scale: +/- 1 mA 2024-10-14T23:26:10.440Z,1728948370.440 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-10-14T23:26:14.653Z,1728948374.653 [CommandExec](IMPORTANT): got command gfscan 2024-10-14T23:26:14.913Z,1728948374.913 [CBIT](IMPORTANT): Beginning ground fault scan 2024-10-14T23:26:22.964Z,1728948382.964 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-10-14T23:26:25.838Z,1728948385.838 [CBIT](IMPORTANT): No ground fault detected mA: CHAN A0 (Batt): 0.003443 CHAN A1 (24V): 0.005429 CHAN A2 (12V): 0.001114 CHAN A3 (5V): -0.003051 CHAN B0 (3.3V): -0.000745 CHAN B1 (3.15aV): -0.000576 CHAN B2 (3.15bV): -0.000847 CHAN B3 (GND): -0.000742 OPEN: 0.006868 Full Scale: +/- 1 mA 2024-10-14T23:26:29.960Z,1728948389.960 [CommandExec](IMPORTANT): got command failComponent 2024-10-14T23:26:29.961Z,1728948389.961 [CommandExec](IMPORTANT): Failed components: 2024-10-14T23:26:29.961Z,1728948389.961 [CommandExec](IMPORTANT): No failed Components. 2024-10-14T23:26:35.894Z,1728948395.894 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-10-14T23:26:35.909Z,1728948395.909 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2024-10-14T23:26:36.051Z,1728948396.051 [CommandLine](INFO): End of History 2024-10-14T23:26:36.052Z,1728948396.052 [CommandLine](INFO): End of History 2024-10-14T23:26:36.053Z,1728948396.053 [CommandLine](INFO): End of History 2024-10-14T23:26:36.083Z,1728948396.083 [CommandLine](INFO): End of History 2024-10-14T23:26:36.084Z,1728948396.084 [CommandLine](INFO): End of History 2024-10-14T23:26:36.085Z,1728948396.085 [CommandLine](INFO): End of History 2024-10-14T23:26:36.142Z,1728948396.142 [CommandLine](INFO): End of History 2024-10-14T23:26:36.143Z,1728948396.143 [CommandLine](INFO): End of History 2024-10-14T23:26:36.144Z,1728948396.144 [CommandLine](INFO): End of History 2024-10-14T23:26:48.416Z,1728948408.416 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-10-14T23:26:54.921Z,1728948414.921 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2 2024-10-14T23:26:54.921Z,1728948414.921 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-10-14T23:26:54.923Z,1728948414.923 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 2 2024-10-14T23:26:54.923Z,1728948414.923 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-10-14T23:26:54.924Z,1728948414.924 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 2 2024-10-14T23:26:54.924Z,1728948414.924 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-10-14T23:26:54.987Z,1728948414.987 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-10-14T23:26:54.987Z,1728948414.987 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-10-14T23:26:54.987Z,1728948414.987 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-10-14T23:26:55.316Z,1728948415.316 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-10-14T23:26:55.316Z,1728948415.316 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2 2024-10-14T23:26:55.317Z,1728948415.317 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-10-14T23:26:55.317Z,1728948415.317 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 2 2024-10-14T23:26:55.318Z,1728948415.318 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-10-14T23:26:55.318Z,1728948415.318 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 2 2024-10-14T23:26:55.706Z,1728948415.706 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-10-14T23:27:01.344Z,1728948421.344 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-10-14T23:27:14.273Z,1728948434.273 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-10-14T23:27:27.200Z,1728948447.200 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-10-14T23:27:45.390Z,1728948465.390 [BPC1](ERROR): Battery stick #59 (s/n: 0184) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0. 2024-10-14T23:27:45.390Z,1728948465.390 [BPC1](INFO): Calculating totals. Valid battery stick count: 45. Valid reserve battery stick count: 5. 2024-10-14T23:27:45.394Z,1728948465.394 [BPC1](INFO): Received data from all battery sticks. 2024-10-14T23:28:08.548Z,1728948488.548 [CommandExec](IMPORTANT): got command failComponent 2024-10-14T23:28:08.548Z,1728948488.548 [CommandExec](IMPORTANT): Failed components: 2024-10-14T23:28:08.549Z,1728948488.549 [CommandExec](IMPORTANT): No failed Components. 2024-10-14T23:29:55.899Z,1728948595.899 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3 2024-10-14T23:29:55.899Z,1728948595.899 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-10-14T23:29:55.900Z,1728948595.900 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 3 2024-10-14T23:29:55.900Z,1728948595.900 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-10-14T23:29:55.902Z,1728948595.902 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 3 2024-10-14T23:29:55.902Z,1728948595.902 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-10-14T23:29:55.917Z,1728948595.917 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-10-14T23:29:55.918Z,1728948595.918 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-10-14T23:29:55.918Z,1728948595.918 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-10-14T23:29:56.307Z,1728948596.307 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-10-14T23:29:56.307Z,1728948596.307 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3 2024-10-14T23:29:56.307Z,1728948596.307 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-10-14T23:29:56.307Z,1728948596.307 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 3 2024-10-14T23:29:56.324Z,1728948596.324 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-10-14T23:29:56.324Z,1728948596.324 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 3 2024-10-14T23:29:56.706Z,1728948596.706 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-10-14T23:30:25.427Z,1728948625.427 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-10-14T23:25:25.2Z 2024-10-14T23:30:25.427Z,1728948625.427 [Default:CheckIn:Read_GPS] Stopped 2024-10-14T23:30:25.427Z,1728948625.427 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-10-14T23:30:25.837Z,1728948625.837 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications 2024-10-14T23:30:32.163Z,1728948632.163 [DataOverHttps](INFO): Sending 168 bytes from file Logs/20241014T232043/Courier0004.lzma 2024-10-14T23:30:33.166Z,1728948633.166 [DataOverHttps](INFO): Moved sent file to Logs/20241014T232043/Courier0004.lzma.bak 2024-10-14T23:30:33.166Z,1728948633.166 [DataOverHttps](INFO): SBD MOMSN=23296944 2024-10-14T23:30:48.645Z,1728948648.645 [DataOverHttps](INFO): Sending 1137 bytes from file Logs/20241014T232043/Express0001.lzma 2024-10-14T23:30:49.646Z,1728948649.646 [DataOverHttps](INFO): Moved sent file to Logs/20241014T232043/Express0001.lzma.bak 2024-10-14T23:30:49.646Z,1728948649.646 [DataOverHttps](INFO): SBD MOMSN=23296948 2024-10-14T23:31:12.945Z,1728948672.945 [DataOverHttps](INFO): Sending 610 bytes from file Logs/20241014T232043/Express0005.lzma 2024-10-14T23:31:13.946Z,1728948673.946 [DataOverHttps](INFO): Moved sent file to Logs/20241014T232043/Express0005.lzma.bak 2024-10-14T23:31:13.946Z,1728948673.946 [DataOverHttps](INFO): SBD MOMSN=23296984 2024-10-14T23:31:15.640Z,1728948675.640 [Default:CheckIn:Read_Iridium] Stopped 2024-10-14T23:31:15.640Z,1728948675.640 [Default:CheckIn:C.Wait] Running Loop=1 2024-10-14T23:31:15.640Z,1728948675.640 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-10-14T23:31:22.848Z,1728948682.848 [CommandExec](IMPORTANT): got command quit 2024-10-14T23:31:23.852Z,1728948683.852 [Supervisor](INFO): Stop Mission called by Supervisor::terminate 2024-10-14T23:31:23.853Z,1728948683.853 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread. 2024-10-14T23:31:23.853Z,1728948683.853 [CommandExec](INFO): Uninitializing the command executive. 2024-10-14T23:31:23.853Z,1728948683.853 [CommandExec](INFO): Uninitializing the command scheduler. 2024-10-14T23:31:23.853Z,1728948683.853 [CommandExec ThreadHandler](INFO): Thread cancelled. 2024-10-14T23:31:23.920Z,1728948683.920 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2024-10-14T23:31:23.920Z,1728948683.920 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2024-10-14T23:31:23.920Z,1728948683.920 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-10-14T23:31:23.921Z,1728948683.921 [NavChartDb](INFO): Join timeout helper Thread ID is 1896 2024-10-14T23:31:24.188Z,1728948684.188 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2024-10-14T23:31:24.188Z,1728948684.188 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-10-14T23:31:24.200Z,1728948684.200 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler 2024-10-14T23:31:24.200Z,1728948684.200 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2024-10-14T23:31:24.200Z,1728948684.200 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 1897 2024-10-14T23:31:24.280Z,1728948684.280 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread. 2024-10-14T23:31:24.280Z,1728948684.280 [WetLabsBB2FL](INFO): Powering down 2024-10-14T23:31:24.281Z,1728948684.281 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2024-10-14T23:31:24.288Z,1728948684.288 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler 2024-10-14T23:31:24.288Z,1728948684.288 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2024-10-14T23:31:24.288Z,1728948684.288 [CTD_Seabird](INFO): Join timeout helper Thread ID is 1898 2024-10-14T23:31:25.192Z,1728948685.192 [CTD_Seabird](INFO): Powering down 2024-10-14T23:31:25.204Z,1728948685.204 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread. 2024-10-14T23:31:25.204Z,1728948685.204 [CTD_Seabird](INFO): Powering down 2024-10-14T23:31:25.231Z,1728948685.231 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2024-10-14T23:31:25.248Z,1728948685.248 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2024-10-14T23:31:25.248Z,1728948685.248 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-10-14T23:31:25.248Z,1728948685.248 [Radio_Surface](INFO): Join timeout helper Thread ID is 1899 2024-10-14T23:31:25.401Z,1728948685.401 [Radio_Surface](INFO): Powering down 2024-10-14T23:31:25.402Z,1728948685.402 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2024-10-14T23:31:25.402Z,1728948685.402 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-10-14T23:31:25.412Z,1728948685.412 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler 2024-10-14T23:31:25.412Z,1728948685.412 [Onboard ThreadHandler](INFO): Thread cancelled. 2024-10-14T23:31:25.413Z,1728948685.413 [Onboard](INFO): Join timeout helper Thread ID is 1900 2024-10-14T23:31:26.600Z,1728948686.600 [DataOverHttps](INFO): Radio surface powered OFF, will not connect. 2024-10-14T23:31:28.906Z,1728948688.906 [Power24vConverter](INFO): Powering down. 2024-10-14T23:31:28.964Z,1728948688.964 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread. 2024-10-14T23:31:28.964Z,1728948688.964 [Onboard ThreadHandler](INFO): Thread cancelled. 2024-10-14T23:31:28.973Z,1728948688.973 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler 2024-10-14T23:31:28.974Z,1728948688.974 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2024-10-14T23:31:28.974Z,1728948688.974 [DataOverHttps](INFO): Join timeout helper Thread ID is 1901 2024-10-14T23:31:29.612Z,1728948689.612 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread. 2024-10-14T23:31:29.612Z,1728948689.612 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2024-10-14T23:31:29.633Z,1728948689.633 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler 2024-10-14T23:31:29.633Z,1728948689.633 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2024-10-14T23:31:29.633Z,1728948689.633 [BackseatComponent](INFO): Join timeout helper Thread ID is 1902 2024-10-14T23:31:29.684Z,1728948689.684 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread. 2024-10-14T23:31:29.684Z,1728948689.684 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2024-10-14T23:31:29.692Z,1728948689.692 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2024-10-14T23:31:29.693Z,1728948689.693 [logger ThreadHandler](INFO): Thread cancelled. 2024-10-14T23:31:29.693Z,1728948689.693 [logger](INFO): Join timeout helper Thread ID is 1903 2024-10-14T23:31:29.720Z,1728948689.720 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2024-10-14T23:31:29.720Z,1728948689.720 [logger ThreadHandler](INFO): Thread cancelled. 2024-10-14T23:31:29.733Z,1728948689.733 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2024-10-14T23:31:29.733Z,1728948689.733 [CommandLine ThreadHandler](INFO): Thread cancelled. 2024-10-14T23:31:29.733Z,1728948689.733 [CommandLine](INFO): Join timeout helper Thread ID is 1904 2024-10-14T23:31:29.804Z,1728948689.804 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2024-10-14T23:31:29.804Z,1728948689.804 [CommandLine ThreadHandler](INFO): Thread cancelled. 2024-10-14T23:31:29.812Z,1728948689.812 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler 2024-10-14T23:31:29.813Z,1728948689.813 [CommandExec ThreadHandler](INFO): Thread cancelled. 2024-10-14T23:31:29.813Z,1728948689.813 [CommandExec](INFO): Join timeout helper Thread ID is 1905 2024-10-14T23:31:29.814Z,1728948689.814 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2024-10-14T23:31:29.814Z,1728948689.814 [controlThread ThreadHandler](INFO): Thread cancelled. 2024-10-14T23:31:29.815Z,1728948689.815 [controlThread](INFO): Join timeout helper Thread ID is 1906 2024-10-14T23:31:30.100Z,1728948690.100 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2024-10-14T23:31:30.100Z,1728948690.100 [controlThread](DEBUG): Uninitializing ControlThread 2024-10-14T23:31:30.101Z,1728948690.101 [AHRS_M2](INFO): Powering down 2024-10-14T23:31:30.173Z,1728948690.173 [NAL9602](INFO): Powering down 2024-10-14T23:31:30.174Z,1728948690.174 [Sonardyne_Nano](INFO): Powering down 2024-10-14T23:31:30.292Z,1728948690.292 [Waterlinked](INFO): Powering down 2024-10-14T23:31:30.294Z,1728948690.294 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator. 2024-10-14T23:31:30.294Z,1728948690.294 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator. 2024-10-14T23:31:30.295Z,1728948690.295 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2024-10-14T23:31:30.296Z,1728948690.296 [MissionManager](INFO): Uninitializing Mission Default 2024-10-14T23:31:30.296Z,1728948690.296 [Default] Stopped 2024-10-14T23:31:30.296Z,1728948690.296 [Default](DEBUG): Aggregate::uninitialize Default 2024-10-14T23:31:30.296Z,1728948690.296 [Default:B.GoToSurface] Stopped 2024-10-14T23:31:30.296Z,1728948690.296 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2024-10-14T23:31:30.296Z,1728948690.296 [Default:CheckIn] Stopped 2024-10-14T23:31:30.296Z,1728948690.296 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-10-14T23:31:30.296Z,1728948690.296 [Default:CheckIn:C.Wait] Stopped 2024-10-14T23:31:30.296Z,1728948690.296 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-10-14T23:31:30.299Z,1728948690.299 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2024-10-14T23:31:30.299Z,1728948690.299 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2024-10-14T23:31:30.299Z,1728948690.299 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2024-10-14T23:31:30.300Z,1728948690.300 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2024-10-14T23:31:30.300Z,1728948690.300 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2024-10-14T23:31:30.300Z,1728948690.300 [BuoyancyServo](INFO): Powering down 2024-10-14T23:31:30.312Z,1728948690.312 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2024-10-14T23:31:30.312Z,1728948690.312 [ElevatorServo](INFO): Powering down 2024-10-14T23:31:30.313Z,1728948690.313 [MassServo](DEBUG): Uninitialize Mass Servo. 2024-10-14T23:31:30.313Z,1728948690.313 [MassServo](INFO): Powering down 2024-10-14T23:31:30.314Z,1728948690.314 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2024-10-14T23:31:30.314Z,1728948690.314 [RudderServo](INFO): Powering down 2024-10-14T23:31:30.315Z,1728948690.315 [ThrusterHE](DEBUG): Uninitialize Thruster Servo. 2024-10-14T23:31:30.315Z,1728948690.315 [ThrusterHE](INFO): Powering down 2024-10-14T23:31:30.316Z,1728948690.316 [SBIT](DEBUG): Uninitialize SBIT Component. 2024-10-14T23:31:30.316Z,1728948690.316 [IBIT](DEBUG): Uninitialize IBIT Component. 2024-10-14T23:31:30.316Z,1728948690.316 [CBIT](DEBUG): Uninitialize CBIT Component. 2024-10-14T23:31:30.316Z,1728948690.316 [CBIT](DEBUG): Powering off loads. 2024-10-14T23:31:30.328Z,1728948690.328 [CBIT](DEBUG): Disabling WDT. 2024-10-14T23:31:30.340Z,1728948690.340 [CBIT](DEBUG): Opening all GF detection circuits. 2024-10-14T23:31:30.341Z,1728948690.341 [controlThread ThreadHandler](INFO): Thread cancelled. 2024-10-14T23:31:30.374Z,1728948690.374 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-10-14T23:31:30.377Z,1728948690.377 [Onboard ThreadHandler](INFO): Thread cancelled. 2024-10-14T23:31:30.382Z,1728948690.382 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2024-10-14T23:31:30.425Z,1728948690.425 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2024-10-14T23:31:30.513Z,1728948690.513 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2024-10-14T23:31:30.519Z,1728948690.519 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2024-10-14T23:31:30.527Z,1728948690.527 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-10-14T23:31:30.589Z,1728948690.589 [logger ThreadHandler](INFO): Thread cancelled.