2023-06-23T17:26:58.456Z,1687541218.456 [Supervisor](DEBUG): Initializing supervisor.
2023-06-23T17:26:58.461Z,1687541218.461 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2023-06-23T17:26:58.462Z,1687541218.462 [SyncHandler](INFO): Protected caller Thread ID is 8667
2023-06-23T17:26:58.462Z,1687541218.462 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2023-06-23T17:26:58.464Z,1687541218.464 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2023-06-23T17:26:58.464Z,1687541218.464 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 8668
2023-06-23T17:26:58.468Z,1687541218.468 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2023-06-23T17:26:58.485Z,1687541218.485 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread.
2023-06-23T17:26:58.486Z,1687541218.486 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2023-06-23T17:26:58.487Z,1687541218.487 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 8669
2023-06-23T17:26:58.491Z,1687541218.491 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2023-06-23T17:26:58.492Z,1687541218.492 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2023-06-23T17:26:58.492Z,1687541218.492 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 8670
2023-06-23T17:26:58.494Z,1687541218.494 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2023-06-23T17:26:58.495Z,1687541218.495 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0
2023-06-23T17:26:58.495Z,1687541218.495 [logger ThreadHandler](INFO): Protected caller Thread ID is 8671
2023-06-23T17:26:58.499Z,1687541218.499 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2023-06-23T17:26:58.499Z,1687541218.499 [Supervisor](INFO): Looking for Config files in directory: Config/
2023-06-23T17:26:58.501Z,1687541218.501 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2023-06-23T17:26:58.597Z,1687541218.597 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2023-06-23T17:26:58.598Z,1687541218.598 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2023-06-23T17:26:59.272Z,1687541219.272 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2023-06-23T17:26:59.272Z,1687541219.272 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg
2023-06-23T17:26:59.486Z,1687541219.486 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock
2023-06-23T17:26:59.487Z,1687541219.487 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2023-06-23T17:26:59.566Z,1687541219.566 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2023-06-23T17:26:59.696Z,1687541219.696 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2023-06-23T17:26:59.696Z,1687541219.696 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2023-06-23T17:26:59.778Z,1687541219.778 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2023-06-23T17:26:59.885Z,1687541219.885 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2023-06-23T17:26:59.885Z,1687541219.885 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2023-06-23T17:27:00.255Z,1687541220.255 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2023-06-23T17:27:00.255Z,1687541220.255 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2023-06-23T17:27:00.723Z,1687541220.723 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2023-06-23T17:27:00.724Z,1687541220.724 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2023-06-23T17:27:00.935Z,1687541220.935 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2023-06-23T17:27:00.935Z,1687541220.935 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2023-06-23T17:27:01.120Z,1687541221.120 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2023-06-23T17:27:01.121Z,1687541221.121 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2023-06-23T17:27:01.632Z,1687541221.632 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2023-06-23T17:27:01.632Z,1687541221.632 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2023-06-23T17:27:02.206Z,1687541222.206 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2023-06-23T17:27:02.206Z,1687541222.206 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2023-06-23T17:27:02.420Z,1687541222.420 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2023-06-23T17:27:02.421Z,1687541222.421 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2023-06-23T17:27:02.788Z,1687541222.788 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2023-06-23T17:27:02.788Z,1687541222.788 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2023-06-23T17:27:03.126Z,1687541223.126 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2023-06-23T17:27:03.128Z,1687541223.128 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-pontus/
2023-06-23T17:27:03.129Z,1687541223.129 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/secure.cfg
2023-06-23T17:27:03.214Z,1687541223.214 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Sensor.cfg
2023-06-23T17:27:03.372Z,1687541223.372 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Servo.cfg
2023-06-23T17:27:03.473Z,1687541223.473 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Simulator.cfg
2023-06-23T17:27:03.559Z,1687541223.559 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/logger.cfg
2023-06-23T17:27:03.653Z,1687541223.653 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/vehicle.cfg
2023-06-23T17:27:03.765Z,1687541223.765 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Battery.cfg
2023-06-23T17:27:04.026Z,1687541224.026 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2023-06-23T17:27:04.027Z,1687541224.027 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Navigation.cfg
2023-06-23T17:27:04.121Z,1687541224.121 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/BIT.cfg
2023-06-23T17:27:04.221Z,1687541224.221 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Science.cfg
2023-06-23T17:27:04.360Z,1687541224.360 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Control.cfg
2023-06-23T17:27:04.462Z,1687541224.462 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-pontus/root/
2023-06-23T17:27:04.462Z,1687541224.462 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg
2023-06-23T17:27:04.469Z,1687541224.469 [Module Loader](DEBUG): Loading Module at Modules/Dock.so
2023-06-23T17:27:04.564Z,1687541224.564 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking)
2023-06-23T17:27:04.564Z,1687541224.564 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2023-06-23T17:27:04.612Z,1687541224.612 [VerticalControl](DEBUG): Construct VerticalControl.
2023-06-23T17:27:04.671Z,1687541224.671 [VerticalControl] Loaded
2023-06-23T17:27:04.672Z,1687541224.672 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2023-06-23T17:27:04.674Z,1687541224.674 [HorizontalControl](DEBUG): Construct HorizontalControl.
2023-06-23T17:27:04.715Z,1687541224.715 [HorizontalControl] Loaded
2023-06-23T17:27:04.715Z,1687541224.715 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2023-06-23T17:27:04.717Z,1687541224.717 [SpeedControl](DEBUG): Construct SpeedControl.
2023-06-23T17:27:04.720Z,1687541224.720 [SpeedControl] Loaded
2023-06-23T17:27:04.721Z,1687541224.721 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2023-06-23T17:27:04.723Z,1687541224.723 [LoopControl](DEBUG): Construct LoopControl.
2023-06-23T17:27:04.724Z,1687541224.724 [LoopControl] Loaded
2023-06-23T17:27:04.724Z,1687541224.724 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2023-06-23T17:27:04.724Z,1687541224.724 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2023-06-23T17:27:04.725Z,1687541224.725 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2023-06-23T17:27:04.772Z,1687541224.772 [DepthRateCalculator] Loaded
2023-06-23T17:27:04.772Z,1687541224.772 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2023-06-23T17:27:04.777Z,1687541224.777 [PitchRateCalculator] Loaded
2023-06-23T17:27:04.777Z,1687541224.777 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2023-06-23T17:27:04.787Z,1687541224.787 [SpeedCalculator] Loaded
2023-06-23T17:27:04.787Z,1687541224.787 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2023-06-23T17:27:04.791Z,1687541224.791 [YawRateCalculator] Loaded
2023-06-23T17:27:04.791Z,1687541224.791 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2023-06-23T17:27:04.809Z,1687541224.809 [ElevatorOffsetCalculator] Loaded
2023-06-23T17:27:04.809Z,1687541224.809 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2023-06-23T17:27:04.810Z,1687541224.810 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2023-06-23T17:27:04.810Z,1687541224.810 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2023-06-23T17:27:04.835Z,1687541224.835 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2023-06-23T17:27:04.836Z,1687541224.836 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2023-06-23T17:27:04.889Z,1687541224.889 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2023-06-23T17:27:04.890Z,1687541224.890 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2023-06-23T17:27:05.180Z,1687541225.180 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2023-06-23T17:27:05.180Z,1687541225.180 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2023-06-23T17:27:05.321Z,1687541225.321 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2023-06-23T17:27:05.322Z,1687541225.322 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2023-06-23T17:27:05.764Z,1687541225.764 [AHRS_M2] Loaded
2023-06-23T17:27:05.764Z,1687541225.764 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread.
2023-06-23T17:27:05.798Z,1687541225.798 [BackseatComponent] Loaded
2023-06-23T17:27:05.798Z,1687541225.798 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread.
2023-06-23T17:27:05.799Z,1687541225.799 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 4098B4E0
2023-06-23T17:27:05.800Z,1687541225.800 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 8753
2023-06-23T17:27:05.802Z,1687541225.802 [LcmUniversalReporter] Loaded
2023-06-23T17:27:05.803Z,1687541225.803 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread.
2023-06-23T17:27:06.600Z,1687541226.600 [BPC1] Loaded
2023-06-23T17:27:06.600Z,1687541226.600 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2023-06-23T17:27:06.671Z,1687541226.671 [DataOverHttps] Loaded
2023-06-23T17:27:06.672Z,1687541226.672 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2023-06-23T17:27:06.673Z,1687541226.673 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 409BB4E0
2023-06-23T17:27:06.673Z,1687541226.673 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 8754
2023-06-23T17:27:06.693Z,1687541226.693 [Depth_Keller] Loaded
2023-06-23T17:27:06.694Z,1687541226.694 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2023-06-23T17:27:06.698Z,1687541226.698 [DropWeight] Loaded
2023-06-23T17:27:06.699Z,1687541226.699 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2023-06-23T17:27:06.760Z,1687541226.760 [NAL9602] Loaded
2023-06-23T17:27:06.761Z,1687541226.761 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2023-06-23T17:27:06.790Z,1687541226.790 [Onboard] Loaded
2023-06-23T17:27:06.790Z,1687541226.790 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread.
2023-06-23T17:27:06.791Z,1687541226.791 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 409EB4E0
2023-06-23T17:27:06.791Z,1687541226.791 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 8755
2023-06-23T17:27:06.797Z,1687541226.797 [PowerOnly](INFO): Adding load control power supply at /dev/loadB1
2023-06-23T17:27:06.808Z,1687541226.808 [PowerOnly] Loaded
2023-06-23T17:27:06.809Z,1687541226.809 [ComponentRegistry](DEBUG): SyncComponent "PowerOnly" handled in the control thread.
2023-06-23T17:27:06.820Z,1687541226.820 [Power24vConverter] Loaded
2023-06-23T17:27:06.820Z,1687541226.820 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread.
2023-06-23T17:27:06.833Z,1687541226.833 [Radio_Surface] Loaded
2023-06-23T17:27:06.833Z,1687541226.833 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2023-06-23T17:27:06.834Z,1687541226.834 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 40A1B4E0
2023-06-23T17:27:06.835Z,1687541226.835 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 8756
2023-06-23T17:27:06.878Z,1687541226.878 [RDI_Pathfinder] Loaded
2023-06-23T17:27:06.879Z,1687541226.879 [ComponentRegistry](DEBUG): SyncComponent "RDI_Pathfinder" handled in the control thread.
2023-06-23T17:27:06.970Z,1687541226.970 [DAT] Loaded
2023-06-23T17:27:06.970Z,1687541226.970 [ComponentRegistry](DEBUG): Component "DAT" handled in its own thread.
2023-06-23T17:27:06.971Z,1687541226.971 [DAT ThreadHandler](DEBUG): Created PCaller Thread at 40A4B4E0
2023-06-23T17:27:06.972Z,1687541226.972 [DAT ThreadHandler](INFO): Protected caller Thread ID is 8757
2023-06-23T17:27:06.972Z,1687541226.972 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2023-06-23T17:27:06.973Z,1687541226.973 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2023-06-23T17:27:07.329Z,1687541227.329 [DeadReckonUsingMultipleVelocitySources] Loaded
2023-06-23T17:27:07.329Z,1687541227.329 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2023-06-23T17:27:07.348Z,1687541227.348 [NavChart] Loaded
2023-06-23T17:27:07.348Z,1687541227.348 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2023-06-23T17:27:07.354Z,1687541227.354 [UniversalFixResidualReporter] Loaded
2023-06-23T17:27:07.354Z,1687541227.354 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2023-06-23T17:27:07.354Z,1687541227.354 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2023-06-23T17:27:07.355Z,1687541227.355 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2023-06-23T17:27:07.552Z,1687541227.552 [SBIT](DEBUG): Construct Startup Built In Test.
2023-06-23T17:27:07.575Z,1687541227.575 [SBIT] Loaded
2023-06-23T17:27:07.575Z,1687541227.575 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2023-06-23T17:27:07.586Z,1687541227.586 [IBIT](DEBUG): Construct Initiated Built In Test.
2023-06-23T17:27:07.601Z,1687541227.601 [IBIT] Loaded
2023-06-23T17:27:07.602Z,1687541227.602 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2023-06-23T17:27:07.607Z,1687541227.607 [CBIT](DEBUG): Construct Continuous Built In Test.
2023-06-23T17:27:07.719Z,1687541227.719 [CBIT] Loaded
2023-06-23T17:27:07.720Z,1687541227.720 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2023-06-23T17:27:07.720Z,1687541227.720 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2023-06-23T17:27:07.721Z,1687541227.721 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2023-06-23T17:27:08.014Z,1687541228.014 [BuoyancyServo] Loaded
2023-06-23T17:27:08.015Z,1687541228.015 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2023-06-23T17:27:08.035Z,1687541228.035 [ElevatorServo] Loaded
2023-06-23T17:27:08.035Z,1687541228.035 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2023-06-23T17:27:08.054Z,1687541228.054 [MassServo] Loaded
2023-06-23T17:27:08.055Z,1687541228.055 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2023-06-23T17:27:08.073Z,1687541228.073 [RudderServo] Loaded
2023-06-23T17:27:08.073Z,1687541228.073 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2023-06-23T17:27:08.090Z,1687541228.090 [ThrusterServo] Loaded
2023-06-23T17:27:08.090Z,1687541228.090 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread.
2023-06-23T17:27:08.091Z,1687541228.091 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2023-06-23T17:27:08.091Z,1687541228.091 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2023-06-23T17:27:08.101Z,1687541228.101 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2023-06-23T17:27:08.102Z,1687541228.102 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2023-06-23T17:27:08.269Z,1687541228.269 [CTD_Seabird] Loaded
2023-06-23T17:27:08.269Z,1687541228.269 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread.
2023-06-23T17:27:08.270Z,1687541228.270 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40B934E0
2023-06-23T17:27:08.271Z,1687541228.271 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 8758
2023-06-23T17:27:08.290Z,1687541228.290 [PAR_Licor] Loaded
2023-06-23T17:27:08.291Z,1687541228.291 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2023-06-23T17:27:08.321Z,1687541228.321 [WetLabsBB2FL] Loaded
2023-06-23T17:27:08.321Z,1687541228.321 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2023-06-23T17:27:08.322Z,1687541228.322 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40BC34E0
2023-06-23T17:27:08.323Z,1687541228.323 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 8759
2023-06-23T17:27:08.342Z,1687541228.342 [WetLabsUBAT] Loaded
2023-06-23T17:27:08.342Z,1687541228.342 [ComponentRegistry](DEBUG): Component "WetLabsUBAT" handled in its own thread.
2023-06-23T17:27:08.343Z,1687541228.343 [WetLabsUBAT ThreadHandler](DEBUG): Created PCaller Thread at 40BF34E0
2023-06-23T17:27:08.344Z,1687541228.344 [WetLabsUBAT ThreadHandler](INFO): Protected caller Thread ID is 8760
2023-06-23T17:27:08.344Z,1687541228.344 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2023-06-23T17:27:08.351Z,1687541228.351 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2023-06-23T17:27:08.353Z,1687541228.353 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2023-06-23T17:27:08.364Z,1687541228.364 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2023-06-23T17:27:08.365Z,1687541228.365 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40C234E0
2023-06-23T17:27:08.366Z,1687541228.366 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 8761
2023-06-23T17:27:08.370Z,1687541228.370 [Supervisor](INFO): Main Thread ID is 7937
2023-06-23T17:27:08.370Z,1687541228.370 [Supervisor](DEBUG): Running supervisor.
2023-06-23T17:27:08.371Z,1687541228.371 [CommandExec ThreadHandler](INFO): Handler Thread ID is 8762
2023-06-23T17:27:08.372Z,1687541228.372 [CommandExec](INFO): Initializing the command executive.
2023-06-23T17:27:08.373Z,1687541228.373 [CommandLine ThreadHandler](INFO): Handler Thread ID is 8763
2023-06-23T17:27:08.375Z,1687541228.375 [controlThread ThreadHandler](INFO): Handler Thread ID is 8764
2023-06-23T17:27:08.376Z,1687541228.376 [controlThread](DEBUG): Initializing ControlThread
2023-06-23T17:27:08.377Z,1687541228.377 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2023-06-23T17:27:08.379Z,1687541228.379 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2023-06-23T17:27:08.379Z,1687541228.379 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2023-06-23T17:27:08.380Z,1687541228.380 [LoopControl](DEBUG): Initialize LoopControlComponent.
2023-06-23T17:27:08.380Z,1687541228.380 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2023-06-23T17:27:08.381Z,1687541228.381 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2023-06-23T17:27:08.381Z,1687541228.381 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2023-06-23T17:27:08.381Z,1687541228.381 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2023-06-23T17:27:08.382Z,1687541228.382 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2023-06-23T17:27:08.389Z,1687541228.389 [NavChart](DEBUG): Initialize NavChart Navigation.
2023-06-23T17:27:08.389Z,1687541228.389 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2023-06-23T17:27:08.390Z,1687541228.390 [SBIT](INFO): Initialize SBIT Component.
2023-06-23T17:27:08.390Z,1687541228.390 [SBIT](IMPORTANT): git: 2023-05-23-14-gd957ee9d8
2023-06-23T17:27:08.390Z,1687541228.390 [SBIT](INFO): git hash: d957ee9d857d054abd03546ddf42b65141472a60
2023-06-23T17:27:08.391Z,1687541228.391 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2023-06-23T17:27:08.392Z,1687541228.392 [SBIT](INFO): Kernel Reporting Different Version From Configuration.
Kernel Expected: #1 PREEMPT Thu Feb 21 11:17:40 PST 2019
Kernel Reported: #1 PREEMPT Wed Mar 17 08:23:48 PDT 2021
2023-06-23T17:27:08.393Z,1687541228.393 [SBIT](INFO): Beginning SBIT in 46.000000 seconds.
2023-06-23T17:27:08.394Z,1687541228.394 [IBIT](INFO): Initialize IBIT Component.
2023-06-23T17:27:08.395Z,1687541228.395 [CBIT](DEBUG): Initialize CBIT Component.
2023-06-23T17:27:08.395Z,1687541228.395 [logger ThreadHandler](INFO): Handler Thread ID is 8765
2023-06-23T17:27:08.406Z,1687541228.406 [CBIT](DEBUG): Initialized mux pins.
2023-06-23T17:27:08.407Z,1687541228.407 [CBIT](DEBUG): Initializing the watchdog timer.
2023-06-23T17:27:08.415Z,1687541228.415 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 8766
2023-06-23T17:27:08.427Z,1687541228.427 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 8767
2023-06-23T17:27:08.428Z,1687541228.428 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2023-06-23T17:27:08.430Z,1687541228.430 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2023-06-23T17:27:08.431Z,1687541228.431 [CBIT](DEBUG): Initializing heartbeat.
2023-06-23T17:27:08.439Z,1687541228.439 [Onboard ThreadHandler](INFO): Handler Thread ID is 8768
2023-06-23T17:27:08.456Z,1687541228.456 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 8769
2023-06-23T17:27:08.475Z,1687541228.475 [DAT ThreadHandler](INFO): Handler Thread ID is 8770
2023-06-23T17:27:08.476Z,1687541228.476 [DAT](INFO): Powering up
2023-06-23T17:27:08.476Z,1687541228.476 [DAT](DEBUG): Initializing DAT.
2023-06-23T17:27:08.480Z,1687541228.480 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 8772
2023-06-23T17:27:08.480Z,1687541228.480 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2023-06-23T17:27:08.484Z,1687541228.484 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 8774
2023-06-23T17:27:08.487Z,1687541228.487 [WetLabsBB2FL](INFO): Powering up
2023-06-23T17:27:08.488Z,1687541228.488 [WetLabsUBAT ThreadHandler](INFO): Handler Thread ID is 8776
2023-06-23T17:27:08.491Z,1687541228.491 [WetLabsUBAT](INFO): Powering up
2023-06-23T17:27:08.492Z,1687541228.492 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 8778
2023-06-23T17:27:08.495Z,1687541228.495 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2023-06-23T17:27:08.496Z,1687541228.496 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2023-06-23T17:27:08.496Z,1687541228.496 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2023-06-23T17:27:08.496Z,1687541228.496 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2023-06-23T17:27:08.496Z,1687541228.496 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2023-06-23T17:27:08.496Z,1687541228.496 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2023-06-23T17:27:08.497Z,1687541228.497 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2023-06-23T17:27:08.497Z,1687541228.497 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2023-06-23T17:27:08.502Z,1687541228.502 [CBIT](DEBUG): Deactivating GF circuits.
2023-06-23T17:27:08.503Z,1687541228.503 [CBIT](DEBUG): Deactivating emergency mode.
2023-06-23T17:27:08.542Z,1687541228.542 [CBIT](DEBUG): Backplane powered.
2023-06-23T17:27:08.547Z,1687541228.547 [MissionManager](INFO): Loading Mission from file: Missions/Startup.xml
2023-06-23T17:27:08.572Z,1687541228.572 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2023-06-23T17:27:08.613Z,1687541228.613 [MissionManager](DEBUG): 
<?xml version="1.0" encoding="UTF-8"?>
<Mission xmlns="Tethys"
       xmlns:Control="Tethys/Control"
       xmlns:Guidance="Tethys/Guidance" 
       xmlns:Units="Tethys/Units"
       xmlns:Universal="Tethys/Universal"
       xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"
       xsi:schemaLocation="Tethys http://okeanids.mbari.org/tethys/Xml/Tethys.xsd
                           Tethys/Control http://okeanids.mbari.org/tethys/Xml/Control.xsd
                           Tethys/Guidance http://okeanids.mbari.org/tethys/Xml/Guidance.xsd
                           Tethys/Units http://okeanids.mbari.org/tethys/Xml/Units.xsd
                           Tethys/Universal http://okeanids.mbari.org/tethys/Xml/Universal.xsd"
       Id="Startup">

    <Guidance:GoToSurface>
        <Progression/>
    </Guidance:GoToSurface>

    <Aggregate Id="StartupSatComms">

        <Sequence/>

        <ReadDatum>
            <Timeout Duration="P1M" />
            <Universal:latitude_fix/>
        </ReadDatum>

        <ReadDatum>
            <Timeout Duration="P1M" />
            <Universal:platform_communications/>
        </ReadDatum>

    </Aggregate>

