2023-08-23T21:57:07.163Z,1692827827.163 [Supervisor](DEBUG): Initializing supervisor.
2023-08-23T21:57:07.167Z,1692827827.167 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2023-08-23T21:57:07.168Z,1692827827.168 [SyncHandler](INFO): Protected caller Thread ID is 6466
2023-08-23T21:57:07.169Z,1692827827.168 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2023-08-23T21:57:07.169Z,1692827827.169 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2023-08-23T21:57:07.170Z,1692827827.170 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 6467
2023-08-23T21:57:07.174Z,1692827827.174 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2023-08-23T21:57:07.191Z,1692827827.191 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread.
2023-08-23T21:57:07.191Z,1692827827.191 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2023-08-23T21:57:07.192Z,1692827827.192 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 6468
2023-08-23T21:57:07.196Z,1692827827.196 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2023-08-23T21:57:07.197Z,1692827827.197 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2023-08-23T21:57:07.197Z,1692827827.197 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 6469
2023-08-23T21:57:07.199Z,1692827827.199 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2023-08-23T21:57:07.200Z,1692827827.200 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0
2023-08-23T21:57:07.200Z,1692827827.200 [logger ThreadHandler](INFO): Protected caller Thread ID is 6470
2023-08-23T21:57:07.204Z,1692827827.204 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2023-08-23T21:57:07.204Z,1692827827.204 [Supervisor](INFO): Looking for Config files in directory: Config/
2023-08-23T21:57:07.210Z,1692827827.210 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2023-08-23T21:57:07.372Z,1692827827.372 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2023-08-23T21:57:07.374Z,1692827827.374 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2023-08-23T21:57:08.051Z,1692827828.051 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2023-08-23T21:57:08.053Z,1692827828.053 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg
2023-08-23T21:57:08.268Z,1692827828.268 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock
2023-08-23T21:57:08.270Z,1692827828.270 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2023-08-23T21:57:08.351Z,1692827828.351 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2023-08-23T21:57:08.481Z,1692827828.481 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2023-08-23T21:57:08.483Z,1692827828.483 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2023-08-23T21:57:08.567Z,1692827828.567 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2023-08-23T21:57:08.675Z,1692827828.675 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2023-08-23T21:57:08.676Z,1692827828.676 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2023-08-23T21:57:09.132Z,1692827829.132 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2023-08-23T21:57:09.133Z,1692827829.133 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2023-08-23T21:57:09.603Z,1692827829.603 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2023-08-23T21:57:09.604Z,1692827829.604 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2023-08-23T21:57:09.817Z,1692827829.817 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2023-08-23T21:57:09.818Z,1692827829.818 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2023-08-23T21:57:10.004Z,1692827830.004 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2023-08-23T21:57:10.005Z,1692827830.005 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2023-08-23T21:57:10.502Z,1692827830.502 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2023-08-23T21:57:10.504Z,1692827830.504 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2023-08-23T21:57:10.830Z,1692827830.830 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2023-08-23T21:57:11.236Z,1692827831.236 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2023-08-23T21:57:11.546Z,1692827831.546 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2023-08-23T21:57:11.546Z,1692827831.546 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2023-08-23T21:57:11.922Z,1692827831.922 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2023-08-23T21:57:11.922Z,1692827831.922 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2023-08-23T21:57:12.248Z,1692827832.248 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2023-08-23T21:57:12.250Z,1692827832.250 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-pontus/
2023-08-23T21:57:12.252Z,1692827832.252 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/secure.cfg
2023-08-23T21:57:12.341Z,1692827832.341 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Sensor.cfg
2023-08-23T21:57:12.506Z,1692827832.506 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Servo.cfg
2023-08-23T21:57:12.611Z,1692827832.611 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Simulator.cfg
2023-08-23T21:57:12.701Z,1692827832.701 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/logger.cfg
2023-08-23T21:57:12.798Z,1692827832.798 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/vehicle.cfg
2023-08-23T21:57:12.914Z,1692827832.914 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Battery.cfg
2023-08-23T21:57:13.179Z,1692827833.179 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2023-08-23T21:57:13.180Z,1692827833.180 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Navigation.cfg
2023-08-23T21:57:13.278Z,1692827833.278 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/BIT.cfg
2023-08-23T21:57:13.379Z,1692827833.379 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Science.cfg
2023-08-23T21:57:13.518Z,1692827833.518 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Control.cfg
2023-08-23T21:57:13.620Z,1692827833.620 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-pontus/root/
2023-08-23T21:57:13.620Z,1692827833.620 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg
2023-08-23T21:57:13.636Z,1692827833.636 [Module Loader](DEBUG): Loading Module at Modules/Dock.so
2023-08-23T21:57:13.759Z,1692827833.759 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking)
2023-08-23T21:57:13.759Z,1692827833.759 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2023-08-23T21:57:13.826Z,1692827833.826 [VerticalControl](DEBUG): Construct VerticalControl.
2023-08-23T21:57:13.884Z,1692827833.884 [VerticalControl] Loaded
2023-08-23T21:57:13.884Z,1692827833.884 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2023-08-23T21:57:13.887Z,1692827833.887 [HorizontalControl](DEBUG): Construct HorizontalControl.
2023-08-23T21:57:13.927Z,1692827833.927 [HorizontalControl] Loaded
2023-08-23T21:57:13.928Z,1692827833.928 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2023-08-23T21:57:13.930Z,1692827833.930 [SpeedControl](DEBUG): Construct SpeedControl.
2023-08-23T21:57:13.933Z,1692827833.933 [SpeedControl] Loaded
2023-08-23T21:57:13.933Z,1692827833.933 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2023-08-23T21:57:13.936Z,1692827833.936 [LoopControl](DEBUG): Construct LoopControl.
2023-08-23T21:57:13.936Z,1692827833.936 [LoopControl] Loaded
2023-08-23T21:57:13.936Z,1692827833.936 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2023-08-23T21:57:13.937Z,1692827833.937 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2023-08-23T21:57:13.937Z,1692827833.937 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2023-08-23T21:57:14.005Z,1692827834.005 [DepthRateCalculator] Loaded
2023-08-23T21:57:14.006Z,1692827834.006 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2023-08-23T21:57:14.010Z,1692827834.010 [PitchRateCalculator] Loaded
2023-08-23T21:57:14.011Z,1692827834.011 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2023-08-23T21:57:14.020Z,1692827834.020 [SpeedCalculator] Loaded
2023-08-23T21:57:14.020Z,1692827834.020 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2023-08-23T21:57:14.025Z,1692827834.025 [YawRateCalculator] Loaded
2023-08-23T21:57:14.025Z,1692827834.025 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2023-08-23T21:57:14.043Z,1692827834.043 [ElevatorOffsetCalculator] Loaded
2023-08-23T21:57:14.043Z,1692827834.043 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2023-08-23T21:57:14.043Z,1692827834.043 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2023-08-23T21:57:14.044Z,1692827834.044 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2023-08-23T21:57:14.087Z,1692827834.087 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2023-08-23T21:57:14.087Z,1692827834.087 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2023-08-23T21:57:14.167Z,1692827834.167 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2023-08-23T21:57:14.168Z,1692827834.168 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2023-08-23T21:57:14.511Z,1692827834.511 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2023-08-23T21:57:14.511Z,1692827834.511 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2023-08-23T21:57:14.687Z,1692827834.687 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2023-08-23T21:57:14.688Z,1692827834.688 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2023-08-23T21:57:15.374Z,1692827835.374 [AHRS_M2] Loaded
2023-08-23T21:57:15.375Z,1692827835.375 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread.
2023-08-23T21:57:15.629Z,1692827835.629 [BackseatComponent] Loaded
2023-08-23T21:57:15.629Z,1692827835.629 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread.
2023-08-23T21:57:15.630Z,1692827835.630 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 4098F4E0
2023-08-23T21:57:15.630Z,1692827835.630 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 6553
2023-08-23T21:57:15.635Z,1692827835.635 [LcmUniversalReporter] Loaded
2023-08-23T21:57:15.635Z,1692827835.635 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread.
2023-08-23T21:57:16.434Z,1692827836.434 [BPC1] Loaded
2023-08-23T21:57:16.435Z,1692827836.435 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2023-08-23T21:57:16.573Z,1692827836.573 [DataOverHttps] Loaded
2023-08-23T21:57:16.601Z,1692827836.601 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2023-08-23T21:57:16.602Z,1692827836.602 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 409BF4E0
2023-08-23T21:57:16.603Z,1692827836.603 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 6554
2023-08-23T21:57:16.669Z,1692827836.669 [Depth_Keller] Loaded
2023-08-23T21:57:16.669Z,1692827836.669 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2023-08-23T21:57:16.694Z,1692827836.694 [DropWeight] Loaded
2023-08-23T21:57:16.694Z,1692827836.694 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2023-08-23T21:57:16.866Z,1692827836.866 [NAL9602] Loaded
2023-08-23T21:57:16.866Z,1692827836.866 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2023-08-23T21:57:16.895Z,1692827836.895 [Onboard] Loaded
2023-08-23T21:57:16.896Z,1692827836.896 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread.
2023-08-23T21:57:16.897Z,1692827836.897 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 409EF4E0
2023-08-23T21:57:16.897Z,1692827836.897 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 6555
2023-08-23T21:57:16.903Z,1692827836.903 [PowerOnly](INFO): Adding load control power supply at /dev/loadB1
2023-08-23T21:57:16.914Z,1692827836.914 [PowerOnly] Loaded
2023-08-23T21:57:16.914Z,1692827836.914 [ComponentRegistry](DEBUG): SyncComponent "PowerOnly" handled in the control thread.
2023-08-23T21:57:16.928Z,1692827836.928 [Power24vConverter] Loaded
2023-08-23T21:57:16.937Z,1692827836.937 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread.
2023-08-23T21:57:16.958Z,1692827836.958 [Radio_Surface] Loaded
2023-08-23T21:57:16.958Z,1692827836.958 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2023-08-23T21:57:16.968Z,1692827836.968 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 40A1F4E0
2023-08-23T21:57:16.969Z,1692827836.969 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 6556
2023-08-23T21:57:17.083Z,1692827837.083 [RDI_Pathfinder] Loaded
2023-08-23T21:57:17.083Z,1692827837.083 [ComponentRegistry](DEBUG): SyncComponent "RDI_Pathfinder" handled in the control thread.
2023-08-23T21:57:17.340Z,1692827837.340 [DAT] Loaded
2023-08-23T21:57:17.340Z,1692827837.340 [ComponentRegistry](DEBUG): Component "DAT" handled in its own thread.
2023-08-23T21:57:17.341Z,1692827837.341 [DAT ThreadHandler](DEBUG): Created PCaller Thread at 40A4F4E0
2023-08-23T21:57:17.341Z,1692827837.341 [DAT ThreadHandler](INFO): Protected caller Thread ID is 6557
2023-08-23T21:57:17.342Z,1692827837.342 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2023-08-23T21:57:17.343Z,1692827837.343 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2023-08-23T21:57:17.491Z,1692827837.491 [DeadReckonUsingMultipleVelocitySources] Loaded
2023-08-23T21:57:17.492Z,1692827837.492 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2023-08-23T21:57:17.505Z,1692827837.505 [NavChart] Loaded
2023-08-23T21:57:17.505Z,1692827837.505 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2023-08-23T21:57:17.511Z,1692827837.511 [UniversalFixResidualReporter] Loaded
2023-08-23T21:57:17.511Z,1692827837.511 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2023-08-23T21:57:17.512Z,1692827837.512 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2023-08-23T21:57:17.513Z,1692827837.513 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2023-08-23T21:57:17.676Z,1692827837.676 [SBIT](DEBUG): Construct Startup Built In Test.
2023-08-23T21:57:17.684Z,1692827837.684 [SBIT] Loaded
2023-08-23T21:57:17.685Z,1692827837.685 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2023-08-23T21:57:17.688Z,1692827837.688 [IBIT](DEBUG): Construct Initiated Built In Test.
2023-08-23T21:57:17.701Z,1692827837.701 [IBIT] Loaded
2023-08-23T21:57:17.701Z,1692827837.701 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2023-08-23T21:57:17.707Z,1692827837.707 [CBIT](DEBUG): Construct Continuous Built In Test.
2023-08-23T21:57:17.808Z,1692827837.808 [CBIT] Loaded
2023-08-23T21:57:17.809Z,1692827837.809 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2023-08-23T21:57:17.809Z,1692827837.809 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2023-08-23T21:57:17.810Z,1692827837.810 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2023-08-23T21:57:17.966Z,1692827837.966 [BuoyancyServo] Loaded
2023-08-23T21:57:17.966Z,1692827837.966 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2023-08-23T21:57:17.986Z,1692827837.986 [ElevatorServo] Loaded
2023-08-23T21:57:17.987Z,1692827837.987 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2023-08-23T21:57:18.006Z,1692827838.006 [MassServo] Loaded
2023-08-23T21:57:18.006Z,1692827838.006 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2023-08-23T21:57:18.024Z,1692827838.024 [RudderServo] Loaded
2023-08-23T21:57:18.025Z,1692827838.025 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2023-08-23T21:57:18.042Z,1692827838.042 [ThrusterServo] Loaded
2023-08-23T21:57:18.042Z,1692827838.042 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread.
2023-08-23T21:57:18.042Z,1692827838.042 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2023-08-23T21:57:18.043Z,1692827838.043 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2023-08-23T21:57:18.058Z,1692827838.058 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2023-08-23T21:57:18.059Z,1692827838.059 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2023-08-23T21:57:18.276Z,1692827838.276 [CTD_Seabird] Loaded
2023-08-23T21:57:18.277Z,1692827838.277 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread.
2023-08-23T21:57:18.278Z,1692827838.278 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40B9A4E0
2023-08-23T21:57:18.278Z,1692827838.278 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 6558
2023-08-23T21:57:18.298Z,1692827838.298 [PAR_Licor] Loaded
2023-08-23T21:57:18.298Z,1692827838.298 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2023-08-23T21:57:18.338Z,1692827838.338 [WetLabsBB2FL] Loaded
2023-08-23T21:57:18.338Z,1692827838.338 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2023-08-23T21:57:18.339Z,1692827838.339 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40BCA4E0
2023-08-23T21:57:18.339Z,1692827838.339 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 6559
2023-08-23T21:57:18.359Z,1692827838.359 [WetLabsUBAT] Loaded
2023-08-23T21:57:18.359Z,1692827838.359 [ComponentRegistry](DEBUG): Component "WetLabsUBAT" handled in its own thread.
2023-08-23T21:57:18.360Z,1692827838.360 [WetLabsUBAT ThreadHandler](DEBUG): Created PCaller Thread at 40BFA4E0
2023-08-23T21:57:18.360Z,1692827838.360 [WetLabsUBAT ThreadHandler](INFO): Protected caller Thread ID is 6560
2023-08-23T21:57:18.361Z,1692827838.361 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2023-08-23T21:57:18.367Z,1692827838.367 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2023-08-23T21:57:18.370Z,1692827838.370 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2023-08-23T21:57:18.381Z,1692827838.381 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2023-08-23T21:57:18.382Z,1692827838.382 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40C2A4E0
2023-08-23T21:57:18.382Z,1692827838.382 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 6561
2023-08-23T21:57:18.387Z,1692827838.387 [Supervisor](INFO): Main Thread ID is 6465
2023-08-23T21:57:18.387Z,1692827838.387 [Supervisor](DEBUG): Running supervisor.
2023-08-23T21:57:18.387Z,1692827838.387 [CommandExec ThreadHandler](INFO): Handler Thread ID is 6562
2023-08-23T21:57:18.388Z,1692827838.388 [CommandExec](INFO): Initializing the command executive.
2023-08-23T21:57:18.389Z,1692827838.389 [CommandLine ThreadHandler](INFO): Handler Thread ID is 6563
2023-08-23T21:57:18.392Z,1692827838.392 [controlThread ThreadHandler](INFO): Handler Thread ID is 6564
2023-08-23T21:57:18.392Z,1692827838.392 [controlThread](DEBUG): Initializing ControlThread
2023-08-23T21:57:18.393Z,1692827838.393 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2023-08-23T21:57:18.395Z,1692827838.395 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2023-08-23T21:57:18.396Z,1692827838.396 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2023-08-23T21:57:18.396Z,1692827838.396 [LoopControl](DEBUG): Initialize LoopControlComponent.
2023-08-23T21:57:18.396Z,1692827838.396 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2023-08-23T21:57:18.397Z,1692827838.397 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2023-08-23T21:57:18.397Z,1692827838.397 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2023-08-23T21:57:18.397Z,1692827838.397 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2023-08-23T21:57:18.398Z,1692827838.398 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2023-08-23T21:57:18.404Z,1692827838.404 [NavChart](DEBUG): Initialize NavChart Navigation.
2023-08-23T21:57:18.404Z,1692827838.404 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2023-08-23T21:57:18.405Z,1692827838.405 [SBIT](INFO): Initialize SBIT Component.
2023-08-23T21:57:18.405Z,1692827838.405 [SBIT](IMPORTANT): git: 2023-08-02-8-ga2b2183f7
2023-08-23T21:57:18.405Z,1692827838.405 [SBIT](INFO): git hash: a2b2183f71e07b707bfeaaf571c74c3561721119
2023-08-23T21:57:18.406Z,1692827838.406 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2023-08-23T21:57:18.407Z,1692827838.407 [SBIT](INFO): Kernel Reporting Different Version From Configuration.
Kernel Expected: #1 PREEMPT Thu Feb 21 11:17:40 PST 2019
Kernel Reported: #1 PREEMPT Wed Mar 17 08:23:48 PDT 2021
2023-08-23T21:57:18.408Z,1692827838.408 [SBIT](INFO): Beginning SBIT in 41.000000 seconds.
2023-08-23T21:57:18.409Z,1692827838.409 [IBIT](INFO): Initialize IBIT Component.
2023-08-23T21:57:18.410Z,1692827838.410 [CBIT](DEBUG): Initialize CBIT Component.
2023-08-23T21:57:18.411Z,1692827838.411 [logger ThreadHandler](INFO): Handler Thread ID is 6565
2023-08-23T21:57:18.421Z,1692827838.421 [CBIT](DEBUG): Initialized mux pins.
2023-08-23T21:57:18.422Z,1692827838.422 [CBIT](DEBUG): Initializing the watchdog timer.
2023-08-23T21:57:18.430Z,1692827838.430 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 6566
2023-08-23T21:57:18.442Z,1692827838.442 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 6567
2023-08-23T21:57:18.443Z,1692827838.443 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2023-08-23T21:57:18.446Z,1692827838.446 [CBIT](CRITICAL): LAST REBOOT DUE TO WATCHDOG TIMER RESET.
2023-08-23T21:57:18.446Z,1692827838.446 [CBIT](DEBUG): Initializing heartbeat.
2023-08-23T21:57:18.454Z,1692827838.454 [Onboard ThreadHandler](INFO): Handler Thread ID is 6568
2023-08-23T21:57:18.472Z,1692827838.472 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 6569
2023-08-23T21:57:18.490Z,1692827838.490 [DAT ThreadHandler](INFO): Handler Thread ID is 6570
2023-08-23T21:57:18.491Z,1692827838.491 [DAT](INFO): Powering up
2023-08-23T21:57:18.491Z,1692827838.491 [DAT](DEBUG): Initializing DAT.
2023-08-23T21:57:18.495Z,1692827838.495 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 6572
2023-08-23T21:57:18.496Z,1692827838.496 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2023-08-23T21:57:18.506Z,1692827838.506 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 6574
2023-08-23T21:57:18.511Z,1692827838.511 [WetLabsBB2FL](INFO): Powering up
2023-08-23T21:57:18.512Z,1692827838.512 [WetLabsUBAT ThreadHandler](INFO): Handler Thread ID is 6576
2023-08-23T21:57:18.517Z,1692827838.517 [CBIT](DEBUG): Deactivating GF circuits.
2023-08-23T21:57:18.518Z,1692827838.518 [CBIT](DEBUG): Deactivating emergency mode.
2023-08-23T21:57:18.518Z,1692827838.518 [WetLabsUBAT](INFO): Powering up
2023-08-23T21:57:18.519Z,1692827838.519 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 6578
2023-08-23T21:57:18.529Z,1692827838.529 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2023-08-23T21:57:18.530Z,1692827838.530 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2023-08-23T21:57:18.530Z,1692827838.530 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2023-08-23T21:57:18.530Z,1692827838.530 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2023-08-23T21:57:18.530Z,1692827838.530 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2023-08-23T21:57:18.530Z,1692827838.530 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2023-08-23T21:57:18.531Z,1692827838.531 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2023-08-23T21:57:18.531Z,1692827838.531 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2023-08-23T21:57:18.557Z,1692827838.557 [CBIT](DEBUG): Backplane powered.
2023-08-23T21:57:18.562Z,1692827838.562 [MissionManager](INFO): Loading Mission from file: Missions/Startup.xml
2023-08-23T21:57:18.612Z,1692827838.612 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2023-08-23T21:57:18.632Z,1692827838.632 [MissionManager](DEBUG): 
<?xml version="1.0" encoding="UTF-8"?>
<Mission xmlns="Tethys"
       xmlns:Control="Tethys/Control"
       xmlns:Guidance="Tethys/Guidance" 
       xmlns:Units="Tethys/Units"
       xmlns:Universal="Tethys/Universal"
       xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"
       xsi:schemaLocation="Tethys http://okeanids.mbari.org/tethys/Xml/Tethys.xsd
                           Tethys/Control http://okeanids.mbari.org/tethys/Xml/Control.xsd
                           Tethys/Guidance http://okeanids.mbari.org/tethys/Xml/Guidance.xsd
                           Tethys/Units http://okeanids.mbari.org/tethys/Xml/Units.xsd
                           Tethys/Universal http://okeanids.mbari.org/tethys/Xml/Universal.xsd"
       Id="Startup">

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

    <Aggregate Id="StartupSatComms">

        <Sequence/>

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

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

    </Aggregate>

