2023-10-02T21:57:30.382Z,1696283850.382 [Supervisor](DEBUG): Initializing supervisor.
2023-10-02T21:57:30.387Z,1696283850.387 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2023-10-02T21:57:30.388Z,1696283850.388 [SyncHandler](INFO): Protected caller Thread ID is 4826
2023-10-02T21:57:30.388Z,1696283850.388 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2023-10-02T21:57:30.390Z,1696283850.390 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2023-10-02T21:57:30.390Z,1696283850.390 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 4827
2023-10-02T21:57:30.394Z,1696283850.394 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2023-10-02T21:57:30.412Z,1696283850.412 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread.
2023-10-02T21:57:30.413Z,1696283850.413 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2023-10-02T21:57:30.413Z,1696283850.413 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 4828
2023-10-02T21:57:30.417Z,1696283850.417 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2023-10-02T21:57:30.418Z,1696283850.418 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2023-10-02T21:57:30.419Z,1696283850.419 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 4829
2023-10-02T21:57:30.420Z,1696283850.420 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2023-10-02T21:57:30.421Z,1696283850.421 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0
2023-10-02T21:57:30.422Z,1696283850.422 [logger ThreadHandler](INFO): Protected caller Thread ID is 4830
2023-10-02T21:57:30.425Z,1696283850.425 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2023-10-02T21:57:30.426Z,1696283850.426 [Supervisor](INFO): Looking for Config files in directory: Config/
2023-10-02T21:57:30.427Z,1696283850.427 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2023-10-02T21:57:30.763Z,1696283850.763 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2023-10-02T21:57:30.764Z,1696283850.764 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2023-10-02T21:57:30.845Z,1696283850.845 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2023-10-02T21:57:30.953Z,1696283850.953 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2023-10-02T21:57:30.954Z,1696283850.954 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2023-10-02T21:57:31.083Z,1696283851.083 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2023-10-02T21:57:31.084Z,1696283851.084 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2023-10-02T21:57:31.428Z,1696283851.428 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2023-10-02T21:57:31.429Z,1696283851.429 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2023-10-02T21:57:31.526Z,1696283851.526 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2023-10-02T21:57:31.527Z,1696283851.527 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2023-10-02T21:57:31.934Z,1696283851.934 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2023-10-02T21:57:31.935Z,1696283851.935 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2023-10-02T21:57:32.147Z,1696283852.147 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2023-10-02T21:57:32.148Z,1696283852.148 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2023-10-02T21:57:32.228Z,1696283852.228 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg
2023-10-02T21:57:32.459Z,1696283852.459 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock
2023-10-02T21:57:32.459Z,1696283852.459 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2023-10-02T21:57:32.679Z,1696283852.679 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2023-10-02T21:57:32.680Z,1696283852.680 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2023-10-02T21:57:33.190Z,1696283853.190 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2023-10-02T21:57:33.191Z,1696283853.191 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2023-10-02T21:57:33.383Z,1696283853.383 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2023-10-02T21:57:33.383Z,1696283853.383 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2023-10-02T21:57:33.670Z,1696283853.670 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2023-10-02T21:57:33.671Z,1696283853.671 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2023-10-02T21:57:34.508Z,1696283854.508 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2023-10-02T21:57:34.508Z,1696283854.508 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2023-10-02T21:57:35.058Z,1696283855.058 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2023-10-02T21:57:35.060Z,1696283855.060 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-ahi/
2023-10-02T21:57:35.061Z,1696283855.061 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Control.cfg
2023-10-02T21:57:35.159Z,1696283855.159 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Science.cfg
2023-10-02T21:57:35.278Z,1696283855.278 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/secure.cfg
2023-10-02T21:57:35.364Z,1696283855.364 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Servo.cfg
2023-10-02T21:57:35.473Z,1696283855.473 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/BIT.cfg
2023-10-02T21:57:35.573Z,1696283855.573 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Battery.cfg
2023-10-02T21:57:35.832Z,1696283855.832 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2023-10-02T21:57:35.832Z,1696283855.832 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/vehicle.cfg
2023-10-02T21:57:35.946Z,1696283855.946 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/logger.cfg
2023-10-02T21:57:36.042Z,1696283856.042 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Navigation.cfg
2023-10-02T21:57:36.148Z,1696283856.148 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Sensor.cfg
2023-10-02T21:57:36.282Z,1696283856.282 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Simulator.cfg
2023-10-02T21:57:36.370Z,1696283856.370 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-ahi/root/
2023-10-02T21:57:36.370Z,1696283856.370 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg
2023-10-02T21:57:36.378Z,1696283856.378 [Module Loader](DEBUG): Loading Module at Modules/Dock.so
2023-10-02T21:57:36.476Z,1696283856.476 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking)
2023-10-02T21:57:36.477Z,1696283856.477 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2023-10-02T21:57:36.526Z,1696283856.526 [VerticalControl](DEBUG): Construct VerticalControl.
2023-10-02T21:57:36.586Z,1696283856.586 [VerticalControl] Loaded
2023-10-02T21:57:36.586Z,1696283856.586 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2023-10-02T21:57:36.589Z,1696283856.589 [HorizontalControl](DEBUG): Construct HorizontalControl.
2023-10-02T21:57:36.629Z,1696283856.629 [HorizontalControl] Loaded
2023-10-02T21:57:36.630Z,1696283856.630 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2023-10-02T21:57:36.632Z,1696283856.632 [SpeedControl](DEBUG): Construct SpeedControl.
2023-10-02T21:57:36.635Z,1696283856.635 [SpeedControl] Loaded
2023-10-02T21:57:36.635Z,1696283856.635 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2023-10-02T21:57:36.638Z,1696283856.638 [LoopControl](DEBUG): Construct LoopControl.
2023-10-02T21:57:36.638Z,1696283856.638 [LoopControl] Loaded
2023-10-02T21:57:36.639Z,1696283856.639 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2023-10-02T21:57:36.639Z,1696283856.639 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2023-10-02T21:57:36.639Z,1696283856.639 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2023-10-02T21:57:36.694Z,1696283856.694 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2023-10-02T21:57:36.694Z,1696283856.694 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2023-10-02T21:57:37.135Z,1696283857.135 [AHRS_M2] Loaded
2023-10-02T21:57:37.136Z,1696283857.136 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread.
2023-10-02T21:57:37.171Z,1696283857.171 [BackseatComponent] Loaded
2023-10-02T21:57:37.171Z,1696283857.171 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread.
2023-10-02T21:57:37.172Z,1696283857.172 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 408814E0
2023-10-02T21:57:37.173Z,1696283857.173 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 4912
2023-10-02T21:57:37.175Z,1696283857.175 [LcmUniversalReporter] Loaded
2023-10-02T21:57:37.176Z,1696283857.176 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread.
2023-10-02T21:57:37.974Z,1696283857.974 [BPC1] Loaded
2023-10-02T21:57:37.974Z,1696283857.974 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2023-10-02T21:57:38.046Z,1696283858.046 [DataOverHttps] Loaded
2023-10-02T21:57:38.046Z,1696283858.046 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2023-10-02T21:57:38.047Z,1696283858.047 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 408B14E0
2023-10-02T21:57:38.047Z,1696283858.047 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 4913
2023-10-02T21:57:38.068Z,1696283858.068 [Depth_Keller] Loaded
2023-10-02T21:57:38.068Z,1696283858.068 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2023-10-02T21:57:38.073Z,1696283858.073 [DropWeight] Loaded
2023-10-02T21:57:38.073Z,1696283858.073 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2023-10-02T21:57:38.135Z,1696283858.135 [NAL9602] Loaded
2023-10-02T21:57:38.136Z,1696283858.136 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2023-10-02T21:57:38.165Z,1696283858.165 [Onboard] Loaded
2023-10-02T21:57:38.165Z,1696283858.165 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread.
2023-10-02T21:57:38.167Z,1696283858.167 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 408E14E0
2023-10-02T21:57:38.167Z,1696283858.167 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 4914
2023-10-02T21:57:38.181Z,1696283858.181 [Power24vConverter] Loaded
2023-10-02T21:57:38.181Z,1696283858.181 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread.
2023-10-02T21:57:38.194Z,1696283858.194 [Radio_Surface] Loaded
2023-10-02T21:57:38.194Z,1696283858.194 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2023-10-02T21:57:38.195Z,1696283858.195 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 409114E0
2023-10-02T21:57:38.196Z,1696283858.196 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 4915
2023-10-02T21:57:38.286Z,1696283858.286 [DAT] Loaded
2023-10-02T21:57:38.286Z,1696283858.286 [ComponentRegistry](DEBUG): Component "DAT" handled in its own thread.
2023-10-02T21:57:38.287Z,1696283858.287 [DAT ThreadHandler](DEBUG): Created PCaller Thread at 409414E0
2023-10-02T21:57:38.288Z,1696283858.288 [DAT ThreadHandler](INFO): Protected caller Thread ID is 4916
2023-10-02T21:57:38.310Z,1696283858.310 [Waterlinked] Loaded
2023-10-02T21:57:38.311Z,1696283858.311 [ComponentRegistry](DEBUG): SyncComponent "Waterlinked" handled in the control thread.
2023-10-02T21:57:38.311Z,1696283858.311 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2023-10-02T21:57:38.311Z,1696283858.311 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2023-10-02T21:57:38.321Z,1696283858.321 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2023-10-02T21:57:38.322Z,1696283858.322 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2023-10-02T21:57:38.348Z,1696283858.348 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2023-10-02T21:57:38.349Z,1696283858.349 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2023-10-02T21:57:38.484Z,1696283858.484 [SBIT](DEBUG): Construct Startup Built In Test.
2023-10-02T21:57:38.493Z,1696283858.493 [SBIT] Loaded
2023-10-02T21:57:38.493Z,1696283858.493 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2023-10-02T21:57:38.496Z,1696283858.496 [IBIT](DEBUG): Construct Initiated Built In Test.
2023-10-02T21:57:38.508Z,1696283858.508 [IBIT] Loaded
2023-10-02T21:57:38.509Z,1696283858.509 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2023-10-02T21:57:38.515Z,1696283858.515 [CBIT](DEBUG): Construct Continuous Built In Test.
2023-10-02T21:57:38.617Z,1696283858.617 [CBIT] Loaded
2023-10-02T21:57:38.617Z,1696283858.617 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2023-10-02T21:57:38.618Z,1696283858.618 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2023-10-02T21:57:38.618Z,1696283858.618 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2023-10-02T21:57:38.914Z,1696283858.914 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2023-10-02T21:57:38.915Z,1696283858.915 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2023-10-02T21:57:38.963Z,1696283858.963 [DepthRateCalculator] Loaded
2023-10-02T21:57:38.963Z,1696283858.963 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2023-10-02T21:57:38.968Z,1696283858.968 [PitchRateCalculator] Loaded
2023-10-02T21:57:38.969Z,1696283858.969 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2023-10-02T21:57:38.979Z,1696283858.979 [SpeedCalculator] Loaded
2023-10-02T21:57:38.979Z,1696283858.979 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2023-10-02T21:57:38.983Z,1696283858.983 [YawRateCalculator] Loaded
2023-10-02T21:57:38.983Z,1696283858.983 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2023-10-02T21:57:39.002Z,1696283859.002 [ElevatorOffsetCalculator] Loaded
2023-10-02T21:57:39.002Z,1696283859.002 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2023-10-02T21:57:39.003Z,1696283859.003 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2023-10-02T21:57:39.003Z,1696283859.003 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2023-10-02T21:57:39.151Z,1696283859.151 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2023-10-02T21:57:39.151Z,1696283859.151 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2023-10-02T21:57:39.260Z,1696283859.260 [DeadReckonUsingMultipleVelocitySources] Loaded
2023-10-02T21:57:39.260Z,1696283859.260 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2023-10-02T21:57:39.303Z,1696283859.303 [DeadReckonUsingSpeedCalculator] Loaded
2023-10-02T21:57:39.304Z,1696283859.304 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread.
2023-10-02T21:57:39.346Z,1696283859.346 [DeadReckonWithRespectToSeafloor] Loaded
2023-10-02T21:57:39.346Z,1696283859.346 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonWithRespectToSeafloor" handled in the control thread.
2023-10-02T21:57:39.360Z,1696283859.360 [NavChart] Loaded
2023-10-02T21:57:39.360Z,1696283859.360 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2023-10-02T21:57:39.366Z,1696283859.366 [UniversalFixResidualReporter] Loaded
2023-10-02T21:57:39.366Z,1696283859.366 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2023-10-02T21:57:39.366Z,1696283859.366 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2023-10-02T21:57:39.367Z,1696283859.367 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2023-10-02T21:57:39.495Z,1696283859.495 [BuoyancyServo] Loaded
2023-10-02T21:57:39.495Z,1696283859.495 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2023-10-02T21:57:39.516Z,1696283859.516 [ElevatorServo] Loaded
2023-10-02T21:57:39.516Z,1696283859.516 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2023-10-02T21:57:39.536Z,1696283859.536 [MassServo] Loaded
2023-10-02T21:57:39.536Z,1696283859.536 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2023-10-02T21:57:39.555Z,1696283859.555 [RudderServo] Loaded
2023-10-02T21:57:39.555Z,1696283859.555 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2023-10-02T21:57:39.569Z,1696283859.569 [ThrusterHE] Loaded
2023-10-02T21:57:39.570Z,1696283859.570 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread.
2023-10-02T21:57:39.570Z,1696283859.570 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2023-10-02T21:57:39.571Z,1696283859.571 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2023-10-02T21:57:39.741Z,1696283859.741 [CTD_Seabird] Loaded
2023-10-02T21:57:39.741Z,1696283859.741 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread.
2023-10-02T21:57:39.742Z,1696283859.742 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40B9B4E0
2023-10-02T21:57:39.742Z,1696283859.742 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 4917
2023-10-02T21:57:39.775Z,1696283859.775 [ESPComponent] Loaded
2023-10-02T21:57:39.776Z,1696283859.776 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread.
2023-10-02T21:57:39.796Z,1696283859.796 [PAR_Licor] Loaded
2023-10-02T21:57:39.796Z,1696283859.796 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2023-10-02T21:57:39.837Z,1696283859.837 [WetLabsBB2FL] Loaded
2023-10-02T21:57:39.837Z,1696283859.837 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2023-10-02T21:57:39.838Z,1696283859.838 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40BCB4E0
2023-10-02T21:57:39.838Z,1696283859.838 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 4918
2023-10-02T21:57:39.839Z,1696283859.839 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2023-10-02T21:57:39.845Z,1696283859.845 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2023-10-02T21:57:39.848Z,1696283859.848 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2023-10-02T21:57:39.859Z,1696283859.859 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2023-10-02T21:57:39.860Z,1696283859.860 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40BFB4E0
2023-10-02T21:57:39.861Z,1696283859.861 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 4919
2023-10-02T21:57:39.865Z,1696283859.865 [Supervisor](INFO): Main Thread ID is 4689
2023-10-02T21:57:39.865Z,1696283859.865 [Supervisor](DEBUG): Running supervisor.
2023-10-02T21:57:39.866Z,1696283859.866 [CommandExec ThreadHandler](INFO): Handler Thread ID is 4920
2023-10-02T21:57:39.866Z,1696283859.866 [CommandExec](INFO): Initializing the command executive.
2023-10-02T21:57:39.868Z,1696283859.868 [CommandLine ThreadHandler](INFO): Handler Thread ID is 4921
2023-10-02T21:57:39.870Z,1696283859.870 [controlThread ThreadHandler](INFO): Handler Thread ID is 4922
2023-10-02T21:57:39.871Z,1696283859.871 [controlThread](DEBUG): Initializing ControlThread
2023-10-02T21:57:39.871Z,1696283859.871 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2023-10-02T21:57:39.873Z,1696283859.873 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2023-10-02T21:57:39.874Z,1696283859.874 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2023-10-02T21:57:39.874Z,1696283859.874 [LoopControl](DEBUG): Initialize LoopControlComponent.
2023-10-02T21:57:39.880Z,1696283859.880 [SBIT](INFO): Initialize SBIT Component.
2023-10-02T21:57:39.881Z,1696283859.881 [SBIT](IMPORTANT): git: 2023-09-18-3-g7ee55e0de
2023-10-02T21:57:39.881Z,1696283859.881 [SBIT](INFO): git hash: 7ee55e0ded82548f5c252ba0d9a41930617440e4
2023-10-02T21:57:39.881Z,1696283859.881 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2023-10-02T21:57:39.883Z,1696283859.883 [SBIT](INFO): Kernel Reporting Different Version From Configuration.
Kernel Expected: #639 PREEMPT Wed Mar 12 12:53:33 PDT 2014
Kernel Reported: #1 PREEMPT Wed Mar 17 08:23:48 PDT 2021
2023-10-02T21:57:39.884Z,1696283859.884 [SBIT](INFO): Beginning SBIT in 60.000000 seconds.
2023-10-02T21:57:39.884Z,1696283859.884 [IBIT](INFO): Initialize IBIT Component.
2023-10-02T21:57:39.885Z,1696283859.885 [CBIT](DEBUG): Initialize CBIT Component.
2023-10-02T21:57:39.886Z,1696283859.886 [logger ThreadHandler](INFO): Handler Thread ID is 4923
2023-10-02T21:57:39.899Z,1696283859.899 [CBIT](DEBUG): Initialized mux pins.
2023-10-02T21:57:39.899Z,1696283859.899 [CBIT](DEBUG): Initializing the watchdog timer.
2023-10-02T21:57:39.903Z,1696283859.903 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 4924
2023-10-02T21:57:39.911Z,1696283859.911 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 4925
2023-10-02T21:57:39.912Z,1696283859.912 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2023-10-02T21:57:39.922Z,1696283859.922 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2023-10-02T21:57:39.923Z,1696283859.923 [CBIT](DEBUG): Initializing heartbeat.
2023-10-02T21:57:39.924Z,1696283859.924 [Onboard ThreadHandler](INFO): Handler Thread ID is 4926
2023-10-02T21:57:39.952Z,1696283859.952 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 4927
2023-10-02T21:57:39.956Z,1696283859.956 [DAT ThreadHandler](INFO): Handler Thread ID is 4928
2023-10-02T21:57:39.957Z,1696283859.957 [DAT](INFO): Powering up
2023-10-02T21:57:39.957Z,1696283859.957 [DAT](DEBUG): Initializing DAT.
2023-10-02T21:57:39.960Z,1696283859.960 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 4930
2023-10-02T21:57:39.960Z,1696283859.960 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2023-10-02T21:57:39.964Z,1696283859.964 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 4932
2023-10-02T21:57:39.967Z,1696283859.967 [WetLabsBB2FL](INFO): Powering up
2023-10-02T21:57:39.968Z,1696283859.968 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 4934
2023-10-02T21:57:39.971Z,1696283859.971 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2HA05M.000
2023-10-02T21:57:39.972Z,1696283859.972 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2HA05M.000
2023-10-02T21:57:39.972Z,1696283859.972 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3HA20M.000
2023-10-02T21:57:39.972Z,1696283859.972 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3HA20M.000
2023-10-02T21:57:39.972Z,1696283859.972 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4HA51M.000
2023-10-02T21:57:39.972Z,1696283859.972 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4HA51M.000
2023-10-02T21:57:39.972Z,1696283859.972 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4HA51M.000
2023-10-02T21:57:39.973Z,1696283859.973 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4HA51M.000
2023-10-02T21:57:39.973Z,1696283859.973 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5HA53M.000
2023-10-02T21:57:39.973Z,1696283859.973 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5HA53M.000
2023-10-02T21:57:39.973Z,1696283859.973 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5HA55M.000
2023-10-02T21:57:39.973Z,1696283859.973 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5HA55M.000
2023-10-02T21:57:39.994Z,1696283859.994 [CBIT](DEBUG): Deactivating GF circuits.
2023-10-02T21:57:39.994Z,1696283859.994 [CBIT](DEBUG): Deactivating emergency mode.
2023-10-02T21:57:40.034Z,1696283860.034 [CBIT](DEBUG): Backplane powered.
2023-10-02T21:57:40.035Z,1696283860.035 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2023-10-02T21:57:40.035Z,1696283860.035 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2023-10-02T21:57:40.035Z,1696283860.035 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2023-10-02T21:57:40.036Z,1696283860.036 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2023-10-02T21:57:40.036Z,1696283860.036 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2023-10-02T21:57:40.037Z,1696283860.037 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2023-10-02T21:57:40.038Z,1696283860.038 [NavChart](DEBUG): Initialize NavChart Navigation.
2023-10-02T21:57:40.038Z,1696283860.038 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2023-10-02T21:57:40.043Z,1696283860.043 [MissionManager](INFO): Loading Mission from file: Missions/Startup.xml
2023-10-02T21:57:40.064Z,1696283860.064 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2023-10-02T21:57:40.093Z,1696283860.093 [MissionManager](DEBUG): 
<?xml version="1.0" encoding="UTF-8"?>
<Mission xmlns="Tethys"
       xmlns:Control="Tethys/Control"
       xmlns:Guidance="Tethys/Guidance" 
       xmlns:Units="Tethys/Units"
       xmlns:Universal="Tethys/Universal"
       xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"
       xsi:schemaLocation="Tethys http://okeanids.mbari.org/tethys/Xml/Tethys.xsd
                           Tethys/Control http://okeanids.mbari.org/tethys/Xml/Control.xsd
                           Tethys/Guidance http://okeanids.mbari.org/tethys/Xml/Guidance.xsd
                           Tethys/Units http://okeanids.mbari.org/tethys/Xml/Units.xsd
                           Tethys/Universal http://okeanids.mbari.org/tethys/Xml/Universal.xsd"
       Id="Startup">

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

    <Aggregate Id="StartupSatComms">

        <Sequence/>

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

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

    </Aggregate>