</Mission>


2023-06-23T17:27:08.613Z,1687541228.613 [MissionManager](INFO): Loading Mission from file: Missions/Default.xml
2023-06-23T17:27:08.697Z,1687541228.697 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2023-06-23T17:27:08.723Z,1687541228.723 [Default:A.Wait](DEBUG): Construct Wait.
2023-06-23T17:27:08.725Z,1687541228.725 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2023-06-23T17:27:08.769Z,1687541228.769 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2023-06-23T17:27:08.772Z,1687541228.772 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2023-06-23T17:27:08.795Z,1687541228.795 [Default:E.Execute](DEBUG): Construct Execute.
2023-06-23T17:27:08.799Z,1687541228.799 [MissionManager](DEBUG): 
<?xml version="1.0" encoding="UTF-8"?>
<Mission xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"
         xmlns="Tethys"
         xmlns:Units="Tethys/Units"
         xmlns:Guidance="Tethys/Guidance"
         xmlns:Universal="Tethys/Universal"
         xsi:schemaLocation="Tethys http://okeanids.mbari.org/tethys/Xml/Tethys.xsd
                             Tethys/Units http://okeanids.mbari.org/tethys/Xml/Units.xsd
                             Tethys/Guidance http://okeanids.mbari.org/tethys/Xml/Guidance.xsd
                             Tethys/Universal http://okeanids.mbari.org/tethys/Xml/Universal.xsd"
         Id="Default">

    <DefineArg Name="ElapsedSinceDefaultStarted"><Units:minute/><Value>0</Value></DefineArg>

    <Guidance:Wait>
        <Description>
            Wait a moment to see if the scheduler starts a new mission before
            starting to actually run Default.
        </Description>
        <Sequence/>
        <Setting><Guidance:Wait.duration/><Units:second/><Value>13</Value></Setting>
    </Guidance:Wait>

    <Guidance:GoToSurface>
        <Progression/>
    </Guidance:GoToSurface>

    <Aggregate Id="CheckIn">

        <Sequence Repeat="288"/>

        <ReadDatum Id="Read_GPS">
            <Timeout Duration="P5M"/>
            <Universal:time_fix/>
        </ReadDatum>

        <ReadDatum Id="Read_Iridium">
            <Timeout Duration="P4H">
                <Guidance:Execute>
                    <Sequence/>
                    <Setting><Guidance:Execute.command/><String>Burn on</String></Setting>
                </Guidance:Execute>
                <Syslog Severity="Critical">Dropped weight due to communications timeout.</Syslog>
            </Timeout>
            <Universal:platform_communications/>
        </ReadDatum>

        <Guidance:Wait>
            <Sequence/>
            <Setting><Guidance:Wait.duration/><Units:minute/><Value>5</Value></Setting>
        </Guidance:Wait>

        <Assign><Sequence/><Arg Name="ElapsedSinceDefaultStarted"/><Elapsed><Universal:mission_started/></Elapsed></Assign>

        <Syslog Severity="Important">Default mission has been running for <Arg Name="ElapsedSinceDefaultStarted"/><Units:minute/></Syslog>

    </Aggregate>

    <Syslog Severity="Important">Restarting logs and Default mission.</Syslog>

    <Guidance:Execute>
        <Sequence/>
        <Setting><Guidance:Execute.command/><String>restart logs</String></Setting>
    </Guidance:Execute>