</Mission>


2023-08-23T21:57:18.632Z,1692827838.632 [MissionManager](INFO): Loading Mission from file: Missions/Default.xml
2023-08-23T21:57:18.746Z,1692827838.746 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2023-08-23T21:57:18.747Z,1692827838.747 [Default:A.Wait](DEBUG): Construct Wait.
2023-08-23T21:57:18.769Z,1692827838.769 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2023-08-23T21:57:18.797Z,1692827838.797 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2023-08-23T21:57:18.800Z,1692827838.800 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2023-08-23T21:57:18.826Z,1692827838.826 [Default:E.Execute](DEBUG): Construct Execute.
2023-08-23T21:57:18.829Z,1692827838.829 [MissionManager](DEBUG): 
<?xml version="1.0" encoding="UTF-8"?>
<Mission xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"
         xmlns="Tethys"
         xmlns:Units="Tethys/Units"
         xmlns:Guidance="Tethys/Guidance"
         xmlns:Universal="Tethys/Universal"
         xsi:schemaLocation="Tethys http://okeanids.mbari.org/tethys/Xml/Tethys.xsd
                             Tethys/Units http://okeanids.mbari.org/tethys/Xml/Units.xsd
                             Tethys/Guidance http://okeanids.mbari.org/tethys/Xml/Guidance.xsd
                             Tethys/Universal http://okeanids.mbari.org/tethys/Xml/Universal.xsd"
         Id="Default">

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

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

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

    <Aggregate Id="CheckIn">

        <Sequence Repeat="288"/>

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

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

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

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

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

    </Aggregate>

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

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