</Mission>


2023-10-02T21:57:40.094Z,1696283860.094 [MissionManager](INFO): Loading Mission from file: Missions/Default.xml
2023-10-02T21:57:40.167Z,1696283860.167 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2023-10-02T21:57:40.168Z,1696283860.168 [Default:A.Wait](DEBUG): Construct Wait.
2023-10-02T21:57:40.171Z,1696283860.171 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2023-10-02T21:57:40.200Z,1696283860.200 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2023-10-02T21:57:40.202Z,1696283860.202 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2023-10-02T21:57:40.232Z,1696283860.232 [Default:E.Execute](DEBUG): Construct Execute.
2023-10-02T21:57:40.235Z,1696283860.235 [MissionManager](DEBUG): 
<?xml version="1.0" encoding="UTF-8"?>
<Mission xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"
         xmlns="Tethys"
         xmlns:Units="Tethys/Units"
         xmlns:Guidance="Tethys/Guidance"
         xmlns:Universal="Tethys/Universal"
         xsi:schemaLocation="Tethys http://okeanids.mbari.org/tethys/Xml/Tethys.xsd
                             Tethys/Units http://okeanids.mbari.org/tethys/Xml/Units.xsd
                             Tethys/Guidance http://okeanids.mbari.org/tethys/Xml/Guidance.xsd
                             Tethys/Universal http://okeanids.mbari.org/tethys/Xml/Universal.xsd"
         Id="Default">

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

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

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

    <Aggregate Id="CheckIn">

        <Sequence Repeat="288"/>

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

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

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

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

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

    </Aggregate>

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

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

