2024-08-19T23:53:10.091Z,1724111590.091 [Supervisor](DEBUG): Initializing supervisor.
2024-08-19T23:53:10.095Z,1724111590.095 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2024-08-19T23:53:10.096Z,1724111590.096 [SyncHandler](INFO): Protected caller Thread ID is 4671
2024-08-19T23:53:10.096Z,1724111590.096 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2024-08-19T23:53:10.097Z,1724111590.097 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2024-08-19T23:53:10.098Z,1724111590.098 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 4672
2024-08-19T23:53:10.101Z,1724111590.101 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2024-08-19T23:53:10.119Z,1724111590.119 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread.
2024-08-19T23:53:10.120Z,1724111590.120 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2024-08-19T23:53:10.121Z,1724111590.121 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 4673
2024-08-19T23:53:10.125Z,1724111590.125 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2024-08-19T23:53:10.126Z,1724111590.126 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2024-08-19T23:53:10.126Z,1724111590.126 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 4674
2024-08-19T23:53:10.128Z,1724111590.128 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2024-08-19T23:53:10.129Z,1724111590.129 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0
2024-08-19T23:53:10.130Z,1724111590.130 [logger ThreadHandler](INFO): Protected caller Thread ID is 4675
2024-08-19T23:53:10.133Z,1724111590.133 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2024-08-19T23:53:10.134Z,1724111590.134 [Supervisor](INFO): Looking for Config files in directory: Config/
2024-08-19T23:53:10.136Z,1724111590.136 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2024-08-19T23:53:10.545Z,1724111590.545 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2024-08-19T23:53:10.545Z,1724111590.545 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2024-08-19T23:53:11.319Z,1724111591.319 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2024-08-19T23:53:11.320Z,1724111591.320 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2024-08-19T23:53:11.443Z,1724111591.443 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2024-08-19T23:53:11.444Z,1724111591.444 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2024-08-19T23:53:12.014Z,1724111592.014 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2024-08-19T23:53:12.015Z,1724111592.015 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2024-08-19T23:53:12.124Z,1724111592.124 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2024-08-19T23:53:12.125Z,1724111592.125 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2024-08-19T23:53:12.219Z,1724111592.219 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2024-08-19T23:53:12.650Z,1724111592.650 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2024-08-19T23:53:12.651Z,1724111592.651 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2024-08-19T23:53:12.890Z,1724111592.890 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2024-08-19T23:53:12.890Z,1724111592.890 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2024-08-19T23:53:13.043Z,1724111593.043 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2024-08-19T23:53:13.044Z,1724111593.044 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg
2024-08-19T23:53:13.303Z,1724111593.303 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock
2024-08-19T23:53:13.303Z,1724111593.303 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2024-08-19T23:53:13.871Z,1724111593.871 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2024-08-19T23:53:13.872Z,1724111593.872 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2024-08-19T23:53:14.276Z,1724111594.276 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2024-08-19T23:53:14.277Z,1724111594.277 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2024-08-19T23:53:14.371Z,1724111594.371 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2024-08-19T23:53:14.582Z,1724111594.582 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2024-08-19T23:53:14.582Z,1724111594.582 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2024-08-19T23:53:14.890Z,1724111594.890 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2024-08-19T23:53:14.891Z,1724111594.891 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2024-08-19T23:53:15.668Z,1724111595.668 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2024-08-19T23:53:15.670Z,1724111595.670 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-brizo/
2024-08-19T23:53:15.671Z,1724111595.671 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Control.cfg
2024-08-19T23:53:15.793Z,1724111595.793 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Sensor.cfg
2024-08-19T23:53:15.958Z,1724111595.958 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Simulator.cfg
2024-08-19T23:53:16.057Z,1724111596.057 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/secure.cfg
2024-08-19T23:53:16.154Z,1724111596.154 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Servo.cfg
2024-08-19T23:53:16.277Z,1724111596.277 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/workSite.cfg
2024-08-19T23:53:16.375Z,1724111596.375 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/vehicle.cfg
2024-08-19T23:53:16.495Z,1724111596.495 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Battery.cfg
2024-08-19T23:53:16.772Z,1724111596.772 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2024-08-19T23:53:16.773Z,1724111596.773 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Science.cfg
2024-08-19T23:53:16.921Z,1724111596.921 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/logger.cfg
2024-08-19T23:53:17.028Z,1724111597.028 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/BIT.cfg
2024-08-19T23:53:17.134Z,1724111597.134 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Navigation.cfg
2024-08-19T23:53:17.252Z,1724111597.252 [Supervisor](IMPORTANT): Reloading configuration overrides from Data/persisted.cfg
2024-08-19T23:53:17.269Z,1724111597.269 [Module Loader](DEBUG): Loading Module at Modules/Dock.so
2024-08-19T23:53:17.377Z,1724111597.377 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking)
2024-08-19T23:53:17.377Z,1724111597.377 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2024-08-19T23:53:17.387Z,1724111597.387 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2024-08-19T23:53:17.388Z,1724111597.388 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2024-08-19T23:53:17.437Z,1724111597.437 [DepthRateCalculator] Loaded
2024-08-19T23:53:17.437Z,1724111597.437 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2024-08-19T23:53:17.443Z,1724111597.443 [PitchRateCalculator] Loaded
2024-08-19T23:53:17.443Z,1724111597.443 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2024-08-19T23:53:17.453Z,1724111597.453 [SpeedCalculator] Loaded
2024-08-19T23:53:17.454Z,1724111597.454 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2024-08-19T23:53:17.459Z,1724111597.459 [YawRateCalculator] Loaded
2024-08-19T23:53:17.459Z,1724111597.459 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2024-08-19T23:53:17.480Z,1724111597.480 [ElevatorOffsetCalculator] Loaded
2024-08-19T23:53:17.481Z,1724111597.481 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2024-08-19T23:53:17.481Z,1724111597.481 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2024-08-19T23:53:17.482Z,1724111597.482 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2024-08-19T23:53:17.533Z,1724111597.533 [VerticalControl](DEBUG): Construct VerticalControl.
2024-08-19T23:53:17.588Z,1724111597.588 [VerticalControl] Loaded
2024-08-19T23:53:17.588Z,1724111597.588 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2024-08-19T23:53:17.591Z,1724111597.591 [HorizontalControl](DEBUG): Construct HorizontalControl.
2024-08-19T23:53:17.638Z,1724111597.638 [HorizontalControl] Loaded
2024-08-19T23:53:17.638Z,1724111597.638 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2024-08-19T23:53:17.641Z,1724111597.641 [SpeedControl](DEBUG): Construct SpeedControl.
2024-08-19T23:53:17.643Z,1724111597.643 [SpeedControl] Loaded
2024-08-19T23:53:17.644Z,1724111597.644 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2024-08-19T23:53:17.646Z,1724111597.646 [LoopControl](DEBUG): Construct LoopControl.
2024-08-19T23:53:17.647Z,1724111597.647 [LoopControl] Loaded
2024-08-19T23:53:17.647Z,1724111597.647 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2024-08-19T23:53:17.647Z,1724111597.647 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2024-08-19T23:53:17.648Z,1724111597.648 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2024-08-19T23:53:17.758Z,1724111597.758 [DeadReckonUsingMultipleVelocitySources] Loaded
2024-08-19T23:53:17.758Z,1724111597.758 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2024-08-19T23:53:17.772Z,1724111597.772 [NavChart] Loaded
2024-08-19T23:53:17.772Z,1724111597.772 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2024-08-19T23:53:17.778Z,1724111597.778 [UniversalFixResidualReporter] Loaded
2024-08-19T23:53:17.778Z,1724111597.778 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2024-08-19T23:53:17.778Z,1724111597.778 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2024-08-19T23:53:17.779Z,1724111597.779 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2024-08-19T23:53:17.948Z,1724111597.948 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2024-08-19T23:53:17.948Z,1724111597.948 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2024-08-19T23:53:18.395Z,1724111598.395 [AHRS_M2] Loaded
2024-08-19T23:53:18.395Z,1724111598.395 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread.
2024-08-19T23:53:18.435Z,1724111598.435 [BackseatComponent] Loaded
2024-08-19T23:53:18.435Z,1724111598.435 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread.
2024-08-19T23:53:18.436Z,1724111598.436 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 409384E0
2024-08-19T23:53:18.437Z,1724111598.437 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 4760
2024-08-19T23:53:18.439Z,1724111598.439 [LcmUniversalReporter] Loaded
2024-08-19T23:53:18.440Z,1724111598.440 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread.
2024-08-19T23:53:19.265Z,1724111599.265 [BPC1] Loaded
2024-08-19T23:53:19.265Z,1724111599.265 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2024-08-19T23:53:19.353Z,1724111599.353 [DATMMP] Loaded
2024-08-19T23:53:19.353Z,1724111599.353 [ComponentRegistry](DEBUG): Component "DATMMP" handled in its own thread.
2024-08-19T23:53:19.354Z,1724111599.354 [DATMMP ThreadHandler](DEBUG): Created PCaller Thread at 409694E0
2024-08-19T23:53:19.355Z,1724111599.355 [DATMMP ThreadHandler](INFO): Protected caller Thread ID is 4761
2024-08-19T23:53:19.427Z,1724111599.427 [DataOverHttps] Loaded
2024-08-19T23:53:19.427Z,1724111599.427 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2024-08-19T23:53:19.428Z,1724111599.428 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 409994E0
2024-08-19T23:53:19.428Z,1724111599.428 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 4762
2024-08-19T23:53:19.451Z,1724111599.451 [Depth_Keller] Loaded
2024-08-19T23:53:19.452Z,1724111599.452 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2024-08-19T23:53:19.492Z,1724111599.492 [DVL_micro] Loaded
2024-08-19T23:53:19.493Z,1724111599.493 [ComponentRegistry](DEBUG): SyncComponent "DVL_micro" handled in the control thread.
2024-08-19T23:53:19.557Z,1724111599.557 [NAL9602] Loaded
2024-08-19T23:53:19.558Z,1724111599.558 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2024-08-19T23:53:19.587Z,1724111599.587 [Onboard] Loaded
2024-08-19T23:53:19.588Z,1724111599.588 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread.
2024-08-19T23:53:19.589Z,1724111599.589 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 409C94E0
2024-08-19T23:53:19.589Z,1724111599.589 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 4763
2024-08-19T23:53:19.603Z,1724111599.603 [Power24vConverter] Loaded
2024-08-19T23:53:19.603Z,1724111599.603 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread.
2024-08-19T23:53:19.619Z,1724111599.619 [Radio_Surface] Loaded
2024-08-19T23:53:19.619Z,1724111599.619 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2024-08-19T23:53:19.620Z,1724111599.620 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 409F94E0
2024-08-19T23:53:19.621Z,1724111599.621 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 4764
2024-08-19T23:53:19.636Z,1724111599.636 [Sonardyne_Nano] Loaded
2024-08-19T23:53:19.637Z,1724111599.637 [ComponentRegistry](DEBUG): SyncComponent "Sonardyne_Nano" handled in the control thread.
2024-08-19T23:53:19.637Z,1724111599.637 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2024-08-19T23:53:19.638Z,1724111599.638 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2024-08-19T23:53:19.768Z,1724111599.768 [BuoyancyServo] Loaded
2024-08-19T23:53:19.768Z,1724111599.768 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2024-08-19T23:53:19.790Z,1724111599.790 [MassServo] Loaded
2024-08-19T23:53:19.790Z,1724111599.790 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2024-08-19T23:53:19.811Z,1724111599.811 [RudderServo] Loaded
2024-08-19T23:53:19.811Z,1724111599.811 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2024-08-19T23:53:19.827Z,1724111599.827 [ThrusterHE] Loaded
2024-08-19T23:53:19.828Z,1724111599.828 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread.
2024-08-19T23:53:19.828Z,1724111599.828 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2024-08-19T23:53:19.828Z,1724111599.828 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2024-08-19T23:53:19.896Z,1724111599.896 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2024-08-19T23:53:19.897Z,1724111599.897 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2024-08-19T23:53:19.986Z,1724111599.986 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2024-08-19T23:53:19.987Z,1724111599.987 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2024-08-19T23:53:20.576Z,1724111600.576 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2024-08-19T23:53:20.576Z,1724111600.576 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2024-08-19T23:53:20.750Z,1724111600.750 [CTD_Seabird] Loaded
2024-08-19T23:53:20.750Z,1724111600.750 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread.
2024-08-19T23:53:20.751Z,1724111600.751 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40BB34E0
2024-08-19T23:53:20.752Z,1724111600.752 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 4765
2024-08-19T23:53:20.785Z,1724111600.785 [ESPComponent] Loaded
2024-08-19T23:53:20.785Z,1724111600.785 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread.
2024-08-19T23:53:20.807Z,1724111600.807 [PAR_Licor] Loaded
2024-08-19T23:53:20.807Z,1724111600.807 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2024-08-19T23:53:20.808Z,1724111600.808 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2024-08-19T23:53:20.809Z,1724111600.809 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2024-08-19T23:53:20.946Z,1724111600.946 [SBIT](DEBUG): Construct Startup Built In Test.
2024-08-19T23:53:20.955Z,1724111600.955 [SBIT] Loaded
2024-08-19T23:53:20.955Z,1724111600.955 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2024-08-19T23:53:20.958Z,1724111600.958 [IBIT](DEBUG): Construct Initiated Built In Test.
2024-08-19T23:53:20.971Z,1724111600.971 [IBIT] Loaded
2024-08-19T23:53:20.972Z,1724111600.972 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2024-08-19T23:53:20.977Z,1724111600.977 [CBIT](DEBUG): Construct Continuous Built In Test.
2024-08-19T23:53:21.084Z,1724111601.084 [CBIT] Loaded
2024-08-19T23:53:21.084Z,1724111601.084 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2024-08-19T23:53:21.084Z,1724111601.084 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2024-08-19T23:53:21.091Z,1724111601.091 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2024-08-19T23:53:21.093Z,1724111601.093 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2024-08-19T23:53:21.105Z,1724111601.105 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2024-08-19T23:53:21.106Z,1724111601.106 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40C224E0
2024-08-19T23:53:21.106Z,1724111601.106 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 4766
2024-08-19T23:53:21.111Z,1724111601.111 [Supervisor](INFO): Main Thread ID is 4670
2024-08-19T23:53:21.111Z,1724111601.111 [Supervisor](DEBUG): Running supervisor.
2024-08-19T23:53:21.111Z,1724111601.111 [CommandExec ThreadHandler](INFO): Handler Thread ID is 4767
2024-08-19T23:53:21.112Z,1724111601.112 [CommandExec](INFO): Initializing the command executive.
2024-08-19T23:53:21.113Z,1724111601.113 [CommandLine ThreadHandler](INFO): Handler Thread ID is 4768
2024-08-19T23:53:21.115Z,1724111601.115 [controlThread ThreadHandler](INFO): Handler Thread ID is 4769
2024-08-19T23:53:21.116Z,1724111601.116 [controlThread](DEBUG): Initializing ControlThread
2024-08-19T23:53:21.117Z,1724111601.117 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2024-08-19T23:53:21.117Z,1724111601.117 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2024-08-19T23:53:21.117Z,1724111601.117 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2024-08-19T23:53:21.118Z,1724111601.118 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2024-08-19T23:53:21.118Z,1724111601.118 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2024-08-19T23:53:21.119Z,1724111601.119 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2024-08-19T23:53:21.120Z,1724111601.120 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2024-08-19T23:53:21.121Z,1724111601.121 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2024-08-19T23:53:21.121Z,1724111601.121 [LoopControl](DEBUG): Initialize LoopControlComponent.
2024-08-19T23:53:21.122Z,1724111601.122 [NavChart](DEBUG): Initialize NavChart Navigation.
2024-08-19T23:53:21.123Z,1724111601.123 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2024-08-19T23:53:21.130Z,1724111601.130 [SBIT](INFO): Initialize SBIT Component.
2024-08-19T23:53:21.131Z,1724111601.131 [SBIT](IMPORTANT): git: 2024-08-12-95-g598b95f60
2024-08-19T23:53:21.131Z,1724111601.131 [SBIT](INFO): git hash: 598b95f6033d24136933a3d5d1ddac5d4570ac95
2024-08-19T23:53:21.131Z,1724111601.131 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2024-08-19T23:53:21.132Z,1724111601.132 [SBIT](INFO): Kernel Reporting Different Version From Configuration.
Kernel Expected: #1 PREEMPT Tue Sep 24 11:12:27 PDT 2019
Kernel Reported: #1 PREEMPT Wed Mar 17 08:23:48 PDT 2021
2024-08-19T23:53:21.133Z,1724111601.133 [SBIT](INFO): Beginning SBIT in 68.000000 seconds.
2024-08-19T23:53:21.134Z,1724111601.134 [IBIT](INFO): Initialize IBIT Component.
2024-08-19T23:53:21.135Z,1724111601.135 [CBIT](DEBUG): Initialize CBIT Component.
2024-08-19T23:53:21.136Z,1724111601.136 [logger ThreadHandler](INFO): Handler Thread ID is 4770
2024-08-19T23:53:21.146Z,1724111601.146 [CBIT](DEBUG): Initialized mux pins.
2024-08-19T23:53:21.146Z,1724111601.146 [CBIT](DEBUG): Initializing the watchdog timer.
2024-08-19T23:53:21.154Z,1724111601.154 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 4771
2024-08-19T23:53:21.166Z,1724111601.166 [DATMMP ThreadHandler](INFO): Handler Thread ID is 4772
2024-08-19T23:53:21.167Z,1724111601.167 [DATMMP](INFO): Start
2024-08-19T23:53:21.167Z,1724111601.167 [DATMMP](INFO): Powering up
2024-08-19T23:53:21.167Z,1724111601.167 [DATMMP](DEBUG): Initializing DATMMP.
2024-08-19T23:53:21.170Z,1724111601.170 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2024-08-19T23:53:21.170Z,1724111601.170 [CBIT](DEBUG): Initializing heartbeat.
2024-08-19T23:53:21.172Z,1724111601.172 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 4774
2024-08-19T23:53:21.174Z,1724111601.174 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2024-08-19T23:53:21.183Z,1724111601.183 [Onboard ThreadHandler](INFO): Handler Thread ID is 4775
2024-08-19T23:53:21.212Z,1724111601.212 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 4776
2024-08-19T23:53:21.222Z,1724111601.222 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 4777
2024-08-19T23:53:21.223Z,1724111601.223 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2024-08-19T23:53:21.227Z,1724111601.227 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 4779
2024-08-19T23:53:21.231Z,1724111601.231 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/DK1NORSO.000
2024-08-19T23:53:21.232Z,1724111601.232 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from DK1NORSO.000
2024-08-19T23:53:21.232Z,1724111601.232 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/DK2NORS.000
2024-08-19T23:53:21.232Z,1724111601.232 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from DK2NORS.000
2024-08-19T23:53:21.232Z,1724111601.232 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/DK3HORRO.000
2024-08-19T23:53:21.232Z,1724111601.232 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from DK3HORRO.000
2024-08-19T23:53:21.242Z,1724111601.242 [CBIT](DEBUG): Deactivating GF circuits.
2024-08-19T23:53:21.242Z,1724111601.242 [CBIT](DEBUG): Deactivating emergency mode.
2024-08-19T23:53:21.282Z,1724111601.282 [CBIT](DEBUG): Backplane powered.
2024-08-19T23:53:21.283Z,1724111601.283 [MissionManager](IMPORTANT): Using TethysL tl-to-tx parser
2024-08-19T23:53:21.283Z,1724111601.283 [MissionManager](INFO): Loading Mission from file: Missions/Startup.tl
2024-08-19T23:53:21.284Z,1724111601.284 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Startup.tl
2024-08-19T23:53:21.286Z,1724111601.286 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Startup.tl
2024-08-19T23:53:21.334Z,1724111601.334 [MissionManager](DEBUG): TethyslAPI: Missions/Startup.tl translated into:
2024-08-19T23:53:21.339Z,1724111601.339 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2024-08-19T23:53:21.375Z,1724111601.375 [MissionManager](DEBUG):
# Copyright (c) 2024 MBARI
# MBARI Proprietary Information. Confidential. All Rights Reserved
# Unauthorized copying or distribution of this file via any medium is strictly
# prohibited.
#
# WARNING - This file contains information whose export is restricted by the
# Export Administration Act of 1979 (Title 50, U.S.C., App. 2401 et seq.), as
# amended. Violations of these export laws are subject to severe civil and/or
# criminal penalties.
mission Startup {
behavior Guidance:GoToSurface {
run in progression
}
aggregate StartupSatComms {
run in sequence
readDatum {
timeout duration=P1M
Universal:latitude_fix
}
readDatum {
timeout duration=P1M
Universal:platform_communications
}
}
}
2024-08-19T23:53:21.375Z,1724111601.375 [MissionManager](INFO): Loading Mission from file: Missions/Default.tl
2024-08-19T23:53:21.375Z,1724111601.375 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Default.tl
2024-08-19T23:53:21.382Z,1724111601.382 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Default.tl
2024-08-19T23:53:21.418Z,1724111601.418 [DATMMP](INFO): Starting
2024-08-19T23:53:21.614Z,1724111601.614 [Radio_Surface](INFO): Powering up
2024-08-19T23:53:21.670Z,1724111601.670 [DATMMP](INFO): Starting
2024-08-19T23:53:21.682Z,1724111601.682 [MissionManager](DEBUG): TethyslAPI: Missions/Default.tl translated into:
0
13
Burn on
Dropped weight due to communications timeout.
5
Default mission has been running for
Restarting logs and Default mission.
restart logs
2024-08-19T23:53:21.711Z,1724111601.711 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2024-08-19T23:53:21.712Z,1724111601.712 [Default:A.Wait](DEBUG): Construct Wait.
2024-08-19T23:53:21.714Z,1724111601.714 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2024-08-19T23:53:21.747Z,1724111601.747 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2024-08-19T23:53:21.749Z,1724111601.749 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2024-08-19T23:53:21.771Z,1724111601.771 [Default:E.Execute](DEBUG): Construct Execute.
2024-08-19T23:53:21.785Z,1724111601.785 [MissionManager](DEBUG):
# Copyright (c) 2024 MBARI
# MBARI Proprietary Information. Confidential. All Rights Reserved
# Unauthorized copying or distribution of this file via any medium is strictly
# prohibited.
#
# WARNING - This file contains information whose export is restricted by the
# Export Administration Act of 1979 (Title 50, U.S.C., App. 2401 et seq.), as
# amended. Violations of these export laws are subject to severe civil and/or
# criminal penalties.
mission Default {
arguments {
ElapsedSinceDefaultStarted = 0 minute
}
behavior Guidance:Wait {
"""
Wait a moment to see if the scheduler starts a new mission before
starting to actually run Default.
"""
run in sequence
set duration = 13 second
}
behavior Guidance:GoToSurface {
run in progression
}
aggregate CheckIn {
run in sequence repeat=288
readDatum id="Read_GPS" {
timeout duration=P5M
Universal:time_fix
}
readDatum id="Read_Iridium" {
timeout duration=P4H {
behavior Guidance:Execute {
run in sequence
set command = "Burn on"
}
syslog critical "Dropped weight due to communications timeout."
}
Universal:platform_communications
}
behavior Guidance:Wait {
run in sequence
set duration = 5 minute
}
assign in sequence ElapsedSinceDefaultStarted = elapsed ( Universal:mission_started )
syslog important "Default mission has been running for " + ElapsedSinceDefaultStarted~minute
}
syslog important "Restarting logs and Default mission."
behavior Guidance:Execute {
run in sequence
set command = "restart logs"
}
}
2024-08-19T23:53:21.798Z,1724111601.798 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,DVL_micro,NAL9602,Power24vConverter,Sonardyne_Nano,ESPComponent,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter,
2024-08-19T23:53:21.818Z,1724111601.818 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2024-08-19T23:53:21.891Z,1724111601.891 [Depth_Keller](ERROR): Pressure or depth reading out of range: 916.699524 decibar, 0.000000 m
2024-08-19T23:53:21.899Z,1724111601.899 [Power24vConverter](INFO): Powering up.
2024-08-19T23:53:21.900Z,1724111601.900 [Sonardyne_Nano](INFO): Initializing.
2024-08-19T23:53:21.922Z,1724111601.922 [DATMMP](INFO): Starting
2024-08-19T23:53:21.942Z,1724111601.942 [DepthRateCalculator](ERROR): Depth measurement is not active
2024-08-19T23:53:21.967Z,1724111601.967 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2024-08-19T23:53:21.974Z,1724111601.974 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2024-08-19T23:53:21.975Z,1724111601.975 [MassServo](DEBUG): Initializing EZServoServo.
2024-08-19T23:53:21.982Z,1724111601.982 [MassServo](DEBUG): Initializing MassServo.
2024-08-19T23:53:21.983Z,1724111601.983 [RudderServo](DEBUG): Initializing EZServoServo.
2024-08-19T23:53:21.990Z,1724111601.990 [RudderServo](DEBUG): Initializing RudderServo.
2024-08-19T23:53:21.991Z,1724111601.991 [ThrusterHE](DEBUG): Initializing EZServoServo.
2024-08-19T23:53:21.998Z,1724111601.998 [ThrusterHE](DEBUG): Initializing ThrusterHE.
2024-08-19T23:53:22.175Z,1724111602.175 [DATMMP](INFO): Starting
2024-08-19T23:53:22.426Z,1724111602.426 [DATMMP](INFO): Starting
2024-08-19T23:53:22.678Z,1724111602.678 [DATMMP](INFO): Starting
2024-08-19T23:53:22.930Z,1724111602.930 [DATMMP](INFO): Starting
2024-08-19T23:53:23.182Z,1724111603.182 [DATMMP](INFO): Starting
2024-08-19T23:53:23.434Z,1724111603.434 [DATMMP](INFO): Starting
2024-08-19T23:53:23.686Z,1724111603.686 [DATMMP](INFO): Starting
2024-08-19T23:53:23.938Z,1724111603.938 [DATMMP](INFO): Starting
2024-08-19T23:53:24.190Z,1724111604.190 [DATMMP](INFO): Starting
2024-08-19T23:53:24.442Z,1724111604.442 [DATMMP](INFO): Starting
2024-08-19T23:53:24.695Z,1724111604.695 [DATMMP](INFO): Starting
2024-08-19T23:53:24.946Z,1724111604.946 [DATMMP](INFO): Starting
2024-08-19T23:53:25.198Z,1724111605.198 [DATMMP](INFO): Starting
2024-08-19T23:53:25.362Z,1724111605.362 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2024-08-19T23:53:25.450Z,1724111605.450 [DATMMP](INFO): Starting
2024-08-19T23:53:25.702Z,1724111605.702 [DATMMP](INFO): Starting
2024-08-19T23:53:25.770Z,1724111605.770 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2024-08-19T23:53:25.954Z,1724111605.954 [DATMMP](INFO): Starting
2024-08-19T23:53:26.207Z,1724111606.207 [DATMMP](INFO): Starting
2024-08-19T23:53:26.274Z,1724111606.274 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2024-08-19T23:53:26.458Z,1724111606.458 [DATMMP](INFO): Starting
2024-08-19T23:53:26.698Z,1724111606.698 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2024-08-19T23:53:26.710Z,1724111606.710 [DATMMP](INFO): Starting
2024-08-19T23:53:26.963Z,1724111606.963 [DATMMP](INFO): Starting
2024-08-19T23:53:27.214Z,1724111607.214 [DATMMP](INFO): Starting
2024-08-19T23:53:27.242Z,1724111607.242 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2024-08-19T23:53:27.466Z,1724111607.466 [DATMMP](INFO): Starting
2024-08-19T23:53:27.710Z,1724111607.710 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2024-08-19T23:53:27.720Z,1724111607.720 [DATMMP](INFO): Starting
2024-08-19T23:53:27.970Z,1724111607.970 [DATMMP](INFO): Starting
2024-08-19T23:53:28.222Z,1724111608.222 [DATMMP](INFO): Starting
2024-08-19T23:53:28.306Z,1724111608.306 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2024-08-19T23:53:28.474Z,1724111608.474 [DATMMP](INFO): Starting
2024-08-19T23:53:28.726Z,1724111608.726 [DATMMP](INFO): Starting
2024-08-19T23:53:28.834Z,1724111608.834 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2024-08-19T23:53:28.979Z,1724111608.979 [DATMMP](INFO): Starting
2024-08-19T23:53:29.230Z,1724111609.230 [DATMMP](INFO): Starting
2024-08-19T23:53:29.274Z,1724111609.274 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2024-08-19T23:53:29.482Z,1724111609.482 [DATMMP](INFO): Starting
2024-08-19T23:53:29.726Z,1724111609.726 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2024-08-19T23:53:29.734Z,1724111609.734 [DATMMP](INFO): Starting
2024-08-19T23:53:29.986Z,1724111609.986 [DATMMP](INFO): Starting
2024-08-19T23:53:30.186Z,1724111610.186 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2024-08-19T23:53:30.238Z,1724111610.238 [DATMMP](INFO): Starting
2024-08-19T23:53:30.490Z,1724111610.490 [DATMMP](INFO): Starting
2024-08-19T23:53:30.614Z,1724111610.614 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2024-08-19T23:53:30.743Z,1724111610.743 [DATMMP](INFO): Starting
2024-08-19T23:53:30.994Z,1724111610.994 [DATMMP](INFO): Starting
2024-08-19T23:53:31.034Z,1724111611.034 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2024-08-19T23:53:31.246Z,1724111611.246 [DATMMP](INFO): Starting
2024-08-19T23:53:31.466Z,1724111611.466 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2024-08-19T23:53:31.498Z,1724111611.498 [DATMMP](INFO): Starting
2024-08-19T23:53:31.750Z,1724111611.750 [DATMMP](INFO): Starting
2024-08-19T23:53:31.898Z,1724111611.898 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2024-08-19T23:53:32.002Z,1724111612.002 [DATMMP](INFO): Starting
2024-08-19T23:53:32.254Z,1724111612.254 [DATMMP](INFO): Starting
2024-08-19T23:53:32.338Z,1724111612.338 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2024-08-19T23:53:32.506Z,1724111612.506 [DATMMP](INFO): Starting
2024-08-19T23:53:32.758Z,1724111612.758 [DATMMP](INFO): Starting
2024-08-19T23:53:32.790Z,1724111612.790 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2024-08-19T23:53:33.010Z,1724111613.010 [DATMMP](INFO): Starting
2024-08-19T23:53:33.218Z,1724111613.218 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2024-08-19T23:53:33.262Z,1724111613.262 [DATMMP](INFO): Starting
2024-08-19T23:53:33.262Z,1724111613.262 [DATMMP](INFO): DAT read:
2024-08-19T23:53:33.263Z,1724111613.263 [DATMMP](INFO): DAT read: Teledyne Benthos DAT-900 Series
2024-08-19T23:53:33.514Z,1724111613.514 [DATMMP](INFO): Starting
2024-08-19T23:53:33.654Z,1724111613.654 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2024-08-19T23:53:33.766Z,1724111613.766 [DATMMP](INFO): Starting
2024-08-19T23:53:34.018Z,1724111614.018 [DATMMP](INFO): Starting
2024-08-19T23:53:34.086Z,1724111614.086 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2024-08-19T23:53:34.270Z,1724111614.270 [DATMMP](INFO): Starting
2024-08-19T23:53:34.274Z,1724111614.274 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2024-08-19T23:53:34.274Z,1724111614.274 [CTD_Seabird] Communications Fault, FailCount= 1
2024-08-19T23:53:34.274Z,1724111614.274 [CTD_Seabird](ERROR): Communications Fault
2024-08-19T23:53:34.506Z,1724111614.506 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2024-08-19T23:53:34.522Z,1724111614.522 [DATMMP](INFO): Starting
2024-08-19T23:53:34.595Z,1724111614.595 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2024-08-19T23:53:34.679Z,1724111614.679 [CTD_Seabird](INFO): Powering down
2024-08-19T23:53:34.774Z,1724111614.774 [DATMMP](INFO): Starting
2024-08-19T23:53:34.775Z,1724111614.775 [DATMMP](INFO): DAT read: MF Frequency Band
2024-08-19T23:53:34.776Z,1724111614.776 [DATMMP](INFO): DAT read: Directional Acoustic Transponder version 8.15.0
2024-08-19T23:53:34.776Z,1724111614.776 [DATMMP](INFO): DAT read: Jul 19 2000 23:53:29
2024-08-19T23:53:34.926Z,1724111614.926 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2024-08-19T23:53:34.926Z,1724111614.926 [AHRS_M2](FAULT): Failed to initialize within timeout.
2024-08-19T23:53:34.926Z,1724111614.926 [AHRS_M2] Communications Fault, FailCount= 1
2024-08-19T23:53:34.926Z,1724111614.926 [AHRS_M2](ERROR): Communications Fault
2024-08-19T23:53:35.010Z,1724111615.010 [CBIT](ERROR): Communications Fault in component: AHRS_M2
2024-08-19T23:53:35.017Z,1724111615.017 [AHRS_M2](INFO): Powering down
2024-08-19T23:53:35.026Z,1724111615.026 [DATMMP](INFO): Starting
2024-08-19T23:53:35.278Z,1724111615.278 [DATMMP](INFO): Starting
2024-08-19T23:53:35.530Z,1724111615.530 [DATMMP](INFO): Starting
2024-08-19T23:53:35.782Z,1724111615.782 [DATMMP](INFO): Starting
2024-08-19T23:53:35.919Z,1724111615.919 [CBIT](INFO): Clearing failed state for component AHRS_M2
2024-08-19T23:53:35.919Z,1724111615.919 [AHRS_M2] No Fault, FailCount= 1
2024-08-19T23:53:35.919Z,1724111615.919 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2024-08-19T23:53:35.919Z,1724111615.919 [CTD_Seabird] No Fault, FailCount= 1
2024-08-19T23:53:36.022Z,1724111616.022 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2024-08-19T23:53:36.034Z,1724111616.034 [DATMMP](INFO): Starting
2024-08-19T23:53:36.035Z,1724111616.035 [DATMMP](INFO): DAT read: Features enabled [Bearing]
2024-08-19T23:53:36.036Z,1724111616.036 [DATMMP](INFO): DAT read: CONNECT 00800 bits/sec 1 of 4, Rate 1/2 CC 12.50ms MGP
2024-08-19T23:53:36.036Z,1724111616.036 [DATMMP](INFO): commRate: 800
2024-08-19T23:53:36.227Z,1724111616.227 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2024-08-19T23:53:36.286Z,1724111616.286 [DATMMP](INFO): Starting
2024-08-19T23:53:36.538Z,1724111616.538 [DATMMP](INFO): Starting
2024-08-19T23:53:36.790Z,1724111616.790 [DATMMP](INFO): Starting
2024-08-19T23:53:37.042Z,1724111617.042 [DATMMP](INFO): Starting
2024-08-19T23:53:37.294Z,1724111617.294 [DATMMP](INFO): Starting
2024-08-19T23:53:37.546Z,1724111617.546 [DATMMP](INFO): Starting
2024-08-19T23:53:37.798Z,1724111617.798 [DATMMP](INFO): Starting
2024-08-19T23:53:38.050Z,1724111618.050 [DATMMP](INFO): Starting
2024-08-19T23:53:38.102Z,1724111618.102 [DATMMP](INFO): entering command mode
2024-08-19T23:53:38.302Z,1724111618.302 [DATMMP](INFO): Starting
2024-08-19T23:53:38.302Z,1724111618.302 [DATMMP](INFO): DAT read:
2024-08-19T23:53:38.303Z,1724111618.303 [DATMMP](INFO): DAT read: user:1>
2024-08-19T23:53:38.303Z,1724111618.303 [DATMMP](DEBUG): read user prompt 1: user:1>
2024-08-19T23:53:38.303Z,1724111618.303 [DATMMP](INFO): entering MMP mode
2024-08-19T23:53:38.554Z,1724111618.554 [DATMMP](INFO): Starting
2024-08-19T23:53:38.555Z,1724111618.555 [DATMMP](INFO): GSXN notify for xid: 0
2024-08-19T23:53:38.556Z,1724111618.556 [DATMMP](INFO): status rx: x1
2024-08-19T23:53:38.557Z,1724111618.557 [DATMMP](INFO): MMP status: 1: started
2024-08-19T23:53:38.557Z,1724111618.557 [DATMMP](INFO): Received message type: status
2024-08-19T23:53:38.557Z,1724111618.557 [DATMMP](INFO): Handled
2024-08-19T23:53:38.806Z,1724111618.806 [DATMMP](INFO): Starting
2024-08-19T23:53:38.807Z,1724111618.807 [DATMMP](INFO): Sent Tx Power Config 8
2024-08-19T23:53:38.807Z,1724111618.807 [DATMMP](INFO): Setting local address: 11
2024-08-19T23:53:38.809Z,1724111618.809 [DATMMP](INFO): Setting time to: 23:53:38 And date to:8/19/2024
2024-08-19T23:53:39.058Z,1724111619.058 [DATMMP](INFO): Starting
2024-08-19T23:53:39.059Z,1724111619.059 [DATMMP](INFO): GSXN notify for xid: 0
2024-08-19T23:53:39.059Z,1724111619.059 [DATMMP](INFO): mdmpower rx: x8 x0 x5 x0
2024-08-19T23:53:39.060Z,1724111619.060 [DATMMP](INFO): Received message type: mdmpower
2024-08-19T23:53:39.060Z,1724111619.060 [DATMMP](INFO): Handled
2024-08-19T23:53:39.310Z,1724111619.310 [DATMMP](INFO): Starting
2024-08-19T23:53:39.310Z,1724111619.310 [DATMMP](INFO): GSXN notify for xid: 10
2024-08-19T23:53:39.311Z,1724111619.311 [DATMMP](INFO): sreg_txpower rx: x8
2024-08-19T23:53:39.311Z,1724111619.311 [DATMMP](INFO): Received message type: sreg_txpower
2024-08-19T23:53:39.311Z,1724111619.311 [DATMMP](INFO): Match for : sreg_txpower
2024-08-19T23:53:39.311Z,1724111619.311 [DATMMP](INFO): ACK
2024-08-19T23:53:39.562Z,1724111619.562 [DATMMP](INFO): Starting
2024-08-19T23:53:39.562Z,1724111619.562 [DATMMP](INFO): GSXN notify for xid: 0
2024-08-19T23:53:39.563Z,1724111619.563 [DATMMP](INFO): mdmlocal rx: xB x0 x0 x0
2024-08-19T23:53:39.563Z,1724111619.563 [DATMMP](INFO): Received message type: mdmlocal
2024-08-19T23:53:39.563Z,1724111619.563 [DATMMP](INFO): Handled
2024-08-19T23:53:39.778Z,1724111619.778 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2024-08-19T23:53:39.787Z,1724111619.787 [DVL_micro](FAULT): Failed to initialize within timeout.
2024-08-19T23:53:39.787Z,1724111619.787 [DVL_micro] Communications Fault, FailCount= 1
2024-08-19T23:53:39.787Z,1724111619.787 [DVL_micro](ERROR): Communications Fault
2024-08-19T23:53:39.838Z,1724111619.838 [DATMMP](INFO): Starting
2024-08-19T23:53:39.838Z,1724111619.838 [DATMMP](INFO): GSXN notify for xid: 11
2024-08-19T23:53:39.839Z,1724111619.839 [DATMMP](INFO): sreg_locaddr rx: xB
2024-08-19T23:53:39.839Z,1724111619.839 [DATMMP](INFO): Received message type: sreg_locaddr
2024-08-19T23:53:39.839Z,1724111619.839 [DATMMP](INFO): Match for : sreg_locaddr
2024-08-19T23:53:39.839Z,1724111619.839 [DATMMP](INFO): ACK
2024-08-19T23:53:39.962Z,1724111619.962 [CBIT](ERROR): Communications Fault in component: DVL_micro
2024-08-19T23:53:40.090Z,1724111620.090 [DATMMP](INFO): Starting
2024-08-19T23:53:40.090Z,1724111620.090 [DATMMP](INFO): GSXN notify for xid: 12
2024-08-19T23:53:40.092Z,1724111620.092 [DATMMP](INFO): timedate rx: x0 x17 x35 x26 x7 x13 x7C x0
2024-08-19T23:53:40.092Z,1724111620.092 [DATMMP](INFO): Received message type: timedate
2024-08-19T23:53:40.092Z,1724111620.092 [DATMMP](INFO): Match for : timedate
2024-08-19T23:53:40.092Z,1724111620.092 [DATMMP](INFO): ACK
2024-08-19T23:53:40.290Z,1724111620.290 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2024-08-19T23:53:40.342Z,1724111620.342 [DATMMP](INFO): Starting
2024-08-19T23:53:40.342Z,1724111620.342 [DATMMP](INFO): GSXN notify for xid: 0
2024-08-19T23:53:40.343Z,1724111620.343 [DATMMP](INFO): sys_verb rx: x0 x0 x0 x0
2024-08-19T23:53:40.343Z,1724111620.343 [DATMMP](INFO): Received message type: sys_verb
2024-08-19T23:53:40.343Z,1724111620.343 [DATMMP](INFO): Handled
2024-08-19T23:53:40.389Z,1724111620.389 [DVL_micro](INFO): Powering down
2024-08-19T23:53:40.594Z,1724111620.594 [DATMMP](INFO): Starting
2024-08-19T23:53:40.594Z,1724111620.594 [DATMMP](INFO): GSXN notify for xid: 13
2024-08-19T23:53:40.595Z,1724111620.595 [DATMMP](INFO): sreg_verbosity rx: x0
2024-08-19T23:53:40.595Z,1724111620.595 [DATMMP](INFO): Received message type: sreg_verbosity
2024-08-19T23:53:40.595Z,1724111620.595 [DATMMP](INFO): Match for : sreg_verbosity
2024-08-19T23:53:40.595Z,1724111620.595 [DATMMP](INFO): ACK
2024-08-19T23:53:40.794Z,1724111620.794 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2024-08-19T23:53:40.854Z,1724111620.854 [DATMMP](INFO): Starting
2024-08-19T23:53:40.854Z,1724111620.854 [DATMMP](INFO): GSXN notify for xid: 14
2024-08-19T23:53:40.855Z,1724111620.855 [DATMMP](INFO): version rx: x2 x5
2024-08-19T23:53:40.855Z,1724111620.855 [DATMMP](INFO): DatMMPVersion: 2.5
2024-08-19T23:53:40.855Z,1724111620.855 [DATMMP](INFO): Received message type: version
2024-08-19T23:53:40.855Z,1724111620.855 [DATMMP](INFO): Match for : version
2024-08-19T23:53:40.855Z,1724111620.855 [DATMMP](INFO): ACK
2024-08-19T23:53:40.855Z,1724111620.855 [DATMMP](INFO): in MMP mode: config complete going to runnable
2024-08-19T23:53:41.198Z,1724111621.198 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2024-08-19T23:53:41.277Z,1724111621.277 [CBIT](INFO): Clearing failed state for component DVL_micro
2024-08-19T23:53:41.278Z,1724111621.278 [DVL_micro] No Fault, FailCount= 1
2024-08-19T23:53:41.610Z,1724111621.610 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2024-08-19T23:53:42.014Z,1724111622.014 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2024-08-19T23:53:42.418Z,1724111622.418 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2024-08-19T23:53:42.818Z,1724111622.818 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2024-08-19T23:53:43.294Z,1724111623.294 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2024-08-19T23:53:43.698Z,1724111623.698 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2024-08-19T23:53:44.102Z,1724111624.102 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2024-08-19T23:53:44.506Z,1724111624.506 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2024-08-19T23:53:44.906Z,1724111624.906 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2024-08-19T23:53:45.302Z,1724111625.302 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2024-08-19T23:53:45.718Z,1724111625.718 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2024-08-19T23:53:46.122Z,1724111626.122 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2024-08-19T23:53:46.518Z,1724111626.518 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2024-08-19T23:53:46.930Z,1724111626.930 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2024-08-19T23:53:47.326Z,1724111627.326 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2024-08-19T23:53:47.738Z,1724111627.738 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2024-08-19T23:53:48.142Z,1724111628.142 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2024-08-19T23:53:48.546Z,1724111628.546 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2024-08-19T23:53:48.946Z,1724111628.946 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2024-08-19T23:53:49.074Z,1724111629.074 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2024-08-19T23:53:49.074Z,1724111629.074 [CTD_Seabird] Communications Fault, FailCount= 2
2024-08-19T23:53:49.074Z,1724111629.074 [CTD_Seabird](ERROR): Communications Fault
2024-08-19T23:53:49.354Z,1724111629.354 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2024-08-19T23:53:49.354Z,1724111629.354 [AHRS_M2](FAULT): Failed to initialize within timeout.
2024-08-19T23:53:49.354Z,1724111629.354 [AHRS_M2] Communications Fault, FailCount= 2
2024-08-19T23:53:49.354Z,1724111629.354 [AHRS_M2](ERROR): Communications Fault
2024-08-19T23:53:49.399Z,1724111629.399 [CBIT](ERROR): Communications Fault in component: AHRS_M2
2024-08-19T23:53:49.399Z,1724111629.399 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2024-08-19T23:53:49.439Z,1724111629.439 [AHRS_M2](INFO): Powering down
2024-08-19T23:53:49.479Z,1724111629.479 [CTD_Seabird](INFO): Powering down
2024-08-19T23:53:49.851Z,1724111629.851 [NAL9602](INFO): Powering up NAL9602
2024-08-19T23:53:50.275Z,1724111630.275 [CBIT](INFO): Clearing failed state for component AHRS_M2
2024-08-19T23:53:50.275Z,1724111630.275 [AHRS_M2] No Fault, FailCount= 2
2024-08-19T23:53:50.651Z,1724111630.651 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2024-08-19T23:53:50.690Z,1724111630.690 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2024-08-19T23:53:50.690Z,1724111630.690 [CTD_Seabird] No Fault, FailCount= 2
2024-08-19T23:53:50.818Z,1724111630.818 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2024-08-19T23:53:53.958Z,1724111633.958 [DATMMP](INFO): GSXN notify for xid: 0
2024-08-19T23:53:53.959Z,1724111633.959 [DATMMP](INFO): timesync rx: x0 x1 x1 x0
2024-08-19T23:53:53.959Z,1724111633.959 [DATMMP](INFO): Received message type: timesync
2024-08-19T23:53:53.960Z,1724111633.960 [DATMMP](INFO): Handled
2024-08-19T23:53:54.202Z,1724111634.202 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2024-08-19T23:53:54.614Z,1724111634.614 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2024-08-19T23:53:55.018Z,1724111635.018 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2024-08-19T23:53:55.422Z,1724111635.422 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2024-08-19T23:53:55.814Z,1724111635.814 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2024-08-19T23:53:56.222Z,1724111636.222 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2024-08-19T23:53:56.619Z,1724111636.619 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2024-08-19T23:53:57.038Z,1724111637.038 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2024-08-19T23:53:57.438Z,1724111637.438 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2024-08-19T23:53:57.846Z,1724111637.846 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2024-08-19T23:53:58.246Z,1724111638.246 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2024-08-19T23:53:58.654Z,1724111638.654 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2024-08-19T23:53:59.054Z,1724111639.054 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2024-08-19T23:53:59.063Z,1724111639.063 [DVL_micro](FAULT): Failed to initialize within timeout.
2024-08-19T23:53:59.063Z,1724111639.063 [DVL_micro] Communications Fault, FailCount= 2
2024-08-19T23:53:59.063Z,1724111639.063 [DVL_micro](ERROR): Communications Fault
2024-08-19T23:53:59.082Z,1724111639.082 [CBIT](ERROR): Communications Fault in component: DVL_micro
2024-08-19T23:53:59.450Z,1724111639.450 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2024-08-19T23:53:59.546Z,1724111639.546 [DVL_micro](INFO): Powering down
2024-08-19T23:53:59.906Z,1724111639.906 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2024-08-19T23:54:00.298Z,1724111640.298 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2024-08-19T23:54:00.346Z,1724111640.346 [CBIT](INFO): Clearing failed state for component DVL_micro
2024-08-19T23:54:00.346Z,1724111640.346 [DVL_micro] No Fault, FailCount= 2
2024-08-19T23:54:00.702Z,1724111640.702 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2024-08-19T23:54:00.712Z,1724111640.713 [NAL9602](INFO): NAL9602 initialized
2024-08-19T23:54:01.110Z,1724111641.110 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2024-08-19T23:54:01.518Z,1724111641.518 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2024-08-19T23:54:01.906Z,1724111641.906 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2024-08-19T23:54:02.314Z,1724111642.314 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2024-08-19T23:54:02.726Z,1724111642.726 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2024-08-19T23:54:03.130Z,1724111643.130 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2024-08-19T23:54:03.534Z,1724111643.534 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2024-08-19T23:54:03.534Z,1724111643.534 [AHRS_M2](FAULT): Failed to initialize within timeout.
2024-08-19T23:54:03.534Z,1724111643.534 [AHRS_M2] Communications Fault, FailCount= 3
2024-08-19T23:54:03.534Z,1724111643.534 [AHRS_M2](ERROR): Communications Fault
2024-08-19T23:54:03.605Z,1724111643.605 [CBIT](ERROR): Communications Fault in component: AHRS_M2
2024-08-19T23:54:03.611Z,1724111643.611 [AHRS_M2](INFO): Powering down
2024-08-19T23:54:03.870Z,1724111643.870 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2024-08-19T23:54:03.870Z,1724111643.870 [CTD_Seabird] Communications Fault, FailCount= 3
2024-08-19T23:54:03.870Z,1724111643.870 [CTD_Seabird](ERROR): Communications Fault
2024-08-19T23:54:04.046Z,1724111644.046 [DATMMP](INFO): GSXN notify for xid: 0
2024-08-19T23:54:04.047Z,1724111644.047 [DATMMP](INFO): timesync rx: x1 x0 x1 x0
2024-08-19T23:54:04.047Z,1724111644.047 [DATMMP](INFO): Received message type: timesync
2024-08-19T23:54:04.048Z,1724111644.048 [DATMMP](INFO): Handled
2024-08-19T23:54:04.079Z,1724111644.079 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2024-08-19T23:54:04.079Z,1724111644.079 [CBIT](FAULT): Communications Fault in component: CTD_Seabird
2024-08-19T23:54:04.274Z,1724111644.274 [CTD_Seabird](INFO): Powering down
2024-08-19T23:54:04.446Z,1724111644.446 [CBIT](INFO): Clearing failed state for component AHRS_M2
2024-08-19T23:54:04.446Z,1724111644.446 [AHRS_M2] No Fault, FailCount= 3
2024-08-19T23:54:04.823Z,1724111644.823 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2024-08-19T23:54:08.382Z,1724111648.382 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2024-08-19T23:54:08.778Z,1724111648.778 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2024-08-19T23:54:09.190Z,1724111649.190 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2024-08-19T23:54:09.594Z,1724111649.594 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2024-08-19T23:54:10.006Z,1724111650.006 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2024-08-19T23:54:10.390Z,1724111650.390 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2024-08-19T23:54:10.798Z,1724111650.798 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2024-08-19T23:54:11.206Z,1724111651.206 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2024-08-19T23:54:11.606Z,1724111651.606 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2024-08-19T23:54:12.022Z,1724111652.022 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2024-08-19T23:54:12.422Z,1724111652.422 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2024-08-19T23:54:12.830Z,1724111652.830 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2024-08-19T23:54:13.234Z,1724111653.234 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2024-08-19T23:54:13.638Z,1724111653.638 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2024-08-19T23:54:14.038Z,1724111654.038 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2024-08-19T23:54:14.446Z,1724111654.446 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2024-08-19T23:54:14.854Z,1724111654.854 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2024-08-19T23:54:15.254Z,1724111655.254 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2024-08-19T23:54:15.658Z,1724111655.658 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2024-08-19T23:54:15.831Z,1724111655.831 [CommandExec](IMPORTANT): got command strobe off
2024-08-19T23:54:15.831Z,1724111655.831 [CommandExec](IMPORTANT): Deactivating strobe
2024-08-19T23:54:16.058Z,1724111656.058 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2024-08-19T23:54:16.454Z,1724111656.454 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2024-08-19T23:54:16.870Z,1724111656.870 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2024-08-19T23:54:17.262Z,1724111657.262 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2024-08-19T23:54:17.678Z,1724111657.678 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2024-08-19T23:54:17.678Z,1724111657.678 [AHRS_M2](FAULT): Failed to initialize within timeout.
2024-08-19T23:54:17.678Z,1724111657.678 [AHRS_M2] Communications Fault, FailCount= 4
2024-08-19T23:54:17.678Z,1724111657.678 [AHRS_M2](ERROR): Communications Fault
2024-08-19T23:54:17.724Z,1724111657.724 [CBIT](ERROR): Communications Fault in component: AHRS_M2
2024-08-19T23:54:17.755Z,1724111657.755 [AHRS_M2](INFO): Powering down
2024-08-19T23:54:18.572Z,1724111658.572 [DVL_micro](FAULT): Failed to initialize within timeout.
2024-08-19T23:54:18.572Z,1724111658.572 [DVL_micro] Communications Fault, FailCount= 3
2024-08-19T23:54:18.572Z,1724111658.572 [DVL_micro](ERROR): Communications Fault
2024-08-19T23:54:18.614Z,1724111658.614 [CBIT](INFO): Clearing failed state for component AHRS_M2
2024-08-19T23:54:18.614Z,1724111658.614 [AHRS_M2] No Fault, FailCount= 4
2024-08-19T23:54:18.614Z,1724111658.614 [CBIT](ERROR): Communications Fault in component: DVL_micro
2024-08-19T23:54:18.615Z,1724111658.615 [CBIT](CRITICAL): Communications Fault in component: DVL_micro
2024-08-19T23:54:18.967Z,1724111658.967 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2024-08-19T23:54:19.070Z,1724111659.070 [DVL_micro](INFO): Powering down
2024-08-19T23:54:19.116Z,1724111659.116 [CommandExec](FAULT): Scheduling is paused
2024-08-19T23:54:19.116Z,1724111659.116 [CBIT](INFO): Critical error at 20240819T235418
2024-08-19T23:54:19.116Z,1724111659.116 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals
2024-08-19T23:54:20.199Z,1724111660.199 [CommandExec](IMPORTANT): got command strobe on
2024-08-19T23:54:20.199Z,1724111660.199 [CommandExec](IMPORTANT): Activating strobe
2024-08-19T23:54:22.526Z,1724111662.526 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2024-08-19T23:54:22.926Z,1724111662.926 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2024-08-19T23:54:23.342Z,1724111663.342 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2024-08-19T23:54:23.746Z,1724111663.746 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2024-08-19T23:54:24.150Z,1724111664.150 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2024-08-19T23:54:24.550Z,1724111664.550 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2024-08-19T23:54:24.679Z,1724111664.679 [CommandExec](IMPORTANT): got command strobe off
2024-08-19T23:54:24.679Z,1724111664.679 [CommandExec](IMPORTANT): Deactivating strobe
2024-08-19T23:54:24.942Z,1724111664.942 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2024-08-19T23:54:25.362Z,1724111665.362 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2024-08-19T23:54:25.762Z,1724111665.762 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2024-08-19T23:54:26.166Z,1724111666.166 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2024-08-19T23:54:26.578Z,1724111666.578 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2024-08-19T23:54:26.998Z,1724111666.998 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2024-08-19T23:54:27.374Z,1724111667.374 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2024-08-19T23:54:27.774Z,1724111667.774 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2024-08-19T23:54:28.186Z,1724111668.186 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2024-08-19T23:54:28.590Z,1724111668.590 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2024-08-19T23:54:28.990Z,1724111668.990 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2024-08-19T23:54:29.390Z,1724111669.390 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2024-08-19T23:54:29.802Z,1724111669.802 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2024-08-19T23:54:29.845Z,1724111669.845 [SBIT](IMPORTANT): Beginning Startup BIT
2024-08-19T23:54:29.850Z,1724111669.850 [CBIT](IMPORTANT): Beginning ground fault scan
2024-08-19T23:54:30.218Z,1724111670.218 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2024-08-19T23:54:30.614Z,1724111670.614 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2024-08-19T23:54:31.006Z,1724111671.006 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2024-08-19T23:54:31.414Z,1724111671.414 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2024-08-19T23:54:31.898Z,1724111671.898 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2024-08-19T23:54:31.898Z,1724111671.898 [AHRS_M2](FAULT): Failed to initialize within timeout.
2024-08-19T23:54:31.898Z,1724111671.898 [AHRS_M2] Communications Fault, FailCount= 5
2024-08-19T23:54:31.898Z,1724111671.898 [AHRS_M2](ERROR): Communications Fault
2024-08-19T23:54:32.013Z,1724111672.013 [CBIT](ERROR): Communications Fault in component: AHRS_M2
2024-08-19T23:54:32.014Z,1724111672.014 [CBIT](CRITICAL): Communications Fault in component: AHRS_M2
2024-08-19T23:54:32.021Z,1724111672.021 [AHRS_M2](INFO): Powering down
2024-08-19T23:54:32.201Z,1724111672.201 [CBIT](INFO): Critical error at 20240819T235432
2024-08-19T23:54:34.376Z,1724111674.376 [CommandExec](IMPORTANT): got command quit
2024-08-19T23:54:35.378Z,1724111675.378 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread.
2024-08-19T23:54:35.378Z,1724111675.378 [CommandExec](INFO): Uninitializing the command executive.
2024-08-19T23:54:35.378Z,1724111675.378 [CommandExec](INFO): Uninitializing the command scheduler.
2024-08-19T23:54:35.378Z,1724111675.378 [CommandExec ThreadHandler](INFO): Thread cancelled.
2024-08-19T23:54:35.554Z,1724111675.554 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye!
2024-08-19T23:54:35.554Z,1724111675.554 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2024-08-19T23:54:35.554Z,1724111675.554 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2024-08-19T23:54:35.555Z,1724111675.555 [NavChartDb](INFO): Join timeout helper Thread ID is 4798
2024-08-19T23:54:35.622Z,1724111675.622 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2024-08-19T23:54:35.623Z,1724111675.623 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2024-08-19T23:54:35.626Z,1724111675.626 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler
2024-08-19T23:54:35.626Z,1724111675.626 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2024-08-19T23:54:35.626Z,1724111675.626 [CTD_Seabird](INFO): Join timeout helper Thread ID is 4799
2024-08-19T23:54:35.946Z,1724111675.946 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread.
2024-08-19T23:54:35.946Z,1724111675.946 [CTD_Seabird](INFO): Powering down
2024-08-19T23:54:35.958Z,1724111675.958 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2024-08-19T23:54:35.962Z,1724111675.962 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2024-08-19T23:54:35.962Z,1724111675.962 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2024-08-19T23:54:35.962Z,1724111675.962 [Radio_Surface](INFO): Join timeout helper Thread ID is 4800
2024-08-19T23:54:35.990Z,1724111675.990 [Radio_Surface](INFO): Powering down
2024-08-19T23:54:35.991Z,1724111675.991 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2024-08-19T23:54:35.991Z,1724111675.991 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2024-08-19T23:54:36.014Z,1724111676.014 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler
2024-08-19T23:54:36.014Z,1724111676.014 [Onboard ThreadHandler](INFO): Thread cancelled.
2024-08-19T23:54:36.014Z,1724111676.014 [Onboard](INFO): Join timeout helper Thread ID is 4801
2024-08-19T23:54:36.242Z,1724111676.242 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread.
2024-08-19T23:54:36.242Z,1724111676.242 [Onboard ThreadHandler](INFO): Thread cancelled.
2024-08-19T23:54:36.259Z,1724111676.259 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler
2024-08-19T23:54:36.259Z,1724111676.259 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2024-08-19T23:54:36.259Z,1724111676.259 [DataOverHttps](INFO): Join timeout helper Thread ID is 4802
2024-08-19T23:54:37.160Z,1724111677.160 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread.
2024-08-19T23:54:37.165Z,1724111677.165 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2024-08-19T23:54:37.183Z,1724111677.183 [ComponentRegistry](INFO): Shutting down DATMMP ThreadHandler
2024-08-19T23:54:37.183Z,1724111677.183 [DATMMP ThreadHandler](INFO): Thread cancelled.
2024-08-19T23:54:37.183Z,1724111677.183 [DATMMP](INFO): Join timeout helper Thread ID is 4803
2024-08-19T23:54:37.338Z,1724111677.338 [DATMMP](INFO): Stop
2024-08-19T23:54:37.338Z,1724111677.338 [DATMMP](INFO): uninitialize
2024-08-19T23:54:37.338Z,1724111677.338 [DATMMP](INFO): Powering down
2024-08-19T23:54:37.411Z,1724111677.411 [DATMMP ThreadHandler](INFO): Uninitializing protected caller thread.
2024-08-19T23:54:37.411Z,1724111677.411 [DATMMP](INFO): uninitialize
2024-08-19T23:54:37.411Z,1724111677.411 [DATMMP](INFO): Powering down
2024-08-19T23:54:37.412Z,1724111677.412 [DATMMP ThreadHandler](INFO): Thread cancelled.
2024-08-19T23:54:37.431Z,1724111677.431 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler
2024-08-19T23:54:37.431Z,1724111677.431 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2024-08-19T23:54:37.431Z,1724111677.431 [BackseatComponent](INFO): Join timeout helper Thread ID is 4804
2024-08-19T23:54:37.538Z,1724111677.538 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread.
2024-08-19T23:54:37.539Z,1724111677.539 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2024-08-19T23:54:37.552Z,1724111677.552 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2024-08-19T23:54:37.552Z,1724111677.552 [logger ThreadHandler](INFO): Thread cancelled.
2024-08-19T23:54:37.553Z,1724111677.553 [logger](INFO): Join timeout helper Thread ID is 4805
2024-08-19T23:54:37.553Z,1724111677.553 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2024-08-19T23:54:37.553Z,1724111677.553 [logger ThreadHandler](INFO): Thread cancelled.
2024-08-19T23:54:37.559Z,1724111677.559 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2024-08-19T23:54:37.559Z,1724111677.559 [CommandLine ThreadHandler](INFO): Thread cancelled.
2024-08-19T23:54:37.559Z,1724111677.559 [CommandLine](INFO): Join timeout helper Thread ID is 4806
2024-08-19T23:54:37.578Z,1724111677.578 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2024-08-19T23:54:37.578Z,1724111677.578 [CommandLine ThreadHandler](INFO): Thread cancelled.
2024-08-19T23:54:37.599Z,1724111677.599 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler
2024-08-19T23:54:37.599Z,1724111677.599 [CommandExec ThreadHandler](INFO): Thread cancelled.
2024-08-19T23:54:37.599Z,1724111677.599 [CommandExec](INFO): Join timeout helper Thread ID is 4807
2024-08-19T23:54:37.600Z,1724111677.600 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2024-08-19T23:54:37.600Z,1724111677.600 [controlThread ThreadHandler](INFO): Thread cancelled.
2024-08-19T23:54:37.601Z,1724111677.601 [controlThread](INFO): Join timeout helper Thread ID is 4808
2024-08-19T23:54:37.670Z,1724111677.670 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2024-08-19T23:54:37.670Z,1724111677.670 [controlThread](DEBUG): Uninitializing ControlThread
2024-08-19T23:54:37.671Z,1724111677.671 [AHRS_M2](INFO): Powering down
2024-08-19T23:54:37.672Z,1724111677.672 [DVL_micro](INFO): Powering down
2024-08-19T23:54:37.673Z,1724111677.673 [NAL9602](INFO): Powering down
2024-08-19T23:54:37.675Z,1724111677.675 [Sonardyne_Nano](INFO): Powering down
2024-08-19T23:54:37.795Z,1724111677.795 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2024-08-19T23:54:37.796Z,1724111677.796 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2024-08-19T23:54:37.796Z,1724111677.796 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2024-08-19T23:54:37.797Z,1724111677.797 [MissionManager](INFO): Uninitializing Mission Default
2024-08-19T23:54:37.799Z,1724111677.799 [MissionManager](INFO): Uninitializing Mission Startup
2024-08-19T23:54:37.801Z,1724111677.801 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2024-08-19T23:54:37.801Z,1724111677.801 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2024-08-19T23:54:37.801Z,1724111677.801 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2024-08-19T23:54:37.801Z,1724111677.801 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2024-08-19T23:54:37.802Z,1724111677.802 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2024-08-19T23:54:37.802Z,1724111677.802 [BuoyancyServo](INFO): Powering down
2024-08-19T23:54:37.814Z,1724111677.814 [MassServo](DEBUG): Uninitialize Mass Servo.
2024-08-19T23:54:37.814Z,1724111677.814 [MassServo](INFO): Powering down
2024-08-19T23:54:37.815Z,1724111677.815 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2024-08-19T23:54:37.815Z,1724111677.815 [RudderServo](INFO): Powering down
2024-08-19T23:54:37.816Z,1724111677.816 [ThrusterHE](DEBUG): Uninitialize Thruster Servo.
2024-08-19T23:54:37.816Z,1724111677.816 [ThrusterHE](INFO): Powering down
2024-08-19T23:54:37.817Z,1724111677.817 [SBIT](DEBUG): Uninitialize SBIT Component.
2024-08-19T23:54:37.817Z,1724111677.817 [IBIT](DEBUG): Uninitialize IBIT Component.
2024-08-19T23:54:37.817Z,1724111677.817 [CBIT](DEBUG): Uninitialize CBIT Component.
2024-08-19T23:54:37.817Z,1724111677.817 [CBIT](DEBUG): Powering off loads.
2024-08-19T23:54:37.830Z,1724111677.830 [CBIT](DEBUG): Disabling WDT.
2024-08-19T23:54:37.842Z,1724111677.842 [CBIT](DEBUG): Opening all GF detection circuits.
2024-08-19T23:54:37.843Z,1724111677.843 [controlThread ThreadHandler](INFO): Thread cancelled.
2024-08-19T23:54:37.896Z,1724111677.896 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2024-08-19T23:54:37.899Z,1724111677.899 [Onboard ThreadHandler](INFO): Thread cancelled.
2024-08-19T23:54:37.905Z,1724111677.905 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2024-08-19T23:54:37.912Z,1724111677.912 [DATMMP ThreadHandler](INFO): Thread cancelled.
2024-08-19T23:54:37.953Z,1724111677.953 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2024-08-19T23:54:38.125Z,1724111678.125 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2024-08-19T23:54:38.148Z,1724111678.148 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2024-08-19T23:54:38.210Z,1724111678.210 [logger ThreadHandler](INFO): Thread cancelled.