</Mission>


2023-08-23T21:57:18.850Z,1692827838.850 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,DropWeight,NAL9602,PowerOnly,Power24vConverter,RDI_Pathfinder,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter,
2023-08-23T21:57:18.856Z,1692827838.856 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2023-08-23T21:57:18.878Z,1692827838.878 [Radio_Surface](INFO): Powering up
2023-08-23T21:57:18.996Z,1692827838.996 [Depth_Keller](ERROR): Pressure or depth reading out of range: -1.000394 decibar, -0.993016 m
2023-08-23T21:57:18.998Z,1692827838.998 [PowerOnly](INFO): Powering up loadControl
2023-08-23T21:57:19.018Z,1692827839.018 [Power24vConverter](INFO): Powering up.
2023-08-23T21:57:19.019Z,1692827839.019 [RDI_Pathfinder](IMPORTANT): Expecting PD13 message format
2023-08-23T21:57:19.032Z,1692827839.032 [DepthRateCalculator](ERROR): Depth measurement is not active
2023-08-23T21:57:19.059Z,1692827839.059 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2023-08-23T21:57:19.066Z,1692827839.066 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2023-08-23T21:57:19.067Z,1692827839.067 [ElevatorServo](DEBUG): Initializing EZServoServo.
2023-08-23T21:57:19.074Z,1692827839.074 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2023-08-23T21:57:19.075Z,1692827839.075 [MassServo](DEBUG): Initializing EZServoServo.
2023-08-23T21:57:19.082Z,1692827839.082 [MassServo](DEBUG): Initializing MassServo.
2023-08-23T21:57:19.083Z,1692827839.083 [RudderServo](DEBUG): Initializing EZServoServo.
2023-08-23T21:57:19.090Z,1692827839.090 [RudderServo](DEBUG): Initializing RudderServo.
2023-08-23T21:57:19.091Z,1692827839.091 [ThrusterServo](DEBUG): Initializing EZServoServo.
2023-08-23T21:57:19.098Z,1692827839.098 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2023-08-23T21:57:19.100Z,1692827839.100 [CommandExec](FAULT): Scheduling is paused
2023-08-23T21:57:19.100Z,1692827839.100 [CBIT](INFO): Critical error at 20230823T215718
2023-08-23T21:57:19.101Z,1692827839.101 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals
2023-08-23T21:57:19.299Z,1692827839.299 [DropWeight](CRITICAL): DROP WEIGHT MISSING.