</Mission>


2023-10-02T21:57:40.240Z,1696283860.240 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,DropWeight,NAL9602,Power24vConverter,Waterlinked,ESPComponent,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,DeadReckonUsingSpeedCalculator,DeadReckonWithRespectToSeafloor,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter,
2023-10-02T21:57:40.262Z,1696283860.262 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2023-10-02T21:57:40.316Z,1696283860.316 [Depth_Keller](ERROR): Pressure or depth reading out of range: -1.140412 decibar, -1.132002 m
2023-10-02T21:57:40.317Z,1696283860.317 [Power24vConverter](INFO): Powering up.
2023-10-02T21:57:40.329Z,1696283860.329 [DepthRateCalculator](ERROR): Depth measurement is not active
2023-10-02T21:57:40.354Z,1696283860.354 [Radio_Surface](INFO): Powering up
2023-10-02T21:57:40.357Z,1696283860.357 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2023-10-02T21:57:40.363Z,1696283860.363 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2023-10-02T21:57:40.364Z,1696283860.364 [ElevatorServo](DEBUG): Initializing EZServoServo.
2023-10-02T21:57:40.371Z,1696283860.371 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2023-10-02T21:57:40.372Z,1696283860.372 [MassServo](DEBUG): Initializing EZServoServo.
2023-10-02T21:57:40.379Z,1696283860.379 [MassServo](DEBUG): Initializing MassServo.
2023-10-02T21:57:40.379Z,1696283860.379 [RudderServo](DEBUG): Initializing EZServoServo.
2023-10-02T21:57:40.387Z,1696283860.387 [RudderServo](DEBUG): Initializing RudderServo.
2023-10-02T21:57:40.388Z,1696283860.388 [ThrusterHE](DEBUG): Initializing EZServoServo.
2023-10-02T21:57:40.395Z,1696283860.395 [ThrusterHE](DEBUG): Initializing ThrusterHE.
2023-10-02T21:57:40.700Z,1696283860.700 [DropWeight](CRITICAL): DROP WEIGHT MISSING.

