2024-07-19T02:50:22.836Z,1721357422.836 [Supervisor](DEBUG): Initializing supervisor.
2024-07-19T02:50:22.840Z,1721357422.840 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2024-07-19T02:50:22.840Z,1721357422.840 [SyncHandler](INFO): Protected caller Thread ID is 836
2024-07-19T02:50:22.841Z,1721357422.841 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2024-07-19T02:50:22.842Z,1721357422.842 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2024-07-19T02:50:22.842Z,1721357422.842 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 837
2024-07-19T02:50:22.846Z,1721357422.846 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2024-07-19T02:50:22.863Z,1721357422.863 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread.
2024-07-19T02:50:22.864Z,1721357422.864 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2024-07-19T02:50:22.864Z,1721357422.864 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 838
2024-07-19T02:50:22.868Z,1721357422.868 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2024-07-19T02:50:22.869Z,1721357422.869 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2024-07-19T02:50:22.870Z,1721357422.870 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 839
2024-07-19T02:50:22.872Z,1721357422.872 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2024-07-19T02:50:22.873Z,1721357422.873 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0
2024-07-19T02:50:22.873Z,1721357422.873 [logger ThreadHandler](INFO): Protected caller Thread ID is 840
2024-07-19T02:50:22.877Z,1721357422.877 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2024-07-19T02:50:22.877Z,1721357422.877 [Supervisor](INFO): Looking for Config files in directory: Config/
2024-07-19T02:50:22.881Z,1721357422.881 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2024-07-19T02:50:23.370Z,1721357423.370 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2024-07-19T02:50:23.372Z,1721357423.372 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2024-07-19T02:50:23.611Z,1721357423.611 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2024-07-19T02:50:23.613Z,1721357423.613 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2024-07-19T02:50:23.706Z,1721357423.706 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg
2024-07-19T02:50:23.955Z,1721357423.955 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock
2024-07-19T02:50:23.957Z,1721357423.957 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2024-07-19T02:50:24.049Z,1721357424.049 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2024-07-19T02:50:24.155Z,1721357424.155 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2024-07-19T02:50:24.157Z,1721357424.157 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2024-07-19T02:50:24.520Z,1721357424.520 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2024-07-19T02:50:24.521Z,1721357424.521 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2024-07-19T02:50:24.666Z,1721357424.666 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2024-07-19T02:50:24.668Z,1721357424.668 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2024-07-19T02:50:25.225Z,1721357425.225 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2024-07-19T02:50:25.226Z,1721357425.226 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2024-07-19T02:50:25.430Z,1721357425.430 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2024-07-19T02:50:25.432Z,1721357425.432 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2024-07-19T02:50:25.861Z,1721357425.861 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2024-07-19T02:50:25.862Z,1721357425.862 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2024-07-19T02:50:26.380Z,1721357426.380 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2024-07-19T02:50:26.381Z,1721357426.381 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2024-07-19T02:50:26.504Z,1721357426.504 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2024-07-19T02:50:26.506Z,1721357426.506 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2024-07-19T02:50:27.369Z,1721357427.369 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2024-07-19T02:50:27.371Z,1721357427.371 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2024-07-19T02:50:27.759Z,1721357427.759 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2024-07-19T02:50:27.761Z,1721357427.761 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2024-07-19T02:50:28.008Z,1721357428.008 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2024-07-19T02:50:28.010Z,1721357428.010 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-triton/
2024-07-19T02:50:28.012Z,1721357428.012 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/vehicle.cfg
2024-07-19T02:50:28.143Z,1721357428.143 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/secure.cfg
2024-07-19T02:50:28.238Z,1721357428.238 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Science.cfg
2024-07-19T02:50:28.388Z,1721357428.388 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Simulator.cfg
2024-07-19T02:50:28.485Z,1721357428.485 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Battery.cfg
2024-07-19T02:50:28.758Z,1721357428.758 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2024-07-19T02:50:28.759Z,1721357428.759 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/logger.cfg
2024-07-19T02:50:28.877Z,1721357428.877 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Servo.cfg
2024-07-19T02:50:28.997Z,1721357428.997 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Navigation.cfg
2024-07-19T02:50:29.117Z,1721357429.117 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Sensor.cfg
2024-07-19T02:50:29.280Z,1721357429.280 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Control.cfg
2024-07-19T02:50:29.390Z,1721357429.390 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/BIT.cfg
2024-07-19T02:50:29.488Z,1721357429.488 [Supervisor](IMPORTANT): Reloading configuration overrides from Data/persisted.cfg
2024-07-19T02:50:29.499Z,1721357429.499 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2024-07-19T02:50:29.515Z,1721357429.515 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2024-07-19T02:50:29.516Z,1721357429.516 [Module Loader](DEBUG): Loading Module at Modules/Dock.so
2024-07-19T02:50:29.659Z,1721357429.659 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking)
2024-07-19T02:50:29.659Z,1721357429.659 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2024-07-19T02:50:29.729Z,1721357429.729 [VerticalControl](DEBUG): Construct VerticalControl.
2024-07-19T02:50:29.789Z,1721357429.789 [VerticalControl] Loaded
2024-07-19T02:50:29.789Z,1721357429.789 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2024-07-19T02:50:29.792Z,1721357429.792 [HorizontalControl](DEBUG): Construct HorizontalControl.
2024-07-19T02:50:29.839Z,1721357429.839 [HorizontalControl] Loaded
2024-07-19T02:50:29.839Z,1721357429.839 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2024-07-19T02:50:29.842Z,1721357429.842 [SpeedControl](DEBUG): Construct SpeedControl.
2024-07-19T02:50:29.845Z,1721357429.845 [SpeedControl] Loaded
2024-07-19T02:50:29.845Z,1721357429.845 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2024-07-19T02:50:29.848Z,1721357429.848 [LoopControl](DEBUG): Construct LoopControl.
2024-07-19T02:50:29.848Z,1721357429.848 [LoopControl] Loaded
2024-07-19T02:50:29.848Z,1721357429.848 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2024-07-19T02:50:29.849Z,1721357429.849 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2024-07-19T02:50:29.851Z,1721357429.851 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2024-07-19T02:50:30.035Z,1721357430.035 [BuoyancyServo] Loaded
2024-07-19T02:50:30.035Z,1721357430.035 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2024-07-19T02:50:30.057Z,1721357430.057 [ElevatorServo] Loaded
2024-07-19T02:50:30.057Z,1721357430.057 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2024-07-19T02:50:30.078Z,1721357430.078 [MassServo] Loaded
2024-07-19T02:50:30.078Z,1721357430.078 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2024-07-19T02:50:30.098Z,1721357430.098 [RudderServo] Loaded
2024-07-19T02:50:30.099Z,1721357430.099 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2024-07-19T02:50:30.115Z,1721357430.115 [ThrusterHE] Loaded
2024-07-19T02:50:30.115Z,1721357430.115 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread.
2024-07-19T02:50:30.116Z,1721357430.116 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2024-07-19T02:50:30.116Z,1721357430.116 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2024-07-19T02:50:30.186Z,1721357430.186 [DepthRateCalculator] Loaded
2024-07-19T02:50:30.186Z,1721357430.186 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2024-07-19T02:50:30.191Z,1721357430.191 [PitchRateCalculator] Loaded
2024-07-19T02:50:30.191Z,1721357430.191 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2024-07-19T02:50:30.201Z,1721357430.201 [SpeedCalculator] Loaded
2024-07-19T02:50:30.201Z,1721357430.201 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2024-07-19T02:50:30.205Z,1721357430.205 [YawRateCalculator] Loaded
2024-07-19T02:50:30.205Z,1721357430.205 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2024-07-19T02:50:30.223Z,1721357430.223 [ElevatorOffsetCalculator] Loaded
2024-07-19T02:50:30.224Z,1721357430.224 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2024-07-19T02:50:30.224Z,1721357430.224 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2024-07-19T02:50:30.225Z,1721357430.225 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2024-07-19T02:50:30.361Z,1721357430.361 [DeadReckonUsingMultipleVelocitySources] Loaded
2024-07-19T02:50:30.362Z,1721357430.362 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2024-07-19T02:50:30.375Z,1721357430.375 [NavChart] Loaded
2024-07-19T02:50:30.375Z,1721357430.375 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2024-07-19T02:50:30.381Z,1721357430.381 [UniversalFixResidualReporter] Loaded
2024-07-19T02:50:30.381Z,1721357430.381 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2024-07-19T02:50:30.382Z,1721357430.382 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2024-07-19T02:50:30.382Z,1721357430.382 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2024-07-19T02:50:31.138Z,1721357431.138 [AHRS_M2] Loaded
2024-07-19T02:50:31.138Z,1721357431.138 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread.
2024-07-19T02:50:31.391Z,1721357431.391 [BackseatComponent] Loaded
2024-07-19T02:50:31.392Z,1721357431.392 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread.
2024-07-19T02:50:31.393Z,1721357431.393 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 4090B4E0
2024-07-19T02:50:31.393Z,1721357431.393 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 922
2024-07-19T02:50:31.396Z,1721357431.396 [LcmUniversalReporter] Loaded
2024-07-19T02:50:31.396Z,1721357431.396 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread.
2024-07-19T02:50:31.402Z,1721357431.402 [BioacousticsDataBridge] Loaded
2024-07-19T02:50:31.403Z,1721357431.403 [ComponentRegistry](DEBUG): SyncComponent "BioacousticsDataBridge" handled in the control thread.
2024-07-19T02:50:32.459Z,1721357432.459 [BPC1] Loaded
2024-07-19T02:50:32.459Z,1721357432.459 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2024-07-19T02:50:32.598Z,1721357432.598 [DataOverHttps] Loaded
2024-07-19T02:50:32.599Z,1721357432.599 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2024-07-19T02:50:32.600Z,1721357432.600 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 4093B4E0
2024-07-19T02:50:32.600Z,1721357432.600 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 923
2024-07-19T02:50:32.623Z,1721357432.623 [Depth_Keller] Loaded
2024-07-19T02:50:32.623Z,1721357432.623 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2024-07-19T02:50:32.628Z,1721357432.628 [DropWeight] Loaded
2024-07-19T02:50:32.629Z,1721357432.629 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2024-07-19T02:50:32.692Z,1721357432.692 [NAL9602] Loaded
2024-07-19T02:50:32.692Z,1721357432.692 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2024-07-19T02:50:32.722Z,1721357432.722 [Onboard] Loaded
2024-07-19T02:50:32.722Z,1721357432.722 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread.
2024-07-19T02:50:32.723Z,1721357432.723 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 4096B4E0
2024-07-19T02:50:32.723Z,1721357432.723 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 924
2024-07-19T02:50:32.737Z,1721357432.737 [Power24vConverter] Loaded
2024-07-19T02:50:32.738Z,1721357432.738 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread.
2024-07-19T02:50:32.753Z,1721357432.753 [Radio_Surface] Loaded
2024-07-19T02:50:32.753Z,1721357432.753 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2024-07-19T02:50:32.754Z,1721357432.754 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 4099B4E0
2024-07-19T02:50:32.755Z,1721357432.755 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 925
2024-07-19T02:50:32.770Z,1721357432.770 [Sonardyne_Nano] Loaded
2024-07-19T02:50:32.770Z,1721357432.770 [ComponentRegistry](DEBUG): SyncComponent "Sonardyne_Nano" handled in the control thread.
2024-07-19T02:50:32.771Z,1721357432.771 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2024-07-19T02:50:32.771Z,1721357432.771 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2024-07-19T02:50:32.852Z,1721357432.852 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2024-07-19T02:50:32.853Z,1721357432.853 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2024-07-19T02:50:33.065Z,1721357433.065 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2024-07-19T02:50:33.066Z,1721357433.066 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2024-07-19T02:50:33.111Z,1721357433.111 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2024-07-19T02:50:33.111Z,1721357433.111 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2024-07-19T02:50:33.331Z,1721357433.331 [CTD_Seabird] Loaded
2024-07-19T02:50:33.332Z,1721357433.332 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread.
2024-07-19T02:50:33.333Z,1721357433.333 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40ADB4E0
2024-07-19T02:50:33.333Z,1721357433.333 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 926
2024-07-19T02:50:33.356Z,1721357433.356 [PAR_Licor] Loaded
2024-07-19T02:50:33.356Z,1721357433.356 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2024-07-19T02:50:33.401Z,1721357433.401 [WetLabsBB2FL] Loaded
2024-07-19T02:50:33.401Z,1721357433.401 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2024-07-19T02:50:33.402Z,1721357433.402 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40B0B4E0
2024-07-19T02:50:33.403Z,1721357433.403 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 927
2024-07-19T02:50:33.403Z,1721357433.403 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2024-07-19T02:50:33.404Z,1721357433.404 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2024-07-19T02:50:33.797Z,1721357433.797 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2024-07-19T02:50:33.797Z,1721357433.797 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2024-07-19T02:50:33.970Z,1721357433.970 [SBIT](DEBUG): Construct Startup Built In Test.
2024-07-19T02:50:33.979Z,1721357433.979 [SBIT] Loaded
2024-07-19T02:50:33.979Z,1721357433.979 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2024-07-19T02:50:33.983Z,1721357433.983 [IBIT](DEBUG): Construct Initiated Built In Test.
2024-07-19T02:50:33.996Z,1721357433.996 [IBIT] Loaded
2024-07-19T02:50:33.997Z,1721357433.997 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2024-07-19T02:50:34.002Z,1721357434.002 [CBIT](DEBUG): Construct Continuous Built In Test.
2024-07-19T02:50:34.107Z,1721357434.107 [CBIT] Loaded
2024-07-19T02:50:34.107Z,1721357434.107 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2024-07-19T02:50:34.107Z,1721357434.107 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2024-07-19T02:50:34.114Z,1721357434.114 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2024-07-19T02:50:34.117Z,1721357434.117 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2024-07-19T02:50:34.128Z,1721357434.128 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2024-07-19T02:50:34.129Z,1721357434.129 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40C074E0
2024-07-19T02:50:34.129Z,1721357434.129 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 928
2024-07-19T02:50:34.134Z,1721357434.134 [Supervisor](INFO): Main Thread ID is 829
2024-07-19T02:50:34.134Z,1721357434.134 [Supervisor](DEBUG): Running supervisor.
2024-07-19T02:50:34.134Z,1721357434.134 [CommandExec ThreadHandler](INFO): Handler Thread ID is 929
2024-07-19T02:50:34.135Z,1721357434.135 [CommandExec](INFO): Initializing the command executive.
2024-07-19T02:50:34.137Z,1721357434.137 [CommandLine ThreadHandler](INFO): Handler Thread ID is 930
2024-07-19T02:50:34.138Z,1721357434.138 [controlThread ThreadHandler](INFO): Handler Thread ID is 931
2024-07-19T02:50:34.139Z,1721357434.139 [controlThread](DEBUG): Initializing ControlThread
2024-07-19T02:50:34.140Z,1721357434.140 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2024-07-19T02:50:34.141Z,1721357434.141 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2024-07-19T02:50:34.142Z,1721357434.142 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2024-07-19T02:50:34.143Z,1721357434.143 [LoopControl](DEBUG): Initialize LoopControlComponent.
2024-07-19T02:50:34.144Z,1721357434.144 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2024-07-19T02:50:34.144Z,1721357434.144 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2024-07-19T02:50:34.145Z,1721357434.145 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2024-07-19T02:50:34.145Z,1721357434.145 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2024-07-19T02:50:34.145Z,1721357434.145 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2024-07-19T02:50:34.146Z,1721357434.146 [NavChart](DEBUG): Initialize NavChart Navigation.
2024-07-19T02:50:34.147Z,1721357434.147 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2024-07-19T02:50:34.156Z,1721357434.156 [SBIT](INFO): Initialize SBIT Component.
2024-07-19T02:50:34.156Z,1721357434.157 [SBIT](IMPORTANT): git: 2024-07-18
2024-07-19T02:50:34.157Z,1721357434.157 [SBIT](INFO): git hash: e777c895b2d7d743d45b75a88845e2c8d3f60819
2024-07-19T02:50:34.157Z,1721357434.157 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2024-07-19T02:50:34.158Z,1721357434.158 [SBIT](INFO): Kernel Reporting Different Version From Configuration.
Kernel Expected: #1 PREEMPT Tue Dec 18 21:19:28 PST 2018
Kernel Reported: #1 PREEMPT Wed Mar 17 08:23:48 PDT 2021
2024-07-19T02:50:34.159Z,1721357434.159 [SBIT](INFO): Beginning SBIT in 110.000000 seconds.
2024-07-19T02:50:34.160Z,1721357434.160 [IBIT](INFO): Initialize IBIT Component.
2024-07-19T02:50:34.161Z,1721357434.161 [CBIT](DEBUG): Initialize CBIT Component.
2024-07-19T02:50:34.162Z,1721357434.162 [logger ThreadHandler](INFO): Handler Thread ID is 932
2024-07-19T02:50:34.172Z,1721357434.172 [CBIT](DEBUG): Initialized mux pins.
2024-07-19T02:50:34.172Z,1721357434.172 [CBIT](DEBUG): Initializing the watchdog timer.
2024-07-19T02:50:34.180Z,1721357434.180 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 933
2024-07-19T02:50:34.192Z,1721357434.192 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 934
2024-07-19T02:50:34.194Z,1721357434.194 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2024-07-19T02:50:34.196Z,1721357434.196 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2024-07-19T02:50:34.196Z,1721357434.196 [CBIT](DEBUG): Initializing heartbeat.
2024-07-19T02:50:34.204Z,1721357434.204 [Onboard ThreadHandler](INFO): Handler Thread ID is 935
2024-07-19T02:50:34.222Z,1721357434.222 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 936
2024-07-19T02:50:34.240Z,1721357434.240 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 937
2024-07-19T02:50:34.241Z,1721357434.241 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2024-07-19T02:50:34.245Z,1721357434.245 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 939
2024-07-19T02:50:34.248Z,1721357434.248 [WetLabsBB2FL](INFO): Powering up
2024-07-19T02:50:34.249Z,1721357434.249 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 941
2024-07-19T02:50:34.257Z,1721357434.257 [NavChartDb](FAULT): Change detected in ENC collection. Wiping NavChart Directory
2024-07-19T02:50:34.268Z,1721357434.268 [CBIT](DEBUG): Deactivating GF circuits.
2024-07-19T02:50:34.268Z,1721357434.268 [CBIT](DEBUG): Deactivating emergency mode.
2024-07-19T02:50:34.283Z,1721357434.283 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2MI60M.000
2024-07-19T02:50:34.284Z,1721357434.284 [NavChartDb](IMPORTANT): Will load Electronic Nav Chart data from US2MI60M.000
2024-07-19T02:50:34.284Z,1721357434.284 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4MI1ND.000
2024-07-19T02:50:34.286Z,1721357434.286 [NavChartDb](IMPORTANT): Will load Electronic Nav Chart data from US4MI1ND.000
2024-07-19T02:50:34.286Z,1721357434.286 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4MI1OD.000
2024-07-19T02:50:34.287Z,1721357434.287 [NavChartDb](IMPORTANT): Will load Electronic Nav Chart data from US4MI1OD.000
2024-07-19T02:50:34.287Z,1721357434.287 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4MI51M.000
2024-07-19T02:50:34.289Z,1721357434.289 [NavChartDb](IMPORTANT): Will load Electronic Nav Chart data from US4MI51M.000
2024-07-19T02:50:34.289Z,1721357434.289 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4MI1OF.000
2024-07-19T02:50:34.290Z,1721357434.290 [NavChartDb](IMPORTANT): Will load Electronic Nav Chart data from US4MI1OF.000
2024-07-19T02:50:34.291Z,1721357434.291 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4MI1NF.000
2024-07-19T02:50:34.304Z,1721357434.304 [NavChartDb](IMPORTANT): Will load Electronic Nav Chart data from US4MI1NF.000
2024-07-19T02:50:34.304Z,1721357434.304 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4MI1MF.000
2024-07-19T02:50:34.306Z,1721357434.306 [NavChartDb](IMPORTANT): Will load Electronic Nav Chart data from US4MI1MF.000
2024-07-19T02:50:34.306Z,1721357434.306 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5MI61M.000
2024-07-19T02:50:34.308Z,1721357434.308 [CBIT](DEBUG): Backplane powered.
2024-07-19T02:50:34.309Z,1721357434.309 [MissionManager](IMPORTANT): Using TethysL tl-to-tx parser
2024-07-19T02:50:34.309Z,1721357434.309 [MissionManager](INFO): Loading Mission from file: Missions/Startup.tl
2024-07-19T02:50:34.310Z,1721357434.310 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Startup.tl
2024-07-19T02:50:34.313Z,1721357434.313 [NavChartDb](IMPORTANT): Will load Electronic Nav Chart data from US5MI61M.000
2024-07-19T02:50:34.313Z,1721357434.313 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4MI1NG.000
2024-07-19T02:50:34.316Z,1721357434.316 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Startup.tl
2024-07-19T02:50:34.332Z,1721357434.332 [NavChartDb](IMPORTANT): Will load Electronic Nav Chart data from US4MI1NG.000
2024-07-19T02:50:34.378Z,1721357434.378 [MissionManager](DEBUG): TethyslAPI: Missions/Startup.tl translated into:
2024-07-19T02:50:34.383Z,1721357434.383 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2024-07-19T02:50:34.384Z,1721357434.384 [NavChartDb](INFO): Setup scan of Resources/ElectronicNavigationCharts/US5MI61M.000
2024-07-19T02:50:34.418Z,1721357434.418 [MissionManager](DEBUG):
# Copyright (c) 2024 MBARI
# MBARI Proprietary Information. Confidential. All Rights Reserved
# Unauthorized copying or distribution of this file via any medium is strictly
# prohibited.
#
# WARNING - This file contains information whose export is restricted by the
# Export Administration Act of 1979 (Title 50, U.S.C., App. 2401 et seq.), as
# amended. Violations of these export laws are subject to severe civil and/or
# criminal penalties.
mission Startup {
behavior Guidance:GoToSurface {
run in progression
}
aggregate StartupSatComms {
run in sequence
readDatum {
timeout duration=P1M
Universal:latitude_fix
}
readDatum {
timeout duration=P1M
Universal:platform_communications
}
}
}
2024-07-19T02:50:34.419Z,1721357434.419 [MissionManager](INFO): Loading Mission from file: Missions/Default.tl
2024-07-19T02:50:34.419Z,1721357434.419 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Default.tl
2024-07-19T02:50:34.454Z,1721357434.454 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Default.tl
2024-07-19T02:50:34.628Z,1721357434.628 [Radio_Surface](INFO): Powering up
2024-07-19T02:50:34.728Z,1721357434.728 [MissionManager](DEBUG): TethyslAPI: Missions/Default.tl translated into:
0
13
Burn on
Dropped weight due to communications timeout.
5
Default mission has been running for
Restarting logs and Default mission.
restart logs
2024-07-19T02:50:34.734Z,1721357434.734 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2024-07-19T02:50:34.735Z,1721357434.735 [Default:A.Wait](DEBUG): Construct Wait.
2024-07-19T02:50:34.749Z,1721357434.749 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2024-07-19T02:50:34.786Z,1721357434.786 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2024-07-19T02:50:34.789Z,1721357434.789 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2024-07-19T02:50:34.795Z,1721357434.795 [Default:E.Execute](DEBUG): Construct Execute.
2024-07-19T02:50:34.818Z,1721357434.818 [MissionManager](DEBUG):
# Copyright (c) 2024 MBARI
# MBARI Proprietary Information. Confidential. All Rights Reserved
# Unauthorized copying or distribution of this file via any medium is strictly
# prohibited.
#
# WARNING - This file contains information whose export is restricted by the
# Export Administration Act of 1979 (Title 50, U.S.C., App. 2401 et seq.), as
# amended. Violations of these export laws are subject to severe civil and/or
# criminal penalties.
mission Default {
arguments {
ElapsedSinceDefaultStarted = 0 minute
}
behavior Guidance:Wait {
"""
Wait a moment to see if the scheduler starts a new mission before
starting to actually run Default.
"""
run in sequence
set duration = 13 second
}
behavior Guidance:GoToSurface {
run in progression
}
aggregate CheckIn {
run in sequence repeat=288
readDatum id="Read_GPS" {
timeout duration=P5M
Universal:time_fix
}
readDatum id="Read_Iridium" {
timeout duration=P4H {
behavior Guidance:Execute {
run in sequence
set command = "Burn on"
}
syslog critical "Dropped weight due to communications timeout."
}
Universal:platform_communications
}
behavior Guidance:Wait {
run in sequence
set duration = 5 minute
}
assign in sequence ElapsedSinceDefaultStarted = elapsed ( Universal:mission_started )
syslog important "Default mission has been running for " + ElapsedSinceDefaultStarted~minute
}
syslog important "Restarting logs and Default mission."
behavior Guidance:Execute {
run in sequence
set command = "restart logs"
}
}
2024-07-19T02:50:34.826Z,1721357434.826 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BioacousticsDataBridge,BPC1,Depth_Keller,DropWeight,NAL9602,Power24vConverter,Sonardyne_Nano,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter,
2024-07-19T02:50:34.849Z,1721357434.849 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2024-07-19T02:50:35.006Z,1721357435.006 [Power24vConverter](INFO): Powering up.
2024-07-19T02:50:35.007Z,1721357435.007 [Sonardyne_Nano](INFO): Initializing.
2024-07-19T02:50:35.064Z,1721357435.064 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2024-07-19T02:50:35.072Z,1721357435.072 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2024-07-19T02:50:35.073Z,1721357435.073 [ElevatorServo](DEBUG): Initializing EZServoServo.
2024-07-19T02:50:35.080Z,1721357435.080 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2024-07-19T02:50:35.081Z,1721357435.081 [MassServo](DEBUG): Initializing EZServoServo.
2024-07-19T02:50:35.088Z,1721357435.088 [MassServo](DEBUG): Initializing MassServo.
2024-07-19T02:50:35.089Z,1721357435.089 [RudderServo](DEBUG): Initializing EZServoServo.
2024-07-19T02:50:35.096Z,1721357435.096 [RudderServo](DEBUG): Initializing RudderServo.
2024-07-19T02:50:35.097Z,1721357435.097 [ThrusterHE](DEBUG): Initializing EZServoServo.
2024-07-19T02:50:35.104Z,1721357435.104 [ThrusterHE](DEBUG): Initializing ThrusterHE.
2024-07-19T02:50:36.356Z,1721357436.356 [WetLabsBB2FL](INFO): Powering down
2024-07-19T02:50:37.258Z,1721357437.258 [Sonardyne_Nano](ERROR): Failed to get valid response or reached max queue size, flushing UART
2024-07-19T02:50:38.497Z,1721357438.497 [Sonardyne_Nano](IMPORTANT): Found beacon with acoustic ID 2107
2024-07-19T02:50:40.762Z,1721357440.762 [ThrusterHE](ERROR): Zero Speed Commanded.
2024-07-19T02:50:44.369Z,1721357444.369 [NavChartDb](INFO): Done scanning features of Resources/ElectronicNavigationCharts/US5MI61M.000
2024-07-19T02:50:56.833Z,1721357456.833 [NavChartDb](INFO): # of records loaded: 5000
2024-07-19T02:51:02.729Z,1721357462.729 [NAL9602](INFO): Powering up NAL9602
2024-07-19T02:51:07.402Z,1721357467.402 [NavChartDb](INFO): # of records loaded: 10000
2024-07-19T02:51:13.642Z,1721357473.642 [NAL9602](INFO): NAL9602 initialized
2024-07-19T02:51:17.599Z,1721357477.599 [NavChartDb](INFO): # of records loaded: 15000
2024-07-19T02:51:26.890Z,1721357486.890 [NavChartDb](INFO): # of records loaded: 20000
2024-07-19T02:51:36.150Z,1721357496.150 [NavChartDb](INFO): # of records loaded: 25000
2024-07-19T02:51:43.718Z,1721357503.718 [NavChartDb](INFO): # of records loaded: 30000
2024-07-19T02:51:50.663Z,1721357510.663 [NavChartDb](INFO): # of records loaded: 35000
2024-07-19T02:51:59.386Z,1721357519.386 [NavChartDb](INFO): # of records loaded: 40000
2024-07-19T02:52:06.661Z,1721357526.661 [NavChartDb](INFO): # of records loaded: 45000
2024-07-19T02:52:14.098Z,1721357534.098 [NavChartDb](INFO): # of records loaded: 50000
2024-07-19T02:52:21.935Z,1721357541.935 [NavChartDb](INFO): # of records loaded: 55000
2024-07-19T02:52:24.774Z,1721357544.774 [SBIT](IMPORTANT): Beginning Startup BIT
2024-07-19T02:52:24.798Z,1721357544.798 [CBIT](IMPORTANT): Beginning ground fault scan
2024-07-19T02:52:29.803Z,1721357549.803 [NavChartDb](INFO): # of records loaded: 60000
2024-07-19T02:52:35.752Z,1721357555.752 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): -0.006876
CHAN A1 (24V): -0.006741
CHAN A2 (12V): -0.005008
CHAN A3 (5V): -0.002834
CHAN B0 (3.3V): -0.000899
CHAN B1 (3.15aV): -0.001085
CHAN B2 (3.15bV): -0.001284
CHAN B3 (GND): -0.000618
OPEN: -0.004861
Full Scale: +/- 1 mA
2024-07-19T02:52:38.353Z,1721357558.353 [NavChartDb](INFO): # of records loaded: 65000
2024-07-19T02:52:46.270Z,1721357566.270 [NavChartDb](INFO): # of records loaded: 70000
2024-07-19T02:52:53.839Z,1721357573.839 [NavChartDb](INFO): # of records loaded: 75000
2024-07-19T02:53:01.830Z,1721357581.830 [NavChartDb](INFO): # of records loaded: 80000
2024-07-19T02:53:10.090Z,1721357590.090 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-07-19T02:53:11.181Z,1721357591.181 [NavChartDb](INFO): # of records loaded: 85000
2024-07-19T02:53:18.563Z,1721357598.563 [SBIT](IMPORTANT): SBIT PASSED
2024-07-19T02:53:18.563Z,1721357598.563 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2024-07-19T02:53:18.572Z,1721357598.572 [SBIT](IMPORTANT): BPC1.batteryMissingStickThreshold=8 count;
2024-07-19T02:53:18.572Z,1721357598.572 [SBIT](IMPORTANT): CTD_Seabird.minSalinityBound=0 practical_salinity_unit;
2024-07-19T02:53:18.572Z,1721357598.572 [SBIT](IMPORTANT): DAT.loadAtStartup=0 bool;
2024-07-19T02:53:18.572Z,1721357598.572 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=250 cubic_centimeter;
2024-07-19T02:53:18.572Z,1721357598.572 [SBIT](IMPORTANT): VerticalControl.massDefault=2.25 centimeter;
2024-07-19T02:53:18.930Z,1721357598.930 [MissionManager](IMPORTANT): Started mission Startup
2024-07-19T02:53:18.930Z,1721357598.930 [Startup] Running Loop=1
2024-07-19T02:53:18.930Z,1721357598.930 [Startup](DEBUG): Aggregate::initialize Startup
2024-07-19T02:53:18.930Z,1721357598.930 [Startup:A.GoToSurface] Running Loop=1
2024-07-19T02:53:18.930Z,1721357598.930 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2024-07-19T02:53:18.931Z,1721357598.931 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2024-07-19T02:53:18.931Z,1721357598.931 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2024-07-19T02:53:18.931Z,1721357598.931 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2024-07-19T02:53:18.932Z,1721357598.932 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2024-07-19T02:53:18.932Z,1721357598.932 [Startup:A.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds.
2024-07-19T02:53:18.932Z,1721357598.932 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2024-07-19T02:53:18.934Z,1721357598.934 [Startup:StartupSatComms] Running Loop=1
2024-07-19T02:53:18.934Z,1721357598.934 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2024-07-19T02:53:18.934Z,1721357598.934 [Startup:StartupSatComms:A] Running Loop=1
2024-07-19T02:53:19.170Z,1721357599.170 [NavChartDb](INFO): # of records loaded: 90000
2024-07-19T02:53:19.319Z,1721357599.319 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2024-07-19T02:53:26.751Z,1721357606.751 [NavChartDb](INFO): # of records loaded: 95000
2024-07-19T02:53:34.276Z,1721357614.276 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2024-07-19T02:53:34.276Z,1721357614.276 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-07-19T02:53:34.291Z,1721357614.291 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-07-19T02:53:34.686Z,1721357614.686 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-07-19T02:53:34.686Z,1721357614.686 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2024-07-19T02:53:34.997Z,1721357614.997 [NavChartDb](INFO): # of records loaded: 100000
2024-07-19T02:53:39.553Z,1721357619.553 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-07-19T02:53:42.818Z,1721357622.818 [NavChartDb](INFO): # of records loaded: 105000
2024-07-19T02:53:47.162Z,1721357627.162 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2024-07-19T02:53:51.329Z,1721357631.329 [NavChartDb](INFO): # of records loaded: 110000
2024-07-19T02:54:04.612Z,1721357644.612 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2024-07-19T02:54:04.898Z,1721357644.898 [NavChartDb](INFO): # of records loaded: 115000
2024-07-19T02:54:16.293Z,1721357656.293 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.002975
2024-07-19T02:54:16.999Z,1721357656.999 [CommandExec](IMPORTANT): got command get latitude
2024-07-19T02:54:16.999Z,1721357656.999 [CommandExec](FAULT): Element has no value
2024-07-19T02:54:17.427Z,1721357657.427 [NavChartDb](INFO): # of records loaded: 120000
2024-07-19T02:54:19.219Z,1721357659.219 [Startup:StartupSatComms:A](INFO): Timed out from 2024-07-19T02:53:18.9Z
2024-07-19T02:54:19.219Z,1721357659.219 [Startup:StartupSatComms:A] Stopped
2024-07-19T02:54:19.220Z,1721357659.220 [Startup:StartupSatComms:B] Running Loop=1
2024-07-19T02:54:19.587Z,1721357659.587 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2024-07-19T02:54:21.261Z,1721357661.261 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2024-07-19T02:54:24.610Z,1721357664.610 [CommandExec](IMPORTANT): got command ibit
2024-07-19T02:54:24.967Z,1721357664.967 [IBIT](IMPORTANT): Beginning Initiated BIT
2024-07-19T02:54:24.967Z,1721357664.967 [IBIT](IMPORTANT): Beginning control surface checks.
2024-07-19T02:54:24.979Z,1721357664.979 [CBIT](IMPORTANT): Beginning ground fault scan
2024-07-19T02:54:28.043Z,1721357668.043 [NavChartDb](INFO): Calculating coverage of Resources/ElectronicNavigationCharts/US5MI61M.000
2024-07-19T02:54:31.556Z,1721357671.556 [NavChartDb](INFO): # of records loaded: 125000
2024-07-19T02:54:35.963Z,1721357675.963 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): -0.003287
CHAN A1 (24V): -0.007083
CHAN A2 (12V): -0.004280
CHAN A3 (5V): -0.002015
CHAN B0 (3.3V): -0.001154
CHAN B1 (3.15aV): -0.001376
CHAN B2 (3.15bV): -0.001234
CHAN B3 (GND): -0.000004
OPEN: 0.003513
Full Scale: +/- 1 mA
2024-07-19T02:54:38.160Z,1721357678.160 [DataOverHttps](INFO): Sending 18 bytes from file Logs/20240719T023040/Courier0007.lzma
2024-07-19T02:54:38.246Z,1721357678.246 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2024-07-19T02:54:39.162Z,1721357679.162 [DataOverHttps](INFO): Moved sent file to Logs/20240719T023040/Courier0007.lzma.bak
2024-07-19T02:54:39.163Z,1721357679.163 [DataOverHttps](INFO): SBD MOMSN=21368791
2024-07-19T02:54:52.224Z,1721357692.224 [NavChartDb](INFO): # of records loaded: 130000
2024-07-19T02:54:54.915Z,1721357694.915 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2024-07-19T02:55:11.841Z,1721357711.841 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2024-07-19T02:55:20.042Z,1721357720.042 [DataOverHttps](INFO): Sending 234 bytes from file Logs/20240719T024437/Courier0000.lzma
2024-07-19T02:55:20.819Z,1721357720.819 [NavChartDb](INFO): # of records loaded: 135000
2024-07-19T02:55:21.026Z,1721357721.026 [DataOverHttps](INFO): Moved sent file to Logs/20240719T024437/Courier0000.lzma.bak
2024-07-19T02:55:21.026Z,1721357721.026 [DataOverHttps](INFO): SBD MOMSN=21368793
2024-07-19T02:55:28.406Z,1721357728.406 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2024-07-19T02:55:37.945Z,1721357737.945 [NavChartDb](INFO): # of records loaded: 140000
2024-07-19T02:55:44.624Z,1721357744.624 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-07-19T02:55:51.429Z,1721357751.429 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20240719T024437/Courier0004.lzma
2024-07-19T02:55:52.430Z,1721357752.430 [DataOverHttps](INFO): Moved sent file to Logs/20240719T024437/Courier0004.lzma.bak
2024-07-19T02:55:52.430Z,1721357752.430 [DataOverHttps](INFO): SBD MOMSN=21368798
2024-07-19T02:55:53.413Z,1721357753.413 [NavChartDb](INFO): # of records loaded: 145000
2024-07-19T02:56:08.285Z,1721357768.285 [NavChartDb](INFO): # of records loaded: 150000
2024-07-19T02:56:16.197Z,1721357776.197 [IBIT](FAULT): Error acquiring IBIT communications status. Timeout expired.
2024-07-19T02:56:16.530Z,1721357776.530 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2024-07-19T02:56:16.611Z,1721357776.611 [IBIT](FAULT): Warning: Battery Data not active. Expected only when running primaries. Threshold checking not active.
2024-07-19T02:56:17.213Z,1721357777.213 [IBIT](IMPORTANT): bitHumidityThreshold: 55.000000 %
2024-07-19T02:56:17.213Z,1721357777.213 [IBIT](IMPORTANT): bitPressureThreshold: 0.750000 psi
2024-07-19T02:56:17.214Z,1721357777.214 [IBIT](IMPORTANT): Pressure:10.267482 PSI
2024-07-19T02:56:17.214Z,1721357777.214 [IBIT](IMPORTANT): Humidity:17.275059 %
2024-07-19T02:56:17.509Z,1721357777.509 [IBIT](IMPORTANT): Vehicle Pitch:-2.844372 degrees
2024-07-19T02:56:17.509Z,1721357777.509 [IBIT](IMPORTANT): Vehicle Roll:-6.148314 degrees
2024-07-19T02:56:17.510Z,1721357777.510 [IBIT](IMPORTANT): Vehicle Heading:283.860901 degrees
2024-07-19T02:56:17.804Z,1721357777.804 [IBIT](IMPORTANT): surfaceThreshold: 1.000000 m
2024-07-19T02:56:17.804Z,1721357777.804 [IBIT](IMPORTANT): buoyancyNeutral: 250.000015 cc
2024-07-19T02:56:17.844Z,1721357777.844 [IBIT](IMPORTANT): massDefault: 2.250000 cm
2024-07-19T02:56:17.845Z,1721357777.845 [IBIT](IMPORTANT): stopDepth: 275.000000 m
2024-07-19T02:56:17.845Z,1721357777.845 [IBIT](IMPORTANT): abortDepth: 300.000000 m
2024-07-19T02:56:17.845Z,1721357777.845 [IBIT](IMPORTANT): IBIT FAILED
2024-07-19T02:56:18.182Z,1721357778.182 [Startup:StartupSatComms:B](INFO): Timed out from 2024-07-19T02:54:19.2Z
2024-07-19T02:56:18.182Z,1721357778.182 [Startup:StartupSatComms:B] Stopped
2024-07-19T02:56:18.182Z,1721357778.182 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2024-07-19T02:56:18.182Z,1721357778.182 [Startup:StartupSatComms] Stopped
2024-07-19T02:56:18.182Z,1721357778.182 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2024-07-19T02:56:18.183Z,1721357778.183 [Startup](INFO): Completed Startup
2024-07-19T02:56:18.183Z,1721357778.183 [MissionManager](INFO): Startup is completed.
2024-07-19T02:56:18.183Z,1721357778.183 [MissionManager](INFO): Uninitializing Mission Startup
2024-07-19T02:56:18.183Z,1721357778.183 [Startup] Stopped
2024-07-19T02:56:18.184Z,1721357778.184 [Startup](DEBUG): Aggregate::uninitialize Startup
2024-07-19T02:56:18.184Z,1721357778.184 [Startup:A.GoToSurface] Stopped
2024-07-19T02:56:18.184Z,1721357778.184 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2024-07-19T02:56:18.570Z,1721357778.570 [MissionManager](IMPORTANT): Started mission Default
2024-07-19T02:56:18.570Z,1721357778.570 [Default] Running Loop=1
2024-07-19T02:56:18.570Z,1721357778.570 [Default](DEBUG): Aggregate::initialize Default
2024-07-19T02:56:18.570Z,1721357778.570 [Default:B.GoToSurface] Running Loop=1
2024-07-19T02:56:18.570Z,1721357778.570 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2024-07-19T02:56:18.571Z,1721357778.571 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2024-07-19T02:56:18.571Z,1721357778.571 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2024-07-19T02:56:18.571Z,1721357778.571 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2024-07-19T02:56:18.572Z,1721357778.572 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2024-07-19T02:56:18.572Z,1721357778.572 [Default:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds.
2024-07-19T02:56:18.584Z,1721357778.584 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2024-07-19T02:56:18.585Z,1721357778.585 [Default:A.Wait] Running Loop=1
2024-07-19T02:56:18.585Z,1721357778.585 [Default:A.Wait](DEBUG): Initialize Wait Component.
2024-07-19T02:56:21.392Z,1721357781.392 [DataOverHttps](INFO): Sending 152 bytes from file Logs/20240719T025022/Courier0000.lzma
2024-07-19T02:56:22.394Z,1721357782.394 [DataOverHttps](INFO): Moved sent file to Logs/20240719T025022/Courier0000.lzma.bak
2024-07-19T02:56:22.394Z,1721357782.394 [DataOverHttps](INFO): SBD MOMSN=21368800
2024-07-19T02:56:24.174Z,1721357784.174 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2024-07-19T02:56:28.547Z,1721357788.547 [NavChartDb](INFO): # of records loaded: 155000
2024-07-19T02:56:31.887Z,1721357791.887 [Default:A.Wait](INFO): Done Waiting.
2024-07-19T02:56:31.888Z,1721357791.888 [Default:A.Wait] Stopped
2024-07-19T02:56:31.888Z,1721357791.888 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2024-07-19T02:56:32.315Z,1721357792.315 [Default:CheckIn] Running Loop=1
2024-07-19T02:56:32.315Z,1721357792.315 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-07-19T02:56:32.315Z,1721357792.315 [Default:CheckIn:Read_GPS] Running Loop=1
2024-07-19T02:56:32.695Z,1721357792.695 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2024-07-19T02:56:35.108Z,1721357795.108 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2
2024-07-19T02:56:35.109Z,1721357795.109 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-07-19T02:56:35.119Z,1721357795.119 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-07-19T02:56:35.582Z,1721357795.582 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-07-19T02:56:35.582Z,1721357795.582 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2
2024-07-19T02:56:38.721Z,1721357798.721 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2024-07-19T02:56:47.584Z,1721357807.584 [NavChartDb](INFO): Done scanning edges of Resources/ElectronicNavigationCharts/US5MI61M.000
2024-07-19T02:56:48.912Z,1721357808.912 [NavChartDb](INFO): # of records loaded: 160000
2024-07-19T02:56:53.332Z,1721357813.332 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-07-19T02:57:02.565Z,1721357822.565 [CommandExec](IMPORTANT): got command ibit
2024-07-19T02:57:02.661Z,1721357822.661 [IBIT](IMPORTANT): Beginning Initiated BIT
2024-07-19T02:57:02.661Z,1721357822.661 [IBIT](IMPORTANT): Beginning control surface checks.
2024-07-19T02:57:02.664Z,1721357822.664 [CBIT](IMPORTANT): Beginning ground fault scan
2024-07-19T02:57:05.557Z,1721357825.557 [NavChartDb](INFO): # of records loaded: 165000
2024-07-19T02:57:08.373Z,1721357828.373 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2024-07-19T02:57:14.068Z,1721357834.068 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): -0.004231
CHAN A1 (24V): -0.006775
CHAN A2 (12V): -0.004761
CHAN A3 (5V): -0.003317
CHAN B0 (3.3V): -0.000963
CHAN B1 (3.15aV): -0.001528
CHAN B2 (3.15bV): -0.000847
CHAN B3 (GND): 0.000146
OPEN: 0.003151
Full Scale: +/- 1 mA
2024-07-19T02:57:24.114Z,1721357844.114 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2024-07-19T02:57:27.839Z,1721357847.839 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-07-19T02:57:39.869Z,1721357859.869 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2024-07-19T02:57:42.138Z,1721357862.138 [NavChartDb](INFO): # of records loaded: 170000
2024-07-19T02:57:43.362Z,1721357863.362 [NavChartDb](INFO): Done scanning nodes of Resources/ElectronicNavigationCharts/US5MI61M.000
2024-07-19T02:57:43.383Z,1721357863.383 [NavChartDb](INFO): # of records loaded: 170330
2024-07-19T02:57:43.395Z,1721357863.395 [NavChartDb](IMPORTANT): Loaded Electronic Nav Chart data from US5MI61M.000
2024-07-19T02:57:43.426Z,1721357863.426 [NavChartDb](INFO): Setup scan of Resources/ElectronicNavigationCharts/US4MI1NG.000
2024-07-19T02:57:43.549Z,1721357863.549 [NavChartDb](INFO): Done scanning features of Resources/ElectronicNavigationCharts/US4MI1NG.000
2024-07-19T02:57:43.645Z,1721357863.645 [NavChartDb](INFO): Calculating coverage of Resources/ElectronicNavigationCharts/US4MI1NG.000
2024-07-19T02:57:43.656Z,1721357863.656 [NavChartDb](INFO): Done scanning edges of Resources/ElectronicNavigationCharts/US4MI1NG.000
2024-07-19T02:57:44.142Z,1721357864.142 [NavChartDb](INFO): Done scanning nodes of Resources/ElectronicNavigationCharts/US4MI1NG.000
2024-07-19T02:57:44.173Z,1721357864.173 [NavChartDb](INFO): # of records loaded: 313
2024-07-19T02:57:44.175Z,1721357864.175 [NavChartDb](IMPORTANT): Loaded Electronic Nav Chart data from US4MI1NG.000
2024-07-19T02:57:44.245Z,1721357864.245 [NavChartDb](INFO): Setup scan of Resources/ElectronicNavigationCharts/US4MI1MF.000
2024-07-19T02:57:44.489Z,1721357864.489 [NavChartDb](INFO): Done scanning features of Resources/ElectronicNavigationCharts/US4MI1MF.000
2024-07-19T02:57:50.942Z,1721357870.942 [NavChartDb](INFO): Calculating coverage of Resources/ElectronicNavigationCharts/US4MI1MF.000
2024-07-19T02:57:51.714Z,1721357871.714 [NavChartDb](INFO): Done scanning edges of Resources/ElectronicNavigationCharts/US4MI1MF.000
2024-07-19T02:57:52.268Z,1721357872.268 [NavChartDb](INFO): Done scanning nodes of Resources/ElectronicNavigationCharts/US4MI1MF.000
2024-07-19T02:57:52.303Z,1721357872.303 [NavChartDb](INFO): # of records loaded: 4559
2024-07-19T02:57:52.305Z,1721357872.305 [NavChartDb](IMPORTANT): Loaded Electronic Nav Chart data from US4MI1MF.000
2024-07-19T02:57:52.345Z,1721357872.345 [NavChartDb](INFO): Setup scan of Resources/ElectronicNavigationCharts/US4MI1NF.000
2024-07-19T02:57:52.594Z,1721357872.594 [NavChartDb](INFO): Done scanning features of Resources/ElectronicNavigationCharts/US4MI1NF.000
2024-07-19T02:57:54.818Z,1721357874.818 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2024-07-19T02:57:56.357Z,1721357876.357 [NavChartDb](INFO): Calculating coverage of Resources/ElectronicNavigationCharts/US4MI1NF.000
2024-07-19T02:57:59.137Z,1721357879.137 [NavChartDb](INFO): Done scanning edges of Resources/ElectronicNavigationCharts/US4MI1NF.000
2024-07-19T02:58:00.459Z,1721357880.459 [NavChartDb](INFO): Done scanning nodes of Resources/ElectronicNavigationCharts/US4MI1NF.000
2024-07-19T02:58:00.577Z,1721357880.577 [NavChartDb](INFO): # of records loaded: 4667
2024-07-19T02:58:00.579Z,1721357880.579 [NavChartDb](IMPORTANT): Loaded Electronic Nav Chart data from US4MI1NF.000
2024-07-19T02:58:00.653Z,1721357880.653 [NavChartDb](INFO): Setup scan of Resources/ElectronicNavigationCharts/US4MI1OF.000
2024-07-19T02:58:02.883Z,1721357882.883 [NavChartDb](INFO): Done scanning features of Resources/ElectronicNavigationCharts/US4MI1OF.000
2024-07-19T02:58:05.461Z,1721357885.461 [CommandExec](IMPORTANT): got command get latitude
2024-07-19T02:58:05.461Z,1721357885.461 [CommandExec](FAULT): Element has no value
2024-07-19T02:58:09.233Z,1721357889.233 [CommandExec](IMPORTANT): got command ibit
2024-07-19T02:58:10.169Z,1721357890.169 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2024-07-19T02:58:10.388Z,1721357890.388 [NavChartDb](INFO): # of records loaded: 5000
2024-07-19T02:58:22.977Z,1721357902.977 [NavChartDb](INFO): # of records loaded: 10000
2024-07-19T02:58:25.232Z,1721357905.232 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-07-19T02:58:37.765Z,1721357917.765 [NavChartDb](INFO): # of records loaded: 15000
2024-07-19T02:58:39.673Z,1721357919.673 [BPC1](ERROR): BPC1A got IPBS message with 5 sticks (min is 7).
2024-07-19T02:58:43.013Z,1721357923.013 [NavChartDb](INFO): # of records loaded: 20000
2024-07-19T02:58:46.135Z,1721357926.135 [BPC1](ERROR): BPC1A got IPBS message with 5 sticks (min is 7).
2024-07-19T02:58:46.141Z,1721357926.141 [BPC1](INFO): Calculating totals. Valid battery stick count: 51. Valid reserve battery stick count: 5.
2024-07-19T02:58:46.145Z,1721357926.145 [BPC1](INFO): Received data from all battery sticks.
2024-07-19T02:58:47.730Z,1721357927.730 [NavChartDb](INFO): # of records loaded: 25000
2024-07-19T02:58:53.222Z,1721357933.222 [NavChartDb](INFO): # of records loaded: 30000
2024-07-19T02:58:53.470Z,1721357933.470 [IBIT](FAULT): Error acquiring IBIT communications status. Timeout expired.
2024-07-19T02:58:53.851Z,1721357933.851 [IBIT](IMPORTANT): Battery Status:
Battery Charge (AH): 0.000000
Voltage: 16.215000
2024-07-19T02:58:53.851Z,1721357933.851 [IBIT](IMPORTANT): batteryCapacityThreshold: 50.000000 Ah
2024-07-19T02:58:53.851Z,1721357933.851 [IBIT](IMPORTANT): batteryVoltageThreshold: 13.700000 V
2024-07-19T02:58:54.273Z,1721357934.273 [IBIT](IMPORTANT): bitHumidityThreshold: 55.000000 %
2024-07-19T02:58:54.274Z,1721357934.274 [IBIT](IMPORTANT): bitPressureThreshold: 0.750000 psi
2024-07-19T02:58:54.274Z,1721357934.274 [IBIT](IMPORTANT): Pressure:10.288651 PSI
2024-07-19T02:58:54.274Z,1721357934.274 [IBIT](IMPORTANT): Humidity:17.275059 %
2024-07-19T02:58:54.677Z,1721357934.677 [IBIT](IMPORTANT): Vehicle Pitch:-2.849344 degrees
2024-07-19T02:58:54.678Z,1721357934.678 [IBIT](IMPORTANT): Vehicle Roll:-6.156486 degrees
2024-07-19T02:58:54.678Z,1721357934.678 [IBIT](IMPORTANT): Vehicle Heading:283.811340 degrees
2024-07-19T02:58:55.066Z,1721357935.066 [IBIT](IMPORTANT): surfaceThreshold: 1.000000 m
2024-07-19T02:58:55.066Z,1721357935.066 [IBIT](IMPORTANT): buoyancyNeutral: 250.000015 cc
2024-07-19T02:58:55.066Z,1721357935.066 [IBIT](IMPORTANT): massDefault: 2.250000 cm
2024-07-19T02:58:55.067Z,1721357935.067 [IBIT](IMPORTANT): stopDepth: 275.000000 m
2024-07-19T02:58:55.067Z,1721357935.067 [IBIT](IMPORTANT): abortDepth: 300.000000 m
2024-07-19T02:58:55.067Z,1721357935.067 [IBIT](IMPORTANT): IBIT FAILED
2024-07-19T02:58:58.869Z,1721357938.869 [NavChartDb](INFO): # of records loaded: 35000
2024-07-19T02:58:58.986Z,1721357938.986 [NavChartDb](INFO): Calculating coverage of Resources/ElectronicNavigationCharts/US4MI1OF.000
2024-07-19T02:59:07.419Z,1721357947.419 [NavChartDb](INFO): Done scanning edges of Resources/ElectronicNavigationCharts/US4MI1OF.000
2024-07-19T02:59:09.726Z,1721357949.726 [NavChartDb](INFO): # of records loaded: 40000
2024-07-19T02:59:14.637Z,1721357954.637 [CommandExec](IMPORTANT): got command ibit
2024-07-19T02:59:14.885Z,1721357954.885 [IBIT](IMPORTANT): Beginning Initiated BIT
2024-07-19T02:59:14.885Z,1721357954.885 [IBIT](IMPORTANT): Beginning control surface checks.
2024-07-19T02:59:14.888Z,1721357954.888 [CBIT](IMPORTANT): Beginning ground fault scan
2024-07-19T02:59:15.595Z,1721357955.595 [NavChartDb](INFO): Done scanning nodes of Resources/ElectronicNavigationCharts/US4MI1OF.000
2024-07-19T02:59:15.626Z,1721357955.626 [NavChartDb](INFO): # of records loaded: 42018
2024-07-19T02:59:15.691Z,1721357955.691 [NavChartDb](IMPORTANT): Loaded Electronic Nav Chart data from US4MI1OF.000
2024-07-19T02:59:15.700Z,1721357955.700 [NavChartDb](INFO): Setup scan of Resources/ElectronicNavigationCharts/US4MI51M.000
2024-07-19T02:59:18.138Z,1721357958.138 [NavChartDb](INFO): Done scanning features of Resources/ElectronicNavigationCharts/US4MI51M.000
2024-07-19T02:59:25.830Z,1721357965.830 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): -0.007166
CHAN A1 (24V): -0.007237
CHAN A2 (12V): -0.004372
CHAN A3 (5V): -0.001956
CHAN B0 (3.3V): -0.001040
CHAN B1 (3.15aV): -0.001456
CHAN B2 (3.15bV): -0.000884
CHAN B3 (GND): -0.000945
OPEN: 0.003416
Full Scale: +/- 1 mA
2024-07-19T02:59:28.707Z,1721357968.707 [NavChartDb](INFO): # of records loaded: 5000
2024-07-19T02:59:36.289Z,1721357976.289 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3
2024-07-19T02:59:36.289Z,1721357976.289 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-07-19T02:59:36.367Z,1721357976.367 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-07-19T02:59:36.761Z,1721357976.761 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-07-19T02:59:36.761Z,1721357976.761 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3
2024-07-19T02:59:38.737Z,1721357978.737 [NavChartDb](INFO): # of records loaded: 10000
2024-07-19T02:59:46.558Z,1721357986.558 [NavChartDb](INFO): # of records loaded: 15000
2024-07-19T02:59:54.682Z,1721357994.682 [NavChartDb](INFO): # of records loaded: 20000
2024-07-19T03:00:05.680Z,1721358005.680 [NavChartDb](INFO): # of records loaded: 25000
2024-07-19T03:00:13.800Z,1721358013.800 [NavChartDb](INFO): # of records loaded: 30000
2024-07-19T03:00:18.544Z,1721358018.544 [NavChartDb](INFO): Calculating coverage of Resources/ElectronicNavigationCharts/US4MI51M.000
2024-07-19T03:00:22.279Z,1721358022.279 [NavChartDb](INFO): # of records loaded: 35000
2024-07-19T03:00:29.447Z,1721358029.447 [NavChartDb](INFO): Done scanning edges of Resources/ElectronicNavigationCharts/US4MI51M.000
2024-07-19T03:00:35.666Z,1721358035.666 [Power24vConverter](INFO): Powering down.
2024-07-19T03:00:38.905Z,1721358038.905 [NavChartDb](INFO): # of records loaded: 40000
2024-07-19T03:00:43.985Z,1721358043.985 [NavChartDb](INFO): Done scanning nodes of Resources/ElectronicNavigationCharts/US4MI51M.000
2024-07-19T03:00:44.311Z,1721358044.311 [NavChartDb](INFO): # of records loaded: 40792
2024-07-19T03:00:44.324Z,1721358044.324 [NavChartDb](IMPORTANT): Loaded Electronic Nav Chart data from US4MI51M.000
2024-07-19T03:00:44.333Z,1721358044.333 [NavChartDb](INFO): Setup scan of Resources/ElectronicNavigationCharts/US4MI1OD.000
2024-07-19T03:00:45.101Z,1721358045.101 [NavChartDb](INFO): Done scanning features of Resources/ElectronicNavigationCharts/US4MI1OD.000
2024-07-19T03:00:55.296Z,1721358055.296 [NavChartDb](INFO): # of records loaded: 5000
2024-07-19T03:01:05.996Z,1721358065.996 [IBIT](FAULT): Error acquiring IBIT communications status. Timeout expired.
2024-07-19T03:01:06.138Z,1721358066.138 [NavChartDb](INFO): Calculating coverage of Resources/ElectronicNavigationCharts/US4MI1OD.000
2024-07-19T03:01:06.419Z,1721358066.419 [IBIT](IMPORTANT): Battery Status:
Battery Charge (AH): 0.000000
Voltage: 16.215000
2024-07-19T03:01:06.420Z,1721358066.420 [IBIT](IMPORTANT): batteryCapacityThreshold: 50.000000 Ah
2024-07-19T03:01:06.420Z,1721358066.420 [IBIT](IMPORTANT): batteryVoltageThreshold: 13.700000 V
2024-07-19T03:01:06.872Z,1721358066.872 [IBIT](IMPORTANT): bitHumidityThreshold: 55.000000 %
2024-07-19T03:01:06.872Z,1721358066.872 [IBIT](IMPORTANT): bitPressureThreshold: 0.750000 psi
2024-07-19T03:01:06.872Z,1721358066.872 [IBIT](IMPORTANT): Pressure:10.326873 PSI
2024-07-19T03:01:06.873Z,1721358066.873 [IBIT](IMPORTANT): Humidity:17.275059 %
2024-07-19T03:01:07.232Z,1721358067.232 [IBIT](IMPORTANT): Vehicle Pitch:-2.847900 degrees
2024-07-19T03:01:07.232Z,1721358067.232 [IBIT](IMPORTANT): Vehicle Roll:-6.153784 degrees
2024-07-19T03:01:07.241Z,1721358067.241 [IBIT](IMPORTANT): Vehicle Heading:283.822540 degrees
2024-07-19T03:01:07.622Z,1721358067.622 [IBIT](IMPORTANT): surfaceThreshold: 1.000000 m
2024-07-19T03:01:07.622Z,1721358067.622 [IBIT](IMPORTANT): buoyancyNeutral: 250.000015 cc
2024-07-19T03:01:07.623Z,1721358067.623 [IBIT](IMPORTANT): massDefault: 2.250000 cm
2024-07-19T03:01:07.623Z,1721358067.623 [IBIT](IMPORTANT): stopDepth: 275.000000 m
2024-07-19T03:01:07.623Z,1721358067.623 [IBIT](IMPORTANT): abortDepth: 300.000000 m
2024-07-19T03:01:07.623Z,1721358067.623 [IBIT](IMPORTANT): IBIT FAILED
2024-07-19T03:01:07.771Z,1721358067.771 [NavChartDb](INFO): Done scanning edges of Resources/ElectronicNavigationCharts/US4MI1OD.000
2024-07-19T03:01:09.173Z,1721358069.173 [NavChartDb](INFO): Done scanning nodes of Resources/ElectronicNavigationCharts/US4MI1OD.000
2024-07-19T03:01:09.284Z,1721358069.284 [NavChartDb](INFO): # of records loaded: 9682
2024-07-19T03:01:09.286Z,1721358069.286 [NavChartDb](IMPORTANT): Loaded Electronic Nav Chart data from US4MI1OD.000
2024-07-19T03:01:09.287Z,1721358069.287 [NavChartDb](INFO): Setup scan of Resources/ElectronicNavigationCharts/US4MI1ND.000
2024-07-19T03:01:10.503Z,1721358070.503 [NavChartDb](INFO): Done scanning features of Resources/ElectronicNavigationCharts/US4MI1ND.000
2024-07-19T03:01:16.478Z,1721358076.478 [NAL9602](FAULT): GPS failed to acquire within timeout.
2024-07-19T03:01:16.478Z,1721358076.478 [NAL9602] Data Fault, FailCount= 1
2024-07-19T03:01:16.478Z,1721358076.478 [NAL9602](ERROR): Data Fault
2024-07-19T03:01:16.502Z,1721358076.502 [CBIT](ERROR): Data Fault in component: NAL9602
2024-07-19T03:01:16.882Z,1721358076.882 [NAL9602](INFO): Powering down
2024-07-19T03:01:17.756Z,1721358077.756 [CBIT](INFO): Clearing failed state for component NAL9602
2024-07-19T03:01:17.756Z,1721358077.756 [NAL9602] No Fault, FailCount= 1
2024-07-19T03:01:21.857Z,1721358081.857 [NavChartDb](INFO): # of records loaded: 5000
2024-07-19T03:01:29.155Z,1721358089.155 [NavChartDb](INFO): # of records loaded: 10000
2024-07-19T03:01:32.686Z,1721358092.686 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-07-19T02:56:32.3Z
2024-07-19T03:01:32.686Z,1721358092.686 [Default:CheckIn:Read_GPS] Stopped
2024-07-19T03:01:32.686Z,1721358092.686 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-07-19T03:01:33.078Z,1721358093.078 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications
2024-07-19T03:01:39.667Z,1721358099.667 [NavChartDb](INFO): Calculating coverage of Resources/ElectronicNavigationCharts/US4MI1ND.000
2024-07-19T03:01:39.685Z,1721358099.685 [NavChartDb](INFO): # of records loaded: 15000
2024-07-19T03:01:47.266Z,1721358107.266 [NAL9602](INFO): Powering up NAL9602
2024-07-19T03:01:47.420Z,1721358107.420 [DataOverHttps](INFO): Sending 168 bytes from file Logs/20240719T025022/Courier0004.lzma
2024-07-19T03:01:48.422Z,1721358108.422 [DataOverHttps](INFO): Moved sent file to Logs/20240719T025022/Courier0004.lzma.bak
2024-07-19T03:01:48.422Z,1721358108.422 [DataOverHttps](INFO): SBD MOMSN=21368803
2024-07-19T03:01:49.662Z,1721358109.662 [NavChartDb](INFO): Done scanning edges of Resources/ElectronicNavigationCharts/US4MI1ND.000
2024-07-19T03:01:55.573Z,1721358115.573 [NavChartDb](INFO): Done scanning nodes of Resources/ElectronicNavigationCharts/US4MI1ND.000
2024-07-19T03:01:55.690Z,1721358115.690 [NavChartDb](INFO): # of records loaded: 19081
2024-07-19T03:01:55.693Z,1721358115.693 [NavChartDb](IMPORTANT): Loaded Electronic Nav Chart data from US4MI1ND.000
2024-07-19T03:01:55.725Z,1721358115.725 [NavChartDb](INFO): Setup scan of Resources/ElectronicNavigationCharts/US2MI60M.000
2024-07-19T03:01:58.182Z,1721358118.182 [NAL9602](INFO): NAL9602 initialized
2024-07-19T03:02:00.013Z,1721358120.013 [NavChartDb](INFO): Done scanning features of Resources/ElectronicNavigationCharts/US2MI60M.000
2024-07-19T03:02:12.971Z,1721358132.971 [NavChartDb](INFO): # of records loaded: 5000
2024-07-19T03:02:22.780Z,1721358142.780 [DataOverHttps](INFO): Sending 18 bytes from file Logs/20240719T023040/Express0008.lzma
2024-07-19T03:02:23.782Z,1721358143.782 [DataOverHttps](INFO): Moved sent file to Logs/20240719T023040/Express0008.lzma.bak
2024-07-19T03:02:23.783Z,1721358143.783 [DataOverHttps](INFO): SBD MOMSN=21368805
2024-07-19T03:02:37.432Z,1721358157.432 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4
2024-07-19T03:02:37.432Z,1721358157.432 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-07-19T03:02:37.513Z,1721358157.513 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-07-19T03:02:37.619Z,1721358157.619 [CommandExec](IMPORTANT): got command get Onboard.Pressure pound_per_square_inch
2024-07-19T03:02:37.620Z,1721358157.620 [CommandExec](IMPORTANT): Onboard.Pressure 10.279752 psi
2024-07-19T03:02:37.651Z,1721358157.651 [CommandExec](IMPORTANT): got command get Onboard.Temperature
2024-07-19T03:02:37.660Z,1721358157.660 [CommandExec](IMPORTANT): Onboard.Temperature 29.295557 degC
2024-07-19T03:02:37.661Z,1721358157.661 [CommandExec](IMPORTANT): got command get Onboard.Humidity
2024-07-19T03:02:37.661Z,1721358157.661 [CommandExec](IMPORTANT): Onboard.Humidity 17.275059 %
2024-07-19T03:02:37.866Z,1721358157.866 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-07-19T03:02:37.866Z,1721358157.866 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4
2024-07-19T03:02:40.133Z,1721358160.133 [NavChartDb](INFO): # of records loaded: 10000
2024-07-19T03:02:52.973Z,1721358172.973 [NavChartDb](INFO): # of records loaded: 15000
2024-07-19T03:03:03.058Z,1721358183.058 [NavChartDb](INFO): # of records loaded: 20000
2024-07-19T03:03:06.796Z,1721358186.796 [DataOverHttps](INFO): Sending 1241 bytes from file Logs/20240719T024437/Express0001.lzma
2024-07-19T03:03:07.774Z,1721358187.774 [DataOverHttps](INFO): Moved sent file to Logs/20240719T024437/Express0001.lzma.bak
2024-07-19T03:03:07.774Z,1721358187.774 [DataOverHttps](INFO): SBD MOMSN=21368807
2024-07-19T03:03:12.807Z,1721358192.807 [NavChartDb](INFO): # of records loaded: 25000
2024-07-19T03:03:18.673Z,1721358198.673 [CommandExec](IMPORTANT): got command ibit
2024-07-19T03:03:18.686Z,1721358198.686 [IBIT](IMPORTANT): Beginning Initiated BIT
2024-07-19T03:03:18.686Z,1721358198.686 [IBIT](IMPORTANT): Beginning control surface checks.
2024-07-19T03:03:18.698Z,1721358198.698 [CBIT](IMPORTANT): Beginning ground fault scan
2024-07-19T03:03:21.531Z,1721358201.531 [CBIT](ERROR): Error reading 24V bus power status. Assuming off for scan purposes.
2024-07-19T03:03:25.428Z,1721358205.428 [NavChartDb](INFO): # of records loaded: 30000
2024-07-19T03:03:29.598Z,1721358209.598 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): -0.003461
CHAN A1 (24V) N/A reporting off
CHAN A2 (12V): -0.005069
CHAN A3 (5V): -0.001824
CHAN B0 (3.3V): -0.000792
CHAN B1 (3.15aV): -0.001637
CHAN B2 (3.15bV): -0.000743
CHAN B3 (GND): -0.000282
OPEN: 0.003902
Full Scale: +/- 1 mA
2024-07-19T03:03:33.431Z,1721358213.431 [NavChartDb](INFO): # of records loaded: 35000
2024-07-19T03:03:43.101Z,1721358223.101 [DataOverHttps](INFO): Sending 114 bytes from file Logs/20240719T024437/Express0005.lzma
2024-07-19T03:03:43.482Z,1721358223.482 [NavChartDb](INFO): # of records loaded: 40000
2024-07-19T03:03:44.102Z,1721358224.102 [DataOverHttps](INFO): Moved sent file to Logs/20240719T024437/Express0005.lzma.bak
2024-07-19T03:03:44.102Z,1721358224.102 [DataOverHttps](INFO): SBD MOMSN=21368835
2024-07-19T03:03:51.999Z,1721358231.999 [NavChartDb](INFO): # of records loaded: 45000
2024-07-19T03:03:55.652Z,1721358235.652 [NavChartDb](INFO): Calculating coverage of Resources/ElectronicNavigationCharts/US2MI60M.000
2024-07-19T03:04:05.591Z,1721358245.591 [NavChartDb](INFO): # of records loaded: 50000
2024-07-19T03:04:14.958Z,1721358254.958 [CommandExec](IMPORTANT): got command get latitude
2024-07-19T03:04:14.958Z,1721358254.958 [CommandExec](FAULT): Element has no value
2024-07-19T03:04:17.954Z,1721358257.954 [NavChartDb](INFO): # of records loaded: 55000
2024-07-19T03:04:20.322Z,1721358260.322 [DataOverHttps](INFO): Sending 1027 bytes from file Logs/20240719T025022/Express0001.lzma
2024-07-19T03:04:21.322Z,1721358261.322 [DataOverHttps](INFO): Moved sent file to Logs/20240719T025022/Express0001.lzma.bak
2024-07-19T03:04:21.322Z,1721358261.322 [DataOverHttps](INFO): SBD MOMSN=21368839
2024-07-19T03:04:35.405Z,1721358275.405 [NavChartDb](INFO): # of records loaded: 60000
2024-07-19T03:04:43.557Z,1721358283.557 [NavChartDb](INFO): Done scanning edges of Resources/ElectronicNavigationCharts/US2MI60M.000
2024-07-19T03:04:43.646Z,1721358283.646 [NavChartDb](CRITICAL): SIGSEGV: address not mapped to object
2024-07-19T03:04:43.646Z,1721358283.646 [NavChartDb] Software Fault, FailCount= 1
2024-07-19T03:04:43.646Z,1721358283.646 [NavChartDb](ERROR): Software Fault
2024-07-19T03:04:43.927Z,1721358283.927 [CommandExec](FAULT): Scheduling is paused
2024-07-19T03:04:43.928Z,1721358283.928 [CBIT](INFO): Critical error at 20240719T030443
2024-07-19T03:04:43.928Z,1721358283.928 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals
2024-07-19T03:04:43.980Z,1721358283.980 [CBIT](ERROR): Software Fault in component: NavChartDb
2024-07-19T03:04:43.992Z,1721358283.992 [CBIT](CRITICAL): Software Fault in component: NavChartDb
2024-07-19T03:04:44.049Z,1721358284.049 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40C074E0
2024-07-19T03:04:44.049Z,1721358284.049 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 1061
2024-07-19T03:04:44.357Z,1721358284.357 [CBIT](INFO): Critical error at 20240719T030443
2024-07-19T03:04:53.934Z,1721358293.934 [DataOverHttps](INFO): Sending 1277 bytes from file Logs/20240719T025022/Express0005.lzma
2024-07-19T03:04:54.934Z,1721358294.934 [DataOverHttps](INFO): Moved sent file to Logs/20240719T025022/Express0005.lzma.bak
2024-07-19T03:04:54.934Z,1721358294.934 [DataOverHttps](INFO): SBD MOMSN=21368869
2024-07-19T03:05:04.035Z,1721358304.035 [CBIT](CRITICAL): Run-time exception #7
2024-07-19T03:05:04.035Z,1721358304.035 [CBIT] Software Fault, FailCount= 1
2024-07-19T03:05:04.035Z,1721358304.035 [CBIT](ERROR): Software Fault
2024-07-19T03:05:04.037Z,1721358304.037 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2024-07-19T03:05:04.038Z,1721358304.038 [SyncHandler](INFO): Protected caller Thread ID is 1083
2024-07-19T03:05:04.231Z,1721358304.231 [CBIT](DEBUG): Uninitialize CBIT Component.
2024-07-19T03:05:04.231Z,1721358304.231 [CBIT](DEBUG): Powering off loads.
2024-07-19T03:05:04.249Z,1721358304.249 [CBIT](DEBUG): Disabling WDT.
2024-07-19T03:05:04.273Z,1721358304.273 [CBIT](DEBUG): Opening all GF detection circuits.
2024-07-19T03:05:06.534Z,1721358306.534 [NAL9602](FAULT): LCB fault: Current Limiter Activated.
2024-07-19T03:05:06.534Z,1721358306.534 [NAL9602] Hardware Fault, FailCount= 2
2024-07-19T03:05:06.534Z,1721358306.534 [NAL9602](ERROR): Hardware Fault
2024-07-19T03:05:06.978Z,1721358306.978 [NAL9602](INFO): Powering down
2024-07-19T03:05:07.346Z,1721358307.346 [NAL9602](FAULT): LCB fault: Current Limiter Activated.
2024-07-19T03:05:09.791Z,1721358309.791 [IBIT](FAULT): Error acquiring IBIT communications status. Timeout expired.
2024-07-19T03:05:10.188Z,1721358310.188 [IBIT](IMPORTANT): Battery Status:
Battery Charge (AH): 0.000000
Voltage: 16.215000
2024-07-19T03:05:10.193Z,1721358310.193 [IBIT](IMPORTANT): batteryCapacityThreshold: 50.000000 Ah
2024-07-19T03:05:10.193Z,1721358310.193 [IBIT](IMPORTANT): batteryVoltageThreshold: 13.700000 V
2024-07-19T03:05:10.663Z,1721358310.663 [IBIT](IMPORTANT): bitHumidityThreshold: 55.000000 %
2024-07-19T03:05:10.663Z,1721358310.663 [IBIT](IMPORTANT): bitPressureThreshold: 0.750000 psi
2024-07-19T03:05:10.664Z,1721358310.664 [IBIT](IMPORTANT): Pressure:10.267482 PSI
2024-07-19T03:05:10.664Z,1721358310.664 [IBIT](IMPORTANT): Humidity:17.305580 %
2024-07-19T03:05:11.014Z,1721358311.014 [IBIT](IMPORTANT): Vehicle Pitch:-2.851732 degrees
2024-07-19T03:05:11.014Z,1721358311.014 [IBIT](IMPORTANT): Vehicle Roll:-6.141645 degrees
2024-07-19T03:05:11.014Z,1721358311.014 [IBIT](IMPORTANT): Vehicle Heading:283.796814 degrees
2024-07-19T03:05:11.428Z,1721358311.428 [IBIT](IMPORTANT): surfaceThreshold: 1.000000 m
2024-07-19T03:05:11.428Z,1721358311.428 [IBIT](IMPORTANT): buoyancyNeutral: 250.000015 cc
2024-07-19T03:05:11.437Z,1721358311.437 [IBIT](IMPORTANT): massDefault: 2.250000 cm
2024-07-19T03:05:11.437Z,1721358311.437 [IBIT](IMPORTANT): stopDepth: 275.000000 m
2024-07-19T03:05:11.438Z,1721358311.438 [IBIT](IMPORTANT): abortDepth: 300.000000 m
2024-07-19T03:05:11.438Z,1721358311.438 [IBIT](IMPORTANT): IBIT FAILED
2024-07-19T03:05:11.806Z,1721358311.806 [Default:CheckIn:Read_Iridium] Stopped
2024-07-19T03:05:11.806Z,1721358311.806 [Default:CheckIn:C.Wait] Running Loop=1
2024-07-19T03:05:11.806Z,1721358311.806 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-07-19T03:05:15.012Z,1721358315.012 [AHRS_M2](FAULT): Failed to acquire valid data within timeout.
2024-07-19T03:05:15.012Z,1721358315.012 [AHRS_M2] Data Fault, FailCount= 1
2024-07-19T03:05:15.012Z,1721358315.012 [AHRS_M2](ERROR): Data Fault
2024-07-19T03:05:15.414Z,1721358315.414 [AHRS_M2](INFO): Powering down
2024-07-19T03:05:38.453Z,1721358338.453 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 5
2024-07-19T03:05:38.453Z,1721358338.453 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-07-19T03:05:55.489Z,1721358355.489 [DataOverHttps](INFO): setting unavailable, lastComms_.elapsed()=60.555431
2024-07-19T03:06:37.681Z,1721358397.681 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2024-07-19T03:07:12.821Z,1721358432.821 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2024-07-19T03:07:47.961Z,1721358467.961 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2024-07-19T03:08:23.125Z,1721358503.125 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2024-07-19T03:08:35.624Z,1721358515.624 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.002680
2024-07-19T03:09:48.193Z,1721358588.193 [CommandExec](IMPORTANT): got command failComponent
2024-07-19T03:09:48.193Z,1721358588.193 [CommandExec](IMPORTANT): Failed components:
2024-07-19T03:09:48.193Z,1721358588.193 [CommandExec](IMPORTANT): DeadReckonUsingMultipleVelocitySources: Software Fault
2024-07-19T03:09:48.194Z,1721358588.194 [CommandExec](IMPORTANT): AHRS_M2: Data Fault
2024-07-19T03:09:48.194Z,1721358588.194 [CommandExec](IMPORTANT): NAL9602: Hardware Fault
2024-07-19T03:09:48.194Z,1721358588.194 [CommandExec](IMPORTANT): CBIT: Software Fault
2024-07-19T03:09:48.194Z,1721358588.194 [CommandExec](IMPORTANT): NavChartDb: Software Fault
2024-07-19T03:10:12.377Z,1721358612.377 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-07-19T03:10:12.377Z,1721358612.377 [Default:CheckIn:C.Wait] Stopped
2024-07-19T03:10:12.377Z,1721358612.377 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-07-19T03:10:12.377Z,1721358612.377 [Default:CheckIn:D] Running Loop=1
2024-07-19T03:10:12.789Z,1721358612.789 [Default:CheckIn:D] Stopped
2024-07-19T03:10:12.789Z,1721358612.789 [Default:CheckIn:E] Running Loop=1
2024-07-19T03:10:13.214Z,1721358613.214 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 13.903643 min
2024-07-19T03:10:13.214Z,1721358613.214 [Default:CheckIn:E] Stopped
2024-07-19T03:10:13.214Z,1721358613.214 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-07-19T03:10:13.214Z,1721358613.214 [Default:CheckIn] Stopped
2024-07-19T03:10:13.214Z,1721358613.214 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-07-19T03:10:13.214Z,1721358613.214 [Default:CheckIn](INFO): Running loop #2
2024-07-19T03:10:13.214Z,1721358613.214 [Default:CheckIn] Running Loop=2
2024-07-19T03:10:13.214Z,1721358613.214 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-07-19T03:10:13.215Z,1721358613.215 [Default:CheckIn:Read_GPS] Running Loop=1
2024-07-19T03:10:36.758Z,1721358636.758 [CommandExec](IMPORTANT): got command restart system
2024-07-19T03:10:38.813Z,1721358638.813 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread.
2024-07-19T03:10:38.813Z,1721358638.813 [CommandExec](INFO): Uninitializing the command executive.
2024-07-19T03:10:38.813Z,1721358638.813 [CommandExec](INFO): Uninitializing the command scheduler.
2024-07-19T03:10:38.813Z,1721358638.813 [CommandExec ThreadHandler](INFO): Thread cancelled.
2024-07-19T03:10:39.009Z,1721358639.009 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye!
2024-07-19T03:10:39.009Z,1721358639.009 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2024-07-19T03:10:39.009Z,1721358639.009 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2024-07-19T03:10:39.010Z,1721358639.010 [NavChartDb](INFO): Join timeout helper Thread ID is 3047
2024-07-19T03:10:39.364Z,1721358639.364 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2024-07-19T03:10:39.365Z,1721358639.365 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2024-07-19T03:10:39.380Z,1721358639.380 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2024-07-19T03:10:39.381Z,1721358639.381 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2024-07-19T03:10:39.381Z,1721358639.381 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 3049
2024-07-19T03:10:39.733Z,1721358639.733 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread.
2024-07-19T03:10:39.733Z,1721358639.733 [WetLabsBB2FL](INFO): Powering down
2024-07-19T03:10:39.734Z,1721358639.734 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2024-07-19T03:10:39.736Z,1721358639.736 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler
2024-07-19T03:10:39.736Z,1721358639.736 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2024-07-19T03:10:39.737Z,1721358639.737 [CTD_Seabird](INFO): Join timeout helper Thread ID is 3052
2024-07-19T03:10:39.885Z,1721358639.885 [CTD_Seabird](INFO): Powering down
2024-07-19T03:10:39.896Z,1721358639.896 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread.
2024-07-19T03:10:39.897Z,1721358639.897 [CTD_Seabird](INFO): Powering down
2024-07-19T03:10:39.908Z,1721358639.908 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2024-07-19T03:10:39.928Z,1721358639.928 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2024-07-19T03:10:39.929Z,1721358639.929 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2024-07-19T03:10:39.929Z,1721358639.929 [Radio_Surface](INFO): Join timeout helper Thread ID is 3055
2024-07-19T03:10:40.008Z,1721358640.008 [Radio_Surface](INFO): Powering down
2024-07-19T03:10:40.009Z,1721358640.009 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2024-07-19T03:10:40.010Z,1721358640.010 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2024-07-19T03:10:40.020Z,1721358640.020 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler
2024-07-19T03:10:40.020Z,1721358640.020 [Onboard ThreadHandler](INFO): Thread cancelled.
2024-07-19T03:10:40.021Z,1721358640.021 [Onboard](INFO): Join timeout helper Thread ID is 3056
2024-07-19T03:10:40.457Z,1721358640.457 [DataOverHttps](INFO): Radio surface powered OFF, will not connect.
2024-07-19T03:10:40.737Z,1721358640.737 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread.
2024-07-19T03:10:40.737Z,1721358640.737 [Onboard ThreadHandler](INFO): Thread cancelled.
2024-07-19T03:10:40.753Z,1721358640.753 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler
2024-07-19T03:10:40.753Z,1721358640.753 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2024-07-19T03:10:40.754Z,1721358640.754 [DataOverHttps](INFO): Join timeout helper Thread ID is 3061
2024-07-19T03:10:41.460Z,1721358641.460 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread.
2024-07-19T03:10:41.461Z,1721358641.461 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2024-07-19T03:10:41.465Z,1721358641.465 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler
2024-07-19T03:10:41.465Z,1721358641.465 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2024-07-19T03:10:41.466Z,1721358641.466 [BackseatComponent](INFO): Join timeout helper Thread ID is 3066
2024-07-19T03:10:41.473Z,1721358641.473 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread.
2024-07-19T03:10:41.473Z,1721358641.473 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2024-07-19T03:10:41.481Z,1721358641.481 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2024-07-19T03:10:41.481Z,1721358641.481 [logger ThreadHandler](INFO): Thread cancelled.
2024-07-19T03:10:41.482Z,1721358641.482 [logger](INFO): Join timeout helper Thread ID is 3068
2024-07-19T03:10:41.484Z,1721358641.484 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2024-07-19T03:10:41.485Z,1721358641.485 [logger ThreadHandler](INFO): Thread cancelled.
2024-07-19T03:10:41.495Z,1721358641.495 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2024-07-19T03:10:41.495Z,1721358641.495 [CommandLine ThreadHandler](INFO): Thread cancelled.
2024-07-19T03:10:41.496Z,1721358641.496 [CommandLine](INFO): Join timeout helper Thread ID is 3069
2024-07-19T03:10:41.573Z,1721358641.573 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2024-07-19T03:10:41.573Z,1721358641.573 [CommandLine ThreadHandler](INFO): Thread cancelled.
2024-07-19T03:10:41.589Z,1721358641.589 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler
2024-07-19T03:10:41.589Z,1721358641.589 [CommandExec ThreadHandler](INFO): Thread cancelled.
2024-07-19T03:10:41.590Z,1721358641.590 [CommandExec](INFO): Join timeout helper Thread ID is 3071
2024-07-19T03:10:41.591Z,1721358641.591 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2024-07-19T03:10:41.591Z,1721358641.591 [controlThread ThreadHandler](INFO): Thread cancelled.
2024-07-19T03:10:41.591Z,1721358641.591 [controlThread](INFO): Join timeout helper Thread ID is 3072
2024-07-19T03:10:41.853Z,1721358641.853 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2024-07-19T03:10:41.853Z,1721358641.853 [controlThread](DEBUG): Uninitializing ControlThread
2024-07-19T03:10:41.853Z,1721358641.853 [AHRS_M2](INFO): Powering down
2024-07-19T03:10:41.855Z,1721358641.855 [NAL9602](INFO): Powering down
2024-07-19T03:10:41.856Z,1721358641.856 [Sonardyne_Nano](INFO): Powering down
2024-07-19T03:10:41.977Z,1721358641.977 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2024-07-19T03:10:41.978Z,1721358641.978 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2024-07-19T03:10:41.978Z,1721358641.978 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2024-07-19T03:10:41.979Z,1721358641.979 [MissionManager](INFO): Uninitializing Mission Default
2024-07-19T03:10:41.979Z,1721358641.979 [Default] Stopped
2024-07-19T03:10:41.979Z,1721358641.979 [Default](DEBUG): Aggregate::uninitialize Default
2024-07-19T03:10:41.979Z,1721358641.979 [Default:B.GoToSurface] Stopped
2024-07-19T03:10:41.979Z,1721358641.979 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2024-07-19T03:10:41.979Z,1721358641.979 [Default:CheckIn] Stopped
2024-07-19T03:10:41.980Z,1721358641.980 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-07-19T03:10:41.980Z,1721358641.980 [Default:CheckIn:Read_GPS] Stopped
2024-07-19T03:10:41.983Z,1721358641.983 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2024-07-19T03:10:41.983Z,1721358641.983 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2024-07-19T03:10:41.983Z,1721358641.983 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2024-07-19T03:10:41.984Z,1721358641.984 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2024-07-19T03:10:41.984Z,1721358641.984 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2024-07-19T03:10:41.984Z,1721358641.984 [BuoyancyServo](INFO): Powering down
2024-07-19T03:10:41.996Z,1721358641.996 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2024-07-19T03:10:41.997Z,1721358641.997 [ElevatorServo](INFO): Powering down
2024-07-19T03:10:41.998Z,1721358641.998 [MassServo](DEBUG): Uninitialize Mass Servo.
2024-07-19T03:10:41.998Z,1721358641.998 [MassServo](INFO): Powering down
2024-07-19T03:10:41.999Z,1721358641.999 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2024-07-19T03:10:41.999Z,1721358641.999 [RudderServo](INFO): Powering down
2024-07-19T03:10:41.000Z,1721358642.000 [ThrusterHE](DEBUG): Uninitialize Thruster Servo.
2024-07-19T03:10:41.000Z,1721358642.000 [ThrusterHE](INFO): Powering down
2024-07-19T03:10:42.001Z,1721358642.001 [SBIT](DEBUG): Uninitialize SBIT Component.
2024-07-19T03:10:42.001Z,1721358642.001 [IBIT](DEBUG): Uninitialize IBIT Component.
2024-07-19T03:10:42.001Z,1721358642.001 [CBIT](DEBUG): Uninitialize CBIT Component.
2024-07-19T03:10:42.002Z,1721358642.002 [CBIT](DEBUG): Powering off loads.
2024-07-19T03:10:42.012Z,1721358642.012 [CBIT](DEBUG): Disabling WDT.
2024-07-19T03:10:42.024Z,1721358642.024 [CBIT](DEBUG): Opening all GF detection circuits.
2024-07-19T03:10:42.025Z,1721358642.025 [controlThread ThreadHandler](INFO): Thread cancelled.
2024-07-19T03:10:42.085Z,1721358642.085 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2024-07-19T03:10:42.088Z,1721358642.088 [Onboard ThreadHandler](INFO): Thread cancelled.
2024-07-19T03:10:42.095Z,1721358642.095 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2024-07-19T03:10:42.141Z,1721358642.141 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2024-07-19T03:10:42.212Z,1721358642.212 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2024-07-19T03:10:42.226Z,1721358642.226 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2024-07-19T03:10:42.261Z,1721358642.261 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2024-07-19T03:10:42.310Z,1721358642.310 [logger ThreadHandler](INFO): Thread cancelled.