2023-06-22T21:06:29.396Z,1687467989.396 [Supervisor](DEBUG): Initializing supervisor.
2023-06-22T21:06:29.400Z,1687467989.400 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2023-06-22T21:06:29.400Z,1687467989.400 [SyncHandler](INFO): Protected caller Thread ID is 4878
2023-06-22T21:06:29.401Z,1687467989.401 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2023-06-22T21:06:29.402Z,1687467989.402 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2023-06-22T21:06:29.402Z,1687467989.402 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 4879
2023-06-22T21:06:29.406Z,1687467989.406 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2023-06-22T21:06:29.423Z,1687467989.423 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread.
2023-06-22T21:06:29.424Z,1687467989.424 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2023-06-22T21:06:29.424Z,1687467989.424 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 4880
2023-06-22T21:06:29.428Z,1687467989.428 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2023-06-22T21:06:29.429Z,1687467989.429 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2023-06-22T21:06:29.430Z,1687467989.430 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 4881
2023-06-22T21:06:29.432Z,1687467989.432 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2023-06-22T21:06:29.433Z,1687467989.433 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0
2023-06-22T21:06:29.433Z,1687467989.433 [logger ThreadHandler](INFO): Protected caller Thread ID is 4882
2023-06-22T21:06:29.437Z,1687467989.437 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2023-06-22T21:06:29.437Z,1687467989.437 [Supervisor](INFO): Looking for Config files in directory: Config/
2023-06-22T21:06:29.439Z,1687467989.439 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2023-06-22T21:06:29.760Z,1687467989.760 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2023-06-22T21:06:29.761Z,1687467989.761 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2023-06-22T21:06:29.841Z,1687467989.841 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2023-06-22T21:06:29.946Z,1687467989.946 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2023-06-22T21:06:29.946Z,1687467989.946 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2023-06-22T21:06:30.072Z,1687467990.072 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2023-06-22T21:06:30.072Z,1687467990.072 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2023-06-22T21:06:30.392Z,1687467990.392 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2023-06-22T21:06:30.392Z,1687467990.392 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2023-06-22T21:06:30.488Z,1687467990.488 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2023-06-22T21:06:30.488Z,1687467990.488 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2023-06-22T21:06:30.859Z,1687467990.859 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2023-06-22T21:06:30.859Z,1687467990.859 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2023-06-22T21:06:31.059Z,1687467991.059 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2023-06-22T21:06:31.059Z,1687467991.059 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2023-06-22T21:06:31.148Z,1687467991.148 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg
2023-06-22T21:06:31.364Z,1687467991.364 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock
2023-06-22T21:06:31.364Z,1687467991.364 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2023-06-22T21:06:31.578Z,1687467991.578 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2023-06-22T21:06:31.579Z,1687467991.579 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2023-06-22T21:06:32.157Z,1687467992.157 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2023-06-22T21:06:32.157Z,1687467992.157 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2023-06-22T21:06:32.338Z,1687467992.338 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2023-06-22T21:06:32.339Z,1687467992.339 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2023-06-22T21:06:32.608Z,1687467992.608 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2023-06-22T21:06:32.609Z,1687467992.609 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2023-06-22T21:06:33.353Z,1687467993.353 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2023-06-22T21:06:33.354Z,1687467993.354 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2023-06-22T21:06:33.868Z,1687467993.868 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2023-06-22T21:06:33.870Z,1687467993.870 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-ahi/
2023-06-22T21:06:33.871Z,1687467993.871 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Control.cfg
2023-06-22T21:06:33.967Z,1687467993.967 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Science.cfg
2023-06-22T21:06:34.083Z,1687467994.083 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/secure.cfg
2023-06-22T21:06:34.168Z,1687467994.168 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Servo.cfg
2023-06-22T21:06:34.275Z,1687467994.275 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/BIT.cfg
2023-06-22T21:06:34.380Z,1687467994.380 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Battery.cfg
2023-06-22T21:06:34.647Z,1687467994.647 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2023-06-22T21:06:34.647Z,1687467994.647 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/vehicle.cfg
2023-06-22T21:06:34.752Z,1687467994.752 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/logger.cfg
2023-06-22T21:06:34.845Z,1687467994.845 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Navigation.cfg
2023-06-22T21:06:34.948Z,1687467994.948 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Sensor.cfg
2023-06-22T21:06:35.076Z,1687467995.076 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Simulator.cfg
2023-06-22T21:06:35.163Z,1687467995.163 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-ahi/root/
2023-06-22T21:06:35.163Z,1687467995.163 [Supervisor](FAULT): Ignoring configuration overrides from Data/persisted.cfg
2023-06-22T21:06:35.165Z,1687467995.165 [Module Loader](DEBUG): Loading Module at Modules/Dock.so
2023-06-22T21:06:35.260Z,1687467995.260 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking)
2023-06-22T21:06:35.260Z,1687467995.260 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2023-06-22T21:06:35.310Z,1687467995.310 [VerticalControl](DEBUG): Construct VerticalControl.
2023-06-22T21:06:35.369Z,1687467995.369 [VerticalControl] Loaded
2023-06-22T21:06:35.369Z,1687467995.369 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2023-06-22T21:06:35.372Z,1687467995.372 [HorizontalControl](DEBUG): Construct HorizontalControl.
2023-06-22T21:06:35.412Z,1687467995.412 [HorizontalControl] Loaded
2023-06-22T21:06:35.412Z,1687467995.412 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2023-06-22T21:06:35.414Z,1687467995.414 [SpeedControl](DEBUG): Construct SpeedControl.
2023-06-22T21:06:35.417Z,1687467995.417 [SpeedControl] Loaded
2023-06-22T21:06:35.418Z,1687467995.418 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2023-06-22T21:06:35.420Z,1687467995.420 [LoopControl](DEBUG): Construct LoopControl.
2023-06-22T21:06:35.421Z,1687467995.421 [LoopControl] Loaded
2023-06-22T21:06:35.421Z,1687467995.421 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2023-06-22T21:06:35.421Z,1687467995.421 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2023-06-22T21:06:35.422Z,1687467995.422 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2023-06-22T21:06:35.476Z,1687467995.476 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2023-06-22T21:06:35.476Z,1687467995.476 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2023-06-22T21:06:35.902Z,1687467995.902 [AHRS_M2] Loaded
2023-06-22T21:06:35.903Z,1687467995.903 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread.
2023-06-22T21:06:36.702Z,1687467996.702 [BPC1] Loaded
2023-06-22T21:06:36.702Z,1687467996.702 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2023-06-22T21:06:36.775Z,1687467996.775 [DataOverHttps] Loaded
2023-06-22T21:06:36.775Z,1687467996.775 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2023-06-22T21:06:36.777Z,1687467996.777 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 4087C4E0
2023-06-22T21:06:36.777Z,1687467996.777 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 4965
2023-06-22T21:06:36.797Z,1687467996.797 [Depth_Keller] Loaded
2023-06-22T21:06:36.797Z,1687467996.797 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2023-06-22T21:06:36.802Z,1687467996.802 [DropWeight] Loaded
2023-06-22T21:06:36.803Z,1687467996.803 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2023-06-22T21:06:36.865Z,1687467996.865 [NAL9602] Loaded
2023-06-22T21:06:36.865Z,1687467996.865 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2023-06-22T21:06:36.894Z,1687467996.894 [Onboard] Loaded
2023-06-22T21:06:36.895Z,1687467996.895 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread.
2023-06-22T21:06:36.896Z,1687467996.896 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 408AC4E0
2023-06-22T21:06:36.896Z,1687467996.896 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 4966
2023-06-22T21:06:36.903Z,1687467996.903 [PowerOnly](INFO): Adding load control power supply at /dev/loadC4
2023-06-22T21:06:36.914Z,1687467996.914 [PowerOnly] Loaded
2023-06-22T21:06:36.914Z,1687467996.914 [ComponentRegistry](DEBUG): SyncComponent "PowerOnly" handled in the control thread.
2023-06-22T21:06:36.926Z,1687467996.926 [Power24vConverter] Loaded
2023-06-22T21:06:36.926Z,1687467996.926 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread.
2023-06-22T21:06:36.939Z,1687467996.939 [Radio_Surface] Loaded
2023-06-22T21:06:36.939Z,1687467996.939 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2023-06-22T21:06:36.940Z,1687467996.940 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 408DC4E0
2023-06-22T21:06:36.941Z,1687467996.941 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 4967
2023-06-22T21:06:37.032Z,1687467997.032 [DAT] Loaded
2023-06-22T21:06:37.032Z,1687467997.032 [ComponentRegistry](DEBUG): Component "DAT" handled in its own thread.
2023-06-22T21:06:37.033Z,1687467997.033 [DAT ThreadHandler](DEBUG): Created PCaller Thread at 4090C4E0
2023-06-22T21:06:37.033Z,1687467997.033 [DAT ThreadHandler](INFO): Protected caller Thread ID is 4968
2023-06-22T21:06:37.034Z,1687467997.034 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2023-06-22T21:06:37.035Z,1687467997.035 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2023-06-22T21:06:37.045Z,1687467997.045 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2023-06-22T21:06:37.045Z,1687467997.045 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2023-06-22T21:06:37.072Z,1687467997.072 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2023-06-22T21:06:37.072Z,1687467997.072 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2023-06-22T21:06:37.204Z,1687467997.204 [SBIT](DEBUG): Construct Startup Built In Test.
2023-06-22T21:06:37.212Z,1687467997.212 [SBIT] Loaded
2023-06-22T21:06:37.213Z,1687467997.213 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2023-06-22T21:06:37.215Z,1687467997.215 [IBIT](DEBUG): Construct Initiated Built In Test.
2023-06-22T21:06:37.228Z,1687467997.228 [IBIT] Loaded
2023-06-22T21:06:37.228Z,1687467997.228 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2023-06-22T21:06:37.234Z,1687467997.234 [CBIT](DEBUG): Construct Continuous Built In Test.
2023-06-22T21:06:37.335Z,1687467997.335 [CBIT] Loaded
2023-06-22T21:06:37.335Z,1687467997.335 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2023-06-22T21:06:37.336Z,1687467997.336 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2023-06-22T21:06:37.336Z,1687467997.336 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2023-06-22T21:06:37.626Z,1687467997.626 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2023-06-22T21:06:37.627Z,1687467997.627 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2023-06-22T21:06:37.676Z,1687467997.676 [DepthRateCalculator] Loaded
2023-06-22T21:06:37.676Z,1687467997.676 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2023-06-22T21:06:37.681Z,1687467997.681 [PitchRateCalculator] Loaded
2023-06-22T21:06:37.682Z,1687467997.682 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2023-06-22T21:06:37.692Z,1687467997.692 [SpeedCalculator] Loaded
2023-06-22T21:06:37.692Z,1687467997.692 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2023-06-22T21:06:37.696Z,1687467997.696 [YawRateCalculator] Loaded
2023-06-22T21:06:37.696Z,1687467997.696 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2023-06-22T21:06:37.715Z,1687467997.715 [ElevatorOffsetCalculator] Loaded
2023-06-22T21:06:37.715Z,1687467997.715 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2023-06-22T21:06:37.715Z,1687467997.715 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2023-06-22T21:06:37.716Z,1687467997.716 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2023-06-22T21:06:37.856Z,1687467997.856 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2023-06-22T21:06:37.857Z,1687467997.857 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2023-06-22T21:06:37.964Z,1687467997.964 [DeadReckonUsingMultipleVelocitySources] Loaded
2023-06-22T21:06:37.965Z,1687467997.965 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2023-06-22T21:06:38.006Z,1687467998.006 [DeadReckonUsingSpeedCalculator] Loaded
2023-06-22T21:06:38.006Z,1687467998.006 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread.
2023-06-22T21:06:38.048Z,1687467998.048 [DeadReckonWithRespectToSeafloor] Loaded
2023-06-22T21:06:38.048Z,1687467998.048 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonWithRespectToSeafloor" handled in the control thread.
2023-06-22T21:06:38.062Z,1687467998.062 [NavChart] Loaded
2023-06-22T21:06:38.062Z,1687467998.062 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2023-06-22T21:06:38.067Z,1687467998.067 [UniversalFixResidualReporter] Loaded
2023-06-22T21:06:38.068Z,1687467998.068 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2023-06-22T21:06:38.068Z,1687467998.068 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2023-06-22T21:06:38.069Z,1687467998.069 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2023-06-22T21:06:38.196Z,1687467998.196 [BuoyancyServo] Loaded
2023-06-22T21:06:38.196Z,1687467998.196 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2023-06-22T21:06:38.216Z,1687467998.216 [ElevatorServo] Loaded
2023-06-22T21:06:38.217Z,1687467998.217 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2023-06-22T21:06:38.236Z,1687467998.236 [MassServo] Loaded
2023-06-22T21:06:38.236Z,1687467998.236 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2023-06-22T21:06:38.254Z,1687467998.254 [RudderServo] Loaded
2023-06-22T21:06:38.255Z,1687467998.255 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2023-06-22T21:06:38.269Z,1687467998.269 [ThrusterHE] Loaded
2023-06-22T21:06:38.269Z,1687467998.269 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread.
2023-06-22T21:06:38.269Z,1687467998.269 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2023-06-22T21:06:38.270Z,1687467998.270 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2023-06-22T21:06:38.436Z,1687467998.436 [CTD_Seabird] Loaded
2023-06-22T21:06:38.436Z,1687467998.436 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread.
2023-06-22T21:06:38.437Z,1687467998.437 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40B634E0
2023-06-22T21:06:38.438Z,1687467998.438 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 4969
2023-06-22T21:06:38.470Z,1687467998.470 [ESPComponent] Loaded
2023-06-22T21:06:38.471Z,1687467998.471 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread.
2023-06-22T21:06:38.490Z,1687467998.490 [PAR_Licor] Loaded
2023-06-22T21:06:38.491Z,1687467998.491 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2023-06-22T21:06:38.521Z,1687467998.521 [WetLabsBB2FL] Loaded
2023-06-22T21:06:38.521Z,1687467998.521 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2023-06-22T21:06:38.522Z,1687467998.522 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40B934E0
2023-06-22T21:06:38.523Z,1687467998.523 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 4970
2023-06-22T21:06:38.523Z,1687467998.523 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2023-06-22T21:06:38.529Z,1687467998.529 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2023-06-22T21:06:38.532Z,1687467998.532 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2023-06-22T21:06:38.543Z,1687467998.543 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2023-06-22T21:06:38.544Z,1687467998.544 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40BC34E0
2023-06-22T21:06:38.544Z,1687467998.544 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 4971
2023-06-22T21:06:38.549Z,1687467998.549 [Supervisor](INFO): Main Thread ID is 4877
2023-06-22T21:06:38.549Z,1687467998.549 [Supervisor](DEBUG): Running supervisor.
2023-06-22T21:06:38.550Z,1687467998.550 [CommandExec ThreadHandler](INFO): Handler Thread ID is 4972
2023-06-22T21:06:38.550Z,1687467998.550 [CommandExec](INFO): Initializing the command executive.
2023-06-22T21:06:38.552Z,1687467998.552 [CommandLine ThreadHandler](INFO): Handler Thread ID is 4973
2023-06-22T21:06:38.554Z,1687467998.554 [controlThread ThreadHandler](INFO): Handler Thread ID is 4974
2023-06-22T21:06:38.555Z,1687467998.555 [controlThread](DEBUG): Initializing ControlThread
2023-06-22T21:06:38.555Z,1687467998.555 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2023-06-22T21:06:38.557Z,1687467998.557 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2023-06-22T21:06:38.558Z,1687467998.558 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2023-06-22T21:06:38.558Z,1687467998.558 [LoopControl](DEBUG): Initialize LoopControlComponent.
2023-06-22T21:06:38.565Z,1687467998.565 [SBIT](INFO): Initialize SBIT Component.
2023-06-22T21:06:38.565Z,1687467998.565 [SBIT](IMPORTANT): git: 2023-05-23-14-gd957ee9d8
2023-06-22T21:06:38.565Z,1687467998.565 [SBIT](INFO): git hash: d957ee9d857d054abd03546ddf42b65141472a60
2023-06-22T21:06:38.566Z,1687467998.566 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2023-06-22T21:06:38.567Z,1687467998.567 [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-06-22T21:06:38.568Z,1687467998.568 [SBIT](INFO): Beginning SBIT in 71.000000 seconds.
2023-06-22T21:06:38.569Z,1687467998.569 [IBIT](INFO): Initialize IBIT Component.
2023-06-22T21:06:38.570Z,1687467998.570 [CBIT](DEBUG): Initialize CBIT Component.
2023-06-22T21:06:38.571Z,1687467998.571 [logger ThreadHandler](INFO): Handler Thread ID is 4975
2023-06-22T21:06:38.583Z,1687467998.583 [CBIT](DEBUG): Initialized mux pins.
2023-06-22T21:06:38.583Z,1687467998.583 [CBIT](FAULT): LAST RESTART WAS UNINTENTIONAL.
2023-06-22T21:06:38.583Z,1687467998.583 [CBIT](DEBUG): Initializing the watchdog timer.
2023-06-22T21:06:38.591Z,1687467998.591 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 4976
2023-06-22T21:06:38.592Z,1687467998.592 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2023-06-22T21:06:38.603Z,1687467998.603 [Onboard ThreadHandler](INFO): Handler Thread ID is 4977
2023-06-22T21:06:38.607Z,1687467998.607 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2023-06-22T21:06:38.608Z,1687467998.608 [CBIT](DEBUG): Initializing heartbeat.
2023-06-22T21:06:38.627Z,1687467998.627 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 4978
2023-06-22T21:06:38.639Z,1687467998.639 [DAT ThreadHandler](INFO): Handler Thread ID is 4979
2023-06-22T21:06:38.640Z,1687467998.640 [DAT](INFO): Powering up
2023-06-22T21:06:38.640Z,1687467998.640 [DAT](DEBUG): Initializing DAT.
2023-06-22T21:06:38.644Z,1687467998.644 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 4981
2023-06-22T21:06:38.645Z,1687467998.645 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2023-06-22T21:06:38.648Z,1687467998.648 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 4983
2023-06-22T21:06:38.651Z,1687467998.651 [WetLabsBB2FL](INFO): Powering up
2023-06-22T21:06:38.652Z,1687467998.652 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 4985
2023-06-22T21:06:38.656Z,1687467998.656 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2HA05M.000
2023-06-22T21:06:38.656Z,1687467998.656 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2HA05M.000
2023-06-22T21:06:38.656Z,1687467998.656 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3HA20M.000
2023-06-22T21:06:38.656Z,1687467998.656 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3HA20M.000
2023-06-22T21:06:38.657Z,1687467998.657 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4HA51M.000
2023-06-22T21:06:38.657Z,1687467998.657 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4HA51M.000
2023-06-22T21:06:38.657Z,1687467998.657 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4HA51M.000
2023-06-22T21:06:38.657Z,1687467998.657 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4HA51M.000
2023-06-22T21:06:38.657Z,1687467998.657 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5HA53M.000
2023-06-22T21:06:38.657Z,1687467998.657 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5HA53M.000
2023-06-22T21:06:38.658Z,1687467998.658 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5HA55M.000
2023-06-22T21:06:38.658Z,1687467998.658 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5HA55M.000
2023-06-22T21:06:38.678Z,1687467998.678 [CBIT](DEBUG): Deactivating GF circuits.
2023-06-22T21:06:38.679Z,1687467998.679 [CBIT](DEBUG): Deactivating emergency mode.
2023-06-22T21:06:38.719Z,1687467998.719 [CBIT](DEBUG): Backplane powered.
2023-06-22T21:06:38.719Z,1687467998.719 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2023-06-22T21:06:38.719Z,1687467998.719 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2023-06-22T21:06:38.720Z,1687467998.720 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2023-06-22T21:06:38.720Z,1687467998.720 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2023-06-22T21:06:38.720Z,1687467998.720 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2023-06-22T21:06:38.721Z,1687467998.721 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2023-06-22T21:06:38.722Z,1687467998.722 [NavChart](DEBUG): Initialize NavChart Navigation.
2023-06-22T21:06:38.722Z,1687467998.722 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2023-06-22T21:06:38.728Z,1687467998.728 [MissionManager](INFO): Loading Mission from file: Missions/Startup.xml
2023-06-22T21:06:38.749Z,1687467998.749 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2023-06-22T21:06:38.790Z,1687467998.790 [MissionManager](DEBUG):
2023-06-22T21:06:38.791Z,1687467998.791 [MissionManager](INFO): Loading Mission from file: Missions/Default.xml
2023-06-22T21:06:38.829Z,1687467998.829 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2023-06-22T21:06:38.830Z,1687467998.830 [Default:A.Wait](DEBUG): Construct Wait.
2023-06-22T21:06:38.832Z,1687467998.832 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2023-06-22T21:06:38.860Z,1687467998.860 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2023-06-22T21:06:38.862Z,1687467998.862 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2023-06-22T21:06:38.903Z,1687467998.903 [Default:E.Execute](DEBUG): Construct Execute.
2023-06-22T21:06:38.906Z,1687467998.906 [MissionManager](DEBUG):
0
Wait a moment to see if the scheduler starts a new mission before
starting to actually run Default.
13
Burn on
Dropped weight due to communications timeout.
5
Default mission has been running for
Restarting logs and Default mission.
restart logs
2023-06-22T21:06:38.911Z,1687467998.911 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,DropWeight,NAL9602,PowerOnly,Power24vConverter,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,Reporter,LogSplitter,
2023-06-22T21:06:38.917Z,1687467998.917 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2023-06-22T21:06:38.973Z,1687467998.973 [Depth_Keller](ERROR): Pressure or depth reading out of range: -1.140412 decibar, -1.132002 m
2023-06-22T21:06:38.974Z,1687467998.974 [PowerOnly](INFO): Stopped
2023-06-22T21:06:38.975Z,1687467998.975 [Power24vConverter](INFO): Powering up.
2023-06-22T21:06:38.981Z,1687467998.981 [DepthRateCalculator](ERROR): Depth measurement is not active
2023-06-22T21:06:39.006Z,1687467999.006 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2023-06-22T21:06:39.019Z,1687467999.019 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2023-06-22T21:06:39.020Z,1687467999.020 [ElevatorServo](DEBUG): Initializing EZServoServo.
2023-06-22T21:06:39.031Z,1687467999.031 [Radio_Surface](INFO): Powering up
2023-06-22T21:06:39.031Z,1687467999.031 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2023-06-22T21:06:39.032Z,1687467999.032 [MassServo](DEBUG): Initializing EZServoServo.
2023-06-22T21:06:39.043Z,1687467999.043 [MassServo](DEBUG): Initializing MassServo.
2023-06-22T21:06:39.044Z,1687467999.044 [RudderServo](DEBUG): Initializing EZServoServo.
2023-06-22T21:06:39.051Z,1687467999.051 [RudderServo](DEBUG): Initializing RudderServo.
2023-06-22T21:06:39.052Z,1687467999.052 [ThrusterHE](DEBUG): Initializing EZServoServo.
2023-06-22T21:06:39.059Z,1687467999.059 [ThrusterHE](DEBUG): Initializing ThrusterHE.
2023-06-22T21:06:39.364Z,1687467999.364 [DropWeight](CRITICAL): DROP WEIGHT MISSING.
2023-06-22T21:06:39.364Z,1687467999.364 [DropWeight] Hardware Fault, FailCount= 1
2023-06-22T21:06:39.364Z,1687467999.364 [DropWeight](ERROR): Hardware Fault
2023-06-22T21:06:39.365Z,1687467999.365 [PowerOnly](INFO): Stopped
2023-06-22T21:06:39.382Z,1687467999.382 [CommandExec](FAULT): Scheduling is paused
2023-06-22T21:06:39.387Z,1687467999.387 [CBIT](INFO): Critical error at 20230622T210639
2023-06-22T21:06:39.387Z,1687467999.387 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals
2023-06-22T21:06:39.389Z,1687467999.389 [CBIT](ERROR): Hardware Fault in component: DropWeight
2023-06-22T21:06:39.390Z,1687467999.390 [CBIT](CRITICAL): Hardware Fault in component: DropWeight
2023-06-22T21:06:39.728Z,1687467999.728 [PowerOnly](INFO): Stopped
2023-06-22T21:06:39.758Z,1687467999.758 [CBIT](INFO): Critical error at 20230622T210639
2023-06-22T21:06:40.136Z,1687468000.136 [PowerOnly](INFO): Stopped
2023-06-22T21:06:40.533Z,1687468000.533 [PowerOnly](INFO): Stopped
2023-06-22T21:06:40.759Z,1687468000.759 [WetLabsBB2FL](INFO): Powering down
2023-06-22T21:06:40.940Z,1687468000.940 [PowerOnly](INFO): Stopped
2023-06-22T21:06:41.344Z,1687468001.344 [PowerOnly](INFO): Stopped
2023-06-22T21:06:41.748Z,1687468001.748 [PowerOnly](INFO): Stopped
2023-06-22T21:06:42.149Z,1687468002.149 [AHRS_M2](DEBUG): boresightMatrix m[ decimal 0 0 2 2 f0.0 f0.0 f-1.0 f0.0 f-1.0 f0.0 f-1.0 f0.0 f0.0 ]m set drop
2023-06-22T21:06:42.152Z,1687468002.152 [PowerOnly](INFO): Stopped
2023-06-22T21:06:42.552Z,1687468002.552 [AHRS_M2](DEBUG): chan0Format 2 set drop
2023-06-22T21:06:42.556Z,1687468002.556 [PowerOnly](INFO): Stopped
2023-06-22T21:06:42.956Z,1687468002.956 [AHRS_M2](DEBUG): chan0Trigger 5 set drop
2023-06-22T21:06:42.960Z,1687468002.960 [PowerOnly](INFO): Stopped
2023-06-22T21:06:43.360Z,1687468003.360 [AHRS_M2](DEBUG): chan0Enables array[ 0 15 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 ]array set drop
2023-06-22T21:06:43.360Z,1687468003.360 [AHRS_M2](DEBUG): chan0EnableBit pitch dvid@ set drop
2023-06-22T21:06:43.364Z,1687468003.364 [PowerOnly](INFO): Stopped
2023-06-22T21:06:43.763Z,1687468003.763 [AHRS_M2](DEBUG): chan0EnableBit roll dvid@ set drop
2023-06-22T21:06:43.772Z,1687468003.772 [PowerOnly](INFO): Stopped
2023-06-22T21:06:44.168Z,1687468004.168 [AHRS_M2](DEBUG): chan0EnableBit yaw dvid@ set drop
2023-06-22T21:06:44.172Z,1687468004.172 [PowerOnly](INFO): Stopped
2023-06-22T21:06:44.572Z,1687468004.572 [AHRS_M2](DEBUG): chan0EnableBit magp dvid@ set drop
2023-06-22T21:06:44.576Z,1687468004.576 [PowerOnly](INFO): Stopped
2023-06-22T21:06:44.748Z,1687468004.748 [ThrusterHE](ERROR): Zero Speed Commanded.
2023-06-22T21:06:44.976Z,1687468004.976 [AHRS_M2](DEBUG): chan0EnableBit accelp dvid@ set drop
2023-06-22T21:06:44.980Z,1687468004.980 [PowerOnly](INFO): Stopped
2023-06-22T21:06:45.381Z,1687468005.381 [AHRS_M2](DEBUG): chan0EnableBit gyrop dvid@ set drop
2023-06-22T21:06:45.384Z,1687468005.384 [PowerOnly](INFO): Stopped
2023-06-22T21:06:45.784Z,1687468005.784 [AHRS_M2](DEBUG): chan0EnableBit yawErrEst dvid@ set drop
2023-06-22T21:06:45.788Z,1687468005.788 [PowerOnly](INFO): Stopped
2023-06-22T21:06:46.188Z,1687468006.188 [AHRS_M2](DEBUG): chan0EnableBit temperature dvid@ set drop
2023-06-22T21:06:46.192Z,1687468006.192 [PowerOnly](INFO): Stopped
2023-06-22T21:06:46.592Z,1687468006.592 [AHRS_M2](DEBUG): chan0EnableBit magBufferActiveIndex dvid@ set drop
2023-06-22T21:06:46.596Z,1687468006.596 [PowerOnly](INFO): Stopped
2023-06-22T21:06:46.996Z,1687468006.996 [AHRS_M2](DEBUG): chan0TriggerDivisor 40 set drop
2023-06-22T21:06:47.000Z,1687468007.000 [PowerOnly](INFO): Stopped
2023-06-22T21:06:47.404Z,1687468007.404 [PowerOnly](INFO): Stopped
2023-06-22T21:06:47.808Z,1687468007.808 [PowerOnly](INFO): Stopped
2023-06-22T21:06:48.212Z,1687468008.212 [PowerOnly](INFO): Stopped
2023-06-22T21:06:48.632Z,1687468008.632 [PowerOnly](INFO): Stopped
2023-06-22T21:06:48.691Z,1687468008.691 [CBIT](CRITICAL): Environmental Failure. Press:14.758947 PSI. Humidity:40%. Temp:25 C. ABORTING MISSION
2023-06-22T21:06:48.920Z,1687468008.920 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004132
2023-06-22T21:06:49.020Z,1687468009.020 [PowerOnly](INFO): Stopped
2023-06-22T21:06:49.081Z,1687468009.081 [CBIT](INFO): Critical error at 20230622T210648
2023-06-22T21:06:49.424Z,1687468009.424 [PowerOnly](INFO): Stopped
2023-06-22T21:06:49.828Z,1687468009.828 [PowerOnly](INFO): Stopped
2023-06-22T21:06:50.237Z,1687468010.237 [PowerOnly](INFO): Stopped
2023-06-22T21:06:50.636Z,1687468010.636 [PowerOnly](INFO): Stopped
2023-06-22T21:06:51.044Z,1687468011.044 [PowerOnly](INFO): Stopped
2023-06-22T21:06:51.441Z,1687468011.441 [PowerOnly](INFO): Stopped
2023-06-22T21:06:51.852Z,1687468011.852 [PowerOnly](INFO): Stopped
2023-06-22T21:06:52.257Z,1687468012.257 [PowerOnly](INFO): Stopped
2023-06-22T21:06:52.660Z,1687468012.660 [PowerOnly](INFO): Stopped
2023-06-22T21:06:53.064Z,1687468013.064 [PowerOnly](INFO): Stopped
2023-06-22T21:06:53.468Z,1687468013.468 [PowerOnly](INFO): Stopped
2023-06-22T21:06:53.872Z,1687468013.872 [PowerOnly](INFO): Stopped
2023-06-22T21:06:54.273Z,1687468014.273 [PowerOnly](INFO): Stopped
2023-06-22T21:06:54.681Z,1687468014.681 [PowerOnly](INFO): Stopped
2023-06-22T21:06:55.078Z,1687468015.078 [PowerOnly](INFO): Stopped
2023-06-22T21:06:55.488Z,1687468015.488 [PowerOnly](INFO): Stopped
2023-06-22T21:06:55.892Z,1687468015.892 [PowerOnly](INFO): Stopped
2023-06-22T21:06:56.293Z,1687468016.293 [PowerOnly](INFO): Stopped
2023-06-22T21:06:56.696Z,1687468016.696 [PowerOnly](INFO): Stopped
2023-06-22T21:06:57.096Z,1687468017.096 [AHRS_M2](FAULT): Failed to acquire valid data within timeout.
2023-06-22T21:06:57.096Z,1687468017.096 [AHRS_M2] Data Fault, FailCount= 1
2023-06-22T21:06:57.096Z,1687468017.096 [AHRS_M2](ERROR): Data Fault
2023-06-22T21:06:57.104Z,1687468017.104 [PowerOnly](INFO): Stopped
2023-06-22T21:06:57.159Z,1687468017.159 [CBIT](ERROR): Data Fault in component: AHRS_M2
2023-06-22T21:06:57.160Z,1687468017.160 [CBIT](CRITICAL): Data Fault in component: AHRS_M2
2023-06-22T21:06:57.504Z,1687468017.504 [PowerOnly](INFO): Stopped
2023-06-22T21:06:57.552Z,1687468017.552 [CBIT](INFO): Critical error at 20230622T210657
2023-06-22T21:06:57.913Z,1687468017.913 [PowerOnly](INFO): Stopped
2023-06-22T21:06:58.316Z,1687468018.316 [PowerOnly](INFO): Stopped
2023-06-22T21:06:58.720Z,1687468018.720 [PowerOnly](INFO): Stopped
2023-06-22T21:06:59.124Z,1687468019.124 [PowerOnly](INFO): Stopped
2023-06-22T21:06:59.529Z,1687468019.529 [PowerOnly](INFO): Stopped
2023-06-22T21:06:59.932Z,1687468019.932 [PowerOnly](INFO): Stopped
2023-06-22T21:07:00.336Z,1687468020.336 [PowerOnly](INFO): Stopped
2023-06-22T21:07:00.740Z,1687468020.740 [PowerOnly](INFO): Stopped
2023-06-22T21:07:01.137Z,1687468021.137 [PowerOnly](INFO): Stopped
2023-06-22T21:07:01.548Z,1687468021.548 [PowerOnly](INFO): Stopped
2023-06-22T21:07:01.952Z,1687468021.952 [PowerOnly](INFO): Stopped
2023-06-22T21:07:02.349Z,1687468022.349 [PowerOnly](INFO): Stopped
2023-06-22T21:07:02.760Z,1687468022.760 [PowerOnly](INFO): Stopped
2023-06-22T21:07:03.164Z,1687468023.164 [PowerOnly](INFO): Stopped
2023-06-22T21:07:03.561Z,1687468023.561 [PowerOnly](INFO): Stopped
2023-06-22T21:07:03.972Z,1687468023.972 [PowerOnly](INFO): Stopped
2023-06-22T21:07:04.372Z,1687468024.372 [PowerOnly](INFO): Stopped
2023-06-22T21:07:04.781Z,1687468024.781 [PowerOnly](INFO): Stopped
2023-06-22T21:07:05.184Z,1687468025.184 [PowerOnly](INFO): Stopped
2023-06-22T21:07:05.588Z,1687468025.588 [PowerOnly](INFO): Stopped
2023-06-22T21:07:05.992Z,1687468025.992 [PowerOnly](INFO): Stopped
2023-06-22T21:07:06.397Z,1687468026.397 [PowerOnly](INFO): Stopped
2023-06-22T21:07:06.800Z,1687468026.800 [PowerOnly](INFO): Stopped
2023-06-22T21:07:07.197Z,1687468027.197 [NAL9602](INFO): Powering up NAL9602
2023-06-22T21:07:07.199Z,1687468027.199 [PowerOnly](INFO): Stopped
2023-06-22T21:07:07.604Z,1687468027.604 [PowerOnly](INFO): Stopped
2023-06-22T21:07:08.013Z,1687468028.013 [PowerOnly](INFO): Stopped
2023-06-22T21:07:08.409Z,1687468028.409 [PowerOnly](INFO): Stopped
2023-06-22T21:07:08.820Z,1687468028.820 [PowerOnly](INFO): Stopped
2023-06-22T21:07:09.224Z,1687468029.224 [PowerOnly](INFO): Stopped
2023-06-22T21:07:09.629Z,1687468029.629 [PowerOnly](INFO): Stopped
2023-06-22T21:07:10.032Z,1687468030.032 [PowerOnly](INFO): Stopped
2023-06-22T21:07:10.436Z,1687468030.436 [PowerOnly](INFO): Stopped
2023-06-22T21:07:10.840Z,1687468030.840 [PowerOnly](INFO): Stopped
2023-06-22T21:07:11.241Z,1687468031.241 [PowerOnly](INFO): Stopped
2023-06-22T21:07:11.644Z,1687468031.644 [PowerOnly](INFO): Stopped
2023-06-22T21:07:12.048Z,1687468032.048 [PowerOnly](INFO): Stopped
2023-06-22T21:07:12.452Z,1687468032.452 [PowerOnly](INFO): Stopped
2023-06-22T21:07:12.856Z,1687468032.856 [PowerOnly](INFO): Stopped
2023-06-22T21:07:13.260Z,1687468033.260 [PowerOnly](INFO): Stopped
2023-06-22T21:07:13.672Z,1687468033.672 [PowerOnly](INFO): Stopped
2023-06-22T21:07:14.068Z,1687468034.068 [PowerOnly](INFO): Stopped
2023-06-22T21:07:14.472Z,1687468034.472 [PowerOnly](INFO): Stopped
2023-06-22T21:07:14.880Z,1687468034.880 [PowerOnly](INFO): Stopped
2023-06-22T21:07:15.284Z,1687468035.284 [PowerOnly](INFO): Stopped
2023-06-22T21:07:15.688Z,1687468035.688 [PowerOnly](INFO): Stopped
2023-06-22T21:07:16.092Z,1687468036.092 [PowerOnly](INFO): Stopped
2023-06-22T21:07:16.496Z,1687468036.496 [PowerOnly](INFO): Stopped
2023-06-22T21:07:16.900Z,1687468036.900 [PowerOnly](INFO): Stopped
2023-06-22T21:07:17.304Z,1687468037.304 [PowerOnly](INFO): Stopped
2023-06-22T21:07:17.723Z,1687468037.723 [PowerOnly](INFO): Stopped
2023-06-22T21:07:18.113Z,1687468038.113 [NAL9602](INFO): NAL9602 initialized
2023-06-22T21:07:18.114Z,1687468038.114 [PowerOnly](INFO): Stopped
2023-06-22T21:07:18.512Z,1687468038.512 [PowerOnly](INFO): Stopped
2023-06-22T21:07:18.935Z,1687468038.935 [PowerOnly](INFO): Stopped
2023-06-22T21:07:19.339Z,1687468039.339 [PowerOnly](INFO): Stopped
2023-06-22T21:07:19.739Z,1687468039.739 [PowerOnly](INFO): Stopped
2023-06-22T21:07:20.132Z,1687468040.132 [PowerOnly](INFO): Stopped
2023-06-22T21:07:20.530Z,1687468040.530 [PowerOnly](INFO): Stopped
2023-06-22T21:07:20.941Z,1687468040.941 [PowerOnly](INFO): Stopped
2023-06-22T21:07:21.355Z,1687468041.355 [PowerOnly](INFO): Stopped
2023-06-22T21:07:21.763Z,1687468041.763 [PowerOnly](INFO): Stopped
2023-06-22T21:07:22.163Z,1687468042.163 [PowerOnly](INFO): Stopped
2023-06-22T21:07:22.556Z,1687468042.556 [PowerOnly](INFO): Stopped
2023-06-22T21:07:22.960Z,1687468042.960 [PowerOnly](INFO): Stopped
2023-06-22T21:07:23.360Z,1687468043.360 [PowerOnly](INFO): Stopped
2023-06-22T21:07:23.769Z,1687468043.769 [PowerOnly](INFO): Stopped
2023-06-22T21:07:24.166Z,1687468044.166 [PowerOnly](INFO): Stopped
2023-06-22T21:07:24.576Z,1687468044.576 [PowerOnly](INFO): Stopped
2023-06-22T21:07:24.982Z,1687468044.982 [PowerOnly](INFO): Stopped
2023-06-22T21:07:25.378Z,1687468045.378 [PowerOnly](INFO): Stopped
2023-06-22T21:07:25.785Z,1687468045.785 [PowerOnly](INFO): Stopped
2023-06-22T21:07:26.207Z,1687468046.207 [PowerOnly](INFO): Stopped
2023-06-22T21:07:26.603Z,1687468046.603 [PowerOnly](INFO): Stopped
2023-06-22T21:07:27.011Z,1687468047.011 [PowerOnly](INFO): Stopped
2023-06-22T21:07:27.415Z,1687468047.415 [PowerOnly](INFO): Stopped
2023-06-22T21:07:27.808Z,1687468047.808 [PowerOnly](INFO): Stopped
2023-06-22T21:07:28.212Z,1687468048.212 [PowerOnly](INFO): Stopped
2023-06-22T21:07:28.616Z,1687468048.616 [PowerOnly](INFO): Stopped
2023-06-22T21:07:29.014Z,1687468049.014 [PowerOnly](INFO): Stopped
2023-06-22T21:07:29.424Z,1687468049.424 [PowerOnly](INFO): Stopped
2023-06-22T21:07:29.829Z,1687468049.829 [PowerOnly](INFO): Stopped
2023-06-22T21:07:30.226Z,1687468050.226 [PowerOnly](INFO): Stopped
2023-06-22T21:07:30.636Z,1687468050.636 [PowerOnly](INFO): Stopped
2023-06-22T21:07:31.041Z,1687468051.041 [PowerOnly](INFO): Stopped
2023-06-22T21:07:31.455Z,1687468051.455 [PowerOnly](INFO): Stopped
2023-06-22T21:07:31.859Z,1687468051.859 [PowerOnly](INFO): Stopped
2023-06-22T21:07:32.267Z,1687468052.267 [PowerOnly](INFO): Stopped
2023-06-22T21:07:32.667Z,1687468052.667 [PowerOnly](INFO): Stopped
2023-06-22T21:07:33.060Z,1687468053.060 [PowerOnly](INFO): Stopped
2023-06-22T21:07:33.464Z,1687468053.464 [PowerOnly](INFO): Stopped
2023-06-22T21:07:33.868Z,1687468053.868 [PowerOnly](INFO): Stopped
2023-06-22T21:07:34.272Z,1687468054.272 [PowerOnly](INFO): Stopped
2023-06-22T21:07:34.676Z,1687468054.676 [PowerOnly](INFO): Stopped
2023-06-22T21:07:35.074Z,1687468055.074 [PowerOnly](INFO): Stopped
2023-06-22T21:07:35.480Z,1687468055.480 [PowerOnly](INFO): Stopped
2023-06-22T21:07:35.885Z,1687468055.885 [PowerOnly](INFO): Stopped
2023-06-22T21:07:36.286Z,1687468056.286 [PowerOnly](INFO): Stopped
2023-06-22T21:07:36.707Z,1687468056.707 [PowerOnly](INFO): Stopped
2023-06-22T21:07:37.115Z,1687468057.115 [PowerOnly](INFO): Stopped
2023-06-22T21:07:37.511Z,1687468057.511 [PowerOnly](INFO): Stopped
2023-06-22T21:07:37.919Z,1687468057.919 [PowerOnly](INFO): Stopped
2023-06-22T21:07:38.312Z,1687468058.312 [PowerOnly](INFO): Stopped
2023-06-22T21:07:38.720Z,1687468058.720 [PowerOnly](INFO): Stopped
2023-06-22T21:07:38.887Z,1687468058.887 [DAT](FAULT): failed to initialize; deviceResponse_ loaded: , available:
2023-06-22T21:07:38.887Z,1687468058.887 [DAT] Communications Fault, FailCount= 1
2023-06-22T21:07:38.887Z,1687468058.887 [DAT](ERROR): Communications Fault
2023-06-22T21:07:39.116Z,1687468059.116 [PowerOnly](INFO): Stopped
2023-06-22T21:07:39.148Z,1687468059.148 [CBIT](ERROR): Communications Fault in component: DAT
2023-06-22T21:07:39.291Z,1687468059.291 [DAT](INFO): Powering down
2023-06-22T21:07:39.550Z,1687468059.550 [PowerOnly](INFO): Stopped
2023-06-22T21:07:39.940Z,1687468059.940 [PowerOnly](INFO): Stopped
2023-06-22T21:07:40.330Z,1687468060.330 [PowerOnly](INFO): Stopped
2023-06-22T21:07:40.345Z,1687468060.345 [CBIT](INFO): Clearing failed state for component DAT
2023-06-22T21:07:40.345Z,1687468060.345 [DAT] No Fault, FailCount= 1
2023-06-22T21:07:40.733Z,1687468060.733 [PowerOnly](INFO): Stopped
2023-06-22T21:07:41.137Z,1687468061.137 [PowerOnly](INFO): Stopped
2023-06-22T21:07:41.540Z,1687468061.540 [PowerOnly](INFO): Stopped
2023-06-22T21:07:41.975Z,1687468061.975 [PowerOnly](INFO): Stopped
2023-06-22T21:07:42.347Z,1687468062.347 [DAT](INFO): Powering up
2023-06-22T21:07:42.347Z,1687468062.347 [DAT](DEBUG): Initializing DAT.
2023-06-22T21:07:42.373Z,1687468062.373 [PowerOnly](INFO): Stopped
2023-06-22T21:07:42.763Z,1687468062.763 [PowerOnly](INFO): Stopped
2023-06-22T21:07:43.175Z,1687468063.175 [PowerOnly](INFO): Stopped
2023-06-22T21:07:43.570Z,1687468063.570 [PowerOnly](INFO): Stopped
2023-06-22T21:07:43.964Z,1687468063.964 [PowerOnly](INFO): Stopped
2023-06-22T21:07:44.047Z,1687468064.047 [CommandExec](IMPORTANT): got command quit
2023-06-22T21:07:44.369Z,1687468064.369 [PowerOnly](INFO): Stopped
2023-06-22T21:07:44.772Z,1687468064.772 [PowerOnly](INFO): Stopped
2023-06-22T21:07:45.051Z,1687468065.051 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread.
2023-06-22T21:07:45.051Z,1687468065.051 [CommandExec](INFO): Uninitializing the command executive.
2023-06-22T21:07:45.051Z,1687468065.051 [CommandExec](INFO): Uninitializing the command scheduler.
2023-06-22T21:07:45.051Z,1687468065.051 [CommandExec ThreadHandler](INFO): Thread cancelled.
2023-06-22T21:07:45.180Z,1687468065.180 [PowerOnly](INFO): Stopped
2023-06-22T21:07:45.222Z,1687468065.222 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye!
2023-06-22T21:07:45.223Z,1687468065.223 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2023-06-22T21:07:45.223Z,1687468065.223 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2023-06-22T21:07:45.223Z,1687468065.223 [NavChartDb](INFO): Join timeout helper Thread ID is 4992
2023-06-22T21:07:45.423Z,1687468065.423 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2023-06-22T21:07:45.423Z,1687468065.423 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2023-06-22T21:07:45.445Z,1687468065.445 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2023-06-22T21:07:45.445Z,1687468065.445 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2023-06-22T21:07:45.446Z,1687468065.446 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 4993
2023-06-22T21:07:45.585Z,1687468065.585 [PowerOnly](INFO): Stopped
2023-06-22T21:07:45.719Z,1687468065.719 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread.
2023-06-22T21:07:45.719Z,1687468065.719 [WetLabsBB2FL](INFO): Powering down
2023-06-22T21:07:45.720Z,1687468065.720 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2023-06-22T21:07:45.723Z,1687468065.723 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler
2023-06-22T21:07:45.723Z,1687468065.723 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2023-06-22T21:07:45.723Z,1687468065.723 [CTD_Seabird](INFO): Join timeout helper Thread ID is 4994
2023-06-22T21:07:45.923Z,1687468065.923 [CTD_Seabird](INFO): Powering down
2023-06-22T21:07:45.935Z,1687468065.935 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread.
2023-06-22T21:07:45.935Z,1687468065.935 [CTD_Seabird](INFO): Powering down
2023-06-22T21:07:45.947Z,1687468065.947 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2023-06-22T21:07:45.967Z,1687468065.967 [ComponentRegistry](INFO): Shutting down DAT ThreadHandler
2023-06-22T21:07:45.967Z,1687468065.967 [DAT ThreadHandler](INFO): Thread cancelled.
2023-06-22T21:07:45.967Z,1687468065.967 [DAT](INFO): Join timeout helper Thread ID is 4995
2023-06-22T21:07:46.011Z,1687468066.011 [PowerOnly](INFO): Stopped
2023-06-22T21:07:46.131Z,1687468066.131 [DAT](INFO): Powering down
2023-06-22T21:07:46.199Z,1687468066.199 [DAT ThreadHandler](INFO): Uninitializing protected caller thread.
2023-06-22T21:07:46.199Z,1687468066.199 [DAT](INFO): Powering down
2023-06-22T21:07:46.200Z,1687468066.200 [DAT ThreadHandler](INFO): Thread cancelled.
2023-06-22T21:07:46.219Z,1687468066.219 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2023-06-22T21:07:46.219Z,1687468066.219 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2023-06-22T21:07:46.219Z,1687468066.219 [Radio_Surface](INFO): Join timeout helper Thread ID is 4996
2023-06-22T21:07:46.401Z,1687468066.401 [PowerOnly](INFO): Stopped
2023-06-22T21:07:46.499Z,1687468066.499 [Radio_Surface](INFO): Powering down
2023-06-22T21:07:46.500Z,1687468066.500 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2023-06-22T21:07:46.500Z,1687468066.500 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2023-06-22T21:07:46.511Z,1687468066.511 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler
2023-06-22T21:07:46.512Z,1687468066.512 [Onboard ThreadHandler](INFO): Thread cancelled.
2023-06-22T21:07:46.512Z,1687468066.512 [Onboard](INFO): Join timeout helper Thread ID is 4997
2023-06-22T21:07:46.806Z,1687468066.806 [PowerOnly](INFO): Stopped
2023-06-22T21:07:47.223Z,1687468067.223 [PowerOnly](INFO): Stopped
2023-06-22T21:07:47.499Z,1687468067.499 [DataOverHttps](INFO): Radio surface powered OFF, will not connect.
2023-06-22T21:07:47.611Z,1687468067.611 [PowerOnly](INFO): Stopped
2023-06-22T21:07:48.023Z,1687468068.023 [PowerOnly](INFO): Stopped
2023-06-22T21:07:48.423Z,1687468068.423 [PowerOnly](INFO): Stopped
2023-06-22T21:07:48.659Z,1687468068.659 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread.
2023-06-22T21:07:48.659Z,1687468068.659 [Onboard ThreadHandler](INFO): Thread cancelled.
2023-06-22T21:07:48.674Z,1687468068.674 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler
2023-06-22T21:07:48.675Z,1687468068.675 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2023-06-22T21:07:48.675Z,1687468068.675 [DataOverHttps](INFO): Join timeout helper Thread ID is 4998
2023-06-22T21:07:48.817Z,1687468068.817 [PowerOnly](INFO): Stopped
2023-06-22T21:07:49.220Z,1687468069.220 [PowerOnly](INFO): Stopped
2023-06-22T21:07:49.507Z,1687468069.507 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread.
2023-06-22T21:07:49.507Z,1687468069.507 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2023-06-22T21:07:49.523Z,1687468069.523 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2023-06-22T21:07:49.523Z,1687468069.523 [logger ThreadHandler](INFO): Thread cancelled.
2023-06-22T21:07:49.524Z,1687468069.524 [logger](INFO): Join timeout helper Thread ID is 4999
2023-06-22T21:07:49.547Z,1687468069.547 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2023-06-22T21:07:49.547Z,1687468069.547 [logger ThreadHandler](INFO): Thread cancelled.
2023-06-22T21:07:49.563Z,1687468069.563 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2023-06-22T21:07:49.563Z,1687468069.563 [CommandLine ThreadHandler](INFO): Thread cancelled.
2023-06-22T21:07:49.564Z,1687468069.564 [CommandLine](INFO): Join timeout helper Thread ID is 5000
2023-06-22T21:07:49.620Z,1687468069.620 [PowerOnly](INFO): Stopped
2023-06-22T21:07:49.631Z,1687468069.631 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2023-06-22T21:07:49.631Z,1687468069.631 [CommandLine ThreadHandler](INFO): Thread cancelled.
2023-06-22T21:07:49.643Z,1687468069.643 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler
2023-06-22T21:07:49.644Z,1687468069.644 [CommandExec ThreadHandler](INFO): Thread cancelled.
2023-06-22T21:07:49.644Z,1687468069.644 [CommandExec](INFO): Join timeout helper Thread ID is 5001
2023-06-22T21:07:49.645Z,1687468069.645 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2023-06-22T21:07:49.645Z,1687468069.645 [controlThread ThreadHandler](INFO): Thread cancelled.
2023-06-22T21:07:49.646Z,1687468069.646 [controlThread](INFO): Join timeout helper Thread ID is 5002
2023-06-22T21:07:50.015Z,1687468070.015 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2023-06-22T21:07:50.015Z,1687468070.015 [controlThread](DEBUG): Uninitializing ControlThread
2023-06-22T21:07:50.016Z,1687468070.016 [NAL9602](INFO): Powering down
2023-06-22T21:07:50.019Z,1687468070.019 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2023-06-22T21:07:50.020Z,1687468070.020 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2023-06-22T21:07:50.020Z,1687468070.020 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2023-06-22T21:07:50.021Z,1687468070.021 [MissionManager](INFO): Uninitializing Mission Default
2023-06-22T21:07:50.023Z,1687468070.023 [MissionManager](INFO): Uninitializing Mission Startup
2023-06-22T21:07:50.024Z,1687468070.024 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2023-06-22T21:07:50.025Z,1687468070.025 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2023-06-22T21:07:50.025Z,1687468070.025 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2023-06-22T21:07:50.025Z,1687468070.025 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2023-06-22T21:07:50.025Z,1687468070.025 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2023-06-22T21:07:50.026Z,1687468070.026 [BuoyancyServo](INFO): Powering down
2023-06-22T21:07:50.039Z,1687468070.039 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2023-06-22T21:07:50.039Z,1687468070.039 [ElevatorServo](INFO): Powering down
2023-06-22T21:07:50.040Z,1687468070.040 [MassServo](DEBUG): Uninitialize Mass Servo.
2023-06-22T21:07:50.040Z,1687468070.040 [MassServo](INFO): Powering down
2023-06-22T21:07:50.041Z,1687468070.041 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2023-06-22T21:07:50.041Z,1687468070.041 [RudderServo](INFO): Powering down
2023-06-22T21:07:50.042Z,1687468070.042 [ThrusterHE](DEBUG): Uninitialize Thruster Servo.
2023-06-22T21:07:50.042Z,1687468070.042 [ThrusterHE](INFO): Powering down
2023-06-22T21:07:50.043Z,1687468070.043 [SBIT](DEBUG): Uninitialize SBIT Component.
2023-06-22T21:07:50.043Z,1687468070.043 [IBIT](DEBUG): Uninitialize IBIT Component.
2023-06-22T21:07:50.043Z,1687468070.043 [CBIT](DEBUG): Uninitialize CBIT Component.
2023-06-22T21:07:50.043Z,1687468070.043 [CBIT](DEBUG): Powering off loads.
2023-06-22T21:07:50.054Z,1687468070.054 [CBIT](DEBUG): Disabling WDT.
2023-06-22T21:07:50.066Z,1687468070.066 [CBIT](DEBUG): Opening all GF detection circuits.
2023-06-22T21:07:50.067Z,1687468070.067 [controlThread ThreadHandler](INFO): Thread cancelled.
2023-06-22T21:07:50.106Z,1687468070.106 [DAT ThreadHandler](INFO): Thread cancelled.
2023-06-22T21:07:50.111Z,1687468070.111 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2023-06-22T21:07:50.114Z,1687468070.114 [Onboard ThreadHandler](INFO): Thread cancelled.
2023-06-22T21:07:50.120Z,1687468070.120 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2023-06-22T21:07:50.374Z,1687468070.374 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2023-06-22T21:07:50.379Z,1687468070.379 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2023-06-22T21:07:50.387Z,1687468070.387 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2023-06-22T21:07:50.433Z,1687468070.433 [logger ThreadHandler](INFO): Thread cancelled.