2024-05-07T17:58:37.892Z,1715104717.892 [Supervisor](DEBUG): Initializing supervisor.
2024-05-07T17:58:37.897Z,1715104717.897 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2024-05-07T17:58:37.897Z,1715104717.897 [SyncHandler](INFO): Protected caller Thread ID is 3373
2024-05-07T17:58:37.898Z,1715104717.898 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2024-05-07T17:58:37.899Z,1715104717.899 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2024-05-07T17:58:37.899Z,1715104717.899 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 3374
2024-05-07T17:58:37.903Z,1715104717.903 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2024-05-07T17:58:37.921Z,1715104717.921 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread.
2024-05-07T17:58:37.922Z,1715104717.922 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2024-05-07T17:58:37.922Z,1715104717.922 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 3375
2024-05-07T17:58:37.927Z,1715104717.927 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2024-05-07T17:58:37.928Z,1715104717.928 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2024-05-07T17:58:37.928Z,1715104717.928 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 3376
2024-05-07T17:58:37.930Z,1715104717.930 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2024-05-07T17:58:37.931Z,1715104717.931 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0
2024-05-07T17:58:37.931Z,1715104717.931 [logger ThreadHandler](INFO): Protected caller Thread ID is 3377
2024-05-07T17:58:37.935Z,1715104717.935 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2024-05-07T17:58:37.935Z,1715104717.935 [Supervisor](INFO): Looking for Config files in directory: Config/
2024-05-07T17:58:37.937Z,1715104717.937 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2024-05-07T17:58:38.162Z,1715104718.162 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2024-05-07T17:58:38.162Z,1715104718.162 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2024-05-07T17:58:38.284Z,1715104718.284 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2024-05-07T17:58:38.285Z,1715104718.285 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2024-05-07T17:58:38.392Z,1715104718.392 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2024-05-07T17:58:38.393Z,1715104718.393 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2024-05-07T17:58:38.897Z,1715104718.897 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2024-05-07T17:58:38.897Z,1715104718.897 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2024-05-07T17:58:39.264Z,1715104719.264 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2024-05-07T17:58:39.265Z,1715104719.265 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2024-05-07T17:58:39.622Z,1715104719.622 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2024-05-07T17:58:39.622Z,1715104719.622 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2024-05-07T17:58:39.823Z,1715104719.823 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2024-05-07T17:58:39.824Z,1715104719.824 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2024-05-07T17:58:39.916Z,1715104719.916 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2024-05-07T17:58:40.010Z,1715104720.010 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2024-05-07T17:58:40.485Z,1715104720.485 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2024-05-07T17:58:40.485Z,1715104720.485 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2024-05-07T17:58:41.004Z,1715104721.004 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2024-05-07T17:58:41.005Z,1715104721.005 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2024-05-07T17:58:41.581Z,1715104721.581 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2024-05-07T17:58:41.581Z,1715104721.581 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2024-05-07T17:58:41.820Z,1715104721.820 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2024-05-07T17:58:41.821Z,1715104721.821 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg
2024-05-07T17:58:42.080Z,1715104722.080 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock
2024-05-07T17:58:42.080Z,1715104722.080 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2024-05-07T17:58:42.231Z,1715104722.231 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2024-05-07T17:58:42.231Z,1715104722.231 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2024-05-07T17:58:43.113Z,1715104723.113 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2024-05-07T17:58:43.115Z,1715104723.115 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-galene/
2024-05-07T17:58:43.116Z,1715104723.116 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/secure.cfg
2024-05-07T17:58:43.212Z,1715104723.212 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/vehicle.cfg
2024-05-07T17:58:43.353Z,1715104723.353 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Battery.cfg
2024-05-07T17:58:43.628Z,1715104723.628 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2024-05-07T17:58:43.629Z,1715104723.629 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Science.cfg
2024-05-07T17:58:43.766Z,1715104723.766 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Control.cfg
2024-05-07T17:58:43.877Z,1715104723.877 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/logger.cfg
2024-05-07T17:58:43.984Z,1715104723.984 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Servo.cfg
2024-05-07T17:58:44.104Z,1715104724.104 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Navigation.cfg
2024-05-07T17:58:44.211Z,1715104724.211 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Simulator.cfg
2024-05-07T17:58:44.310Z,1715104724.310 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/BIT.cfg
2024-05-07T17:58:44.412Z,1715104724.412 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Sensor.cfg
2024-05-07T17:58:44.596Z,1715104724.596 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-galene/root/
2024-05-07T17:58:44.596Z,1715104724.596 [Supervisor](IMPORTANT): Reloading configuration overrides from Data/persisted.cfg
2024-05-07T17:58:44.600Z,1715104724.600 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2024-05-07T17:58:44.651Z,1715104724.651 [DepthRateCalculator] Loaded
2024-05-07T17:58:44.651Z,1715104724.651 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2024-05-07T17:58:44.657Z,1715104724.657 [PitchRateCalculator] Loaded
2024-05-07T17:58:44.658Z,1715104724.658 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2024-05-07T17:58:44.668Z,1715104724.668 [SpeedCalculator] Loaded
2024-05-07T17:58:44.668Z,1715104724.668 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2024-05-07T17:58:44.673Z,1715104724.673 [YawRateCalculator] Loaded
2024-05-07T17:58:44.673Z,1715104724.673 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2024-05-07T17:58:44.694Z,1715104724.694 [ElevatorOffsetCalculator] Loaded
2024-05-07T17:58:44.694Z,1715104724.694 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2024-05-07T17:58:44.695Z,1715104724.695 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2024-05-07T17:58:44.695Z,1715104724.695 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2024-05-07T17:58:44.722Z,1715104724.722 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2024-05-07T17:58:44.722Z,1715104724.722 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2024-05-07T17:58:44.732Z,1715104724.732 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2024-05-07T17:58:44.733Z,1715104724.733 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2024-05-07T17:58:45.187Z,1715104725.187 [AHRS_M2] Loaded
2024-05-07T17:58:45.187Z,1715104725.187 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread.
2024-05-07T17:58:45.222Z,1715104725.222 [BackseatComponent] Loaded
2024-05-07T17:58:45.222Z,1715104725.222 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread.
2024-05-07T17:58:45.224Z,1715104725.224 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 408584E0
2024-05-07T17:58:45.224Z,1715104725.224 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 3459
2024-05-07T17:58:45.227Z,1715104725.227 [LcmUniversalReporter] Loaded
2024-05-07T17:58:45.227Z,1715104725.227 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread.
2024-05-07T17:58:46.195Z,1715104726.195 [BPC1] Loaded
2024-05-07T17:58:46.196Z,1715104726.196 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2024-05-07T17:58:46.267Z,1715104726.267 [DataOverHttps] Loaded
2024-05-07T17:58:46.267Z,1715104726.267 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2024-05-07T17:58:46.268Z,1715104726.268 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 408884E0
2024-05-07T17:58:46.268Z,1715104726.268 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 3460
2024-05-07T17:58:46.288Z,1715104726.288 [Depth_Keller] Loaded
2024-05-07T17:58:46.289Z,1715104726.289 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2024-05-07T17:58:46.293Z,1715104726.293 [DropWeight] Loaded
2024-05-07T17:58:46.293Z,1715104726.293 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2024-05-07T17:58:46.355Z,1715104726.355 [NAL9602] Loaded
2024-05-07T17:58:46.355Z,1715104726.355 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2024-05-07T17:58:46.384Z,1715104726.384 [Onboard] Loaded
2024-05-07T17:58:46.384Z,1715104726.384 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread.
2024-05-07T17:58:46.385Z,1715104726.385 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 408B84E0
2024-05-07T17:58:46.386Z,1715104726.386 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 3461
2024-05-07T17:58:46.398Z,1715104726.398 [Power24vConverter] Loaded
2024-05-07T17:58:46.398Z,1715104726.398 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread.
2024-05-07T17:58:46.412Z,1715104726.412 [Radio_Surface] Loaded
2024-05-07T17:58:46.412Z,1715104726.412 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2024-05-07T17:58:46.413Z,1715104726.413 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 408E84E0
2024-05-07T17:58:46.414Z,1715104726.414 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 3462
2024-05-07T17:58:46.427Z,1715104726.427 [Sonardyne_Nano] Loaded
2024-05-07T17:58:46.427Z,1715104726.427 [ComponentRegistry](DEBUG): SyncComponent "Sonardyne_Nano" handled in the control thread.
2024-05-07T17:58:46.517Z,1715104726.517 [DAT] Loaded
2024-05-07T17:58:46.517Z,1715104726.517 [ComponentRegistry](DEBUG): Component "DAT" handled in its own thread.
2024-05-07T17:58:46.518Z,1715104726.518 [DAT ThreadHandler](DEBUG): Created PCaller Thread at 409184E0
2024-05-07T17:58:46.518Z,1715104726.518 [DAT ThreadHandler](INFO): Protected caller Thread ID is 3463
2024-05-07T17:58:46.541Z,1715104726.541 [Waterlinked] Loaded
2024-05-07T17:58:46.541Z,1715104726.541 [ComponentRegistry](DEBUG): SyncComponent "Waterlinked" handled in the control thread.
2024-05-07T17:58:46.541Z,1715104726.541 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2024-05-07T17:58:46.542Z,1715104726.542 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2024-05-07T17:58:46.651Z,1715104726.651 [DeadReckonUsingMultipleVelocitySources] Loaded
2024-05-07T17:58:46.652Z,1715104726.652 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2024-05-07T17:58:46.692Z,1715104726.692 [DeadReckonUsingSpeedCalculator] Loaded
2024-05-07T17:58:46.693Z,1715104726.693 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread.
2024-05-07T17:58:46.706Z,1715104726.706 [NavChart] Loaded
2024-05-07T17:58:46.706Z,1715104726.706 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2024-05-07T17:58:46.712Z,1715104726.712 [UniversalFixResidualReporter] Loaded
2024-05-07T17:58:46.712Z,1715104726.712 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2024-05-07T17:58:46.713Z,1715104726.713 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2024-05-07T17:58:46.713Z,1715104726.713 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2024-05-07T17:58:46.853Z,1715104726.853 [SBIT](DEBUG): Construct Startup Built In Test.
2024-05-07T17:58:46.867Z,1715104726.867 [SBIT] Loaded
2024-05-07T17:58:46.867Z,1715104726.867 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2024-05-07T17:58:46.870Z,1715104726.870 [IBIT](DEBUG): Construct Initiated Built In Test.
2024-05-07T17:58:46.882Z,1715104726.882 [IBIT] Loaded
2024-05-07T17:58:46.883Z,1715104726.883 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2024-05-07T17:58:46.888Z,1715104726.888 [CBIT](DEBUG): Construct Continuous Built In Test.
2024-05-07T17:58:47.001Z,1715104727.001 [CBIT] Loaded
2024-05-07T17:58:47.001Z,1715104727.001 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2024-05-07T17:58:47.002Z,1715104727.002 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2024-05-07T17:58:47.002Z,1715104727.002 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2024-05-07T17:58:47.173Z,1715104727.173 [CTD_Seabird] Loaded
2024-05-07T17:58:47.173Z,1715104727.173 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread.
2024-05-07T17:58:47.174Z,1715104727.174 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40A204E0
2024-05-07T17:58:47.175Z,1715104727.175 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 3464
2024-05-07T17:58:47.195Z,1715104727.195 [PAR_Licor] Loaded
2024-05-07T17:58:47.196Z,1715104727.196 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2024-05-07T17:58:47.239Z,1715104727.239 [WetLabsBB2FL] Loaded
2024-05-07T17:58:47.239Z,1715104727.239 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2024-05-07T17:58:47.240Z,1715104727.240 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40A504E0
2024-05-07T17:58:47.240Z,1715104727.240 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 3465
2024-05-07T17:58:47.241Z,1715104727.241 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2024-05-07T17:58:47.241Z,1715104727.241 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2024-05-07T17:58:47.372Z,1715104727.372 [BuoyancyServo] Loaded
2024-05-07T17:58:47.373Z,1715104727.373 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2024-05-07T17:58:47.394Z,1715104727.394 [ElevatorServo] Loaded
2024-05-07T17:58:47.394Z,1715104727.394 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2024-05-07T17:58:47.415Z,1715104727.415 [MassServo] Loaded
2024-05-07T17:58:47.415Z,1715104727.415 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2024-05-07T17:58:47.435Z,1715104727.435 [RudderServo] Loaded
2024-05-07T17:58:47.436Z,1715104727.436 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2024-05-07T17:58:47.452Z,1715104727.452 [ThrusterHE] Loaded
2024-05-07T17:58:47.452Z,1715104727.452 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread.
2024-05-07T17:58:47.452Z,1715104727.452 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2024-05-07T17:58:47.453Z,1715104727.453 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2024-05-07T17:58:47.505Z,1715104727.505 [VerticalControl](DEBUG): Construct VerticalControl.
2024-05-07T17:58:47.556Z,1715104727.556 [VerticalControl] Loaded
2024-05-07T17:58:47.556Z,1715104727.556 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2024-05-07T17:58:47.559Z,1715104727.559 [HorizontalControl](DEBUG): Construct HorizontalControl.
2024-05-07T17:58:47.602Z,1715104727.602 [HorizontalControl] Loaded
2024-05-07T17:58:47.603Z,1715104727.603 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2024-05-07T17:58:47.605Z,1715104727.605 [SpeedControl](DEBUG): Construct SpeedControl.
2024-05-07T17:58:47.607Z,1715104727.607 [SpeedControl] Loaded
2024-05-07T17:58:47.607Z,1715104727.607 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2024-05-07T17:58:47.610Z,1715104727.610 [LoopControl](DEBUG): Construct LoopControl.
2024-05-07T17:58:47.610Z,1715104727.610 [LoopControl] Loaded
2024-05-07T17:58:47.611Z,1715104727.611 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2024-05-07T17:58:47.611Z,1715104727.611 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2024-05-07T17:58:47.612Z,1715104727.612 [Module Loader](DEBUG): Loading Module at Modules/Dock.so
2024-05-07T17:58:47.726Z,1715104727.726 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking)
2024-05-07T17:58:47.727Z,1715104727.727 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2024-05-07T17:58:47.896Z,1715104727.896 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2024-05-07T17:58:47.896Z,1715104727.896 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2024-05-07T17:58:48.231Z,1715104728.231 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2024-05-07T17:58:48.231Z,1715104728.231 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2024-05-07T17:58:48.287Z,1715104728.287 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2024-05-07T17:58:48.294Z,1715104728.294 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2024-05-07T17:58:48.297Z,1715104728.297 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2024-05-07T17:58:48.308Z,1715104728.308 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2024-05-07T17:58:48.309Z,1715104728.309 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40C374E0
2024-05-07T17:58:48.309Z,1715104728.309 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 3466
2024-05-07T17:58:48.314Z,1715104728.314 [Supervisor](INFO): Main Thread ID is 2701
2024-05-07T17:58:48.314Z,1715104728.314 [Supervisor](DEBUG): Running supervisor.
2024-05-07T17:58:48.314Z,1715104728.314 [CommandExec ThreadHandler](INFO): Handler Thread ID is 3467
2024-05-07T17:58:48.315Z,1715104728.315 [CommandExec](INFO): Initializing the command executive.
2024-05-07T17:58:48.316Z,1715104728.316 [CommandLine ThreadHandler](INFO): Handler Thread ID is 3468
2024-05-07T17:58:48.319Z,1715104728.319 [controlThread ThreadHandler](INFO): Handler Thread ID is 3469
2024-05-07T17:58:48.319Z,1715104728.319 [controlThread](DEBUG): Initializing ControlThread
2024-05-07T17:58:48.320Z,1715104728.320 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2024-05-07T17:58:48.320Z,1715104728.320 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2024-05-07T17:58:48.321Z,1715104728.321 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2024-05-07T17:58:48.321Z,1715104728.321 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2024-05-07T17:58:48.321Z,1715104728.321 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2024-05-07T17:58:48.329Z,1715104728.329 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2024-05-07T17:58:48.329Z,1715104728.329 [NavChart](DEBUG): Initialize NavChart Navigation.
2024-05-07T17:58:48.329Z,1715104728.329 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2024-05-07T17:58:48.330Z,1715104728.330 [SBIT](INFO): Initialize SBIT Component.
2024-05-07T17:58:48.330Z,1715104728.330 [SBIT](IMPORTANT): git: 2024-05-07
2024-05-07T17:58:48.330Z,1715104728.330 [SBIT](INFO): git hash: caae5b805170f9c680da20e21004b1da522ccce4
2024-05-07T17:58:48.331Z,1715104728.331 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2024-05-07T17:58:48.332Z,1715104728.332 [SBIT](INFO): Kernel Reporting Different Version From Configuration.
Kernel Expected: #2 PREEMPT Thu Jan 11 20:13:48 PST 2018
Kernel Reported: #1 PREEMPT Wed Mar 17 08:23:48 PDT 2021
2024-05-07T17:58:48.333Z,1715104728.333 [SBIT](INFO): Beginning SBIT in 77.000000 seconds.
2024-05-07T17:58:48.334Z,1715104728.334 [IBIT](INFO): Initialize IBIT Component.
2024-05-07T17:58:48.335Z,1715104728.335 [CBIT](DEBUG): Initialize CBIT Component.
2024-05-07T17:58:48.335Z,1715104728.335 [logger ThreadHandler](INFO): Handler Thread ID is 3470
2024-05-07T17:58:48.346Z,1715104728.346 [CBIT](DEBUG): Initialized mux pins.
2024-05-07T17:58:48.346Z,1715104728.346 [CBIT](DEBUG): Initializing the watchdog timer.
2024-05-07T17:58:48.354Z,1715104728.354 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 3471
2024-05-07T17:58:48.366Z,1715104728.366 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 3472
2024-05-07T17:58:48.368Z,1715104728.368 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2024-05-07T17:58:48.370Z,1715104728.370 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2024-05-07T17:58:48.370Z,1715104728.370 [CBIT](DEBUG): Initializing heartbeat.
2024-05-07T17:58:48.379Z,1715104728.379 [Onboard ThreadHandler](INFO): Handler Thread ID is 3473
2024-05-07T17:58:48.396Z,1715104728.396 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 3474
2024-05-07T17:58:48.419Z,1715104728.419 [DAT ThreadHandler](INFO): Handler Thread ID is 3475
2024-05-07T17:58:48.419Z,1715104728.419 [DAT](INFO): Powering up
2024-05-07T17:58:48.420Z,1715104728.420 [DAT](DEBUG): Initializing DAT.
2024-05-07T17:58:48.423Z,1715104728.423 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 3477
2024-05-07T17:58:48.424Z,1715104728.424 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2024-05-07T17:58:48.427Z,1715104728.427 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 3479
2024-05-07T17:58:48.430Z,1715104728.430 [WetLabsBB2FL](INFO): Powering up
2024-05-07T17:58:48.432Z,1715104728.432 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 3481
2024-05-07T17:58:48.434Z,1715104728.434 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2024-05-07T17:58:48.435Z,1715104728.435 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2024-05-07T17:58:48.435Z,1715104728.435 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2024-05-07T17:58:48.435Z,1715104728.435 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2024-05-07T17:58:48.435Z,1715104728.435 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2024-05-07T17:58:48.435Z,1715104728.435 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2024-05-07T17:58:48.436Z,1715104728.436 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2024-05-07T17:58:48.436Z,1715104728.436 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2024-05-07T17:58:48.442Z,1715104728.442 [CBIT](DEBUG): Deactivating GF circuits.
2024-05-07T17:58:48.442Z,1715104728.442 [CBIT](DEBUG): Deactivating emergency mode.
2024-05-07T17:58:48.482Z,1715104728.482 [CBIT](DEBUG): Backplane powered.
2024-05-07T17:58:48.487Z,1715104728.487 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2024-05-07T17:58:48.489Z,1715104728.489 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2024-05-07T17:58:48.490Z,1715104728.490 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2024-05-07T17:58:48.490Z,1715104728.490 [LoopControl](DEBUG): Initialize LoopControlComponent.
2024-05-07T17:58:48.491Z,1715104728.491 [MissionManager](IMPORTANT): Using TethysL tl-to-tx parser
2024-05-07T17:58:48.492Z,1715104728.492 [MissionManager](INFO): Loading Mission from file: Missions/Startup.tl
2024-05-07T17:58:48.492Z,1715104728.492 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Startup.tl
2024-05-07T17:58:48.493Z,1715104728.493 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Startup.tl
2024-05-07T17:58:48.540Z,1715104728.540 [MissionManager](DEBUG): TethyslAPI: Missions/Startup.tl translated into:
2024-05-07T17:58:48.548Z,1715104728.548 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2024-05-07T17:58:48.580Z,1715104728.580 [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-05-07T17:58:48.580Z,1715104728.580 [MissionManager](INFO): Loading Mission from file: Missions/Default.tl
2024-05-07T17:58:48.580Z,1715104728.580 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Default.tl
2024-05-07T17:58:48.581Z,1715104728.581 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Default.tl
2024-05-07T17:58:48.783Z,1715104728.783 [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-05-07T17:58:48.802Z,1715104728.802 [Radio_Surface](INFO): Powering up
2024-05-07T17:58:48.806Z,1715104728.806 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2024-05-07T17:58:48.807Z,1715104728.807 [Default:A.Wait](DEBUG): Construct Wait.
2024-05-07T17:58:48.809Z,1715104728.809 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2024-05-07T17:58:48.838Z,1715104728.838 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2024-05-07T17:58:48.841Z,1715104728.841 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2024-05-07T17:58:48.870Z,1715104728.870 [Default:E.Execute](DEBUG): Construct Execute.
2024-05-07T17:58:48.873Z,1715104728.873 [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-05-07T17:58:48.878Z,1715104728.878 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,DropWeight,NAL9602,Power24vConverter,Sonardyne_Nano,Waterlinked,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,DeadReckonUsingSpeedCalculator,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter,
2024-05-07T17:58:48.885Z,1715104728.885 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2024-05-07T17:58:48.937Z,1715104728.937 [Power24vConverter](INFO): Powering up.
2024-05-07T17:58:48.938Z,1715104728.938 [Sonardyne_Nano](INFO): Initializing.
2024-05-07T17:58:49.019Z,1715104729.019 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2024-05-07T17:58:49.026Z,1715104729.026 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2024-05-07T17:58:49.027Z,1715104729.027 [ElevatorServo](DEBUG): Initializing EZServoServo.
2024-05-07T17:58:49.034Z,1715104729.034 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2024-05-07T17:58:49.035Z,1715104729.035 [MassServo](DEBUG): Initializing EZServoServo.
2024-05-07T17:58:49.043Z,1715104729.043 [MassServo](DEBUG): Initializing MassServo.
2024-05-07T17:58:49.043Z,1715104729.043 [RudderServo](DEBUG): Initializing EZServoServo.
2024-05-07T17:58:49.050Z,1715104729.050 [RudderServo](DEBUG): Initializing RudderServo.
2024-05-07T17:58:49.051Z,1715104729.051 [ThrusterHE](DEBUG): Initializing EZServoServo.
2024-05-07T17:58:49.062Z,1715104729.062 [ThrusterHE](DEBUG): Initializing ThrusterHE.
2024-05-07T17:58:50.908Z,1715104730.908 [Sonardyne_Nano](ERROR): Failed to get valid response or reached max queue size, flushing UART
2024-05-07T17:58:51.042Z,1715104731.042 [WetLabsBB2FL](INFO): Powering down
2024-05-07T17:58:52.195Z,1715104732.195 [Sonardyne_Nano](IMPORTANT): Found beacon with acoustic ID 2105
2024-05-07T17:58:52.566Z,1715104732.566 [Sonardyne_Nano](INFO): Battery below minimum, enabling charging
2024-05-07T17:58:54.771Z,1715104734.771 [ThrusterHE](ERROR): Zero Speed Commanded.
2024-05-07T17:58:55.455Z,1715104735.455 [CTD_Seabird](ERROR): Device message queue exceeded the allowed limit.
2024-05-07T17:59:00.774Z,1715104740.774 [DAT](INFO): DAT read:
2024-05-07T17:59:00.776Z,1715104740.776 [DAT](INFO): DAT read: Teledyne Benthos DAT-900 Series
2024-05-07T17:59:02.539Z,1715104742.539 [DAT](INFO): DAT read: MF Frequency Band
2024-05-07T17:59:02.540Z,1715104742.540 [DAT](INFO): DAT read: Directional Acoustic Transponder version 8.15.0
2024-05-07T17:59:02.540Z,1715104742.540 [DAT](INFO): DAT read: May 7 2024 17:58:56
2024-05-07T17:59:03.799Z,1715104743.799 [DAT](INFO): DAT read: Features enabled [Bearing]
2024-05-07T17:59:03.800Z,1715104743.800 [DAT](INFO): DAT read: CONNECT 00800 bits/sec 1 of 4, Rate 1/2 CC 12.50ms MGP
2024-05-07T17:59:03.800Z,1715104743.800 [DAT](INFO): commRate: 800
2024-05-07T17:59:05.866Z,1715104745.866 [DAT](INFO): entering command mode
2024-05-07T17:59:06.066Z,1715104746.066 [DAT](INFO): DAT read:
2024-05-07T17:59:06.067Z,1715104746.067 [DAT](INFO): DAT read: user:1>
2024-05-07T17:59:06.067Z,1715104746.067 [DAT](INFO): setting verbose to 3
2024-05-07T17:59:06.319Z,1715104746.319 [DAT](INFO): DAT read: user:1>
2024-05-07T17:59:06.320Z,1715104746.320 [DAT](INFO): DAT read: Verbose | 3
2024-05-07T17:59:06.320Z,1715104746.320 [DAT](INFO): set verbose to 3
2024-05-07T17:59:06.320Z,1715104746.320 [DAT](INFO): setting DatVerbose to 27440
2024-05-07T17:59:06.571Z,1715104746.571 [DAT](INFO): DAT read: user:2>
2024-05-07T17:59:06.572Z,1715104746.572 [DAT](INFO): DAT read: DatVerbose | 27440
2024-05-07T17:59:06.572Z,1715104746.572 [DAT](INFO): set DatVerbose to 27440
2024-05-07T17:59:06.572Z,1715104746.572 [DAT](INFO): setting transmit power to 8
2024-05-07T17:59:06.823Z,1715104746.823 [DAT](INFO): DAT read: user:3>
2024-05-07T17:59:06.823Z,1715104746.823 [DAT](INFO): DAT read: TxPower | 8 (Max)
2024-05-07T17:59:06.824Z,1715104746.824 [DAT](INFO): set transmit power to 8
2024-05-07T17:59:06.824Z,1715104746.824 [DAT](INFO): setting local address to 9
2024-05-07T17:59:07.074Z,1715104747.074 [DAT](INFO): DAT read: user:4>
2024-05-07T17:59:07.075Z,1715104747.075 [DAT](INFO): DAT read: LocalAddr | 9
2024-05-07T17:59:07.076Z,1715104747.076 [DAT](INFO): set local address to 9
2024-05-07T17:59:07.077Z,1715104747.077 [DAT](INFO): Setting time to: 17:59:7 And date to:5/7/2024
2024-05-07T17:59:07.326Z,1715104747.326 [DAT](INFO): DAT read: user:5>
2024-05-07T17:59:07.327Z,1715104747.327 [DAT](INFO): DAT read: Tue May 7, 2024 17:59:07
2024-05-07T17:59:07.328Z,1715104747.328 [DAT](INFO): Local DAT time set to Tue May 7, 2024 17:59:07
2024-05-07T17:59:16.368Z,1715104756.368 [NAL9602](INFO): Powering up NAL9602
2024-05-07T17:59:21.474Z,1715104761.474 [CommandExec](IMPORTANT): got command failComponent
2024-05-07T17:59:21.475Z,1715104761.475 [CommandExec](IMPORTANT): Failed components:
2024-05-07T17:59:21.475Z,1715104761.475 [CommandExec](IMPORTANT): No failed Components.
2024-05-07T17:59:27.276Z,1715104767.276 [NAL9602](INFO): NAL9602 initialized
2024-05-07T18:00:06.073Z,1715104806.073 [SBIT](IMPORTANT): Beginning Startup BIT
2024-05-07T18:00:06.094Z,1715104806.094 [CBIT](IMPORTANT): Beginning ground fault scan
2024-05-07T18:00:17.685Z,1715104817.685 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): -0.006202
CHAN A1 (24V): 0.001928
CHAN A2 (12V): -0.005343
CHAN A3 (5V): -0.002884
CHAN B0 (3.3V): -0.000898
CHAN B1 (3.15aV): -0.001879
CHAN B2 (3.15bV): -0.001543
CHAN B3 (GND): -0.000745
OPEN: 0.005146
Full Scale: +/- 1 mA
2024-05-07T18:00:25.698Z,1715104825.698 [Waterlinked](INFO): Powering down
2024-05-07T18:01:00.034Z,1715104860.034 [SBIT](IMPORTANT): SBIT PASSED
2024-05-07T18:01:00.034Z,1715104860.034 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2024-05-07T18:01:00.035Z,1715104860.035 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=352.020527 cubic_centimeter;
2024-05-07T18:01:00.035Z,1715104860.035 [SBIT](IMPORTANT): VerticalControl.massDefault=14.385980 millimeter;
2024-05-07T18:01:00.407Z,1715104860.407 [MissionManager](IMPORTANT): Started mission Startup
2024-05-07T18:01:00.407Z,1715104860.407 [Startup] Running Loop=1
2024-05-07T18:01:00.407Z,1715104860.407 [Startup](DEBUG): Aggregate::initialize Startup
2024-05-07T18:01:00.407Z,1715104860.407 [Startup:A.GoToSurface] Running Loop=1
2024-05-07T18:01:00.407Z,1715104860.407 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2024-05-07T18:01:00.408Z,1715104860.408 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2024-05-07T18:01:00.408Z,1715104860.408 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2024-05-07T18:01:00.409Z,1715104860.409 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2024-05-07T18:01:00.409Z,1715104860.409 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2024-05-07T18:01:00.409Z,1715104860.409 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2024-05-07T18:01:00.412Z,1715104860.412 [Startup:StartupSatComms] Running Loop=1
2024-05-07T18:01:00.412Z,1715104860.412 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2024-05-07T18:01:00.412Z,1715104860.412 [Startup:StartupSatComms:A] Running Loop=1
2024-05-07T18:01:00.800Z,1715104860.800 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2024-05-07T18:01:48.492Z,1715104908.492 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2024-05-07T18:01:48.492Z,1715104908.492 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-05-07T18:01:48.493Z,1715104908.493 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 1
2024-05-07T18:01:48.493Z,1715104908.493 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2024-05-07T18:01:48.505Z,1715104908.505 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-05-07T18:01:48.505Z,1715104908.505 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2024-05-07T18:01:48.900Z,1715104908.900 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-05-07T18:01:48.900Z,1715104908.900 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2024-05-07T18:01:48.900Z,1715104908.900 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2024-05-07T18:01:48.900Z,1715104908.900 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 1
2024-05-07T18:01:49.278Z,1715104909.278 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2024-05-07T18:02:00.597Z,1715104920.597 [Startup:StartupSatComms:A](INFO): Timed out from 2024-05-07T18:01:00.4Z
2024-05-07T18:02:00.597Z,1715104920.597 [Startup:StartupSatComms:A] Stopped
2024-05-07T18:02:00.597Z,1715104920.597 [Startup:StartupSatComms:B] Running Loop=1
2024-05-07T18:02:01.009Z,1715104921.009 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2024-05-07T18:03:00.783Z,1715104980.783 [Startup:StartupSatComms:B](INFO): Timed out from 2024-05-07T18:02:00.6Z
2024-05-07T18:03:00.783Z,1715104980.783 [Startup:StartupSatComms:B] Stopped
2024-05-07T18:03:00.783Z,1715104980.783 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2024-05-07T18:03:00.783Z,1715104980.783 [Startup:StartupSatComms] Stopped
2024-05-07T18:03:00.783Z,1715104980.783 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2024-05-07T18:03:00.784Z,1715104980.784 [Startup](INFO): Completed Startup
2024-05-07T18:03:00.784Z,1715104980.784 [MissionManager](INFO): Startup is completed.
2024-05-07T18:03:00.784Z,1715104980.784 [MissionManager](INFO): Uninitializing Mission Startup
2024-05-07T18:03:00.785Z,1715104980.785 [Startup] Stopped
2024-05-07T18:03:00.785Z,1715104980.785 [Startup](DEBUG): Aggregate::uninitialize Startup
2024-05-07T18:03:00.785Z,1715104980.785 [Startup:A.GoToSurface] Stopped
2024-05-07T18:03:00.785Z,1715104980.785 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2024-05-07T18:03:01.200Z,1715104981.200 [MissionManager](IMPORTANT): Started mission Default
2024-05-07T18:03:01.200Z,1715104981.200 [Default] Running Loop=1
2024-05-07T18:03:01.200Z,1715104981.200 [Default](DEBUG): Aggregate::initialize Default
2024-05-07T18:03:01.200Z,1715104981.200 [Default:B.GoToSurface] Running Loop=1
2024-05-07T18:03:01.200Z,1715104981.200 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2024-05-07T18:03:01.201Z,1715104981.201 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2024-05-07T18:03:01.201Z,1715104981.201 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2024-05-07T18:03:01.201Z,1715104981.201 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2024-05-07T18:03:01.201Z,1715104981.201 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2024-05-07T18:03:01.202Z,1715104981.202 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2024-05-07T18:03:01.202Z,1715104981.202 [Default:A.Wait] Running Loop=1
2024-05-07T18:03:01.202Z,1715104981.202 [Default:A.Wait](DEBUG): Initialize Wait Component.
2024-05-07T18:03:14.520Z,1715104994.520 [Default:A.Wait](INFO): Done Waiting.
2024-05-07T18:03:14.520Z,1715104994.520 [Default:A.Wait] Stopped
2024-05-07T18:03:14.520Z,1715104994.520 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2024-05-07T18:03:14.983Z,1715104994.983 [Default:CheckIn] Running Loop=1
2024-05-07T18:03:14.983Z,1715104994.983 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-05-07T18:03:14.983Z,1715104994.983 [Default:CheckIn:Read_GPS] Running Loop=1
2024-05-07T18:03:15.318Z,1715104995.318 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2024-05-07T18:04:31.275Z,1715105071.275 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2024-05-07T18:04:49.479Z,1715105089.479 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2
2024-05-07T18:04:49.479Z,1715105089.479 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-05-07T18:04:49.480Z,1715105089.480 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 2
2024-05-07T18:04:49.480Z,1715105089.480 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2024-05-07T18:04:49.491Z,1715105089.491 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-05-07T18:04:49.491Z,1715105089.491 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2024-05-07T18:04:49.885Z,1715105089.885 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-05-07T18:04:49.885Z,1715105089.885 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2
2024-05-07T18:04:49.886Z,1715105089.886 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2024-05-07T18:04:49.886Z,1715105089.886 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 2
2024-05-07T18:04:50.254Z,1715105090.254 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2024-05-07T18:05:23.780Z,1715105123.780 [BPC1](INFO): Calculating totals. Valid battery stick count: 56. Valid reserve battery stick count: 6.
2024-05-07T18:05:23.783Z,1715105123.783 [BPC1](INFO): Received data from all battery sticks.
2024-05-07T18:07:50.470Z,1715105270.470 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3
2024-05-07T18:07:50.470Z,1715105270.470 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-05-07T18:07:50.471Z,1715105270.471 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 3
2024-05-07T18:07:50.472Z,1715105270.472 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2024-05-07T18:07:50.482Z,1715105270.482 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-05-07T18:07:50.482Z,1715105270.482 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2024-05-07T18:07:50.853Z,1715105270.853 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-05-07T18:07:50.853Z,1715105270.853 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3
2024-05-07T18:07:50.853Z,1715105270.853 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2024-05-07T18:07:50.853Z,1715105270.853 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 3
2024-05-07T18:07:51.252Z,1715105271.252 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2024-05-07T18:08:15.085Z,1715105295.085 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-05-07T18:03:14.0Z
2024-05-07T18:08:15.085Z,1715105295.085 [Default:CheckIn:Read_GPS] Stopped
2024-05-07T18:08:15.085Z,1715105295.085 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-05-07T18:08:15.489Z,1715105295.489 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications
2024-05-07T18:08:44.562Z,1715105324.562 [NAL9602](ERROR): Queried for signal strength and failed to receive proper response.
2024-05-07T18:08:44.638Z,1715105324.638 [NAL9602](ERROR): received:
+CSQ:0
OK
2024-05-07T18:08:59.969Z,1715105339.969 [NAL9602](INFO): SBD MO Status=1, MOMSN=17029, MT Status=0, MTMSN=0
2024-05-07T18:09:00.018Z,1715105340.018 [NAL9602](INFO): Sent 38 bytes from file Logs/20240507T175254/Courier0004.lzma
2024-05-07T18:09:00.018Z,1715105340.018 [NAL9602](INFO): Packets left to send: 0
2024-05-07T18:09:10.917Z,1715105350.917 [NAL9602](INFO): SBD MO Status=1, MOMSN=17030, MT Status=0, MTMSN=0
2024-05-07T18:09:10.966Z,1715105350.966 [NAL9602](INFO): Sent 151 bytes from file Logs/20240507T175837/Courier0000.lzma
2024-05-07T18:09:10.966Z,1715105350.966 [NAL9602](INFO): Packets left to send: 0
2024-05-07T18:09:31.569Z,1715105371.569 [NAL9602](INFO): SBD MO Status=2, MOMSN=17031, MT Status=2, MTMSN=0
2024-05-07T18:09:31.569Z,1715105371.569 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2024-05-07T18:09:32.375Z,1715105372.375 [NAL9602](FAULT): GPS failed to acquire within timeout.
2024-05-07T18:09:32.376Z,1715105372.376 [NAL9602] Data Fault, FailCount= 1
2024-05-07T18:09:32.376Z,1715105372.376 [NAL9602](ERROR): Data Fault
2024-05-07T18:09:32.394Z,1715105372.394 [CBIT](ERROR): Data Fault in component: NAL9602
2024-05-07T18:09:32.779Z,1715105372.779 [NAL9602](INFO): Powering down
2024-05-07T18:09:33.620Z,1715105373.620 [CBIT](INFO): Clearing failed state for component NAL9602
2024-05-07T18:09:33.621Z,1715105373.621 [NAL9602] No Fault, FailCount= 1
2024-05-07T18:10:03.079Z,1715105403.079 [NAL9602](INFO): Powering up NAL9602
2024-05-07T18:10:13.994Z,1715105413.994 [NAL9602](INFO): NAL9602 initialized
2024-05-07T18:10:39.879Z,1715105439.879 [NAL9602](INFO): SBD MO Status=2, MOMSN=17031, MT Status=2, MTMSN=0
2024-05-07T18:10:39.879Z,1715105439.879 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2024-05-07T18:10:51.603Z,1715105451.603 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4
2024-05-07T18:10:51.603Z,1715105451.603 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-05-07T18:10:51.604Z,1715105451.604 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 4
2024-05-07T18:10:51.604Z,1715105451.604 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2024-05-07T18:10:51.639Z,1715105451.639 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-05-07T18:10:51.639Z,1715105451.639 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2024-05-07T18:10:52.016Z,1715105452.016 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-05-07T18:10:52.016Z,1715105452.016 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4
2024-05-07T18:10:52.016Z,1715105452.016 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2024-05-07T18:10:52.016Z,1715105452.016 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 4
2024-05-07T18:10:52.411Z,1715105452.411 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2024-05-07T18:11:09.817Z,1715105469.817 [NAL9602](INFO): SBD MO Status=2, MOMSN=17031, MT Status=2, MTMSN=0
2024-05-07T18:11:09.817Z,1715105469.817 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2024-05-07T18:11:28.845Z,1715105488.845 [NAL9602](INFO): SBD MO Status=2, MOMSN=17031, MT Status=2, MTMSN=0
2024-05-07T18:11:28.845Z,1715105488.845 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2024-05-07T18:11:40.197Z,1715105500.197 [NAL9602](INFO): SBD MO Status=1, MOMSN=17031, MT Status=0, MTMSN=0
2024-05-07T18:11:40.250Z,1715105500.250 [NAL9602](INFO): Sent 169 bytes from file Logs/20240507T175837/Courier0004.lzma
2024-05-07T18:11:40.250Z,1715105500.250 [NAL9602](INFO): Packets left to send: 0
2024-05-07T18:11:49.125Z,1715105509.125 [NAL9602](INFO): SBD MO Status=1, MOMSN=17032, MT Status=0, MTMSN=0
2024-05-07T18:11:49.175Z,1715105509.175 [NAL9602](INFO): Sent 174 bytes from file Logs/20240507T175254/Express0005.lzma
2024-05-07T18:11:49.176Z,1715105509.176 [NAL9602](INFO): Packets left to send: 0
2024-05-07T18:11:58.856Z,1715105518.856 [NAL9602](INFO): SBD MO Status=1, MOMSN=17033, MT Status=0, MTMSN=0
2024-05-07T18:11:58.910Z,1715105518.910 [NAL9602](INFO): Sent 332 bytes from file Logs/20240507T175837/Express0001.lzma
2024-05-07T18:11:58.911Z,1715105518.911 [NAL9602](INFO): Packets left to send: 2
2024-05-07T18:12:08.597Z,1715105528.597 [NAL9602](INFO): SBD MO Status=1, MOMSN=17034, MT Status=0, MTMSN=0
2024-05-07T18:12:08.658Z,1715105528.658 [NAL9602](INFO): Sent 332 bytes from file Logs/20240507T175837/Express0001.lzma
2024-05-07T18:12:08.658Z,1715105528.658 [NAL9602](INFO): Packets left to send: 1
2024-05-07T18:12:19.162Z,1715105539.162 [NAL9602](INFO): SBD MO Status=1, MOMSN=17035, MT Status=0, MTMSN=0
2024-05-07T18:12:19.222Z,1715105539.222 [NAL9602](INFO): Sent 141 bytes from file Logs/20240507T175837/Express0001.lzma
2024-05-07T18:12:19.222Z,1715105539.222 [NAL9602](INFO): Packets left to send: 0
2024-05-07T18:12:40.185Z,1715105560.185 [NAL9602](INFO): SBD MO Status=1, MOMSN=17036, MT Status=0, MTMSN=0
2024-05-07T18:12:40.234Z,1715105560.234 [NAL9602](INFO): Sent 185 bytes from file Logs/20240507T175837/Express0005.lzma
2024-05-07T18:12:40.234Z,1715105560.234 [NAL9602](INFO): Packets left to send: 0
2024-05-07T18:12:47.457Z,1715105567.457 [NAL9602](INFO): SBD MO Status=0, MOMSN=17037, MT Status=0, MTMSN=0
2024-05-07T18:12:47.541Z,1715105567.541 [Default:CheckIn:Read_Iridium] Stopped
2024-05-07T18:12:47.541Z,1715105567.541 [Default:CheckIn:C.Wait] Running Loop=1
2024-05-07T18:12:47.541Z,1715105567.541 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-05-07T18:12:48.669Z,1715105568.669 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,181248.00,A,3648.14241,N,12147.22614,W,0.233,347.31,070524,,,A*77
2024-05-07T18:12:48.681Z,1715105568.681 [NAL9602](INFO): GPS fix at 20240507T181248: (36.802374, -121.787102)
2024-05-07T18:13:21.392Z,1715105601.392 [NAL9602](INFO): Not Powering down - fast GPS
2024-05-07T18:17:48.061Z,1715105868.061 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-05-07T18:17:48.061Z,1715105868.061 [Default:CheckIn:C.Wait] Stopped
2024-05-07T18:17:48.061Z,1715105868.061 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-05-07T18:17:48.061Z,1715105868.061 [Default:CheckIn:D] Running Loop=1
2024-05-07T18:17:48.467Z,1715105868.467 [Default:CheckIn:D] Stopped
2024-05-07T18:17:48.467Z,1715105868.467 [Default:CheckIn:E] Running Loop=1
2024-05-07T18:17:48.859Z,1715105868.859 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 14.787781 min
2024-05-07T18:17:48.860Z,1715105868.860 [Default:CheckIn:E] Stopped
2024-05-07T18:17:48.860Z,1715105868.860 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-05-07T18:17:48.860Z,1715105868.860 [Default:CheckIn] Stopped
2024-05-07T18:17:48.860Z,1715105868.860 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-05-07T18:17:48.860Z,1715105868.860 [Default:CheckIn](INFO): Running loop #2
2024-05-07T18:17:48.860Z,1715105868.860 [Default:CheckIn] Running Loop=2
2024-05-07T18:17:48.860Z,1715105868.860 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-05-07T18:17:48.860Z,1715105868.860 [Default:CheckIn:Read_GPS] Running Loop=1
2024-05-07T18:17:50.866Z,1715105870.866 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,181750.00,A,3648.13865,N,12147.22252,W,0.136,347.31,070524,,,A*70
2024-05-07T18:17:50.868Z,1715105870.868 [NAL9602](INFO): GPS fix at 20240507T181750: (36.802311, -121.787042)
2024-05-07T18:17:50.880Z,1715105870.880 [Default:CheckIn:Read_GPS] Stopped
2024-05-07T18:17:50.881Z,1715105870.881 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-05-07T18:18:09.505Z,1715105889.505 [NAL9602](IMPORTANT): SBD MO Status=1, MOMSN=17038, MT Status=1, MTMSN=870
2024-05-07T18:18:09.557Z,1715105889.557 [NAL9602](INFO): Sent 223 bytes from file Logs/20240507T175837/Courier0007.lzma
2024-05-07T18:18:09.557Z,1715105889.557 [NAL9602](INFO): Packets left to send: 0
2024-05-07T18:18:09.995Z,1715105889.995 [NAL9602](INFO): Received command: ibit
2024-05-07T18:18:10.083Z,1715105890.083 [CommandExec](IMPORTANT): got command ibit
2024-05-07T18:18:10.323Z,1715105890.323 [IBIT](IMPORTANT): Beginning Initiated BIT
2024-05-07T18:18:10.323Z,1715105890.323 [IBIT](IMPORTANT): Beginning control surface checks.
2024-05-07T18:18:10.327Z,1715105890.327 [CBIT](IMPORTANT): Beginning ground fault scan
2024-05-07T18:18:11.521Z,1715105891.521 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,181810.00,A,3648.13870,N,12147.22251,W,0.194,347.31,070524,,,A*74
2024-05-07T18:18:11.523Z,1715105891.523 [NAL9602](INFO): GPS fix at 20240507T181810: (36.802312, -121.787042)
2024-05-07T18:18:22.621Z,1715105902.621 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): -0.007121
CHAN A1 (24V): 0.001797
CHAN A2 (12V): -0.005822
CHAN A3 (5V): -0.003005
CHAN B0 (3.3V): -0.001387
CHAN B1 (3.15aV): -0.001679
CHAN B2 (3.15bV): -0.001584
CHAN B3 (GND): -0.001742
OPEN: 0.005389
Full Scale: +/- 1 mA
2024-05-07T18:18:27.444Z,1715105907.444 [NAL9602](INFO): SBD MO Status=1, MOMSN=17039, MT Status=0, MTMSN=0
2024-05-07T18:18:27.502Z,1715105907.502 [NAL9602](INFO): Sent 324 bytes from file Logs/20240507T175837/Express0008.lzma
2024-05-07T18:18:27.502Z,1715105907.502 [NAL9602](INFO): Packets left to send: 0
2024-05-07T18:18:33.914Z,1715105913.914 [NAL9602](INFO): SBD MO Status=0, MOMSN=17040, MT Status=0, MTMSN=0
2024-05-07T18:18:35.121Z,1715105915.121 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,181834.00,A,3648.13856,N,12147.22370,W,0.467,347.31,070524,,,A*7D
2024-05-07T18:18:35.131Z,1715105915.131 [NAL9602](INFO): GPS fix at 20240507T181834: (36.802309, -121.787062)
2024-05-07T18:18:50.760Z,1715105930.760 [DataOverHttps](IMPORTANT): SBD MTMSN=20240507T181849
2024-05-07T18:18:50.764Z,1715105930.764 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004962
2024-05-07T18:18:57.066Z,1715105937.066 [IBIT](IMPORTANT): Communications Status:
Fix Status: 1
Iridium Signal Strength: 3
Latitude: 36.802311 Longitude: -121.787064
2024-05-07T18:18:57.456Z,1715105937.456 [IBIT](IMPORTANT): Battery Status:
Battery Charge (AH): 0.000000
Voltage: 16.572001
2024-05-07T18:18:57.456Z,1715105937.456 [IBIT](IMPORTANT): batteryCapacityThreshold: 50.000000 Ah
2024-05-07T18:18:57.456Z,1715105937.456 [IBIT](IMPORTANT): batteryVoltageThreshold: 13.700000 V
2024-05-07T18:18:57.832Z,1715105937.832 [IBIT](IMPORTANT): bitHumidityThreshold: 55.000000 %
2024-05-07T18:18:57.833Z,1715105937.833 [IBIT](IMPORTANT): bitPressureThreshold: 0.750000 psi
2024-05-07T18:18:57.833Z,1715105937.833 [IBIT](IMPORTANT): Pressure:9.117849 PSI
2024-05-07T18:18:57.833Z,1715105937.833 [IBIT](IMPORTANT): Humidity:14.106947 %
2024-05-07T18:18:58.217Z,1715105938.217 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20240507T175837/Courier0010.lzma
2024-05-07T18:18:58.220Z,1715105938.220 [DataOverHttps](INFO): Received command: gfscan
2024-05-07T18:18:58.264Z,1715105938.264 [IBIT](IMPORTANT): Vehicle Pitch:-0.984126 degrees
2024-05-07T18:18:58.264Z,1715105938.264 [IBIT](IMPORTANT): Vehicle Roll:-0.834128 degrees
2024-05-07T18:18:58.264Z,1715105938.264 [IBIT](IMPORTANT): Vehicle Heading:293.887451 degrees
2024-05-07T18:18:58.311Z,1715105938.311 [CommandExec](IMPORTANT): got command gfscan
2024-05-07T18:18:58.661Z,1715105938.661 [IBIT](IMPORTANT): surfaceThreshold: 1.000000 m
2024-05-07T18:18:58.666Z,1715105938.666 [IBIT](IMPORTANT): buoyancyNeutral: 352.020538 cc
2024-05-07T18:18:58.666Z,1715105938.666 [IBIT](IMPORTANT): massDefault: 1.438598 cm
2024-05-07T18:18:58.667Z,1715105938.667 [IBIT](IMPORTANT): stopDepth: 290.000000 m
2024-05-07T18:18:58.667Z,1715105938.667 [IBIT](IMPORTANT): abortDepth: 300.000000 m
2024-05-07T18:18:58.667Z,1715105938.667 [IBIT](IMPORTANT): IBIT PASSED
2024-05-07T18:18:58.679Z,1715105938.679 [CBIT](IMPORTANT): Beginning ground fault scan
2024-05-07T18:18:59.468Z,1715105939.468 [DataOverHttps](INFO): Moved sent file to Logs/20240507T175837/Courier0010.lzma.bak
2024-05-07T18:18:59.468Z,1715105939.468 [DataOverHttps](INFO): SBD MOMSN=20823647
2024-05-07T18:19:02.657Z,1715105942.657 [NAL9602](INFO): SBD MO Status=2, MOMSN=17041, MT Status=2, MTMSN=0
2024-05-07T18:19:02.657Z,1715105942.657 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2024-05-07T18:19:09.576Z,1715105949.576 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): -0.007700
CHAN A1 (24V): 0.002038
CHAN A2 (12V): -0.005563
CHAN A3 (5V): -0.003469
CHAN B0 (3.3V): -0.001697
CHAN B1 (3.15aV): -0.001558
CHAN B2 (3.15bV): -0.002020
CHAN B3 (GND): -0.000650
OPEN: 0.005308
Full Scale: +/- 1 mA
2024-05-07T18:19:15.226Z,1715105955.226 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20240507T175837/Courier0013.lzma
2024-05-07T18:19:16.228Z,1715105956.228 [DataOverHttps](INFO): Moved sent file to Logs/20240507T175837/Courier0013.lzma.bak
2024-05-07T18:19:16.228Z,1715105956.228 [DataOverHttps](INFO): SBD MOMSN=20823657
2024-05-07T18:19:32.174Z,1715105972.174 [DataOverHttps](INFO): Sending 374 bytes from file Logs/20240507T175837/Express0011.lzma
2024-05-07T18:19:33.176Z,1715105973.176 [DataOverHttps](INFO): Moved sent file to Logs/20240507T175837/Express0011.lzma.bak
2024-05-07T18:19:33.176Z,1715105973.176 [DataOverHttps](INFO): SBD MOMSN=20823660
2024-05-07T18:19:33.363Z,1715105973.363 [NAL9602](INFO): Not Powering down - fast GPS
2024-05-07T18:19:49.079Z,1715105989.079 [DataOverHttps](INFO): Sending 587 bytes from file Logs/20240507T175837/Express0014.lzma
2024-05-07T18:19:50.080Z,1715105990.080 [DataOverHttps](INFO): Moved sent file to Logs/20240507T175837/Express0014.lzma.bak
2024-05-07T18:19:50.080Z,1715105990.080 [DataOverHttps](INFO): SBD MOMSN=20823665
2024-05-07T18:19:51.158Z,1715105991.158 [Default:CheckIn:Read_Iridium] Stopped
2024-05-07T18:19:51.158Z,1715105991.158 [Default:CheckIn:C.Wait] Running Loop=1
2024-05-07T18:19:51.158Z,1715105991.158 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-05-07T18:24:51.733Z,1715106291.733 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-05-07T18:24:51.733Z,1715106291.733 [Default:CheckIn:C.Wait] Stopped
2024-05-07T18:24:51.733Z,1715106291.733 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-05-07T18:24:51.733Z,1715106291.733 [Default:CheckIn:D] Running Loop=1
2024-05-07T18:24:52.131Z,1715106292.131 [Default:CheckIn:D] Stopped
2024-05-07T18:24:52.131Z,1715106292.131 [Default:CheckIn:E] Running Loop=1
2024-05-07T18:24:52.532Z,1715106292.532 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 21.848840 min
2024-05-07T18:24:52.532Z,1715106292.532 [Default:CheckIn:E] Stopped
2024-05-07T18:24:52.532Z,1715106292.532 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-05-07T18:24:52.532Z,1715106292.532 [Default:CheckIn] Stopped
2024-05-07T18:24:52.532Z,1715106292.532 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-05-07T18:24:52.533Z,1715106292.533 [Default:CheckIn](INFO): Running loop #3
2024-05-07T18:24:52.533Z,1715106292.533 [Default:CheckIn] Running Loop=3
2024-05-07T18:24:52.533Z,1715106292.533 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-05-07T18:24:52.533Z,1715106292.533 [Default:CheckIn:Read_GPS] Running Loop=1
2024-05-07T18:24:54.546Z,1715106294.546 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,182453.00,A,3648.13834,N,12147.22321,W,0.136,347.31,070524,,,A*72
2024-05-07T18:24:54.548Z,1715106294.548 [NAL9602](INFO): GPS fix at 20240507T182453: (36.802306, -121.787053)
2024-05-07T18:24:54.560Z,1715106294.560 [Default:CheckIn:Read_GPS] Stopped
2024-05-07T18:24:54.560Z,1715106294.560 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-05-07T18:25:01.509Z,1715106301.509 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20240507T175837/Courier0016.lzma
2024-05-07T18:25:02.512Z,1715106302.512 [DataOverHttps](INFO): Moved sent file to Logs/20240507T175837/Courier0016.lzma.bak
2024-05-07T18:25:02.512Z,1715106302.512 [DataOverHttps](INFO): SBD MOMSN=20823771
2024-05-07T18:25:11.913Z,1715106311.913 [NAL9602](IMPORTANT): SBD MO Status=1, MOMSN=17041, MT Status=1, MTMSN=871
2024-05-07T18:25:11.913Z,1715106311.913 [NAL9602](INFO): Data available in MT queue
2024-05-07T18:25:12.410Z,1715106312.410 [NAL9602](INFO): Received command: failc
2024-05-07T18:25:12.447Z,1715106312.447 [CommandExec](IMPORTANT): got command failComponent
2024-05-07T18:25:12.447Z,1715106312.447 [CommandExec](IMPORTANT): Failed components:
2024-05-07T18:25:12.447Z,1715106312.447 [CommandExec](IMPORTANT): No failed Components.
2024-05-07T18:25:18.342Z,1715106318.342 [DataOverHttps](INFO): Sending 288 bytes from file Logs/20240507T175837/Express0017.lzma
2024-05-07T18:25:19.344Z,1715106319.344 [DataOverHttps](INFO): Moved sent file to Logs/20240507T175837/Express0017.lzma.bak
2024-05-07T18:25:19.344Z,1715106319.344 [DataOverHttps](INFO): SBD MOMSN=20823774
2024-05-07T18:25:20.407Z,1715106320.407 [Default:CheckIn:Read_Iridium] Stopped
2024-05-07T18:25:20.407Z,1715106320.407 [Default:CheckIn:C.Wait] Running Loop=1
2024-05-07T18:25:20.408Z,1715106320.408 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-05-07T18:25:43.019Z,1715106343.019 [NAL9602](INFO): Not Powering down - fast GPS
2024-05-07T18:30:21.023Z,1715106621.023 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-05-07T18:30:21.023Z,1715106621.023 [Default:CheckIn:C.Wait] Stopped
2024-05-07T18:30:21.023Z,1715106621.023 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-05-07T18:30:21.023Z,1715106621.023 [Default:CheckIn:D] Running Loop=1
2024-05-07T18:30:21.431Z,1715106621.431 [Default:CheckIn:D] Stopped
2024-05-07T18:30:21.431Z,1715106621.431 [Default:CheckIn:E] Running Loop=1
2024-05-07T18:30:21.828Z,1715106621.828 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 27.337177 min
2024-05-07T18:30:21.829Z,1715106621.829 [Default:CheckIn:E] Stopped
2024-05-07T18:30:21.829Z,1715106621.829 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-05-07T18:30:21.829Z,1715106621.829 [Default:CheckIn] Stopped
2024-05-07T18:30:21.829Z,1715106621.829 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-05-07T18:30:21.829Z,1715106621.829 [Default:CheckIn](INFO): Running loop #4
2024-05-07T18:30:21.829Z,1715106621.829 [Default:CheckIn] Running Loop=4
2024-05-07T18:30:21.829Z,1715106621.829 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-05-07T18:30:21.829Z,1715106621.829 [Default:CheckIn:Read_GPS] Running Loop=1
2024-05-07T18:30:23.837Z,1715106623.837 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,183023.00,A,3648.13691,N,12147.22367,W,0.253,347.31,070524,,,A*73
2024-05-07T18:30:23.839Z,1715106623.839 [NAL9602](INFO): GPS fix at 20240507T183023: (36.802282, -121.787061)
2024-05-07T18:30:23.866Z,1715106623.866 [Default:CheckIn:Read_GPS] Stopped
2024-05-07T18:30:23.866Z,1715106623.866 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-05-07T18:30:30.749Z,1715106630.749 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20240507T175837/Courier0019.lzma
2024-05-07T18:30:31.752Z,1715106631.752 [DataOverHttps](INFO): Moved sent file to Logs/20240507T175837/Courier0019.lzma.bak
2024-05-07T18:30:31.752Z,1715106631.752 [DataOverHttps](INFO): SBD MOMSN=20823799
2024-05-07T18:30:47.894Z,1715106647.894 [DataOverHttps](INFO): Sending 228 bytes from file Logs/20240507T175837/Express0020.lzma
2024-05-07T18:30:48.896Z,1715106648.896 [DataOverHttps](INFO): Moved sent file to Logs/20240507T175837/Express0020.lzma.bak
2024-05-07T18:30:48.896Z,1715106648.896 [DataOverHttps](INFO): SBD MOMSN=20823802
2024-05-07T18:30:50.104Z,1715106650.104 [NAL9602](INFO): SBD MO Status=1, MOMSN=17042, MT Status=0, MTMSN=0
2024-05-07T18:30:50.105Z,1715106650.105 [NAL9602](INFO): No messages in MT queue
2024-05-07T18:30:50.117Z,1715106650.117 [Default:CheckIn:Read_Iridium] Stopped
2024-05-07T18:30:50.117Z,1715106650.117 [Default:CheckIn:C.Wait] Running Loop=1
2024-05-07T18:30:50.117Z,1715106650.117 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-05-07T18:31:20.800Z,1715106680.800 [NAL9602](INFO): Not Powering down - fast GPS
2024-05-07T18:35:50.712Z,1715106950.712 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-05-07T18:35:50.712Z,1715106950.712 [Default:CheckIn:C.Wait] Stopped
2024-05-07T18:35:50.712Z,1715106950.712 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-05-07T18:35:50.713Z,1715106950.713 [Default:CheckIn:D] Running Loop=1
2024-05-07T18:35:51.099Z,1715106951.099 [Default:CheckIn:D] Stopped
2024-05-07T18:35:51.100Z,1715106951.100 [Default:CheckIn:E] Running Loop=1
2024-05-07T18:35:51.501Z,1715106951.501 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 32.831657 min
2024-05-07T18:35:51.501Z,1715106951.501 [Default:CheckIn:E] Stopped
2024-05-07T18:35:51.501Z,1715106951.501 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-05-07T18:35:51.501Z,1715106951.501 [Default:CheckIn] Stopped
2024-05-07T18:35:51.501Z,1715106951.501 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-05-07T18:35:51.501Z,1715106951.501 [Default:CheckIn](INFO): Running loop #5
2024-05-07T18:35:51.501Z,1715106951.501 [Default:CheckIn] Running Loop=5
2024-05-07T18:35:51.502Z,1715106951.502 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-05-07T18:35:51.502Z,1715106951.502 [Default:CheckIn:Read_GPS] Running Loop=1
2024-05-07T18:35:53.501Z,1715106953.501 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,183552.00,A,3648.13996,N,12147.22170,W,0.214,0.00,070524,,,A*7D
2024-05-07T18:35:53.516Z,1715106953.516 [NAL9602](INFO): GPS fix at 20240507T183552: (36.802333, -121.787028)
2024-05-07T18:35:53.528Z,1715106953.528 [Default:CheckIn:Read_GPS] Stopped
2024-05-07T18:35:53.528Z,1715106953.528 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-05-07T18:36:00.977Z,1715106960.977 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20240507T175837/Courier0022.lzma
2024-05-07T18:36:01.980Z,1715106961.980 [DataOverHttps](INFO): Moved sent file to Logs/20240507T175837/Courier0022.lzma.bak
2024-05-07T18:36:01.980Z,1715106961.980 [DataOverHttps](INFO): SBD MOMSN=20823876
2024-05-07T18:36:08.044Z,1715106968.044 [NAL9602](INFO): SBD MO Status=1, MOMSN=17043, MT Status=0, MTMSN=0
2024-05-07T18:36:08.044Z,1715106968.044 [NAL9602](INFO): No messages in MT queue
2024-05-07T18:36:17.786Z,1715106977.786 [DataOverHttps](INFO): Sending 130 bytes from file Logs/20240507T175837/Express0023.lzma
2024-05-07T18:36:18.788Z,1715106978.788 [DataOverHttps](INFO): Moved sent file to Logs/20240507T175837/Express0023.lzma.bak
2024-05-07T18:36:18.788Z,1715106978.788 [DataOverHttps](INFO): SBD MOMSN=20823879
2024-05-07T18:36:20.187Z,1715106980.187 [Default:CheckIn:Read_Iridium] Stopped
2024-05-07T18:36:20.187Z,1715106980.187 [Default:CheckIn:C.Wait] Running Loop=1
2024-05-07T18:36:20.187Z,1715106980.187 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-05-07T18:36:38.747Z,1715106998.747 [NAL9602](INFO): Not Powering down - fast GPS
2024-05-07T18:38:57.187Z,1715107137.187 [DAT](INFO): DAT read: user:6>Rx Time:18:38:56.5842
2024-05-07T18:38:57.188Z,1715107137.188 [DAT](INFO): Rx dataTimestamp_ set to:1715107137.187322
2024-05-07T18:38:57.188Z,1715107137.188 [DAT](INFO): DAT read:
2024-05-07T18:38:57.189Z,1715107137.189 [DAT](INFO): DAT read: $Packet for address 0
2024-05-07T18:38:57.189Z,1715107137.189 [DAT](INFO): received a packet notification
2024-05-07T18:41:20.751Z,1715107280.751 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-05-07T18:41:20.751Z,1715107280.751 [Default:CheckIn:C.Wait] Stopped
2024-05-07T18:41:20.752Z,1715107280.752 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-05-07T18:41:20.752Z,1715107280.752 [Default:CheckIn:D] Running Loop=1
2024-05-07T18:41:21.159Z,1715107281.159 [Default:CheckIn:D] Stopped
2024-05-07T18:41:21.159Z,1715107281.159 [Default:CheckIn:E] Running Loop=1
2024-05-07T18:41:21.561Z,1715107281.561 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 38.332642 min
2024-05-07T18:41:21.561Z,1715107281.561 [Default:CheckIn:E] Stopped
2024-05-07T18:41:21.561Z,1715107281.561 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-05-07T18:41:21.561Z,1715107281.561 [Default:CheckIn] Stopped
2024-05-07T18:41:21.561Z,1715107281.561 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-05-07T18:41:21.562Z,1715107281.562 [Default:CheckIn](INFO): Running loop #6
2024-05-07T18:41:21.562Z,1715107281.562 [Default:CheckIn] Running Loop=6
2024-05-07T18:41:21.562Z,1715107281.562 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-05-07T18:41:21.562Z,1715107281.562 [Default:CheckIn:Read_GPS] Running Loop=1
2024-05-07T18:41:23.569Z,1715107283.569 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,184122.00,A,3648.14323,N,12147.20894,W,0.214,95.70,070524,,,A*40
2024-05-07T18:41:23.580Z,1715107283.580 [NAL9602](INFO): GPS fix at 20240507T184122: (36.802387, -121.786816)
2024-05-07T18:41:23.592Z,1715107283.592 [Default:CheckIn:Read_GPS] Stopped
2024-05-07T18:41:23.592Z,1715107283.592 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-05-07T18:41:37.304Z,1715107297.304 [NAL9602](INFO): SBD MO Status=1, MOMSN=17044, MT Status=0, MTMSN=0
2024-05-07T18:41:37.304Z,1715107297.304 [NAL9602](INFO): No messages in MT queue
2024-05-07T18:41:39.043Z,1715107299.043 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20240507T175837/Courier0025.lzma
2024-05-07T18:41:40.044Z,1715107300.044 [DataOverHttps](INFO): Moved sent file to Logs/20240507T175837/Courier0025.lzma.bak
2024-05-07T18:41:40.044Z,1715107300.044 [DataOverHttps](INFO): SBD MOMSN=20823899
2024-05-07T18:42:01.758Z,1715107321.758 [DataOverHttps](INFO): Sending 130 bytes from file Logs/20240507T175837/Express0026.lzma
2024-05-07T18:42:05.772Z,1715107325.772 [DataOverHttps](INFO): Moved sent file to Logs/20240507T175837/Express0026.lzma.bak
2024-05-07T18:42:05.772Z,1715107325.772 [DataOverHttps](INFO): SBD MOMSN=20823902
2024-05-07T18:42:06.878Z,1715107326.878 [Default:CheckIn:Read_Iridium] Stopped
2024-05-07T18:42:06.878Z,1715107326.878 [Default:CheckIn:C.Wait] Running Loop=1
2024-05-07T18:42:06.879Z,1715107326.879 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-05-07T18:42:08.071Z,1715107328.071 [NAL9602](INFO): Not Powering down - fast GPS
2024-05-07T18:47:07.461Z,1715107627.461 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-05-07T18:47:07.461Z,1715107627.461 [Default:CheckIn:C.Wait] Stopped
2024-05-07T18:47:07.461Z,1715107627.461 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-05-07T18:47:07.461Z,1715107627.461 [Default:CheckIn:D] Running Loop=1
2024-05-07T18:47:07.860Z,1715107627.860 [Default:CheckIn:D] Stopped
2024-05-07T18:47:07.860Z,1715107627.860 [Default:CheckIn:E] Running Loop=1
2024-05-07T18:47:08.260Z,1715107628.260 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 44.110994 min
2024-05-07T18:47:08.260Z,1715107628.260 [Default:CheckIn:E] Stopped
2024-05-07T18:47:08.260Z,1715107628.260 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-05-07T18:47:08.260Z,1715107628.260 [Default:CheckIn] Stopped
2024-05-07T18:47:08.260Z,1715107628.260 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-05-07T18:47:08.260Z,1715107628.260 [Default:CheckIn](INFO): Running loop #7
2024-05-07T18:47:08.260Z,1715107628.260 [Default:CheckIn] Running Loop=7
2024-05-07T18:47:08.261Z,1715107628.261 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-05-07T18:47:08.261Z,1715107628.261 [Default:CheckIn:Read_GPS] Running Loop=1
2024-05-07T18:47:10.270Z,1715107630.270 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,184709.00,A,3648.14038,N,12147.21111,W,0.544,3.21,070524,,,A*7A
2024-05-07T18:47:10.272Z,1715107630.272 [NAL9602](INFO): GPS fix at 20240507T184709: (36.802340, -121.786852)
2024-05-07T18:47:10.284Z,1715107630.284 [Default:CheckIn:Read_GPS] Stopped
2024-05-07T18:47:10.284Z,1715107630.284 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-05-07T18:47:17.158Z,1715107637.158 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20240507T175837/Courier0028.lzma
2024-05-07T18:47:18.160Z,1715107638.160 [DataOverHttps](INFO): Moved sent file to Logs/20240507T175837/Courier0028.lzma.bak
2024-05-07T18:47:18.160Z,1715107638.160 [DataOverHttps](INFO): SBD MOMSN=20823992
2024-05-07T18:47:20.776Z,1715107640.776 [NAL9602](INFO): SBD MO Status=1, MOMSN=17045, MT Status=0, MTMSN=0
2024-05-07T18:47:20.777Z,1715107640.777 [NAL9602](INFO): No messages in MT queue
2024-05-07T18:47:34.046Z,1715107654.046 [DataOverHttps](INFO): Sending 131 bytes from file Logs/20240507T175837/Express0029.lzma
2024-05-07T18:47:35.048Z,1715107655.048 [DataOverHttps](INFO): Moved sent file to Logs/20240507T175837/Express0029.lzma.bak
2024-05-07T18:47:35.048Z,1715107655.048 [DataOverHttps](INFO): SBD MOMSN=20824000
2024-05-07T18:47:36.137Z,1715107656.137 [Default:CheckIn:Read_Iridium] Stopped
2024-05-07T18:47:36.137Z,1715107656.137 [Default:CheckIn:C.Wait] Running Loop=1
2024-05-07T18:47:36.137Z,1715107656.137 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-05-07T18:47:51.479Z,1715107671.479 [NAL9602](INFO): Not Powering down - fast GPS
2024-05-07T18:52:36.722Z,1715107956.722 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-05-07T18:52:36.722Z,1715107956.722 [Default:CheckIn:C.Wait] Stopped
2024-05-07T18:52:36.722Z,1715107956.722 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-05-07T18:52:36.722Z,1715107956.722 [Default:CheckIn:D] Running Loop=1
2024-05-07T18:52:37.142Z,1715107957.142 [Default:CheckIn:D] Stopped
2024-05-07T18:52:37.142Z,1715107957.142 [Default:CheckIn:E] Running Loop=1
2024-05-07T18:52:37.520Z,1715107957.520 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 49.598975 min
2024-05-07T18:52:37.520Z,1715107957.520 [Default:CheckIn:E] Stopped
2024-05-07T18:52:37.521Z,1715107957.521 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-05-07T18:52:37.521Z,1715107957.521 [Default:CheckIn] Stopped
2024-05-07T18:52:37.521Z,1715107957.521 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-05-07T18:52:37.521Z,1715107957.521 [Default:CheckIn](INFO): Running loop #8
2024-05-07T18:52:37.521Z,1715107957.521 [Default:CheckIn] Running Loop=8
2024-05-07T18:52:37.521Z,1715107957.521 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-05-07T18:52:37.521Z,1715107957.521 [Default:CheckIn:Read_GPS] Running Loop=1
2024-05-07T18:52:39.534Z,1715107959.534 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,185238.00,A,3648.13838,N,12147.20569,W,0.272,313.09,070524,,,A*73
2024-05-07T18:52:39.536Z,1715107959.536 [NAL9602](INFO): GPS fix at 20240507T185238: (36.802306, -121.786761)
2024-05-07T18:52:39.548Z,1715107959.548 [Default:CheckIn:Read_GPS] Stopped
2024-05-07T18:52:39.548Z,1715107959.548 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-05-07T18:52:46.417Z,1715107966.417 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20240507T175837/Courier0031.lzma
2024-05-07T18:52:47.420Z,1715107967.420 [DataOverHttps](INFO): Moved sent file to Logs/20240507T175837/Courier0031.lzma.bak
2024-05-07T18:52:47.420Z,1715107967.420 [DataOverHttps](INFO): SBD MOMSN=20824028
2024-05-07T18:53:03.470Z,1715107983.470 [DataOverHttps](INFO): Sending 132 bytes from file Logs/20240507T175837/Express0032.lzma
2024-05-07T18:53:04.472Z,1715107984.472 [DataOverHttps](INFO): Moved sent file to Logs/20240507T175837/Express0032.lzma.bak
2024-05-07T18:53:04.472Z,1715107984.472 [DataOverHttps](INFO): SBD MOMSN=20824039
2024-05-07T18:53:05.799Z,1715107985.799 [Default:CheckIn:Read_Iridium] Stopped
2024-05-07T18:53:05.799Z,1715107985.799 [Default:CheckIn:C.Wait] Running Loop=1
2024-05-07T18:53:05.799Z,1715107985.799 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-05-07T18:53:15.081Z,1715107995.081 [NAL9602](INFO): SBD MO Status=2, MOMSN=17046, MT Status=2, MTMSN=0
2024-05-07T18:53:15.081Z,1715107995.081 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2024-05-07T18:53:40.936Z,1715108020.936 [NAL9602](INFO): SBD MO Status=2, MOMSN=17046, MT Status=2, MTMSN=0
2024-05-07T18:53:40.937Z,1715108020.937 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2024-05-07T18:54:09.216Z,1715108049.216 [NAL9602](INFO): SBD MO Status=2, MOMSN=17046, MT Status=2, MTMSN=0
2024-05-07T18:54:09.217Z,1715108049.217 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2024-05-07T18:54:31.436Z,1715108071.436 [NAL9602](INFO): SBD MO Status=2, MOMSN=17046, MT Status=2, MTMSN=0
2024-05-07T18:54:31.436Z,1715108071.436 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2024-05-07T18:55:07.799Z,1715108107.799 [NAL9602](INFO): SBD MO Status=1, MOMSN=17046, MT Status=0, MTMSN=0
2024-05-07T18:55:07.799Z,1715108107.799 [NAL9602](INFO): No messages in MT queue
2024-05-07T18:55:38.507Z,1715108138.507 [NAL9602](INFO): Not Powering down - fast GPS
2024-05-07T18:58:06.379Z,1715108286.379 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-05-07T18:58:06.379Z,1715108286.379 [Default:CheckIn:C.Wait] Stopped
2024-05-07T18:58:06.379Z,1715108286.379 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-05-07T18:58:06.379Z,1715108286.379 [Default:CheckIn:D] Running Loop=1
2024-05-07T18:58:06.786Z,1715108286.786 [Default:CheckIn:D] Stopped
2024-05-07T18:58:06.786Z,1715108286.786 [Default:CheckIn:E] Running Loop=1
2024-05-07T18:58:07.199Z,1715108287.199 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 55.093091 min
2024-05-07T18:58:07.199Z,1715108287.199 [Default:CheckIn:E] Stopped
2024-05-07T18:58:07.200Z,1715108287.200 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-05-07T18:58:07.200Z,1715108287.200 [Default:CheckIn] Stopped
2024-05-07T18:58:07.200Z,1715108287.200 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-05-07T18:58:07.200Z,1715108287.200 [Default:CheckIn](INFO): Running loop #9
2024-05-07T18:58:07.200Z,1715108287.200 [Default:CheckIn] Running Loop=9
2024-05-07T18:58:07.200Z,1715108287.200 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-05-07T18:58:07.200Z,1715108287.200 [Default:CheckIn:Read_GPS] Running Loop=1
2024-05-07T18:58:09.197Z,1715108289.197 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,185808.00,A,3648.13780,N,12147.20747,W,0.330,103.10,070524,,,D*71
2024-05-07T18:58:09.199Z,1715108289.199 [NAL9602](INFO): GPS fix at 20240507T185808: (36.802297, -121.786791)
2024-05-07T18:58:09.211Z,1715108289.211 [Default:CheckIn:Read_GPS] Stopped
2024-05-07T18:58:09.211Z,1715108289.211 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-05-07T18:58:16.790Z,1715108296.790 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20240507T175837/Courier0034.lzma
2024-05-07T18:58:17.792Z,1715108297.792 [DataOverHttps](INFO): Moved sent file to Logs/20240507T175837/Courier0034.lzma.bak
2024-05-07T18:58:17.792Z,1715108297.792 [DataOverHttps](INFO): SBD MOMSN=20824121
2024-05-07T18:58:33.798Z,1715108313.798 [DataOverHttps](INFO): Sending 130 bytes from file Logs/20240507T175837/Express0035.lzma
2024-05-07T18:58:34.800Z,1715108314.800 [DataOverHttps](INFO): Moved sent file to Logs/20240507T175837/Express0035.lzma.bak
2024-05-07T18:58:34.800Z,1715108314.800 [DataOverHttps](INFO): SBD MOMSN=20824127
2024-05-07T18:58:35.869Z,1715108315.869 [Default:CheckIn:Read_Iridium] Stopped
2024-05-07T18:58:35.869Z,1715108315.869 [Default:CheckIn:C.Wait] Running Loop=1
2024-05-07T18:58:35.869Z,1715108315.869 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-05-07T18:59:17.469Z,1715108357.469 [NAL9602](INFO): SBD MO Status=2, MOMSN=17047, MT Status=2, MTMSN=0
2024-05-07T18:59:17.469Z,1715108357.469 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2024-05-07T19:01:32.473Z,1715108492.473 [NAL9602](INFO): SBD MO Status=2, MOMSN=17047, MT Status=2, MTMSN=0
2024-05-07T19:01:32.473Z,1715108492.473 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2024-05-07T19:01:40.635Z,1715108500.635 [DAT](INFO): DAT read:
2024-05-07T19:01:40.887Z,1715108500.887 [DAT](INFO): DAT read: Command '+++++' not found
2024-05-07T19:01:40.888Z,1715108500.888 [DAT](INFO): unknown deviceResponse_: Command '+++++' not found
2024-05-07T19:01:40.888Z,1715108500.888 [DAT](INFO): DAT read: Error
2024-05-07T19:01:40.888Z,1715108500.888 [DAT](INFO): unknown deviceResponse_: Error
2024-05-07T19:01:52.268Z,1715108512.268 [NAL9602](INFO): SBD MO Status=1, MOMSN=17047, MT Status=0, MTMSN=0
2024-05-07T19:01:52.268Z,1715108512.268 [NAL9602](INFO): No messages in MT queue
2024-05-07T19:02:22.979Z,1715108542.979 [NAL9602](INFO): Not Powering down - fast GPS
2024-05-07T19:02:23.158Z,1715108543.158 [CommandExec](IMPORTANT): got command configSet DAT.loadAtStartup 0 bool persist
2024-05-07T19:02:23.159Z,1715108543.159 [CommandExec](IMPORTANT): configSet DAT.loadAtStartup requires a restart to take effect.
2024-05-07T19:02:23.161Z,1715108543.161 [CommandExec](IMPORTANT): got command restart application
2024-05-07T19:02:24.162Z,1715108544.162 [Supervisor](INFO): Stop Mission called by Supervisor::terminate
2024-05-07T19:02:24.162Z,1715108544.162 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread.
2024-05-07T19:02:24.162Z,1715108544.162 [CommandExec](INFO): Uninitializing the command executive.
2024-05-07T19:02:24.162Z,1715108544.162 [CommandExec](INFO): Uninitializing the command scheduler.
2024-05-07T19:02:24.163Z,1715108544.163 [CommandExec ThreadHandler](INFO): Thread cancelled.
2024-05-07T19:02:24.238Z,1715108544.238 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye!
2024-05-07T19:02:24.238Z,1715108544.238 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2024-05-07T19:02:24.238Z,1715108544.238 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2024-05-07T19:02:24.239Z,1715108544.239 [NavChartDb](INFO): Join timeout helper Thread ID is 3554
2024-05-07T19:02:24.278Z,1715108544.278 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2024-05-07T19:02:24.278Z,1715108544.278 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2024-05-07T19:02:24.290Z,1715108544.290 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2024-05-07T19:02:24.290Z,1715108544.290 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2024-05-07T19:02:24.291Z,1715108544.291 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 3555
2024-05-07T19:02:24.466Z,1715108544.466 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread.
2024-05-07T19:02:24.466Z,1715108544.466 [WetLabsBB2FL](INFO): Powering down
2024-05-07T19:02:24.467Z,1715108544.467 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2024-05-07T19:02:24.478Z,1715108544.478 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler
2024-05-07T19:02:24.478Z,1715108544.478 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2024-05-07T19:02:24.478Z,1715108544.478 [CTD_Seabird](INFO): Join timeout helper Thread ID is 3556
2024-05-07T19:02:25.414Z,1715108545.414 [CTD_Seabird](INFO): Powering down
2024-05-07T19:02:25.426Z,1715108545.426 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread.
2024-05-07T19:02:25.426Z,1715108545.426 [CTD_Seabird](INFO): Powering down
2024-05-07T19:02:25.438Z,1715108545.438 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2024-05-07T19:02:25.446Z,1715108545.446 [ComponentRegistry](INFO): Shutting down DAT ThreadHandler
2024-05-07T19:02:25.446Z,1715108545.446 [DAT ThreadHandler](INFO): Thread cancelled.
2024-05-07T19:02:25.446Z,1715108545.446 [DAT](INFO): Join timeout helper Thread ID is 3557
2024-05-07T19:02:25.538Z,1715108545.538 [DAT](INFO): Powering down
2024-05-07T19:02:25.611Z,1715108545.611 [DAT ThreadHandler](INFO): Uninitializing protected caller thread.
2024-05-07T19:02:25.611Z,1715108545.611 [DAT](INFO): Powering down
2024-05-07T19:02:25.612Z,1715108545.612 [DAT ThreadHandler](INFO): Thread cancelled.
2024-05-07T19:02:25.626Z,1715108545.626 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2024-05-07T19:02:25.626Z,1715108545.626 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2024-05-07T19:02:25.626Z,1715108545.626 [Radio_Surface](INFO): Join timeout helper Thread ID is 3558
2024-05-07T19:02:25.986Z,1715108545.986 [Radio_Surface](INFO): Powering down
2024-05-07T19:02:25.987Z,1715108545.987 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2024-05-07T19:02:25.987Z,1715108545.987 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2024-05-07T19:02:26.007Z,1715108546.007 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler
2024-05-07T19:02:26.007Z,1715108546.007 [Onboard ThreadHandler](INFO): Thread cancelled.
2024-05-07T19:02:26.007Z,1715108546.007 [Onboard](INFO): Join timeout helper Thread ID is 3559
2024-05-07T19:02:26.022Z,1715108546.022 [DataOverHttps](INFO): Radio surface powered OFF, will not connect.
2024-05-07T19:02:26.618Z,1715108546.618 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread.
2024-05-07T19:02:26.618Z,1715108546.618 [Onboard ThreadHandler](INFO): Thread cancelled.
2024-05-07T19:02:26.631Z,1715108546.631 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler
2024-05-07T19:02:26.631Z,1715108546.631 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2024-05-07T19:02:26.631Z,1715108546.631 [DataOverHttps](INFO): Join timeout helper Thread ID is 3560
2024-05-07T19:02:27.026Z,1715108547.026 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread.
2024-05-07T19:02:27.026Z,1715108547.026 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2024-05-07T19:02:27.035Z,1715108547.035 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler
2024-05-07T19:02:27.035Z,1715108547.035 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2024-05-07T19:02:27.035Z,1715108547.035 [BackseatComponent](INFO): Join timeout helper Thread ID is 3561
2024-05-07T19:02:27.138Z,1715108547.138 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread.
2024-05-07T19:02:27.138Z,1715108547.138 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2024-05-07T19:02:27.159Z,1715108547.159 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2024-05-07T19:02:27.159Z,1715108547.159 [logger ThreadHandler](INFO): Thread cancelled.
2024-05-07T19:02:27.159Z,1715108547.159 [logger](INFO): Join timeout helper Thread ID is 3562
2024-05-07T19:02:27.166Z,1715108547.166 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2024-05-07T19:02:27.166Z,1715108547.166 [logger ThreadHandler](INFO): Thread cancelled.
2024-05-07T19:02:27.179Z,1715108547.179 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2024-05-07T19:02:27.179Z,1715108547.179 [CommandLine ThreadHandler](INFO): Thread cancelled.
2024-05-07T19:02:27.179Z,1715108547.179 [CommandLine](INFO): Join timeout helper Thread ID is 3563
2024-05-07T19:02:27.230Z,1715108547.230 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2024-05-07T19:02:27.230Z,1715108547.230 [CommandLine ThreadHandler](INFO): Thread cancelled.
2024-05-07T19:02:27.239Z,1715108547.239 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler
2024-05-07T19:02:27.239Z,1715108547.239 [CommandExec ThreadHandler](INFO): Thread cancelled.
2024-05-07T19:02:27.239Z,1715108547.239 [CommandExec](INFO): Join timeout helper Thread ID is 3564
2024-05-07T19:02:27.240Z,1715108547.240 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2024-05-07T19:02:27.240Z,1715108547.240 [controlThread ThreadHandler](INFO): Thread cancelled.
2024-05-07T19:02:27.241Z,1715108547.241 [controlThread](INFO): Join timeout helper Thread ID is 3565
2024-05-07T19:02:27.398Z,1715108547.398 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2024-05-07T19:02:27.398Z,1715108547.398 [controlThread](DEBUG): Uninitializing ControlThread
2024-05-07T19:02:27.399Z,1715108547.399 [AHRS_M2](INFO): Powering down
2024-05-07T19:02:27.471Z,1715108547.471 [NAL9602](INFO): Powering down
2024-05-07T19:02:27.472Z,1715108547.472 [Sonardyne_Nano](INFO): Powering down
2024-05-07T19:02:27.590Z,1715108547.590 [Waterlinked](INFO): Powering down
2024-05-07T19:02:27.592Z,1715108547.592 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2024-05-07T19:02:27.592Z,1715108547.592 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2024-05-07T19:02:27.593Z,1715108547.593 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2024-05-07T19:02:27.594Z,1715108547.594 [MissionManager](INFO): Uninitializing Mission Default
2024-05-07T19:02:27.594Z,1715108547.594 [Default] Stopped
2024-05-07T19:02:27.594Z,1715108547.594 [Default](DEBUG): Aggregate::uninitialize Default
2024-05-07T19:02:27.594Z,1715108547.594 [Default:B.GoToSurface] Stopped
2024-05-07T19:02:27.594Z,1715108547.594 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2024-05-07T19:02:27.594Z,1715108547.594 [Default:CheckIn] Stopped
2024-05-07T19:02:27.594Z,1715108547.594 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-05-07T19:02:27.594Z,1715108547.594 [Default:CheckIn:C.Wait] Stopped
2024-05-07T19:02:27.594Z,1715108547.594 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-05-07T19:02:27.597Z,1715108547.597 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2024-05-07T19:02:27.597Z,1715108547.597 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2024-05-07T19:02:27.598Z,1715108547.598 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2024-05-07T19:02:27.598Z,1715108547.598 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2024-05-07T19:02:27.598Z,1715108547.598 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2024-05-07T19:02:27.599Z,1715108547.599 [BuoyancyServo](INFO): Powering down
2024-05-07T19:02:27.610Z,1715108547.610 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2024-05-07T19:02:27.610Z,1715108547.610 [ElevatorServo](INFO): Powering down
2024-05-07T19:02:27.611Z,1715108547.611 [MassServo](DEBUG): Uninitialize Mass Servo.
2024-05-07T19:02:27.611Z,1715108547.611 [MassServo](INFO): Powering down
2024-05-07T19:02:27.612Z,1715108547.612 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2024-05-07T19:02:27.612Z,1715108547.612 [RudderServo](INFO): Powering down
2024-05-07T19:02:27.613Z,1715108547.613 [ThrusterHE](DEBUG): Uninitialize Thruster Servo.
2024-05-07T19:02:27.613Z,1715108547.613 [ThrusterHE](INFO): Powering down
2024-05-07T19:02:27.614Z,1715108547.614 [SBIT](DEBUG): Uninitialize SBIT Component.
2024-05-07T19:02:27.614Z,1715108547.614 [IBIT](DEBUG): Uninitialize IBIT Component.
2024-05-07T19:02:27.614Z,1715108547.614 [CBIT](DEBUG): Uninitialize CBIT Component.
2024-05-07T19:02:27.615Z,1715108547.615 [CBIT](DEBUG): Powering off loads.
2024-05-07T19:02:27.626Z,1715108547.626 [CBIT](DEBUG): Disabling WDT.
2024-05-07T19:02:27.638Z,1715108547.638 [CBIT](DEBUG): Opening all GF detection circuits.
2024-05-07T19:02:27.639Z,1715108547.639 [controlThread ThreadHandler](INFO): Thread cancelled.
2024-05-07T19:02:27.672Z,1715108547.672 [DAT ThreadHandler](INFO): Thread cancelled.
2024-05-07T19:02:27.678Z,1715108547.678 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2024-05-07T19:02:27.680Z,1715108547.680 [Onboard ThreadHandler](INFO): Thread cancelled.
2024-05-07T19:02:27.686Z,1715108547.686 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2024-05-07T19:02:27.729Z,1715108547.729 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2024-05-07T19:02:27.778Z,1715108547.778 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2024-05-07T19:02:27.782Z,1715108547.782 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2024-05-07T19:02:27.843Z,1715108547.843 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2024-05-07T19:02:27.892Z,1715108547.892 [logger ThreadHandler](INFO): Thread cancelled.