2023-08-23T21:57:19.299Z,1692827839.299 [DropWeight] Hardware Fault, FailCount= 1
2023-08-23T21:57:19.299Z,1692827839.299 [DropWeight](ERROR): Hardware Fault
2023-08-23T21:57:19.316Z,1692827839.316 [CBIT](INFO): Critical error at 20230823T215719
2023-08-23T21:57:19.327Z,1692827839.327 [CBIT](ERROR): Hardware Fault in component: DropWeight
2023-08-23T21:57:19.327Z,1692827839.327 [CBIT](CRITICAL): Hardware Fault in component: DropWeight
2023-08-23T21:57:19.696Z,1692827839.696 [CBIT](INFO): Critical error at 20230823T215719
2023-08-23T21:57:21.122Z,1692827841.122 [WetLabsBB2FL](INFO): Powering down
2023-08-23T21:57:27.122Z,1692827847.122 [CommandExec](IMPORTANT): got command gfscan
2023-08-23T21:57:27.478Z,1692827847.478 [CBIT](IMPORTANT): Beginning ground fault scan
2023-08-23T21:57:27.785Z,1692827847.785 [WetLabsUBAT](INFO): Powering down
2023-08-23T21:57:31.342Z,1692827851.342 [DAT](INFO): DAT read: 

2023-08-23T21:57:31.344Z,1692827851.344 [DAT](INFO): DAT read: Teledyne Benthos DAT-900 Series

2023-08-23T21:57:31.795Z,1692827851.795 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004539
2023-08-23T21:57:32.854Z,1692827852.854 [DAT](INFO): DAT read: MF Frequency Band

2023-08-23T21:57:32.855Z,1692827852.855 [DAT](INFO): DAT read: Directional Acoustic Transponder version 8.15.0

2023-08-23T21:57:32.856Z,1692827852.856 [DAT](INFO): DAT read: Aug 15 2023 22:24:28 

2023-08-23T21:57:34.115Z,1692827854.115 [DAT](INFO): DAT read: Features enabled [Bearing]

2023-08-23T21:57:34.116Z,1692827854.116 [DAT](INFO): DAT read: CONNECT 00800 bits/sec 1 of 4, Rate 1/2 CC 12.50ms MGP

2023-08-23T21:57:34.116Z,1692827854.116 [DAT](INFO): commRate: 800
2023-08-23T21:57:36.181Z,1692827856.181 [DAT](INFO): entering command mode
2023-08-23T21:57:36.382Z,1692827856.382 [DAT](INFO): DAT read: 

2023-08-23T21:57:36.383Z,1692827856.383 [DAT](INFO): DAT read: user:1>

2023-08-23T21:57:36.383Z,1692827856.383 [DAT](INFO): setting verbose to 3
2023-08-23T21:57:36.634Z,1692827856.634 [DAT](INFO): DAT read: user:1>

2023-08-23T21:57:36.635Z,1692827856.635 [DAT](INFO): DAT read: Verbose         | 3           

2023-08-23T21:57:36.635Z,1692827856.635 [DAT](INFO): set verbose to 3
2023-08-23T21:57:36.636Z,1692827856.636 [DAT](INFO): setting DatVerbose to 27440
2023-08-23T21:57:36.886Z,1692827856.886 [DAT](INFO): DAT read: user:2>

2023-08-23T21:57:36.887Z,1692827856.887 [DAT](INFO): DAT read: DatVerbose      | 27440       

2023-08-23T21:57:36.887Z,1692827856.887 [DAT](INFO): set DatVerbose to 27440
2023-08-23T21:57:36.888Z,1692827856.888 [DAT](INFO): setting transmit power to 8
2023-08-23T21:57:37.138Z,1692827857.138 [DAT](INFO): DAT read: user:3>

2023-08-23T21:57:37.139Z,1692827857.139 [DAT](INFO): DAT read: TxPower         | 8 (Max)     

2023-08-23T21:57:37.139Z,1692827857.139 [DAT](INFO): set transmit power to 8
2023-08-23T21:57:37.140Z,1692827857.140 [DAT](INFO): setting local address to 10
2023-08-23T21:57:37.390Z,1692827857.390 [DAT](INFO): DAT read: user:4>

