2024-08-12T15:39:30.053Z,1723477170.053 [Supervisor](DEBUG): Initializing supervisor.
2024-08-12T15:39:30.058Z,1723477170.058 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2024-08-12T15:39:30.059Z,1723477170.059 [SyncHandler](INFO): Protected caller Thread ID is 4229
2024-08-12T15:39:30.059Z,1723477170.059 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2024-08-12T15:39:30.061Z,1723477170.061 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2024-08-12T15:39:30.061Z,1723477170.061 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 4230
2024-08-12T15:39:30.065Z,1723477170.065 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2024-08-12T15:39:30.082Z,1723477170.082 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread.
2024-08-12T15:39:30.083Z,1723477170.083 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2024-08-12T15:39:30.084Z,1723477170.084 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 4231
2024-08-12T15:39:30.088Z,1723477170.088 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2024-08-12T15:39:30.089Z,1723477170.089 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2024-08-12T15:39:30.089Z,1723477170.089 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 4232
2024-08-12T15:39:30.091Z,1723477170.091 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2024-08-12T15:39:30.092Z,1723477170.092 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0
2024-08-12T15:39:30.092Z,1723477170.092 [logger ThreadHandler](INFO): Protected caller Thread ID is 4233
2024-08-12T15:39:30.096Z,1723477170.096 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2024-08-12T15:39:30.096Z,1723477170.096 [Supervisor](INFO): Looking for Config files in directory: Config/
2024-08-12T15:39:30.146Z,1723477170.146 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2024-08-12T15:39:30.544Z,1723477170.544 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2024-08-12T15:39:30.545Z,1723477170.545 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2024-08-12T15:39:30.638Z,1723477170.638 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2024-08-12T15:39:31.183Z,1723477171.183 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2024-08-12T15:39:31.184Z,1723477171.184 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2024-08-12T15:39:31.543Z,1723477171.543 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2024-08-12T15:39:31.544Z,1723477171.544 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2024-08-12T15:39:31.660Z,1723477171.660 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2024-08-12T15:39:31.661Z,1723477171.661 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2024-08-12T15:39:32.077Z,1723477172.077 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2024-08-12T15:39:32.078Z,1723477172.078 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2024-08-12T15:39:32.305Z,1723477172.305 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2024-08-12T15:39:32.306Z,1723477172.306 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2024-08-12T15:39:32.853Z,1723477172.853 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2024-08-12T15:39:32.854Z,1723477172.854 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2024-08-12T15:39:33.001Z,1723477173.001 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2024-08-12T15:39:33.001Z,1723477173.001 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2024-08-12T15:39:33.092Z,1723477173.092 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2024-08-12T15:39:33.941Z,1723477173.941 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2024-08-12T15:39:33.942Z,1723477173.942 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2024-08-12T15:39:34.339Z,1723477174.339 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2024-08-12T15:39:34.340Z,1723477174.340 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2024-08-12T15:39:34.544Z,1723477174.544 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2024-08-12T15:39:34.545Z,1723477174.545 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2024-08-12T15:39:34.670Z,1723477174.670 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2024-08-12T15:39:34.671Z,1723477174.671 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2024-08-12T15:39:34.910Z,1723477174.910 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2024-08-12T15:39:34.911Z,1723477174.911 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg
2024-08-12T15:39:35.186Z,1723477175.186 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock
2024-08-12T15:39:35.187Z,1723477175.187 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-daphne/
2024-08-12T15:39:35.188Z,1723477175.188 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Navigation.cfg
2024-08-12T15:39:35.554Z,1723477175.554 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Simulator.cfg
2024-08-12T15:39:35.702Z,1723477175.702 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Control.cfg
2024-08-12T15:39:36.063Z,1723477176.063 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/secure.cfg
2024-08-12T15:39:36.175Z,1723477176.175 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Servo.cfg
2024-08-12T15:39:36.290Z,1723477176.290 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/BIT.cfg
2024-08-12T15:39:36.395Z,1723477176.395 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/vehicle.cfg
2024-08-12T15:39:36.524Z,1723477176.524 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Sensor.cfg
2024-08-12T15:39:36.693Z,1723477176.693 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Science.cfg
2024-08-12T15:39:36.847Z,1723477176.847 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/logger.cfg
2024-08-12T15:39:36.971Z,1723477176.971 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Battery.cfg
2024-08-12T15:39:37.249Z,1723477177.249 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2024-08-12T15:39:37.250Z,1723477177.250 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-daphne/root/
2024-08-12T15:39:37.251Z,1723477177.251 [Supervisor](IMPORTANT): Reloading configuration overrides from Data/persisted.cfg
2024-08-12T15:39:37.255Z,1723477177.255 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2024-08-12T15:39:37.307Z,1723477177.307 [VerticalControl](DEBUG): Construct VerticalControl.
2024-08-12T15:39:37.366Z,1723477177.366 [VerticalControl] Loaded
2024-08-12T15:39:37.366Z,1723477177.366 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2024-08-12T15:39:37.369Z,1723477177.369 [HorizontalControl](DEBUG): Construct HorizontalControl.
2024-08-12T15:39:37.415Z,1723477177.415 [HorizontalControl] Loaded
2024-08-12T15:39:37.415Z,1723477177.415 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2024-08-12T15:39:37.418Z,1723477177.418 [SpeedControl](DEBUG): Construct SpeedControl.
2024-08-12T15:39:37.421Z,1723477177.421 [SpeedControl] Loaded
2024-08-12T15:39:37.421Z,1723477177.421 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2024-08-12T15:39:37.424Z,1723477177.424 [LoopControl](DEBUG): Construct LoopControl.
2024-08-12T15:39:37.424Z,1723477177.424 [LoopControl] Loaded
2024-08-12T15:39:37.424Z,1723477177.424 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2024-08-12T15:39:37.425Z,1723477177.425 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2024-08-12T15:39:37.425Z,1723477177.425 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2024-08-12T15:39:37.435Z,1723477177.435 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2024-08-12T15:39:37.436Z,1723477177.436 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2024-08-12T15:39:37.600Z,1723477177.600 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2024-08-12T15:39:37.601Z,1723477177.601 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2024-08-12T15:39:37.753Z,1723477177.753 [BuoyancyServo] Loaded
2024-08-12T15:39:37.753Z,1723477177.753 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2024-08-12T15:39:37.775Z,1723477177.775 [ElevatorServo] Loaded
2024-08-12T15:39:37.775Z,1723477177.775 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2024-08-12T15:39:37.796Z,1723477177.796 [MassServo] Loaded
2024-08-12T15:39:37.796Z,1723477177.796 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2024-08-12T15:39:37.816Z,1723477177.816 [RudderServo] Loaded
2024-08-12T15:39:37.816Z,1723477177.816 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2024-08-12T15:39:37.832Z,1723477177.832 [ThrusterHE] Loaded
2024-08-12T15:39:37.832Z,1723477177.832 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread.
2024-08-12T15:39:37.833Z,1723477177.833 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2024-08-12T15:39:37.833Z,1723477177.833 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2024-08-12T15:39:37.943Z,1723477177.943 [DeadReckonUsingMultipleVelocitySources] Loaded
2024-08-12T15:39:37.943Z,1723477177.943 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2024-08-12T15:39:37.956Z,1723477177.956 [NavChart] Loaded
2024-08-12T15:39:37.956Z,1723477177.956 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2024-08-12T15:39:37.962Z,1723477177.962 [UniversalFixResidualReporter] Loaded
2024-08-12T15:39:37.962Z,1723477177.962 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2024-08-12T15:39:37.962Z,1723477177.962 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2024-08-12T15:39:37.963Z,1723477177.963 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2024-08-12T15:39:38.017Z,1723477178.017 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2024-08-12T15:39:38.018Z,1723477178.018 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2024-08-12T15:39:38.442Z,1723477178.442 [AHRS_M2] Loaded
2024-08-12T15:39:38.442Z,1723477178.442 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread.
2024-08-12T15:39:39.261Z,1723477179.261 [BPC1] Loaded
2024-08-12T15:39:39.261Z,1723477179.261 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2024-08-12T15:39:39.333Z,1723477179.333 [DataOverHttps] Loaded
2024-08-12T15:39:39.334Z,1723477179.334 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2024-08-12T15:39:39.335Z,1723477179.335 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 409314E0
2024-08-12T15:39:39.335Z,1723477179.335 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 4315
2024-08-12T15:39:39.358Z,1723477179.358 [Depth_Keller] Loaded
2024-08-12T15:39:39.359Z,1723477179.359 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2024-08-12T15:39:39.364Z,1723477179.364 [DropWeight] Loaded
2024-08-12T15:39:39.364Z,1723477179.364 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2024-08-12T15:39:39.427Z,1723477179.427 [NAL9602] Loaded
2024-08-12T15:39:39.428Z,1723477179.428 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2024-08-12T15:39:39.457Z,1723477179.457 [Onboard] Loaded
2024-08-12T15:39:39.458Z,1723477179.458 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread.
2024-08-12T15:39:39.459Z,1723477179.459 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 409614E0
2024-08-12T15:39:39.459Z,1723477179.459 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 4316
2024-08-12T15:39:39.474Z,1723477179.474 [Power24vConverter] Loaded
2024-08-12T15:39:39.475Z,1723477179.475 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread.
2024-08-12T15:39:39.489Z,1723477179.489 [Radio_Surface] Loaded
2024-08-12T15:39:39.490Z,1723477179.490 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2024-08-12T15:39:39.491Z,1723477179.491 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 409914E0
2024-08-12T15:39:39.491Z,1723477179.491 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 4317
2024-08-12T15:39:39.586Z,1723477179.586 [DAT] Loaded
2024-08-12T15:39:39.587Z,1723477179.587 [ComponentRegistry](DEBUG): Component "DAT" handled in its own thread.
2024-08-12T15:39:39.588Z,1723477179.588 [DAT ThreadHandler](DEBUG): Created PCaller Thread at 409C14E0
2024-08-12T15:39:39.588Z,1723477179.588 [DAT ThreadHandler](INFO): Protected caller Thread ID is 4318
2024-08-12T15:39:39.588Z,1723477179.588 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2024-08-12T15:39:39.589Z,1723477179.589 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2024-08-12T15:39:39.637Z,1723477179.637 [DepthRateCalculator] Loaded
2024-08-12T15:39:39.638Z,1723477179.638 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2024-08-12T15:39:39.642Z,1723477179.642 [PitchRateCalculator] Loaded
2024-08-12T15:39:39.643Z,1723477179.643 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2024-08-12T15:39:39.651Z,1723477179.651 [SpeedCalculator] Loaded
2024-08-12T15:39:39.652Z,1723477179.652 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2024-08-12T15:39:39.656Z,1723477179.656 [YawRateCalculator] Loaded
2024-08-12T15:39:39.656Z,1723477179.656 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2024-08-12T15:39:39.675Z,1723477179.675 [ElevatorOffsetCalculator] Loaded
2024-08-12T15:39:39.675Z,1723477179.675 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2024-08-12T15:39:39.676Z,1723477179.676 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2024-08-12T15:39:39.676Z,1723477179.676 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2024-08-12T15:39:39.805Z,1723477179.805 [CANONSampler] Loaded
2024-08-12T15:39:39.806Z,1723477179.806 [ComponentRegistry](DEBUG): SyncComponent "CANONSampler" handled in the control thread.
2024-08-12T15:39:39.869Z,1723477179.869 [CTD_Seabird] Loaded
2024-08-12T15:39:39.869Z,1723477179.869 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread.
2024-08-12T15:39:39.870Z,1723477179.870 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40A7D4E0
2024-08-12T15:39:39.870Z,1723477179.870 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 4319
2024-08-12T15:39:39.894Z,1723477179.894 [PAR_Licor] Loaded
2024-08-12T15:39:39.894Z,1723477179.894 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2024-08-12T15:39:39.936Z,1723477179.936 [WetLabsBB2FL] Loaded
2024-08-12T15:39:39.936Z,1723477179.936 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2024-08-12T15:39:39.937Z,1723477179.937 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40AAD4E0
2024-08-12T15:39:39.937Z,1723477179.937 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 4320
2024-08-12T15:39:39.938Z,1723477179.938 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2024-08-12T15:39:39.939Z,1723477179.939 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2024-08-12T15:39:39.964Z,1723477179.964 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2024-08-12T15:39:39.965Z,1723477179.965 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2024-08-12T15:39:40.289Z,1723477180.289 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2024-08-12T15:39:40.290Z,1723477180.290 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2024-08-12T15:39:40.657Z,1723477180.657 [SBIT](DEBUG): Construct Startup Built In Test.
2024-08-12T15:39:40.666Z,1723477180.666 [SBIT] Loaded
2024-08-12T15:39:40.666Z,1723477180.666 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2024-08-12T15:39:40.669Z,1723477180.669 [IBIT](DEBUG): Construct Initiated Built In Test.
2024-08-12T15:39:40.729Z,1723477180.729 [IBIT] Loaded
2024-08-12T15:39:40.730Z,1723477180.730 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2024-08-12T15:39:40.735Z,1723477180.735 [CBIT](DEBUG): Construct Continuous Built In Test.
2024-08-12T15:39:40.860Z,1723477180.860 [CBIT] Loaded
2024-08-12T15:39:40.860Z,1723477180.860 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2024-08-12T15:39:40.861Z,1723477180.861 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2024-08-12T15:39:40.861Z,1723477180.861 [Module Loader](DEBUG): Loading Module at Modules/Dock.so
2024-08-12T15:39:40.967Z,1723477180.967 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking)
2024-08-12T15:39:40.973Z,1723477180.973 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2024-08-12T15:39:40.976Z,1723477180.976 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2024-08-12T15:39:40.988Z,1723477180.988 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2024-08-12T15:39:40.989Z,1723477180.989 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40C074E0
2024-08-12T15:39:40.989Z,1723477180.989 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 4321
2024-08-12T15:39:40.993Z,1723477180.993 [Supervisor](INFO): Main Thread ID is 3900
2024-08-12T15:39:40.994Z,1723477180.994 [Supervisor](DEBUG): Running supervisor.
2024-08-12T15:39:40.994Z,1723477180.994 [CommandExec ThreadHandler](INFO): Handler Thread ID is 4322
2024-08-12T15:39:40.995Z,1723477180.995 [CommandExec](INFO): Initializing the command executive.
2024-08-12T15:39:40.996Z,1723477180.996 [CommandLine ThreadHandler](INFO): Handler Thread ID is 4323
2024-08-12T15:39:40.998Z,1723477180.998 [controlThread ThreadHandler](INFO): Handler Thread ID is 4324
2024-08-12T15:39:40.999Z,1723477180.999 [controlThread](DEBUG): Initializing ControlThread
2024-08-12T15:39:40.000Z,1723477181.000 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2024-08-12T15:39:41.001Z,1723477181.001 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2024-08-12T15:39:41.002Z,1723477181.002 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2024-08-12T15:39:41.002Z,1723477181.002 [LoopControl](DEBUG): Initialize LoopControlComponent.
2024-08-12T15:39:41.004Z,1723477181.004 [NavChart](DEBUG): Initialize NavChart Navigation.
2024-08-12T15:39:41.005Z,1723477181.005 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2024-08-12T15:39:41.011Z,1723477181.011 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2024-08-12T15:39:41.012Z,1723477181.012 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2024-08-12T15:39:41.012Z,1723477181.012 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2024-08-12T15:39:41.012Z,1723477181.012 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2024-08-12T15:39:41.012Z,1723477181.012 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2024-08-12T15:39:41.018Z,1723477181.018 [SBIT](INFO): Initialize SBIT Component.
2024-08-12T15:39:41.018Z,1723477181.018 [SBIT](IMPORTANT): git: 2024-08-08
2024-08-12T15:39:41.018Z,1723477181.018 [SBIT](INFO): git hash: 26c6456c853cecfda73d9d132c4354bf334e3a6e
2024-08-12T15:39:41.019Z,1723477181.019 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2024-08-12T15:39:41.020Z,1723477181.020 [SBIT](INFO): Kernel Reporting Different Version From Configuration.
Kernel Expected: #2 PREEMPT Thu Jan 11 20:13:48 PST 2018
Kernel Reported: #1 PREEMPT Wed Mar 17 08:23:48 PDT 2021
2024-08-12T15:39:41.021Z,1723477181.021 [SBIT](INFO): Beginning SBIT in 63.000000 seconds.
2024-08-12T15:39:41.022Z,1723477181.022 [IBIT](INFO): Initialize IBIT Component.
2024-08-12T15:39:41.022Z,1723477181.022 [CBIT](DEBUG): Initialize CBIT Component.
2024-08-12T15:39:41.023Z,1723477181.023 [logger ThreadHandler](INFO): Handler Thread ID is 4325
2024-08-12T15:39:41.033Z,1723477181.033 [CBIT](DEBUG): Initialized mux pins.
2024-08-12T15:39:41.034Z,1723477181.034 [CBIT](DEBUG): Initializing the watchdog timer.
2024-08-12T15:39:41.042Z,1723477181.042 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 4326
2024-08-12T15:39:41.044Z,1723477181.044 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2024-08-12T15:39:41.054Z,1723477181.054 [Onboard ThreadHandler](INFO): Handler Thread ID is 4327
2024-08-12T15:39:41.058Z,1723477181.058 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2024-08-12T15:39:41.059Z,1723477181.059 [CBIT](DEBUG): Initializing heartbeat.
2024-08-12T15:39:41.075Z,1723477181.075 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 4328
2024-08-12T15:39:41.094Z,1723477181.094 [DAT ThreadHandler](INFO): Handler Thread ID is 4329
2024-08-12T15:39:41.095Z,1723477181.095 [DAT](INFO): Powering up
2024-08-12T15:39:41.095Z,1723477181.095 [DAT](DEBUG): Initializing DAT.
2024-08-12T15:39:41.099Z,1723477181.099 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 4331
2024-08-12T15:39:41.100Z,1723477181.100 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2024-08-12T15:39:41.107Z,1723477181.107 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 4333
2024-08-12T15:39:41.110Z,1723477181.110 [WetLabsBB2FL](INFO): Powering up
2024-08-12T15:39:41.111Z,1723477181.111 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 4335
2024-08-12T15:39:41.114Z,1723477181.114 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2024-08-12T15:39:41.115Z,1723477181.115 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2024-08-12T15:39:41.115Z,1723477181.115 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2024-08-12T15:39:41.115Z,1723477181.115 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2024-08-12T15:39:41.115Z,1723477181.115 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2024-08-12T15:39:41.115Z,1723477181.115 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2024-08-12T15:39:41.115Z,1723477181.115 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2024-08-12T15:39:41.116Z,1723477181.116 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2024-08-12T15:39:41.130Z,1723477181.129 [CBIT](DEBUG): Deactivating GF circuits.
2024-08-12T15:39:41.130Z,1723477181.130 [CBIT](DEBUG): Deactivating emergency mode.
2024-08-12T15:39:41.169Z,1723477181.169 [CBIT](DEBUG): Backplane powered.
2024-08-12T15:39:41.170Z,1723477181.170 [MissionManager](IMPORTANT): Using TethysL tl-to-tx parser
2024-08-12T15:39:41.171Z,1723477181.171 [MissionManager](INFO): Loading Mission from file: Missions/Startup.tl
2024-08-12T15:39:41.171Z,1723477181.171 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Startup.tl
2024-08-12T15:39:41.172Z,1723477181.172 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Startup.tl
2024-08-12T15:39:41.211Z,1723477181.211 [MissionManager](DEBUG): TethyslAPI: Missions/Startup.tl translated into:
2024-08-12T15:39:41.221Z,1723477181.221 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2024-08-12T15:39:41.240Z,1723477181.240 [MissionManager](DEBUG):
# Copyright (c) 2024 MBARI
# MBARI Proprietary Information. Confidential. All Rights Reserved
# Unauthorized copying or distribution of this file via any medium is strictly
# prohibited.
#
# WARNING - This file contains information whose export is restricted by the
# Export Administration Act of 1979 (Title 50, U.S.C., App. 2401 et seq.), as
# amended. Violations of these export laws are subject to severe civil and/or
# criminal penalties.
mission Startup {
behavior Guidance:GoToSurface {
run in progression
}
aggregate StartupSatComms {
run in sequence
readDatum {
timeout duration=P1M
Universal:latitude_fix
}
readDatum {
timeout duration=P1M
Universal:platform_communications
}
}
}
2024-08-12T15:39:41.241Z,1723477181.241 [MissionManager](INFO): Loading Mission from file: Missions/Default.tl
2024-08-12T15:39:41.261Z,1723477181.261 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Default.tl
2024-08-12T15:39:41.262Z,1723477181.262 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Default.tl
2024-08-12T15:39:41.478Z,1723477181.478 [Radio_Surface](INFO): Powering up
2024-08-12T15:39:41.524Z,1723477181.524 [MissionManager](DEBUG): TethyslAPI: Missions/Default.tl translated into:
0
13
Burn on
Dropped weight due to communications timeout.
5
Default mission has been running for
Restarting logs and Default mission.
restart logs
2024-08-12T15:39:41.550Z,1723477181.550 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2024-08-12T15:39:41.551Z,1723477181.551 [Default:A.Wait](DEBUG): Construct Wait.
2024-08-12T15:39:41.553Z,1723477181.553 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2024-08-12T15:39:41.593Z,1723477181.593 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2024-08-12T15:39:41.612Z,1723477181.612 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2024-08-12T15:39:41.634Z,1723477181.634 [Default:E.Execute](DEBUG): Construct Execute.
2024-08-12T15:39:41.637Z,1723477181.637 [MissionManager](DEBUG):
# Copyright (c) 2024 MBARI
# MBARI Proprietary Information. Confidential. All Rights Reserved
# Unauthorized copying or distribution of this file via any medium is strictly
# prohibited.
#
# WARNING - This file contains information whose export is restricted by the
# Export Administration Act of 1979 (Title 50, U.S.C., App. 2401 et seq.), as
# amended. Violations of these export laws are subject to severe civil and/or
# criminal penalties.
mission Default {
arguments {
ElapsedSinceDefaultStarted = 0 minute
}
behavior Guidance:Wait {
"""
Wait a moment to see if the scheduler starts a new mission before
starting to actually run Default.
"""
run in sequence
set duration = 13 second
}
behavior Guidance:GoToSurface {
run in progression
}
aggregate CheckIn {
run in sequence repeat=288
readDatum id="Read_GPS" {
timeout duration=P5M
Universal:time_fix
}
readDatum id="Read_Iridium" {
timeout duration=P4H {
behavior Guidance:Execute {
run in sequence
set command = "Burn on"
}
syslog critical "Dropped weight due to communications timeout."
}
Universal:platform_communications
}
behavior Guidance:Wait {
run in sequence
set duration = 5 minute
}
assign in sequence ElapsedSinceDefaultStarted = elapsed ( Universal:mission_started )
syslog important "Default mission has been running for " + ElapsedSinceDefaultStarted~minute
}
syslog important "Restarting logs and Default mission."
behavior Guidance:Execute {
run in sequence
set command = "restart logs"
}
}
2024-08-12T15:39:41.641Z,1723477181.641 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,DropWeight,NAL9602,Power24vConverter,CANONSampler,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,Reporter,LogSplitter,
2024-08-12T15:39:41.660Z,1723477181.660 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2024-08-12T15:39:41.739Z,1723477181.739 [Depth_Keller](ERROR): Pressure or depth reading out of range: 1831.023193 decibar, 0.000000 m
2024-08-12T15:39:41.740Z,1723477181.740 [Power24vConverter](INFO): Powering up.
2024-08-12T15:39:41.741Z,1723477181.741 [CANONSampler](INFO): Powering down
2024-08-12T15:39:41.749Z,1723477181.749 [DepthRateCalculator](ERROR): Depth measurement is not active
2024-08-12T15:39:41.787Z,1723477181.787 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2024-08-12T15:39:41.794Z,1723477181.794 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2024-08-12T15:39:41.795Z,1723477181.795 [ElevatorServo](DEBUG): Initializing EZServoServo.
2024-08-12T15:39:41.802Z,1723477181.802 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2024-08-12T15:39:41.803Z,1723477181.803 [MassServo](DEBUG): Initializing EZServoServo.
2024-08-12T15:39:41.810Z,1723477181.810 [MassServo](DEBUG): Initializing MassServo.
2024-08-12T15:39:41.811Z,1723477181.811 [RudderServo](DEBUG): Initializing EZServoServo.
2024-08-12T15:39:41.818Z,1723477181.818 [RudderServo](DEBUG): Initializing RudderServo.
2024-08-12T15:39:41.819Z,1723477181.819 [ThrusterHE](DEBUG): Initializing EZServoServo.
2024-08-12T15:39:41.826Z,1723477181.826 [ThrusterHE](DEBUG): Initializing ThrusterHE.
2024-08-12T15:39:43.722Z,1723477183.722 [WetLabsBB2FL](INFO): Powering down
2024-08-12T15:39:48.130Z,1723477188.130 [CTD_Seabird](ERROR): Device message queue exceeded the allowed limit.
2024-08-12T15:39:52.686Z,1723477192.686 [DAT](INFO): DAT read:
2024-08-12T15:39:52.688Z,1723477192.688 [DAT](INFO): DAT read: Teledyne Benthos DAT-900 Series
2024-08-12T15:39:54.198Z,1723477194.198 [DAT](INFO): DAT read: MF Frequency Band
2024-08-12T15:39:54.200Z,1723477194.200 [DAT](INFO): DAT read: Directional Acoustic Transponder version 8.15.0
2024-08-12T15:39:54.200Z,1723477194.200 [DAT](INFO): DAT read: Aug 12 2024 15:39:49
2024-08-12T15:39:55.207Z,1723477195.207 [DAT](INFO): DAT read: Features enabled [Bearing]
2024-08-12T15:39:55.208Z,1723477195.208 [DAT](INFO): DAT read: CONNECT 01200 bits/sec 1 of 4, Rate 1/2 CC
2024-08-12T15:39:55.208Z,1723477195.208 [DAT](INFO): commRate: 1200
2024-08-12T15:39:57.273Z,1723477197.273 [DAT](INFO): entering command mode
2024-08-12T15:39:57.474Z,1723477197.474 [DAT](INFO): DAT read:
2024-08-12T15:39:57.475Z,1723477197.475 [DAT](INFO): DAT read: user:1>
2024-08-12T15:39:57.475Z,1723477197.475 [DAT](INFO): setting verbose to 3
2024-08-12T15:39:57.726Z,1723477197.726 [DAT](INFO): DAT read: user:1>
2024-08-12T15:39:57.727Z,1723477197.727 [DAT](INFO): DAT read: Verbose | 3
2024-08-12T15:39:57.728Z,1723477197.728 [DAT](INFO): set verbose to 3
2024-08-12T15:39:57.728Z,1723477197.728 [DAT](INFO): setting DatVerbose to 27440
2024-08-12T15:39:57.978Z,1723477197.978 [DAT](INFO): DAT read: user:2>
2024-08-12T15:39:57.979Z,1723477197.979 [DAT](INFO): DAT read: DatVerbose | 27440
2024-08-12T15:39:57.980Z,1723477197.980 [DAT](INFO): set DatVerbose to 27440
2024-08-12T15:39:57.980Z,1723477197.980 [DAT](INFO): setting transmit power to 8
2024-08-12T15:39:58.230Z,1723477198.230 [DAT](INFO): DAT read: user:3>
2024-08-12T15:39:58.231Z,1723477198.231 [DAT](INFO): DAT read: TxPower | 8 (Max)
2024-08-12T15:39:58.232Z,1723477198.232 [DAT](INFO): set transmit power to 8
2024-08-12T15:39:58.232Z,1723477198.232 [DAT](INFO): setting local address to 8
2024-08-12T15:39:58.482Z,1723477198.482 [DAT](INFO): DAT read: user:4>
2024-08-12T15:39:58.483Z,1723477198.483 [DAT](INFO): DAT read: LocalAddr | 8
2024-08-12T15:39:58.483Z,1723477198.483 [DAT](INFO): set local address to 8
2024-08-12T15:39:58.485Z,1723477198.485 [DAT](INFO): Setting time to: 15:39:58 And date to:8/12/2024
2024-08-12T15:39:58.734Z,1723477198.734 [DAT](INFO): DAT read: user:5>
2024-08-12T15:39:58.735Z,1723477198.735 [DAT](INFO): DAT read: Mon Aug 12, 2024 15:39:58
2024-08-12T15:39:58.736Z,1723477198.736 [DAT](INFO): Local DAT time set to Mon Aug 12, 2024 15:39:58
2024-08-12T15:40:09.527Z,1723477209.527 [NAL9602](INFO): Powering up NAL9602
2024-08-12T15:40:20.435Z,1723477220.435 [NAL9602](INFO): NAL9602 initialized
2024-08-12T15:40:44.726Z,1723477244.726 [SBIT](IMPORTANT): Beginning Startup BIT
2024-08-12T15:40:44.730Z,1723477244.730 [CBIT](IMPORTANT): Beginning ground fault scan
2024-08-12T15:40:46.699Z,1723477246.699 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-08-12T15:40:55.629Z,1723477255.629 [CBIT](ERROR): Ground fault scan returned out of bounds value. Re-running scan.
2024-08-12T15:40:56.029Z,1723477256.029 [CBIT](IMPORTANT): Beginning ground fault scan
2024-08-12T15:40:58.407Z,1723477258.407 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-08-12T15:41:06.971Z,1723477266.971 [CBIT](ERROR): Ground fault scan returned out of bounds value. Re-running scan.
2024-08-12T15:41:07.359Z,1723477267.359 [CBIT](IMPORTANT): Beginning ground fault scan
2024-08-12T15:41:10.123Z,1723477270.123 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-08-12T15:41:18.251Z,1723477278.251 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): -0.002621
CHAN A1 (24V): 0.000522
CHAN A2 (12V): -0.002347
CHAN A3 (5V): -0.001698
CHAN B0 (3.3V): -0.000016
CHAN B1 (3.15aV): -0.000160
CHAN B2 (3.15bV): -0.000190
CHAN B3 (GND): 0.000190
OPEN: -0.000055
Full Scale: +/- 1 mA
2024-08-12T15:41:21.838Z,1723477281.838 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-08-12T15:41:33.959Z,1723477293.959 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-08-12T15:41:38.828Z,1723477298.828 [SBIT](IMPORTANT): SBIT PASSED
2024-08-12T15:41:38.829Z,1723477298.829 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2024-08-12T15:41:38.846Z,1723477298.846 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=128.796039 cubic_centimeter;
2024-08-12T15:41:38.846Z,1723477298.846 [SBIT](IMPORTANT): VerticalControl.massDefault=10.940930 millimeter;
2024-08-12T15:41:39.227Z,1723477299.227 [MissionManager](IMPORTANT): Started mission Startup
2024-08-12T15:41:39.227Z,1723477299.227 [Startup] Running Loop=1
2024-08-12T15:41:39.227Z,1723477299.227 [Startup](DEBUG): Aggregate::initialize Startup
2024-08-12T15:41:39.227Z,1723477299.227 [Startup:A.GoToSurface] Running Loop=1
2024-08-12T15:41:39.228Z,1723477299.228 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2024-08-12T15:41:39.228Z,1723477299.228 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2024-08-12T15:41:39.228Z,1723477299.228 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2024-08-12T15:41:39.229Z,1723477299.229 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2024-08-12T15:41:39.229Z,1723477299.229 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2024-08-12T15:41:39.230Z,1723477299.230 [Startup:A.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds.
2024-08-12T15:41:39.230Z,1723477299.230 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2024-08-12T15:41:39.232Z,1723477299.232 [Startup:StartupSatComms] Running Loop=1
2024-08-12T15:41:39.232Z,1723477299.232 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2024-08-12T15:41:39.232Z,1723477299.232 [Startup:StartupSatComms:A] Running Loop=1
2024-08-12T15:41:39.640Z,1723477299.640 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2024-08-12T15:41:45.674Z,1723477305.674 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-08-12T15:41:57.795Z,1723477317.795 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-08-12T15:42:09.926Z,1723477329.926 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-08-12T15:42:23.928Z,1723477343.928 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.005030
2024-08-12T15:42:28.519Z,1723477348.519 [CommandExec](IMPORTANT): got command burn on
2024-08-12T15:42:28.519Z,1723477348.519 [CommandExec](IMPORTANT): Activating dropweight wire
2024-08-12T15:42:32.782Z,1723477352.782 [CommandExec](IMPORTANT): got command burn off
2024-08-12T15:42:32.783Z,1723477352.783 [CommandExec](IMPORTANT): Deactivating dropweight wire
2024-08-12T15:42:39.420Z,1723477359.420 [Startup:StartupSatComms:A](INFO): Timed out from 2024-08-12T15:41:39.2Z
2024-08-12T15:42:39.420Z,1723477359.420 [Startup:StartupSatComms:A] Stopped
2024-08-12T15:42:39.420Z,1723477359.420 [Startup:StartupSatComms:B] Running Loop=1
2024-08-12T15:42:39.827Z,1723477359.827 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2024-08-12T15:42:41.063Z,1723477361.063 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2024-08-12T15:42:41.063Z,1723477361.063 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-08-12T15:42:41.073Z,1723477361.073 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-08-12T15:42:41.482Z,1723477361.482 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-08-12T15:42:41.482Z,1723477361.482 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2024-08-12T15:42:46.257Z,1723477366.257 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20240812T152901/Courier0007.lzma
2024-08-12T15:42:47.259Z,1723477367.259 [DataOverHttps](INFO): Moved sent file to Logs/20240812T152901/Courier0007.lzma.bak
2024-08-12T15:42:47.260Z,1723477367.260 [DataOverHttps](INFO): SBD MOMSN=21490047
2024-08-12T15:43:02.733Z,1723477382.733 [DataOverHttps](INFO): Sending 151 bytes from file Logs/20240812T153930/Courier0000.lzma
2024-08-12T15:43:03.735Z,1723477383.735 [DataOverHttps](INFO): Moved sent file to Logs/20240812T153930/Courier0000.lzma.bak
2024-08-12T15:43:03.735Z,1723477383.735 [DataOverHttps](INFO): SBD MOMSN=21490049
2024-08-12T15:43:19.501Z,1723477399.501 [DataOverHttps](INFO): Sending 113 bytes from file Logs/20240812T152901/Express0008.lzma
2024-08-12T15:43:20.503Z,1723477400.503 [DataOverHttps](INFO): Moved sent file to Logs/20240812T152901/Express0008.lzma.bak
2024-08-12T15:43:20.503Z,1723477400.503 [DataOverHttps](INFO): SBD MOMSN=21490052
2024-08-12T15:43:36.015Z,1723477416.015 [DataOverHttps](INFO): Sending 767 bytes from file Logs/20240812T153930/Express0001.lzma
2024-08-12T15:43:37.015Z,1723477417.015 [DataOverHttps](INFO): Moved sent file to Logs/20240812T153930/Express0001.lzma.bak
2024-08-12T15:43:37.016Z,1723477417.016 [DataOverHttps](INFO): SBD MOMSN=21490055
2024-08-12T15:43:38.043Z,1723477418.043 [Startup:StartupSatComms:B] Stopped
2024-08-12T15:43:38.044Z,1723477418.044 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2024-08-12T15:43:38.044Z,1723477418.044 [Startup:StartupSatComms] Stopped
2024-08-12T15:43:38.044Z,1723477418.044 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2024-08-12T15:43:38.045Z,1723477418.045 [Startup](INFO): Completed Startup
2024-08-12T15:43:38.045Z,1723477418.045 [MissionManager](INFO): Startup is completed.
2024-08-12T15:43:38.045Z,1723477418.045 [MissionManager](INFO): Uninitializing Mission Startup
2024-08-12T15:43:38.045Z,1723477418.045 [Startup] Stopped
2024-08-12T15:43:38.045Z,1723477418.045 [Startup](DEBUG): Aggregate::uninitialize Startup
2024-08-12T15:43:38.045Z,1723477418.045 [Startup:A.GoToSurface] Stopped
2024-08-12T15:43:38.046Z,1723477418.046 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2024-08-12T15:43:38.436Z,1723477418.436 [MissionManager](IMPORTANT): Started mission Default
2024-08-12T15:43:38.436Z,1723477418.436 [Default] Running Loop=1
2024-08-12T15:43:38.436Z,1723477418.436 [Default](DEBUG): Aggregate::initialize Default
2024-08-12T15:43:38.436Z,1723477418.436 [Default:B.GoToSurface] Running Loop=1
2024-08-12T15:43:38.436Z,1723477418.436 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2024-08-12T15:43:38.436Z,1723477418.436 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2024-08-12T15:43:38.437Z,1723477418.437 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2024-08-12T15:43:38.437Z,1723477418.437 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2024-08-12T15:43:38.437Z,1723477418.437 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2024-08-12T15:43:38.438Z,1723477418.438 [Default:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds.
2024-08-12T15:43:38.438Z,1723477418.438 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2024-08-12T15:43:38.438Z,1723477418.438 [Default:A.Wait] Running Loop=1
2024-08-12T15:43:38.438Z,1723477418.438 [Default:A.Wait](DEBUG): Initialize Wait Component.
2024-08-12T15:43:51.751Z,1723477431.751 [Default:A.Wait](INFO): Done Waiting.
2024-08-12T15:43:51.751Z,1723477431.751 [Default:A.Wait] Stopped
2024-08-12T15:43:51.752Z,1723477431.752 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2024-08-12T15:43:52.148Z,1723477432.148 [Default:CheckIn] Running Loop=1
2024-08-12T15:43:52.148Z,1723477432.148 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-08-12T15:43:52.148Z,1723477432.148 [Default:CheckIn:Read_GPS] Running Loop=1
2024-08-12T15:43:52.589Z,1723477432.589 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2024-08-12T15:44:08.138Z,1723477448.138 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2024-08-12T15:44:36.578Z,1723477476.578 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-08-12T15:44:39.262Z,1723477479.262 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2024-08-12T15:44:49.910Z,1723477489.910 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-08-12T15:45:03.639Z,1723477503.639 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-08-12T15:45:10.386Z,1723477510.386 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2024-08-12T15:45:16.978Z,1723477516.978 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-08-12T15:45:24.251Z,1723477524.251 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2024-08-12T15:45:30.310Z,1723477530.310 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-08-12T15:45:41.522Z,1723477541.522 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2024-08-12T15:45:42.040Z,1723477542.040 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2
2024-08-12T15:45:42.040Z,1723477542.040 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-08-12T15:45:42.051Z,1723477542.051 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-08-12T15:45:42.510Z,1723477542.510 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-08-12T15:45:42.510Z,1723477542.510 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2
2024-08-12T15:45:43.642Z,1723477543.642 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-08-12T15:45:57.366Z,1723477557.366 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-08-12T15:46:11.506Z,1723477571.506 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-08-12T15:46:12.646Z,1723477572.646 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2024-08-12T15:46:25.243Z,1723477585.243 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-08-12T15:46:37.750Z,1723477597.750 [DataOverHttps](INFO): setting unavailable, lastComms_.elapsed()=180.735184
2024-08-12T15:46:38.978Z,1723477598.978 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-08-12T15:46:52.310Z,1723477612.310 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-08-12T15:47:13.894Z,1723477633.894 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2024-08-12T15:47:45.026Z,1723477665.026 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2024-08-12T15:48:16.154Z,1723477696.154 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2024-08-12T15:48:43.063Z,1723477723.063 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3
2024-08-12T15:48:43.063Z,1723477723.063 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-08-12T15:48:43.074Z,1723477723.074 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-08-12T15:48:43.439Z,1723477723.439 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-08-12T15:48:43.439Z,1723477723.439 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3
2024-08-12T15:48:47.278Z,1723477727.278 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2024-08-12T15:48:52.340Z,1723477732.340 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-08-12T15:43:52.1Z
2024-08-12T15:48:52.340Z,1723477732.340 [Default:CheckIn:Read_GPS] Stopped
2024-08-12T15:48:52.340Z,1723477732.340 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-08-12T15:48:52.719Z,1723477732.719 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications
2024-08-12T15:49:18.402Z,1723477758.402 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2024-08-12T15:49:22.607Z,1723477762.607 [NAL9602](ERROR): Queried for signal strength and failed to receive proper response.
2024-08-12T15:49:22.681Z,1723477762.681 [NAL9602](ERROR): received:
+CSQ:0
OK
2024-08-12T15:49:49.526Z,1723477789.526 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2024-08-12T15:50:20.659Z,1723477820.659 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2024-08-12T15:50:24.015Z,1723477824.015 [NAL9602](FAULT): GPS failed to acquire within timeout.
2024-08-12T15:50:24.015Z,1723477824.015 [NAL9602] Data Fault, FailCount= 1
2024-08-12T15:50:24.015Z,1723477824.015 [NAL9602](ERROR): Data Fault
2024-08-12T15:50:24.034Z,1723477824.034 [CBIT](ERROR): Data Fault in component: NAL9602
2024-08-12T15:50:24.419Z,1723477824.419 [NAL9602](INFO): Powering down
2024-08-12T15:50:25.272Z,1723477825.272 [CBIT](INFO): Clearing failed state for component NAL9602
2024-08-12T15:50:25.272Z,1723477825.272 [NAL9602] No Fault, FailCount= 1
2024-08-12T15:50:51.782Z,1723477851.782 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2024-08-12T15:50:54.719Z,1723477854.719 [NAL9602](INFO): Powering up NAL9602
2024-08-12T15:51:05.647Z,1723477865.647 [NAL9602](INFO): NAL9602 initialized
2024-08-12T15:51:22.906Z,1723477882.906 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2024-08-12T15:51:44.030Z,1723477904.030 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4
2024-08-12T15:51:44.030Z,1723477904.030 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-08-12T15:51:44.041Z,1723477904.041 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-08-12T15:51:44.427Z,1723477904.427 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-08-12T15:51:44.427Z,1723477904.427 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4
2024-08-12T15:51:54.046Z,1723477914.046 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2024-08-12T15:52:25.174Z,1723477945.174 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2024-08-12T15:52:56.298Z,1723477976.298 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2024-08-12T15:53:27.430Z,1723478007.430 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2024-08-12T15:53:58.554Z,1723478038.554 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2024-08-12T15:54:17.114Z,1723478057.114 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-08-12T15:54:29.638Z,1723478069.638 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-08-12T15:54:29.678Z,1723478069.678 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2024-08-12T15:54:43.374Z,1723478083.374 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-08-12T15:54:45.038Z,1723478085.038 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 5
2024-08-12T15:54:45.038Z,1723478085.038 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-08-12T15:54:45.048Z,1723478085.048 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-08-12T15:54:45.449Z,1723478085.449 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-08-12T15:54:45.449Z,1723478085.449 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 5
2024-08-12T15:54:56.706Z,1723478096.706 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-08-12T15:55:00.807Z,1723478100.807 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2024-08-12T15:55:10.038Z,1723478110.038 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-08-12T15:55:23.370Z,1723478123.370 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-08-12T15:55:31.930Z,1723478131.930 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2024-08-12T15:55:36.702Z,1723478136.702 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-08-12T15:55:50.438Z,1723478150.438 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-08-12T15:56:03.058Z,1723478163.058 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2024-08-12T15:56:03.770Z,1723478163.770 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-08-12T15:56:17.911Z,1723478177.911 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-08-12T15:56:31.648Z,1723478191.648 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-08-12T15:56:34.182Z,1723478194.182 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2024-08-12T15:57:05.323Z,1723478225.323 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2024-08-12T15:57:36.450Z,1723478256.450 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2024-08-12T15:57:46.031Z,1723478266.031 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 6
2024-08-12T15:57:46.031Z,1723478266.031 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-08-12T15:57:46.042Z,1723478266.042 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-08-12T15:57:46.412Z,1723478266.412 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-08-12T15:57:46.412Z,1723478266.412 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 6
2024-08-12T15:58:07.574Z,1723478287.574 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2024-08-12T15:58:38.698Z,1723478318.698 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2024-08-12T15:59:09.830Z,1723478349.830 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2024-08-12T15:59:40.954Z,1723478380.954 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2024-08-12T15:59:41.568Z,1723478381.568 [NAL9602](INFO): SBD MO Status=2, MOMSN=54772, MT Status=2, MTMSN=0
2024-08-12T15:59:41.569Z,1723478381.569 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2024-08-12T15:59:58.274Z,1723478398.274 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.002950
2024-08-12T16:00:04.232Z,1723478404.232 [NAL9602](INFO): SBD MO Status=2, MOMSN=54772, MT Status=2, MTMSN=0
2024-08-12T16:00:04.232Z,1723478404.232 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2024-08-12T16:00:05.521Z,1723478405.521 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20240812T153930/Courier0004.lzma
2024-08-12T16:00:06.523Z,1723478406.523 [DataOverHttps](INFO): Moved sent file to Logs/20240812T153930/Courier0004.lzma.bak
2024-08-12T16:00:06.524Z,1723478406.524 [DataOverHttps](INFO): SBD MOMSN=21490154
2024-08-12T16:00:24.830Z,1723478424.830 [DataOverHttps](INFO): Sending 187 bytes from file Logs/20240812T153930/Express0005.lzma
2024-08-12T16:00:25.831Z,1723478425.831 [DataOverHttps](INFO): Moved sent file to Logs/20240812T153930/Express0005.lzma.bak
2024-08-12T16:00:25.832Z,1723478425.832 [DataOverHttps](INFO): SBD MOMSN=21490200
2024-08-12T16:00:26.922Z,1723478426.922 [Default:CheckIn:Read_Iridium] Stopped
2024-08-12T16:00:26.923Z,1723478426.922 [Default:CheckIn:C.Wait] Running Loop=1
2024-08-12T16:00:26.923Z,1723478426.923 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-08-12T16:00:47.151Z,1723478447.151 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 7
2024-08-12T16:00:47.151Z,1723478447.151 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-08-12T16:00:47.174Z,1723478447.174 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-08-12T16:00:47.848Z,1723478447.848 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-08-12T16:00:47.848Z,1723478447.848 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 7
2024-08-12T16:01:07.311Z,1723478467.311 [NAL9602](FAULT): GPS failed to acquire within timeout.
2024-08-12T16:01:07.311Z,1723478467.311 [NAL9602] Data Fault, FailCount= 2
2024-08-12T16:01:07.311Z,1723478467.311 [NAL9602](ERROR): Data Fault
2024-08-12T16:01:07.449Z,1723478467.449 [CBIT](ERROR): Data Fault in component: NAL9602
2024-08-12T16:01:07.707Z,1723478467.707 [NAL9602](INFO): Powering down
2024-08-12T16:01:08.543Z,1723478468.543 [CBIT](INFO): Clearing failed state for component NAL9602
2024-08-12T16:01:08.543Z,1723478468.543 [NAL9602] No Fault, FailCount= 2
2024-08-12T16:01:38.004Z,1723478498.004 [NAL9602](INFO): Powering up NAL9602
2024-08-12T16:01:48.911Z,1723478508.911 [NAL9602](INFO): NAL9602 initialized
2024-08-12T16:02:35.647Z,1723478555.647 [DataOverHttps](IMPORTANT): SBD MTMSN=20240812T160234
2024-08-12T16:02:42.782Z,1723478562.782 [DataOverHttps](INFO): Received command: ibit
2024-08-12T16:02:42.806Z,1723478562.806 [CommandExec](IMPORTANT): got command ibit
2024-08-12T16:02:43.071Z,1723478563.071 [IBIT](IMPORTANT): Beginning Initiated BIT
2024-08-12T16:02:43.071Z,1723478563.071 [IBIT](IMPORTANT): Beginning control surface checks.
2024-08-12T16:02:43.076Z,1723478563.076 [CBIT](IMPORTANT): Beginning ground fault scan
2024-08-12T16:02:43.783Z,1723478563.783 [DataOverHttps](IMPORTANT): SBD MTMSN=20240812T160242
2024-08-12T16:02:53.754Z,1723478573.754 [DataOverHttps](INFO): Received command: failc
2024-08-12T16:02:53.762Z,1723478573.762 [CommandExec](IMPORTANT): got command failComponent
2024-08-12T16:02:53.763Z,1723478573.763 [CommandExec](IMPORTANT): Failed components:
2024-08-12T16:02:53.763Z,1723478573.763 [CommandExec](IMPORTANT): No failed Components.
2024-08-12T16:02:54.125Z,1723478574.125 [CBIT](ERROR): Ground fault scan returned out of bounds value. Re-running scan.
2024-08-12T16:02:54.512Z,1723478574.512 [CBIT](IMPORTANT): Beginning ground fault scan
2024-08-12T16:03:05.538Z,1723478585.538 [CBIT](ERROR): Ground fault scan returned out of bounds value. Re-running scan.
2024-08-12T16:03:05.986Z,1723478585.986 [CBIT](IMPORTANT): Beginning ground fault scan
2024-08-12T16:03:17.207Z,1723478597.207 [CBIT](ERROR): Ground fault scan returned out of bounds value. Re-running scan.
2024-08-12T16:03:17.207Z,1723478597.207 [CBIT](IMPORTANT): Ground fault scan returned out of bounds value in succession 3 times. Will re-run scan on normal schedule.
2024-08-12T16:03:19.945Z,1723478599.945 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,160318.00,A,3648.14474,N,12147.22977,W,0.097,276.01,120824,,,A*73
2024-08-12T16:03:19.948Z,1723478599.948 [NAL9602](INFO): GPS fix at 20240812T160318: (36.802412, -121.787163)
2024-08-12T16:03:22.776Z,1723478602.776 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,160321.00,A,3648.14419,N,12147.23084,W,0.058,276.01,120824,,,A*75
2024-08-12T16:03:22.783Z,1723478602.783 [NAL9602](INFO): GPS fix at 20240812T160321: (36.802403, -121.787181)
2024-08-12T16:03:26.000Z,1723478606.000 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,160324.00,A,3648.14385,N,12147.23067,W,0.583,276.01,120824,,,A*7C
2024-08-12T16:03:26.003Z,1723478606.003 [NAL9602](INFO): GPS fix at 20240812T160324: (36.802397, -121.787178)
2024-08-12T16:03:28.890Z,1723478608.890 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,160327.00,A,3648.14378,N,12147.23072,W,0.544,276.01,120824,,,A*72
2024-08-12T16:03:28.893Z,1723478608.893 [NAL9602](INFO): GPS fix at 20240812T160327: (36.802396, -121.787179)
2024-08-12T16:03:29.298Z,1723478609.298 [IBIT](IMPORTANT): Communications Status:
Fix Status: 1
Iridium Signal Strength: 5
Latitude: 36.802395 Longitude: -121.787178
2024-08-12T16:03:29.670Z,1723478609.670 [IBIT](FAULT): Warning: Battery Data not active. Expected only when running primaries. Threshold checking not active.
2024-08-12T16:03:30.079Z,1723478610.079 [IBIT](IMPORTANT): bitHumidityThreshold: 55.000000 %
2024-08-12T16:03:30.079Z,1723478610.079 [IBIT](IMPORTANT): bitPressureThreshold: 0.750000 psi
2024-08-12T16:03:30.080Z,1723478610.080 [IBIT](IMPORTANT): Pressure:10.333934 PSI
2024-08-12T16:03:30.080Z,1723478610.080 [IBIT](IMPORTANT): Humidity:15.138567 %
2024-08-12T16:03:30.464Z,1723478610.464 [IBIT](IMPORTANT): Vehicle Pitch:-0.614985 degrees
2024-08-12T16:03:30.464Z,1723478610.464 [IBIT](IMPORTANT): Vehicle Roll:-0.583828 degrees
2024-08-12T16:03:30.464Z,1723478610.464 [IBIT](IMPORTANT): Vehicle Heading:22.586115 degrees
2024-08-12T16:03:30.872Z,1723478610.872 [IBIT](IMPORTANT): surfaceThreshold: 1.000000 m
2024-08-12T16:03:30.872Z,1723478610.872 [IBIT](IMPORTANT): buoyancyNeutral: 128.796036 cc
2024-08-12T16:03:30.872Z,1723478610.872 [IBIT](IMPORTANT): massDefault: 1.094093 cm
2024-08-12T16:03:30.873Z,1723478610.873 [IBIT](IMPORTANT): stopDepth: 250.000000 m
2024-08-12T16:03:30.873Z,1723478610.873 [IBIT](IMPORTANT): abortDepth: 270.000000 m
2024-08-12T16:03:30.873Z,1723478610.873 [IBIT](IMPORTANT): IBIT PASSED
2024-08-12T16:03:58.316Z,1723478638.316 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-08-12T16:04:01.554Z,1723478641.554 [NAL9602](INFO): Not Powering down - fast GPS
2024-08-12T16:04:14.073Z,1723478654.073 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-08-12T16:04:29.876Z,1723478669.876 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-08-12T16:04:45.634Z,1723478685.634 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-08-12T16:05:01.427Z,1723478701.427 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-08-12T16:05:16.843Z,1723478716.843 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-08-12T16:05:27.700Z,1723478727.700 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-08-12T16:05:27.701Z,1723478727.701 [Default:CheckIn:C.Wait] Stopped
2024-08-12T16:05:27.701Z,1723478727.701 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-08-12T16:05:27.701Z,1723478727.701 [Default:CheckIn:D] Running Loop=1
2024-08-12T16:05:28.113Z,1723478728.113 [Default:CheckIn:D] Stopped
2024-08-12T16:05:28.113Z,1723478728.113 [Default:CheckIn:E] Running Loop=1
2024-08-12T16:05:28.513Z,1723478728.513 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 21.827952 min
2024-08-12T16:05:28.513Z,1723478728.513 [Default:CheckIn:E] Stopped
2024-08-12T16:05:28.513Z,1723478728.513 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-08-12T16:05:28.513Z,1723478728.513 [Default:CheckIn] Stopped
2024-08-12T16:05:28.513Z,1723478728.513 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-08-12T16:05:28.513Z,1723478728.513 [Default:CheckIn](INFO): Running loop #2
2024-08-12T16:05:28.529Z,1723478728.529 [Default:CheckIn] Running Loop=2
2024-08-12T16:05:28.530Z,1723478728.530 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-08-12T16:05:28.530Z,1723478728.530 [Default:CheckIn:Read_GPS] Running Loop=1
2024-08-12T16:05:30.527Z,1723478730.527 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,160528.00,A,3648.14224,N,12147.22736,W,0.078,137.85,120824,,,A*75
2024-08-12T16:05:30.530Z,1723478730.530 [NAL9602](INFO): GPS fix at 20240812T160528: (36.802371, -121.787123)
2024-08-12T16:05:30.540Z,1723478730.540 [Default:CheckIn:Read_GPS] Stopped
2024-08-12T16:05:30.540Z,1723478730.540 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-08-12T16:05:32.537Z,1723478732.537 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-08-12T16:05:37.510Z,1723478737.510 [DataOverHttps](INFO): Sending 222 bytes from file Logs/20240812T153930/Courier0007.lzma
2024-08-12T16:05:38.511Z,1723478738.511 [DataOverHttps](INFO): Moved sent file to Logs/20240812T153930/Courier0007.lzma.bak
2024-08-12T16:05:38.512Z,1723478738.512 [DataOverHttps](INFO): SBD MOMSN=21490215
2024-08-12T16:05:48.696Z,1723478748.696 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-08-12T16:05:54.523Z,1723478754.523 [DataOverHttps](INFO): Sending 963 bytes from file Logs/20240812T153930/Express0008.lzma
2024-08-12T16:05:55.523Z,1723478755.523 [DataOverHttps](INFO): Moved sent file to Logs/20240812T153930/Express0008.lzma.bak
2024-08-12T16:05:55.523Z,1723478755.523 [DataOverHttps](INFO): SBD MOMSN=21490218
2024-08-12T16:05:56.789Z,1723478756.789 [Default:CheckIn:Read_Iridium] Stopped
2024-08-12T16:05:56.789Z,1723478756.789 [Default:CheckIn:C.Wait] Running Loop=1
2024-08-12T16:05:56.790Z,1723478756.790 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-08-12T16:06:02.093Z,1723478762.093 [NAL9602](INFO): SBD MO Status=2, MOMSN=54772, MT Status=2, MTMSN=0
2024-08-12T16:06:02.093Z,1723478762.093 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2024-08-12T16:06:04.048Z,1723478764.048 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-08-12T16:06:32.332Z,1723478792.332 [NAL9602](INFO): SBD MO Status=0, MOMSN=54772, MT Status=0, MTMSN=0
2024-08-12T16:06:32.332Z,1723478792.332 [NAL9602](INFO): No messages in MT queue
2024-08-12T16:07:03.034Z,1723478823.034 [NAL9602](INFO): Not Powering down - fast GPS
2024-08-12T16:10:42.000Z,1723479042.000 [BPC1](INFO): Calculating totals. Valid battery stick count: 49. Valid reserve battery stick count: 5.
2024-08-12T16:10:42.004Z,1723479042.004 [BPC1](ERROR): Failed to receive data from all sticks prior to timeout. Will not retry this scan cycle.
2024-08-12T16:10:57.368Z,1723479057.368 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-08-12T16:10:57.369Z,1723479057.369 [Default:CheckIn:C.Wait] Stopped
2024-08-12T16:10:57.369Z,1723479057.369 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-08-12T16:10:57.369Z,1723479057.369 [Default:CheckIn:D] Running Loop=1
2024-08-12T16:10:57.772Z,1723479057.772 [Default:CheckIn:D] Stopped
2024-08-12T16:10:57.772Z,1723479057.772 [Default:CheckIn:E] Running Loop=1
2024-08-12T16:10:58.173Z,1723479058.173 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 27.322278 min
2024-08-12T16:10:58.174Z,1723479058.174 [Default:CheckIn:E] Stopped
2024-08-12T16:10:58.174Z,1723479058.174 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-08-12T16:10:58.174Z,1723479058.174 [Default:CheckIn] Stopped
2024-08-12T16:10:58.174Z,1723479058.174 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-08-12T16:10:58.174Z,1723479058.174 [Default:CheckIn](INFO): Running loop #3
2024-08-12T16:10:58.174Z,1723479058.174 [Default:CheckIn] Running Loop=3
2024-08-12T16:10:58.174Z,1723479058.174 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-08-12T16:10:58.174Z,1723479058.174 [Default:CheckIn:Read_GPS] Running Loop=1
2024-08-12T16:11:00.188Z,1723479060.188 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,161059.00,A,3648.15037,N,12147.22150,W,0.661,12.14,120824,,,A*40
2024-08-12T16:11:00.191Z,1723479060.191 [NAL9602](INFO): GPS fix at 20240812T161059: (36.802506, -121.787025)
2024-08-12T16:11:00.216Z,1723479060.216 [Default:CheckIn:Read_GPS] Stopped
2024-08-12T16:11:00.216Z,1723479060.216 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-08-12T16:11:07.485Z,1723479067.485 [DataOverHttps](INFO): Sending 201 bytes from file Logs/20240812T153930/Courier0010.lzma
2024-08-12T16:11:08.487Z,1723479068.487 [DataOverHttps](INFO): Moved sent file to Logs/20240812T153930/Courier0010.lzma.bak
2024-08-12T16:11:08.487Z,1723479068.487 [DataOverHttps](INFO): SBD MOMSN=21490309
2024-08-12T16:11:17.556Z,1723479077.556 [NAL9602](INFO): SBD MO Status=0, MOMSN=54773, MT Status=0, MTMSN=0
2024-08-12T16:11:17.556Z,1723479077.556 [NAL9602](INFO): No messages in MT queue
2024-08-12T16:11:24.337Z,1723479084.337 [DataOverHttps](INFO): Sending 131 bytes from file Logs/20240812T153930/Express0012.lzma
2024-08-12T16:11:25.339Z,1723479085.339 [DataOverHttps](INFO): Moved sent file to Logs/20240812T153930/Express0012.lzma.bak
2024-08-12T16:11:25.339Z,1723479085.339 [DataOverHttps](INFO): SBD MOMSN=21490312
2024-08-12T16:11:26.458Z,1723479086.458 [Default:CheckIn:Read_Iridium] Stopped
2024-08-12T16:11:26.458Z,1723479086.458 [Default:CheckIn:C.Wait] Running Loop=1
2024-08-12T16:11:26.458Z,1723479086.458 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-08-12T16:11:48.257Z,1723479108.257 [NAL9602](INFO): Not Powering down - fast GPS
2024-08-12T16:16:27.041Z,1723479387.041 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-08-12T16:16:27.041Z,1723479387.041 [Default:CheckIn:C.Wait] Stopped
2024-08-12T16:16:27.041Z,1723479387.041 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-08-12T16:16:27.041Z,1723479387.041 [Default:CheckIn:D] Running Loop=1
2024-08-12T16:16:27.452Z,1723479387.452 [Default:CheckIn:D] Stopped
2024-08-12T16:16:27.453Z,1723479387.453 [Default:CheckIn:E] Running Loop=1
2024-08-12T16:16:27.852Z,1723479387.852 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 32.816943 min
2024-08-12T16:16:27.852Z,1723479387.852 [Default:CheckIn:E] Stopped
2024-08-12T16:16:27.852Z,1723479387.852 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-08-12T16:16:27.852Z,1723479387.852 [Default:CheckIn] Stopped
2024-08-12T16:16:27.852Z,1723479387.852 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-08-12T16:16:27.853Z,1723479387.853 [Default:CheckIn](INFO): Running loop #4
2024-08-12T16:16:27.853Z,1723479387.853 [Default:CheckIn] Running Loop=4
2024-08-12T16:16:27.853Z,1723479387.853 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-08-12T16:16:27.853Z,1723479387.853 [Default:CheckIn:Read_GPS] Running Loop=1
2024-08-12T16:16:29.860Z,1723479389.860 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,161629.00,A,3648.15050,N,12147.22131,W,0.019,120.07,120824,,,A*7C
2024-08-12T16:16:29.862Z,1723479389.862 [NAL9602](INFO): GPS fix at 20240812T161629: (36.802508, -121.787022)
2024-08-12T16:16:29.872Z,1723479389.872 [Default:CheckIn:Read_GPS] Stopped
2024-08-12T16:16:29.872Z,1723479389.872 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-08-12T16:16:37.493Z,1723479397.493 [DataOverHttps](INFO): Sending 74 bytes from file Logs/20240812T153930/Courier0016.lzma
2024-08-12T16:16:38.496Z,1723479398.496 [DataOverHttps](INFO): Moved sent file to Logs/20240812T153930/Courier0016.lzma.bak
2024-08-12T16:16:38.496Z,1723479398.496 [DataOverHttps](INFO): SBD MOMSN=21490323
2024-08-12T16:16:57.053Z,1723479417.053 [DataOverHttps](INFO): Sending 132 bytes from file Logs/20240812T153930/Express0017.lzma
2024-08-12T16:16:58.055Z,1723479418.055 [DataOverHttps](INFO): Moved sent file to Logs/20240812T153930/Express0017.lzma.bak
2024-08-12T16:16:58.056Z,1723479418.056 [DataOverHttps](INFO): SBD MOMSN=21490326
2024-08-12T16:16:59.435Z,1723479419.435 [Default:CheckIn:Read_Iridium] Stopped
2024-08-12T16:16:59.435Z,1723479419.435 [Default:CheckIn:C.Wait] Running Loop=1
2024-08-12T16:16:59.435Z,1723479419.435 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-08-12T16:17:18.392Z,1723479438.392 [NAL9602](INFO): SBD MO Status=0, MOMSN=54774, MT Status=0, MTMSN=0
2024-08-12T16:17:18.392Z,1723479438.392 [NAL9602](INFO): No messages in MT queue
2024-08-12T16:17:49.094Z,1723479469.094 [NAL9602](INFO): Not Powering down - fast GPS
2024-08-12T16:22:00.034Z,1723479720.034 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-08-12T16:22:00.034Z,1723479720.034 [Default:CheckIn:C.Wait] Stopped
2024-08-12T16:22:00.034Z,1723479720.034 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-08-12T16:22:00.034Z,1723479720.034 [Default:CheckIn:D] Running Loop=1
2024-08-12T16:22:00.424Z,1723479720.424 [Default:CheckIn:D] Stopped
2024-08-12T16:22:00.424Z,1723479720.424 [Default:CheckIn:E] Running Loop=1
2024-08-12T16:22:00.832Z,1723479720.832 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 38.366463 min
2024-08-12T16:22:00.833Z,1723479720.833 [Default:CheckIn:E] Stopped
2024-08-12T16:22:00.833Z,1723479720.833 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-08-12T16:22:00.833Z,1723479720.833 [Default:CheckIn] Stopped
2024-08-12T16:22:00.833Z,1723479720.833 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-08-12T16:22:00.833Z,1723479720.833 [Default:CheckIn](INFO): Running loop #5
2024-08-12T16:22:00.833Z,1723479720.833 [Default:CheckIn] Running Loop=5
2024-08-12T16:22:00.834Z,1723479720.834 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-08-12T16:22:00.834Z,1723479720.834 [Default:CheckIn:Read_GPS] Running Loop=1
2024-08-12T16:22:02.840Z,1723479722.840 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,162202.00,A,3648.15035,N,12147.22056,W,0.039,120.07,120824,,,A*73
2024-08-12T16:22:02.843Z,1723479722.843 [NAL9602](INFO): GPS fix at 20240812T162202: (36.802506, -121.787009)
2024-08-12T16:22:02.853Z,1723479722.853 [Default:CheckIn:Read_GPS] Stopped
2024-08-12T16:22:02.853Z,1723479722.853 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-08-12T16:22:09.469Z,1723479729.469 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20240812T153930/Courier0019.lzma
2024-08-12T16:22:10.471Z,1723479730.471 [DataOverHttps](INFO): Moved sent file to Logs/20240812T153930/Courier0019.lzma.bak
2024-08-12T16:22:10.471Z,1723479730.471 [DataOverHttps](INFO): SBD MOMSN=21490395
2024-08-12T16:22:22.661Z,1723479742.661 [NAL9602](INFO): SBD MO Status=0, MOMSN=54775, MT Status=0, MTMSN=0
2024-08-12T16:22:22.661Z,1723479742.661 [NAL9602](INFO): No messages in MT queue
2024-08-12T16:22:29.437Z,1723479749.437 [DataOverHttps](INFO): Sending 131 bytes from file Logs/20240812T153930/Express0020.lzma
2024-08-12T16:22:30.439Z,1723479750.439 [DataOverHttps](INFO): Moved sent file to Logs/20240812T153930/Express0020.lzma.bak
2024-08-12T16:22:30.439Z,1723479750.439 [DataOverHttps](INFO): SBD MOMSN=21490398
2024-08-12T16:22:31.571Z,1723479751.571 [Default:CheckIn:Read_Iridium] Stopped
2024-08-12T16:22:31.571Z,1723479751.571 [Default:CheckIn:C.Wait] Running Loop=1
2024-08-12T16:22:31.571Z,1723479751.571 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-08-12T16:22:53.403Z,1723479773.403 [NAL9602](INFO): Not Powering down - fast GPS
2024-08-12T16:26:42.919Z,1723480002.919 [DataOverHttps](IMPORTANT): SBD MTMSN=20240812T162642
2024-08-12T16:26:51.809Z,1723480011.809 [DataOverHttps](INFO): Received command: restart app
2024-08-12T16:26:51.855Z,1723480011.855 [CommandExec](IMPORTANT): got command restart application
2024-08-12T16:26:52.858Z,1723480012.858 [Supervisor](INFO): Stop Mission called by Supervisor::terminate
2024-08-12T16:26:52.858Z,1723480012.858 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread.
2024-08-12T16:26:52.858Z,1723480012.858 [CommandExec](INFO): Uninitializing the command executive.
2024-08-12T16:26:52.858Z,1723480012.858 [CommandExec](INFO): Uninitializing the command scheduler.
2024-08-12T16:26:52.859Z,1723480012.859 [CommandExec ThreadHandler](INFO): Thread cancelled.
2024-08-12T16:26:52.941Z,1723480012.941 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye!
2024-08-12T16:26:52.942Z,1723480012.942 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2024-08-12T16:26:52.942Z,1723480012.942 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2024-08-12T16:26:52.942Z,1723480012.942 [NavChartDb](INFO): Join timeout helper Thread ID is 4508
2024-08-12T16:26:53.250Z,1723480013.250 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2024-08-12T16:26:53.250Z,1723480013.250 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2024-08-12T16:26:53.262Z,1723480013.262 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2024-08-12T16:26:53.262Z,1723480013.262 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2024-08-12T16:26:53.262Z,1723480013.262 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 4509
2024-08-12T16:26:53.478Z,1723480013.478 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread.
2024-08-12T16:26:53.478Z,1723480013.478 [WetLabsBB2FL](INFO): Powering down
2024-08-12T16:26:53.479Z,1723480013.479 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2024-08-12T16:26:53.486Z,1723480013.486 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler
2024-08-12T16:26:53.486Z,1723480013.486 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2024-08-12T16:26:53.486Z,1723480013.486 [CTD_Seabird](INFO): Join timeout helper Thread ID is 4510
2024-08-12T16:26:54.042Z,1723480014.042 [CTD_Seabird](INFO): Powering down
2024-08-12T16:26:54.054Z,1723480014.054 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread.
2024-08-12T16:26:54.054Z,1723480014.054 [CTD_Seabird](INFO): Powering down
2024-08-12T16:26:54.068Z,1723480014.068 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2024-08-12T16:26:54.074Z,1723480014.074 [ComponentRegistry](INFO): Shutting down DAT ThreadHandler
2024-08-12T16:26:54.074Z,1723480014.074 [DAT ThreadHandler](INFO): Thread cancelled.
2024-08-12T16:26:54.074Z,1723480014.074 [DAT](INFO): Join timeout helper Thread ID is 4511
2024-08-12T16:26:54.135Z,1723480014.135 [DAT](INFO): Powering down
2024-08-12T16:26:54.218Z,1723480014.218 [DAT ThreadHandler](INFO): Uninitializing protected caller thread.
2024-08-12T16:26:54.218Z,1723480014.218 [DAT](INFO): Powering down
2024-08-12T16:26:54.219Z,1723480014.219 [DAT ThreadHandler](INFO): Thread cancelled.
2024-08-12T16:26:54.237Z,1723480014.237 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2024-08-12T16:26:54.238Z,1723480014.238 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2024-08-12T16:26:54.238Z,1723480014.238 [Radio_Surface](INFO): Join timeout helper Thread ID is 4512
2024-08-12T16:26:54.438Z,1723480014.438 [Radio_Surface](INFO): Powering down
2024-08-12T16:26:54.439Z,1723480014.439 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2024-08-12T16:26:54.439Z,1723480014.439 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2024-08-12T16:26:54.447Z,1723480014.447 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler
2024-08-12T16:26:54.447Z,1723480014.447 [Onboard ThreadHandler](INFO): Thread cancelled.
2024-08-12T16:26:54.447Z,1723480014.447 [Onboard](INFO): Join timeout helper Thread ID is 4513
2024-08-12T16:26:54.810Z,1723480014.810 [DataOverHttps](INFO): Radio surface powered OFF, will not connect.
2024-08-12T16:26:58.466Z,1723480018.466 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread.
2024-08-12T16:26:58.466Z,1723480018.466 [Onboard ThreadHandler](INFO): Thread cancelled.
2024-08-12T16:26:58.486Z,1723480018.486 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler
2024-08-12T16:26:58.486Z,1723480018.486 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2024-08-12T16:26:58.487Z,1723480018.487 [DataOverHttps](INFO): Join timeout helper Thread ID is 4514
2024-08-12T16:26:58.826Z,1723480018.826 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread.
2024-08-12T16:26:58.826Z,1723480018.826 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2024-08-12T16:26:58.842Z,1723480018.842 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2024-08-12T16:26:58.842Z,1723480018.842 [logger ThreadHandler](INFO): Thread cancelled.
2024-08-12T16:26:58.843Z,1723480018.843 [logger](INFO): Join timeout helper Thread ID is 4515
2024-08-12T16:26:58.862Z,1723480018.862 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2024-08-12T16:26:58.862Z,1723480018.862 [logger ThreadHandler](INFO): Thread cancelled.
2024-08-12T16:26:58.882Z,1723480018.882 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2024-08-12T16:26:58.882Z,1723480018.882 [CommandLine ThreadHandler](INFO): Thread cancelled.
2024-08-12T16:26:58.883Z,1723480018.883 [CommandLine](INFO): Join timeout helper Thread ID is 4516
2024-08-12T16:26:58.942Z,1723480018.942 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2024-08-12T16:26:58.942Z,1723480018.942 [CommandLine ThreadHandler](INFO): Thread cancelled.
2024-08-12T16:26:58.962Z,1723480018.962 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler
2024-08-12T16:26:58.962Z,1723480018.962 [CommandExec ThreadHandler](INFO): Thread cancelled.
2024-08-12T16:26:58.963Z,1723480018.963 [CommandExec](INFO): Join timeout helper Thread ID is 4517
2024-08-12T16:26:58.964Z,1723480018.964 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2024-08-12T16:26:58.964Z,1723480018.964 [controlThread ThreadHandler](INFO): Thread cancelled.
2024-08-12T16:26:58.964Z,1723480018.964 [controlThread](INFO): Join timeout helper Thread ID is 4518
2024-08-12T16:26:59.026Z,1723480019.026 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2024-08-12T16:26:59.026Z,1723480019.026 [controlThread](DEBUG): Uninitializing ControlThread
2024-08-12T16:26:59.026Z,1723480019.026 [AHRS_M2](INFO): Powering down
2024-08-12T16:26:59.098Z,1723480019.098 [NAL9602](INFO): Powering down
2024-08-12T16:26:59.101Z,1723480019.101 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2024-08-12T16:26:59.102Z,1723480019.102 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2024-08-12T16:26:59.102Z,1723480019.102 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2024-08-12T16:26:59.103Z,1723480019.103 [MissionManager](INFO): Uninitializing Mission Default
2024-08-12T16:26:59.103Z,1723480019.103 [Default] Stopped
2024-08-12T16:26:59.103Z,1723480019.103 [Default](DEBUG): Aggregate::uninitialize Default
2024-08-12T16:26:59.103Z,1723480019.103 [Default:B.GoToSurface] Stopped
2024-08-12T16:26:59.103Z,1723480019.103 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2024-08-12T16:26:59.103Z,1723480019.103 [Default:CheckIn] Stopped
2024-08-12T16:26:59.103Z,1723480019.103 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-08-12T16:26:59.103Z,1723480019.103 [Default:CheckIn:C.Wait] Stopped
2024-08-12T16:26:59.103Z,1723480019.103 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-08-12T16:26:59.106Z,1723480019.106 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2024-08-12T16:26:59.106Z,1723480019.106 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2024-08-12T16:26:59.107Z,1723480019.107 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2024-08-12T16:26:59.107Z,1723480019.107 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2024-08-12T16:26:59.107Z,1723480019.107 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2024-08-12T16:26:59.107Z,1723480019.107 [BuoyancyServo](INFO): Powering down
2024-08-12T16:26:59.122Z,1723480019.122 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2024-08-12T16:26:59.122Z,1723480019.122 [ElevatorServo](INFO): Powering down
2024-08-12T16:26:59.123Z,1723480019.123 [MassServo](DEBUG): Uninitialize Mass Servo.
2024-08-12T16:26:59.123Z,1723480019.123 [MassServo](INFO): Powering down
2024-08-12T16:26:59.124Z,1723480019.124 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2024-08-12T16:26:59.124Z,1723480019.124 [RudderServo](INFO): Powering down
2024-08-12T16:26:59.125Z,1723480019.125 [ThrusterHE](DEBUG): Uninitialize Thruster Servo.
2024-08-12T16:26:59.125Z,1723480019.125 [ThrusterHE](INFO): Powering down
2024-08-12T16:26:59.126Z,1723480019.126 [SBIT](DEBUG): Uninitialize SBIT Component.
2024-08-12T16:26:59.126Z,1723480019.126 [IBIT](DEBUG): Uninitialize IBIT Component.
2024-08-12T16:26:59.127Z,1723480019.127 [CBIT](DEBUG): Uninitialize CBIT Component.
2024-08-12T16:26:59.127Z,1723480019.127 [CBIT](DEBUG): Powering off loads.
2024-08-12T16:26:59.137Z,1723480019.137 [CBIT](DEBUG): Disabling WDT.
2024-08-12T16:26:59.149Z,1723480019.149 [CBIT](DEBUG): Opening all GF detection circuits.
2024-08-12T16:26:59.150Z,1723480019.150 [controlThread ThreadHandler](INFO): Thread cancelled.
2024-08-12T16:26:59.208Z,1723480019.208 [DAT ThreadHandler](INFO): Thread cancelled.
2024-08-12T16:26:59.213Z,1723480019.213 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2024-08-12T16:26:59.215Z,1723480019.215 [Onboard ThreadHandler](INFO): Thread cancelled.
2024-08-12T16:26:59.221Z,1723480019.221 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2024-08-12T16:26:59.299Z,1723480019.299 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2024-08-12T16:26:59.304Z,1723480019.304 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2024-08-12T16:26:59.355Z,1723480019.355 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2024-08-12T16:26:59.431Z,1723480019.431 [logger ThreadHandler](INFO): Thread cancelled.