2024-07-19T01:20:55.532Z,1721352055.532 [Supervisor](DEBUG): Initializing supervisor.
2024-07-19T01:20:55.537Z,1721352055.537 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2024-07-19T01:20:55.537Z,1721352055.537 [SyncHandler](INFO): Protected caller Thread ID is 1076
2024-07-19T01:20:55.538Z,1721352055.538 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2024-07-19T01:20:55.539Z,1721352055.539 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2024-07-19T01:20:55.539Z,1721352055.539 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 1077
2024-07-19T01:20:55.543Z,1721352055.543 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2024-07-19T01:20:55.561Z,1721352055.561 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread.
2024-07-19T01:20:55.562Z,1721352055.562 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2024-07-19T01:20:55.562Z,1721352055.562 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 1078
2024-07-19T01:20:55.567Z,1721352055.567 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2024-07-19T01:20:55.568Z,1721352055.568 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2024-07-19T01:20:55.568Z,1721352055.568 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 1079
2024-07-19T01:20:55.570Z,1721352055.570 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2024-07-19T01:20:55.571Z,1721352055.571 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0
2024-07-19T01:20:55.571Z,1721352055.571 [logger ThreadHandler](INFO): Protected caller Thread ID is 1080
2024-07-19T01:20:55.575Z,1721352055.575 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2024-07-19T01:20:55.575Z,1721352055.575 [Supervisor](INFO): Looking for Config files in directory: Config/
2024-07-19T01:20:55.577Z,1721352055.577 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2024-07-19T01:20:56.094Z,1721352056.094 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2024-07-19T01:20:56.095Z,1721352056.095 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2024-07-19T01:20:56.335Z,1721352056.335 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2024-07-19T01:20:56.336Z,1721352056.336 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2024-07-19T01:20:56.431Z,1721352056.431 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg
2024-07-19T01:20:56.698Z,1721352056.698 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock
2024-07-19T01:20:56.698Z,1721352056.698 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2024-07-19T01:20:56.790Z,1721352056.790 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2024-07-19T01:20:56.900Z,1721352056.900 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2024-07-19T01:20:56.900Z,1721352056.900 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2024-07-19T01:20:57.281Z,1721352057.281 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2024-07-19T01:20:57.282Z,1721352057.282 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2024-07-19T01:20:57.432Z,1721352057.432 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2024-07-19T01:20:57.433Z,1721352057.433 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2024-07-19T01:20:58.020Z,1721352058.020 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2024-07-19T01:20:58.021Z,1721352058.021 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2024-07-19T01:20:58.236Z,1721352058.236 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2024-07-19T01:20:58.237Z,1721352058.237 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2024-07-19T01:20:58.688Z,1721352058.688 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2024-07-19T01:20:58.688Z,1721352058.688 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2024-07-19T01:20:59.010Z,1721352059.010 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2024-07-19T01:20:59.011Z,1721352059.011 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2024-07-19T01:20:59.135Z,1721352059.135 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2024-07-19T01:20:59.136Z,1721352059.136 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2024-07-19T01:21:00.114Z,1721352060.114 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2024-07-19T01:21:00.114Z,1721352060.114 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2024-07-19T01:21:00.721Z,1721352060.721 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2024-07-19T01:21:00.721Z,1721352060.721 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2024-07-19T01:21:00.977Z,1721352060.977 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2024-07-19T01:21:00.979Z,1721352060.979 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-triton/
2024-07-19T01:21:00.980Z,1721352060.980 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/vehicle.cfg
2024-07-19T01:21:01.115Z,1721352061.115 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/secure.cfg
2024-07-19T01:21:01.211Z,1721352061.211 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Science.cfg
2024-07-19T01:21:01.367Z,1721352061.367 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Simulator.cfg
2024-07-19T01:21:01.466Z,1721352061.466 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Battery.cfg
2024-07-19T01:21:01.780Z,1721352061.780 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2024-07-19T01:21:01.781Z,1721352061.781 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/logger.cfg
2024-07-19T01:21:01.901Z,1721352061.901 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Servo.cfg
2024-07-19T01:21:02.024Z,1721352062.024 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Navigation.cfg
2024-07-19T01:21:02.147Z,1721352062.147 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Sensor.cfg
2024-07-19T01:21:02.316Z,1721352062.316 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Control.cfg
2024-07-19T01:21:02.428Z,1721352062.428 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/BIT.cfg
2024-07-19T01:21:02.527Z,1721352062.527 [Supervisor](IMPORTANT): Reloading configuration overrides from Data/persisted.cfg
2024-07-19T01:21:02.534Z,1721352062.534 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2024-07-19T01:21:02.545Z,1721352062.545 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2024-07-19T01:21:02.545Z,1721352062.545 [Module Loader](DEBUG): Loading Module at Modules/Dock.so
2024-07-19T01:21:02.662Z,1721352062.662 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking)
2024-07-19T01:21:02.662Z,1721352062.662 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2024-07-19T01:21:02.717Z,1721352062.717 [VerticalControl](DEBUG): Construct VerticalControl.
2024-07-19T01:21:02.779Z,1721352062.779 [VerticalControl] Loaded
2024-07-19T01:21:02.779Z,1721352062.779 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2024-07-19T01:21:02.782Z,1721352062.782 [HorizontalControl](DEBUG): Construct HorizontalControl.
2024-07-19T01:21:02.832Z,1721352062.832 [HorizontalControl] Loaded
2024-07-19T01:21:02.832Z,1721352062.832 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2024-07-19T01:21:02.834Z,1721352062.834 [SpeedControl](DEBUG): Construct SpeedControl.
2024-07-19T01:21:02.837Z,1721352062.837 [SpeedControl] Loaded
2024-07-19T01:21:02.838Z,1721352062.838 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2024-07-19T01:21:02.840Z,1721352062.840 [LoopControl](DEBUG): Construct LoopControl.
2024-07-19T01:21:02.841Z,1721352062.841 [LoopControl] Loaded
2024-07-19T01:21:02.841Z,1721352062.841 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2024-07-19T01:21:02.842Z,1721352062.842 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2024-07-19T01:21:02.842Z,1721352062.842 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2024-07-19T01:21:03.002Z,1721352063.002 [BuoyancyServo] Loaded
2024-07-19T01:21:03.002Z,1721352063.002 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2024-07-19T01:21:03.024Z,1721352063.024 [ElevatorServo] Loaded
2024-07-19T01:21:03.025Z,1721352063.025 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2024-07-19T01:21:03.046Z,1721352063.046 [MassServo] Loaded
2024-07-19T01:21:03.046Z,1721352063.046 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2024-07-19T01:21:03.067Z,1721352063.067 [RudderServo] Loaded
2024-07-19T01:21:03.067Z,1721352063.067 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2024-07-19T01:21:03.084Z,1721352063.084 [ThrusterHE] Loaded
2024-07-19T01:21:03.085Z,1721352063.085 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread.
2024-07-19T01:21:03.085Z,1721352063.085 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2024-07-19T01:21:03.086Z,1721352063.086 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2024-07-19T01:21:03.138Z,1721352063.138 [DepthRateCalculator] Loaded
2024-07-19T01:21:03.138Z,1721352063.138 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2024-07-19T01:21:03.143Z,1721352063.143 [PitchRateCalculator] Loaded
2024-07-19T01:21:03.143Z,1721352063.143 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2024-07-19T01:21:03.153Z,1721352063.153 [SpeedCalculator] Loaded
2024-07-19T01:21:03.153Z,1721352063.153 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2024-07-19T01:21:03.158Z,1721352063.158 [YawRateCalculator] Loaded
2024-07-19T01:21:03.158Z,1721352063.158 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2024-07-19T01:21:03.177Z,1721352063.177 [ElevatorOffsetCalculator] Loaded
2024-07-19T01:21:03.177Z,1721352063.177 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2024-07-19T01:21:03.178Z,1721352063.178 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2024-07-19T01:21:03.178Z,1721352063.178 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2024-07-19T01:21:03.293Z,1721352063.293 [DeadReckonUsingMultipleVelocitySources] Loaded
2024-07-19T01:21:03.293Z,1721352063.293 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2024-07-19T01:21:03.307Z,1721352063.307 [NavChart] Loaded
2024-07-19T01:21:03.307Z,1721352063.307 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2024-07-19T01:21:03.313Z,1721352063.313 [UniversalFixResidualReporter] Loaded
2024-07-19T01:21:03.314Z,1721352063.314 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2024-07-19T01:21:03.314Z,1721352063.314 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2024-07-19T01:21:03.315Z,1721352063.315 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2024-07-19T01:21:03.764Z,1721352063.764 [AHRS_M2] Loaded
2024-07-19T01:21:03.764Z,1721352063.764 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread.
2024-07-19T01:21:03.804Z,1721352063.804 [BackseatComponent] Loaded
2024-07-19T01:21:03.805Z,1721352063.805 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread.
2024-07-19T01:21:03.806Z,1721352063.806 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 4090B4E0
2024-07-19T01:21:03.806Z,1721352063.806 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 1162
2024-07-19T01:21:03.809Z,1721352063.809 [LcmUniversalReporter] Loaded
2024-07-19T01:21:03.809Z,1721352063.809 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread.
2024-07-19T01:21:03.816Z,1721352063.816 [BioacousticsDataBridge] Loaded
2024-07-19T01:21:03.816Z,1721352063.816 [ComponentRegistry](DEBUG): SyncComponent "BioacousticsDataBridge" handled in the control thread.
2024-07-19T01:21:04.662Z,1721352064.662 [BPC1] Loaded
2024-07-19T01:21:04.662Z,1721352064.662 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2024-07-19T01:21:04.734Z,1721352064.734 [DataOverHttps] Loaded
2024-07-19T01:21:04.734Z,1721352064.734 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2024-07-19T01:21:04.735Z,1721352064.735 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 4093B4E0
2024-07-19T01:21:04.735Z,1721352064.735 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 1163
2024-07-19T01:21:04.759Z,1721352064.759 [Depth_Keller] Loaded
2024-07-19T01:21:04.759Z,1721352064.759 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2024-07-19T01:21:04.765Z,1721352064.765 [DropWeight] Loaded
2024-07-19T01:21:04.765Z,1721352064.765 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2024-07-19T01:21:04.831Z,1721352064.831 [NAL9602] Loaded
2024-07-19T01:21:04.831Z,1721352064.831 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2024-07-19T01:21:04.861Z,1721352064.861 [Onboard] Loaded
2024-07-19T01:21:04.861Z,1721352064.861 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread.
2024-07-19T01:21:04.863Z,1721352064.863 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 4096B4E0
2024-07-19T01:21:04.863Z,1721352064.863 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 1164
2024-07-19T01:21:04.878Z,1721352064.878 [Power24vConverter] Loaded
2024-07-19T01:21:04.878Z,1721352064.878 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread.
2024-07-19T01:21:04.894Z,1721352064.894 [Radio_Surface] Loaded
2024-07-19T01:21:04.894Z,1721352064.894 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2024-07-19T01:21:04.895Z,1721352064.895 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 4099B4E0
2024-07-19T01:21:04.896Z,1721352064.896 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 1165
2024-07-19T01:21:04.911Z,1721352064.911 [Sonardyne_Nano] Loaded
2024-07-19T01:21:04.911Z,1721352064.911 [ComponentRegistry](DEBUG): SyncComponent "Sonardyne_Nano" handled in the control thread.
2024-07-19T01:21:04.912Z,1721352064.912 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2024-07-19T01:21:04.913Z,1721352064.913 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2024-07-19T01:21:04.970Z,1721352064.970 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2024-07-19T01:21:04.971Z,1721352064.971 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2024-07-19T01:21:05.150Z,1721352065.150 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2024-07-19T01:21:05.151Z,1721352065.151 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2024-07-19T01:21:05.237Z,1721352065.237 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2024-07-19T01:21:05.237Z,1721352065.237 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2024-07-19T01:21:05.492Z,1721352065.492 [CTD_Seabird] Loaded
2024-07-19T01:21:05.492Z,1721352065.492 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread.
2024-07-19T01:21:05.493Z,1721352065.493 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40ADB4E0
2024-07-19T01:21:05.493Z,1721352065.493 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 1166
2024-07-19T01:21:05.516Z,1721352065.516 [PAR_Licor] Loaded
2024-07-19T01:21:05.516Z,1721352065.516 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2024-07-19T01:21:05.563Z,1721352065.563 [WetLabsBB2FL] Loaded
2024-07-19T01:21:05.563Z,1721352065.563 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2024-07-19T01:21:05.564Z,1721352065.564 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40B0B4E0
2024-07-19T01:21:05.565Z,1721352065.565 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 1167
2024-07-19T01:21:05.566Z,1721352065.566 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2024-07-19T01:21:05.566Z,1721352065.566 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2024-07-19T01:21:06.125Z,1721352066.125 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2024-07-19T01:21:06.126Z,1721352066.126 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2024-07-19T01:21:06.275Z,1721352066.275 [SBIT](DEBUG): Construct Startup Built In Test.
2024-07-19T01:21:06.284Z,1721352066.284 [SBIT] Loaded
2024-07-19T01:21:06.284Z,1721352066.284 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2024-07-19T01:21:06.287Z,1721352066.287 [IBIT](DEBUG): Construct Initiated Built In Test.
2024-07-19T01:21:06.300Z,1721352066.300 [IBIT] Loaded
2024-07-19T01:21:06.301Z,1721352066.301 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2024-07-19T01:21:06.307Z,1721352066.307 [CBIT](DEBUG): Construct Continuous Built In Test.
2024-07-19T01:21:06.414Z,1721352066.414 [CBIT] Loaded
2024-07-19T01:21:06.414Z,1721352066.414 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2024-07-19T01:21:06.415Z,1721352066.415 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2024-07-19T01:21:06.421Z,1721352066.421 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2024-07-19T01:21:06.424Z,1721352066.424 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2024-07-19T01:21:06.436Z,1721352066.436 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2024-07-19T01:21:06.437Z,1721352066.437 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40C074E0
2024-07-19T01:21:06.437Z,1721352066.437 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 1168
2024-07-19T01:21:06.442Z,1721352066.442 [Supervisor](INFO): Main Thread ID is 830
2024-07-19T01:21:06.442Z,1721352066.442 [Supervisor](DEBUG): Running supervisor.
2024-07-19T01:21:06.442Z,1721352066.442 [CommandExec ThreadHandler](INFO): Handler Thread ID is 1169
2024-07-19T01:21:06.443Z,1721352066.443 [CommandExec](INFO): Initializing the command executive.
2024-07-19T01:21:06.444Z,1721352066.444 [CommandLine ThreadHandler](INFO): Handler Thread ID is 1170
2024-07-19T01:21:06.446Z,1721352066.446 [controlThread ThreadHandler](INFO): Handler Thread ID is 1171
2024-07-19T01:21:06.447Z,1721352066.447 [controlThread](DEBUG): Initializing ControlThread
2024-07-19T01:21:06.448Z,1721352066.448 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2024-07-19T01:21:06.449Z,1721352066.449 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2024-07-19T01:21:06.450Z,1721352066.450 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2024-07-19T01:21:06.451Z,1721352066.451 [LoopControl](DEBUG): Initialize LoopControlComponent.
2024-07-19T01:21:06.452Z,1721352066.452 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2024-07-19T01:21:06.452Z,1721352066.452 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2024-07-19T01:21:06.453Z,1721352066.453 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2024-07-19T01:21:06.453Z,1721352066.453 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2024-07-19T01:21:06.453Z,1721352066.453 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2024-07-19T01:21:06.454Z,1721352066.454 [NavChart](DEBUG): Initialize NavChart Navigation.
2024-07-19T01:21:06.455Z,1721352066.455 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2024-07-19T01:21:06.462Z,1721352066.462 [SBIT](INFO): Initialize SBIT Component.
2024-07-19T01:21:06.463Z,1721352066.463 [SBIT](IMPORTANT): git: 2024-07-18
2024-07-19T01:21:06.463Z,1721352066.463 [SBIT](INFO): git hash: e777c895b2d7d743d45b75a88845e2c8d3f60819
2024-07-19T01:21:06.463Z,1721352066.463 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2024-07-19T01:21:06.464Z,1721352066.464 [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-19T01:21:06.465Z,1721352066.465 [SBIT](INFO): Beginning SBIT in 110.000000 seconds.
2024-07-19T01:21:06.466Z,1721352066.466 [IBIT](INFO): Initialize IBIT Component.
2024-07-19T01:21:06.467Z,1721352066.467 [CBIT](DEBUG): Initialize CBIT Component.
2024-07-19T01:21:06.468Z,1721352066.468 [logger ThreadHandler](INFO): Handler Thread ID is 1172
2024-07-19T01:21:06.478Z,1721352066.478 [CBIT](DEBUG): Initialized mux pins.
2024-07-19T01:21:06.478Z,1721352066.478 [CBIT](DEBUG): Initializing the watchdog timer.
2024-07-19T01:21:06.486Z,1721352066.486 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 1173
2024-07-19T01:21:06.498Z,1721352066.498 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 1174
2024-07-19T01:21:06.500Z,1721352066.500 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2024-07-19T01:21:06.509Z,1721352066.509 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2024-07-19T01:21:06.511Z,1721352066.511 [Onboard ThreadHandler](INFO): Handler Thread ID is 1175
2024-07-19T01:21:06.534Z,1721352066.534 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 1176
2024-07-19T01:21:06.548Z,1721352066.548 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 1177
2024-07-19T01:21:06.549Z,1721352066.549 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 1179
2024-07-19T01:21:06.559Z,1721352066.559 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2024-07-19T01:21:06.564Z,1721352066.564 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 1178
2024-07-19T01:21:06.566Z,1721352066.566 [WetLabsBB2FL](INFO): Powering up
2024-07-19T01:21:06.938Z,1721352066.938 [Radio_Surface](INFO): Powering up
2024-07-19T01:21:07.118Z,1721352067.118 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2MI60M.000
2024-07-19T01:21:07.120Z,1721352067.120 [NavChartDb](IMPORTANT): Will load Electronic Nav Chart data from US2MI60M.000
2024-07-19T01:21:07.120Z,1721352067.120 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4MI1ND.000
2024-07-19T01:21:07.121Z,1721352067.121 [NavChartDb](IMPORTANT): Will load Electronic Nav Chart data from US4MI1ND.000
2024-07-19T01:21:07.122Z,1721352067.122 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4MI1OD.000
2024-07-19T01:21:07.123Z,1721352067.123 [NavChartDb](IMPORTANT): Will load Electronic Nav Chart data from US4MI1OD.000
2024-07-19T01:21:07.123Z,1721352067.123 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4MI51M.000
2024-07-19T01:21:07.125Z,1721352067.125 [NavChartDb](IMPORTANT): Will load Electronic Nav Chart data from US4MI51M.000
2024-07-19T01:21:07.125Z,1721352067.125 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4MI1OF.000
2024-07-19T01:21:07.126Z,1721352067.126 [CBIT](DEBUG): Initializing heartbeat.
2024-07-19T01:21:07.127Z,1721352067.127 [NavChartDb](IMPORTANT): Will load Electronic Nav Chart data from US4MI1OF.000
2024-07-19T01:21:07.128Z,1721352067.128 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4MI1NF.000
2024-07-19T01:21:07.129Z,1721352067.129 [NavChartDb](IMPORTANT): Will load Electronic Nav Chart data from US4MI1NF.000
2024-07-19T01:21:07.129Z,1721352067.129 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4MI1MF.000
2024-07-19T01:21:07.131Z,1721352067.131 [NavChartDb](IMPORTANT): Will load Electronic Nav Chart data from US4MI1MF.000
2024-07-19T01:21:07.133Z,1721352067.133 [NavChartDb](INFO): Setup scan of Resources/ElectronicNavigationCharts/US4MI1MF.000
2024-07-19T01:21:07.198Z,1721352067.198 [CBIT](DEBUG): Deactivating GF circuits.
2024-07-19T01:21:07.198Z,1721352067.198 [CBIT](DEBUG): Deactivating emergency mode.
2024-07-19T01:21:07.238Z,1721352067.238 [CBIT](DEBUG): Backplane powered.
2024-07-19T01:21:07.239Z,1721352067.239 [MissionManager](IMPORTANT): Using TethysL tl-to-tx parser
2024-07-19T01:21:07.239Z,1721352067.239 [MissionManager](INFO): Loading Mission from file: Missions/Startup.tl
2024-07-19T01:21:07.240Z,1721352067.240 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Startup.tl
2024-07-19T01:21:07.241Z,1721352067.241 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Startup.tl
2024-07-19T01:21:07.344Z,1721352067.344 [MissionManager](DEBUG): TethyslAPI: Missions/Startup.tl translated into:
2024-07-19T01:21:07.356Z,1721352067.356 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2024-07-19T01:21:07.412Z,1721352067.412 [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-19T01:21:07.412Z,1721352067.412 [MissionManager](INFO): Loading Mission from file: Missions/Default.tl
2024-07-19T01:21:07.413Z,1721352067.413 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Default.tl
2024-07-19T01:21:07.434Z,1721352067.434 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Default.tl
2024-07-19T01:21:07.671Z,1721352067.671 [NavChartDb](INFO): Done scanning features of Resources/ElectronicNavigationCharts/US4MI1MF.000
2024-07-19T01:21:07.916Z,1721352067.916 [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-19T01:21:07.921Z,1721352067.921 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2024-07-19T01:21:07.939Z,1721352067.939 [Default:A.Wait](DEBUG): Construct Wait.
2024-07-19T01:21:07.941Z,1721352067.941 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2024-07-19T01:21:08.005Z,1721352068.005 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2024-07-19T01:21:08.007Z,1721352068.007 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2024-07-19T01:21:08.029Z,1721352068.029 [Default:E.Execute](DEBUG): Construct Execute.
2024-07-19T01:21:08.033Z,1721352068.033 [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-19T01:21:08.051Z,1721352068.051 [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-19T01:21:08.104Z,1721352068.104 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2024-07-19T01:21:08.221Z,1721352068.221 [Power24vConverter](INFO): Powering up.
2024-07-19T01:21:08.222Z,1721352068.222 [Sonardyne_Nano](INFO): Initializing.
2024-07-19T01:21:08.313Z,1721352068.313 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2024-07-19T01:21:08.315Z,1721352068.315 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2024-07-19T01:21:08.317Z,1721352068.317 [ElevatorServo](DEBUG): Initializing EZServoServo.
2024-07-19T01:21:08.346Z,1721352068.346 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2024-07-19T01:21:08.347Z,1721352068.347 [MassServo](DEBUG): Initializing EZServoServo.
2024-07-19T01:21:08.350Z,1721352068.350 [MassServo](DEBUG): Initializing MassServo.
2024-07-19T01:21:08.351Z,1721352068.351 [RudderServo](DEBUG): Initializing EZServoServo.
2024-07-19T01:21:08.375Z,1721352068.375 [RudderServo](DEBUG): Initializing RudderServo.
2024-07-19T01:21:08.376Z,1721352068.376 [ThrusterHE](DEBUG): Initializing EZServoServo.
2024-07-19T01:21:08.387Z,1721352068.387 [ThrusterHE](DEBUG): Initializing ThrusterHE.
2024-07-19T01:21:08.674Z,1721352068.674 [WetLabsBB2FL](INFO): Powering down
2024-07-19T01:21:10.484Z,1721352070.484 [Sonardyne_Nano](ERROR): Failed to get valid response or reached max queue size, flushing UART
2024-07-19T01:21:11.723Z,1721352071.723 [Sonardyne_Nano](IMPORTANT): Found beacon with acoustic ID 2107
2024-07-19T01:21:13.586Z,1721352073.586 [CTD_Seabird](ERROR): Device message queue exceeded the allowed limit.
2024-07-19T01:21:13.979Z,1721352073.979 [ThrusterHE](ERROR): Zero Speed Commanded.
2024-07-19T01:21:21.659Z,1721352081.659 [NavChartDb](INFO): Calculating coverage of Resources/ElectronicNavigationCharts/US4MI1MF.000
2024-07-19T01:21:22.516Z,1721352082.516 [NavChartDb](INFO): Done scanning edges of Resources/ElectronicNavigationCharts/US4MI1MF.000
2024-07-19T01:21:23.735Z,1721352083.735 [NavChartDb](INFO): Done scanning nodes of Resources/ElectronicNavigationCharts/US4MI1MF.000
2024-07-19T01:21:23.747Z,1721352083.747 [NavChartDb](INFO): # of records loaded: 4559
2024-07-19T01:21:23.749Z,1721352083.749 [NavChartDb](IMPORTANT): Loaded Electronic Nav Chart data from US4MI1MF.000
2024-07-19T01:21:23.827Z,1721352083.827 [NavChartDb](INFO): Setup scan of Resources/ElectronicNavigationCharts/US4MI1NF.000
2024-07-19T01:21:24.146Z,1721352084.146 [NavChartDb](INFO): Done scanning features of Resources/ElectronicNavigationCharts/US4MI1NF.000
2024-07-19T01:21:28.101Z,1721352088.101 [NavChartDb](INFO): Calculating coverage of Resources/ElectronicNavigationCharts/US4MI1NF.000
2024-07-19T01:21:30.992Z,1721352090.992 [NavChartDb](INFO): Done scanning edges of Resources/ElectronicNavigationCharts/US4MI1NF.000
2024-07-19T01:21:32.382Z,1721352092.382 [NavChartDb](INFO): Done scanning nodes of Resources/ElectronicNavigationCharts/US4MI1NF.000
2024-07-19T01:21:32.401Z,1721352092.401 [NavChartDb](INFO): # of records loaded: 4667
2024-07-19T01:21:32.403Z,1721352092.403 [NavChartDb](IMPORTANT): Loaded Electronic Nav Chart data from US4MI1NF.000
2024-07-19T01:21:32.487Z,1721352092.487 [NavChartDb](INFO): Setup scan of Resources/ElectronicNavigationCharts/US4MI1OF.000
2024-07-19T01:21:34.606Z,1721352094.606 [NavChartDb](INFO): Done scanning features of Resources/ElectronicNavigationCharts/US4MI1OF.000
2024-07-19T01:21:35.132Z,1721352095.132 [NAL9602](INFO): Powering up NAL9602
2024-07-19T01:21:44.060Z,1721352104.060 [NavChartDb](INFO): # of records loaded: 5000
2024-07-19T01:21:46.044Z,1721352106.044 [NAL9602](INFO): NAL9602 initialized
2024-07-19T01:21:51.883Z,1721352111.883 [NavChartDb](INFO): # of records loaded: 10000
2024-07-19T01:21:59.383Z,1721352119.383 [NavChartDb](INFO): # of records loaded: 15000
2024-07-19T01:22:09.075Z,1721352129.075 [NavChartDb](INFO): # of records loaded: 20000
2024-07-19T01:22:16.309Z,1721352136.309 [NavChartDb](INFO): # of records loaded: 25000
2024-07-19T01:22:22.804Z,1721352142.804 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2024-07-19T01:22:24.094Z,1721352144.094 [NavChartDb](INFO): # of records loaded: 30000
2024-07-19T01:22:30.485Z,1721352150.485 [NAL9602](INFO): SBD MO Status=2, MOMSN=5274, MT Status=2, MTMSN=0
2024-07-19T01:22:30.485Z,1721352150.485 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2024-07-19T01:22:32.414Z,1721352152.414 [NavChartDb](INFO): # of records loaded: 35000
2024-07-19T01:22:32.828Z,1721352152.828 [NavChartDb](INFO): Calculating coverage of Resources/ElectronicNavigationCharts/US4MI1OF.000
2024-07-19T01:22:37.751Z,1721352157.751 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2024-07-19T01:22:41.503Z,1721352161.503 [NavChartDb](INFO): Done scanning edges of Resources/ElectronicNavigationCharts/US4MI1OF.000
2024-07-19T01:22:42.656Z,1721352162.656 [NavChartDb](INFO): # of records loaded: 40000
2024-07-19T01:22:47.873Z,1721352167.873 [NAL9602](INFO): SBD MO Status=2, MOMSN=5274, MT Status=2, MTMSN=0
2024-07-19T01:22:47.873Z,1721352167.873 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2024-07-19T01:22:50.353Z,1721352170.353 [NavChartDb](INFO): Done scanning nodes of Resources/ElectronicNavigationCharts/US4MI1OF.000
2024-07-19T01:22:50.383Z,1721352170.383 [NavChartDb](INFO): # of records loaded: 42018
2024-07-19T01:22:50.388Z,1721352170.388 [NavChartDb](IMPORTANT): Loaded Electronic Nav Chart data from US4MI1OF.000
2024-07-19T01:22:50.450Z,1721352170.450 [NavChartDb](INFO): Setup scan of Resources/ElectronicNavigationCharts/US4MI51M.000
2024-07-19T01:22:52.473Z,1721352172.473 [NavChartDb](INFO): Done scanning features of Resources/ElectronicNavigationCharts/US4MI51M.000
2024-07-19T01:22:53.103Z,1721352173.103 [BPC1](ERROR): BPC1A got IPBS message with 5 sticks (min is 7).
2024-07-19T01:22:57.205Z,1721352177.205 [SBIT](IMPORTANT): Beginning Startup BIT
2024-07-19T01:22:57.218Z,1721352177.218 [CBIT](IMPORTANT): Beginning ground fault scan
2024-07-19T01:23:00.733Z,1721352180.733 [NavChartDb](INFO): # of records loaded: 5000
2024-07-19T01:23:07.648Z,1721352187.648 [BPC1](ERROR): BPC1A got IPBS message with 5 sticks (min is 7).
2024-07-19T01:23:08.136Z,1721352188.136 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): -0.001604
CHAN A1 (24V): -0.007325
CHAN A2 (12V): -0.004642
CHAN A3 (5V): -0.003084
CHAN B0 (3.3V): -0.000620
CHAN B1 (3.15aV): -0.000955
CHAN B2 (3.15bV): -0.000887
CHAN B3 (GND): -0.000083
OPEN: 0.003457
Full Scale: +/- 1 mA
2024-07-19T01:23:10.050Z,1721352190.050 [NavChartDb](INFO): # of records loaded: 10000
2024-07-19T01:23:18.332Z,1721352198.332 [NavChartDb](INFO): # of records loaded: 15000
2024-07-19T01:23:21.793Z,1721352201.793 [NAL9602](INFO): SBD MO Status=0, MOMSN=5274, MT Status=0, MTMSN=0
2024-07-19T01:23:21.793Z,1721352201.793 [NAL9602](INFO): No messages in MT queue
2024-07-19T01:23:22.595Z,1721352202.595 [BPC1](ERROR): BPC1A got IPBS message with 5 sticks (min is 7).
2024-07-19T01:23:26.523Z,1721352206.523 [NavChartDb](INFO): # of records loaded: 20000
2024-07-19T01:23:34.437Z,1721352214.437 [NavChartDb](INFO): # of records loaded: 25000
2024-07-19T01:23:36.735Z,1721352216.735 [BPC1](ERROR): BPC1A got IPBS message with 5 sticks (min is 7).
2024-07-19T01:23:42.931Z,1721352222.931 [NavChartDb](INFO): # of records loaded: 30000
2024-07-19T01:23:47.550Z,1721352227.550 [NavChartDb](INFO): Calculating coverage of Resources/ElectronicNavigationCharts/US4MI51M.000
2024-07-19T01:23:50.879Z,1721352230.879 [BPC1](ERROR): BPC1A got IPBS message with 5 sticks (min is 7).
2024-07-19T01:23:51.261Z,1721352231.261 [NavChartDb](INFO): # of records loaded: 35000
2024-07-19T01:23:51.353Z,1721352231.353 [SBIT](IMPORTANT): SBIT PASSED
2024-07-19T01:23:51.354Z,1721352231.354 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2024-07-19T01:23:51.359Z,1721352231.359 [SBIT](IMPORTANT): BPC1.batteryMissingStickThreshold=8 count;
2024-07-19T01:23:51.359Z,1721352231.359 [SBIT](IMPORTANT): CTD_Seabird.minSalinityBound=0 practical_salinity_unit;
2024-07-19T01:23:51.359Z,1721352231.359 [SBIT](IMPORTANT): DAT.loadAtStartup=0 bool;
2024-07-19T01:23:51.359Z,1721352231.359 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=250 cubic_centimeter;
2024-07-19T01:23:51.359Z,1721352231.359 [SBIT](IMPORTANT): VerticalControl.massDefault=2.25 centimeter;
2024-07-19T01:23:51.868Z,1721352231.868 [MissionManager](IMPORTANT): Started mission Startup
2024-07-19T01:23:51.868Z,1721352231.868 [Startup] Running Loop=1
2024-07-19T01:23:51.869Z,1721352231.869 [Startup](DEBUG): Aggregate::initialize Startup
2024-07-19T01:23:51.869Z,1721352231.869 [Startup:A.GoToSurface] Running Loop=1
2024-07-19T01:23:51.869Z,1721352231.869 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2024-07-19T01:23:51.869Z,1721352231.869 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2024-07-19T01:23:51.874Z,1721352231.874 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2024-07-19T01:23:51.874Z,1721352231.874 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2024-07-19T01:23:51.875Z,1721352231.875 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2024-07-19T01:23:51.875Z,1721352231.875 [Startup:A.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds.
2024-07-19T01:23:51.875Z,1721352231.875 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2024-07-19T01:23:51.877Z,1721352231.877 [Startup:StartupSatComms] Running Loop=1
2024-07-19T01:23:51.877Z,1721352231.877 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2024-07-19T01:23:51.877Z,1721352231.877 [Startup:StartupSatComms:A] Running Loop=1
2024-07-19T01:23:52.180Z,1721352232.180 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2024-07-19T01:23:58.843Z,1721352238.843 [NavChartDb](INFO): Done scanning edges of Resources/ElectronicNavigationCharts/US4MI51M.000
2024-07-19T01:24:04.702Z,1721352244.702 [NavChartDb](INFO): # of records loaded: 40000
2024-07-19T01:24:05.435Z,1721352245.435 [BPC1](ERROR): BPC1A got IPBS message with 5 sticks (min is 7).
2024-07-19T01:24:06.723Z,1721352246.723 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2024-07-19T01:24:06.723Z,1721352246.723 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-07-19T01:24:06.743Z,1721352246.743 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-07-19T01:24:07.128Z,1721352247.128 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-07-19T01:24:07.128Z,1721352247.128 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2024-07-19T01:24:07.348Z,1721352247.348 [NavChartDb](INFO): Done scanning nodes of Resources/ElectronicNavigationCharts/US4MI51M.000
2024-07-19T01:24:07.421Z,1721352247.421 [NavChartDb](INFO): # of records loaded: 40792
2024-07-19T01:24:07.430Z,1721352247.430 [NavChartDb](IMPORTANT): Loaded Electronic Nav Chart data from US4MI51M.000
2024-07-19T01:24:07.454Z,1721352247.454 [NavChartDb](INFO): Setup scan of Resources/ElectronicNavigationCharts/US4MI1OD.000
2024-07-19T01:24:07.908Z,1721352247.908 [NavChartDb](INFO): Done scanning features of Resources/ElectronicNavigationCharts/US4MI1OD.000
2024-07-19T01:24:15.741Z,1721352255.741 [NavChartDb](INFO): # of records loaded: 5000
2024-07-19T01:24:19.575Z,1721352259.575 [BPC1](ERROR): BPC1A got IPBS message with 5 sticks (min is 7).
2024-07-19T01:24:21.404Z,1721352261.404 [NavChartDb](INFO): Calculating coverage of Resources/ElectronicNavigationCharts/US4MI1OD.000
2024-07-19T01:24:22.500Z,1721352262.500 [NavChartDb](INFO): Done scanning edges of Resources/ElectronicNavigationCharts/US4MI1OD.000
2024-07-19T01:24:23.824Z,1721352263.824 [NavChartDb](INFO): Done scanning nodes of Resources/ElectronicNavigationCharts/US4MI1OD.000
2024-07-19T01:24:23.861Z,1721352263.861 [NavChartDb](INFO): # of records loaded: 9682
2024-07-19T01:24:23.863Z,1721352263.863 [NavChartDb](IMPORTANT): Loaded Electronic Nav Chart data from US4MI1OD.000
2024-07-19T01:24:23.890Z,1721352263.890 [NavChartDb](INFO): Setup scan of Resources/ElectronicNavigationCharts/US4MI1ND.000
2024-07-19T01:24:24.966Z,1721352264.966 [NavChartDb](INFO): Done scanning features of Resources/ElectronicNavigationCharts/US4MI1ND.000
2024-07-19T01:24:34.143Z,1721352274.143 [BPC1](ERROR): BPC1A got IPBS message with 5 sticks (min is 7).
2024-07-19T01:24:41.333Z,1721352281.333 [NavChartDb](INFO): # of records loaded: 5000
2024-07-19T01:24:49.281Z,1721352289.281 [BPC1](ERROR): BPC1A got IPBS message with 5 sticks (min is 7).
2024-07-19T01:24:52.137Z,1721352292.137 [Startup:StartupSatComms:A](INFO): Timed out from 2024-07-19T01:23:51.9Z
2024-07-19T01:24:52.137Z,1721352292.137 [Startup:StartupSatComms:A] Stopped
2024-07-19T01:24:52.137Z,1721352292.137 [Startup:StartupSatComms:B] Running Loop=1
2024-07-19T01:24:52.576Z,1721352292.576 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2024-07-19T01:24:54.363Z,1721352294.363 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.002947
2024-07-19T01:24:59.919Z,1721352299.919 [CommandExec](IMPORTANT): got command failComponent
2024-07-19T01:24:59.922Z,1721352299.922 [CommandExec](IMPORTANT): Failed components:
2024-07-19T01:24:59.922Z,1721352299.922 [CommandExec](IMPORTANT): No failed Components.
2024-07-19T01:25:00.287Z,1721352300.287 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-07-19T01:25:00.313Z,1721352300.313 [NavChartDb](INFO): # of records loaded: 10000
2024-07-19T01:25:03.379Z,1721352303.379 [BPC1](ERROR): BPC1A got IPBS message with 5 sticks (min is 7).
2024-07-19T01:25:11.726Z,1721352311.726 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20240719T010419/Courier0010.lzma
2024-07-19T01:25:12.728Z,1721352312.728 [DataOverHttps](INFO): Moved sent file to Logs/20240719T010419/Courier0010.lzma.bak
2024-07-19T01:25:12.728Z,1721352312.728 [DataOverHttps](INFO): SBD MOMSN=21368320
2024-07-19T01:25:12.801Z,1721352312.801 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-07-19T01:25:13.604Z,1721352313.604 [NavChartDb](INFO): Calculating coverage of Resources/ElectronicNavigationCharts/US4MI1ND.000
2024-07-19T01:25:13.666Z,1721352313.666 [NavChartDb](INFO): # of records loaded: 15000
2024-07-19T01:25:19.752Z,1721352319.752 [CommandExec](IMPORTANT): got command get latitude
2024-07-19T01:25:19.753Z,1721352319.753 [CommandExec](FAULT): Element has no value
2024-07-19T01:25:22.143Z,1721352322.143 [CommandExec](IMPORTANT): got command ibit
2024-07-19T01:25:22.493Z,1721352322.493 [IBIT](IMPORTANT): Beginning Initiated BIT
2024-07-19T01:25:22.493Z,1721352322.493 [IBIT](IMPORTANT): Beginning control surface checks.
2024-07-19T01:25:22.497Z,1721352322.497 [CBIT](IMPORTANT): Beginning ground fault scan
2024-07-19T01:25:22.901Z,1721352322.901 [NavChartDb](INFO): Done scanning edges of Resources/ElectronicNavigationCharts/US4MI1ND.000
2024-07-19T01:25:29.813Z,1721352329.813 [NavChartDb](INFO): Done scanning nodes of Resources/ElectronicNavigationCharts/US4MI1ND.000
2024-07-19T01:25:29.857Z,1721352329.857 [NavChartDb](INFO): # of records loaded: 19081
2024-07-19T01:25:29.881Z,1721352329.881 [NavChartDb](IMPORTANT): Loaded Electronic Nav Chart data from US4MI1ND.000
2024-07-19T01:25:29.890Z,1721352329.890 [NavChartDb](INFO): Setup scan of Resources/ElectronicNavigationCharts/US2MI60M.000
2024-07-19T01:25:33.342Z,1721352333.342 [NavChartDb](INFO): Done scanning features of Resources/ElectronicNavigationCharts/US2MI60M.000
2024-07-19T01:25:33.713Z,1721352333.713 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): 0.000983
CHAN A1 (24V): -0.007852
CHAN A2 (12V): -0.005072
CHAN A3 (5V): -0.003055
CHAN B0 (3.3V): -0.001122
CHAN B1 (3.15aV): -0.000881
CHAN B2 (3.15bV): -0.001662
CHAN B3 (GND): -0.000180
OPEN: 0.003541
Full Scale: +/- 1 mA
2024-07-19T01:25:41.830Z,1721352341.830 [DataOverHttps](INFO): Sending 151 bytes from file Logs/20240719T012055/Courier0000.lzma
2024-07-19T01:25:42.832Z,1721352342.832 [DataOverHttps](INFO): Moved sent file to Logs/20240719T012055/Courier0000.lzma.bak
2024-07-19T01:25:42.832Z,1721352342.832 [DataOverHttps](INFO): SBD MOMSN=21368322
2024-07-19T01:25:48.190Z,1721352348.190 [NavChartDb](INFO): # of records loaded: 5000
2024-07-19T01:25:52.809Z,1721352352.809 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-07-19T01:26:01.723Z,1721352361.723 [NavChartDb](INFO): # of records loaded: 10000
2024-07-19T01:26:16.446Z,1721352376.446 [DataOverHttps](INFO): Sending 174 bytes from file Logs/20240719T010419/Express0011.lzma
2024-07-19T01:26:17.140Z,1721352377.140 [NavChartDb](INFO): # of records loaded: 15000
2024-07-19T01:26:17.448Z,1721352377.448 [DataOverHttps](INFO): Moved sent file to Logs/20240719T010419/Express0011.lzma.bak
2024-07-19T01:26:17.448Z,1721352377.448 [DataOverHttps](INFO): SBD MOMSN=21368325
2024-07-19T01:26:37.278Z,1721352397.278 [NavChartDb](INFO): # of records loaded: 20000
2024-07-19T01:26:50.985Z,1721352410.985 [CommandExec](IMPORTANT): got command get latitude
2024-07-19T01:26:50.985Z,1721352410.985 [CommandExec](FAULT): Element has no value
2024-07-19T01:26:52.195Z,1721352412.195 [NavChartDb](INFO): # of records loaded: 25000
2024-07-19T01:26:52.901Z,1721352412.901 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,012652.00,A,4538.81724,N,08428.34150,W,0.894,138.15,190724,,,A*7B
2024-07-19T01:26:52.905Z,1721352412.905 [NAL9602](INFO): GPS fix at 20240719T012652: (45.646954, -84.472358)
2024-07-19T01:26:52.990Z,1721352412.990 [IBIT](IMPORTANT): Communications Status:
Fix Status: 1
Iridium Signal Strength: 5
Latitude: 45.646954 Longitude: -84.472359
2024-07-19T01:26:53.401Z,1721352413.401 [IBIT](FAULT): Warning: Battery Data not active. Expected only when running primaries. Threshold checking not active.
2024-07-19T01:26:53.791Z,1721352413.791 [IBIT](IMPORTANT): bitHumidityThreshold: 55.000000 %
2024-07-19T01:26:53.791Z,1721352413.791 [IBIT](IMPORTANT): bitPressureThreshold: 0.750000 psi
2024-07-19T01:26:53.791Z,1721352413.791 [IBIT](IMPORTANT): Pressure:10.314523 PSI
2024-07-19T01:26:53.792Z,1721352413.792 [IBIT](IMPORTANT): Humidity:17.275059 %
2024-07-19T01:26:54.175Z,1721352414.175 [IBIT](IMPORTANT): Vehicle Pitch:-2.850118 degrees
2024-07-19T01:26:54.176Z,1721352414.176 [IBIT](IMPORTANT): Vehicle Roll:-6.136510 degrees
2024-07-19T01:26:54.176Z,1721352414.176 [IBIT](IMPORTANT): Vehicle Heading:263.471130 degrees
2024-07-19T01:26:54.560Z,1721352414.560 [IBIT](IMPORTANT): surfaceThreshold: 1.000000 m
2024-07-19T01:26:54.560Z,1721352414.560 [IBIT](IMPORTANT): buoyancyNeutral: 250.000015 cc
2024-07-19T01:26:54.560Z,1721352414.560 [IBIT](IMPORTANT): massDefault: 2.250000 cm
2024-07-19T01:26:54.560Z,1721352414.560 [IBIT](IMPORTANT): stopDepth: 275.000000 m
2024-07-19T01:26:54.561Z,1721352414.561 [IBIT](IMPORTANT): abortDepth: 300.000000 m
2024-07-19T01:26:54.561Z,1721352414.561 [IBIT](IMPORTANT): IBIT PASSED
2024-07-19T01:26:54.953Z,1721352414.953 [Startup:StartupSatComms:B](INFO): Timed out from 2024-07-19T01:24:52.1Z
2024-07-19T01:26:54.953Z,1721352414.953 [Startup:StartupSatComms:B] Stopped
2024-07-19T01:26:54.953Z,1721352414.953 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2024-07-19T01:26:54.953Z,1721352414.953 [Startup:StartupSatComms] Stopped
2024-07-19T01:26:54.953Z,1721352414.953 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2024-07-19T01:26:54.962Z,1721352414.962 [Startup](INFO): Completed Startup
2024-07-19T01:26:54.962Z,1721352414.962 [MissionManager](INFO): Startup is completed.
2024-07-19T01:26:54.963Z,1721352414.963 [MissionManager](INFO): Uninitializing Mission Startup
2024-07-19T01:26:54.963Z,1721352414.963 [Startup] Stopped
2024-07-19T01:26:54.963Z,1721352414.963 [Startup](DEBUG): Aggregate::uninitialize Startup
2024-07-19T01:26:54.963Z,1721352414.963 [Startup:A.GoToSurface] Stopped
2024-07-19T01:26:54.963Z,1721352414.963 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2024-07-19T01:26:55.349Z,1721352415.349 [MissionManager](IMPORTANT): Started mission Default
2024-07-19T01:26:55.349Z,1721352415.349 [Default] Running Loop=1
2024-07-19T01:26:55.349Z,1721352415.349 [Default](DEBUG): Aggregate::initialize Default
2024-07-19T01:26:55.349Z,1721352415.349 [Default:B.GoToSurface] Running Loop=1
2024-07-19T01:26:55.349Z,1721352415.349 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2024-07-19T01:26:55.349Z,1721352415.349 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2024-07-19T01:26:55.358Z,1721352415.358 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2024-07-19T01:26:55.358Z,1721352415.358 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2024-07-19T01:26:55.359Z,1721352415.359 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2024-07-19T01:26:55.359Z,1721352415.359 [Default:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds.
2024-07-19T01:26:55.359Z,1721352415.359 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2024-07-19T01:26:55.359Z,1721352415.359 [Default:A.Wait] Running Loop=1
2024-07-19T01:26:55.359Z,1721352415.359 [Default:A.Wait](DEBUG): Initialize Wait Component.
2024-07-19T01:26:58.879Z,1721352418.879 [DataOverHttps](INFO): Sending 962 bytes from file Logs/20240719T012055/Express0001.lzma
2024-07-19T01:26:59.880Z,1721352419.880 [DataOverHttps](INFO): Moved sent file to Logs/20240719T012055/Express0001.lzma.bak
2024-07-19T01:26:59.880Z,1721352419.880 [DataOverHttps](INFO): SBD MOMSN=21368329
2024-07-19T01:27:05.591Z,1721352425.591 [NavChartDb](INFO): # of records loaded: 30000
2024-07-19T01:27:07.387Z,1721352427.387 [CommandExec](IMPORTANT): got command ibit
2024-07-19T01:27:07.584Z,1721352427.584 [IBIT](IMPORTANT): Beginning Initiated BIT
2024-07-19T01:27:07.584Z,1721352427.584 [IBIT](IMPORTANT): Beginning control surface checks.
2024-07-19T01:27:07.625Z,1721352427.625 [CBIT](IMPORTANT): Beginning ground fault scan
2024-07-19T01:27:09.069Z,1721352429.069 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,012708.00,A,4538.80981,N,08428.33222,W,0.486,59.77,190724,,,A*49
2024-07-19T01:27:09.071Z,1721352429.071 [NAL9602](INFO): GPS fix at 20240719T012708: (45.646830, -84.472204)
2024-07-19T01:27:11.905Z,1721352431.905 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,012711.00,A,4538.80889,N,08428.33106,W,1.361,9.53,190724,,,A*71
2024-07-19T01:27:11.907Z,1721352431.907 [NAL9602](INFO): GPS fix at 20240719T012711: (45.646815, -84.472184)
2024-07-19T01:27:14.769Z,1721352434.769 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,012714.00,A,4538.80846,N,08428.33054,W,0.330,9.53,190724,,,A*74
2024-07-19T01:27:14.775Z,1721352434.775 [NAL9602](INFO): GPS fix at 20240719T012714: (45.646808, -84.472176)
2024-07-19T01:27:17.280Z,1721352437.280 [NavChartDb](INFO): # of records loaded: 35000
2024-07-19T01:27:17.961Z,1721352437.961 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,012717.00,A,4538.80733,N,08428.32908,W,1.186,327.62,190724,,,A*78
2024-07-19T01:27:17.963Z,1721352437.963 [NAL9602](INFO): GPS fix at 20240719T012717: (45.646789, -84.472151)
2024-07-19T01:27:18.429Z,1721352438.429 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): -0.002960
CHAN A1 (24V): -0.007277
CHAN A2 (12V): -0.004938
CHAN A3 (5V): -0.002583
CHAN B0 (3.3V): -0.001104
CHAN B1 (3.15aV): -0.000838
CHAN B2 (3.15bV): -0.001862
CHAN B3 (GND): -0.000588
OPEN: 0.003544
Full Scale: +/- 1 mA
2024-07-19T01:27:20.783Z,1721352440.783 [BPC1](ERROR): BPC1A: No match for serial number 1717 in BPC1A's battery stick inventory (sticks 1-31 in onboard configuration file).
2024-07-19T01:27:20.791Z,1721352440.791 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,012720.00,A,4538.80633,N,08428.32776,W,0.117,327.62,190724,,,A*73
2024-07-19T01:27:20.793Z,1721352440.793 [NAL9602](INFO): GPS fix at 20240719T012720: (45.646772, -84.472129)
2024-07-19T01:27:24.017Z,1721352444.017 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,012723.00,A,4538.80477,N,08428.32578,W,0.680,318.87,190724,,,A*70
2024-07-19T01:27:24.023Z,1721352444.023 [NAL9602](INFO): GPS fix at 20240719T012723: (45.646746, -84.472096)
2024-07-19T01:27:25.812Z,1721352445.812 [NavChartDb](INFO): # of records loaded: 40000
2024-07-19T01:27:26.877Z,1721352446.877 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,012726.00,A,4538.80358,N,08428.32428,W,1.438,317.11,190724,,,A*7B
2024-07-19T01:27:26.883Z,1721352446.883 [NAL9602](INFO): GPS fix at 20240719T012726: (45.646726, -84.472071)
2024-07-19T01:27:30.081Z,1721352450.081 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,012729.00,A,4538.80283,N,08428.32323,W,0.408,29.09,190724,,,A*4A
2024-07-19T01:27:30.083Z,1721352450.083 [NAL9602](INFO): GPS fix at 20240719T012729: (45.646714, -84.472054)
2024-07-19T01:27:32.909Z,1721352452.909 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,012732.00,A,4538.80142,N,08428.32138,W,1.244,94.22,190724,,,A*46
2024-07-19T01:27:32.911Z,1721352452.911 [NAL9602](INFO): GPS fix at 20240719T012732: (45.646690, -84.472023)
2024-07-19T01:27:34.034Z,1721352454.034 [NavChartDb](INFO): # of records loaded: 45000
2024-07-19T01:27:35.733Z,1721352455.733 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,012735.00,A,4538.79935,N,08428.31860,W,0.292,122.93,190724,,,A*74
2024-07-19T01:27:35.735Z,1721352455.735 [NAL9602](INFO): GPS fix at 20240719T012735: (45.646656, -84.471977)
2024-07-19T01:27:36.023Z,1721352456.023 [NavChartDb](INFO): Calculating coverage of Resources/ElectronicNavigationCharts/US2MI60M.000
2024-07-19T01:27:38.965Z,1721352458.965 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,012738.00,A,4538.79833,N,08428.31720,W,0.855,136.13,190724,,,A*79
2024-07-19T01:27:38.967Z,1721352458.967 [NAL9602](INFO): GPS fix at 20240719T012738: (45.646639, -84.471953)
2024-07-19T01:27:41.820Z,1721352461.820 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,012741.00,A,4538.79796,N,08428.31665,W,1.497,137.32,190724,,,A*76
2024-07-19T01:27:41.834Z,1721352461.834 [NAL9602](INFO): GPS fix at 20240719T012741: (45.646633, -84.471944)
2024-07-19T01:27:45.033Z,1721352465.033 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,012744.00,A,4538.79730,N,08428.31579,W,0.641,137.11,190724,,,A*78
2024-07-19T01:27:45.035Z,1721352465.035 [NAL9602](INFO): GPS fix at 20240719T012744: (45.646622, -84.471930)
2024-07-19T01:27:45.144Z,1721352465.144 [NavChartDb](INFO): # of records loaded: 50000
2024-07-19T01:27:47.976Z,1721352467.976 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,012747.00,A,4538.79766,N,08428.31629,W,0.253,138.31,190724,,,A*74
2024-07-19T01:27:47.983Z,1721352467.983 [NAL9602](INFO): GPS fix at 20240719T012747: (45.646628, -84.471938)
2024-07-19T01:27:51.089Z,1721352471.089 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,012750.00,A,4538.79921,N,08428.31830,W,1.477,138.20,190724,,,A*78
2024-07-19T01:27:51.091Z,1721352471.091 [NAL9602](INFO): GPS fix at 20240719T012750: (45.646653, -84.471972)
2024-07-19T01:27:53.913Z,1721352473.913 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,012753.00,A,4538.80194,N,08428.32175,W,0.544,92.81,190724,,,A*4A
2024-07-19T01:27:53.915Z,1721352473.915 [NAL9602](INFO): GPS fix at 20240719T012753: (45.646699, -84.472029)
2024-07-19T01:27:53.999Z,1721352473.999 [IBIT](IMPORTANT): Communications Status:
Fix Status: 1
Iridium Signal Strength: 5
Latitude: 45.646698 Longitude: -84.472031
2024-07-19T01:27:54.372Z,1721352474.372 [IBIT](FAULT): Warning: Battery Data not active. Expected only when running primaries. Threshold checking not active.
2024-07-19T01:27:54.751Z,1721352474.751 [IBIT](IMPORTANT): bitHumidityThreshold: 55.000000 %
2024-07-19T01:27:54.751Z,1721352474.751 [IBIT](IMPORTANT): bitPressureThreshold: 0.750000 psi
2024-07-19T01:27:54.751Z,1721352474.751 [IBIT](IMPORTANT): Pressure:10.267482 PSI
2024-07-19T01:27:54.752Z,1721352474.752 [IBIT](IMPORTANT): Humidity:17.275059 %
2024-07-19T01:27:55.159Z,1721352475.159 [IBIT](IMPORTANT): Vehicle Pitch:-2.845252 degrees
2024-07-19T01:27:55.159Z,1721352475.159 [IBIT](IMPORTANT): Vehicle Roll:-6.160172 degrees
2024-07-19T01:27:55.159Z,1721352475.159 [IBIT](IMPORTANT): Vehicle Heading:263.498932 degrees
2024-07-19T01:27:55.574Z,1721352475.574 [IBIT](IMPORTANT): surfaceThreshold: 1.000000 m
2024-07-19T01:27:55.575Z,1721352475.575 [IBIT](IMPORTANT): buoyancyNeutral: 250.000015 cc
2024-07-19T01:27:55.575Z,1721352475.575 [IBIT](IMPORTANT): massDefault: 2.250000 cm
2024-07-19T01:27:55.575Z,1721352475.575 [IBIT](IMPORTANT): stopDepth: 275.000000 m
2024-07-19T01:27:55.575Z,1721352475.575 [IBIT](IMPORTANT): abortDepth: 300.000000 m
2024-07-19T01:27:55.575Z,1721352475.575 [IBIT](IMPORTANT): IBIT PASSED
2024-07-19T01:27:55.955Z,1721352475.955 [Default:A.Wait](INFO): Done Waiting.
2024-07-19T01:27:55.955Z,1721352475.955 [Default:A.Wait] Stopped
2024-07-19T01:27:55.955Z,1721352475.955 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2024-07-19T01:27:55.968Z,1721352475.968 [NavChartDb](INFO): # of records loaded: 55000
2024-07-19T01:27:56.396Z,1721352476.396 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-07-19T01:27:56.465Z,1721352476.465 [Default:CheckIn] Running Loop=1
2024-07-19T01:27:56.465Z,1721352476.465 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-07-19T01:27:56.465Z,1721352476.465 [Default:CheckIn:Read_GPS] Running Loop=1
2024-07-19T01:27:56.789Z,1721352476.789 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2024-07-19T01:27:58.361Z,1721352478.361 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,012757.00,A,4538.80481,N,08428.32535,W,1.341,335.80,190724,,,A*72
2024-07-19T01:27:58.363Z,1721352478.363 [NAL9602](INFO): GPS fix at 20240719T012757: (45.646747, -84.472089)
2024-07-19T01:27:58.414Z,1721352478.414 [Default:CheckIn:Read_GPS] Stopped
2024-07-19T01:27:58.414Z,1721352478.414 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-07-19T01:27:58.811Z,1721352478.811 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications
2024-07-19T01:28:11.346Z,1721352491.346 [NavChartDb](INFO): # of records loaded: 60000
2024-07-19T01:28:13.010Z,1721352493.010 [DataOverHttps](INFO): Sending 224 bytes from file Logs/20240719T012055/Courier0004.lzma
2024-07-19T01:28:13.676Z,1721352493.676 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2024-07-19T01:28:13.699Z,1721352493.699 [BPC1](INFO): Calculating totals. Valid battery stick count: 51. Valid reserve battery stick count: 5.
2024-07-19T01:28:13.707Z,1721352493.707 [BPC1](INFO): Received data from all battery sticks.
2024-07-19T01:28:14.012Z,1721352494.012 [DataOverHttps](INFO): Moved sent file to Logs/20240719T012055/Courier0004.lzma.bak
2024-07-19T01:28:14.012Z,1721352494.012 [DataOverHttps](INFO): SBD MOMSN=21368359
2024-07-19T01:28:19.583Z,1721352499.583 [NavChartDb](INFO): Done scanning edges of Resources/ElectronicNavigationCharts/US2MI60M.000
2024-07-19T01:28:30.251Z,1721352510.251 [NAL9602](INFO): Not Powering down - fast GPS
2024-07-19T01:28:41.737Z,1721352521.737 [NavChartDb](INFO): Done scanning nodes of Resources/ElectronicNavigationCharts/US2MI60M.000
2024-07-19T01:28:42.267Z,1721352522.267 [NavChartDb](INFO): # of records loaded: 64544
2024-07-19T01:28:42.272Z,1721352522.272 [NavChartDb](IMPORTANT): Loaded Electronic Nav Chart data from US2MI60M.000
2024-07-19T01:28:43.234Z,1721352523.234 [NavChartDb](INFO): Creating index for soundings
2024-07-19T01:28:53.804Z,1721352533.804 [DataOverHttps](INFO): Sending 1149 bytes from file Logs/20240719T012055/Express0005.lzma
2024-07-19T01:28:54.804Z,1721352534.804 [DataOverHttps](INFO): Moved sent file to Logs/20240719T012055/Express0005.lzma.bak
2024-07-19T01:28:54.804Z,1721352534.804 [DataOverHttps](INFO): SBD MOMSN=21368362
2024-07-19T01:29:08.677Z,1721352548.677 [Default:CheckIn:Read_Iridium] Stopped
2024-07-19T01:29:08.677Z,1721352548.677 [Default:CheckIn:C.Wait] Running Loop=1
2024-07-19T01:29:08.677Z,1721352548.677 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-07-19T01:29:09.145Z,1721352549.145 [NavChartDb](INFO): Creating index for 0p0
2024-07-19T01:29:20.006Z,1721352560.006 [NavChartDb](INFO): Creating index for 1p8
2024-07-19T01:29:25.647Z,1721352565.647 [NavChartDb](INFO): Creating index for 3p6
2024-07-19T01:29:28.819Z,1721352568.819 [CommandExec](IMPORTANT): got command show variable distance
2024-07-19T01:29:28.822Z,1721352568.822 [CommandExec](IMPORTANT): distance_from_shore (unknown)
2024-07-19T01:29:28.823Z,1721352568.823 [CommandExec](IMPORTANT): fix_distance_made_good (unknown)
2024-07-19T01:29:28.823Z,1721352568.823 [CommandExec](IMPORTANT): fix_residual_distance (unknown)
2024-07-19T01:29:28.824Z,1721352568.824 [CommandExec](IMPORTANT): fix_residual_percent_distance_traveled (unknown)
2024-07-19T01:29:28.825Z,1721352568.825 [CommandExec](IMPORTANT): platform_distance_wrt_ground (unknown)
2024-07-19T01:29:28.825Z,1721352568.825 [CommandExec](IMPORTANT): platform_distance_wrt_sea_water (meter)
2024-07-19T01:29:28.909Z,1721352568.909 [CommandExec](IMPORTANT): ShortestDistanceToPolygonSidesCalculator.loadAtStartup (bool)
2024-07-19T01:29:28.919Z,1721352568.919 [CommandExec](IMPORTANT): ShortestDistanceToPolygonSidesCalculator.verbosity (count)
2024-07-19T01:29:28.919Z,1721352568.919 [CommandExec](IMPORTANT): ShortestDistanceToPolygonSidesCalculator.latVertex1 (degree)
2024-07-19T01:29:28.920Z,1721352568.920 [CommandExec](IMPORTANT): ShortestDistanceToPolygonSidesCalculator.lonVertex1 (degree)
2024-07-19T01:29:28.920Z,1721352568.920 [CommandExec](IMPORTANT): ShortestDistanceToPolygonSidesCalculator.latVertex2 (degree)
2024-07-19T01:29:28.921Z,1721352568.921 [CommandExec](IMPORTANT): ShortestDistanceToPolygonSidesCalculator.lonVertex2 (degree)
2024-07-19T01:29:28.921Z,1721352568.921 [CommandExec](IMPORTANT): ShortestDistanceToPolygonSidesCalculator.latVertex3 (degree)
2024-07-19T01:29:28.921Z,1721352568.921 [CommandExec](IMPORTANT): ShortestDistanceToPolygonSidesCalculator.lonVertex3 (degree)
2024-07-19T01:29:28.922Z,1721352568.922 [CommandExec](IMPORTANT): ShortestDistanceToPolygonSidesCalculator.latVertex4 (degree)
2024-07-19T01:29:28.958Z,1721352568.958 [CommandExec](IMPORTANT): ShortestDistanceToPolygonSidesCalculator.lonVertex4 (degree)
2024-07-19T01:29:28.959Z,1721352568.959 [CommandExec](IMPORTANT): ShortestDistanceToPolygonSidesCalculator.latVertex5 (degree)
2024-07-19T01:29:28.959Z,1721352568.959 [CommandExec](IMPORTANT): ShortestDistanceToPolygonSidesCalculator.lonVertex5 (degree)
2024-07-19T01:29:28.959Z,1721352568.959 [CommandExec](IMPORTANT): ShortestDistanceToPolygonSidesCalculator.latVertex6 (degree)
2024-07-19T01:29:28.960Z,1721352568.960 [CommandExec](IMPORTANT): ShortestDistanceToPolygonSidesCalculator.lonVertex6 (degree)
2024-07-19T01:29:28.960Z,1721352568.960 [CommandExec](IMPORTANT): ShortestDistanceToPolygonSidesCalculator.latVertex7 (degree)
2024-07-19T01:29:28.960Z,1721352568.960 [CommandExec](IMPORTANT): ShortestDistanceToPolygonSidesCalculator.lonVertex7 (degree)
2024-07-19T01:29:28.961Z,1721352568.961 [CommandExec](IMPORTANT): ShortestDistanceToPolygonSidesCalculator.latVertex8 (degree)
2024-07-19T01:29:28.961Z,1721352568.961 [CommandExec](IMPORTANT): ShortestDistanceToPolygonSidesCalculator.lonVertex8 (degree)
2024-07-19T01:29:28.961Z,1721352568.961 [CommandExec](IMPORTANT): ShortestDistanceToPolygonSidesCalculator.latVertex9 (degree)
2024-07-19T01:29:28.974Z,1721352568.974 [CommandExec](IMPORTANT): ShortestDistanceToPolygonSidesCalculator.lonVertex9 (degree)
2024-07-19T01:29:28.974Z,1721352568.974 [CommandExec](IMPORTANT): ShortestDistanceToPolygonSidesCalculator.latVertex10 (degree)
2024-07-19T01:29:28.975Z,1721352568.975 [CommandExec](IMPORTANT): ShortestDistanceToPolygonSidesCalculator.lonVertex10 (degree)
2024-07-19T01:29:28.977Z,1721352568.977 [CommandExec](IMPORTANT): LineCapture.rolloutDistance (meter)
2024-07-19T01:29:29.045Z,1721352569.045 [CommandExec](IMPORTANT): MassServo.deviationDistance (millimeter)
2024-07-19T01:29:29.137Z,1721352569.137 [CommandExec](IMPORTANT): GobyModem.maxDistance (kilometer)
2024-07-19T01:29:29.180Z,1721352569.180 [CommandExec](IMPORTANT): Rowe_600.acousticBlankingDistance (meter)
2024-07-19T01:29:29.287Z,1721352569.287 [CommandExec](IMPORTANT): SpeedCalculator.platform_distance_wrt_sea_water (meter)
2024-07-19T01:29:29.289Z,1721352569.289 [CommandExec](IMPORTANT): DeadReckonUsingMultipleVelocitySources.fix_distance_made_good (meter)
2024-07-19T01:29:29.289Z,1721352569.289 [CommandExec](IMPORTANT): DeadReckonUsingMultipleVelocitySources.fix_residual_distance (meter)
2024-07-19T01:29:29.306Z,1721352569.306 [CommandExec](IMPORTANT): DeadReckonUsingMultipleVelocitySources.fix_residual_percent_distance_traveled (percent)
2024-07-19T01:29:29.307Z,1721352569.307 [CommandExec](IMPORTANT): NavChart.distance_from_shore (meter)
2024-07-19T01:29:29.399Z,1721352569.399 [CommandExec](IMPORTANT): NavChartDb.closestDistance (meter)
2024-07-19T01:29:29.400Z,1721352569.400 [CommandExec](IMPORTANT): NavChartDb.nextDistance (meter)
2024-07-19T01:29:29.689Z,1721352569.689 [NavChartDb](INFO): Creating index for 5p4
2024-07-19T01:29:43.191Z,1721352583.191 [CommandExec](IMPORTANT): got command get NavChart.distance_from_shore
2024-07-19T01:29:43.192Z,1721352583.192 [CommandExec](IMPORTANT): NavChart.distance_from_shore nan m
2024-07-19T01:29:43.464Z,1721352583.464 [NavChartDb](INFO): Creating index for 7p3
2024-07-19T01:29:49.956Z,1721352589.956 [NavChartDb](INFO): Creating index for 9p1
2024-07-19T01:31:09.047Z,1721352669.047 [Power24vConverter](INFO): Powering down.
2024-07-19T01:33:06.714Z,1721352786.714 [CommandExec](IMPORTANT): got command get NavChart.distance_from_shore
2024-07-19T01:33:06.715Z,1721352786.715 [CommandExec](IMPORTANT): NavChart.distance_from_shore 88.886566 m
2024-07-19T01:33:14.703Z,1721352794.703 [CommandExec](IMPORTANT): got command failComponent
2024-07-19T01:33:14.703Z,1721352794.703 [CommandExec](IMPORTANT): Failed components:
2024-07-19T01:33:14.703Z,1721352794.703 [CommandExec](IMPORTANT): No failed Components.
2024-07-19T01:34:09.253Z,1721352849.253 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-07-19T01:34:09.253Z,1721352849.253 [Default:CheckIn:C.Wait] Stopped
2024-07-19T01:34:09.253Z,1721352849.253 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-07-19T01:34:09.253Z,1721352849.253 [Default:CheckIn:D] Running Loop=1
2024-07-19T01:34:09.654Z,1721352849.654 [Default:CheckIn:D] Stopped
2024-07-19T01:34:09.654Z,1721352849.654 [Default:CheckIn:E] Running Loop=1
2024-07-19T01:34:10.057Z,1721352850.057 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 7.238418 min
2024-07-19T01:34:10.057Z,1721352850.057 [Default:CheckIn:E] Stopped
2024-07-19T01:34:10.057Z,1721352850.057 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-07-19T01:34:10.057Z,1721352850.057 [Default:CheckIn] Stopped
2024-07-19T01:34:10.057Z,1721352850.057 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-07-19T01:34:10.057Z,1721352850.057 [Default:CheckIn](INFO): Running loop #2
2024-07-19T01:34:10.058Z,1721352850.058 [Default:CheckIn] Running Loop=2
2024-07-19T01:34:10.058Z,1721352850.058 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-07-19T01:34:10.058Z,1721352850.058 [Default:CheckIn:Read_GPS] Running Loop=1
2024-07-19T01:34:12.069Z,1721352852.069 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,013411.00,A,4538.82215,N,08428.35562,W,1.341,41.13,190724,,,A*44
2024-07-19T01:34:12.071Z,1721352852.071 [NAL9602](INFO): GPS fix at 20240719T013411: (45.647036, -84.472594)
2024-07-19T01:34:12.081Z,1721352852.081 [Default:CheckIn:Read_GPS] Stopped
2024-07-19T01:34:12.081Z,1721352852.081 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-07-19T01:34:21.810Z,1721352861.810 [DataOverHttps](INFO): Sending 201 bytes from file Logs/20240719T012055/Courier0007.lzma
2024-07-19T01:34:22.812Z,1721352862.812 [DataOverHttps](INFO): Moved sent file to Logs/20240719T012055/Courier0007.lzma.bak
2024-07-19T01:34:22.812Z,1721352862.812 [DataOverHttps](INFO): SBD MOMSN=21368413
2024-07-19T01:34:47.371Z,1721352887.371 [DataOverHttps](INFO): Sending 832 bytes from file Logs/20240719T012055/Express0008.lzma
2024-07-19T01:34:48.372Z,1721352888.372 [DataOverHttps](INFO): Moved sent file to Logs/20240719T012055/Express0008.lzma.bak
2024-07-19T01:34:48.372Z,1721352888.372 [DataOverHttps](INFO): SBD MOMSN=21368416
2024-07-19T01:34:54.901Z,1721352894.901 [Default:CheckIn:Read_Iridium] Stopped
2024-07-19T01:34:54.901Z,1721352894.901 [Default:CheckIn:C.Wait] Running Loop=1
2024-07-19T01:34:54.901Z,1721352894.901 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-07-19T01:38:15.051Z,1721353095.051 [DataOverHttps](IMPORTANT): SBD MTMSN=20240719T013814
2024-07-19T01:38:26.255Z,1721353106.255 [DataOverHttps](INFO): Received command: restart app
2024-07-19T01:38:26.303Z,1721353106.303 [CommandExec](IMPORTANT): got command restart application
2024-07-19T01:38:27.306Z,1721353107.306 [Supervisor](INFO): Stop Mission called by Supervisor::terminate
2024-07-19T01:38:27.307Z,1721353107.307 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread.
2024-07-19T01:38:27.307Z,1721353107.307 [CommandExec](INFO): Uninitializing the command executive.
2024-07-19T01:38:27.307Z,1721353107.307 [CommandExec](INFO): Uninitializing the command scheduler.
2024-07-19T01:38:27.307Z,1721353107.307 [CommandExec ThreadHandler](INFO): Thread cancelled.
2024-07-19T01:38:27.470Z,1721353107.470 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye!
2024-07-19T01:38:27.470Z,1721353107.470 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2024-07-19T01:38:27.470Z,1721353107.470 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2024-07-19T01:38:27.471Z,1721353107.471 [NavChartDb](INFO): Join timeout helper Thread ID is 1298
2024-07-19T01:38:27.714Z,1721353107.714 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2024-07-19T01:38:27.715Z,1721353107.715 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2024-07-19T01:38:27.730Z,1721353107.730 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2024-07-19T01:38:27.730Z,1721353107.730 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2024-07-19T01:38:27.731Z,1721353107.731 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 1299
2024-07-19T01:38:27.731Z,1721353107.731 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread.
2024-07-19T01:38:27.731Z,1721353107.731 [WetLabsBB2FL](INFO): Powering down
2024-07-19T01:38:27.732Z,1721353107.732 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2024-07-19T01:38:27.733Z,1721353107.733 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler
2024-07-19T01:38:27.733Z,1721353107.733 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2024-07-19T01:38:27.733Z,1721353107.733 [CTD_Seabird](INFO): Join timeout helper Thread ID is 1300
2024-07-19T01:38:28.135Z,1721353108.135 [CTD_Seabird](INFO): Powering down
2024-07-19T01:38:28.146Z,1721353108.146 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread.
2024-07-19T01:38:28.146Z,1721353108.146 [CTD_Seabird](INFO): Powering down
2024-07-19T01:38:28.166Z,1721353108.166 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2024-07-19T01:38:28.174Z,1721353108.174 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2024-07-19T01:38:28.174Z,1721353108.174 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2024-07-19T01:38:28.175Z,1721353108.175 [Radio_Surface](INFO): Join timeout helper Thread ID is 1301
2024-07-19T01:38:28.374Z,1721353108.374 [Radio_Surface](INFO): Powering down
2024-07-19T01:38:28.375Z,1721353108.375 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2024-07-19T01:38:28.375Z,1721353108.375 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2024-07-19T01:38:28.390Z,1721353108.390 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler
2024-07-19T01:38:28.390Z,1721353108.390 [Onboard ThreadHandler](INFO): Thread cancelled.
2024-07-19T01:38:28.390Z,1721353108.390 [Onboard](INFO): Join timeout helper Thread ID is 1302
2024-07-19T01:38:29.274Z,1721353109.274 [DataOverHttps](INFO): Radio surface powered OFF, will not connect.
2024-07-19T01:38:32.414Z,1721353112.414 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread.
2024-07-19T01:38:32.414Z,1721353112.414 [Onboard ThreadHandler](INFO): Thread cancelled.
2024-07-19T01:38:32.427Z,1721353112.427 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler
2024-07-19T01:38:32.427Z,1721353112.427 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2024-07-19T01:38:32.427Z,1721353112.427 [DataOverHttps](INFO): Join timeout helper Thread ID is 1303
2024-07-19T01:38:33.290Z,1721353113.290 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread.
2024-07-19T01:38:33.290Z,1721353113.290 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2024-07-19T01:38:33.307Z,1721353113.307 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler
2024-07-19T01:38:33.307Z,1721353113.307 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2024-07-19T01:38:33.307Z,1721353113.307 [BackseatComponent](INFO): Join timeout helper Thread ID is 1304
2024-07-19T01:38:33.334Z,1721353113.334 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread.
2024-07-19T01:38:33.335Z,1721353113.335 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2024-07-19T01:38:33.347Z,1721353113.347 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2024-07-19T01:38:33.347Z,1721353113.347 [logger ThreadHandler](INFO): Thread cancelled.
2024-07-19T01:38:33.347Z,1721353113.347 [logger](INFO): Join timeout helper Thread ID is 1305
2024-07-19T01:38:33.363Z,1721353113.363 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2024-07-19T01:38:33.363Z,1721353113.363 [logger ThreadHandler](INFO): Thread cancelled.
2024-07-19T01:38:33.375Z,1721353113.375 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2024-07-19T01:38:33.375Z,1721353113.375 [CommandLine ThreadHandler](INFO): Thread cancelled.
2024-07-19T01:38:33.375Z,1721353113.375 [CommandLine](INFO): Join timeout helper Thread ID is 1306
2024-07-19T01:38:33.466Z,1721353113.466 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2024-07-19T01:38:33.467Z,1721353113.467 [CommandLine ThreadHandler](INFO): Thread cancelled.
2024-07-19T01:38:33.479Z,1721353113.479 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler
2024-07-19T01:38:33.479Z,1721353113.479 [CommandExec ThreadHandler](INFO): Thread cancelled.
2024-07-19T01:38:33.479Z,1721353113.479 [CommandExec](INFO): Join timeout helper Thread ID is 1307
2024-07-19T01:38:33.482Z,1721353113.482 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2024-07-19T01:38:33.482Z,1721353113.482 [controlThread ThreadHandler](INFO): Thread cancelled.
2024-07-19T01:38:33.483Z,1721353113.483 [controlThread](INFO): Join timeout helper Thread ID is 1308
2024-07-19T01:38:33.521Z,1721353113.521 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2024-07-19T01:38:33.521Z,1721353113.521 [controlThread](DEBUG): Uninitializing ControlThread
2024-07-19T01:38:33.521Z,1721353113.521 [AHRS_M2](INFO): Powering down
2024-07-19T01:38:33.595Z,1721353113.595 [NAL9602](INFO): Powering down
2024-07-19T01:38:33.596Z,1721353113.596 [Sonardyne_Nano](INFO): Powering down
2024-07-19T01:38:33.715Z,1721353113.715 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2024-07-19T01:38:33.716Z,1721353113.716 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2024-07-19T01:38:33.716Z,1721353113.716 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2024-07-19T01:38:33.716Z,1721353113.716 [MissionManager](INFO): Uninitializing Mission Default
2024-07-19T01:38:33.717Z,1721353113.717 [Default] Stopped
2024-07-19T01:38:33.717Z,1721353113.717 [Default](DEBUG): Aggregate::uninitialize Default
2024-07-19T01:38:33.717Z,1721353113.717 [Default:B.GoToSurface] Stopped
2024-07-19T01:38:33.717Z,1721353113.717 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2024-07-19T01:38:33.717Z,1721353113.717 [Default:CheckIn] Stopped
2024-07-19T01:38:33.717Z,1721353113.717 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-07-19T01:38:33.717Z,1721353113.717 [Default:CheckIn:C.Wait] Stopped
2024-07-19T01:38:33.717Z,1721353113.717 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-07-19T01:38:33.720Z,1721353113.720 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2024-07-19T01:38:33.720Z,1721353113.720 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2024-07-19T01:38:33.720Z,1721353113.720 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2024-07-19T01:38:33.721Z,1721353113.721 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2024-07-19T01:38:33.721Z,1721353113.721 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2024-07-19T01:38:33.721Z,1721353113.721 [BuoyancyServo](INFO): Powering down
2024-07-19T01:38:33.734Z,1721353113.734 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2024-07-19T01:38:33.734Z,1721353113.734 [ElevatorServo](INFO): Powering down
2024-07-19T01:38:33.735Z,1721353113.735 [MassServo](DEBUG): Uninitialize Mass Servo.
2024-07-19T01:38:33.735Z,1721353113.735 [MassServo](INFO): Powering down
2024-07-19T01:38:33.736Z,1721353113.736 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2024-07-19T01:38:33.736Z,1721353113.736 [RudderServo](INFO): Powering down
2024-07-19T01:38:33.737Z,1721353113.737 [ThrusterHE](DEBUG): Uninitialize Thruster Servo.
2024-07-19T01:38:33.737Z,1721353113.737 [ThrusterHE](INFO): Powering down
2024-07-19T01:38:33.738Z,1721353113.738 [SBIT](DEBUG): Uninitialize SBIT Component.
2024-07-19T01:38:33.738Z,1721353113.738 [IBIT](DEBUG): Uninitialize IBIT Component.
2024-07-19T01:38:33.738Z,1721353113.738 [CBIT](DEBUG): Uninitialize CBIT Component.
2024-07-19T01:38:33.738Z,1721353113.738 [CBIT](DEBUG): Powering off loads.
2024-07-19T01:38:33.750Z,1721353113.750 [CBIT](DEBUG): Disabling WDT.
2024-07-19T01:38:33.762Z,1721353113.762 [CBIT](DEBUG): Opening all GF detection circuits.
2024-07-19T01:38:33.763Z,1721353113.763 [controlThread ThreadHandler](INFO): Thread cancelled.
2024-07-19T01:38:33.825Z,1721353113.825 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2024-07-19T01:38:33.828Z,1721353113.828 [Onboard ThreadHandler](INFO): Thread cancelled.
2024-07-19T01:38:33.834Z,1721353113.834 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2024-07-19T01:38:33.878Z,1721353113.878 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2024-07-19T01:38:33.917Z,1721353113.917 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2024-07-19T01:38:33.922Z,1721353113.922 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2024-07-19T01:38:33.954Z,1721353113.954 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2024-07-19T01:38:34.019Z,1721353114.019 [logger ThreadHandler](INFO): Thread cancelled.