2023-10-02T21:57:40.700Z,1696283860.700 [DropWeight] Hardware Fault, FailCount= 1
2023-10-02T21:57:40.700Z,1696283860.700 [DropWeight](ERROR): Hardware Fault
2023-10-02T21:57:40.727Z,1696283860.727 [CommandExec](FAULT): Scheduling is paused
2023-10-02T21:57:40.727Z,1696283860.727 [CBIT](INFO): Critical error at 20231002T215740
2023-10-02T21:57:40.728Z,1696283860.728 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals
2023-10-02T21:57:40.734Z,1696283860.734 [CBIT](ERROR): Hardware Fault in component: DropWeight
2023-10-02T21:57:40.735Z,1696283860.735 [CBIT](CRITICAL): Hardware Fault in component: DropWeight
2023-10-02T21:57:41.077Z,1696283861.077 [CBIT](INFO): Critical error at 20231002T215740
2023-10-02T21:57:42.074Z,1696283862.074 [WetLabsBB2FL](INFO): Powering down
2023-10-02T21:57:46.160Z,1696283866.160 [ThrusterHE](ERROR): Zero Speed Commanded.
2023-10-02T21:57:49.539Z,1696283869.539 [DAT](INFO): DAT read: 

2023-10-02T21:57:49.541Z,1696283869.541 [DAT](INFO): DAT read: Teledyne Benthos DAT-900 Series

2023-10-02T21:57:50.800Z,1696283870.800 [DAT](INFO): DAT read: MF Frequency Band

2023-10-02T21:57:50.801Z,1696283870.801 [DAT](INFO): DAT read: Directional Acoustic Transponder version 8.10.9

2023-10-02T21:57:50.802Z,1696283870.802 [DAT](INFO): DAT read: Oct  2 2023 21:57:46 

2023-10-02T21:57:51.556Z,1696283871.556 [DAT](INFO): DAT read: Features enabled [Bearing]

2023-10-02T21:57:51.558Z,1696283871.558 [DAT](INFO): DAT read: CONNECT 00800 bits/sec 1 of 4, Rate 1/2 CC 12.50ms MGP

2023-10-02T21:57:51.558Z,1696283871.558 [DAT](INFO): commRate: 800
2023-10-02T21:57:53.622Z,1696283873.622 [DAT](INFO): entering command mode
2023-10-02T21:57:53.823Z,1696283873.823 [DAT](INFO): DAT read: 

2023-10-02T21:57:53.823Z,1696283873.823 [DAT](INFO): DAT read: user:1>

2023-10-02T21:57:53.824Z,1696283873.824 [DAT](INFO): setting verbose to 3
2023-10-02T21:57:54.075Z,1696283874.075 [DAT](INFO): DAT read: user:1>

2023-10-02T21:57:54.076Z,1696283874.076 [DAT](INFO): DAT read: Verbose         | 3           

2023-10-02T21:57:54.076Z,1696283874.076 [DAT](INFO): set verbose to 3
2023-10-02T21:57:54.077Z,1696283874.077 [DAT](INFO): setting DatVerbose to 27440
2023-10-02T21:57:54.327Z,1696283874.327 [DAT](INFO): DAT read: user:2>

2023-10-02T21:57:54.328Z,1696283874.328 [DAT](INFO): DAT read: DatVerbose      | 27440       

2023-10-02T21:57:54.328Z,1696283874.328 [DAT](INFO): set DatVerbose to 27440
2023-10-02T21:57:54.329Z,1696283874.329 [DAT](INFO): setting transmit power to 8
2023-10-02T21:57:54.579Z,1696283874.579 [DAT](INFO): DAT read: user:3>

2023-10-02T21:57:54.580Z,1696283874.580 [DAT](INFO): DAT read: TxPower         | 8 (Max)     

2023-10-02T21:57:54.580Z,1696283874.580 [DAT](INFO): set transmit power to 8
2023-10-02T21:57:54.581Z,1696283874.581 [DAT](INFO): setting local address to 1
2023-10-02T21:57:54.831Z,1696283874.831 [DAT](INFO): DAT read: user:4>

2023-10-02T21:57:54.832Z,1696283874.832 [DAT](INFO): DAT read: LocalAddr       | 1           

2023-10-02T21:57:54.832Z,1696283874.832 [DAT](INFO): set local address to 1
2023-10-02T21:57:54.834Z,1696283874.834 [DAT](INFO): Setting time to: 21:57:54 And date to:10/2/2023
2023-10-02T21:57:55.083Z,1696283875.083 [DAT](INFO): DAT read: user:5>

2023-10-02T21:57:55.084Z,1696283875.084 [DAT](INFO): DAT read: Mon Oct 2, 2023  21:57:54  

2023-10-02T21:57:55.084Z,1696283875.084 [DAT](INFO): Local DAT time set to Mon Oct 2, 2023  21:57:54  

2023-10-02T21:57:55.085Z,1696283875.085 [DAT](INFO): DAT read: Ok

2023-10-02T21:57:55.085Z,1696283875.085 [DAT](INFO): unknown deviceResponse_: Ok

