2023-07-24T22:45:18.841Z,1690238718.841 [Supervisor](DEBUG): Initializing supervisor.
2023-07-24T22:45:18.846Z,1690238718.846 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2023-07-24T22:45:18.846Z,1690238718.846 [SyncHandler](INFO): Protected caller Thread ID is 2071
2023-07-24T22:45:18.847Z,1690238718.847 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2023-07-24T22:45:18.848Z,1690238718.848 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2023-07-24T22:45:18.848Z,1690238718.848 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 2072
2023-07-24T22:45:18.853Z,1690238718.853 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2023-07-24T22:45:18.870Z,1690238718.870 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread.
2023-07-24T22:45:18.871Z,1690238718.871 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2023-07-24T22:45:18.871Z,1690238718.871 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 2073
2023-07-24T22:45:18.875Z,1690238718.875 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2023-07-24T22:45:18.876Z,1690238718.876 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2023-07-24T22:45:18.876Z,1690238718.876 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 2074
2023-07-24T22:45:18.878Z,1690238718.878 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2023-07-24T22:45:18.879Z,1690238718.879 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0
2023-07-24T22:45:18.880Z,1690238718.880 [logger ThreadHandler](INFO): Protected caller Thread ID is 2075
2023-07-24T22:45:18.883Z,1690238718.883 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2023-07-24T22:45:18.884Z,1690238718.884 [Supervisor](INFO): Looking for Config files in directory: Config/
2023-07-24T22:45:18.885Z,1690238718.885 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2023-07-24T22:45:19.096Z,1690238719.096 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2023-07-24T22:45:19.097Z,1690238719.097 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2023-07-24T22:45:19.204Z,1690238719.204 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2023-07-24T22:45:19.204Z,1690238719.204 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2023-07-24T22:45:19.301Z,1690238719.301 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2023-07-24T22:45:19.302Z,1690238719.302 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2023-07-24T22:45:19.755Z,1690238719.755 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2023-07-24T22:45:19.756Z,1690238719.756 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2023-07-24T22:45:20.089Z,1690238720.089 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2023-07-24T22:45:20.089Z,1690238720.089 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2023-07-24T22:45:20.405Z,1690238720.405 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2023-07-24T22:45:20.406Z,1690238720.406 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2023-07-24T22:45:20.586Z,1690238720.586 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2023-07-24T22:45:20.587Z,1690238720.587 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2023-07-24T22:45:20.668Z,1690238720.668 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2023-07-24T22:45:20.751Z,1690238720.751 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2023-07-24T22:45:21.133Z,1690238721.133 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2023-07-24T22:45:21.134Z,1690238721.134 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2023-07-24T22:45:21.751Z,1690238721.751 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2023-07-24T22:45:21.751Z,1690238721.751 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2023-07-24T22:45:22.249Z,1690238722.249 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2023-07-24T22:45:22.250Z,1690238722.250 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2023-07-24T22:45:22.463Z,1690238722.463 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2023-07-24T22:45:22.464Z,1690238722.464 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg
2023-07-24T22:45:22.691Z,1690238722.691 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock
2023-07-24T22:45:22.691Z,1690238722.691 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2023-07-24T22:45:22.828Z,1690238722.828 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2023-07-24T22:45:22.829Z,1690238722.829 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2023-07-24T22:45:23.608Z,1690238723.608 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2023-07-24T22:45:23.610Z,1690238723.610 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-galene/
2023-07-24T22:45:23.611Z,1690238723.611 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/secure.cfg
2023-07-24T22:45:23.699Z,1690238723.699 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/vehicle.cfg
2023-07-24T22:45:23.830Z,1690238723.830 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Battery.cfg
2023-07-24T22:45:24.096Z,1690238724.096 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2023-07-24T22:45:24.096Z,1690238724.096 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Science.cfg
2023-07-24T22:45:24.220Z,1690238724.220 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Control.cfg
2023-07-24T22:45:24.323Z,1690238724.323 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/logger.cfg
2023-07-24T22:45:24.418Z,1690238724.418 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Servo.cfg
2023-07-24T22:45:24.528Z,1690238724.528 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Navigation.cfg
2023-07-24T22:45:24.625Z,1690238724.625 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Simulator.cfg
2023-07-24T22:45:24.713Z,1690238724.713 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/BIT.cfg
2023-07-24T22:45:24.815Z,1690238724.815 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Sensor.cfg
2023-07-24T22:45:24.976Z,1690238724.976 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg
2023-07-24T22:45:24.997Z,1690238724.997 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2023-07-24T22:45:25.045Z,1690238725.045 [DepthRateCalculator] Loaded
2023-07-24T22:45:25.045Z,1690238725.045 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2023-07-24T22:45:25.051Z,1690238725.051 [PitchRateCalculator] Loaded
2023-07-24T22:45:25.051Z,1690238725.051 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2023-07-24T22:45:25.061Z,1690238725.061 [SpeedCalculator] Loaded
2023-07-24T22:45:25.061Z,1690238725.061 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2023-07-24T22:45:25.066Z,1690238725.066 [YawRateCalculator] Loaded
2023-07-24T22:45:25.066Z,1690238725.066 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2023-07-24T22:45:25.087Z,1690238725.087 [ElevatorOffsetCalculator] Loaded
2023-07-24T22:45:25.087Z,1690238725.087 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2023-07-24T22:45:25.088Z,1690238725.088 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2023-07-24T22:45:25.088Z,1690238725.088 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2023-07-24T22:45:25.115Z,1690238725.115 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2023-07-24T22:45:25.115Z,1690238725.115 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2023-07-24T22:45:25.125Z,1690238725.125 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2023-07-24T22:45:25.125Z,1690238725.125 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2023-07-24T22:45:25.537Z,1690238725.537 [BackseatComponent] Loaded
2023-07-24T22:45:25.537Z,1690238725.537 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread.
2023-07-24T22:45:25.538Z,1690238725.538 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 4084C4E0
2023-07-24T22:45:25.539Z,1690238725.539 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 2157
2023-07-24T22:45:25.541Z,1690238725.541 [LcmUniversalReporter] Loaded
2023-07-24T22:45:25.542Z,1690238725.542 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread.
2023-07-24T22:45:26.328Z,1690238726.328 [BPC1] Loaded
2023-07-24T22:45:26.329Z,1690238726.329 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2023-07-24T22:45:26.400Z,1690238726.400 [DataOverHttps] Loaded
2023-07-24T22:45:26.401Z,1690238726.401 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2023-07-24T22:45:26.402Z,1690238726.402 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 4087C4E0
2023-07-24T22:45:26.402Z,1690238726.402 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 2158
2023-07-24T22:45:26.423Z,1690238726.423 [Depth_Keller] Loaded
2023-07-24T22:45:26.423Z,1690238726.423 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2023-07-24T22:45:26.484Z,1690238726.484 [NAL9602] Loaded
2023-07-24T22:45:26.485Z,1690238726.485 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2023-07-24T22:45:26.513Z,1690238726.513 [Onboard] Loaded
2023-07-24T22:45:26.513Z,1690238726.513 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread.
2023-07-24T22:45:26.514Z,1690238726.514 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 408AC4E0
2023-07-24T22:45:26.515Z,1690238726.515 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 2159
2023-07-24T22:45:26.521Z,1690238726.521 [PowerOnly](INFO): Adding load control power supply at /dev/loadC3
2023-07-24T22:45:26.531Z,1690238726.531 [PowerOnly] Loaded
2023-07-24T22:45:26.532Z,1690238726.532 [ComponentRegistry](DEBUG): SyncComponent "PowerOnly" handled in the control thread.
2023-07-24T22:45:26.543Z,1690238726.543 [Power24vConverter] Loaded
2023-07-24T22:45:26.543Z,1690238726.543 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread.
2023-07-24T22:45:26.557Z,1690238726.557 [Radio_Surface] Loaded
2023-07-24T22:45:26.557Z,1690238726.557 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2023-07-24T22:45:26.558Z,1690238726.558 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 408DC4E0
2023-07-24T22:45:26.559Z,1690238726.559 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 2160
2023-07-24T22:45:26.560Z,1690238726.560 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2023-07-24T22:45:26.560Z,1690238726.560 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2023-07-24T22:45:26.668Z,1690238726.668 [DeadReckonUsingMultipleVelocitySources] Loaded
2023-07-24T22:45:26.668Z,1690238726.668 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2023-07-24T22:45:26.708Z,1690238726.708 [DeadReckonUsingSpeedCalculator] Loaded
2023-07-24T22:45:26.709Z,1690238726.709 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread.
2023-07-24T22:45:26.722Z,1690238726.722 [NavChart] Loaded
2023-07-24T22:45:26.722Z,1690238726.722 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2023-07-24T22:45:26.727Z,1690238726.727 [UniversalFixResidualReporter] Loaded
2023-07-24T22:45:26.728Z,1690238726.728 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2023-07-24T22:45:26.728Z,1690238726.728 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2023-07-24T22:45:26.729Z,1690238726.729 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2023-07-24T22:45:27.187Z,1690238727.187 [SBIT](DEBUG): Construct Startup Built In Test.
2023-07-24T22:45:27.212Z,1690238727.212 [SBIT] Loaded
2023-07-24T22:45:27.212Z,1690238727.212 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2023-07-24T22:45:27.246Z,1690238727.246 [IBIT](DEBUG): Construct Initiated Built In Test.
2023-07-24T22:45:27.267Z,1690238727.267 [IBIT] Loaded
2023-07-24T22:45:27.267Z,1690238727.267 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2023-07-24T22:45:27.324Z,1690238727.324 [CBIT](DEBUG): Construct Continuous Built In Test.
2023-07-24T22:45:27.459Z,1690238727.459 [CBIT] Loaded
2023-07-24T22:45:27.460Z,1690238727.460 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2023-07-24T22:45:27.460Z,1690238727.460 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2023-07-24T22:45:27.461Z,1690238727.461 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2023-07-24T22:45:27.663Z,1690238727.663 [PAR_Licor] Loaded
2023-07-24T22:45:27.663Z,1690238727.663 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2023-07-24T22:45:27.702Z,1690238727.702 [WetLabsBB2FL] Loaded
2023-07-24T22:45:27.703Z,1690238727.703 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2023-07-24T22:45:27.704Z,1690238727.704 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 409E14E0
2023-07-24T22:45:27.704Z,1690238727.704 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 2161
2023-07-24T22:45:27.705Z,1690238727.705 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2023-07-24T22:45:27.705Z,1690238727.705 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2023-07-24T22:45:27.830Z,1690238727.830 [BuoyancyServo] Loaded
2023-07-24T22:45:27.831Z,1690238727.831 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2023-07-24T22:45:27.851Z,1690238727.851 [ElevatorServo] Loaded
2023-07-24T22:45:27.852Z,1690238727.852 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2023-07-24T22:45:27.872Z,1690238727.872 [MassServo] Loaded
2023-07-24T22:45:27.872Z,1690238727.872 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2023-07-24T22:45:27.892Z,1690238727.892 [RudderServo] Loaded
2023-07-24T22:45:27.892Z,1690238727.892 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2023-07-24T22:45:27.908Z,1690238727.908 [ThrusterHE] Loaded
2023-07-24T22:45:27.908Z,1690238727.908 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread.
2023-07-24T22:45:27.908Z,1690238727.908 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2023-07-24T22:45:27.909Z,1690238727.909 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2023-07-24T22:45:27.957Z,1690238727.957 [VerticalControl](DEBUG): Construct VerticalControl.
2023-07-24T22:45:28.007Z,1690238728.007 [VerticalControl] Loaded
2023-07-24T22:45:28.007Z,1690238728.007 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2023-07-24T22:45:28.010Z,1690238728.010 [HorizontalControl](DEBUG): Construct HorizontalControl.
2023-07-24T22:45:28.046Z,1690238728.046 [HorizontalControl] Loaded
2023-07-24T22:45:28.047Z,1690238728.047 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2023-07-24T22:45:28.049Z,1690238728.049 [SpeedControl](DEBUG): Construct SpeedControl.
2023-07-24T22:45:28.051Z,1690238728.051 [SpeedControl] Loaded
2023-07-24T22:45:28.051Z,1690238728.051 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2023-07-24T22:45:28.054Z,1690238728.054 [LoopControl](DEBUG): Construct LoopControl.
2023-07-24T22:45:28.054Z,1690238728.054 [LoopControl] Loaded
2023-07-24T22:45:28.054Z,1690238728.054 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2023-07-24T22:45:28.055Z,1690238728.055 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2023-07-24T22:45:28.055Z,1690238728.055 [Module Loader](DEBUG): Loading Module at Modules/Dock.so
2023-07-24T22:45:28.150Z,1690238728.150 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking)
2023-07-24T22:45:28.150Z,1690238728.150 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2023-07-24T22:45:28.290Z,1690238728.290 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2023-07-24T22:45:28.290Z,1690238728.290 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2023-07-24T22:45:28.578Z,1690238728.578 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2023-07-24T22:45:28.579Z,1690238728.579 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2023-07-24T22:45:28.648Z,1690238728.648 [StratificationFrontDetector](INFO): thresholdVTHI set to: 0.399988 degC
2023-07-24T22:45:28.648Z,1690238728.648 [StratificationFrontDetector](DEBUG): (re)initializing
2023-07-24T22:45:28.648Z,1690238728.648 [StratificationFrontDetector] Loaded
2023-07-24T22:45:28.648Z,1690238728.648 [ComponentRegistry](DEBUG): SyncComponent "StratificationFrontDetector" handled in the control thread.
2023-07-24T22:45:28.649Z,1690238728.649 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2023-07-24T22:45:28.655Z,1690238728.655 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2023-07-24T22:45:28.658Z,1690238728.658 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2023-07-24T22:45:28.669Z,1690238728.669 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2023-07-24T22:45:28.670Z,1690238728.670 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40B954E0
2023-07-24T22:45:28.670Z,1690238728.670 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 2162
2023-07-24T22:45:28.675Z,1690238728.675 [Supervisor](INFO): Main Thread ID is 1806
2023-07-24T22:45:28.675Z,1690238728.675 [Supervisor](DEBUG): Running supervisor.
2023-07-24T22:45:28.675Z,1690238728.675 [CommandExec ThreadHandler](INFO): Handler Thread ID is 2163
2023-07-24T22:45:28.676Z,1690238728.676 [CommandExec](INFO): Initializing the command executive.
2023-07-24T22:45:28.677Z,1690238728.677 [CommandLine ThreadHandler](INFO): Handler Thread ID is 2164
2023-07-24T22:45:28.680Z,1690238728.680 [controlThread ThreadHandler](INFO): Handler Thread ID is 2165
2023-07-24T22:45:28.680Z,1690238728.680 [controlThread](DEBUG): Initializing ControlThread
2023-07-24T22:45:28.681Z,1690238728.681 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2023-07-24T22:45:28.681Z,1690238728.681 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2023-07-24T22:45:28.682Z,1690238728.682 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2023-07-24T22:45:28.682Z,1690238728.682 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2023-07-24T22:45:28.682Z,1690238728.682 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2023-07-24T22:45:28.688Z,1690238728.688 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2023-07-24T22:45:28.688Z,1690238728.688 [NavChart](DEBUG): Initialize NavChart Navigation.
2023-07-24T22:45:28.688Z,1690238728.688 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2023-07-24T22:45:28.689Z,1690238728.689 [SBIT](INFO): Initialize SBIT Component.
2023-07-24T22:45:28.689Z,1690238728.689 [SBIT](IMPORTANT): git: 2023-07-12-1-g0ce2d268e
2023-07-24T22:45:28.689Z,1690238728.689 [SBIT](INFO): git hash: 0ce2d268e1d2339405b049ee60cd4c78b5e142ba
2023-07-24T22:45:28.690Z,1690238728.690 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2023-07-24T22:45:28.691Z,1690238728.691 [SBIT](INFO): Kernel Reporting Different Version From Configuration.
Kernel Expected: #2 PREEMPT Thu Jan 11 20:13:48 PST 2018
Kernel Reported: #1 PREEMPT Wed Mar 17 08:23:48 PDT 2021
2023-07-24T22:45:28.692Z,1690238728.692 [SBIT](INFO): Beginning SBIT in 76.000000 seconds.
2023-07-24T22:45:28.692Z,1690238728.692 [IBIT](INFO): Initialize IBIT Component.
2023-07-24T22:45:28.693Z,1690238728.693 [CBIT](DEBUG): Initialize CBIT Component.
2023-07-24T22:45:28.694Z,1690238728.694 [logger ThreadHandler](INFO): Handler Thread ID is 2166
2023-07-24T22:45:28.706Z,1690238728.706 [CBIT](DEBUG): Initialized mux pins.
2023-07-24T22:45:28.706Z,1690238728.706 [CBIT](DEBUG): Initializing the watchdog timer.
2023-07-24T22:45:28.715Z,1690238728.715 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 2167
2023-07-24T22:45:28.727Z,1690238728.727 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 2168
2023-07-24T22:45:28.728Z,1690238728.728 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2023-07-24T22:45:28.730Z,1690238728.730 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2023-07-24T22:45:28.731Z,1690238728.731 [CBIT](DEBUG): Initializing heartbeat.
2023-07-24T22:45:28.739Z,1690238728.739 [Onboard ThreadHandler](INFO): Handler Thread ID is 2169
2023-07-24T22:45:28.756Z,1690238728.756 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 2170
2023-07-24T22:45:28.779Z,1690238728.779 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 2171
2023-07-24T22:45:28.783Z,1690238728.783 [WetLabsBB2FL](INFO): Powering up
2023-07-24T22:45:28.784Z,1690238728.784 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 2173
2023-07-24T22:45:28.787Z,1690238728.787 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2023-07-24T22:45:28.787Z,1690238728.787 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2023-07-24T22:45:28.787Z,1690238728.787 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2023-07-24T22:45:28.787Z,1690238728.787 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2023-07-24T22:45:28.788Z,1690238728.788 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2023-07-24T22:45:28.788Z,1690238728.788 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2023-07-24T22:45:28.788Z,1690238728.788 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2023-07-24T22:45:28.788Z,1690238728.788 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2023-07-24T22:45:28.802Z,1690238728.802 [CBIT](DEBUG): Deactivating GF circuits.
2023-07-24T22:45:28.802Z,1690238728.802 [CBIT](DEBUG): Deactivating emergency mode.
2023-07-24T22:45:28.842Z,1690238728.842 [CBIT](DEBUG): Backplane powered.
2023-07-24T22:45:28.848Z,1690238728.848 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2023-07-24T22:45:28.849Z,1690238728.849 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2023-07-24T22:45:28.850Z,1690238728.850 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2023-07-24T22:45:28.851Z,1690238728.851 [LoopControl](DEBUG): Initialize LoopControlComponent.
2023-07-24T22:45:28.852Z,1690238728.852 [MissionManager](INFO): Loading Mission from file: Missions/Startup.xml
2023-07-24T22:45:28.865Z,1690238728.865 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2023-07-24T22:45:28.902Z,1690238728.902 [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-07-24T22:45:28.903Z,1690238728.903 [MissionManager](INFO): Loading Mission from file: Missions/Default.xml
2023-07-24T22:45:28.952Z,1690238728.952 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2023-07-24T22:45:28.953Z,1690238728.953 [Default:A.Wait](DEBUG): Construct Wait.
2023-07-24T22:45:28.982Z,1690238728.982 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2023-07-24T22:45:28.000Z,1690238729.000 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2023-07-24T22:45:29.023Z,1690238729.023 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2023-07-24T22:45:29.032Z,1690238729.032 [Default:E.Execute](DEBUG): Construct Execute.
2023-07-24T22:45:29.042Z,1690238729.042 [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-07-24T22:45:29.047Z,1690238729.047 [controlThread](DEBUG): Component order: CycleStarter,BPC1,Depth_Keller,NAL9602,PowerOnly,Power24vConverter,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,StratificationFrontDetector,DeadReckonUsingMultipleVelocitySources,DeadReckonUsingSpeedCalculator,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter,
2023-07-24T22:45:29.099Z,1690238729.099 [Depth_Keller](ERROR): Pressure or depth reading out of range: 1629.131348 decibar, 0.000000 m
2023-07-24T22:45:29.101Z,1690238729.101 [Power24vConverter](INFO): Powering up.
2023-07-24T22:45:29.108Z,1690238729.108 [DepthRateCalculator](ERROR): Depth measurement is not active
2023-07-24T22:45:29.133Z,1690238729.133 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2023-07-24T22:45:29.139Z,1690238729.139 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2023-07-24T22:45:29.139Z,1690238729.139 [ElevatorServo](DEBUG): Initializing EZServoServo.
2023-07-24T22:45:29.147Z,1690238729.147 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2023-07-24T22:45:29.147Z,1690238729.147 [MassServo](DEBUG): Initializing EZServoServo.
2023-07-24T22:45:29.155Z,1690238729.155 [MassServo](DEBUG): Initializing MassServo.
2023-07-24T22:45:29.155Z,1690238729.155 [RudderServo](DEBUG): Initializing EZServoServo.
2023-07-24T22:45:29.162Z,1690238729.162 [Radio_Surface](INFO): Powering up
2023-07-24T22:45:29.163Z,1690238729.163 [RudderServo](DEBUG): Initializing RudderServo.
2023-07-24T22:45:29.164Z,1690238729.164 [ThrusterHE](DEBUG): Initializing EZServoServo.
2023-07-24T22:45:29.171Z,1690238729.171 [ThrusterHE](DEBUG): Initializing ThrusterHE.
2023-07-24T22:45:31.394Z,1690238731.394 [WetLabsBB2FL](INFO): Powering down
2023-07-24T22:45:34.891Z,1690238734.891 [ThrusterHE](ERROR): Zero Speed Commanded.
2023-07-24T22:45:56.532Z,1690238756.532 [NAL9602](INFO): Powering up NAL9602
2023-07-24T22:46:07.440Z,1690238767.440 [NAL9602](INFO): NAL9602 initialized
2023-07-24T22:46:45.439Z,1690238805.439 [SBIT](IMPORTANT): Beginning Startup BIT
2023-07-24T22:46:45.443Z,1690238805.443 [CBIT](IMPORTANT): Beginning ground fault scan
2023-07-24T22:46:56.379Z,1690238816.379 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): 0.020408
CHAN A1 (24V): 0.001313
CHAN A2 (12V): -0.005550
CHAN A3 (5V): -0.002873
CHAN B0 (3.3V): -0.000955
CHAN B1 (3.15aV): -0.001662
CHAN B2 (3.15bV): -0.002096
CHAN B3 (GND): -0.000463
OPEN: 0.004055
Full Scale: +/- 1 mA
2023-07-24T22:47:28.725Z,1690238848.725 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2023-07-24T22:47:28.725Z,1690238848.725 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2023-07-24T22:47:28.725Z,1690238848.725 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-07-24T22:47:28.727Z,1690238848.727 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2023-07-24T22:47:28.727Z,1690238848.727 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 1
2023-07-24T22:47:28.728Z,1690238848.728 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2023-07-24T22:47:28.831Z,1690238848.831 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-07-24T22:47:28.832Z,1690238848.832 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2023-07-24T22:47:29.219Z,1690238849.219 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-07-24T22:47:29.219Z,1690238849.219 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2023-07-24T22:47:29.220Z,1690238849.220 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2023-07-24T22:47:29.220Z,1690238849.220 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 1
2023-07-24T22:47:29.504Z,1690238849.504 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2023-07-24T22:47:39.575Z,1690238859.575 [SBIT](IMPORTANT): SBIT PASSED
2023-07-24T22:47:39.575Z,1690238859.575 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2023-07-24T22:47:39.576Z,1690238859.576 [SBIT](IMPORTANT): AHRS_M2.loadAtStartup=0 bool;

2023-07-24T22:47:39.576Z,1690238859.576 [SBIT](IMPORTANT): CBIT.gfScanTimeout=1 hour;

2023-07-24T22:47:39.576Z,1690238859.576 [SBIT](IMPORTANT): CBIT.runNavErrorCritical=0 bool;

2023-07-24T22:47:39.576Z,1690238859.576 [SBIT](IMPORTANT): CTD_Seabird.loadAtStartup=0 bool;

2023-07-24T22:47:39.576Z,1690238859.576 [SBIT](IMPORTANT): DAT.loadAtStartup=0 bool;

2023-07-24T22:47:39.576Z,1690238859.576 [SBIT](IMPORTANT): DropWeight.loadAtStartup=0 bool;

2023-07-24T22:47:39.577Z,1690238859.577 [SBIT](IMPORTANT): ESPComponent.sampleTimeout=2 minute;

2023-07-24T22:47:39.577Z,1690238859.577 [SBIT](IMPORTANT): Express none CTD_Seabird.bin_median_sea_water_salinity;

2023-07-24T22:47:39.577Z,1690238859.577 [SBIT](IMPORTANT): Express none CTD_Seabird.bin_median_sea_water_temperature;

2023-07-24T22:47:39.577Z,1690238859.577 [SBIT](IMPORTANT): Express none WetLabsBB2FL.bin_mean_mass_concentration_of_chlorophyll_in_sea_water;

2023-07-24T22:47:39.577Z,1690238859.577 [SBIT](IMPORTANT): Express none WetLabsBB2FL.bin_median_mass_concentration_of_chlorophyll_in_sea_water;

2023-07-24T22:47:39.577Z,1690238859.577 [SBIT](IMPORTANT): Express linearApproximation _.ayeris_disk_space 100.000000 gigabyte;

2023-07-24T22:47:39.577Z,1690238859.577 [SBIT](IMPORTANT): Express linearApproximation _.ayeris_particle_counts 300.000000 count_per_second;

2023-07-24T22:47:39.577Z,1690238859.577 [SBIT](IMPORTANT): Express none _.ayeris_particle_shape;

2023-07-24T22:47:39.578Z,1690238859.578 [SBIT](IMPORTANT): Express none _.ayeris_particle_slope;

2023-07-24T22:47:39.578Z,1690238859.578 [SBIT](IMPORTANT): Express linearApproximation depth 5.000000 meter;

2023-07-24T22:47:39.578Z,1690238859.578 [SBIT](IMPORTANT): Express linearApproximation latitude 0.005000 degree;

2023-07-24T22:47:39.578Z,1690238859.578 [SBIT](IMPORTANT): Express linearApproximation longitude 0.005000 degree;

2023-07-24T22:47:39.578Z,1690238859.578 [SBIT](IMPORTANT): Sonardyne_Nano.loadAtStartup=0 bool;

2023-07-24T22:47:39.578Z,1690238859.578 [SBIT](IMPORTANT): StratificationFrontDetector.loadAtStartup=1 bool;

2023-07-24T22:47:39.578Z,1690238859.578 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=284.635244 cubic_centimeter;

2023-07-24T22:47:39.578Z,1690238859.578 [SBIT](IMPORTANT): VerticalControl.massDefault=14.174119 millimeter;

2023-07-24T22:47:39.579Z,1690238859.579 [SBIT](IMPORTANT): VerticalHomogeneityIndexCalculator.depth3=20 meter;

2023-07-24T22:47:39.579Z,1690238859.579 [SBIT](IMPORTANT): VerticalHomogeneityIndexCalculator.depth4=30 meter;

2023-07-24T22:47:39.579Z,1690238859.579 [SBIT](IMPORTANT): Waterlinked.loadAtStartup=0 bool;

2023-07-24T22:47:39.985Z,1690238859.985 [MissionManager](IMPORTANT): Started mission Startup
2023-07-24T22:47:39.986Z,1690238859.986 [Startup] Running Loop=1
2023-07-24T22:47:39.986Z,1690238859.986 [Startup](DEBUG): Aggregate::initialize Startup
2023-07-24T22:47:39.986Z,1690238859.986 [Startup:A.GoToSurface] Running Loop=1
2023-07-24T22:47:39.986Z,1690238859.986 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2023-07-24T22:47:39.987Z,1690238859.987 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2023-07-24T22:47:39.987Z,1690238859.987 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2023-07-24T22:47:39.987Z,1690238859.987 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2023-07-24T22:47:39.988Z,1690238859.988 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2023-07-24T22:47:39.988Z,1690238859.988 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2023-07-24T22:47:39.989Z,1690238859.989 [Startup:StartupSatComms] Running Loop=1
2023-07-24T22:47:39.990Z,1690238859.990 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2023-07-24T22:47:39.990Z,1690238859.990 [Startup:StartupSatComms:A] Running Loop=1
2023-07-24T22:47:40.382Z,1690238860.382 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2023-07-24T22:47:56.389Z,1690238876.389 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004758
2023-07-24T22:48:40.160Z,1690238920.160 [Startup:StartupSatComms:A](INFO): Timed out from 2023-07-24T22:47:39.0Z
2023-07-24T22:48:40.160Z,1690238920.160 [Startup:StartupSatComms:A] Stopped
2023-07-24T22:48:40.160Z,1690238920.160 [Startup:StartupSatComms:B] Running Loop=1
2023-07-24T22:48:40.565Z,1690238920.565 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2023-07-24T22:48:46.668Z,1690238926.668 [DataOverHttps](INFO): Sending 369 bytes from file Logs/20230713T153336/Courier0010.lzma
2023-07-24T22:48:47.669Z,1690238927.669 [DataOverHttps](INFO): Moved sent file to Logs/20230713T153336/Courier0010.lzma.bak
2023-07-24T22:48:47.669Z,1690238927.669 [DataOverHttps](INFO): SBD MOMSN=18472948
2023-07-24T22:49:02.855Z,1690238942.855 [DataOverHttps](INFO): Sending 357 bytes from file Logs/20230713T153336/Courier0013.lzma
2023-07-24T22:49:03.856Z,1690238943.856 [DataOverHttps](INFO): Moved sent file to Logs/20230713T153336/Courier0013.lzma.bak
2023-07-24T22:49:03.856Z,1690238943.856 [DataOverHttps](INFO): SBD MOMSN=18472993
2023-07-24T22:49:19.159Z,1690238959.159 [DataOverHttps](INFO): Sending 373 bytes from file Logs/20230713T153336/Courier0016.lzma
2023-07-24T22:49:20.160Z,1690238960.160 [DataOverHttps](INFO): Moved sent file to Logs/20230713T153336/Courier0016.lzma.bak
2023-07-24T22:49:20.160Z,1690238960.160 [DataOverHttps](INFO): SBD MOMSN=18473032
2023-07-24T22:49:29.547Z,1690238969.547 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2023-07-24T22:49:29.547Z,1690238969.547 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2
2023-07-24T22:49:29.547Z,1690238969.547 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-07-24T22:49:29.548Z,1690238969.548 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2023-07-24T22:49:29.548Z,1690238969.548 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 2
2023-07-24T22:49:29.549Z,1690238969.549 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2023-07-24T22:49:29.600Z,1690238969.600 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-07-24T22:49:29.600Z,1690238969.600 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2023-07-24T22:49:30.017Z,1690238970.017 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-07-24T22:49:30.017Z,1690238970.017 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2
2023-07-24T22:49:30.018Z,1690238970.018 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2023-07-24T22:49:30.018Z,1690238970.018 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 2
2023-07-24T22:49:30.370Z,1690238970.370 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2023-07-24T22:49:35.267Z,1690238975.267 [DataOverHttps](INFO): Sending 363 bytes from file Logs/20230713T153336/Courier0019.lzma
2023-07-24T22:49:36.268Z,1690238976.268 [DataOverHttps](INFO): Moved sent file to Logs/20230713T153336/Courier0019.lzma.bak
2023-07-24T22:49:36.268Z,1690238976.268 [DataOverHttps](INFO): SBD MOMSN=18473080
2023-07-24T22:49:40.457Z,1690238980.457 [Startup:StartupSatComms:B](INFO): Timed out from 2023-07-24T22:48:40.2Z
2023-07-24T22:49:40.457Z,1690238980.457 [Startup:StartupSatComms:B] Stopped
2023-07-24T22:49:40.457Z,1690238980.457 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2023-07-24T22:49:40.457Z,1690238980.457 [Startup:StartupSatComms] Stopped
2023-07-24T22:49:40.457Z,1690238980.457 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2023-07-24T22:49:40.458Z,1690238980.458 [Startup](INFO): Completed Startup
2023-07-24T22:49:40.458Z,1690238980.458 [MissionManager](INFO): Startup is completed.
2023-07-24T22:49:40.458Z,1690238980.458 [MissionManager](INFO): Uninitializing Mission Startup
2023-07-24T22:49:40.458Z,1690238980.458 [Startup] Stopped
2023-07-24T22:49:40.458Z,1690238980.458 [Startup](DEBUG): Aggregate::uninitialize Startup
2023-07-24T22:49:40.458Z,1690238980.458 [Startup:A.GoToSurface] Stopped
2023-07-24T22:49:40.458Z,1690238980.458 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2023-07-24T22:49:40.852Z,1690238980.852 [MissionManager](IMPORTANT): Started mission Default
2023-07-24T22:49:40.852Z,1690238980.852 [Default] Running Loop=1
2023-07-24T22:49:40.852Z,1690238980.852 [Default](DEBUG): Aggregate::initialize Default
2023-07-24T22:49:40.852Z,1690238980.852 [Default:B.GoToSurface] Running Loop=1
2023-07-24T22:49:40.852Z,1690238980.852 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2023-07-24T22:49:40.853Z,1690238980.853 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2023-07-24T22:49:40.853Z,1690238980.853 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2023-07-24T22:49:40.853Z,1690238980.853 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2023-07-24T22:49:40.853Z,1690238980.853 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2023-07-24T22:49:40.854Z,1690238980.854 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2023-07-24T22:49:40.858Z,1690238980.858 [Default:A.Wait] Running Loop=1
2023-07-24T22:49:40.858Z,1690238980.858 [Default:A.Wait](DEBUG): Initialize Wait Component.
2023-07-24T22:49:51.428Z,1690238991.428 [DataOverHttps](INFO): Sending 361 bytes from file Logs/20230713T153336/Courier0022.lzma
2023-07-24T22:49:52.428Z,1690238992.428 [DataOverHttps](INFO): Moved sent file to Logs/20230713T153336/Courier0022.lzma.bak
2023-07-24T22:49:52.428Z,1690238992.428 [DataOverHttps](INFO): SBD MOMSN=18473121
2023-07-24T22:49:54.164Z,1690238994.164 [Default:A.Wait](INFO): Done Waiting.
2023-07-24T22:49:54.164Z,1690238994.164 [Default:A.Wait] Stopped
2023-07-24T22:49:54.164Z,1690238994.164 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2023-07-24T22:49:54.569Z,1690238994.569 [Default:CheckIn] Running Loop=1
2023-07-24T22:49:54.570Z,1690238994.570 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2023-07-24T22:49:54.570Z,1690238994.570 [Default:CheckIn:Read_GPS] Running Loop=1
2023-07-24T22:49:54.981Z,1690238994.981 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2023-07-24T22:51:10.916Z,1690239070.916 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2023-07-24T22:51:30.794Z,1690239090.794 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2023-07-24T22:51:30.794Z,1690239090.794 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3
2023-07-24T22:51:30.794Z,1690239090.794 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-07-24T22:51:30.796Z,1690239090.796 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2023-07-24T22:51:30.796Z,1690239090.796 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 3
2023-07-24T22:51:30.796Z,1690239090.796 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2023-07-24T22:51:30.808Z,1690239090.808 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-07-24T22:51:30.808Z,1690239090.808 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2023-07-24T22:51:31.193Z,1690239091.193 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-07-24T22:51:31.193Z,1690239091.193 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3
2023-07-24T22:51:31.194Z,1690239091.194 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2023-07-24T22:51:31.194Z,1690239091.194 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 3
2023-07-24T22:51:31.564Z,1690239091.564 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2023-07-24T22:53:17.417Z,1690239197.417 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2023-07-24T22:53:31.587Z,1690239211.587 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2023-07-24T22:53:31.587Z,1690239211.587 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4
2023-07-24T22:53:31.587Z,1690239211.587 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-07-24T22:53:31.589Z,1690239211.589 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2023-07-24T22:53:31.589Z,1690239211.589 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 4
2023-07-24T22:53:31.589Z,1690239211.589 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2023-07-24T22:53:31.640Z,1690239211.640 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-07-24T22:53:31.640Z,1690239211.640 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2023-07-24T22:53:31.976Z,1690239211.976 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-07-24T22:53:31.976Z,1690239211.976 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4
2023-07-24T22:53:31.976Z,1690239211.976 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2023-07-24T22:53:31.976Z,1690239211.976 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 4
2023-07-24T22:53:32.335Z,1690239212.335 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2023-07-24T22:53:38.375Z,1690239218.375 [BPC1](INFO): Calculating totals. Valid battery stick count: 56. Valid reserve battery stick count: 6.
2023-07-24T22:53:38.378Z,1690239218.378 [BPC1](INFO): Received data from all battery sticks.
2023-07-24T22:54:54.768Z,1690239294.768 [Default:CheckIn:Read_GPS](INFO): Timed out from 2023-07-24T22:49:54.6Z
2023-07-24T22:54:54.768Z,1690239294.768 [Default:CheckIn:Read_GPS] Stopped
2023-07-24T22:54:54.768Z,1690239294.768 [Default:CheckIn:Read_Iridium] Running Loop=1
2023-07-24T22:54:55.158Z,1690239295.158 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications
2023-07-24T22:55:01.523Z,1690239301.523 [DataOverHttps](INFO): Sending 361 bytes from file Logs/20230713T153336/Courier0025.lzma
2023-07-24T22:55:02.524Z,1690239302.524 [DataOverHttps](INFO): Moved sent file to Logs/20230713T153336/Courier0025.lzma.bak
2023-07-24T22:55:02.524Z,1690239302.524 [DataOverHttps](INFO): SBD MOMSN=18473201
2023-07-24T22:55:17.680Z,1690239317.680 [DataOverHttps](INFO): Sending 363 bytes from file Logs/20230713T153336/Courier0028.lzma
2023-07-24T22:55:18.680Z,1690239318.680 [DataOverHttps](INFO): Moved sent file to Logs/20230713T153336/Courier0028.lzma.bak
2023-07-24T22:55:18.680Z,1690239318.680 [DataOverHttps](INFO): SBD MOMSN=18473242
2023-07-24T22:55:30.280Z,1690239330.280 [Power24vConverter](INFO): Powering down.
2023-07-24T22:55:32.338Z,1690239332.338 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2023-07-24T22:55:32.338Z,1690239332.338 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 5
2023-07-24T22:55:32.338Z,1690239332.338 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-07-24T22:55:32.339Z,1690239332.339 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2023-07-24T22:55:32.339Z,1690239332.339 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 5
2023-07-24T22:55:32.339Z,1690239332.339 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2023-07-24T22:55:32.401Z,1690239332.401 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-07-24T22:55:32.401Z,1690239332.401 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2023-07-24T22:55:32.740Z,1690239332.740 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-07-24T22:55:32.740Z,1690239332.740 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 5
2023-07-24T22:55:32.740Z,1690239332.740 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2023-07-24T22:55:32.740Z,1690239332.740 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 5
2023-07-24T22:55:33.126Z,1690239333.126 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2023-07-24T22:55:33.892Z,1690239333.892 [DataOverHttps](INFO): Sending 350 bytes from file Logs/20230713T153336/Courier0031.lzma
2023-07-24T22:55:34.892Z,1690239334.892 [DataOverHttps](INFO): Moved sent file to Logs/20230713T153336/Courier0031.lzma.bak
2023-07-24T22:55:34.892Z,1690239334.892 [DataOverHttps](INFO): SBD MOMSN=18473284
2023-07-24T22:55:50.019Z,1690239350.019 [DataOverHttps](INFO): Sending 354 bytes from file Logs/20230713T153336/Courier0034.lzma
2023-07-24T22:55:51.020Z,1690239351.020 [DataOverHttps](INFO): Moved sent file to Logs/20230713T153336/Courier0034.lzma.bak
2023-07-24T22:55:51.020Z,1690239351.020 [DataOverHttps](INFO): SBD MOMSN=18473323
2023-07-24T22:56:06.199Z,1690239366.199 [DataOverHttps](INFO): Sending 359 bytes from file Logs/20230713T153336/Courier0037.lzma
2023-07-24T22:56:07.202Z,1690239367.202 [DataOverHttps](INFO): Moved sent file to Logs/20230713T153336/Courier0037.lzma.bak
2023-07-24T22:56:07.202Z,1690239367.202 [DataOverHttps](INFO): SBD MOMSN=18473365
2023-07-24T22:56:08.267Z,1690239368.267 [NAL9602](FAULT): GPS failed to acquire within timeout.
2023-07-24T22:56:08.268Z,1690239368.268 [NAL9602] Data Fault, FailCount= 1
2023-07-24T22:56:08.268Z,1690239368.268 [NAL9602](ERROR): Data Fault
2023-07-24T22:56:08.320Z,1690239368.320 [CBIT](ERROR): Data Fault in component: NAL9602
2023-07-24T22:56:08.660Z,1690239368.660 [NAL9602](INFO): Powering down
2023-07-24T22:56:09.499Z,1690239369.499 [CBIT](INFO): Clearing failed state for component NAL9602
2023-07-24T22:56:09.499Z,1690239369.499 [NAL9602] No Fault, FailCount= 1
2023-07-24T22:56:22.271Z,1690239382.271 [DataOverHttps](INFO): Sending 347 bytes from file Logs/20230713T153336/Courier0040.lzma
2023-07-24T22:56:23.272Z,1690239383.272 [DataOverHttps](INFO): Moved sent file to Logs/20230713T153336/Courier0040.lzma.bak
2023-07-24T22:56:23.272Z,1690239383.272 [DataOverHttps](INFO): SBD MOMSN=18473407
2023-07-24T22:56:38.256Z,1690239398.256 [DataOverHttps](INFO): Sending 359 bytes from file Logs/20230713T153336/Courier0043.lzma
2023-07-24T22:56:38.957Z,1690239398.957 [NAL9602](INFO): Powering up NAL9602
2023-07-24T22:56:39.256Z,1690239399.256 [DataOverHttps](INFO): Moved sent file to Logs/20230713T153336/Courier0043.lzma.bak
2023-07-24T22:56:39.257Z,1690239399.257 [DataOverHttps](INFO): SBD MOMSN=18473449
2023-07-24T22:56:49.872Z,1690239409.872 [NAL9602](INFO): NAL9602 initialized
2023-07-24T22:56:54.279Z,1690239414.279 [DataOverHttps](INFO): Sending 352 bytes from file Logs/20230713T153336/Courier0046.lzma
2023-07-24T22:56:55.280Z,1690239415.280 [DataOverHttps](INFO): Moved sent file to Logs/20230713T153336/Courier0046.lzma.bak
2023-07-24T22:56:55.280Z,1690239415.280 [DataOverHttps](INFO): SBD MOMSN=18473498
2023-07-24T22:57:10.427Z,1690239430.427 [DataOverHttps](INFO): Sending 368 bytes from file Logs/20230713T153336/Courier0049.lzma
2023-07-24T22:57:11.428Z,1690239431.428 [DataOverHttps](INFO): Moved sent file to Logs/20230713T153336/Courier0049.lzma.bak
2023-07-24T22:57:11.428Z,1690239431.428 [DataOverHttps](INFO): SBD MOMSN=18473537
2023-07-24T22:57:26.579Z,1690239446.579 [DataOverHttps](INFO): Sending 363 bytes from file Logs/20230713T153336/Courier0052.lzma
2023-07-24T22:57:27.580Z,1690239447.580 [DataOverHttps](INFO): Moved sent file to Logs/20230713T153336/Courier0052.lzma.bak
2023-07-24T22:57:27.580Z,1690239447.580 [DataOverHttps](INFO): SBD MOMSN=18473579
2023-07-24T22:57:33.138Z,1690239453.138 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2023-07-24T22:57:33.138Z,1690239453.138 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 6
2023-07-24T22:57:33.138Z,1690239453.138 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-07-24T22:57:33.140Z,1690239453.140 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2023-07-24T22:57:33.140Z,1690239453.140 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 6
2023-07-24T22:57:33.140Z,1690239453.140 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2023-07-24T22:57:33.162Z,1690239453.162 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-07-24T22:57:33.163Z,1690239453.163 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2023-07-24T22:57:33.531Z,1690239453.531 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-07-24T22:57:33.531Z,1690239453.531 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 6
2023-07-24T22:57:33.532Z,1690239453.532 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2023-07-24T22:57:33.532Z,1690239453.532 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 6
2023-07-24T22:57:33.919Z,1690239453.919 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2023-07-24T22:57:42.759Z,1690239462.759 [DataOverHttps](INFO): Sending 359 bytes from file Logs/20230713T153336/Courier0055.lzma
2023-07-24T22:57:43.760Z,1690239463.760 [DataOverHttps](INFO): Moved sent file to Logs/20230713T153336/Courier0055.lzma.bak
2023-07-24T22:57:43.761Z,1690239463.761 [DataOverHttps](INFO): SBD MOMSN=18473620
2023-07-24T22:57:58.899Z,1690239478.899 [DataOverHttps](INFO): Sending 362 bytes from file Logs/20230713T153336/Courier0058.lzma
2023-07-24T22:57:59.900Z,1690239479.900 [DataOverHttps](INFO): Moved sent file to Logs/20230713T153336/Courier0058.lzma.bak
2023-07-24T22:57:59.900Z,1690239479.900 [DataOverHttps](INFO): SBD MOMSN=18473660
2023-07-24T22:58:13.139Z,1690239493.139 [CommandExec](IMPORTANT): got command failComponent
2023-07-24T22:58:13.139Z,1690239493.139 [CommandExec](IMPORTANT): Failed components:
2023-07-24T22:58:13.139Z,1690239493.139 [CommandExec](IMPORTANT): No failed Components.
2023-07-24T22:58:15.087Z,1690239495.087 [DataOverHttps](INFO): Sending 372 bytes from file Logs/20230713T153336/Courier0061.lzma
2023-07-24T22:58:16.088Z,1690239496.088 [DataOverHttps](INFO): Moved sent file to Logs/20230713T153336/Courier0061.lzma.bak
2023-07-24T22:58:16.089Z,1690239496.089 [DataOverHttps](INFO): SBD MOMSN=18473701
2023-07-24T22:58:31.236Z,1690239511.236 [DataOverHttps](INFO): Sending 357 bytes from file Logs/20230713T153336/Courier0064.lzma
2023-07-24T22:58:32.236Z,1690239512.236 [DataOverHttps](INFO): Moved sent file to Logs/20230713T153336/Courier0064.lzma.bak
2023-07-24T22:58:32.236Z,1690239512.236 [DataOverHttps](INFO): SBD MOMSN=18473743
2023-07-24T22:58:47.355Z,1690239527.355 [DataOverHttps](INFO): Sending 361 bytes from file Logs/20230713T153336/Courier0067.lzma
2023-07-24T22:58:48.356Z,1690239528.356 [DataOverHttps](INFO): Moved sent file to Logs/20230713T153336/Courier0067.lzma.bak
2023-07-24T22:58:48.356Z,1690239528.356 [DataOverHttps](INFO): SBD MOMSN=18473782
2023-07-24T22:59:02.450Z,1690239542.450 [DataOverHttps](INFO): Sending 361 bytes from file Logs/20230713T153336/Courier0070.lzma
2023-07-24T22:59:03.440Z,1690239543.440 [DataOverHttps](INFO): Moved sent file to Logs/20230713T153336/Courier0070.lzma.bak
2023-07-24T22:59:03.440Z,1690239543.440 [DataOverHttps](INFO): SBD MOMSN=18473824
2023-07-24T22:59:18.500Z,1690239558.500 [DataOverHttps](INFO): Sending 351 bytes from file Logs/20230713T153336/Courier0073.lzma
2023-07-24T22:59:19.500Z,1690239559.500 [DataOverHttps](INFO): Moved sent file to Logs/20230713T153336/Courier0073.lzma.bak
2023-07-24T22:59:19.501Z,1690239559.501 [DataOverHttps](INFO): SBD MOMSN=18473865
2023-07-24T22:59:34.006Z,1690239574.006 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2023-07-24T22:59:34.006Z,1690239574.006 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 7
2023-07-24T22:59:34.006Z,1690239574.006 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-07-24T22:59:34.008Z,1690239574.008 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2023-07-24T22:59:34.008Z,1690239574.008 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 7
2023-07-24T22:59:34.008Z,1690239574.008 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2023-07-24T22:59:34.096Z,1690239574.096 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-07-24T22:59:34.096Z,1690239574.096 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2023-07-24T22:59:34.420Z,1690239574.420 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-07-24T22:59:34.420Z,1690239574.420 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 7
2023-07-24T22:59:34.420Z,1690239574.420 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2023-07-24T22:59:34.420Z,1690239574.420 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 7
2023-07-24T22:59:34.774Z,1690239574.774 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2023-07-24T22:59:42.437Z,1690239582.437 [DataOverHttps](INFO): Sending 160 bytes from file Logs/20230713T153336/Courier0076.lzma
2023-07-24T22:59:43.430Z,1690239583.430 [DataOverHttps](INFO): Moved sent file to Logs/20230713T153336/Courier0076.lzma.bak
2023-07-24T22:59:43.430Z,1690239583.430 [DataOverHttps](INFO): SBD MOMSN=18473905
2023-07-24T23:00:03.475Z,1690239603.475 [DataOverHttps](INFO): Sending 290 bytes from file Logs/20230724T223617/Courier0000.lzma
2023-07-24T23:00:04.468Z,1690239604.468 [DataOverHttps](INFO): Moved sent file to Logs/20230724T223617/Courier0000.lzma.bak
2023-07-24T23:00:04.468Z,1690239604.468 [DataOverHttps](INFO): SBD MOMSN=18473912
2023-07-24T23:00:07.331Z,1690239607.331 [CommandExec](IMPORTANT): got command restart system
2023-07-24T23:00:09.498Z,1690239609.498 [Supervisor](INFO): Stop Mission called by Supervisor::terminate
2023-07-24T23:00:09.499Z,1690239609.499 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread.
2023-07-24T23:00:09.499Z,1690239609.499 [CommandExec](INFO): Uninitializing the command executive.
2023-07-24T23:00:09.499Z,1690239609.499 [CommandExec](INFO): Uninitializing the command scheduler.
2023-07-24T23:00:09.499Z,1690239609.499 [CommandExec ThreadHandler](INFO): Thread cancelled.
2023-07-24T23:00:09.690Z,1690239609.690 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup.  Bye!
2023-07-24T23:00:09.690Z,1690239609.690 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2023-07-24T23:00:09.691Z,1690239609.691 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2023-07-24T23:00:09.691Z,1690239609.691 [NavChartDb](INFO): Join timeout helper Thread ID is 2216
2023-07-24T23:00:10.075Z,1690239610.075 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2023-07-24T23:00:10.075Z,1690239610.075 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2023-07-24T23:00:10.082Z,1690239610.082 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2023-07-24T23:00:10.082Z,1690239610.082 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2023-07-24T23:00:10.083Z,1690239610.083 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 2218
2023-07-24T23:00:10.226Z,1690239610.226 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread.
2023-07-24T23:00:10.227Z,1690239610.227 [WetLabsBB2FL](INFO): Powering down
2023-07-24T23:00:10.228Z,1690239610.228 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2023-07-24T23:00:10.230Z,1690239610.230 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2023-07-24T23:00:10.230Z,1690239610.230 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2023-07-24T23:00:10.231Z,1690239610.231 [Radio_Surface](INFO): Join timeout helper Thread ID is 2219
2023-07-24T23:00:10.430Z,1690239610.430 [Radio_Surface](INFO): Powering down
2023-07-24T23:00:10.432Z,1690239610.432 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2023-07-24T23:00:10.432Z,1690239610.432 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2023-07-24T23:00:10.442Z,1690239610.442 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler
2023-07-24T23:00:10.443Z,1690239610.443 [Onboard ThreadHandler](INFO): Thread cancelled.
2023-07-24T23:00:10.443Z,1690239610.443 [Onboard](INFO): Join timeout helper Thread ID is 2220
2023-07-24T23:00:14.559Z,1690239614.559 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread.
2023-07-24T23:00:14.559Z,1690239614.559 [Onboard ThreadHandler](INFO): Thread cancelled.
2023-07-24T23:00:14.562Z,1690239614.562 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler
2023-07-24T23:00:14.562Z,1690239614.562 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2023-07-24T23:00:14.563Z,1690239614.563 [DataOverHttps](INFO): Join timeout helper Thread ID is 2221
2023-07-24T23:00:15.266Z,1690239615.266 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread.
2023-07-24T23:00:15.270Z,1690239615.270 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2023-07-24T23:00:15.275Z,1690239615.275 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler
2023-07-24T23:00:15.275Z,1690239615.275 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2023-07-24T23:00:15.276Z,1690239615.276 [BackseatComponent](INFO): Join timeout helper Thread ID is 2222
2023-07-24T23:00:15.443Z,1690239615.443 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread.
2023-07-24T23:00:15.443Z,1690239615.443 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2023-07-24T23:00:15.463Z,1690239615.463 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2023-07-24T23:00:15.463Z,1690239615.463 [logger ThreadHandler](INFO): Thread cancelled.
2023-07-24T23:00:15.463Z,1690239615.463 [logger](INFO): Join timeout helper Thread ID is 2223
2023-07-24T23:00:15.494Z,1690239615.494 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2023-07-24T23:00:15.495Z,1690239615.495 [logger ThreadHandler](INFO): Thread cancelled.
2023-07-24T23:00:15.503Z,1690239615.503 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2023-07-24T23:00:15.503Z,1690239615.503 [CommandLine ThreadHandler](INFO): Thread cancelled.
2023-07-24T23:00:15.503Z,1690239615.503 [CommandLine](INFO): Join timeout helper Thread ID is 2224
2023-07-24T23:00:15.546Z,1690239615.546 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2023-07-24T23:00:15.547Z,1690239615.547 [CommandLine ThreadHandler](INFO): Thread cancelled.
2023-07-24T23:00:15.563Z,1690239615.563 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler
2023-07-24T23:00:15.563Z,1690239615.563 [CommandExec ThreadHandler](INFO): Thread cancelled.
2023-07-24T23:00:15.564Z,1690239615.564 [CommandExec](INFO): Join timeout helper Thread ID is 2225
2023-07-24T23:00:15.583Z,1690239615.583 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2023-07-24T23:00:15.583Z,1690239615.583 [controlThread ThreadHandler](INFO): Thread cancelled.
2023-07-24T23:00:15.584Z,1690239615.584 [controlThread](INFO): Join timeout helper Thread ID is 2226
2023-07-24T23:00:15.596Z,1690239615.596 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2023-07-24T23:00:15.596Z,1690239615.596 [controlThread](DEBUG): Uninitializing ControlThread
2023-07-24T23:00:15.597Z,1690239615.597 [NAL9602](INFO): Powering down
2023-07-24T23:00:15.599Z,1690239615.599 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2023-07-24T23:00:15.600Z,1690239615.600 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2023-07-24T23:00:15.600Z,1690239615.600 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2023-07-24T23:00:15.601Z,1690239615.601 [MissionManager](INFO): Uninitializing Mission Default
2023-07-24T23:00:15.601Z,1690239615.601 [Default] Stopped
2023-07-24T23:00:15.601Z,1690239615.601 [Default](DEBUG): Aggregate::uninitialize Default
2023-07-24T23:00:15.601Z,1690239615.601 [Default:B.GoToSurface] Stopped
2023-07-24T23:00:15.601Z,1690239615.601 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2023-07-24T23:00:15.601Z,1690239615.601 [Default:CheckIn] Stopped
2023-07-24T23:00:15.601Z,1690239615.601 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2023-07-24T23:00:15.602Z,1690239615.602 [Default:CheckIn:Read_Iridium] Stopped
2023-07-24T23:00:15.604Z,1690239615.604 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2023-07-24T23:00:15.605Z,1690239615.605 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2023-07-24T23:00:15.605Z,1690239615.605 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2023-07-24T23:00:15.605Z,1690239615.605 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2023-07-24T23:00:15.606Z,1690239615.606 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2023-07-24T23:00:15.606Z,1690239615.606 [BuoyancyServo](INFO): Powering down
2023-07-24T23:00:15.618Z,1690239615.618 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2023-07-24T23:00:15.619Z,1690239615.619 [ElevatorServo](INFO): Powering down
2023-07-24T23:00:15.620Z,1690239615.620 [MassServo](DEBUG): Uninitialize Mass Servo.
2023-07-24T23:00:15.620Z,1690239615.620 [MassServo](INFO): Powering down
2023-07-24T23:00:15.621Z,1690239615.621 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2023-07-24T23:00:15.621Z,1690239615.621 [RudderServo](INFO): Powering down
2023-07-24T23:00:15.622Z,1690239615.622 [ThrusterHE](DEBUG): Uninitialize Thruster Servo.
2023-07-24T23:00:15.622Z,1690239615.622 [ThrusterHE](INFO): Powering down
2023-07-24T23:00:15.623Z,1690239615.623 [SBIT](DEBUG): Uninitialize SBIT Component.
2023-07-24T23:00:15.623Z,1690239615.623 [IBIT](DEBUG): Uninitialize IBIT Component.
2023-07-24T23:00:15.623Z,1690239615.623 [CBIT](DEBUG): Uninitialize CBIT Component.
2023-07-24T23:00:15.624Z,1690239615.624 [CBIT](DEBUG): Powering off loads.
2023-07-24T23:00:15.634Z,1690239615.634 [CBIT](DEBUG): Disabling WDT.
2023-07-24T23:00:15.646Z,1690239615.646 [CBIT](DEBUG): Opening all GF detection circuits.
2023-07-24T23:00:15.647Z,1690239615.647 [controlThread ThreadHandler](INFO): Thread cancelled.
2023-07-24T23:00:15.780Z,1690239615.780 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2023-07-24T23:00:15.784Z,1690239615.784 [Onboard ThreadHandler](INFO): Thread cancelled.
2023-07-24T23:00:15.790Z,1690239615.790 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2023-07-24T23:00:15.836Z,1690239615.836 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2023-07-24T23:00:15.891Z,1690239615.891 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2023-07-24T23:00:15.956Z,1690239615.956 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2023-07-24T23:00:16.003Z,1690239616.003 [logger ThreadHandler](INFO): Thread cancelled.