2023-08-23T21:57:37.391Z,1692827857.391 [DAT](INFO): DAT read: LocalAddr       | 10          

2023-08-23T21:57:37.391Z,1692827857.391 [DAT](INFO): set local address to 10
2023-08-23T21:57:37.392Z,1692827857.392 [DAT](INFO): Setting time to: 21:57:37 And date to:8/23/2023
2023-08-23T21:57:37.642Z,1692827857.642 [DAT](INFO): DAT read: user:5>

2023-08-23T21:57:37.643Z,1692827857.643 [DAT](INFO): DAT read: Wed Aug 23, 2023  21:57:37  

2023-08-23T21:57:37.643Z,1692827857.643 [DAT](INFO): Local DAT time set to Wed Aug 23, 2023  21:57:37  

2023-08-23T21:57:38.796Z,1692827858.796 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): 0.002125
CHAN A1 (24V): 0.001367
CHAN A2 (12V): -0.007562
CHAN A3 (5V): -0.002937
CHAN B0 (3.3V): 0.004395
CHAN B1 (3.15aV): -0.000567
CHAN B2 (3.15bV): 0.000214
CHAN B3 (GND): 0.002378
OPEN: 0.005300
Full Scale: +/- 1 mA
2023-08-23T21:57:47.175Z,1692827867.175 [NAL9602](INFO): Powering up NAL9602
2023-08-23T21:57:52.098Z,1692827872.098 [CommandExec](IMPORTANT): got command gfscan
2023-08-23T21:57:52.490Z,1692827872.490 [CBIT](IMPORTANT): Beginning ground fault scan
2023-08-23T21:57:58.083Z,1692827878.083 [NAL9602](INFO): NAL9602 initialized
2023-08-23T21:58:00.184Z,1692827880.184 [SBIT](IMPORTANT): Beginning Startup BIT
2023-08-23T21:58:03.501Z,1692827883.501 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): 0.001708
CHAN A1 (24V): 0.001907
CHAN A2 (12V): -0.007080
CHAN A3 (5V): -0.002354
CHAN B0 (3.3V): -0.000636
CHAN B1 (3.15aV): -0.002577
CHAN B2 (3.15bV): 0.000416
CHAN B3 (GND): 0.001827
OPEN: 0.005239
Full Scale: +/- 1 mA
2023-08-23T21:58:30.523Z,1692827910.523 [CommandExec](IMPORTANT): got command strobe off
2023-08-23T21:58:30.523Z,1692827910.523 [CommandExec](IMPORTANT): Deactivating strobe
2023-08-23T21:58:36.886Z,1692827916.886 [RDI_Pathfinder](ERROR): only read 3 of 4 data items for beam range. Device response is::RA,  0.00,   0.00,   0.00,   0.00
2023-08-23T21:58:54.295Z,1692827934.295 [SBIT](IMPORTANT): SBIT PASSED
2023-08-23T21:58:54.295Z,1692827934.295 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2023-08-23T21:58:54.296Z,1692827934.296 [SBIT](IMPORTANT): BPC1.batteryMissingStickThreshold=2 count;

2023-08-23T21:58:54.297Z,1692827934.297 [SBIT](IMPORTANT): CBIT.gf24Offset=143 microampere;

2023-08-23T21:58:54.297Z,1692827934.297 [SBIT](IMPORTANT): Express none CTD_Seabird.bin_median_sea_water_salinity;

2023-08-23T21:58:54.297Z,1692827934.297 [SBIT](IMPORTANT): Express none PowerOnly.component_avgCurrent_loadControl;

2023-08-23T21:58:54.297Z,1692827934.297 [SBIT](IMPORTANT): Express none WetLabsUBAT.flow_rate;

2023-08-23T21:58:54.314Z,1692827934.314 [SBIT](IMPORTANT): IBIT.batteryCapacityThreshold=20 ampere_hour;

2023-08-23T21:58:54.314Z,1692827934.314 [SBIT](IMPORTANT): IBIT.batteryVoltageThreshold=12 volt;

2023-08-23T21:58:54.314Z,1692827934.314 [SBIT](IMPORTANT): RDI_Pathfinder.loadAtStartup=1 bool;

2023-08-23T21:58:54.314Z,1692827934.314 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=183.016767 cubic_centimeter;

2023-08-23T21:58:54.314Z,1692827934.314 [SBIT](IMPORTANT): VerticalControl.massDefault=5.356425 millimeter;

2023-08-23T21:58:54.314Z,1692827934.314 [SBIT](IMPORTANT): WetLabsUBAT.loadAtStartup=1 bool;