2023-10-02T21:58:08.160Z,1696283888.160 [NAL9602](INFO): Powering up NAL9602
2023-10-02T21:58:19.069Z,1696283899.069 [NAL9602](INFO): NAL9602 initialized
2023-10-02T21:58:40.527Z,1696283920.527 [SBIT](IMPORTANT): Beginning Startup BIT
2023-10-02T21:58:40.531Z,1696283920.531 [CBIT](IMPORTANT): Beginning ground fault scan
2023-10-02T21:58:51.633Z,1696283931.633 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): -0.000401
CHAN A1 (24V): 0.000151
CHAN A2 (12V): -0.000328
CHAN A3 (5V): -0.001303
CHAN B0 (3.3V): -0.000142
CHAN B1 (3.15aV): 0.000437
CHAN B2 (3.15bV): -0.000185
CHAN B3 (GND): -0.000047
OPEN: 0.006777
Full Scale: +/- 1 mA
2023-10-02T21:58:59.119Z,1696283939.119 [Waterlinked](INFO): Powering down
2023-10-02T21:59:31.699Z,1696283971.699 [CommandExec](IMPORTANT): got command failComponent
2023-10-02T21:59:31.699Z,1696283971.699 [CommandExec](IMPORTANT): Failed components:
2023-10-02T21:59:31.699Z,1696283971.699 [CommandExec](IMPORTANT): DropWeight: Hardware Fault
2023-10-02T21:59:34.205Z,1696283974.205 [SBIT](IMPORTANT): SBIT PASSED
2023-10-02T21:59:34.205Z,1696283974.205 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2023-10-02T21:59:34.206Z,1696283974.206 [SBIT](IMPORTANT): BackseatComponent.loadAtStartup=1 bool;

2023-10-02T21:59:34.206Z,1696283974.206 [SBIT](IMPORTANT): BackseatComponent.needs24v=1 bool;

2023-10-02T21:59:34.206Z,1696283974.206 [SBIT](IMPORTANT): CBIT.gf24Offset=158.5 microampere;

2023-10-02T21:59:34.207Z,1696283974.207 [SBIT](IMPORTANT): PowerOnly.sampleTime1=1 second;

2023-10-02T21:59:34.207Z,1696283974.207 [SBIT](IMPORTANT): Rowe_600.loadAtStartup=0 bool;

2023-10-02T21:59:34.207Z,1696283974.207 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=159.679458 cubic_centimeter;

2023-10-02T21:59:34.207Z,1696283974.207 [SBIT](IMPORTANT): VerticalControl.massDefault=10.000082 millimeter;