</Mission>


2023-06-23T17:27:08.821Z,1687541228.821 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,DropWeight,NAL9602,PowerOnly,Power24vConverter,RDI_Pathfinder,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter,
2023-06-23T17:27:08.842Z,1687541228.842 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2023-06-23T17:27:08.871Z,1687541228.871 [Radio_Surface](INFO): Powering up
2023-06-23T17:27:08.940Z,1687541228.940 [Depth_Keller](ERROR): Pressure or depth reading out of range: -1.000394 decibar, -0.993016 m
2023-06-23T17:27:08.942Z,1687541228.942 [PowerOnly](INFO): Powering up loadControl
2023-06-23T17:27:08.959Z,1687541228.959 [Power24vConverter](INFO): Powering up.
2023-06-23T17:27:08.960Z,1687541228.960 [RDI_Pathfinder](IMPORTANT): Expecting PD13 message format
2023-06-23T17:27:08.995Z,1687541228.995 [DepthRateCalculator](ERROR): Depth measurement is not active
2023-06-23T17:27:09.037Z,1687541229.037 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2023-06-23T17:27:09.043Z,1687541229.043 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2023-06-23T17:27:09.044Z,1687541229.044 [ElevatorServo](DEBUG): Initializing EZServoServo.
2023-06-23T17:27:09.051Z,1687541229.051 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2023-06-23T17:27:09.052Z,1687541229.052 [MassServo](DEBUG): Initializing EZServoServo.
2023-06-23T17:27:09.059Z,1687541229.059 [MassServo](DEBUG): Initializing MassServo.
2023-06-23T17:27:09.060Z,1687541229.060 [RudderServo](DEBUG): Initializing EZServoServo.
2023-06-23T17:27:09.067Z,1687541229.067 [RudderServo](DEBUG): Initializing RudderServo.
2023-06-23T17:27:09.068Z,1687541229.068 [ThrusterServo](DEBUG): Initializing EZServoServo.
2023-06-23T17:27:09.075Z,1687541229.075 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2023-06-23T17:27:11.098Z,1687541231.098 [WetLabsBB2FL](INFO): Powering down
2023-06-23T17:27:17.760Z,1687541237.760 [WetLabsUBAT](INFO): Powering down
2023-06-23T17:27:20.575Z,1687541240.575 [DAT](INFO): DAT read: 

2023-06-23T17:27:20.577Z,1687541240.577 [DAT](INFO): DAT read: Teledyne Benthos DAT-900 Series

2023-06-23T17:27:22.339Z,1687541242.339 [DAT](INFO): DAT read: MF Frequency Band

2023-06-23T17:27:22.341Z,1687541242.341 [DAT](INFO): DAT read: Directional Acoustic Transponder version 8.15.0

2023-06-23T17:27:22.341Z,1687541242.341 [DAT](INFO): DAT read: Jun 23 2023 17:27:17 

2023-06-23T17:27:23.348Z,1687541243.348 [DAT](INFO): DAT read: Features enabled [Bearing]

2023-06-23T17:27:23.349Z,1687541243.349 [DAT](INFO): DAT read: CONNECT 00800 bits/sec 1 of 4, Rate 1/2 CC 12.50ms MGP

2023-06-23T17:27:23.349Z,1687541243.349 [DAT](INFO): commRate: 800
2023-06-23T17:27:25.414Z,1687541245.414 [DAT](INFO): entering command mode
2023-06-23T17:27:25.615Z,1687541245.615 [DAT](INFO): DAT read: 

2023-06-23T17:27:25.616Z,1687541245.616 [DAT](INFO): DAT read: user:1>

2023-06-23T17:27:25.616Z,1687541245.616 [DAT](INFO): setting verbose to 3
2023-06-23T17:27:25.867Z,1687541245.867 [DAT](INFO): DAT read: user:1>

2023-06-23T17:27:25.868Z,1687541245.868 [DAT](INFO): DAT read: Verbose         | 3           

2023-06-23T17:27:25.868Z,1687541245.868 [DAT](INFO): set verbose to 3
2023-06-23T17:27:25.869Z,1687541245.869 [DAT](INFO): setting DatVerbose to 27440
2023-06-23T17:27:26.119Z,1687541246.119 [DAT](INFO): DAT read: user:2>

2023-06-23T17:27:26.120Z,1687541246.120 [DAT](INFO): DAT read: DatVerbose      | 27440       

2023-06-23T17:27:26.120Z,1687541246.120 [DAT](INFO): set DatVerbose to 27440
2023-06-23T17:27:26.121Z,1687541246.121 [DAT](INFO): setting transmit power to 8
2023-06-23T17:27:26.371Z,1687541246.371 [DAT](INFO): DAT read: user:3>

2023-06-23T17:27:26.372Z,1687541246.372 [DAT](INFO): DAT read: TxPower         | 8 (Max)     

2023-06-23T17:27:26.372Z,1687541246.372 [DAT](INFO): set transmit power to 8
2023-06-23T17:27:26.373Z,1687541246.373 [DAT](INFO): setting local address to 10
2023-06-23T17:27:26.623Z,1687541246.623 [DAT](INFO): DAT read: user:4>

2023-06-23T17:27:26.624Z,1687541246.624 [DAT](INFO): DAT read: LocalAddr       | 10          

2023-06-23T17:27:26.624Z,1687541246.624 [DAT](INFO): set local address to 10
2023-06-23T17:27:26.625Z,1687541246.625 [DAT](INFO): Setting time to: 17:27:26 And date to:6/23/2023
2023-06-23T17:27:26.875Z,1687541246.875 [DAT](INFO): DAT read: user:5>

2023-06-23T17:27:26.876Z,1687541246.876 [DAT](INFO): DAT read: Fri Jun 23, 2023  17:27:26  

2023-06-23T17:27:26.876Z,1687541246.876 [DAT](INFO): Local DAT time set to Fri Jun 23, 2023  17:27:26  

2023-06-23T17:27:37.160Z,1687541257.160 [NAL9602](INFO): Powering up NAL9602
2023-06-23T17:27:44.735Z,1687541264.735 [CommandExec](IMPORTANT): got command configSet PowerOnly.sampleTime1 1 second
2023-06-23T17:27:45.248Z,1687541265.248 [PowerOnly](INFO): Powering down loadControl
2023-06-23T17:27:48.076Z,1687541268.076 [NAL9602](INFO): NAL9602 initialized
2023-06-23T17:27:54.263Z,1687541274.263 [CommandExec](IMPORTANT): got command configSet PowerOnly.sampleTime1 0 second
2023-06-23T17:27:54.540Z,1687541274.540 [PowerOnly](INFO): Powering up loadControl
2023-06-23T17:27:54.982Z,1687541274.982 [SBIT](IMPORTANT): Beginning Startup BIT
2023-06-23T17:27:55.018Z,1687541275.018 [CBIT](IMPORTANT): Beginning ground fault scan
2023-06-23T17:28:05.929Z,1687541285.929 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): -0.005611
CHAN A1 (24V): 0.007445
CHAN A2 (12V): -0.003990
CHAN A3 (5V): 0.000094
CHAN B0 (3.3V): 0.002139
CHAN B1 (3.15aV): 0.001703
CHAN B2 (3.15bV): 0.001372
CHAN B3 (GND): 0.002212
OPEN: 0.005730
Full Scale: +/- 1 mA
2023-06-23T17:28:48.732Z,1687541328.732 [SBIT](IMPORTANT): SBIT PASSED
2023-06-23T17:28:48.732Z,1687541328.732 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2023-06-23T17:28:48.733Z,1687541328.733 [SBIT](IMPORTANT): BPC1.batteryMissingStickThreshold=2 count;

2023-06-23T17:28:48.733Z,1687541328.733 [SBIT](IMPORTANT): CBIT.gf24Offset=143 microampere;

2023-06-23T17:28:48.733Z,1687541328.733 [SBIT](IMPORTANT): Express linearApproximation WetLabsUBAT.flow_rate 0.300000 liter_per_second;

2023-06-23T17:28:48.733Z,1687541328.733 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=295.498135 cubic_centimeter;

2023-06-23T17:28:48.733Z,1687541328.733 [SBIT](IMPORTANT): VerticalControl.massDefault=6.676639 millimeter;

2023-06-23T17:28:48.733Z,1687541328.733 [SBIT](IMPORTANT): WetLabsUBAT.loadAtStartup=1 bool;