2023-08-23T21:58:54.687Z,1692827934.687 [MissionManager](IMPORTANT): Started mission Startup
2023-08-23T21:58:54.687Z,1692827934.687 [Startup] Running Loop=1
2023-08-23T21:58:54.687Z,1692827934.687 [Startup](DEBUG): Aggregate::initialize Startup
2023-08-23T21:58:54.687Z,1692827934.687 [Startup:A.GoToSurface] Running Loop=1
2023-08-23T21:58:54.687Z,1692827934.687 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2023-08-23T21:58:54.688Z,1692827934.688 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2023-08-23T21:58:54.688Z,1692827934.688 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2023-08-23T21:58:54.689Z,1692827934.689 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2023-08-23T21:58:54.689Z,1692827934.689 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2023-08-23T21:58:54.690Z,1692827934.690 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2023-08-23T21:58:54.692Z,1692827934.692 [Startup:StartupSatComms] Running Loop=1
2023-08-23T21:58:54.692Z,1692827934.692 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2023-08-23T21:58:54.692Z,1692827934.692 [Startup:StartupSatComms:A] Running Loop=1
2023-08-23T21:58:55.064Z,1692827935.064 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2023-08-23T21:59:54.874Z,1692827994.874 [Startup:StartupSatComms:A](INFO): Timed out from 2023-08-23T21:58:54.7Z
2023-08-23T21:59:54.874Z,1692827994.874 [Startup:StartupSatComms:A] Stopped
2023-08-23T21:59:54.874Z,1692827994.874 [Startup:StartupSatComms:B] Running Loop=1
2023-08-23T21:59:55.265Z,1692827995.265 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2023-08-23T22:00:02.544Z,1692828002.544 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20230815T185138/Courier0040.lzma
2023-08-23T22:00:03.544Z,1692828003.544 [DataOverHttps](INFO): Moved sent file to Logs/20230815T185138/Courier0040.lzma.bak
2023-08-23T22:00:03.544Z,1692828003.544 [DataOverHttps](INFO): SBD MOMSN=18586382
2023-08-23T22:00:18.723Z,1692828018.723 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2023-08-23T22:00:18.723Z,1692828018.723 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-08-23T22:00:18.744Z,1692828018.744 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-08-23T22:00:19.100Z,1692828019.100 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-08-23T22:00:19.100Z,1692828019.100 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2023-08-23T22:00:19.487Z,1692828019.487 [DataOverHttps](INFO): Sending 281 bytes from file Logs/20230815T214636/Courier0000.lzma
2023-08-23T22:00:20.487Z,1692828020.487 [DataOverHttps](INFO): Moved sent file to Logs/20230815T214636/Courier0000.lzma.bak
2023-08-23T22:00:20.487Z,1692828020.487 [DataOverHttps](INFO): SBD MOMSN=18586384
2023-08-23T22:00:37.349Z,1692828037.349 [DataOverHttps](INFO): Sending 282 bytes from file Logs/20230823T215707/Courier0000.lzma
2023-08-23T22:00:38.351Z,1692828038.351 [DataOverHttps](INFO): Moved sent file to Logs/20230823T215707/Courier0000.lzma.bak
2023-08-23T22:00:38.351Z,1692828038.351 [DataOverHttps](INFO): SBD MOMSN=18586390
2023-08-23T22:00:54.338Z,1692828054.338 [DataOverHttps](INFO): Sending 95 bytes from file Logs/20230815T185138/Express0041.lzma
2023-08-23T22:00:55.108Z,1692828055.108 [Startup:StartupSatComms:B](INFO): Timed out from 2023-08-23T21:59:54.9Z
2023-08-23T22:00:55.108Z,1692828055.108 [Startup:StartupSatComms:B] Stopped
2023-08-23T22:00:55.108Z,1692828055.108 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2023-08-23T22:00:55.108Z,1692828055.108 [Startup:StartupSatComms] Stopped
2023-08-23T22:00:55.109Z,1692828055.109 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2023-08-23T22:00:55.110Z,1692828055.110 [Startup](INFO): Completed Startup
2023-08-23T22:00:55.110Z,1692828055.110 [MissionManager](INFO): Startup is completed.
2023-08-23T22:00:55.110Z,1692828055.110 [MissionManager](INFO): Uninitializing Mission Startup
2023-08-23T22:00:55.110Z,1692828055.110 [Startup] Stopped
2023-08-23T22:00:55.110Z,1692828055.110 [Startup](DEBUG): Aggregate::uninitialize Startup
2023-08-23T22:00:55.110Z,1692828055.110 [Startup:A.GoToSurface] Stopped
2023-08-23T22:00:55.110Z,1692828055.110 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2023-08-23T22:00:55.339Z,1692828055.339 [DataOverHttps](INFO): Moved sent file to Logs/20230815T185138/Express0041.lzma.bak
2023-08-23T22:00:55.340Z,1692828055.340 [DataOverHttps](INFO): SBD MOMSN=18586396
2023-08-23T22:00:55.500Z,1692828055.500 [MissionManager](IMPORTANT): Started mission Default
2023-08-23T22:00:55.500Z,1692828055.500 [Default] Running Loop=1
2023-08-23T22:00:55.500Z,1692828055.500 [Default](DEBUG): Aggregate::initialize Default
2023-08-23T22:00:55.500Z,1692828055.500 [Default:B.GoToSurface] Running Loop=1
2023-08-23T22:00:55.500Z,1692828055.500 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2023-08-23T22:00:55.500Z,1692828055.500 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2023-08-23T22:00:55.501Z,1692828055.501 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2023-08-23T22:00:55.501Z,1692828055.501 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2023-08-23T22:00:55.526Z,1692828055.526 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2023-08-23T22:00:55.526Z,1692828055.526 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2023-08-23T22:00:55.526Z,1692828055.526 [Default:A.Wait] Running Loop=1
2023-08-23T22:00:55.526Z,1692828055.526 [Default:A.Wait](DEBUG): Initialize Wait Component.
2023-08-23T22:01:08.876Z,1692828068.876 [Default:A.Wait](INFO): Done Waiting.
2023-08-23T22:01:08.876Z,1692828068.876 [Default:A.Wait] Stopped
2023-08-23T22:01:08.876Z,1692828068.876 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2023-08-23T22:01:09.244Z,1692828069.244 [Default:CheckIn] Running Loop=1
2023-08-23T22:01:09.244Z,1692828069.244 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2023-08-23T22:01:09.244Z,1692828069.244 [Default:CheckIn:Read_GPS] Running Loop=1
2023-08-23T22:01:09.656Z,1692828069.656 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2023-08-23T22:03:01.563Z,1692828181.563 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2023-08-23T22:03:19.756Z,1692828199.756 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2
2023-08-23T22:03:19.756Z,1692828199.756 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-08-23T22:03:19.767Z,1692828199.767 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-08-23T22:03:20.166Z,1692828200.166 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-08-23T22:03:20.166Z,1692828200.166 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2
2023-08-23T22:04:47.815Z,1692828287.815 [BPC1](INFO): Calculating totals. Valid battery stick count: 56. Valid reserve battery stick count: 6.
2023-08-23T22:04:47.818Z,1692828287.818 [BPC1](INFO): Received data from all battery sticks.
2023-08-23T22:06:09.456Z,1692828369.456 [Default:CheckIn:Read_GPS](INFO): Timed out from 2023-08-23T22:01:09.2Z
2023-08-23T22:06:09.456Z,1692828369.456 [Default:CheckIn:Read_GPS] Stopped
2023-08-23T22:06:09.456Z,1692828369.456 [Default:CheckIn:Read_Iridium] Running Loop=1
2023-08-23T22:06:09.860Z,1692828369.860 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications
2023-08-23T22:06:20.065Z,1692828380.065 [DataOverHttps](INFO): Sending 168 bytes from file Logs/20230823T215707/Courier0004.lzma
2023-08-23T22:06:20.855Z,1692828380.855 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3
2023-08-23T22:06:20.855Z,1692828380.855 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-08-23T22:06:20.891Z,1692828380.891 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-08-23T22:06:21.236Z,1692828381.236 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-08-23T22:06:21.236Z,1692828381.236 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3
2023-08-23T22:06:30.103Z,1692828390.103 [DataOverHttps](INFO): Moved sent file to Logs/20230823T215707/Courier0004.lzma.bak
2023-08-23T22:06:30.103Z,1692828390.103 [DataOverHttps](INFO): SBD MOMSN=18586422
2023-08-23T22:06:46.056Z,1692828406.056 [DataOverHttps](INFO): Sending 1078 bytes from file Logs/20230815T214636/Express0001.lzma
2023-08-23T22:06:47.055Z,1692828407.055 [DataOverHttps](INFO): Moved sent file to Logs/20230815T214636/Express0001.lzma.bak
2023-08-23T22:06:47.055Z,1692828407.055 [DataOverHttps](INFO): SBD MOMSN=18586424
2023-08-23T22:07:02.979Z,1692828422.979 [DataOverHttps](INFO): Sending 1065 bytes from file Logs/20230823T215707/Express0001.lzma
2023-08-23T22:07:03.980Z,1692828423.980 [DataOverHttps](INFO): Moved sent file to Logs/20230823T215707/Express0001.lzma.bak
2023-08-23T22:07:03.980Z,1692828423.980 [DataOverHttps](INFO): SBD MOMSN=18586458
2023-08-23T22:07:19.749Z,1692828439.749 [DataOverHttps](INFO): Sending 188 bytes from file Logs/20230823T215707/Express0005.lzma
2023-08-23T22:07:20.751Z,1692828440.751 [DataOverHttps](INFO): Moved sent file to Logs/20230823T215707/Express0005.lzma.bak
2023-08-23T22:07:20.751Z,1692828440.751 [DataOverHttps](INFO): SBD MOMSN=18586488
2023-08-23T22:07:22.204Z,1692828442.204 [Default:CheckIn:Read_Iridium] Stopped
2023-08-23T22:07:22.204Z,1692828442.204 [Default:CheckIn:C.Wait] Running Loop=1
2023-08-23T22:07:22.204Z,1692828442.204 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2023-08-23T22:07:58.951Z,1692828478.951 [NAL9602](FAULT): GPS failed to acquire within timeout.
2023-08-23T22:07:58.951Z,1692828478.951 [NAL9602] Data Fault, FailCount= 1
2023-08-23T22:07:58.951Z,1692828478.951 [NAL9602](ERROR): Data Fault
2023-08-23T22:07:59.026Z,1692828479.026 [CBIT](ERROR): Data Fault in component: NAL9602
2023-08-23T22:07:59.359Z,1692828479.359 [NAL9602](INFO): Powering down
2023-08-23T22:08:00.205Z,1692828480.205 [CBIT](INFO): Clearing failed state for component NAL9602
2023-08-23T22:08:00.205Z,1692828480.205 [NAL9602] No Fault, FailCount= 1
2023-08-23T22:08:29.659Z,1692828509.659 [NAL9602](INFO): Powering up NAL9602
2023-08-23T22:08:40.597Z,1692828520.597 [NAL9602](INFO): NAL9602 initialized
2023-08-23T22:09:21.803Z,1692828561.803 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4
2023-08-23T22:09:21.803Z,1692828561.803 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-08-23T22:09:21.839Z,1692828561.839 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-08-23T22:09:22.205Z,1692828562.205 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-08-23T22:09:22.205Z,1692828562.205 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4
2023-08-23T22:12:19.585Z,1692828739.585 [CBIT](INFO): Clearing failed state for component DropWeight
2023-08-23T22:12:19.586Z,1692828739.586 [DropWeight] No Fault, FailCount= 1
2023-08-23T22:12:22.856Z,1692828742.856 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 5
2023-08-23T22:12:22.856Z,1692828742.856 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-08-23T22:12:22.862Z,1692828742.862 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2023-08-23T22:12:22.862Z,1692828742.862 [Default:CheckIn:C.Wait] Stopped
2023-08-23T22:12:22.862Z,1692828742.862 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2023-08-23T22:12:22.862Z,1692828742.862 [Default:CheckIn:D] Running Loop=1
2023-08-23T22:12:22.896Z,1692828742.896 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-08-23T22:12:23.215Z,1692828743.215 [Default:CheckIn:D] Stopped
2023-08-23T22:12:23.215Z,1692828743.215 [Default:CheckIn:E] Running Loop=1
2023-08-23T22:12:23.224Z,1692828743.224 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-08-23T22:12:23.225Z,1692828743.225 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 5
2023-08-23T22:12:23.599Z,1692828743.599 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 11.461921 min 
2023-08-23T22:12:23.600Z,1692828743.600 [Default:CheckIn:E] Stopped
2023-08-23T22:12:23.600Z,1692828743.600 [Default:CheckIn](INFO): Completed Default:CheckIn
2023-08-23T22:12:23.600Z,1692828743.600 [Default:CheckIn] Stopped
2023-08-23T22:12:23.600Z,1692828743.600 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2023-08-23T22:12:23.600Z,1692828743.600 [Default:CheckIn](INFO): Running loop #2
2023-08-23T22:12:23.600Z,1692828743.600 [Default:CheckIn] Running Loop=2
2023-08-23T22:12:23.600Z,1692828743.600 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2023-08-23T22:12:23.600Z,1692828743.600 [Default:CheckIn:Read_GPS] Running Loop=1
2023-08-23T22:13:26.652Z,1692828806.652 [RDI_Pathfinder](ERROR): only read 3 of 4 data items for bottom velocity. Device response is::BS,-32768,-32768,5.98
2023-08-23T22:13:28.596Z,1692828808.596 [CommandExec](IMPORTANT): got command gfscan
2023-08-23T22:13:28.720Z,1692828808.720 [CBIT](IMPORTANT): Beginning ground fault scan
2023-08-23T22:13:39.590Z,1692828819.590 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): -0.005910
CHAN A1 (24V): 0.005865
CHAN A2 (12V): -0.004398
CHAN A3 (5V): -0.000510
CHAN B0 (3.3V): 0.000787
CHAN B1 (3.15aV): 0.000617
CHAN B2 (3.15bV): 0.000293
CHAN B3 (GND): 0.001506
OPEN: 0.005258
Full Scale: +/- 1 mA
2023-08-23T22:13:49.758Z,1692828829.758 [CommandExec](IMPORTANT): got command quit
2023-08-23T22:13:50.762Z,1692828830.762 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread.
2023-08-23T22:13:50.762Z,1692828830.762 [CommandExec](INFO): Uninitializing the command executive.
2023-08-23T22:13:50.762Z,1692828830.762 [CommandExec](INFO): Uninitializing the command scheduler.
2023-08-23T22:13:50.762Z,1692828830.762 [CommandExec ThreadHandler](INFO): Thread cancelled.
2023-08-23T22:13:50.905Z,1692828830.905 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup.  Bye!
2023-08-23T22:13:50.906Z,1692828830.906 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2023-08-23T22:13:50.906Z,1692828830.906 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2023-08-23T22:13:50.906Z,1692828830.906 [NavChartDb](INFO): Join timeout helper Thread ID is 6629
2023-08-23T22:13:51.026Z,1692828831.026 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2023-08-23T22:13:51.026Z,1692828831.026 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2023-08-23T22:13:51.037Z,1692828831.037 [ComponentRegistry](INFO): Shutting down WetLabsUBAT ThreadHandler
2023-08-23T22:13:51.037Z,1692828831.037 [WetLabsUBAT ThreadHandler](INFO): Thread cancelled.
2023-08-23T22:13:51.038Z,1692828831.038 [WetLabsUBAT](INFO): Join timeout helper Thread ID is 6630
2023-08-23T22:13:51.122Z,1692828831.122 [WetLabsUBAT ThreadHandler](INFO): Uninitializing protected caller thread.
2023-08-23T22:13:51.122Z,1692828831.122 [WetLabsUBAT](INFO): Powering down
2023-08-23T22:13:51.123Z,1692828831.123 [WetLabsUBAT ThreadHandler](INFO): Thread cancelled.
2023-08-23T22:13:51.137Z,1692828831.137 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2023-08-23T22:13:51.137Z,1692828831.137 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2023-08-23T22:13:51.138Z,1692828831.138 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 6631
2023-08-23T22:13:51.438Z,1692828831.438 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread.
2023-08-23T22:13:51.438Z,1692828831.438 [WetLabsBB2FL](INFO): Powering down
2023-08-23T22:13:51.439Z,1692828831.439 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2023-08-23T22:13:51.441Z,1692828831.441 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler
2023-08-23T22:13:51.441Z,1692828831.441 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2023-08-23T22:13:51.442Z,1692828831.442 [CTD_Seabird](INFO): Join timeout helper Thread ID is 6632
2023-08-23T22:13:51.678Z,1692828831.678 [CTD_Seabird](INFO): Powering down
2023-08-23T22:13:51.690Z,1692828831.690 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread.
2023-08-23T22:13:51.690Z,1692828831.690 [CTD_Seabird](INFO): Powering down
2023-08-23T22:13:51.701Z,1692828831.701 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2023-08-23T22:13:51.712Z,1692828831.712 [ComponentRegistry](INFO): Shutting down DAT ThreadHandler
2023-08-23T22:13:51.712Z,1692828831.712 [DAT ThreadHandler](INFO): Thread cancelled.
2023-08-23T22:13:51.712Z,1692828831.712 [DAT](INFO): Join timeout helper Thread ID is 6633
2023-08-23T22:13:51.905Z,1692828831.905 [DAT](INFO): Powering down
2023-08-23T22:13:51.978Z,1692828831.978 [DAT ThreadHandler](INFO): Uninitializing protected caller thread.
2023-08-23T22:13:51.978Z,1692828831.978 [DAT](INFO): Powering down
2023-08-23T22:13:51.979Z,1692828831.979 [DAT ThreadHandler](INFO): Thread cancelled.
2023-08-23T22:13:51.994Z,1692828831.994 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2023-08-23T22:13:51.994Z,1692828831.994 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2023-08-23T22:13:51.995Z,1692828831.995 [Radio_Surface](INFO): Join timeout helper Thread ID is 6634
2023-08-23T22:13:52.225Z,1692828832.225 [Radio_Surface](INFO): Powering down
2023-08-23T22:13:52.226Z,1692828832.226 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2023-08-23T22:13:52.227Z,1692828832.227 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2023-08-23T22:13:52.238Z,1692828832.238 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler
2023-08-23T22:13:52.238Z,1692828832.238 [Onboard ThreadHandler](INFO): Thread cancelled.
2023-08-23T22:13:52.239Z,1692828832.239 [Onboard](INFO): Join timeout helper Thread ID is 6635
2023-08-23T22:13:52.910Z,1692828832.910 [DataOverHttps](INFO): Radio surface powered OFF, will not connect.
2023-08-23T22:13:54.302Z,1692828834.302 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread.
2023-08-23T22:13:54.302Z,1692828834.302 [Onboard ThreadHandler](INFO): Thread cancelled.
2023-08-23T22:13:54.322Z,1692828834.322 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler
2023-08-23T22:13:54.322Z,1692828834.322 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2023-08-23T22:13:54.323Z,1692828834.323 [DataOverHttps](INFO): Join timeout helper Thread ID is 6636
2023-08-23T22:13:54.918Z,1692828834.918 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread.
2023-08-23T22:13:54.918Z,1692828834.918 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2023-08-23T22:13:54.930Z,1692828834.930 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler
2023-08-23T22:13:54.930Z,1692828834.930 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2023-08-23T22:13:54.931Z,1692828834.931 [BackseatComponent](INFO): Join timeout helper Thread ID is 6637
2023-08-23T22:13:55.050Z,1692828835.050 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread.
2023-08-23T22:13:55.050Z,1692828835.050 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2023-08-23T22:13:55.062Z,1692828835.062 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2023-08-23T22:13:55.062Z,1692828835.062 [logger ThreadHandler](INFO): Thread cancelled.
2023-08-23T22:13:55.063Z,1692828835.063 [logger](INFO): Join timeout helper Thread ID is 6638
2023-08-23T22:13:55.073Z,1692828835.073 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2023-08-23T22:13:55.074Z,1692828835.074 [logger ThreadHandler](INFO): Thread cancelled.
2023-08-23T22:13:55.082Z,1692828835.082 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2023-08-23T22:13:55.082Z,1692828835.082 [CommandLine ThreadHandler](INFO): Thread cancelled.
2023-08-23T22:13:55.083Z,1692828835.083 [CommandLine](INFO): Join timeout helper Thread ID is 6639
2023-08-23T22:13:55.129Z,1692828835.129 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2023-08-23T22:13:55.130Z,1692828835.130 [CommandLine ThreadHandler](INFO): Thread cancelled.
2023-08-23T22:13:55.142Z,1692828835.142 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler
2023-08-23T22:13:55.142Z,1692828835.142 [CommandExec ThreadHandler](INFO): Thread cancelled.
2023-08-23T22:13:55.143Z,1692828835.143 [CommandExec](INFO): Join timeout helper Thread ID is 6640
2023-08-23T22:13:55.144Z,1692828835.144 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2023-08-23T22:13:55.144Z,1692828835.144 [controlThread ThreadHandler](INFO): Thread cancelled.
2023-08-23T22:13:55.144Z,1692828835.144 [controlThread](INFO): Join timeout helper Thread ID is 6641
2023-08-23T22:13:55.282Z,1692828835.282 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2023-08-23T22:13:55.282Z,1692828835.282 [controlThread](DEBUG): Uninitializing ControlThread
2023-08-23T22:13:55.282Z,1692828835.282 [AHRS_M2](INFO): Powering down
2023-08-23T22:13:55.354Z,1692828835.354 [NAL9602](INFO): Powering down
2023-08-23T22:13:55.425Z,1692828835.425 [RDI_Pathfinder](INFO): Powering down
2023-08-23T22:13:55.427Z,1692828835.427 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2023-08-23T22:13:55.428Z,1692828835.428 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2023-08-23T22:13:55.428Z,1692828835.428 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2023-08-23T22:13:55.429Z,1692828835.429 [MissionManager](INFO): Uninitializing Mission Default
2023-08-23T22:13:55.429Z,1692828835.429 [Default] Stopped
2023-08-23T22:13:55.429Z,1692828835.429 [Default](DEBUG): Aggregate::uninitialize Default
2023-08-23T22:13:55.429Z,1692828835.429 [Default:B.GoToSurface] Stopped
2023-08-23T22:13:55.429Z,1692828835.429 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2023-08-23T22:13:55.429Z,1692828835.429 [Default:CheckIn] Stopped
2023-08-23T22:13:55.429Z,1692828835.429 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2023-08-23T22:13:55.429Z,1692828835.429 [Default:CheckIn:Read_GPS] Stopped
2023-08-23T22:13:55.432Z,1692828835.432 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2023-08-23T22:13:55.433Z,1692828835.433 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2023-08-23T22:13:55.433Z,1692828835.433 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2023-08-23T22:13:55.433Z,1692828835.433 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2023-08-23T22:13:55.434Z,1692828835.434 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2023-08-23T22:13:55.434Z,1692828835.434 [BuoyancyServo](INFO): Powering down
2023-08-23T22:13:55.446Z,1692828835.446 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2023-08-23T22:13:55.446Z,1692828835.446 [ElevatorServo](INFO): Powering down
2023-08-23T22:13:55.447Z,1692828835.447 [MassServo](DEBUG): Uninitialize Mass Servo.
2023-08-23T22:13:55.447Z,1692828835.447 [MassServo](INFO): Powering down
2023-08-23T22:13:55.447Z,1692828835.447 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2023-08-23T22:13:55.448Z,1692828835.448 [RudderServo](INFO): Powering down
2023-08-23T22:13:55.448Z,1692828835.448 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2023-08-23T22:13:55.448Z,1692828835.448 [ThrusterServo](INFO): Powering down
2023-08-23T22:13:55.449Z,1692828835.449 [SBIT](DEBUG): Uninitialize SBIT Component.
2023-08-23T22:13:55.450Z,1692828835.450 [IBIT](DEBUG): Uninitialize IBIT Component.
2023-08-23T22:13:55.450Z,1692828835.450 [CBIT](DEBUG): Uninitialize CBIT Component.
2023-08-23T22:13:55.450Z,1692828835.450 [CBIT](DEBUG): Powering off loads.
2023-08-23T22:13:55.461Z,1692828835.461 [CBIT](DEBUG): Disabling WDT.
2023-08-23T22:13:55.473Z,1692828835.473 [CBIT](DEBUG): Opening all GF detection circuits.
2023-08-23T22:13:55.474Z,1692828835.474 [controlThread ThreadHandler](INFO): Thread cancelled.
2023-08-23T22:13:55.524Z,1692828835.524 [DAT ThreadHandler](INFO): Thread cancelled.
2023-08-23T22:13:55.532Z,1692828835.532 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2023-08-23T22:13:55.534Z,1692828835.534 [Onboard ThreadHandler](INFO): Thread cancelled.
2023-08-23T22:13:55.540Z,1692828835.540 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2023-08-23T22:13:55.583Z,1692828835.583 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2023-08-23T22:13:55.641Z,1692828835.641 [WetLabsUBAT ThreadHandler](INFO): Thread cancelled.
2023-08-23T22:13:55.643Z,1692828835.643 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2023-08-23T22:13:55.647Z,1692828835.647 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2023-08-23T22:13:55.655Z,1692828835.655 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2023-08-23T22:13:55.715Z,1692828835.715 [logger ThreadHandler](INFO): Thread cancelled.