2023-10-02T21:59:34.303Z,1696283974.303 [CommandExec](IMPORTANT): got command failComponent
2023-10-02T21:59:34.303Z,1696283974.303 [CommandExec](IMPORTANT): Failed components:
2023-10-02T21:59:34.303Z,1696283974.303 [CommandExec](IMPORTANT): DropWeight: Hardware Fault
2023-10-02T21:59:34.612Z,1696283974.612 [MissionManager](IMPORTANT): Started mission Startup
2023-10-02T21:59:34.612Z,1696283974.612 [Startup] Running Loop=1
2023-10-02T21:59:34.612Z,1696283974.612 [Startup](DEBUG): Aggregate::initialize Startup
2023-10-02T21:59:34.612Z,1696283974.612 [Startup:A.GoToSurface] Running Loop=1
2023-10-02T21:59:34.612Z,1696283974.612 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2023-10-02T21:59:34.613Z,1696283974.613 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2023-10-02T21:59:34.613Z,1696283974.613 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2023-10-02T21:59:34.614Z,1696283974.614 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2023-10-02T21:59:34.614Z,1696283974.614 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2023-10-02T21:59:34.615Z,1696283974.615 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2023-10-02T21:59:34.616Z,1696283974.616 [Startup:StartupSatComms] Running Loop=1
2023-10-02T21:59:34.616Z,1696283974.616 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2023-10-02T21:59:34.617Z,1696283974.617 [Startup:StartupSatComms:A] Running Loop=1
2023-10-02T21:59:35.060Z,1696283975.060 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2023-10-02T22:00:25.261Z,1696284025.261 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004962
2023-10-02T22:00:34.835Z,1696284034.835 [Startup:StartupSatComms:A](INFO): Timed out from 2023-10-02T21:59:34.6Z
2023-10-02T22:00:34.835Z,1696284034.835 [Startup:StartupSatComms:A] Stopped
2023-10-02T22:00:34.835Z,1696284034.835 [Startup:StartupSatComms:B] Running Loop=1
2023-10-02T22:00:35.304Z,1696284035.304 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2023-10-02T22:00:40.115Z,1696284040.115 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2023-10-02T22:00:40.115Z,1696284040.115 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-10-02T22:00:40.116Z,1696284040.116 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 1
2023-10-02T22:00:40.116Z,1696284040.116 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2023-10-02T22:00:40.117Z,1696284040.117 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1
2023-10-02T22:00:40.117Z,1696284040.117 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2023-10-02T22:00:40.180Z,1696284040.180 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-10-02T22:00:40.181Z,1696284040.181 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2023-10-02T22:00:40.181Z,1696284040.181 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2023-10-02T22:00:40.520Z,1696284040.520 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-10-02T22:00:40.520Z,1696284040.520 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2023-10-02T22:00:40.520Z,1696284040.520 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2023-10-02T22:00:40.521Z,1696284040.521 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 1
2023-10-02T22:00:40.521Z,1696284040.521 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2023-10-02T22:00:40.521Z,1696284040.521 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1
2023-10-02T22:00:40.918Z,1696284040.918 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2023-10-02T22:00:42.650Z,1696284042.650 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20231002T175339/Courier0004.lzma
2023-10-02T22:00:43.652Z,1696284043.652 [DataOverHttps](INFO): Moved sent file to Logs/20231002T175339/Courier0004.lzma.bak
2023-10-02T22:00:43.652Z,1696284043.652 [DataOverHttps](INFO): SBD MOMSN=18976705
2023-10-02T22:00:59.344Z,1696284059.344 [DataOverHttps](INFO): Sending 241 bytes from file Logs/20231002T201117/Courier0000.lzma
2023-10-02T22:01:00.344Z,1696284060.344 [DataOverHttps](INFO): Moved sent file to Logs/20231002T201117/Courier0000.lzma.bak
2023-10-02T22:01:00.344Z,1696284060.344 [DataOverHttps](INFO): SBD MOMSN=18976707
2023-10-02T22:01:15.830Z,1696284075.830 [DataOverHttps](INFO): Sending 240 bytes from file Logs/20231002T201309/Courier0000.lzma
2023-10-02T22:01:16.832Z,1696284076.832 [DataOverHttps](INFO): Moved sent file to Logs/20231002T201309/Courier0000.lzma.bak
2023-10-02T22:01:16.832Z,1696284076.832 [DataOverHttps](INFO): SBD MOMSN=18976712
2023-10-02T22:01:32.463Z,1696284092.463 [DataOverHttps](INFO): Sending 241 bytes from file Logs/20231002T201515/Courier0000.lzma
2023-10-02T22:01:33.464Z,1696284093.464 [DataOverHttps](INFO): Moved sent file to Logs/20231002T201515/Courier0000.lzma.bak
2023-10-02T22:01:33.464Z,1696284093.464 [DataOverHttps](INFO): SBD MOMSN=18976717
2023-10-02T22:01:35.043Z,1696284095.043 [Startup:StartupSatComms:B](INFO): Timed out from 2023-10-02T22:00:34.8Z
2023-10-02T22:01:35.043Z,1696284095.043 [Startup:StartupSatComms:B] Stopped
2023-10-02T22:01:35.043Z,1696284095.043 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2023-10-02T22:01:35.043Z,1696284095.043 [Startup:StartupSatComms] Stopped
2023-10-02T22:01:35.043Z,1696284095.043 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2023-10-02T22:01:35.044Z,1696284095.044 [Startup](INFO): Completed Startup
2023-10-02T22:01:35.044Z,1696284095.044 [MissionManager](INFO): Startup is completed.
2023-10-02T22:01:35.044Z,1696284095.044 [MissionManager](INFO): Uninitializing Mission Startup
2023-10-02T22:01:35.044Z,1696284095.044 [Startup] Stopped
2023-10-02T22:01:35.044Z,1696284095.044 [Startup](DEBUG): Aggregate::uninitialize Startup
2023-10-02T22:01:35.044Z,1696284095.044 [Startup:A.GoToSurface] Stopped
2023-10-02T22:01:35.044Z,1696284095.044 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2023-10-02T22:01:35.437Z,1696284095.437 [MissionManager](IMPORTANT): Started mission Default
2023-10-02T22:01:35.437Z,1696284095.437 [Default] Running Loop=1
2023-10-02T22:01:35.437Z,1696284095.437 [Default](DEBUG): Aggregate::initialize Default
2023-10-02T22:01:35.437Z,1696284095.437 [Default:B.GoToSurface] Running Loop=1
2023-10-02T22:01:35.438Z,1696284095.438 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2023-10-02T22:01:35.438Z,1696284095.438 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2023-10-02T22:01:35.438Z,1696284095.438 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2023-10-02T22:01:35.439Z,1696284095.439 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2023-10-02T22:01:35.439Z,1696284095.439 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2023-10-02T22:01:35.439Z,1696284095.439 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2023-10-02T22:01:35.440Z,1696284095.440 [Default:A.Wait] Running Loop=1
2023-10-02T22:01:35.440Z,1696284095.440 [Default:A.Wait](DEBUG): Initialize Wait Component.
2023-10-02T22:01:48.768Z,1696284108.768 [Default:A.Wait](INFO): Done Waiting.
2023-10-02T22:01:48.768Z,1696284108.768 [Default:A.Wait] Stopped
2023-10-02T22:01:48.768Z,1696284108.768 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2023-10-02T22:01:49.166Z,1696284109.166 [Default:CheckIn] Running Loop=1
2023-10-02T22:01:49.166Z,1696284109.166 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2023-10-02T22:01:49.166Z,1696284109.166 [Default:CheckIn:Read_GPS] Running Loop=1
2023-10-02T22:01:49.575Z,1696284109.575 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2023-10-02T22:02:12.234Z,1696284132.234 [DataOverHttps](INFO): Sending 240 bytes from file Logs/20231002T215439/Courier0000.lzma
2023-10-02T22:02:13.236Z,1696284133.236 [DataOverHttps](INFO): Moved sent file to Logs/20231002T215439/Courier0000.lzma.bak
2023-10-02T22:02:13.236Z,1696284133.236 [DataOverHttps](INFO): SBD MOMSN=18976722
2023-10-02T22:03:22.477Z,1696284202.477 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2023-10-02T22:03:41.076Z,1696284221.076 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2
2023-10-02T22:03:41.076Z,1696284221.076 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-10-02T22:03:41.077Z,1696284221.077 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 2
2023-10-02T22:03:41.077Z,1696284221.077 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2023-10-02T22:03:41.112Z,1696284221.112 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 2
2023-10-02T22:03:41.112Z,1696284221.112 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2023-10-02T22:03:41.149Z,1696284221.149 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-10-02T22:03:41.149Z,1696284221.149 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2023-10-02T22:03:41.149Z,1696284221.149 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2023-10-02T22:03:41.521Z,1696284221.521 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-10-02T22:03:41.522Z,1696284221.522 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2
2023-10-02T22:03:41.526Z,1696284221.526 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2023-10-02T22:03:41.526Z,1696284221.526 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 2
2023-10-02T22:03:41.527Z,1696284221.527 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2023-10-02T22:03:41.527Z,1696284221.527 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 2
2023-10-02T22:03:41.895Z,1696284221.895 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2023-10-02T22:06:42.080Z,1696284402.080 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3
2023-10-02T22:06:42.080Z,1696284402.080 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-10-02T22:06:42.086Z,1696284402.086 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 3
2023-10-02T22:06:42.086Z,1696284402.086 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2023-10-02T22:06:42.088Z,1696284402.088 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 3
2023-10-02T22:06:42.088Z,1696284402.088 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2023-10-02T22:06:42.147Z,1696284402.147 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-10-02T22:06:42.147Z,1696284402.147 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2023-10-02T22:06:42.148Z,1696284402.148 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2023-10-02T22:06:42.515Z,1696284402.515 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-10-02T22:06:42.515Z,1696284402.515 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3
2023-10-02T22:06:42.516Z,1696284402.516 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2023-10-02T22:06:42.516Z,1696284402.516 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 3
2023-10-02T22:06:42.517Z,1696284402.517 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2023-10-02T22:06:42.517Z,1696284402.517 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 3
2023-10-02T22:06:42.882Z,1696284402.882 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2023-10-02T22:06:49.363Z,1696284409.363 [Default:CheckIn:Read_GPS](INFO): Timed out from 2023-10-02T22:01:49.2Z
2023-10-02T22:06:49.363Z,1696284409.363 [Default:CheckIn:Read_GPS] Stopped
2023-10-02T22:06:49.363Z,1696284409.363 [Default:CheckIn:Read_Iridium] Running Loop=1
2023-10-02T22:06:49.774Z,1696284409.774 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications
2023-10-02T22:06:56.918Z,1696284416.918 [DataOverHttps](INFO): Sending 241 bytes from file Logs/20231002T215730/Courier0000.lzma
2023-10-02T22:06:57.920Z,1696284417.920 [DataOverHttps](INFO): Moved sent file to Logs/20231002T215730/Courier0000.lzma.bak
2023-10-02T22:06:57.920Z,1696284417.920 [DataOverHttps](INFO): SBD MOMSN=18976736
2023-10-02T22:07:13.462Z,1696284433.462 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20231002T215730/Courier0004.lzma
2023-10-02T22:07:14.464Z,1696284434.464 [DataOverHttps](INFO): Moved sent file to Logs/20231002T215730/Courier0004.lzma.bak
2023-10-02T22:07:14.464Z,1696284434.464 [DataOverHttps](INFO): SBD MOMSN=18976749
2023-10-02T22:07:29.887Z,1696284449.887 [DataOverHttps](INFO): Sending 495 bytes from file Logs/20231002T175339/Express0005.lzma
2023-10-02T22:07:30.888Z,1696284450.888 [DataOverHttps](INFO): Moved sent file to Logs/20231002T175339/Express0005.lzma.bak
2023-10-02T22:07:30.888Z,1696284450.888 [DataOverHttps](INFO): SBD MOMSN=18976818
2023-10-02T22:07:46.631Z,1696284466.631 [DataOverHttps](INFO): Sending 541 bytes from file Logs/20231002T201117/Express0001.lzma
2023-10-02T22:07:47.632Z,1696284467.632 [DataOverHttps](INFO): Moved sent file to Logs/20231002T201117/Express0001.lzma.bak
2023-10-02T22:07:47.632Z,1696284467.632 [DataOverHttps](INFO): SBD MOMSN=18976832
2023-10-02T22:08:03.164Z,1696284483.164 [DataOverHttps](INFO): Sending 805 bytes from file Logs/20231002T201309/Express0001.lzma
2023-10-02T22:08:04.164Z,1696284484.164 [DataOverHttps](INFO): Moved sent file to Logs/20231002T201309/Express0001.lzma.bak
2023-10-02T22:08:04.164Z,1696284484.164 [DataOverHttps](INFO): SBD MOMSN=18976842
2023-10-02T22:08:19.603Z,1696284499.603 [DataOverHttps](INFO): Sending 527 bytes from file Logs/20231002T201515/Express0001.lzma
2023-10-02T22:08:20.604Z,1696284500.604 [DataOverHttps](INFO): Moved sent file to Logs/20231002T201515/Express0001.lzma.bak
2023-10-02T22:08:20.604Z,1696284500.604 [DataOverHttps](INFO): SBD MOMSN=18976864
2023-10-02T22:08:21.440Z,1696284501.440 [NAL9602](FAULT): GPS failed to acquire within timeout.
2023-10-02T22:08:21.440Z,1696284501.440 [NAL9602] Data Fault, FailCount= 1
2023-10-02T22:08:21.440Z,1696284501.440 [NAL9602](ERROR): Data Fault
2023-10-02T22:08:21.463Z,1696284501.463 [CBIT](ERROR): Data Fault in component: NAL9602
2023-10-02T22:08:21.852Z,1696284501.852 [NAL9602](INFO): Powering down
2023-10-02T22:08:22.694Z,1696284502.694 [CBIT](INFO): Clearing failed state for component NAL9602
2023-10-02T22:08:22.695Z,1696284502.695 [NAL9602] No Fault, FailCount= 1
2023-10-02T22:08:36.140Z,1696284516.140 [DataOverHttps](INFO): Sending 1089 bytes from file Logs/20231002T215439/Express0001.lzma
2023-10-02T22:08:37.143Z,1696284517.143 [DataOverHttps](INFO): Moved sent file to Logs/20231002T215439/Express0001.lzma.bak
2023-10-02T22:08:37.144Z,1696284517.144 [DataOverHttps](INFO): SBD MOMSN=18976874
2023-10-02T22:08:52.159Z,1696284532.159 [NAL9602](INFO): Powering up NAL9602
2023-10-02T22:08:52.596Z,1696284532.596 [DataOverHttps](INFO): Sending 879 bytes from file Logs/20231002T215730/Express0001.lzma
2023-10-02T22:08:53.596Z,1696284533.596 [DataOverHttps](INFO): Moved sent file to Logs/20231002T215730/Express0001.lzma.bak
2023-10-02T22:08:53.596Z,1696284533.596 [DataOverHttps](INFO): SBD MOMSN=18976912
2023-10-02T22:09:03.052Z,1696284543.052 [NAL9602](INFO): NAL9602 initialized
2023-10-02T22:09:09.090Z,1696284549.090 [DataOverHttps](INFO): Sending 205 bytes from file Logs/20231002T215730/Express0005.lzma
2023-10-02T22:09:10.092Z,1696284550.092 [DataOverHttps](INFO): Moved sent file to Logs/20231002T215730/Express0005.lzma.bak
2023-10-02T22:09:10.092Z,1696284550.092 [DataOverHttps](INFO): SBD MOMSN=18976937
2023-10-02T22:09:11.950Z,1696284551.950 [Default:CheckIn:Read_Iridium] Stopped
2023-10-02T22:09:11.950Z,1696284551.950 [Default:CheckIn:C.Wait] Running Loop=1
2023-10-02T22:09:11.950Z,1696284551.950 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2023-10-02T22:09:43.083Z,1696284583.083 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4
2023-10-02T22:09:43.083Z,1696284583.083 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-10-02T22:09:43.084Z,1696284583.084 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 4
2023-10-02T22:09:43.084Z,1696284583.084 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2023-10-02T22:09:43.086Z,1696284583.086 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 4
2023-10-02T22:09:43.086Z,1696284583.086 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2023-10-02T22:09:43.097Z,1696284583.097 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-10-02T22:09:43.097Z,1696284583.097 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2023-10-02T22:09:43.097Z,1696284583.097 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2023-10-02T22:09:43.501Z,1696284583.501 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-10-02T22:09:43.501Z,1696284583.501 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4
2023-10-02T22:09:43.502Z,1696284583.502 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2023-10-02T22:09:43.502Z,1696284583.502 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 4
2023-10-02T22:09:43.503Z,1696284583.503 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2023-10-02T22:09:43.503Z,1696284583.503 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 4
2023-10-02T22:09:43.867Z,1696284583.867 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2023-10-02T22:10:01.900Z,1696284601.900 [CommandExec](IMPORTANT): got command strobe off
2023-10-02T22:10:01.900Z,1696284601.900 [CommandExec](IMPORTANT): Deactivating strobe
2023-10-02T22:12:40.875Z,1696284760.875 [CBIT](INFO): Clearing failed state for component DropWeight
2023-10-02T22:12:40.875Z,1696284760.875 [DropWeight] No Fault, FailCount= 1
2023-10-02T22:12:44.095Z,1696284764.095 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 5
2023-10-02T22:12:44.095Z,1696284764.095 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-10-02T22:12:44.096Z,1696284764.096 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 5
2023-10-02T22:12:44.096Z,1696284764.096 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2023-10-02T22:12:44.098Z,1696284764.098 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 5
2023-10-02T22:12:44.098Z,1696284764.098 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2023-10-02T22:12:44.109Z,1696284764.109 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-10-02T22:12:44.109Z,1696284764.109 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2023-10-02T22:12:44.109Z,1696284764.109 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2023-10-02T22:12:44.513Z,1696284764.513 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-10-02T22:12:44.513Z,1696284764.513 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 5
2023-10-02T22:12:44.514Z,1696284764.514 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2023-10-02T22:12:44.514Z,1696284764.514 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 5
2023-10-02T22:12:44.515Z,1696284764.515 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2023-10-02T22:12:44.515Z,1696284764.515 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 5
2023-10-02T22:12:44.899Z,1696284764.899 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2023-10-02T22:13:41.884Z,1696284821.884 [CommandExec](IMPORTANT): got command restart system
2023-10-02T22:13:43.946Z,1696284823.946 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread.
2023-10-02T22:13:43.947Z,1696284823.947 [CommandExec](INFO): Uninitializing the command executive.
2023-10-02T22:13:43.947Z,1696284823.947 [CommandExec](INFO): Uninitializing the command scheduler.
2023-10-02T22:13:43.947Z,1696284823.947 [CommandExec ThreadHandler](INFO): Thread cancelled.
2023-10-02T22:13:43.950Z,1696284823.950 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup.  Bye!
2023-10-02T22:13:43.950Z,1696284823.950 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2023-10-02T22:13:43.951Z,1696284823.951 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2023-10-02T22:13:43.951Z,1696284823.951 [NavChartDb](INFO): Join timeout helper Thread ID is 4960
2023-10-02T22:13:44.131Z,1696284824.131 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2023-10-02T22:13:44.131Z,1696284824.131 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2023-10-02T22:13:44.150Z,1696284824.150 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2023-10-02T22:13:44.150Z,1696284824.150 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2023-10-02T22:13:44.151Z,1696284824.151 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 4961
2023-10-02T22:13:44.450Z,1696284824.450 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread.
2023-10-02T22:13:44.451Z,1696284824.451 [WetLabsBB2FL](INFO): Powering down
2023-10-02T22:13:44.452Z,1696284824.452 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2023-10-02T22:13:44.466Z,1696284824.466 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler
2023-10-02T22:13:44.466Z,1696284824.466 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2023-10-02T22:13:44.467Z,1696284824.467 [CTD_Seabird](INFO): Join timeout helper Thread ID is 4962
2023-10-02T22:13:44.986Z,1696284824.986 [CTD_Seabird](INFO): Powering down
2023-10-02T22:13:45.006Z,1696284825.006 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread.
2023-10-02T22:13:45.006Z,1696284825.006 [CTD_Seabird](INFO): Powering down
2023-10-02T22:13:45.018Z,1696284825.018 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2023-10-02T22:13:45.034Z,1696284825.034 [ComponentRegistry](INFO): Shutting down DAT ThreadHandler
2023-10-02T22:13:45.034Z,1696284825.034 [DAT ThreadHandler](INFO): Thread cancelled.
2023-10-02T22:13:45.035Z,1696284825.035 [DAT](INFO): Join timeout helper Thread ID is 4963
2023-10-02T22:13:45.182Z,1696284825.182 [DAT](INFO): Powering down
2023-10-02T22:13:45.255Z,1696284825.255 [DAT ThreadHandler](INFO): Uninitializing protected caller thread.
2023-10-02T22:13:45.255Z,1696284825.255 [DAT](INFO): Powering down
2023-10-02T22:13:45.256Z,1696284825.256 [DAT ThreadHandler](INFO): Thread cancelled.
2023-10-02T22:13:45.269Z,1696284825.269 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2023-10-02T22:13:45.269Z,1696284825.269 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2023-10-02T22:13:45.270Z,1696284825.270 [Radio_Surface](INFO): Join timeout helper Thread ID is 4964
2023-10-02T22:13:45.642Z,1696284825.642 [Radio_Surface](INFO): Powering down
2023-10-02T22:13:45.643Z,1696284825.643 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2023-10-02T22:13:45.644Z,1696284825.644 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2023-10-02T22:13:45.651Z,1696284825.651 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler
2023-10-02T22:13:45.651Z,1696284825.651 [Onboard ThreadHandler](INFO): Thread cancelled.
2023-10-02T22:13:45.652Z,1696284825.652 [Onboard](INFO): Join timeout helper Thread ID is 4965
2023-10-02T22:13:45.715Z,1696284825.715 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread.
2023-10-02T22:13:45.715Z,1696284825.715 [Onboard ThreadHandler](INFO): Thread cancelled.
2023-10-02T22:13:45.732Z,1696284825.732 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler
2023-10-02T22:13:45.732Z,1696284825.732 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2023-10-02T22:13:45.732Z,1696284825.732 [DataOverHttps](INFO): Join timeout helper Thread ID is 4966
2023-10-02T22:13:45.754Z,1696284825.754 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread.
2023-10-02T22:13:45.755Z,1696284825.755 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2023-10-02T22:13:45.759Z,1696284825.759 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler
2023-10-02T22:13:45.759Z,1696284825.759 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2023-10-02T22:13:45.759Z,1696284825.759 [BackseatComponent](INFO): Join timeout helper Thread ID is 4967
2023-10-02T22:13:45.783Z,1696284825.783 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread.
2023-10-02T22:13:45.783Z,1696284825.783 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2023-10-02T22:13:45.803Z,1696284825.803 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2023-10-02T22:13:45.803Z,1696284825.803 [logger ThreadHandler](INFO): Thread cancelled.
2023-10-02T22:13:45.804Z,1696284825.804 [logger](INFO): Join timeout helper Thread ID is 4968
2023-10-02T22:13:45.830Z,1696284825.830 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2023-10-02T22:13:45.831Z,1696284825.831 [logger ThreadHandler](INFO): Thread cancelled.
2023-10-02T22:13:45.843Z,1696284825.843 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2023-10-02T22:13:45.843Z,1696284825.843 [CommandLine ThreadHandler](INFO): Thread cancelled.
2023-10-02T22:13:45.843Z,1696284825.843 [CommandLine](INFO): Join timeout helper Thread ID is 4969
2023-10-02T22:13:45.915Z,1696284825.915 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2023-10-02T22:13:45.915Z,1696284825.915 [CommandLine ThreadHandler](INFO): Thread cancelled.
2023-10-02T22:13:45.923Z,1696284825.923 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler
2023-10-02T22:13:45.923Z,1696284825.923 [CommandExec ThreadHandler](INFO): Thread cancelled.
2023-10-02T22:13:45.924Z,1696284825.924 [CommandExec](INFO): Join timeout helper Thread ID is 4970
2023-10-02T22:13:45.934Z,1696284825.934 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2023-10-02T22:13:45.934Z,1696284825.934 [controlThread ThreadHandler](INFO): Thread cancelled.
2023-10-02T22:13:45.935Z,1696284825.935 [controlThread](INFO): Join timeout helper Thread ID is 4971
2023-10-02T22:13:46.286Z,1696284826.286 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2023-10-02T22:13:46.287Z,1696284826.287 [controlThread](DEBUG): Uninitializing ControlThread
2023-10-02T22:13:46.287Z,1696284826.287 [AHRS_M2](INFO): Powering down
2023-10-02T22:13:46.360Z,1696284826.360 [NAL9602](INFO): Powering down
2023-10-02T22:13:46.361Z,1696284826.361 [Waterlinked](INFO): Powering down
2023-10-02T22:13:46.364Z,1696284826.364 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2023-10-02T22:13:46.365Z,1696284826.365 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2023-10-02T22:13:46.365Z,1696284826.365 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2023-10-02T22:13:46.366Z,1696284826.366 [MissionManager](INFO): Uninitializing Mission Default
2023-10-02T22:13:46.366Z,1696284826.366 [Default] Stopped
2023-10-02T22:13:46.366Z,1696284826.366 [Default](DEBUG): Aggregate::uninitialize Default
2023-10-02T22:13:46.366Z,1696284826.366 [Default:B.GoToSurface] Stopped
2023-10-02T22:13:46.366Z,1696284826.366 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2023-10-02T22:13:46.367Z,1696284826.367 [Default:CheckIn] Stopped
2023-10-02T22:13:46.367Z,1696284826.367 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2023-10-02T22:13:46.367Z,1696284826.367 [Default:CheckIn:C.Wait] Stopped
2023-10-02T22:13:46.367Z,1696284826.367 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2023-10-02T22:13:46.370Z,1696284826.370 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2023-10-02T22:13:46.370Z,1696284826.370 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2023-10-02T22:13:46.370Z,1696284826.370 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2023-10-02T22:13:46.371Z,1696284826.371 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2023-10-02T22:13:46.371Z,1696284826.371 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2023-10-02T22:13:46.371Z,1696284826.371 [BuoyancyServo](INFO): Powering down
2023-10-02T22:13:46.386Z,1696284826.386 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2023-10-02T22:13:46.387Z,1696284826.387 [ElevatorServo](INFO): Powering down
2023-10-02T22:13:46.388Z,1696284826.388 [MassServo](DEBUG): Uninitialize Mass Servo.
2023-10-02T22:13:46.388Z,1696284826.388 [MassServo](INFO): Powering down
2023-10-02T22:13:46.389Z,1696284826.389 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2023-10-02T22:13:46.389Z,1696284826.389 [RudderServo](INFO): Powering down
2023-10-02T22:13:46.390Z,1696284826.390 [ThrusterHE](DEBUG): Uninitialize Thruster Servo.
2023-10-02T22:13:46.390Z,1696284826.390 [ThrusterHE](INFO): Powering down
2023-10-02T22:13:46.391Z,1696284826.391 [SBIT](DEBUG): Uninitialize SBIT Component.
2023-10-02T22:13:46.391Z,1696284826.391 [IBIT](DEBUG): Uninitialize IBIT Component.
2023-10-02T22:13:46.391Z,1696284826.391 [CBIT](DEBUG): Uninitialize CBIT Component.
2023-10-02T22:13:46.391Z,1696284826.391 [CBIT](DEBUG): Powering off loads.
2023-10-02T22:13:46.402Z,1696284826.402 [CBIT](DEBUG): Disabling WDT.
2023-10-02T22:13:46.414Z,1696284826.414 [CBIT](DEBUG): Opening all GF detection circuits.
2023-10-02T22:13:46.415Z,1696284826.415 [controlThread ThreadHandler](INFO): Thread cancelled.
2023-10-02T22:13:46.457Z,1696284826.457 [DAT ThreadHandler](INFO): Thread cancelled.
2023-10-02T22:13:46.462Z,1696284826.462 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2023-10-02T22:13:46.464Z,1696284826.464 [Onboard ThreadHandler](INFO): Thread cancelled.
2023-10-02T22:13:46.471Z,1696284826.471 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2023-10-02T22:13:46.518Z,1696284826.518 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2023-10-02T22:13:46.612Z,1696284826.612 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2023-10-02T22:13:46.618Z,1696284826.618 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2023-10-02T22:13:46.626Z,1696284826.626 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2023-10-02T22:13:46.676Z,1696284826.676 [logger ThreadHandler](INFO): Thread cancelled.