2023-06-23T17:28:49.117Z,1687541329.117 [MissionManager](IMPORTANT): Started mission Startup
2023-06-23T17:28:49.117Z,1687541329.117 [Startup] Running Loop=1
2023-06-23T17:28:49.117Z,1687541329.117 [Startup](DEBUG): Aggregate::initialize Startup
2023-06-23T17:28:49.117Z,1687541329.117 [Startup:A.GoToSurface] Running Loop=1
2023-06-23T17:28:49.117Z,1687541329.117 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2023-06-23T17:28:49.118Z,1687541329.118 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2023-06-23T17:28:49.118Z,1687541329.118 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2023-06-23T17:28:49.119Z,1687541329.119 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2023-06-23T17:28:49.119Z,1687541329.119 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2023-06-23T17:28:49.120Z,1687541329.120 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2023-06-23T17:28:49.121Z,1687541329.121 [Startup:StartupSatComms] Running Loop=1
2023-06-23T17:28:49.121Z,1687541329.121 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2023-06-23T17:28:49.121Z,1687541329.121 [Startup:StartupSatComms:A] Running Loop=1
2023-06-23T17:28:49.508Z,1687541329.508 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2023-06-23T17:29:36.475Z,1687541376.475 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.016138
2023-06-23T17:29:49.289Z,1687541389.289 [Startup:StartupSatComms:A](INFO): Timed out from 2023-06-23T17:28:49.1Z
2023-06-23T17:29:49.289Z,1687541389.289 [Startup:StartupSatComms:A] Stopped
2023-06-23T17:29:49.289Z,1687541389.289 [Startup:StartupSatComms:B] Running Loop=1
2023-06-23T17:29:49.690Z,1687541389.690 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2023-06-23T17:29:57.083Z,1687541397.083 [DataOverHttps](INFO): Sending 151 bytes from file Logs/20230623T172107/Courier0000.lzma
2023-06-23T17:29:58.084Z,1687541398.084 [DataOverHttps](INFO): Moved sent file to Logs/20230623T172107/Courier0000.lzma.bak
2023-06-23T17:29:58.084Z,1687541398.084 [DataOverHttps](INFO): SBD MOMSN=18422361
2023-06-23T17:30:08.695Z,1687541408.695 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2023-06-23T17:30:08.695Z,1687541408.695 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-06-23T17:30:08.726Z,1687541408.726 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-06-23T17:30:09.093Z,1687541409.093 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-06-23T17:30:09.094Z,1687541409.094 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2023-06-23T17:30:13.962Z,1687541413.962 [DataOverHttps](INFO): Sending 151 bytes from file Logs/20230623T172348/Courier0000.lzma
2023-06-23T17:30:14.964Z,1687541414.964 [DataOverHttps](INFO): Moved sent file to Logs/20230623T172348/Courier0000.lzma.bak
2023-06-23T17:30:14.964Z,1687541414.964 [DataOverHttps](INFO): SBD MOMSN=18422367
2023-06-23T17:30:30.966Z,1687541430.966 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20230623T172348/Courier0004.lzma
2023-06-23T17:30:31.968Z,1687541431.968 [DataOverHttps](INFO): Moved sent file to Logs/20230623T172348/Courier0004.lzma.bak
2023-06-23T17:30:31.968Z,1687541431.968 [DataOverHttps](INFO): SBD MOMSN=18422370
2023-06-23T17:30:48.518Z,1687541448.518 [DataOverHttps](INFO): Sending 151 bytes from file Logs/20230623T172658/Courier0000.lzma
2023-06-23T17:30:49.486Z,1687541449.486 [Startup:StartupSatComms:B](INFO): Timed out from 2023-06-23T17:29:49.3Z
2023-06-23T17:30:49.486Z,1687541449.486 [Startup:StartupSatComms:B] Stopped
2023-06-23T17:30:49.486Z,1687541449.486 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2023-06-23T17:30:49.486Z,1687541449.486 [Startup:StartupSatComms] Stopped
2023-06-23T17:30:49.486Z,1687541449.486 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2023-06-23T17:30:49.487Z,1687541449.487 [Startup](INFO): Completed Startup
2023-06-23T17:30:49.487Z,1687541449.487 [MissionManager](INFO): Startup is completed.
2023-06-23T17:30:49.487Z,1687541449.487 [MissionManager](INFO): Uninitializing Mission Startup
2023-06-23T17:30:49.487Z,1687541449.487 [Startup] Stopped
2023-06-23T17:30:49.488Z,1687541449.488 [Startup](DEBUG): Aggregate::uninitialize Startup
2023-06-23T17:30:49.488Z,1687541449.488 [Startup:A.GoToSurface] Stopped
2023-06-23T17:30:49.488Z,1687541449.488 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2023-06-23T17:30:49.520Z,1687541449.520 [DataOverHttps](INFO): Moved sent file to Logs/20230623T172658/Courier0000.lzma.bak
2023-06-23T17:30:49.520Z,1687541449.520 [DataOverHttps](INFO): SBD MOMSN=18422372
2023-06-23T17:30:49.900Z,1687541449.900 [MissionManager](IMPORTANT): Started mission Default
2023-06-23T17:30:49.900Z,1687541449.900 [Default] Running Loop=1
2023-06-23T17:30:49.900Z,1687541449.900 [Default](DEBUG): Aggregate::initialize Default
2023-06-23T17:30:49.900Z,1687541449.900 [Default:B.GoToSurface] Running Loop=1
2023-06-23T17:30:49.901Z,1687541449.901 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2023-06-23T17:30:49.901Z,1687541449.901 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2023-06-23T17:30:49.901Z,1687541449.901 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2023-06-23T17:30:49.901Z,1687541449.901 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2023-06-23T17:30:49.902Z,1687541449.902 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2023-06-23T17:30:49.902Z,1687541449.902 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2023-06-23T17:30:49.903Z,1687541449.903 [Default:A.Wait] Running Loop=1
2023-06-23T17:30:49.903Z,1687541449.903 [Default:A.Wait](DEBUG): Initialize Wait Component.
2023-06-23T17:31:03.237Z,1687541463.237 [Default:A.Wait](INFO): Done Waiting.
2023-06-23T17:31:03.237Z,1687541463.237 [Default:A.Wait] Stopped
2023-06-23T17:31:03.237Z,1687541463.237 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2023-06-23T17:31:03.675Z,1687541463.675 [Default:CheckIn] Running Loop=1
2023-06-23T17:31:03.675Z,1687541463.675 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2023-06-23T17:31:03.675Z,1687541463.675 [Default:CheckIn:Read_GPS] Running Loop=1
2023-06-23T17:31:04.044Z,1687541464.044 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2023-06-23T17:32:51.488Z,1687541571.488 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2023-06-23T17:33:09.672Z,1687541589.672 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2
2023-06-23T17:33:09.672Z,1687541589.672 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-06-23T17:33:09.684Z,1687541589.684 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-06-23T17:33:10.087Z,1687541590.087 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-06-23T17:33:10.087Z,1687541590.087 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2
2023-06-23T17:35:27.052Z,1687541727.052 [BPC1](INFO): Calculating totals. Valid battery stick count: 56. Valid reserve battery stick count: 6.
2023-06-23T17:35:27.060Z,1687541727.060 [BPC1](INFO): Received data from all battery sticks.
2023-06-23T17:36:03.821Z,1687541763.821 [Default:CheckIn:Read_GPS](INFO): Timed out from 2023-06-23T17:31:03.7Z
2023-06-23T17:36:03.821Z,1687541763.821 [Default:CheckIn:Read_GPS] Stopped
2023-06-23T17:36:03.821Z,1687541763.821 [Default:CheckIn:Read_Iridium] Running Loop=1
2023-06-23T17:36:04.228Z,1687541764.228 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications
2023-06-23T17:36:10.692Z,1687541770.692 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3
2023-06-23T17:36:10.692Z,1687541770.692 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-06-23T17:36:10.703Z,1687541770.703 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-06-23T17:36:11.077Z,1687541771.077 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-06-23T17:36:11.077Z,1687541771.077 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3
2023-06-23T17:36:11.110Z,1687541771.110 [DataOverHttps](INFO): Sending 168 bytes from file Logs/20230623T172658/Courier0004.lzma
2023-06-23T17:36:12.112Z,1687541772.112 [DataOverHttps](INFO): Moved sent file to Logs/20230623T172658/Courier0004.lzma.bak
2023-06-23T17:36:12.112Z,1687541772.112 [DataOverHttps](INFO): SBD MOMSN=18422390
2023-06-23T17:36:28.520Z,1687541788.520 [CommandExec](IMPORTANT): got command configSet PowerOnly.sampleTime1 1 second
2023-06-23T17:36:29.240Z,1687541789.240 [PowerOnly](INFO): Powering down loadControl
2023-06-23T17:36:29.623Z,1687541789.623 [DataOverHttps](INFO): Sending 827 bytes from file Logs/20230622T000855/Express0001.lzma
2023-06-23T17:36:29.640Z,1687541789.640 [PowerOnly](FAULT): loadControl LCB fault:  Invalid Command. Hardware Overcurrent Shutdown. Current Limiter Activated.
2023-06-23T17:36:29.640Z,1687541789.640 [PowerOnly] Hardware Fault, FailCount= 1
2023-06-23T17:36:29.640Z,1687541789.640 [PowerOnly](ERROR): Hardware Fault
2023-06-23T17:36:29.657Z,1687541789.657 [CBIT](ERROR): Hardware Fault in component: PowerOnly
2023-06-23T17:36:30.045Z,1687541790.045 [PowerOnly](INFO): Powering down loadControl
2023-06-23T17:36:30.624Z,1687541790.624 [DataOverHttps](INFO): Moved sent file to Logs/20230622T000855/Express0001.lzma.bak
2023-06-23T17:36:30.624Z,1687541790.624 [DataOverHttps](INFO): SBD MOMSN=18422392
2023-06-23T17:36:30.913Z,1687541790.913 [CBIT](INFO): Clearing failed state for component PowerOnly
2023-06-23T17:36:30.913Z,1687541790.913 [PowerOnly] No Fault, FailCount= 1
2023-06-23T17:36:32.499Z,1687541792.499 [PowerOnly](INFO): Powering down loadControl
2023-06-23T17:36:32.569Z,1687541792.569 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for altitude
2023-06-23T17:36:46.594Z,1687541806.594 [DataOverHttps](INFO): Sending 114 bytes from file Logs/20230622T000855/Express0005.lzma
2023-06-23T17:36:47.596Z,1687541807.596 [DataOverHttps](INFO): Moved sent file to Logs/20230622T000855/Express0005.lzma.bak
2023-06-23T17:36:47.596Z,1687541807.596 [DataOverHttps](INFO): SBD MOMSN=18422410
2023-06-23T17:36:55.336Z,1687541815.336 [CommandExec](IMPORTANT): got command configSet PowerOnly.sampleTime1 0 second
2023-06-23T17:36:55.521Z,1687541815.521 [PowerOnly](INFO): Powering up loadControl
2023-06-23T17:37:03.443Z,1687541823.443 [DataOverHttps](INFO): Sending 890 bytes from file Logs/20230622T001207/Express0001.lzma
2023-06-23T17:37:04.447Z,1687541824.447 [DataOverHttps](INFO): Moved sent file to Logs/20230622T001207/Express0001.lzma.bak
2023-06-23T17:37:04.448Z,1687541824.448 [DataOverHttps](INFO): SBD MOMSN=18422413
2023-06-23T17:37:20.457Z,1687541840.457 [DataOverHttps](INFO): Sending 1121 bytes from file Logs/20230623T171037/Express0001.lzma
2023-06-23T17:37:21.448Z,1687541841.448 [DataOverHttps](INFO): Moved sent file to Logs/20230623T171037/Express0001.lzma.bak
2023-06-23T17:37:21.448Z,1687541841.448 [DataOverHttps](INFO): SBD MOMSN=18422435
2023-06-23T17:37:37.278Z,1687541857.278 [DataOverHttps](INFO): Sending 203 bytes from file Logs/20230623T171037/Express0005.lzma
2023-06-23T17:37:38.280Z,1687541858.280 [DataOverHttps](INFO): Moved sent file to Logs/20230623T171037/Express0005.lzma.bak
2023-06-23T17:37:38.280Z,1687541858.280 [DataOverHttps](INFO): SBD MOMSN=18422475
2023-06-23T17:37:50.468Z,1687541870.468 [NAL9602](FAULT): GPS failed to acquire within timeout.
2023-06-23T17:37:50.468Z,1687541870.468 [NAL9602] Data Fault, FailCount= 1
2023-06-23T17:37:50.468Z,1687541870.468 [NAL9602](ERROR): Data Fault
2023-06-23T17:37:50.567Z,1687541870.567 [CBIT](ERROR): Data Fault in component: NAL9602
2023-06-23T17:37:50.844Z,1687541870.844 [NAL9602](INFO): Powering down
2023-06-23T17:37:51.694Z,1687541871.694 [CBIT](INFO): Clearing failed state for component NAL9602
2023-06-23T17:37:51.694Z,1687541871.694 [NAL9602] No Fault, FailCount= 1
2023-06-23T17:37:54.167Z,1687541874.167 [DataOverHttps](INFO): Sending 565 bytes from file Logs/20230623T171446/Express0001.lzma
2023-06-23T17:37:55.168Z,1687541875.168 [DataOverHttps](INFO): Moved sent file to Logs/20230623T171446/Express0001.lzma.bak
2023-06-23T17:37:55.168Z,1687541875.168 [DataOverHttps](INFO): SBD MOMSN=18422486
2023-06-23T17:38:11.028Z,1687541891.028 [DataOverHttps](INFO): Sending 1196 bytes from file Logs/20230623T171628/Express0001.lzma
2023-06-23T17:38:12.029Z,1687541892.029 [DataOverHttps](INFO): Moved sent file to Logs/20230623T171628/Express0001.lzma.bak
2023-06-23T17:38:12.029Z,1687541892.029 [DataOverHttps](INFO): SBD MOMSN=18422496
2023-06-23T17:38:21.150Z,1687541901.150 [NAL9602](INFO): Powering up NAL9602
2023-06-23T17:38:27.020Z,1687541907.020 [DataOverHttps](INFO): Sending 117 bytes from file Logs/20230623T171628/Express0005.lzma
2023-06-23T17:38:28.016Z,1687541908.016 [DataOverHttps](INFO): Moved sent file to Logs/20230623T171628/Express0005.lzma.bak
2023-06-23T17:38:28.016Z,1687541908.016 [DataOverHttps](INFO): SBD MOMSN=18422543
2023-06-23T17:38:32.064Z,1687541912.064 [NAL9602](INFO): NAL9602 initialized
2023-06-23T17:38:44.267Z,1687541924.267 [DataOverHttps](INFO): Sending 924 bytes from file Logs/20230623T172107/Express0001.lzma
2023-06-23T17:38:45.268Z,1687541925.268 [DataOverHttps](INFO): Moved sent file to Logs/20230623T172107/Express0001.lzma.bak
2023-06-23T17:38:45.268Z,1687541925.268 [DataOverHttps](INFO): SBD MOMSN=18422547
2023-06-23T17:39:00.966Z,1687541940.966 [CommandExec](IMPORTANT): got command configSet PowerOnly.sampleTime1 1 second
2023-06-23T17:39:01.368Z,1687541941.368 [DataOverHttps](INFO): Sending 890 bytes from file Logs/20230623T172348/Express0001.lzma
2023-06-23T17:39:01.545Z,1687541941.545 [PowerOnly](INFO): Powering down loadControl
2023-06-23T17:39:02.364Z,1687541942.364 [DataOverHttps](INFO): Moved sent file to Logs/20230623T172348/Express0001.lzma.bak
2023-06-23T17:39:02.364Z,1687541942.364 [DataOverHttps](INFO): SBD MOMSN=18422568
2023-06-23T17:39:11.147Z,1687541951.147 [CommandExec](IMPORTANT): got command configSet PowerOnly.sampleTime1 0 second
2023-06-23T17:39:11.249Z,1687541951.249 [PowerOnly](INFO): Powering up loadControl
2023-06-23T17:39:11.656Z,1687541951.656 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4
2023-06-23T17:39:11.656Z,1687541951.656 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-06-23T17:39:11.667Z,1687541951.667 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-06-23T17:39:12.071Z,1687541952.071 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-06-23T17:39:12.071Z,1687541952.071 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4
2023-06-23T17:39:18.530Z,1687541958.530 [DataOverHttps](INFO): Sending 79 bytes from file Logs/20230623T172348/Express0005.lzma
2023-06-23T17:39:19.532Z,1687541959.532 [DataOverHttps](INFO): Moved sent file to Logs/20230623T172348/Express0005.lzma.bak
2023-06-23T17:39:19.532Z,1687541959.532 [DataOverHttps](INFO): SBD MOMSN=18422587
2023-06-23T17:39:35.383Z,1687541975.383 [DataOverHttps](INFO): Sending 900 bytes from file Logs/20230623T172658/Express0001.lzma
2023-06-23T17:39:36.384Z,1687541976.384 [DataOverHttps](INFO): Moved sent file to Logs/20230623T172658/Express0001.lzma.bak
2023-06-23T17:39:36.384Z,1687541976.384 [DataOverHttps](INFO): SBD MOMSN=18422590
2023-06-23T17:39:37.768Z,1687541977.768 [CommandExec](IMPORTANT): got command configSet PowerOnly.sampleTime1 1 second
2023-06-23T17:39:38.327Z,1687541978.327 [PowerOnly](INFO): Powering down loadControl
2023-06-23T17:39:50.848Z,1687541990.848 [CommandExec](IMPORTANT): got command configSet PowerOnly.sampleTime1 0 second
2023-06-23T17:39:51.236Z,1687541991.236 [PowerOnly](INFO): Powering up loadControl
2023-06-23T17:39:52.882Z,1687541992.882 [DataOverHttps](INFO): Sending 187 bytes from file Logs/20230623T172658/Express0005.lzma
2023-06-23T17:39:53.884Z,1687541993.884 [DataOverHttps](INFO): Moved sent file to Logs/20230623T172658/Express0005.lzma.bak
2023-06-23T17:39:53.884Z,1687541993.884 [DataOverHttps](INFO): SBD MOMSN=18422610
2023-06-23T17:39:55.296Z,1687541995.296 [Default:CheckIn:Read_Iridium] Stopped
2023-06-23T17:39:55.296Z,1687541995.296 [Default:CheckIn:C.Wait] Running Loop=1
2023-06-23T17:39:55.296Z,1687541995.296 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2023-06-23T17:42:12.707Z,1687542132.707 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 5
2023-06-23T17:42:12.707Z,1687542132.707 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-06-23T17:42:12.718Z,1687542132.718 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-06-23T17:42:13.089Z,1687542133.089 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-06-23T17:42:13.089Z,1687542133.089 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 5
2023-06-23T17:44:55.893Z,1687542295.893 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2023-06-23T17:44:55.894Z,1687542295.894 [Default:CheckIn:C.Wait] Stopped
2023-06-23T17:44:55.894Z,1687542295.894 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2023-06-23T17:44:55.894Z,1687542295.894 [Default:CheckIn:D] Running Loop=1
2023-06-23T17:44:56.289Z,1687542296.289 [Default:CheckIn:D] Stopped
2023-06-23T17:44:56.289Z,1687542296.289 [Default:CheckIn:E] Running Loop=1
2023-06-23T17:44:56.743Z,1687542296.743 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 14.106477 min 
2023-06-23T17:44:56.743Z,1687542296.743 [Default:CheckIn:E] Stopped
2023-06-23T17:44:56.743Z,1687542296.743 [Default:CheckIn](INFO): Completed Default:CheckIn
2023-06-23T17:44:56.743Z,1687542296.743 [Default:CheckIn] Stopped
2023-06-23T17:44:56.744Z,1687542296.744 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2023-06-23T17:44:56.744Z,1687542296.744 [Default:CheckIn](INFO): Running loop #2
2023-06-23T17:44:56.744Z,1687542296.744 [Default:CheckIn] Running Loop=2
2023-06-23T17:44:56.744Z,1687542296.744 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2023-06-23T17:44:56.744Z,1687542296.744 [Default:CheckIn:Read_GPS] Running Loop=1
2023-06-23T17:45:13.668Z,1687542313.668 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 6
2023-06-23T17:45:13.668Z,1687542313.668 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-06-23T17:45:13.679Z,1687542313.679 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-06-23T17:45:14.095Z,1687542314.095 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-06-23T17:45:14.095Z,1687542314.095 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 6
2023-06-23T17:48:14.683Z,1687542494.683 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 7
2023-06-23T17:48:14.683Z,1687542494.683 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-06-23T17:48:14.725Z,1687542494.725 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-06-23T17:48:15.101Z,1687542495.101 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-06-23T17:48:15.101Z,1687542495.101 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 7
2023-06-23T17:48:34.443Z,1687542514.443 [NAL9602](FAULT): GPS failed to acquire within timeout.
2023-06-23T17:48:34.443Z,1687542514.443 [NAL9602] Data Fault, FailCount= 2
2023-06-23T17:48:34.443Z,1687542514.443 [NAL9602](ERROR): Data Fault
2023-06-23T17:48:34.514Z,1687542514.514 [CBIT](ERROR): Data Fault in component: NAL9602
2023-06-23T17:48:34.848Z,1687542514.848 [NAL9602](INFO): Powering down
2023-06-23T17:48:35.669Z,1687542515.669 [CBIT](INFO): Clearing failed state for component NAL9602
2023-06-23T17:48:35.669Z,1687542515.669 [NAL9602] No Fault, FailCount= 2
2023-06-23T17:49:05.144Z,1687542545.144 [NAL9602](INFO): Powering up NAL9602
2023-06-23T17:49:16.048Z,1687542556.048 [NAL9602](INFO): NAL9602 initialized
2023-06-23T17:49:56.912Z,1687542596.912 [Default:CheckIn:Read_GPS](INFO): Timed out from 2023-06-23T17:44:56.7Z
2023-06-23T17:49:56.912Z,1687542596.912 [Default:CheckIn:Read_GPS] Stopped
2023-06-23T17:49:56.912Z,1687542596.912 [Default:CheckIn:Read_Iridium] Running Loop=1
2023-06-23T17:50:03.834Z,1687542603.834 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20230623T172658/Courier0007.lzma
2023-06-23T17:50:04.836Z,1687542604.836 [DataOverHttps](INFO): Moved sent file to Logs/20230623T172658/Courier0007.lzma.bak
2023-06-23T17:50:04.836Z,1687542604.836 [DataOverHttps](INFO): SBD MOMSN=18422645
2023-06-23T17:50:20.742Z,1687542620.742 [DataOverHttps](INFO): Sending 363 bytes from file Logs/20230623T172658/Express0008.lzma
2023-06-23T17:50:21.744Z,1687542621.744 [DataOverHttps](INFO): Moved sent file to Logs/20230623T172658/Express0008.lzma.bak
2023-06-23T17:50:21.744Z,1687542621.744 [DataOverHttps](INFO): SBD MOMSN=18422647
2023-06-23T17:50:23.153Z,1687542623.153 [Default:CheckIn:Read_Iridium] Stopped
2023-06-23T17:50:23.153Z,1687542623.153 [Default:CheckIn:C.Wait] Running Loop=1
2023-06-23T17:50:23.153Z,1687542623.153 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2023-06-23T17:51:15.652Z,1687542675.652 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 8
2023-06-23T17:51:15.652Z,1687542675.652 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-06-23T17:51:15.663Z,1687542675.663 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-06-23T17:51:16.073Z,1687542676.073 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-06-23T17:51:16.073Z,1687542676.073 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 8
2023-06-23T17:54:03.217Z,1687542843.217 [CommandExec](IMPORTANT): got command configSet PowerOnly.sampleTime1 1 second
2023-06-23T17:54:03.714Z,1687542843.714 [PowerOnly](INFO): Powering down loadControl
2023-06-23T17:54:16.684Z,1687542856.684 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 9
2023-06-23T17:54:16.684Z,1687542856.684 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-06-23T17:54:16.703Z,1687542856.703 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-06-23T17:54:17.066Z,1687542857.066 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-06-23T17:54:17.066Z,1687542857.066 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 9
2023-06-23T17:54:33.577Z,1687542873.577 [CommandExec](IMPORTANT): got command configSet PowerOnly.sampleTime1 0 second
2023-06-23T17:54:33.621Z,1687542873.621 [PowerOnly](INFO): Powering up loadControl
2023-06-23T17:55:23.717Z,1687542923.717 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2023-06-23T17:55:23.717Z,1687542923.717 [Default:CheckIn:C.Wait] Stopped
2023-06-23T17:55:23.717Z,1687542923.717 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2023-06-23T17:55:23.717Z,1687542923.717 [Default:CheckIn:D] Running Loop=1
2023-06-23T17:55:24.121Z,1687542924.121 [Default:CheckIn:D] Stopped
2023-06-23T17:55:24.121Z,1687542924.121 [Default:CheckIn:E] Running Loop=1
2023-06-23T17:55:24.563Z,1687542924.563 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 24.570331 min 
2023-06-23T17:55:24.563Z,1687542924.563 [Default:CheckIn:E] Stopped
2023-06-23T17:55:24.563Z,1687542924.563 [Default:CheckIn](INFO): Completed Default:CheckIn
2023-06-23T17:55:24.563Z,1687542924.563 [Default:CheckIn] Stopped
2023-06-23T17:55:24.563Z,1687542924.563 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2023-06-23T17:55:24.563Z,1687542924.563 [Default:CheckIn](INFO): Running loop #3
2023-06-23T17:55:24.563Z,1687542924.563 [Default:CheckIn] Running Loop=3
2023-06-23T17:55:24.563Z,1687542924.563 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2023-06-23T17:55:24.564Z,1687542924.564 [Default:CheckIn:Read_GPS] Running Loop=1
2023-06-23T17:57:17.637Z,1687543037.637 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 10
2023-06-23T17:57:17.637Z,1687543037.637 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-06-23T17:57:17.648Z,1687543037.648 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-06-23T17:57:18.049Z,1687543038.049 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-06-23T17:57:18.050Z,1687543038.050 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 10
2023-06-23T17:59:18.429Z,1687543158.429 [NAL9602](FAULT): GPS failed to acquire within timeout.
2023-06-23T17:59:18.429Z,1687543158.429 [NAL9602] Data Fault, FailCount= 3
2023-06-23T17:59:18.429Z,1687543158.429 [NAL9602](ERROR): Data Fault
2023-06-23T17:59:18.530Z,1687543158.530 [CBIT](ERROR): Data Fault in component: NAL9602
2023-06-23T17:59:18.828Z,1687543158.828 [NAL9602](INFO): Powering down
2023-06-23T17:59:19.685Z,1687543159.685 [CBIT](INFO): Clearing failed state for component NAL9602
2023-06-23T17:59:19.685Z,1687543159.685 [NAL9602] No Fault, FailCount= 3
2023-06-23T17:59:49.132Z,1687543189.132 [NAL9602](INFO): Powering up NAL9602
2023-06-23T18:00:00.041Z,1687543200.041 [NAL9602](INFO): NAL9602 initialized
2023-06-23T18:00:18.656Z,1687543218.656 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 11
2023-06-23T18:00:18.656Z,1687543218.656 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-06-23T18:00:18.687Z,1687543218.687 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-06-23T18:00:19.067Z,1687543219.067 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-06-23T18:00:19.067Z,1687543219.067 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 11
2023-06-23T18:00:24.705Z,1687543224.705 [Default:CheckIn:Read_GPS](INFO): Timed out from 2023-06-23T17:55:24.6Z
2023-06-23T18:00:24.706Z,1687543224.706 [Default:CheckIn:Read_GPS] Stopped
2023-06-23T18:00:24.706Z,1687543224.706 [Default:CheckIn:Read_Iridium] Running Loop=1
2023-06-23T18:00:32.468Z,1687543232.468 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20230623T172658/Courier0010.lzma
2023-06-23T18:00:33.464Z,1687543233.464 [DataOverHttps](INFO): Moved sent file to Logs/20230623T172658/Courier0010.lzma.bak
2023-06-23T18:00:33.464Z,1687543233.464 [DataOverHttps](INFO): SBD MOMSN=18422689
2023-06-23T18:00:49.295Z,1687543249.295 [DataOverHttps](INFO): Sending 207 bytes from file Logs/20230623T172658/Express0011.lzma
2023-06-23T18:00:50.297Z,1687543250.297 [DataOverHttps](INFO): Moved sent file to Logs/20230623T172658/Express0011.lzma.bak
2023-06-23T18:00:50.297Z,1687543250.297 [DataOverHttps](INFO): SBD MOMSN=18422691
2023-06-23T18:00:51.781Z,1687543251.781 [Default:CheckIn:Read_Iridium] Stopped
2023-06-23T18:00:51.781Z,1687543251.781 [Default:CheckIn:C.Wait] Running Loop=1
2023-06-23T18:00:51.781Z,1687543251.781 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2023-06-23T18:02:42.377Z,1687543362.377 [CommandExec](IMPORTANT): got command configSet PowerOnly.sampleTime1 0 second
2023-06-23T18:03:04.921Z,1687543384.921 [CommandExec](IMPORTANT): got command configSet PowerOnly.sampleTime1 1 second
2023-06-23T18:03:05.503Z,1687543385.503 [PowerOnly](INFO): Powering down loadControl
2023-06-23T18:03:10.745Z,1687543390.745 [CommandExec](IMPORTANT): got command configSet PowerOnly.sampleTime1 1 second
2023-06-23T18:03:19.663Z,1687543399.663 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 12
2023-06-23T18:03:19.663Z,1687543399.663 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-06-23T18:03:19.678Z,1687543399.678 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-06-23T18:03:20.049Z,1687543400.049 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-06-23T18:03:20.049Z,1687543400.049 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 12
2023-06-23T18:03:59.819Z,1687543439.819 [CommandExec](IMPORTANT): got command configSet PowerOnly.sampleTime1 0 second
2023-06-23T18:04:00.013Z,1687543440.013 [PowerOnly](INFO): Powering up loadControl
2023-06-23T18:05:52.361Z,1687543552.361 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2023-06-23T18:05:52.361Z,1687543552.361 [Default:CheckIn:C.Wait] Stopped
2023-06-23T18:05:52.361Z,1687543552.361 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2023-06-23T18:05:52.361Z,1687543552.361 [Default:CheckIn:D] Running Loop=1
2023-06-23T18:05:52.778Z,1687543552.778 [Default:CheckIn:D] Stopped
2023-06-23T18:05:52.778Z,1687543552.778 [Default:CheckIn:E] Running Loop=1
2023-06-23T18:05:53.173Z,1687543553.173 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 35.047961 min 
2023-06-23T18:05:53.173Z,1687543553.173 [Default:CheckIn:E] Stopped
2023-06-23T18:05:53.173Z,1687543553.173 [Default:CheckIn](INFO): Completed Default:CheckIn
2023-06-23T18:05:53.173Z,1687543553.173 [Default:CheckIn] Stopped
2023-06-23T18:05:53.174Z,1687543553.174 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2023-06-23T18:05:53.174Z,1687543553.174 [Default:CheckIn](INFO): Running loop #4
2023-06-23T18:05:53.174Z,1687543553.174 [Default:CheckIn] Running Loop=4
2023-06-23T18:05:53.174Z,1687543553.174 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2023-06-23T18:05:53.174Z,1687543553.174 [Default:CheckIn:Read_GPS] Running Loop=1
2023-06-23T18:06:20.649Z,1687543580.649 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 13
2023-06-23T18:06:20.649Z,1687543580.649 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-06-23T18:06:20.660Z,1687543580.660 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-06-23T18:06:21.060Z,1687543581.060 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-06-23T18:06:21.060Z,1687543581.060 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 13
2023-06-23T18:07:10.745Z,1687543630.745 [RDI_Pathfinder](ERROR): only read 1 of 4 data items
2023-06-23T18:08:13.453Z,1687543693.453 [CommandExec](IMPORTANT): got command configSet PowerOnly.sampleTime1 0 second
2023-06-23T18:08:35.080Z,1687543715.080 [CommandExec](IMPORTANT): got command configSet PowerOnly.sampleTime1 1 second
2023-06-23T18:08:35.544Z,1687543715.544 [PowerOnly](INFO): Powering down loadControl
2023-06-23T18:08:41.920Z,1687543721.920 [CommandExec](IMPORTANT): got command configSet PowerOnly.sampleTime1 0 second
2023-06-23T18:08:42.009Z,1687543722.009 [PowerOnly](INFO): Powering up loadControl
2023-06-23T18:09:21.618Z,1687543761.618 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 14
2023-06-23T18:09:21.618Z,1687543761.618 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-06-23T18:09:21.628Z,1687543761.628 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-06-23T18:09:22.037Z,1687543762.037 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-06-23T18:09:22.037Z,1687543762.037 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 14
2023-06-23T18:10:01.589Z,1687543801.589 [NAL9602](FAULT): GPS failed to acquire within timeout.
2023-06-23T18:10:01.589Z,1687543801.589 [NAL9602] Data Fault, FailCount= 4
2023-06-23T18:10:01.589Z,1687543801.589 [NAL9602](ERROR): Data Fault
2023-06-23T18:10:01.644Z,1687543801.644 [CBIT](ERROR): Data Fault in component: NAL9602
2023-06-23T18:10:01.000Z,1687543802.000 [NAL9602](INFO): Powering down
2023-06-23T18:10:02.852Z,1687543802.852 [CBIT](INFO): Clearing failed state for component NAL9602
2023-06-23T18:10:02.852Z,1687543802.852 [NAL9602] No Fault, FailCount= 4
2023-06-23T18:10:32.303Z,1687543832.303 [NAL9602](INFO): Powering up NAL9602
2023-06-23T18:10:43.204Z,1687543843.204 [NAL9602](INFO): NAL9602 initialized
2023-06-23T18:10:53.333Z,1687543853.333 [Default:CheckIn:Read_GPS](INFO): Timed out from 2023-06-23T18:05:53.2Z
2023-06-23T18:10:53.333Z,1687543853.333 [Default:CheckIn:Read_GPS] Stopped
2023-06-23T18:10:53.333Z,1687543853.333 [Default:CheckIn:Read_Iridium] Running Loop=1
2023-06-23T18:11:00.578Z,1687543860.578 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20230623T172658/Courier0013.lzma
2023-06-23T18:11:01.580Z,1687543861.580 [DataOverHttps](INFO): Moved sent file to Logs/20230623T172658/Courier0013.lzma.bak
2023-06-23T18:11:01.580Z,1687543861.580 [DataOverHttps](INFO): SBD MOMSN=18422727
2023-06-23T18:11:20.231Z,1687543880.231 [CommandExec](IMPORTANT): got command configSet PowerOnly.sampleTime1 0 second
2023-06-23T18:11:20.427Z,1687543880.427 [DataOverHttps](INFO): Sending 240 bytes from file Logs/20230623T172658/Express0014.lzma
2023-06-23T18:11:21.424Z,1687543881.424 [DataOverHttps](INFO): Moved sent file to Logs/20230623T172658/Express0014.lzma.bak
2023-06-23T18:11:21.425Z,1687543881.425 [DataOverHttps](INFO): SBD MOMSN=18422729
2023-06-23T18:11:22.880Z,1687543882.880 [Default:CheckIn:Read_Iridium] Stopped
2023-06-23T18:11:22.880Z,1687543882.880 [Default:CheckIn:C.Wait] Running Loop=1
2023-06-23T18:11:22.880Z,1687543882.880 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2023-06-23T18:11:47.331Z,1687543907.331 [CommandExec](IMPORTANT): got command configSet PowerOnly.sampleTime1 0 second
2023-06-23T18:12:05.830Z,1687543925.830 [CommandExec](IMPORTANT): got command configSet PowerOnly.sampleTime1 0 second
2023-06-23T18:12:17.945Z,1687543937.945 [CommandExec](IMPORTANT): got command configSet PowerOnly.sampleTime1 1 second
2023-06-23T18:12:18.623Z,1687543938.623 [PowerOnly](INFO): Powering down loadControl
2023-06-23T18:12:22.703Z,1687543942.703 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 15
2023-06-23T18:12:22.703Z,1687543942.703 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-06-23T18:12:22.714Z,1687543942.714 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-06-23T18:12:23.113Z,1687543943.113 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-06-23T18:12:23.113Z,1687543943.113 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 15
2023-06-23T18:12:27.922Z,1687543947.922 [CommandExec](IMPORTANT): got command configSet PowerOnly.sampleTime1 0 second
2023-06-23T18:12:28.333Z,1687543948.333 [PowerOnly](INFO): Powering up loadControl
2023-06-23T18:13:33.589Z,1687544013.589 [CommandExec](IMPORTANT): got command configSet PowerOnly.sampleTime1 1 second
2023-06-23T18:13:34.185Z,1687544014.185 [PowerOnly](INFO): Powering down loadControl
2023-06-23T18:13:43.277Z,1687544023.277 [CommandExec](IMPORTANT): got command configSet PowerOnly.sampleTime1 0 second
2023-06-23T18:13:43.479Z,1687544023.479 [PowerOnly](INFO): Powering up loadControl
2023-06-23T18:14:06.053Z,1687544046.053 [CommandExec](IMPORTANT): got command configSet PowerOnly.sampleTime1 1 second
2023-06-23T18:14:06.526Z,1687544046.526 [PowerOnly](INFO): Powering down loadControl
2023-06-23T18:14:08.778Z,1687544048.778 [CommandExec](IMPORTANT): got command configSet PowerOnly.sampleTime1 0 second
2023-06-23T18:14:08.927Z,1687544048.927 [PowerOnly](INFO): Powering up loadControl
2023-06-23T18:14:27.173Z,1687544067.173 [CommandExec](IMPORTANT): got command configSet PowerOnly.sampleTime1 1 second
2023-06-23T18:14:27.901Z,1687544067.901 [PowerOnly](INFO): Powering down loadControl
2023-06-23T18:14:29.443Z,1687544069.443 [CommandExec](IMPORTANT): got command configSet PowerOnly.sampleTime1 0 second
2023-06-23T18:14:29.529Z,1687544069.529 [PowerOnly](INFO): Powering up loadControl
2023-06-23T18:14:56.408Z,1687544096.408 [CommandExec](IMPORTANT): got command configSet PowerOnly.sampleTime1 1 second
2023-06-23T18:14:56.997Z,1687544096.997 [PowerOnly](INFO): Powering down loadControl
2023-06-23T18:14:58.872Z,1687544098.872 [CommandExec](IMPORTANT): got command configSet PowerOnly.sampleTime1 0 second
2023-06-23T18:14:59.019Z,1687544099.019 [PowerOnly](INFO): Powering up loadControl
2023-06-23T18:15:08.057Z,1687544108.057 [CommandExec](IMPORTANT): got command configSet PowerOnly.sampleTime1 1 second
2023-06-23T18:15:08.700Z,1687544108.700 [PowerOnly](INFO): Powering down loadControl
2023-06-23T18:15:14.190Z,1687544114.190 [CommandExec](IMPORTANT): got command configSet PowerOnly.sampleTime1 0 second
2023-06-23T18:15:14.356Z,1687544114.356 [PowerOnly](INFO): Powering up loadControl
2023-06-23T18:15:23.676Z,1687544123.676 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 16
2023-06-23T18:15:23.676Z,1687544123.676 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-06-23T18:15:23.703Z,1687544123.703 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-06-23T18:15:24.093Z,1687544124.093 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-06-23T18:15:24.093Z,1687544124.093 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 16
2023-06-23T18:15:32.883Z,1687544132.883 [CommandExec](IMPORTANT): got command configSet PowerOnly.sampleTime1 1 second
2023-06-23T18:15:33.370Z,1687544133.370 [PowerOnly](INFO): Powering down loadControl
2023-06-23T18:15:38.011Z,1687544138.011 [CommandExec](IMPORTANT): got command configSet PowerOnly.sampleTime1 0 second
2023-06-23T18:15:38.206Z,1687544138.206 [PowerOnly](INFO): Powering up loadControl
2023-06-23T18:16:23.465Z,1687544183.465 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2023-06-23T18:16:23.465Z,1687544183.465 [Default:CheckIn:C.Wait] Stopped
2023-06-23T18:16:23.466Z,1687544183.466 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2023-06-23T18:16:23.466Z,1687544183.466 [Default:CheckIn:D] Running Loop=1
2023-06-23T18:16:23.857Z,1687544183.857 [Default:CheckIn:D] Stopped
2023-06-23T18:16:23.857Z,1687544183.857 [Default:CheckIn:E] Running Loop=1
2023-06-23T18:16:24.261Z,1687544184.261 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 45.565951 min 
2023-06-23T18:16:24.261Z,1687544184.261 [Default:CheckIn:E] Stopped
2023-06-23T18:16:24.261Z,1687544184.261 [Default:CheckIn](INFO): Completed Default:CheckIn
2023-06-23T18:16:24.261Z,1687544184.261 [Default:CheckIn] Stopped
2023-06-23T18:16:24.261Z,1687544184.261 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2023-06-23T18:16:24.261Z,1687544184.261 [Default:CheckIn](INFO): Running loop #5
2023-06-23T18:16:24.261Z,1687544184.261 [Default:CheckIn] Running Loop=5
2023-06-23T18:16:24.262Z,1687544184.262 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2023-06-23T18:16:24.262Z,1687544184.262 [Default:CheckIn:Read_GPS] Running Loop=1
2023-06-23T18:18:08.836Z,1687544288.836 [CommandExec](IMPORTANT): got command ! echo 1 > /dev/loadB1
2023-06-23T18:18:24.689Z,1687544304.689 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 17
2023-06-23T18:18:24.689Z,1687544304.689 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-06-23T18:18:24.700Z,1687544304.700 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-06-23T18:18:25.070Z,1687544305.070 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-06-23T18:18:25.071Z,1687544305.071 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 17
2023-06-23T18:18:44.624Z,1687544324.624 [CommandExec](IMPORTANT): got command ! echo 0 > /dev/loadB1
2023-06-23T18:18:57.193Z,1687544337.193 [CommandExec](IMPORTANT): got command configSet PowerOnly.sampleTime1 1 second
2023-06-23T18:18:57.789Z,1687544337.789 [PowerOnly](INFO): Powering down loadControl
2023-06-23T18:18:58.191Z,1687544338.191 [PowerOnly](FAULT): loadControl LCB fault: LCB Watchdog Reset. Invalid Command. Hardware Overcurrent Shutdown. Current Limiter Activated.
2023-06-23T18:18:58.191Z,1687544338.191 [PowerOnly] Hardware Fault, FailCount= 1
2023-06-23T18:18:58.191Z,1687544338.191 [PowerOnly](ERROR): Hardware Fault
2023-06-23T18:18:58.246Z,1687544338.246 [CBIT](ERROR): Hardware Fault in component: PowerOnly
2023-06-23T18:18:58.587Z,1687544338.587 [PowerOnly](INFO): Powering down loadControl
2023-06-23T18:18:59.414Z,1687544339.414 [CBIT](INFO): Clearing failed state for component PowerOnly
2023-06-23T18:18:59.414Z,1687544339.414 [PowerOnly] No Fault, FailCount= 1
2023-06-23T18:19:01.022Z,1687544341.022 [PowerOnly](INFO): Powering down loadControl
2023-06-23T18:19:12.256Z,1687544352.256 [CommandExec](IMPORTANT): got command configSet PowerOnly.sampleTime1 0 second
2023-06-23T18:19:12.347Z,1687544352.347 [PowerOnly](INFO): Powering up loadControl
2023-06-23T18:20:45.648Z,1687544445.648 [NAL9602](FAULT): GPS failed to acquire within timeout.
2023-06-23T18:20:45.648Z,1687544445.648 [NAL9602] Data Fault, FailCount= 5
2023-06-23T18:20:45.648Z,1687544445.648 [NAL9602](ERROR): Data Fault
2023-06-23T18:20:45.711Z,1687544445.711 [CommandExec](IMPORTANT): got command configSet PowerOnly.sampleTime1 1 second
2023-06-23T18:20:45.728Z,1687544445.728 [CBIT](ERROR): Data Fault in component: NAL9602
2023-06-23T18:20:45.728Z,1687544445.728 [CBIT](CRITICAL): Data Fault in component: NAL9602
2023-06-23T18:20:46.056Z,1687544446.056 [NAL9602](INFO): Powering down
2023-06-23T18:20:46.072Z,1687544446.072 [CommandExec](FAULT): Scheduling is paused
2023-06-23T18:20:46.072Z,1687544446.072 [CBIT](INFO): Critical error at 20230623T182045
2023-06-23T18:20:46.073Z,1687544446.073 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals
2023-06-23T18:20:46.483Z,1687544446.483 [PowerOnly](INFO): Powering down loadControl
2023-06-23T18:21:24.504Z,1687544484.504 [Default:CheckIn:Read_GPS](INFO): Timed out from 2023-06-23T18:16:24.3Z
2023-06-23T18:21:24.504Z,1687544484.504 [Default:CheckIn:Read_GPS] Stopped
2023-06-23T18:21:24.505Z,1687544484.505 [Default:CheckIn:Read_Iridium] Running Loop=1
2023-06-23T18:21:25.607Z,1687544485.607 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 18
2023-06-23T18:21:25.607Z,1687544485.607 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-06-23T18:21:25.643Z,1687544485.643 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-06-23T18:21:25.976Z,1687544485.976 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-06-23T18:21:25.976Z,1687544485.976 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 18
2023-06-23T18:21:32.066Z,1687544492.066 [DataOverHttps](INFO): Sending 105 bytes from file Logs/20230623T172658/Courier0016.lzma
2023-06-23T18:21:33.069Z,1687544493.069 [DataOverHttps](INFO): Moved sent file to Logs/20230623T172658/Courier0016.lzma.bak
2023-06-23T18:21:33.069Z,1687544493.069 [DataOverHttps](INFO): SBD MOMSN=18422805
2023-06-23T18:21:49.079Z,1687544509.079 [DataOverHttps](INFO): Sending 459 bytes from file Logs/20230623T172658/Express0017.lzma
2023-06-23T18:21:50.080Z,1687544510.080 [DataOverHttps](INFO): Moved sent file to Logs/20230623T172658/Express0017.lzma.bak
2023-06-23T18:21:50.080Z,1687544510.080 [DataOverHttps](INFO): SBD MOMSN=18422808
2023-06-23T18:21:51.425Z,1687544511.425 [Default:CheckIn:Read_Iridium] Stopped
2023-06-23T18:21:51.425Z,1687544511.425 [Default:CheckIn:C.Wait] Running Loop=1
2023-06-23T18:21:51.425Z,1687544511.425 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2023-06-23T18:22:45.965Z,1687544565.965 [CBIT](INFO): Clearing failed state for component NAL9602
2023-06-23T18:22:45.965Z,1687544565.965 [NAL9602] No Fault, FailCount= 5
2023-06-23T18:22:46.364Z,1687544566.364 [NAL9602](INFO): Powering up NAL9602
2023-06-23T18:22:57.260Z,1687544577.260 [NAL9602](INFO): NAL9602 initialized
2023-06-23T18:24:26.581Z,1687544666.581 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 19
2023-06-23T18:24:26.581Z,1687544666.581 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-06-23T18:24:26.612Z,1687544666.612 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-06-23T18:24:26.993Z,1687544666.993 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-06-23T18:24:26.993Z,1687544666.993 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 19
2023-06-23T18:26:00.087Z,1687544760.087 [CommandExec](IMPORTANT): got command configSet PowerOnly.sampleTime1 0 second
2023-06-23T18:26:00.282Z,1687544760.282 [PowerOnly](INFO): Powering up loadControl
2023-06-23T18:26:36.666Z,1687544796.666 [RDI_Pathfinder](ERROR): only read 0 of 4 data items
2023-06-23T18:26:51.986Z,1687544811.986 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2023-06-23T18:26:51.986Z,1687544811.986 [Default:CheckIn:C.Wait] Stopped
2023-06-23T18:26:51.987Z,1687544811.987 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2023-06-23T18:26:51.987Z,1687544811.987 [Default:CheckIn:D] Running Loop=1
2023-06-23T18:26:52.401Z,1687544812.401 [Default:CheckIn:D] Stopped
2023-06-23T18:26:52.401Z,1687544812.401 [Default:CheckIn:E] Running Loop=1
2023-06-23T18:26:52.829Z,1687544812.829 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 56.041683 min 
2023-06-23T18:26:52.829Z,1687544812.829 [Default:CheckIn:E] Stopped
2023-06-23T18:26:52.829Z,1687544812.829 [Default:CheckIn](INFO): Completed Default:CheckIn
2023-06-23T18:26:52.829Z,1687544812.829 [Default:CheckIn] Stopped
2023-06-23T18:26:52.829Z,1687544812.829 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2023-06-23T18:26:52.829Z,1687544812.829 [Default:CheckIn](INFO): Running loop #6
2023-06-23T18:26:52.830Z,1687544812.830 [Default:CheckIn] Running Loop=6
2023-06-23T18:26:52.830Z,1687544812.830 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2023-06-23T18:26:52.830Z,1687544812.830 [Default:CheckIn:Read_GPS] Running Loop=1
2023-06-23T18:27:00.518Z,1687544820.518 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for water mass range.
2023-06-23T18:27:27.543Z,1687544847.543 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 20
2023-06-23T18:27:27.544Z,1687544847.544 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-06-23T18:27:27.554Z,1687544847.554 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-06-23T18:27:27.992Z,1687544847.992 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-06-23T18:27:27.992Z,1687544847.992 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 20
2023-06-23T18:27:35.072Z,1687544855.072 [CommandExec](IMPORTANT): got command restart application
2023-06-23T18:27:36.075Z,1687544856.075 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread.
2023-06-23T18:27:36.075Z,1687544856.075 [CommandExec](INFO): Uninitializing the command executive.
2023-06-23T18:27:36.075Z,1687544856.075 [CommandExec](INFO): Uninitializing the command scheduler.
2023-06-23T18:27:36.075Z,1687544856.075 [CommandExec ThreadHandler](INFO): Thread cancelled.
2023-06-23T18:27:36.139Z,1687544856.139 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup.  Bye!
2023-06-23T18:27:36.139Z,1687544856.139 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2023-06-23T18:27:36.139Z,1687544856.139 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2023-06-23T18:27:36.140Z,1687544856.140 [NavChartDb](INFO): Join timeout helper Thread ID is 8844
2023-06-23T18:27:36.271Z,1687544856.271 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2023-06-23T18:27:36.271Z,1687544856.271 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2023-06-23T18:27:36.286Z,1687544856.286 [ComponentRegistry](INFO): Shutting down WetLabsUBAT ThreadHandler
2023-06-23T18:27:36.286Z,1687544856.286 [WetLabsUBAT ThreadHandler](INFO): Thread cancelled.
2023-06-23T18:27:36.287Z,1687544856.287 [WetLabsUBAT](INFO): Join timeout helper Thread ID is 8845
2023-06-23T18:27:36.523Z,1687544856.523 [WetLabsUBAT ThreadHandler](INFO): Uninitializing protected caller thread.
2023-06-23T18:27:36.523Z,1687544856.523 [WetLabsUBAT](INFO): Powering down
2023-06-23T18:27:36.524Z,1687544856.524 [WetLabsUBAT ThreadHandler](INFO): Thread cancelled.
2023-06-23T18:27:36.526Z,1687544856.526 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2023-06-23T18:27:36.529Z,1687544856.529 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2023-06-23T18:27:36.530Z,1687544856.530 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 8846
2023-06-23T18:27:36.643Z,1687544856.643 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread.
2023-06-23T18:27:36.643Z,1687544856.643 [WetLabsBB2FL](INFO): Powering down
2023-06-23T18:27:36.644Z,1687544856.644 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2023-06-23T18:27:36.654Z,1687544856.654 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler
2023-06-23T18:27:36.654Z,1687544856.654 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2023-06-23T18:27:36.655Z,1687544856.655 [CTD_Seabird](INFO): Join timeout helper Thread ID is 8847
2023-06-23T18:27:37.523Z,1687544857.523 [CTD_Seabird](INFO): Powering down
2023-06-23T18:27:37.534Z,1687544857.534 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread.
2023-06-23T18:27:37.535Z,1687544857.535 [CTD_Seabird](INFO): Powering down
2023-06-23T18:27:37.546Z,1687544857.546 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2023-06-23T18:27:37.547Z,1687544857.547 [ComponentRegistry](INFO): Shutting down DAT ThreadHandler
2023-06-23T18:27:37.547Z,1687544857.547 [DAT ThreadHandler](INFO): Thread cancelled.
2023-06-23T18:27:37.547Z,1687544857.547 [DAT](INFO): Join timeout helper Thread ID is 8848
2023-06-23T18:27:37.643Z,1687544857.643 [DAT](INFO): Powering down
2023-06-23T18:27:37.715Z,1687544857.715 [DAT ThreadHandler](INFO): Uninitializing protected caller thread.
2023-06-23T18:27:37.715Z,1687544857.715 [DAT](INFO): Powering down
2023-06-23T18:27:37.716Z,1687544857.716 [DAT ThreadHandler](INFO): Thread cancelled.
2023-06-23T18:27:37.727Z,1687544857.727 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2023-06-23T18:27:37.727Z,1687544857.727 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2023-06-23T18:27:37.728Z,1687544857.728 [Radio_Surface](INFO): Join timeout helper Thread ID is 8849
2023-06-23T18:27:37.878Z,1687544857.878 [Radio_Surface](INFO): Powering down
2023-06-23T18:27:37.879Z,1687544857.879 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2023-06-23T18:27:37.880Z,1687544857.880 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2023-06-23T18:27:37.887Z,1687544857.887 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler
2023-06-23T18:27:37.887Z,1687544857.887 [Onboard ThreadHandler](INFO): Thread cancelled.
2023-06-23T18:27:37.888Z,1687544857.888 [Onboard](INFO): Join timeout helper Thread ID is 8850
2023-06-23T18:27:38.479Z,1687544858.479 [DataOverHttps](INFO): Radio surface powered OFF, will not connect.
2023-06-23T18:27:41.475Z,1687544861.475 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread.
2023-06-23T18:27:41.475Z,1687544861.475 [Onboard ThreadHandler](INFO): Thread cancelled.
2023-06-23T18:27:41.487Z,1687544861.487 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler
2023-06-23T18:27:41.487Z,1687544861.487 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2023-06-23T18:27:41.488Z,1687544861.488 [DataOverHttps](INFO): Join timeout helper Thread ID is 8851
2023-06-23T18:27:41.491Z,1687544861.491 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread.
2023-06-23T18:27:41.491Z,1687544861.491 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2023-06-23T18:27:41.515Z,1687544861.515 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler
2023-06-23T18:27:41.515Z,1687544861.515 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2023-06-23T18:27:41.516Z,1687544861.516 [BackseatComponent](INFO): Join timeout helper Thread ID is 8852
2023-06-23T18:27:41.600Z,1687544861.600 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread.
2023-06-23T18:27:41.600Z,1687544861.600 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2023-06-23T18:27:41.603Z,1687544861.603 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2023-06-23T18:27:41.603Z,1687544861.603 [logger ThreadHandler](INFO): Thread cancelled.
2023-06-23T18:27:41.604Z,1687544861.604 [logger](INFO): Join timeout helper Thread ID is 8853
2023-06-23T18:27:41.607Z,1687544861.607 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2023-06-23T18:27:41.607Z,1687544861.607 [logger ThreadHandler](INFO): Thread cancelled.
2023-06-23T18:27:41.623Z,1687544861.623 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2023-06-23T18:27:41.623Z,1687544861.623 [CommandLine ThreadHandler](INFO): Thread cancelled.
2023-06-23T18:27:41.624Z,1687544861.624 [CommandLine](INFO): Join timeout helper Thread ID is 8854
2023-06-23T18:27:41.647Z,1687544861.647 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2023-06-23T18:27:41.647Z,1687544861.647 [CommandLine ThreadHandler](INFO): Thread cancelled.
2023-06-23T18:27:41.675Z,1687544861.675 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler
2023-06-23T18:27:41.675Z,1687544861.675 [CommandExec ThreadHandler](INFO): Thread cancelled.
2023-06-23T18:27:41.676Z,1687544861.676 [CommandExec](INFO): Join timeout helper Thread ID is 8855
2023-06-23T18:27:41.680Z,1687544861.680 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2023-06-23T18:27:41.680Z,1687544861.680 [controlThread ThreadHandler](INFO): Thread cancelled.
2023-06-23T18:27:41.680Z,1687544861.680 [controlThread](INFO): Join timeout helper Thread ID is 8856
2023-06-23T18:27:41.699Z,1687544861.699 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2023-06-23T18:27:41.700Z,1687544861.700 [controlThread](DEBUG): Uninitializing ControlThread
2023-06-23T18:27:41.700Z,1687544861.700 [AHRS_M2](INFO): Powering down
2023-06-23T18:27:41.771Z,1687544861.771 [NAL9602](INFO): Powering down
2023-06-23T18:27:41.843Z,1687544861.843 [RDI_Pathfinder](INFO): Powering down
2023-06-23T18:27:41.844Z,1687544861.844 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2023-06-23T18:27:41.845Z,1687544861.845 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2023-06-23T18:27:41.845Z,1687544861.845 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2023-06-23T18:27:41.846Z,1687544861.846 [MissionManager](INFO): Uninitializing Mission Default
2023-06-23T18:27:41.846Z,1687544861.846 [Default] Stopped
2023-06-23T18:27:41.846Z,1687544861.846 [Default](DEBUG): Aggregate::uninitialize Default
2023-06-23T18:27:41.846Z,1687544861.846 [Default:B.GoToSurface] Stopped
2023-06-23T18:27:41.846Z,1687544861.846 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2023-06-23T18:27:41.846Z,1687544861.846 [Default:CheckIn] Stopped
2023-06-23T18:27:41.846Z,1687544861.846 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2023-06-23T18:27:41.846Z,1687544861.846 [Default:CheckIn:Read_GPS] Stopped
2023-06-23T18:27:41.849Z,1687544861.849 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2023-06-23T18:27:41.849Z,1687544861.849 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2023-06-23T18:27:41.850Z,1687544861.850 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2023-06-23T18:27:41.850Z,1687544861.850 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2023-06-23T18:27:41.850Z,1687544861.850 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2023-06-23T18:27:41.851Z,1687544861.851 [BuoyancyServo](INFO): Powering down
2023-06-23T18:27:41.863Z,1687544861.863 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2023-06-23T18:27:41.863Z,1687544861.863 [ElevatorServo](INFO): Powering down
2023-06-23T18:27:41.864Z,1687544861.864 [MassServo](DEBUG): Uninitialize Mass Servo.
2023-06-23T18:27:41.864Z,1687544861.864 [MassServo](INFO): Powering down
2023-06-23T18:27:41.865Z,1687544861.865 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2023-06-23T18:27:41.865Z,1687544861.865 [RudderServo](INFO): Powering down
2023-06-23T18:27:41.865Z,1687544861.865 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2023-06-23T18:27:41.866Z,1687544861.866 [ThrusterServo](INFO): Powering down
2023-06-23T18:27:41.867Z,1687544861.867 [SBIT](DEBUG): Uninitialize SBIT Component.
2023-06-23T18:27:41.867Z,1687544861.867 [IBIT](DEBUG): Uninitialize IBIT Component.
2023-06-23T18:27:41.867Z,1687544861.867 [CBIT](DEBUG): Uninitialize CBIT Component.
2023-06-23T18:27:41.867Z,1687544861.867 [CBIT](DEBUG): Powering off loads.
2023-06-23T18:27:41.878Z,1687544861.878 [CBIT](DEBUG): Disabling WDT.
2023-06-23T18:27:41.890Z,1687544861.890 [CBIT](DEBUG): Opening all GF detection circuits.
2023-06-23T18:27:41.891Z,1687544861.891 [controlThread ThreadHandler](INFO): Thread cancelled.
2023-06-23T18:27:41.949Z,1687544861.949 [DAT ThreadHandler](INFO): Thread cancelled.
2023-06-23T18:27:41.956Z,1687544861.956 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2023-06-23T18:27:41.959Z,1687544861.959 [Onboard ThreadHandler](INFO): Thread cancelled.
2023-06-23T18:27:41.965Z,1687544861.965 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2023-06-23T18:27:42.008Z,1687544862.008 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2023-06-23T18:27:42.068Z,1687544862.068 [WetLabsUBAT ThreadHandler](INFO): Thread cancelled.
2023-06-23T18:27:42.070Z,1687544862.070 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2023-06-23T18:27:42.073Z,1687544862.073 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2023-06-23T18:27:42.081Z,1687544862.081 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2023-06-23T18:27:42.144Z,1687544862.144 [logger ThreadHandler](INFO): Thread cancelled.