2022-11-15T17:52:51.300Z,1668534771.300 [Supervisor](DEBUG): Initializing supervisor.
2022-11-15T17:52:51.305Z,1668534771.305 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2022-11-15T17:52:51.306Z,1668534771.306 [SyncHandler](INFO): Protected caller Thread ID is 7769
2022-11-15T17:52:51.307Z,1668534771.307 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2022-11-15T17:52:51.308Z,1668534771.308 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2022-11-15T17:52:51.308Z,1668534771.308 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 7770
2022-11-15T17:52:51.313Z,1668534771.313 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2022-11-15T17:52:51.331Z,1668534771.331 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread.
2022-11-15T17:52:51.331Z,1668534771.331 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2022-11-15T17:52:51.332Z,1668534771.332 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 7771
2022-11-15T17:52:51.336Z,1668534771.336 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2022-11-15T17:52:51.337Z,1668534771.337 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2022-11-15T17:52:51.337Z,1668534771.337 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 7772
2022-11-15T17:52:51.339Z,1668534771.339 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2022-11-15T17:52:51.340Z,1668534771.340 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0
2022-11-15T17:52:51.341Z,1668534771.341 [logger ThreadHandler](INFO): Protected caller Thread ID is 7773
2022-11-15T17:52:51.344Z,1668534771.344 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2022-11-15T17:52:51.345Z,1668534771.345 [Supervisor](INFO): Looking for Config files in directory: Config/
2022-11-15T17:52:51.347Z,1668534771.347 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2022-11-15T17:52:51.615Z,1668534771.615 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2022-11-15T17:52:51.615Z,1668534771.615 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2022-11-15T17:52:51.720Z,1668534771.720 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2022-11-15T17:52:51.721Z,1668534771.721 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2022-11-15T17:52:51.815Z,1668534771.815 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2022-11-15T17:52:51.815Z,1668534771.815 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2022-11-15T17:52:52.252Z,1668534772.252 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2022-11-15T17:52:52.252Z,1668534772.252 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2022-11-15T17:52:52.595Z,1668534772.595 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2022-11-15T17:52:52.595Z,1668534772.595 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2022-11-15T17:52:52.928Z,1668534772.928 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2022-11-15T17:52:52.929Z,1668534772.929 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2022-11-15T17:52:53.112Z,1668534773.112 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2022-11-15T17:52:53.113Z,1668534773.113 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2022-11-15T17:52:53.191Z,1668534773.191 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2022-11-15T17:52:53.270Z,1668534773.270 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2022-11-15T17:52:53.683Z,1668534773.683 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2022-11-15T17:52:53.684Z,1668534773.684 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2022-11-15T17:52:54.101Z,1668534774.101 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2022-11-15T17:52:54.102Z,1668534774.102 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2022-11-15T17:52:54.598Z,1668534774.598 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2022-11-15T17:52:54.599Z,1668534774.599 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2022-11-15T17:52:54.811Z,1668534774.811 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2022-11-15T17:52:54.812Z,1668534774.812 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg
2022-11-15T17:52:55.048Z,1668534775.048 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock
2022-11-15T17:52:55.048Z,1668534775.048 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2022-11-15T17:52:55.186Z,1668534775.186 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2022-11-15T17:52:55.187Z,1668534775.187 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2022-11-15T17:52:55.939Z,1668534775.939 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2022-11-15T17:52:55.941Z,1668534775.941 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-galene/
2022-11-15T17:52:55.942Z,1668534775.942 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/secure.cfg
2022-11-15T17:52:56.025Z,1668534776.025 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/vehicle.cfg
2022-11-15T17:52:56.202Z,1668534776.202 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Battery.cfg
2022-11-15T17:52:56.466Z,1668534776.466 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2022-11-15T17:52:56.466Z,1668534776.466 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Science.cfg
2022-11-15T17:52:56.579Z,1668534776.579 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Control.cfg
2022-11-15T17:52:56.678Z,1668534776.678 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/logger.cfg
2022-11-15T17:52:56.769Z,1668534776.769 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Servo.cfg
2022-11-15T17:52:56.880Z,1668534776.880 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Navigation.cfg
2022-11-15T17:52:56.973Z,1668534776.973 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Simulator.cfg
2022-11-15T17:52:57.057Z,1668534777.057 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/BIT.cfg
2022-11-15T17:52:57.155Z,1668534777.155 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Sensor.cfg
2022-11-15T17:52:57.309Z,1668534777.309 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-galene/root/
2022-11-15T17:52:57.310Z,1668534777.310 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg
2022-11-15T17:52:57.311Z,1668534777.311 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2022-11-15T17:52:57.366Z,1668534777.366 [DepthRateCalculator] Loaded
2022-11-15T17:52:57.366Z,1668534777.366 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2022-11-15T17:52:57.371Z,1668534777.371 [PitchRateCalculator] Loaded
2022-11-15T17:52:57.372Z,1668534777.372 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2022-11-15T17:52:57.382Z,1668534777.382 [SpeedCalculator] Loaded
2022-11-15T17:52:57.382Z,1668534777.382 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2022-11-15T17:52:57.387Z,1668534777.387 [YawRateCalculator] Loaded
2022-11-15T17:52:57.387Z,1668534777.387 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2022-11-15T17:52:57.408Z,1668534777.408 [ElevatorOffsetCalculator] Loaded
2022-11-15T17:52:57.408Z,1668534777.408 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2022-11-15T17:52:57.409Z,1668534777.409 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2022-11-15T17:52:57.409Z,1668534777.409 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2022-11-15T17:52:57.437Z,1668534777.437 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2022-11-15T17:52:57.438Z,1668534777.438 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2022-11-15T17:52:57.448Z,1668534777.448 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2022-11-15T17:52:57.449Z,1668534777.449 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2022-11-15T17:52:57.904Z,1668534777.904 [AHRS_M2] Loaded
2022-11-15T17:52:57.905Z,1668534777.905 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread.
2022-11-15T17:52:57.939Z,1668534777.939 [BackseatComponent] Loaded
2022-11-15T17:52:57.939Z,1668534777.939 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread.
2022-11-15T17:52:57.941Z,1668534777.941 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 4083D4E0
2022-11-15T17:52:57.941Z,1668534777.941 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 7855
2022-11-15T17:52:57.944Z,1668534777.944 [LcmUniversalReporter] Loaded
2022-11-15T17:52:57.944Z,1668534777.944 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread.
2022-11-15T17:52:58.810Z,1668534778.810 [BPC1] Loaded
2022-11-15T17:52:58.810Z,1668534778.810 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2022-11-15T17:52:58.951Z,1668534778.951 [DataOverHttps] Loaded
2022-11-15T17:52:58.967Z,1668534778.967 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2022-11-15T17:52:58.968Z,1668534778.968 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 4086D4E0
2022-11-15T17:52:58.968Z,1668534778.968 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 7856
2022-11-15T17:52:59.024Z,1668534779.024 [Depth_Keller] Loaded
2022-11-15T17:52:59.024Z,1668534779.024 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2022-11-15T17:52:59.064Z,1668534779.064 [DropWeight] Loaded
2022-11-15T17:52:59.064Z,1668534779.064 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2022-11-15T17:52:59.083Z,1668534779.083 [MultiRay] Loaded
2022-11-15T17:52:59.083Z,1668534779.083 [ComponentRegistry](DEBUG): SyncComponent "MultiRay" handled in the control thread.
2022-11-15T17:52:59.270Z,1668534779.270 [NAL9602] Loaded
2022-11-15T17:52:59.270Z,1668534779.270 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2022-11-15T17:52:59.391Z,1668534779.391 [Onboard] Loaded
2022-11-15T17:52:59.391Z,1668534779.391 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread.
2022-11-15T17:52:59.392Z,1668534779.392 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 4089D4E0
2022-11-15T17:52:59.393Z,1668534779.393 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 7857
2022-11-15T17:52:59.399Z,1668534779.399 [PowerOnly](INFO): Adding load control power supply at /dev/loadC3
2022-11-15T17:52:59.409Z,1668534779.409 [PowerOnly] Loaded
2022-11-15T17:52:59.410Z,1668534779.410 [ComponentRegistry](DEBUG): SyncComponent "PowerOnly" handled in the control thread.
2022-11-15T17:52:59.421Z,1668534779.421 [Power24vConverter] Loaded
2022-11-15T17:52:59.421Z,1668534779.421 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread.
2022-11-15T17:52:59.435Z,1668534779.435 [Radio_Surface] Loaded
2022-11-15T17:52:59.436Z,1668534779.436 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2022-11-15T17:52:59.437Z,1668534779.437 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 408CD4E0
2022-11-15T17:52:59.437Z,1668534779.437 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 7858
2022-11-15T17:52:59.530Z,1668534779.530 [DAT] Loaded
2022-11-15T17:52:59.530Z,1668534779.530 [ComponentRegistry](DEBUG): Component "DAT" handled in its own thread.
2022-11-15T17:52:59.531Z,1668534779.531 [DAT ThreadHandler](DEBUG): Created PCaller Thread at 408FD4E0
2022-11-15T17:52:59.532Z,1668534779.532 [DAT ThreadHandler](INFO): Protected caller Thread ID is 7859
2022-11-15T17:52:59.532Z,1668534779.532 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2022-11-15T17:52:59.533Z,1668534779.533 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2022-11-15T17:52:59.647Z,1668534779.647 [DeadReckonUsingMultipleVelocitySources] Loaded
2022-11-15T17:52:59.647Z,1668534779.647 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2022-11-15T17:52:59.688Z,1668534779.688 [DeadReckonUsingSpeedCalculator] Loaded
2022-11-15T17:52:59.688Z,1668534779.688 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread.
2022-11-15T17:52:59.702Z,1668534779.702 [NavChart] Loaded
2022-11-15T17:52:59.702Z,1668534779.702 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2022-11-15T17:52:59.708Z,1668534779.708 [UniversalFixResidualReporter] Loaded
2022-11-15T17:52:59.708Z,1668534779.708 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2022-11-15T17:52:59.709Z,1668534779.709 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2022-11-15T17:52:59.709Z,1668534779.709 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2022-11-15T17:52:59.858Z,1668534779.858 [SBIT](DEBUG): Construct Startup Built In Test.
2022-11-15T17:52:59.872Z,1668534779.872 [SBIT] Loaded
2022-11-15T17:52:59.872Z,1668534779.872 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2022-11-15T17:52:59.875Z,1668534779.875 [IBIT](DEBUG): Construct Initiated Built In Test.
2022-11-15T17:52:59.888Z,1668534779.888 [IBIT] Loaded
2022-11-15T17:52:59.888Z,1668534779.888 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2022-11-15T17:52:59.894Z,1668534779.894 [CBIT](DEBUG): Construct Continuous Built In Test.
2022-11-15T17:52:59.994Z,1668534779.994 [CBIT] Loaded
2022-11-15T17:52:59.995Z,1668534779.995 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2022-11-15T17:52:59.995Z,1668534779.995 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2022-11-15T17:52:59.996Z,1668534779.996 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2022-11-15T17:53:00.175Z,1668534780.175 [CTD_Seabird] Loaded
2022-11-15T17:53:00.175Z,1668534780.175 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread.
2022-11-15T17:53:00.176Z,1668534780.176 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40A014E0
2022-11-15T17:53:00.177Z,1668534780.177 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 7860
2022-11-15T17:53:00.197Z,1668534780.197 [PAR_Licor] Loaded
2022-11-15T17:53:00.197Z,1668534780.197 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2022-11-15T17:53:00.227Z,1668534780.227 [WetLabsBB2FL] Loaded
2022-11-15T17:53:00.228Z,1668534780.228 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2022-11-15T17:53:00.229Z,1668534780.229 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40A314E0
2022-11-15T17:53:00.229Z,1668534780.229 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 7861
2022-11-15T17:53:00.230Z,1668534780.230 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2022-11-15T17:53:00.230Z,1668534780.230 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2022-11-15T17:53:00.363Z,1668534780.363 [BuoyancyServo] Loaded
2022-11-15T17:53:00.363Z,1668534780.363 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2022-11-15T17:53:00.384Z,1668534780.384 [ElevatorServo] Loaded
2022-11-15T17:53:00.385Z,1668534780.385 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2022-11-15T17:53:00.406Z,1668534780.406 [MassServo] Loaded
2022-11-15T17:53:00.406Z,1668534780.406 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2022-11-15T17:53:00.426Z,1668534780.426 [RudderServo] Loaded
2022-11-15T17:53:00.427Z,1668534780.427 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2022-11-15T17:53:00.442Z,1668534780.442 [ThrusterHE] Loaded
2022-11-15T17:53:00.443Z,1668534780.443 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread.
2022-11-15T17:53:00.443Z,1668534780.443 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2022-11-15T17:53:00.444Z,1668534780.444 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2022-11-15T17:53:00.499Z,1668534780.499 [VerticalControl](DEBUG): Construct VerticalControl.
2022-11-15T17:53:00.548Z,1668534780.548 [VerticalControl] Loaded
2022-11-15T17:53:00.549Z,1668534780.549 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2022-11-15T17:53:00.552Z,1668534780.552 [HorizontalControl](DEBUG): Construct HorizontalControl.
2022-11-15T17:53:00.588Z,1668534780.588 [HorizontalControl] Loaded
2022-11-15T17:53:00.589Z,1668534780.589 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2022-11-15T17:53:00.591Z,1668534780.591 [SpeedControl](DEBUG): Construct SpeedControl.
2022-11-15T17:53:00.593Z,1668534780.593 [SpeedControl] Loaded
2022-11-15T17:53:00.593Z,1668534780.593 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2022-11-15T17:53:00.596Z,1668534780.596 [LoopControl](DEBUG): Construct LoopControl.
2022-11-15T17:53:00.596Z,1668534780.596 [LoopControl] Loaded
2022-11-15T17:53:00.597Z,1668534780.597 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2022-11-15T17:53:00.597Z,1668534780.597 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2022-11-15T17:53:00.598Z,1668534780.598 [Module Loader](DEBUG): Loading Module at Modules/Dock.so
2022-11-15T17:53:00.697Z,1668534780.697 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking)
2022-11-15T17:53:00.697Z,1668534780.697 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2022-11-15T17:53:00.855Z,1668534780.855 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2022-11-15T17:53:00.856Z,1668534780.856 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2022-11-15T17:53:01.181Z,1668534781.181 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2022-11-15T17:53:01.182Z,1668534781.182 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2022-11-15T17:53:01.243Z,1668534781.243 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2022-11-15T17:53:01.249Z,1668534781.249 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2022-11-15T17:53:01.252Z,1668534781.252 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2022-11-15T17:53:01.264Z,1668534781.264 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2022-11-15T17:53:01.265Z,1668534781.265 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40BD34E0
2022-11-15T17:53:01.265Z,1668534781.265 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 7862
2022-11-15T17:53:01.270Z,1668534781.270 [Supervisor](INFO): Main Thread ID is 9034
2022-11-15T17:53:01.270Z,1668534781.270 [Supervisor](DEBUG): Running supervisor.
2022-11-15T17:53:01.270Z,1668534781.270 [CommandExec ThreadHandler](INFO): Handler Thread ID is 7863
2022-11-15T17:53:01.271Z,1668534781.271 [CommandExec](INFO): Initializing the command executive.
2022-11-15T17:53:01.273Z,1668534781.273 [CommandLine ThreadHandler](INFO): Handler Thread ID is 7864
2022-11-15T17:53:01.275Z,1668534781.275 [controlThread ThreadHandler](INFO): Handler Thread ID is 7865
2022-11-15T17:53:01.275Z,1668534781.275 [controlThread](DEBUG): Initializing ControlThread
2022-11-15T17:53:01.276Z,1668534781.276 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2022-11-15T17:53:01.276Z,1668534781.276 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2022-11-15T17:53:01.277Z,1668534781.277 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2022-11-15T17:53:01.277Z,1668534781.277 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2022-11-15T17:53:01.277Z,1668534781.277 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2022-11-15T17:53:01.285Z,1668534781.285 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2022-11-15T17:53:01.286Z,1668534781.286 [NavChart](DEBUG): Initialize NavChart Navigation.
2022-11-15T17:53:01.286Z,1668534781.286 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2022-11-15T17:53:01.286Z,1668534781.286 [SBIT](INFO): Initialize SBIT Component.
2022-11-15T17:53:01.287Z,1668534781.287 [SBIT](IMPORTANT): git: 2022-10-11-55-gab7960b4b
2022-11-15T17:53:01.287Z,1668534781.287 [SBIT](INFO): git hash: ab7960b4beddd477643728a638a431b52e5259f5
2022-11-15T17:53:01.287Z,1668534781.287 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2022-11-15T17:53:01.289Z,1668534781.289 [SBIT](INFO): Kernel Reporting Different Version From Configuration.
Kernel Expected: #2 PREEMPT Thu Jan 11 20:13:48 PST 2018
Kernel Reported: #1 PREEMPT Wed Mar 17 08:23:48 PDT 2021
2022-11-15T17:53:01.290Z,1668534781.290 [SBIT](INFO): Beginning SBIT in 28.000000 seconds.
2022-11-15T17:53:01.291Z,1668534781.291 [IBIT](INFO): Initialize IBIT Component.
2022-11-15T17:53:01.291Z,1668534781.291 [CBIT](DEBUG): Initialize CBIT Component.
2022-11-15T17:53:01.292Z,1668534781.292 [logger ThreadHandler](INFO): Handler Thread ID is 7866
2022-11-15T17:53:01.303Z,1668534781.303 [CBIT](DEBUG): Initialized mux pins.
2022-11-15T17:53:01.303Z,1668534781.303 [CBIT](DEBUG): Initializing the watchdog timer.
2022-11-15T17:53:01.311Z,1668534781.311 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 7867
2022-11-15T17:53:01.323Z,1668534781.323 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 7868
2022-11-15T17:53:01.324Z,1668534781.324 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2022-11-15T17:53:01.327Z,1668534781.327 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2022-11-15T17:53:01.327Z,1668534781.327 [CBIT](DEBUG): Initializing heartbeat.
2022-11-15T17:53:01.335Z,1668534781.335 [Onboard ThreadHandler](INFO): Handler Thread ID is 7869
2022-11-15T17:53:01.364Z,1668534781.364 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 7870
2022-11-15T17:53:01.376Z,1668534781.376 [DAT ThreadHandler](INFO): Handler Thread ID is 7871
2022-11-15T17:53:01.376Z,1668534781.376 [DAT](INFO): Powering up
2022-11-15T17:53:01.376Z,1668534781.376 [DAT](DEBUG): Initializing DAT.
2022-11-15T17:53:01.380Z,1668534781.380 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 7873
2022-11-15T17:53:01.381Z,1668534781.381 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2022-11-15T17:53:01.384Z,1668534781.384 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 7875
2022-11-15T17:53:01.387Z,1668534781.387 [WetLabsBB2FL](INFO): Powering up
2022-11-15T17:53:01.388Z,1668534781.388 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 7877
2022-11-15T17:53:01.396Z,1668534781.396 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2022-11-15T17:53:01.396Z,1668534781.396 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2022-11-15T17:53:01.396Z,1668534781.396 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2022-11-15T17:53:01.396Z,1668534781.396 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2022-11-15T17:53:01.397Z,1668534781.397 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2022-11-15T17:53:01.397Z,1668534781.397 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2022-11-15T17:53:01.397Z,1668534781.397 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2022-11-15T17:53:01.397Z,1668534781.397 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2022-11-15T17:53:01.399Z,1668534781.399 [CBIT](DEBUG): Deactivating GF circuits.
2022-11-15T17:53:01.399Z,1668534781.399 [CBIT](DEBUG): Deactivating emergency mode.
2022-11-15T17:53:01.435Z,1668534781.435 [CBIT](DEBUG): Backplane powered.
2022-11-15T17:53:01.440Z,1668534781.440 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2022-11-15T17:53:01.442Z,1668534781.442 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2022-11-15T17:53:01.443Z,1668534781.443 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2022-11-15T17:53:01.443Z,1668534781.443 [LoopControl](DEBUG): Initialize LoopControlComponent.
2022-11-15T17:53:01.444Z,1668534781.444 [MissionManager](INFO): Loading Mission from file: Missions/Startup.xml
2022-11-15T17:53:01.471Z,1668534781.471 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2022-11-15T17:53:01.491Z,1668534781.491 [MissionManager](DEBUG): 
<?xml version="1.0" encoding="UTF-8"?>
<Mission xmlns="Tethys"
       xmlns:Control="Tethys/Control"
       xmlns:Guidance="Tethys/Guidance" 
       xmlns:Units="Tethys/Units"
       xmlns:Universal="Tethys/Universal"
       xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"
       xsi:schemaLocation="Tethys http://okeanids.mbari.org/tethys/Xml/Tethys.xsd
                           Tethys/Control http://okeanids.mbari.org/tethys/Xml/Control.xsd
                           Tethys/Guidance http://okeanids.mbari.org/tethys/Xml/Guidance.xsd
                           Tethys/Units http://okeanids.mbari.org/tethys/Xml/Units.xsd
                           Tethys/Universal http://okeanids.mbari.org/tethys/Xml/Universal.xsd"
       Id="Startup">

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

    <Aggregate Id="StartupSatComms">

        <Sequence/>

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

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

    </Aggregate>

</Mission>


2022-11-15T17:53:01.491Z,1668534781.491 [MissionManager](INFO): Loading Mission from file: Missions/Default.xml
2022-11-15T17:53:01.549Z,1668534781.549 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2022-11-15T17:53:01.571Z,1668534781.571 [Default:A.Wait](DEBUG): Construct Wait.
2022-11-15T17:53:01.573Z,1668534781.573 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2022-11-15T17:53:01.592Z,1668534781.592 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2022-11-15T17:53:01.594Z,1668534781.594 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2022-11-15T17:53:01.619Z,1668534781.619 [Default:E.Execute](DEBUG): Construct Execute.
2022-11-15T17:53:01.639Z,1668534781.639 [MissionManager](DEBUG): 
<?xml version="1.0" encoding="UTF-8"?>
<Mission xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"
         xmlns="Tethys"
         xmlns:Units="Tethys/Units"
         xmlns:Guidance="Tethys/Guidance"
         xmlns:Universal="Tethys/Universal"
         xsi:schemaLocation="Tethys http://okeanids.mbari.org/tethys/Xml/Tethys.xsd
                             Tethys/Units http://okeanids.mbari.org/tethys/Xml/Units.xsd
                             Tethys/Guidance http://okeanids.mbari.org/tethys/Xml/Guidance.xsd
                             Tethys/Universal http://okeanids.mbari.org/tethys/Xml/Universal.xsd"
         Id="Default">

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

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

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

    <Aggregate Id="CheckIn">

        <Sequence Repeat="288"/>

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

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

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

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

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

    </Aggregate>

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

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

</Mission>


2022-11-15T17:53:01.657Z,1668534781.657 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,DropWeight,MultiRay,NAL9602,PowerOnly,Power24vConverter,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,DeadReckonUsingSpeedCalculator,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter,
2022-11-15T17:53:01.671Z,1668534781.671 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2022-11-15T17:53:01.733Z,1668534781.733 [MultiRay](INFO): Powering up MultiRay Lights
2022-11-15T17:53:01.767Z,1668534781.767 [Radio_Surface](INFO): Powering up
2022-11-15T17:53:01.772Z,1668534781.772 [Power24vConverter](INFO): Powering up.
2022-11-15T17:53:01.824Z,1668534781.824 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2022-11-15T17:53:01.831Z,1668534781.831 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2022-11-15T17:53:01.832Z,1668534781.832 [ElevatorServo](DEBUG): Initializing EZServoServo.
2022-11-15T17:53:01.839Z,1668534781.839 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2022-11-15T17:53:01.840Z,1668534781.840 [MassServo](DEBUG): Initializing EZServoServo.
2022-11-15T17:53:01.847Z,1668534781.847 [MassServo](DEBUG): Initializing MassServo.
2022-11-15T17:53:01.848Z,1668534781.848 [RudderServo](DEBUG): Initializing EZServoServo.
2022-11-15T17:53:01.855Z,1668534781.855 [RudderServo](DEBUG): Initializing RudderServo.
2022-11-15T17:53:01.856Z,1668534781.856 [ThrusterHE](DEBUG): Initializing EZServoServo.
2022-11-15T17:53:01.863Z,1668534781.863 [ThrusterHE](DEBUG): Initializing ThrusterHE.
2022-11-15T17:53:02.104Z,1668534782.104 [DropWeight](CRITICAL): DROP WEIGHT MISSING.

2022-11-15T17:53:02.104Z,1668534782.104 [DropWeight] Hardware Fault, FailCount= 1
2022-11-15T17:53:02.104Z,1668534782.104 [DropWeight](ERROR): Hardware Fault
2022-11-15T17:53:02.163Z,1668534782.163 [CommandExec](FAULT): Scheduling is paused
2022-11-15T17:53:02.164Z,1668534782.164 [CBIT](INFO): Critical error at 20221115T175302
2022-11-15T17:53:02.164Z,1668534782.164 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals
2022-11-15T17:53:02.166Z,1668534782.166 [CBIT](ERROR): Hardware Fault in component: DropWeight
2022-11-15T17:53:02.169Z,1668534782.169 [CBIT](CRITICAL): Hardware Fault in component: DropWeight
2022-11-15T17:53:02.839Z,1668534782.839 [RudderServo](ERROR): Rudder initialization uart error serial timeout
2022-11-15T17:53:02.839Z,1668534782.839 [RudderServo](FAULT): Rudder failed to initialize
2022-11-15T17:53:02.839Z,1668534782.839 [RudderServo] Communications Fault, FailCount= 1
2022-11-15T17:53:02.839Z,1668534782.839 [RudderServo](ERROR): Communications Fault
2022-11-15T17:53:02.841Z,1668534782.841 [CBIT](INFO): Critical error at 20221115T175302
2022-11-15T17:53:02.843Z,1668534782.843 [CBIT](ERROR): Communications Fault in component: RudderServo
2022-11-15T17:53:03.268Z,1668534783.268 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2022-11-15T17:53:03.268Z,1668534783.268 [RudderServo](INFO): Powering down
2022-11-15T17:53:03.735Z,1668534783.735 [RudderServo](DEBUG): Initializing EZServoServo.
2022-11-15T17:53:03.856Z,1668534783.856 [RudderServo](DEBUG): Initializing RudderServo.
2022-11-15T17:53:03.860Z,1668534783.860 [CBIT](INFO): Clearing failed state for component RudderServo
2022-11-15T17:53:03.860Z,1668534783.860 [RudderServo] No Fault, FailCount= 1
2022-11-15T17:53:05.227Z,1668534785.227 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-15T17:53:05.691Z,1668534785.691 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-15T17:53:06.095Z,1668534786.095 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-15T17:53:06.571Z,1668534786.571 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-15T17:53:06.675Z,1668534786.675 [WetLabsBB2FL] Communications Fault, FailCount= 1
2022-11-15T17:53:06.676Z,1668534786.676 [WetLabsBB2FL](ERROR): Communications Fault
2022-11-15T17:53:06.975Z,1668534786.975 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-15T17:53:07.102Z,1668534787.102 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL
2022-11-15T17:53:07.175Z,1668534787.175 [WetLabsBB2FL](INFO): Powering down
2022-11-15T17:53:07.423Z,1668534787.423 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-15T17:53:07.532Z,1668534787.532 [ThrusterHE](ERROR): Zero Speed Commanded.
2022-11-15T17:53:07.927Z,1668534787.927 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-15T17:53:08.219Z,1668534788.219 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL
2022-11-15T17:53:08.219Z,1668534788.219 [WetLabsBB2FL] No Fault, FailCount= 1
2022-11-15T17:53:08.388Z,1668534788.388 [WetLabsBB2FL](INFO): Powering up
2022-11-15T17:53:08.551Z,1668534788.551 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-15T17:53:08.819Z,1668534788.819 [MassServo](ERROR): getPosition uart error serial timeout
2022-11-15T17:53:08.819Z,1668534788.819 [MassServo](FAULT): Invalid EZ Servo response:"\n"
2022-11-15T17:53:08.819Z,1668534788.819 [MassServo] Communications Fault, FailCount= 1
2022-11-15T17:53:08.819Z,1668534788.819 [MassServo](ERROR): Communications Fault
2022-11-15T17:53:08.824Z,1668534788.824 [CBIT](ERROR): Communications Fault in component: MassServo
2022-11-15T17:53:09.155Z,1668534789.155 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-15T17:53:09.184Z,1668534789.184 [MassServo](DEBUG): Uninitialize Mass Servo.
2022-11-15T17:53:09.184Z,1668534789.184 [MassServo](INFO): Powering down
2022-11-15T17:53:09.555Z,1668534789.555 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-15T17:53:09.963Z,1668534789.963 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-15T17:53:09.990Z,1668534789.990 [MassServo](DEBUG): Initializing EZServoServo.
2022-11-15T17:53:10.108Z,1668534790.108 [MassServo](DEBUG): Initializing MassServo.
2022-11-15T17:53:10.112Z,1668534790.112 [CBIT](INFO): Clearing failed state for component MassServo
2022-11-15T17:53:10.112Z,1668534790.112 [MassServo] No Fault, FailCount= 1
2022-11-15T17:53:10.443Z,1668534790.443 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-15T17:53:10.843Z,1668534790.843 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-15T17:53:11.247Z,1668534791.247 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-15T17:53:11.647Z,1668534791.647 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-15T17:53:12.055Z,1668534792.055 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-15T17:53:12.451Z,1668534792.451 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-15T17:53:12.867Z,1668534792.867 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-15T17:53:13.267Z,1668534793.267 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-15T17:53:13.667Z,1668534793.667 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-15T17:53:13.679Z,1668534793.679 [WetLabsBB2FL] Communications Fault, FailCount= 2
2022-11-15T17:53:13.679Z,1668534793.679 [WetLabsBB2FL](ERROR): Communications Fault
2022-11-15T17:53:13.796Z,1668534793.796 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL
2022-11-15T17:53:14.119Z,1668534794.119 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-15T17:53:14.179Z,1668534794.179 [WetLabsBB2FL](INFO): Powering down
2022-11-15T17:53:14.431Z,1668534794.431 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2022-11-15T17:53:14.431Z,1668534794.431 [CTD_Seabird] Communications Fault, FailCount= 1
2022-11-15T17:53:14.431Z,1668534794.431 [CTD_Seabird](ERROR): Communications Fault
2022-11-15T17:53:14.535Z,1668534794.535 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-15T17:53:14.535Z,1668534794.535 [AHRS_M2](FAULT): Failed to initialize within timeout.
2022-11-15T17:53:14.535Z,1668534794.535 [AHRS_M2] Communications Fault, FailCount= 1
2022-11-15T17:53:14.535Z,1668534794.535 [AHRS_M2](ERROR): Communications Fault
2022-11-15T17:53:14.592Z,1668534794.592 [CBIT](ERROR): Communications Fault in component: AHRS_M2
2022-11-15T17:53:14.592Z,1668534794.592 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2022-11-15T17:53:14.607Z,1668534794.607 [AHRS_M2](INFO): Powering down
2022-11-15T17:53:14.836Z,1668534794.836 [CTD_Seabird](INFO): Powering down
2022-11-15T17:53:15.075Z,1668534795.075 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL
2022-11-15T17:53:15.075Z,1668534795.075 [WetLabsBB2FL] No Fault, FailCount= 2
2022-11-15T17:53:15.392Z,1668534795.392 [WetLabsBB2FL](INFO): Powering up
2022-11-15T17:53:15.467Z,1668534795.467 [CBIT](INFO): Clearing failed state for component AHRS_M2
2022-11-15T17:53:15.467Z,1668534795.467 [AHRS_M2] No Fault, FailCount= 1
2022-11-15T17:53:15.820Z,1668534795.820 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2022-11-15T17:53:15.886Z,1668534795.886 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2022-11-15T17:53:15.886Z,1668534795.886 [CTD_Seabird] No Fault, FailCount= 1
2022-11-15T17:53:16.009Z,1668534796.009 [DAT](INFO): commRate: 800
2022-11-15T17:53:16.179Z,1668534796.179 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2022-11-15T17:53:18.075Z,1668534798.075 [DAT](INFO): entering command mode
2022-11-15T17:53:18.275Z,1668534798.275 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:18.527Z,1668534798.527 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:18.779Z,1668534798.779 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:19.031Z,1668534799.031 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:19.283Z,1668534799.283 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:19.375Z,1668534799.375 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-15T17:53:19.535Z,1668534799.535 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:19.783Z,1668534799.783 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-15T17:53:19.791Z,1668534799.791 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:20.043Z,1668534800.043 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:20.183Z,1668534800.183 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-15T17:53:20.296Z,1668534800.296 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:20.547Z,1668534800.547 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:20.579Z,1668534800.579 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-15T17:53:20.683Z,1668534800.683 [WetLabsBB2FL] Communications Fault, FailCount= 3
2022-11-15T17:53:20.683Z,1668534800.683 [WetLabsBB2FL](ERROR): Communications Fault
2022-11-15T17:53:20.799Z,1668534800.799 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:20.987Z,1668534800.987 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-15T17:53:21.011Z,1668534801.011 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL
2022-11-15T17:53:21.051Z,1668534801.051 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:21.183Z,1668534801.183 [WetLabsBB2FL](INFO): Powering down
2022-11-15T17:53:21.303Z,1668534801.303 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:21.399Z,1668534801.399 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-15T17:53:21.555Z,1668534801.555 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:21.799Z,1668534801.799 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-15T17:53:21.807Z,1668534801.807 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:22.059Z,1668534802.059 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:22.195Z,1668534802.195 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-15T17:53:22.232Z,1668534802.232 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL
2022-11-15T17:53:22.232Z,1668534802.232 [WetLabsBB2FL] No Fault, FailCount= 3
2022-11-15T17:53:22.313Z,1668534802.313 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:22.433Z,1668534802.433 [WetLabsBB2FL](INFO): Powering up
2022-11-15T17:53:22.563Z,1668534802.563 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:22.619Z,1668534802.619 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-15T17:53:22.815Z,1668534802.815 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:23.019Z,1668534803.019 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-15T17:53:23.067Z,1668534803.067 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:23.319Z,1668534803.319 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:23.415Z,1668534803.415 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-15T17:53:23.572Z,1668534803.572 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:23.823Z,1668534803.823 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:23.823Z,1668534803.823 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-15T17:53:24.075Z,1668534804.075 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:24.223Z,1668534804.223 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-15T17:53:24.330Z,1668534804.330 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:24.579Z,1668534804.579 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:24.619Z,1668534804.619 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-15T17:53:24.831Z,1668534804.831 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:25.031Z,1668534805.031 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-15T17:53:25.087Z,1668534805.087 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:25.339Z,1668534805.339 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:25.427Z,1668534805.427 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-15T17:53:25.591Z,1668534805.591 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:25.839Z,1668534805.839 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-15T17:53:25.847Z,1668534805.847 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:26.099Z,1668534806.099 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:26.243Z,1668534806.243 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-15T17:53:26.353Z,1668534806.353 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:26.603Z,1668534806.603 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:26.640Z,1668534806.640 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-15T17:53:26.855Z,1668534806.855 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:27.051Z,1668534807.051 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-15T17:53:27.107Z,1668534807.107 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:27.359Z,1668534807.359 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:27.455Z,1668534807.455 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-15T17:53:27.611Z,1668534807.611 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:27.690Z,1668534807.690 [WetLabsBB2FL] Communications Fault, FailCount= 4
2022-11-15T17:53:27.691Z,1668534807.691 [WetLabsBB2FL](ERROR): Communications Fault
2022-11-15T17:53:27.863Z,1668534807.863 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-15T17:53:27.863Z,1668534807.863 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:27.887Z,1668534807.887 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL
2022-11-15T17:53:28.115Z,1668534808.115 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:28.191Z,1668534808.191 [WetLabsBB2FL](INFO): Powering down
2022-11-15T17:53:28.255Z,1668534808.255 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-15T17:53:28.369Z,1668534808.369 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:28.619Z,1668534808.619 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:28.659Z,1668534808.659 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-15T17:53:28.659Z,1668534808.659 [AHRS_M2](FAULT): Failed to initialize within timeout.
2022-11-15T17:53:28.659Z,1668534808.659 [AHRS_M2] Communications Fault, FailCount= 2
2022-11-15T17:53:28.659Z,1668534808.659 [AHRS_M2](ERROR): Communications Fault
2022-11-15T17:53:28.705Z,1668534808.705 [CBIT](ERROR): Communications Fault in component: AHRS_M2
2022-11-15T17:53:28.747Z,1668534808.747 [AHRS_M2](INFO): Powering down
2022-11-15T17:53:28.871Z,1668534808.871 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:29.123Z,1668534809.123 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:29.169Z,1668534809.169 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL
2022-11-15T17:53:29.169Z,1668534809.169 [WetLabsBB2FL] No Fault, FailCount= 4
2022-11-15T17:53:29.231Z,1668534809.231 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2022-11-15T17:53:29.231Z,1668534809.231 [CTD_Seabird] Communications Fault, FailCount= 2
2022-11-15T17:53:29.231Z,1668534809.231 [CTD_Seabird](ERROR): Communications Fault
2022-11-15T17:53:29.375Z,1668534809.375 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:29.404Z,1668534809.404 [WetLabsBB2FL](INFO): Powering up
2022-11-15T17:53:29.560Z,1668534809.560 [NAL9602](INFO): Powering up NAL9602
2022-11-15T17:53:29.591Z,1668534809.591 [CBIT](INFO): Clearing failed state for component AHRS_M2
2022-11-15T17:53:29.592Z,1668534809.592 [AHRS_M2] No Fault, FailCount= 2
2022-11-15T17:53:29.592Z,1668534809.592 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2022-11-15T17:53:29.627Z,1668534809.627 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:29.635Z,1668534809.635 [CTD_Seabird](INFO): Powering down
2022-11-15T17:53:29.879Z,1668534809.879 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:29.959Z,1668534809.959 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2022-11-15T17:53:29.993Z,1668534809.993 [SBIT](IMPORTANT): Beginning Startup BIT
2022-11-15T17:53:29.997Z,1668534809.997 [CBIT](IMPORTANT): Beginning ground fault scan
2022-11-15T17:53:30.131Z,1668534810.131 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:30.383Z,1668534810.383 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:30.635Z,1668534810.635 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:30.835Z,1668534810.835 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2022-11-15T17:53:30.835Z,1668534810.835 [CTD_Seabird] No Fault, FailCount= 2
2022-11-15T17:53:30.887Z,1668534810.887 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:30.979Z,1668534810.979 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2022-11-15T17:53:31.139Z,1668534811.139 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:31.391Z,1668534811.391 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:31.643Z,1668534811.643 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:31.895Z,1668534811.895 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:32.147Z,1668534812.147 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:32.399Z,1668534812.399 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:32.651Z,1668534812.651 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:32.903Z,1668534812.903 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:33.155Z,1668534813.155 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:33.155Z,1668534813.155 [DAT](FAULT): failed to enter command mode
2022-11-15T17:53:33.459Z,1668534813.459 [DAT](INFO): entering command mode
2022-11-15T17:53:33.511Z,1668534813.511 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-15T17:53:33.659Z,1668534813.659 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:33.911Z,1668534813.911 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:33.979Z,1668534813.979 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-15T17:53:34.164Z,1668534814.164 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:34.415Z,1668534814.415 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:34.603Z,1668534814.603 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-15T17:53:34.673Z,1668534814.673 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:34.699Z,1668534814.699 [WetLabsBB2FL] Communications Fault, FailCount= 5
2022-11-15T17:53:34.699Z,1668534814.699 [WetLabsBB2FL](ERROR): Communications Fault
2022-11-15T17:53:34.731Z,1668534814.731 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL
2022-11-15T17:53:34.732Z,1668534814.732 [CBIT](FAULT): Communications Fault in component: WetLabsBB2FL
2022-11-15T17:53:34.928Z,1668534814.928 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:35.079Z,1668534815.079 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-15T17:53:35.179Z,1668534815.179 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:35.195Z,1668534815.195 [WetLabsBB2FL](INFO): Powering down
2022-11-15T17:53:35.431Z,1668534815.431 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:35.591Z,1668534815.591 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-15T17:53:35.683Z,1668534815.683 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:35.935Z,1668534815.935 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:36.071Z,1668534816.071 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-15T17:53:36.187Z,1668534816.187 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:36.439Z,1668534816.439 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:36.467Z,1668534816.467 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-15T17:53:36.691Z,1668534816.691 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:36.883Z,1668534816.883 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-15T17:53:36.943Z,1668534816.943 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:37.195Z,1668534817.195 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:37.267Z,1668534817.267 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-15T17:53:37.447Z,1668534817.447 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:37.699Z,1668534817.699 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:37.731Z,1668534817.731 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-15T17:53:37.951Z,1668534817.951 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:38.143Z,1668534818.143 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-15T17:53:38.203Z,1668534818.203 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:38.455Z,1668534818.455 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:38.551Z,1668534818.551 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-15T17:53:38.720Z,1668534818.720 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:38.971Z,1668534818.971 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:39.007Z,1668534819.007 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-15T17:53:39.223Z,1668534819.223 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:39.407Z,1668534819.407 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-15T17:53:39.475Z,1668534819.475 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:39.727Z,1668534819.727 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:39.811Z,1668534819.811 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-15T17:53:39.981Z,1668534819.981 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:40.231Z,1668534820.231 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:40.283Z,1668534820.283 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-15T17:53:40.483Z,1668534820.483 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:40.699Z,1668534820.699 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-15T17:53:40.709Z,1668534820.709 [NAL9602](INFO): NAL9602 initialized
2022-11-15T17:53:40.735Z,1668534820.735 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:40.987Z,1668534820.987 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:41.107Z,1668534821.107 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-15T17:53:41.239Z,1668534821.239 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:41.491Z,1668534821.491 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:41.571Z,1668534821.571 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-15T17:53:41.670Z,1668534821.670 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): 0.012751
CHAN A1 (24V): 0.000764
CHAN A2 (12V): -0.005382
CHAN A3 (5V): -0.003058
CHAN B0 (3.3V): -0.001699
CHAN B1 (3.15aV): -0.001367
CHAN B2 (3.15bV): -0.001502
CHAN B3 (GND): -0.001043
OPEN: 0.004811
Full Scale: +/- 1 mA
2022-11-15T17:53:41.743Z,1668534821.743 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:41.995Z,1668534821.995 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:42.247Z,1668534822.247 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:42.403Z,1668534822.403 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2022-11-15T17:53:42.499Z,1668534822.499 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:42.751Z,1668534822.751 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:42.823Z,1668534822.823 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2022-11-15T17:53:42.823Z,1668534822.823 [AHRS_M2](FAULT): Failed to initialize within timeout.
2022-11-15T17:53:42.823Z,1668534822.823 [AHRS_M2] Communications Fault, FailCount= 3
2022-11-15T17:53:42.823Z,1668534822.823 [AHRS_M2](ERROR): Communications Fault
2022-11-15T17:53:42.967Z,1668534822.967 [CBIT](ERROR): Communications Fault in component: AHRS_M2
2022-11-15T17:53:42.974Z,1668534822.974 [AHRS_M2](INFO): Powering down
2022-11-15T17:53:43.003Z,1668534823.003 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:43.255Z,1668534823.255 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:43.507Z,1668534823.507 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:43.759Z,1668534823.759 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:43.823Z,1668534823.823 [CBIT](INFO): Clearing failed state for component AHRS_M2
2022-11-15T17:53:43.823Z,1668534823.823 [AHRS_M2] No Fault, FailCount= 3
2022-11-15T17:53:44.011Z,1668534824.011 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:44.031Z,1668534824.031 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2022-11-15T17:53:44.031Z,1668534824.031 [CTD_Seabird] Communications Fault, FailCount= 3
2022-11-15T17:53:44.031Z,1668534824.031 [CTD_Seabird](ERROR): Communications Fault
2022-11-15T17:53:44.183Z,1668534824.183 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2022-11-15T17:53:44.231Z,1668534824.231 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2022-11-15T17:53:44.232Z,1668534824.232 [CBIT](FAULT): Communications Fault in component: CTD_Seabird
2022-11-15T17:53:44.263Z,1668534824.263 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:44.435Z,1668534824.435 [CTD_Seabird](INFO): Powering down
2022-11-15T17:53:44.515Z,1668534824.515 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:44.767Z,1668534824.767 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:45.019Z,1668534825.019 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:45.271Z,1668534825.271 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:45.523Z,1668534825.523 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:45.775Z,1668534825.775 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:46.027Z,1668534826.027 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:46.279Z,1668534826.279 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:46.531Z,1668534826.531 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:46.783Z,1668534826.783 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:47.035Z,1668534827.035 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:47.287Z,1668534827.287 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:47.539Z,1668534827.539 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:47.739Z,1668534827.739 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2022-11-15T17:53:47.791Z,1668534827.791 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:48.043Z,1668534828.043 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:48.183Z,1668534828.183 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2022-11-15T17:53:48.295Z,1668534828.295 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:48.547Z,1668534828.547 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:48.547Z,1668534828.547 [DAT](FAULT): failed to enter command mode
2022-11-15T17:53:48.647Z,1668534828.647 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2022-11-15T17:53:48.851Z,1668534828.851 [DAT](INFO): entering command mode
2022-11-15T17:53:49.051Z,1668534829.051 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:49.127Z,1668534829.127 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2022-11-15T17:53:49.303Z,1668534829.303 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:49.555Z,1668534829.555 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:49.607Z,1668534829.607 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2022-11-15T17:53:49.807Z,1668534829.807 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:50.059Z,1668534830.059 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:50.063Z,1668534830.063 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2022-11-15T17:53:50.311Z,1668534830.311 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:50.527Z,1668534830.527 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2022-11-15T17:53:50.563Z,1668534830.563 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:50.815Z,1668534830.815 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:51.067Z,1668534831.067 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:51.076Z,1668534831.076 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2022-11-15T17:53:51.319Z,1668534831.319 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:51.571Z,1668534831.571 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:51.579Z,1668534831.579 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2022-11-15T17:53:51.823Z,1668534831.823 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:51.987Z,1668534831.987 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2022-11-15T17:53:52.075Z,1668534832.075 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:52.327Z,1668534832.327 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:52.383Z,1668534832.383 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2022-11-15T17:53:52.579Z,1668534832.579 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:52.779Z,1668534832.779 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2022-11-15T17:53:52.831Z,1668534832.831 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:53.084Z,1668534833.084 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:53.195Z,1668534833.195 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2022-11-15T17:53:53.335Z,1668534833.335 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:53.587Z,1668534833.587 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:53.611Z,1668534833.611 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2022-11-15T17:53:53.839Z,1668534833.839 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:54.027Z,1668534834.027 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2022-11-15T17:53:54.101Z,1668534834.101 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:54.351Z,1668534834.351 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:54.427Z,1668534834.427 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2022-11-15T17:53:54.603Z,1668534834.603 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:54.847Z,1668534834.847 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2022-11-15T17:53:54.855Z,1668534834.855 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:55.107Z,1668534835.107 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:55.243Z,1668534835.243 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2022-11-15T17:53:55.359Z,1668534835.359 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:55.611Z,1668534835.611 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:55.647Z,1668534835.647 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2022-11-15T17:53:55.863Z,1668534835.863 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:56.051Z,1668534836.051 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2022-11-15T17:53:56.115Z,1668534836.115 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:56.367Z,1668534836.367 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:56.451Z,1668534836.451 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2022-11-15T17:53:56.619Z,1668534836.619 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:56.859Z,1668534836.859 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2022-11-15T17:53:56.871Z,1668534836.871 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:57.123Z,1668534837.123 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:57.263Z,1668534837.263 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2022-11-15T17:53:57.263Z,1668534837.263 [AHRS_M2](FAULT): Failed to initialize within timeout.
2022-11-15T17:53:57.263Z,1668534837.263 [AHRS_M2] Communications Fault, FailCount= 4
2022-11-15T17:53:57.263Z,1668534837.263 [AHRS_M2](ERROR): Communications Fault
2022-11-15T17:53:57.337Z,1668534837.337 [CBIT](ERROR): Communications Fault in component: AHRS_M2
2022-11-15T17:53:57.344Z,1668534837.344 [AHRS_M2](INFO): Powering down
2022-11-15T17:53:57.379Z,1668534837.379 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:57.631Z,1668534837.631 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:57.883Z,1668534837.883 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:58.135Z,1668534838.135 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:58.226Z,1668534838.226 [CBIT](INFO): Clearing failed state for component AHRS_M2
2022-11-15T17:53:58.226Z,1668534838.226 [AHRS_M2] No Fault, FailCount= 4
2022-11-15T17:53:58.387Z,1668534838.387 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:58.555Z,1668534838.555 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2022-11-15T17:53:58.639Z,1668534838.639 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:58.891Z,1668534838.891 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:59.143Z,1668534839.143 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:59.395Z,1668534839.395 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:59.647Z,1668534839.647 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:53:59.899Z,1668534839.899 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:00.151Z,1668534840.151 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:00.403Z,1668534840.403 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:00.655Z,1668534840.655 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:00.907Z,1668534840.907 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:01.159Z,1668534841.159 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:01.411Z,1668534841.411 [DAT](FAULT): failed to initialize, no bytes available on serial interface
2022-11-15T17:54:01.411Z,1668534841.411 [DAT] Communications Fault, FailCount= 1
2022-11-15T17:54:01.411Z,1668534841.411 [DAT](ERROR): Communications Fault
2022-11-15T17:54:01.427Z,1668534841.427 [CBIT](ERROR): Communications Fault in component: DAT
2022-11-15T17:54:01.815Z,1668534841.815 [DAT](INFO): Powering down
2022-11-15T17:54:02.111Z,1668534842.111 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2022-11-15T17:54:02.515Z,1668534842.515 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2022-11-15T17:54:02.927Z,1668534842.927 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2022-11-15T17:54:02.980Z,1668534842.980 [CBIT](INFO): Clearing failed state for component DAT
2022-11-15T17:54:02.980Z,1668534842.980 [DAT] No Fault, FailCount= 1
2022-11-15T17:54:03.335Z,1668534843.335 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2022-11-15T17:54:03.719Z,1668534843.719 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2022-11-15T17:54:04.135Z,1668534844.135 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2022-11-15T17:54:04.543Z,1668534844.543 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2022-11-15T17:54:04.867Z,1668534844.867 [DAT](INFO): Powering up
2022-11-15T17:54:04.867Z,1668534844.867 [DAT](DEBUG): Initializing DAT.
2022-11-15T17:54:04.955Z,1668534844.955 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2022-11-15T17:54:05.343Z,1668534845.343 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2022-11-15T17:54:05.747Z,1668534845.747 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2022-11-15T17:54:06.151Z,1668534846.151 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2022-11-15T17:54:06.559Z,1668534846.559 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2022-11-15T17:54:06.959Z,1668534846.959 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2022-11-15T17:54:07.363Z,1668534847.363 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2022-11-15T17:54:07.767Z,1668534847.767 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2022-11-15T17:54:08.175Z,1668534848.175 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2022-11-15T17:54:08.575Z,1668534848.575 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2022-11-15T17:54:08.991Z,1668534848.991 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2022-11-15T17:54:09.415Z,1668534849.415 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2022-11-15T17:54:09.823Z,1668534849.823 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2022-11-15T17:54:10.235Z,1668534850.235 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2022-11-15T17:54:10.631Z,1668534850.631 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2022-11-15T17:54:11.035Z,1668534851.035 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2022-11-15T17:54:11.443Z,1668534851.443 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2022-11-15T17:54:11.443Z,1668534851.443 [AHRS_M2](FAULT): Failed to initialize within timeout.
2022-11-15T17:54:11.443Z,1668534851.443 [AHRS_M2] Communications Fault, FailCount= 5
2022-11-15T17:54:11.443Z,1668534851.443 [AHRS_M2](ERROR): Communications Fault
2022-11-15T17:54:11.623Z,1668534851.623 [CBIT](ERROR): Communications Fault in component: AHRS_M2
2022-11-15T17:54:11.623Z,1668534851.623 [CBIT](CRITICAL): Communications Fault in component: AHRS_M2
2022-11-15T17:54:11.631Z,1668534851.631 [AHRS_M2](INFO): Powering down
2022-11-15T17:54:11.833Z,1668534851.833 [CBIT](INFO): Critical error at 20221115T175411
2022-11-15T17:54:19.489Z,1668534859.489 [DAT](INFO): commRate: 800
2022-11-15T17:54:21.555Z,1668534861.555 [DAT](INFO): entering command mode
2022-11-15T17:54:21.756Z,1668534861.756 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:22.007Z,1668534862.007 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:22.259Z,1668534862.259 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:22.511Z,1668534862.511 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:22.764Z,1668534862.764 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:23.015Z,1668534863.015 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:23.267Z,1668534863.267 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:23.398Z,1668534863.398 [SBIT](IMPORTANT): SBIT PASSED
2022-11-15T17:54:23.399Z,1668534863.399 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2022-11-15T17:54:23.399Z,1668534863.399 [SBIT](IMPORTANT): No configSet variables persisted
2022-11-15T17:54:23.519Z,1668534863.519 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:23.769Z,1668534863.769 [MissionManager](IMPORTANT): Started mission Startup
2022-11-15T17:54:23.769Z,1668534863.769 [Startup] Running Loop=1
2022-11-15T17:54:23.769Z,1668534863.769 [Startup](DEBUG): Aggregate::initialize Startup
2022-11-15T17:54:23.769Z,1668534863.769 [Startup:A.GoToSurface] Running Loop=1
2022-11-15T17:54:23.769Z,1668534863.769 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2022-11-15T17:54:23.770Z,1668534863.770 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2022-11-15T17:54:23.771Z,1668534863.771 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:23.772Z,1668534863.772 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2022-11-15T17:54:23.772Z,1668534863.772 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2022-11-15T17:54:23.773Z,1668534863.773 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2022-11-15T17:54:23.773Z,1668534863.773 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2022-11-15T17:54:23.775Z,1668534863.775 [Startup:StartupSatComms] Running Loop=1
2022-11-15T17:54:23.775Z,1668534863.775 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2022-11-15T17:54:23.775Z,1668534863.775 [Startup:StartupSatComms:A] Running Loop=1
2022-11-15T17:54:24.023Z,1668534864.023 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:24.192Z,1668534864.192 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2022-11-15T17:54:24.275Z,1668534864.275 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:24.527Z,1668534864.527 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:24.779Z,1668534864.779 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:25.031Z,1668534865.031 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:25.283Z,1668534865.283 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:25.535Z,1668534865.535 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:25.787Z,1668534865.787 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:26.039Z,1668534866.039 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:26.291Z,1668534866.291 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:26.543Z,1668534866.543 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:26.795Z,1668534866.795 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:27.047Z,1668534867.047 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:27.299Z,1668534867.299 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:27.551Z,1668534867.551 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:27.803Z,1668534867.803 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:28.055Z,1668534868.055 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:28.307Z,1668534868.307 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:28.559Z,1668534868.559 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:28.811Z,1668534868.811 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:29.063Z,1668534869.063 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:29.315Z,1668534869.315 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:29.567Z,1668534869.567 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:29.819Z,1668534869.819 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:30.071Z,1668534870.071 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:30.323Z,1668534870.323 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:30.575Z,1668534870.575 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:30.827Z,1668534870.827 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:31.079Z,1668534871.079 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:31.331Z,1668534871.331 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:31.583Z,1668534871.583 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:31.835Z,1668534871.835 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:32.087Z,1668534872.087 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:32.339Z,1668534872.339 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:32.591Z,1668534872.591 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:32.843Z,1668534872.843 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:33.095Z,1668534873.095 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:33.347Z,1668534873.347 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:33.599Z,1668534873.599 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:33.851Z,1668534873.851 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:34.103Z,1668534874.103 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:34.355Z,1668534874.355 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:34.607Z,1668534874.607 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:34.859Z,1668534874.859 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:35.111Z,1668534875.111 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:35.363Z,1668534875.363 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:35.615Z,1668534875.615 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:35.872Z,1668534875.872 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:36.123Z,1668534876.123 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:36.375Z,1668534876.375 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:36.627Z,1668534876.627 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:36.627Z,1668534876.627 [DAT](FAULT): failed to enter command mode
2022-11-15T17:54:36.931Z,1668534876.931 [DAT](INFO): entering command mode
2022-11-15T17:54:37.131Z,1668534877.131 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:37.383Z,1668534877.383 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:37.635Z,1668534877.635 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:37.888Z,1668534877.888 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:38.139Z,1668534878.139 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:38.391Z,1668534878.391 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:38.643Z,1668534878.643 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:38.895Z,1668534878.895 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:39.147Z,1668534879.147 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:39.399Z,1668534879.399 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:39.651Z,1668534879.651 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:39.908Z,1668534879.908 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:40.155Z,1668534880.155 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:40.407Z,1668534880.407 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:40.659Z,1668534880.659 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:40.911Z,1668534880.911 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:41.163Z,1668534881.163 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:41.415Z,1668534881.415 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:41.667Z,1668534881.667 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:41.919Z,1668534881.919 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:42.172Z,1668534882.172 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:42.423Z,1668534882.423 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:42.675Z,1668534882.675 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:42.927Z,1668534882.927 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:43.179Z,1668534883.179 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:43.431Z,1668534883.431 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:43.683Z,1668534883.683 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:43.935Z,1668534883.935 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:44.187Z,1668534884.187 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:44.439Z,1668534884.439 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:44.691Z,1668534884.691 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:44.943Z,1668534884.943 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:45.195Z,1668534885.195 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:45.447Z,1668534885.447 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:45.699Z,1668534885.699 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:45.951Z,1668534885.951 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:46.203Z,1668534886.203 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:46.455Z,1668534886.455 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:46.707Z,1668534886.707 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:46.959Z,1668534886.959 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:47.211Z,1668534887.211 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:47.463Z,1668534887.463 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:47.715Z,1668534887.715 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:47.967Z,1668534887.967 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:48.219Z,1668534888.219 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:48.475Z,1668534888.475 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:48.727Z,1668534888.727 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:48.979Z,1668534888.979 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:49.231Z,1668534889.231 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:49.483Z,1668534889.483 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:49.735Z,1668534889.735 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:49.987Z,1668534889.987 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:50.239Z,1668534890.239 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:50.491Z,1668534890.491 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:50.743Z,1668534890.743 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:50.995Z,1668534890.995 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:51.247Z,1668534891.247 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:51.499Z,1668534891.499 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:51.751Z,1668534891.751 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:52.003Z,1668534892.003 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:52.003Z,1668534892.003 [DAT](FAULT): failed to enter command mode
2022-11-15T17:54:52.307Z,1668534892.307 [DAT](INFO): entering command mode
2022-11-15T17:54:52.507Z,1668534892.507 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:52.759Z,1668534892.759 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:53.011Z,1668534893.011 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:53.263Z,1668534893.263 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:53.515Z,1668534893.515 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:53.767Z,1668534893.767 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:54.019Z,1668534894.019 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:54.271Z,1668534894.271 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:54.523Z,1668534894.523 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:54.775Z,1668534894.775 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:55.027Z,1668534895.027 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:55.279Z,1668534895.279 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:55.531Z,1668534895.531 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:55.783Z,1668534895.783 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:56.035Z,1668534896.035 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:56.287Z,1668534896.287 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:56.539Z,1668534896.539 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:56.791Z,1668534896.791 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:57.043Z,1668534897.043 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:57.295Z,1668534897.295 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:57.547Z,1668534897.547 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:57.799Z,1668534897.799 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:58.051Z,1668534898.051 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:58.303Z,1668534898.303 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:58.566Z,1668534898.566 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:58.819Z,1668534898.819 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:59.071Z,1668534899.071 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:59.323Z,1668534899.323 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:59.575Z,1668534899.575 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:54:59.827Z,1668534899.827 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:00.079Z,1668534900.079 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:00.331Z,1668534900.331 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:00.587Z,1668534900.587 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:00.839Z,1668534900.839 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:01.091Z,1668534901.091 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:01.343Z,1668534901.343 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:01.350Z,1668534901.350 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2022-11-15T17:55:01.350Z,1668534901.350 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2022-11-15T17:55:01.350Z,1668534901.350 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2022-11-15T17:55:01.351Z,1668534901.351 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2022-11-15T17:55:01.352Z,1668534901.352 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 1
2022-11-15T17:55:01.352Z,1668534901.352 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2022-11-15T17:55:01.402Z,1668534901.402 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2022-11-15T17:55:01.402Z,1668534901.402 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2022-11-15T17:55:01.595Z,1668534901.595 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:01.822Z,1668534901.822 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2022-11-15T17:55:01.822Z,1668534901.822 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2022-11-15T17:55:01.823Z,1668534901.823 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2022-11-15T17:55:01.823Z,1668534901.823 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 1
2022-11-15T17:55:01.847Z,1668534901.847 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:02.099Z,1668534902.099 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:02.160Z,1668534902.160 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2022-11-15T17:55:02.351Z,1668534902.351 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:02.603Z,1668534902.603 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:02.855Z,1668534902.855 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:03.107Z,1668534903.107 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:03.359Z,1668534903.359 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:03.611Z,1668534903.611 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:03.863Z,1668534903.863 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:04.115Z,1668534904.115 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:04.367Z,1668534904.367 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:04.619Z,1668534904.619 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:04.871Z,1668534904.871 [DAT](FAULT): failed to initialize, no bytes available on serial interface
2022-11-15T17:55:04.871Z,1668534904.871 [DAT] Communications Fault, FailCount= 2
2022-11-15T17:55:04.871Z,1668534904.871 [DAT](ERROR): Communications Fault
2022-11-15T17:55:04.981Z,1668534904.981 [CBIT](ERROR): Communications Fault in component: DAT
2022-11-15T17:55:05.275Z,1668534905.275 [DAT](INFO): Powering down
2022-11-15T17:55:06.220Z,1668534906.220 [CBIT](INFO): Clearing failed state for component DAT
2022-11-15T17:55:06.220Z,1668534906.220 [DAT] No Fault, FailCount= 2
2022-11-15T17:55:08.323Z,1668534908.323 [DAT](INFO): Powering up
2022-11-15T17:55:08.323Z,1668534908.323 [DAT](DEBUG): Initializing DAT.
2022-11-15T17:55:22.945Z,1668534922.945 [DAT](INFO): commRate: 800
2022-11-15T17:55:24.018Z,1668534924.018 [Startup:StartupSatComms:A](INFO): Timed out from 2022-11-15T17:54:23.8Z
2022-11-15T17:55:24.018Z,1668534924.018 [Startup:StartupSatComms:A] Stopped
2022-11-15T17:55:24.018Z,1668534924.018 [Startup:StartupSatComms:B] Running Loop=1
2022-11-15T17:55:24.388Z,1668534924.388 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2022-11-15T17:55:25.011Z,1668534925.011 [DAT](INFO): entering command mode
2022-11-15T17:55:25.211Z,1668534925.211 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:25.463Z,1668534925.463 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:25.715Z,1668534925.715 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:25.967Z,1668534925.967 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:26.219Z,1668534926.219 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:26.471Z,1668534926.471 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:26.723Z,1668534926.723 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:26.976Z,1668534926.976 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:27.227Z,1668534927.227 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:27.479Z,1668534927.479 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:27.731Z,1668534927.731 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:27.983Z,1668534927.983 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:28.235Z,1668534928.235 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:28.487Z,1668534928.487 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:28.739Z,1668534928.739 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:28.991Z,1668534928.991 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:29.243Z,1668534929.243 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:29.385Z,1668534929.385 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.005126
2022-11-15T17:55:29.495Z,1668534929.495 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:29.747Z,1668534929.747 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:29.999Z,1668534929.999 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:30.251Z,1668534930.251 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:30.503Z,1668534930.503 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:30.755Z,1668534930.755 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:31.007Z,1668534931.007 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:31.259Z,1668534931.259 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:31.511Z,1668534931.511 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:31.763Z,1668534931.763 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:32.015Z,1668534932.015 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:32.267Z,1668534932.267 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:32.519Z,1668534932.519 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:32.771Z,1668534932.771 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:33.023Z,1668534933.023 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:33.275Z,1668534933.275 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:33.527Z,1668534933.527 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:33.779Z,1668534933.779 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:34.031Z,1668534934.031 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:34.283Z,1668534934.283 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:34.535Z,1668534934.535 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:34.787Z,1668534934.787 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:35.039Z,1668534935.039 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:35.291Z,1668534935.291 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:35.543Z,1668534935.543 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:35.795Z,1668534935.795 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:36.047Z,1668534936.047 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:36.299Z,1668534936.299 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:36.557Z,1668534936.557 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:36.682Z,1668534936.682 [DataOverHttps](INFO): Sending 96 bytes from file Logs/20221114T210356/Courier0361.lzma
2022-11-15T17:55:36.807Z,1668534936.807 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:37.059Z,1668534937.059 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:37.311Z,1668534937.311 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:37.563Z,1668534937.563 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:37.685Z,1668534937.685 [DataOverHttps](INFO): Moved sent file to Logs/20221114T210356/Courier0361.lzma.bak
2022-11-15T17:55:37.685Z,1668534937.685 [DataOverHttps](INFO): SBD MOMSN=17307136
2022-11-15T17:55:37.815Z,1668534937.815 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:38.067Z,1668534938.067 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:38.319Z,1668534938.319 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:38.575Z,1668534938.575 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:38.827Z,1668534938.827 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:39.079Z,1668534939.079 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:39.331Z,1668534939.331 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:39.583Z,1668534939.583 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:39.835Z,1668534939.835 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:40.087Z,1668534940.087 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:40.087Z,1668534940.087 [DAT](FAULT): failed to enter command mode
2022-11-15T17:55:40.391Z,1668534940.391 [DAT](INFO): entering command mode
2022-11-15T17:55:40.591Z,1668534940.591 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:40.843Z,1668534940.843 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:41.095Z,1668534941.095 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:41.347Z,1668534941.347 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:41.599Z,1668534941.599 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:41.851Z,1668534941.851 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:42.103Z,1668534942.103 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:42.355Z,1668534942.355 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:42.608Z,1668534942.608 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:42.859Z,1668534942.859 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:43.111Z,1668534943.111 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:43.363Z,1668534943.363 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:43.615Z,1668534943.615 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:43.867Z,1668534943.867 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:44.119Z,1668534944.119 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:44.371Z,1668534944.371 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:44.628Z,1668534944.628 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:44.875Z,1668534944.875 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:45.127Z,1668534945.127 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:45.379Z,1668534945.379 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:45.631Z,1668534945.631 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:45.883Z,1668534945.883 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:46.135Z,1668534946.135 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:46.387Z,1668534946.387 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:46.639Z,1668534946.639 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:46.891Z,1668534946.891 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:47.143Z,1668534947.143 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:47.395Z,1668534947.395 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:47.647Z,1668534947.647 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:47.899Z,1668534947.899 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:48.151Z,1668534948.151 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:48.403Z,1668534948.403 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:48.655Z,1668534948.655 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:48.907Z,1668534948.907 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:49.170Z,1668534949.170 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:49.423Z,1668534949.423 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:49.675Z,1668534949.675 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:49.927Z,1668534949.927 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:50.179Z,1668534950.179 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:50.431Z,1668534950.431 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:50.683Z,1668534950.683 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:50.935Z,1668534950.935 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:51.188Z,1668534951.188 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:51.439Z,1668534951.439 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:51.691Z,1668534951.691 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:51.943Z,1668534951.943 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:52.195Z,1668534952.195 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:52.447Z,1668534952.447 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:52.699Z,1668534952.699 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:52.951Z,1668534952.951 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:53.063Z,1668534953.063 [DataOverHttps](INFO): Sending 270 bytes from file Logs/20221115T175251/Courier0000.lzma
2022-11-15T17:55:53.203Z,1668534953.203 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:53.455Z,1668534953.455 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:53.707Z,1668534953.707 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:53.959Z,1668534953.959 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:54.064Z,1668534954.064 [DataOverHttps](INFO): Moved sent file to Logs/20221115T175251/Courier0000.lzma.bak
2022-11-15T17:55:54.064Z,1668534954.064 [DataOverHttps](INFO): SBD MOMSN=17307140
2022-11-15T17:55:54.211Z,1668534954.211 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:54.463Z,1668534954.463 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:54.715Z,1668534954.715 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:54.967Z,1668534954.967 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:55.219Z,1668534955.219 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:55.471Z,1668534955.471 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:55.471Z,1668534955.471 [DAT](FAULT): failed to enter command mode
2022-11-15T17:55:55.775Z,1668534955.775 [DAT](INFO): entering command mode
2022-11-15T17:55:55.983Z,1668534955.983 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:56.235Z,1668534956.235 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:56.488Z,1668534956.488 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:56.739Z,1668534956.739 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:56.991Z,1668534956.991 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:57.243Z,1668534957.243 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:57.495Z,1668534957.495 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:57.747Z,1668534957.747 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:57.999Z,1668534957.999 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:58.251Z,1668534958.251 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:58.503Z,1668534958.503 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:58.755Z,1668534958.755 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:59.007Z,1668534959.007 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:59.263Z,1668534959.263 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:59.515Z,1668534959.515 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:55:59.767Z,1668534959.767 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:00.019Z,1668534960.019 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:00.271Z,1668534960.271 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:00.523Z,1668534960.523 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:00.775Z,1668534960.775 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:01.027Z,1668534961.027 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:01.279Z,1668534961.279 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:01.531Z,1668534961.531 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:01.783Z,1668534961.783 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:02.035Z,1668534962.035 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:02.287Z,1668534962.287 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:02.539Z,1668534962.539 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:02.791Z,1668534962.791 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:03.043Z,1668534963.043 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:03.295Z,1668534963.295 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:03.547Z,1668534963.547 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:03.799Z,1668534963.799 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:04.051Z,1668534964.051 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:04.303Z,1668534964.303 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:04.555Z,1668534964.555 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:04.807Z,1668534964.807 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:04.874Z,1668534964.874 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL
2022-11-15T17:56:04.887Z,1668534964.887 [WetLabsBB2FL] No Fault, FailCount= 5
2022-11-15T17:56:05.059Z,1668534965.059 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:05.088Z,1668534965.088 [WetLabsBB2FL](INFO): Powering up
2022-11-15T17:56:05.311Z,1668534965.311 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:05.563Z,1668534965.563 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:05.816Z,1668534965.816 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:06.067Z,1668534966.067 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:06.319Z,1668534966.319 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:06.571Z,1668534966.571 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:06.823Z,1668534966.823 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:07.075Z,1668534967.075 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:07.327Z,1668534967.327 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:07.579Z,1668534967.579 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:07.831Z,1668534967.831 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:08.083Z,1668534968.083 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:08.335Z,1668534968.335 [DAT](FAULT): failed to initialize, no bytes available on serial interface
2022-11-15T17:56:08.335Z,1668534968.335 [DAT] Communications Fault, FailCount= 3
2022-11-15T17:56:08.335Z,1668534968.335 [DAT](ERROR): Communications Fault
2022-11-15T17:56:08.566Z,1668534968.566 [CBIT](ERROR): Communications Fault in component: DAT
2022-11-15T17:56:08.739Z,1668534968.739 [DAT](INFO): Powering down
2022-11-15T17:56:09.423Z,1668534969.423 [DataOverHttps](INFO): Sending 706 bytes from file Logs/20221114T210356/Express0362.lzma
2022-11-15T17:56:09.739Z,1668534969.739 [CBIT](INFO): Clearing failed state for component DAT
2022-11-15T17:56:09.739Z,1668534969.739 [DAT] No Fault, FailCount= 3
2022-11-15T17:56:10.382Z,1668534970.382 [WetLabsBB2FL] Communications Fault, FailCount= 1
2022-11-15T17:56:10.383Z,1668534970.383 [WetLabsBB2FL](ERROR): Communications Fault
2022-11-15T17:56:10.425Z,1668534970.425 [DataOverHttps](INFO): Moved sent file to Logs/20221114T210356/Express0362.lzma.bak
2022-11-15T17:56:10.425Z,1668534970.425 [DataOverHttps](INFO): SBD MOMSN=17307146
2022-11-15T17:56:10.568Z,1668534970.568 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL
2022-11-15T17:56:10.883Z,1668534970.883 [WetLabsBB2FL](INFO): Powering down
2022-11-15T17:56:11.733Z,1668534971.733 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL
2022-11-15T17:56:11.733Z,1668534971.733 [WetLabsBB2FL] No Fault, FailCount= 1
2022-11-15T17:56:11.787Z,1668534971.787 [DAT](INFO): Powering up
2022-11-15T17:56:11.787Z,1668534971.787 [DAT](DEBUG): Initializing DAT.
2022-11-15T17:56:12.103Z,1668534972.103 [WetLabsBB2FL](INFO): Powering up
2022-11-15T17:56:14.181Z,1668534974.181 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2022-11-15T17:56:14.182Z,1668534974.182 [CTD_Seabird] No Fault, FailCount= 3
2022-11-15T17:56:14.475Z,1668534974.475 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2022-11-15T17:56:17.395Z,1668534977.395 [WetLabsBB2FL] Communications Fault, FailCount= 2
2022-11-15T17:56:17.395Z,1668534977.395 [WetLabsBB2FL](ERROR): Communications Fault
2022-11-15T17:56:17.781Z,1668534977.781 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL
2022-11-15T17:56:17.895Z,1668534977.895 [WetLabsBB2FL](INFO): Powering down
2022-11-15T17:56:19.007Z,1668534979.007 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL
2022-11-15T17:56:19.007Z,1668534979.007 [WetLabsBB2FL] No Fault, FailCount= 2
2022-11-15T17:56:19.108Z,1668534979.108 [WetLabsBB2FL](INFO): Powering up
2022-11-15T17:56:24.290Z,1668534984.290 [Startup:StartupSatComms:B](INFO): Timed out from 2022-11-15T17:55:24.0Z
2022-11-15T17:56:24.290Z,1668534984.290 [Startup:StartupSatComms:B] Stopped
2022-11-15T17:56:24.290Z,1668534984.290 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2022-11-15T17:56:24.290Z,1668534984.290 [Startup:StartupSatComms] Stopped
2022-11-15T17:56:24.290Z,1668534984.290 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2022-11-15T17:56:24.295Z,1668534984.295 [Startup](INFO): Completed Startup
2022-11-15T17:56:24.295Z,1668534984.295 [MissionManager](INFO): Startup is completed.
2022-11-15T17:56:24.295Z,1668534984.295 [MissionManager](INFO): Uninitializing Mission Startup
2022-11-15T17:56:24.296Z,1668534984.296 [Startup] Stopped
2022-11-15T17:56:24.296Z,1668534984.296 [Startup](DEBUG): Aggregate::uninitialize Startup
2022-11-15T17:56:24.296Z,1668534984.296 [Startup:A.GoToSurface] Stopped
2022-11-15T17:56:24.296Z,1668534984.296 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2022-11-15T17:56:24.411Z,1668534984.411 [WetLabsBB2FL] Communications Fault, FailCount= 3
2022-11-15T17:56:24.411Z,1668534984.411 [WetLabsBB2FL](ERROR): Communications Fault
2022-11-15T17:56:24.687Z,1668534984.687 [MissionManager](IMPORTANT): Started mission Default
2022-11-15T17:56:24.687Z,1668534984.687 [Default] Running Loop=1
2022-11-15T17:56:24.688Z,1668534984.688 [Default](DEBUG): Aggregate::initialize Default
2022-11-15T17:56:24.688Z,1668534984.688 [Default:B.GoToSurface] Running Loop=1
2022-11-15T17:56:24.688Z,1668534984.688 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2022-11-15T17:56:24.688Z,1668534984.688 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2022-11-15T17:56:24.688Z,1668534984.688 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2022-11-15T17:56:24.689Z,1668534984.689 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2022-11-15T17:56:24.689Z,1668534984.689 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2022-11-15T17:56:24.689Z,1668534984.689 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2022-11-15T17:56:24.690Z,1668534984.690 [Default:A.Wait] Running Loop=1
2022-11-15T17:56:24.690Z,1668534984.690 [Default:A.Wait](DEBUG): Initialize Wait Component.
2022-11-15T17:56:24.711Z,1668534984.711 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL
2022-11-15T17:56:24.884Z,1668534984.884 [CommandExec](IMPORTANT): got command show stack
2022-11-15T17:56:24.884Z,1668534984.884 [CommandExec](IMPORTANT): Behavior Stack:

2022-11-15T17:56:24.884Z,1668534984.884 [Default](IMPORTANT): Priority 0: Default:A.Wait
2022-11-15T17:56:24.885Z,1668534984.885 [Default](IMPORTANT): Priority 1: Default:B.GoToSurface
2022-11-15T17:56:24.907Z,1668534984.907 [WetLabsBB2FL](INFO): Powering down
2022-11-15T17:56:25.861Z,1668534985.861 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL
2022-11-15T17:56:25.861Z,1668534985.861 [WetLabsBB2FL] No Fault, FailCount= 3
2022-11-15T17:56:25.978Z,1668534985.978 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20221114T210356/Express0365.lzma
2022-11-15T17:56:26.120Z,1668534986.120 [WetLabsBB2FL](INFO): Powering up
2022-11-15T17:56:26.409Z,1668534986.409 [DAT](INFO): commRate: 800
2022-11-15T17:56:26.981Z,1668534986.981 [DataOverHttps](INFO): Moved sent file to Logs/20221114T210356/Express0365.lzma.bak
2022-11-15T17:56:26.981Z,1668534986.981 [DataOverHttps](INFO): SBD MOMSN=17307203
2022-11-15T17:56:27.527Z,1668534987.527 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2022-11-15T17:56:27.527Z,1668534987.527 [CTD_Seabird] Communications Fault, FailCount= 1
2022-11-15T17:56:27.527Z,1668534987.527 [CTD_Seabird](ERROR): Communications Fault
2022-11-15T17:56:27.879Z,1668534987.879 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2022-11-15T17:56:27.931Z,1668534987.931 [CTD_Seabird](INFO): Powering down
2022-11-15T17:56:28.475Z,1668534988.475 [DAT](INFO): entering command mode
2022-11-15T17:56:28.675Z,1668534988.675 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:28.927Z,1668534988.927 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:29.093Z,1668534989.093 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2022-11-15T17:56:29.093Z,1668534989.093 [CTD_Seabird] No Fault, FailCount= 1
2022-11-15T17:56:29.179Z,1668534989.179 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:29.275Z,1668534989.275 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2022-11-15T17:56:29.431Z,1668534989.431 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:29.683Z,1668534989.683 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:29.935Z,1668534989.935 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:30.187Z,1668534990.187 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:30.439Z,1668534990.439 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:30.691Z,1668534990.691 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:30.943Z,1668534990.943 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:31.195Z,1668534991.195 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:31.415Z,1668534991.415 [WetLabsBB2FL] Communications Fault, FailCount= 4
2022-11-15T17:56:31.415Z,1668534991.415 [WetLabsBB2FL](ERROR): Communications Fault
2022-11-15T17:56:31.447Z,1668534991.447 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:31.557Z,1668534991.557 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL
2022-11-15T17:56:31.699Z,1668534991.699 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:31.919Z,1668534991.919 [WetLabsBB2FL](INFO): Powering down
2022-11-15T17:56:31.951Z,1668534991.951 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:32.203Z,1668534992.203 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:32.455Z,1668534992.455 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:32.707Z,1668534992.707 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:32.747Z,1668534992.747 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL
2022-11-15T17:56:32.747Z,1668534992.747 [WetLabsBB2FL] No Fault, FailCount= 4
2022-11-15T17:56:32.959Z,1668534992.959 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:33.132Z,1668534993.132 [WetLabsBB2FL](INFO): Powering up
2022-11-15T17:56:33.211Z,1668534993.211 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:33.463Z,1668534993.463 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:33.715Z,1668534993.715 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:33.967Z,1668534993.967 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:34.219Z,1668534994.219 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:34.471Z,1668534994.471 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:34.723Z,1668534994.723 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:34.975Z,1668534994.975 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:35.227Z,1668534995.227 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:35.479Z,1668534995.479 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:35.731Z,1668534995.731 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:35.995Z,1668534995.995 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:36.055Z,1668534996.055 [CommandExec](IMPORTANT): got command run ./Missions/Maintenance/multiray_test.xml
2022-11-15T17:56:36.055Z,1668534996.055 [MissionManager](INFO): Loading Mission from file: ./Missions/Maintenance/multiray_test.xml
2022-11-15T17:56:36.121Z,1668534996.121 [MissionManager](INFO): DefineArg multiray_test.MissionTimeout = 5.000000 min
2022-11-15T17:56:36.124Z,1668534996.124 [MissionManager](INFO): DefineArg multiray_test.LightDuration = 5.000000 s
2022-11-15T17:56:36.127Z,1668534996.127 [MissionManager](INFO): DefineArg multiray_test.LightMode0 = 0.000000 count
2022-11-15T17:56:36.129Z,1668534996.129 [MissionManager](INFO): DefineArg multiray_test.LightMode1 = 1.000000 count
2022-11-15T17:56:36.132Z,1668534996.132 [MissionManager](INFO): DefineArg multiray_test.LightMode2 = 2.000000 count
2022-11-15T17:56:36.136Z,1668534996.136 [MissionManager](INFO): DefineArg multiray_test.EnabledMultiray = 1 bool
2022-11-15T17:56:36.160Z,1668534996.160 [multiray_test:C.Wait](DEBUG): Construct Wait.
2022-11-15T17:56:36.167Z,1668534996.167 [multiray_test:E.Wait](DEBUG): Construct Wait.
2022-11-15T17:56:36.170Z,1668534996.170 [multiray_test:G.Wait](DEBUG): Construct Wait.
2022-11-15T17:56:36.177Z,1668534996.177 [multiray_test:I.Wait](DEBUG): Construct Wait.
2022-11-15T17:56:36.196Z,1668534996.196 [multiray_test:K.Wait](DEBUG): Construct Wait.
2022-11-15T17:56:36.204Z,1668534996.204 [multiray_test:M.Wait](DEBUG): Construct Wait.
2022-11-15T17:56:36.213Z,1668534996.213 [multiray_test:O.Wait](DEBUG): Construct Wait.
2022-11-15T17:56:36.224Z,1668534996.224 [multiray_test:Q.Wait](DEBUG): Construct Wait.
2022-11-15T17:56:36.244Z,1668534996.244 [multiray_test:R.Wait](DEBUG): Construct Wait.
2022-11-15T17:56:36.247Z,1668534996.247 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:36.255Z,1668534996.255 [multiray_test:T.Wait](DEBUG): Construct Wait.
2022-11-15T17:56:36.265Z,1668534996.265 [MissionManager](DEBUG): 
<?xml version="1.0" encoding="UTF-8"?>

<Mission xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"
         xmlns="Tethys"
         xmlns:Guidance="Tethys/Guidance"
         xmlns:Units="Tethys/Units"
         xmlns:Sample="Tethys/Sample"
         xmlns:Sensor="Tethys/Sensor"
         xsi:schemaLocation="Tethys http://okeanids.mbari.org/tethys/Xml/Tethys.xsd
                             Tethys/Units http://okeanids.mbari.org/tethys/Xml/Units.xsd
                             Tethys/Sensor http://okeanids.mbari.org/tethys/Xml/Sensor.xsd"
       Id="multiray_test">

    <Description>
        This mission is designed to run in the lab only. Cycles through MultiRay light modes
    </Description>

    <DefineArg Name="MissionTimeout"><Description>
        How long to let the mission run.
    </Description><Units:minute/><Value>5</Value></DefineArg>

    <DefineArg Name="LightDuration"><Description>
        How long to wait before changing light modes
    </Description><Units:second/><Value>5</Value></DefineArg>

    <DefineArg Name="LightMode0"><Description>
        Light mode = 0
    </Description><Units:count/><Value>0</Value></DefineArg>

    <DefineArg Name="LightMode1"><Description>
        Light mode = 1
    </Description><Units:count/><Value>1</Value></DefineArg>

    <DefineArg Name="LightMode2"><Description>
        Light mode = 2
    </Description><Units:count/><Value>2</Value></DefineArg>

    <DefineArg Name="EnabledMultiray"><Description>
        Automatically set to true if the Multiray is enabled.
    </Description><Science:MultiRay.loadAtStartup/></DefineArg>

    <Timeout Duration="MissionTimeout"/>



    <ReadData Strategy="MinError">
        <While>
            <Arg Name="EnabledMultiray"/>
        </While>
    <Sensor:MultiRay.lightModeLog/>
    </ReadData>


    <!-- <ReadDatum>
            <Sensor:MultiRay.lightModeLog/>
    </ReadDatum> -->

    <Assign><Sequence/><Sensor:MultiRay.lightModeCommand/><Arg Name="LightMode0"/></Assign>    
    <Guidance:Wait>
                <Sequence/>
                <Setting><Guidance:Wait.duration/><Arg Name="LightDuration"/></Setting>
            </Guidance:Wait>

    <Assign><Sequence/><Sensor:MultiRay.lightModeCommand/><Arg Name="LightMode1"/></Assign>    
    <Guidance:Wait>
                <Sequence/>
                <Setting><Guidance:Wait.duration/><Arg Name="LightDuration"/></Setting>
            </Guidance:Wait>

    <Assign><Sequence/><Sensor:MultiRay.lightModeCommand/><Arg Name="LightMode2"/></Assign>    
    <Guidance:Wait>
                <Sequence/>
                <Setting><Guidance:Wait.duration/><Arg Name="LightDuration"/></Setting>
            </Guidance:Wait>

    <Assign><Sequence/><Sensor:MultiRay.lightModeCommand/><Arg Name="LightMode0"/></Assign>    
    <Guidance:Wait>
                <Sequence/>
                <Setting><Guidance:Wait.duration/><Arg Name="LightDuration"/></Setting>
            </Guidance:Wait>
    
    <Assign><Sequence/><Sensor:MultiRay.lightModeCommand/><Arg Name="LightMode1"/></Assign>    
    <Guidance:Wait>
                <Sequence/>
                <Setting><Guidance:Wait.duration/><Arg Name="LightDuration"/></Setting>
            </Guidance:Wait>

    <Assign><Sequence/><Sensor:MultiRay.lightModeCommand/><Arg Name="LightMode2"/></Assign>    
    <Guidance:Wait>
                <Sequence/>
                <Setting><Guidance:Wait.duration/><Arg Name="LightDuration"/></Setting>
            </Guidance:Wait>

    <Assign><Sequence/><Sensor:MultiRay.lightModeCommand/><Arg Name="LightMode0"/></Assign>    
    <Guidance:Wait>
                <Sequence/>
                <Setting><Guidance:Wait.duration/><Arg Name="LightDuration"/></Setting>
            </Guidance:Wait>

    <Assign><Sequence/><Sensor:MultiRay.lightModeCommand/><Arg Name="LightMode1"/></Assign>    
    <Guidance:Wait>
                <Sequence/>
                <Setting><Guidance:Wait.duration/><Arg Name="LightDuration"/></Setting>
            </Guidance:Wait>

    <Assign><Sequence/><Sensor:MultiRay.lightModeCommand/><Arg Name="LightMode2"/></Assign>    
    <Guidance:Wait>
                <Sequence/>
                <Setting><Guidance:Wait.duration/><Arg Name="LightDuration"/></Setting>
            </Guidance:Wait>

    <Assign><Sequence/><Sensor:MultiRay.lightModeCommand/><Arg Name="LightMode0"/></Assign>    
    <Guidance:Wait>
                <Sequence/>
                <Setting><Guidance:Wait.duration/><Arg Name="LightDuration"/></Setting>
            </Guidance:Wait>

</Mission>


2022-11-15T17:56:36.272Z,1668534996.272 [CommandExec](IMPORTANT): Running ./Missions/Maintenance/multiray_test.xml
2022-11-15T17:56:36.377Z,1668534996.377 [Default] Stopped
2022-11-15T17:56:36.377Z,1668534996.377 [Default](DEBUG): Aggregate::uninitialize Default
2022-11-15T17:56:36.377Z,1668534996.377 [Default:A.Wait] Stopped
2022-11-15T17:56:36.377Z,1668534996.377 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2022-11-15T17:56:36.377Z,1668534996.377 [Default:B.GoToSurface] Stopped
2022-11-15T17:56:36.378Z,1668534996.378 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2022-11-15T17:56:36.378Z,1668534996.378 [MissionManager](IMPORTANT): Started mission multiray_test
2022-11-15T17:56:36.378Z,1668534996.378 [multiray_test] Running Loop=1
2022-11-15T17:56:36.378Z,1668534996.378 [multiray_test](DEBUG): Aggregate::initialize multiray_test
2022-11-15T17:56:36.378Z,1668534996.378 [multiray_test:A] Running Loop=1
2022-11-15T17:56:36.379Z,1668534996.379 [multiray_test:B] Running Loop=1
2022-11-15T17:56:36.379Z,1668534996.379 [multiray_test:B] Stopped
2022-11-15T17:56:36.379Z,1668534996.379 [multiray_test:C.Wait] Running Loop=1
2022-11-15T17:56:36.379Z,1668534996.379 [multiray_test:C.Wait](DEBUG): Initialize Wait Component.
2022-11-15T17:56:36.379Z,1668534996.379 [multiray_test:A] Running Loop=1
2022-11-15T17:56:36.380Z,1668534996.380 [multiray_test:A](DEBUG): Initialize ReadDataComponent to sense MultiRay.lightModeLog
2022-11-15T17:56:36.499Z,1668534996.499 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:36.751Z,1668534996.751 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:37.003Z,1668534997.003 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:37.255Z,1668534997.255 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:37.507Z,1668534997.507 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:37.759Z,1668534997.759 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:37.989Z,1668534997.989 [MultiRay](INFO): All lights off failed! Try again next cycle
2022-11-15T17:56:38.011Z,1668534998.011 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:38.263Z,1668534998.263 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:38.431Z,1668534998.431 [WetLabsBB2FL] Communications Fault, FailCount= 5
2022-11-15T17:56:38.431Z,1668534998.431 [WetLabsBB2FL](ERROR): Communications Fault
2022-11-15T17:56:38.434Z,1668534998.434 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL
2022-11-15T17:56:38.435Z,1668534998.435 [CBIT](FAULT): Communications Fault in component: WetLabsBB2FL
2022-11-15T17:56:38.515Z,1668534998.515 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:38.767Z,1668534998.767 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:38.785Z,1668534998.785 [MultiRay](INFO): All lights off failed! Try again next cycle
2022-11-15T17:56:38.931Z,1668534998.931 [WetLabsBB2FL](INFO): Powering down
2022-11-15T17:56:39.019Z,1668534999.019 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:39.271Z,1668534999.271 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:39.523Z,1668534999.523 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:39.580Z,1668534999.580 [MultiRay](INFO): All lights off failed! Try again next cycle
2022-11-15T17:56:39.775Z,1668534999.775 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:40.027Z,1668535000.027 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:40.279Z,1668535000.279 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:40.388Z,1668535000.388 [MultiRay](INFO): All lights off failed! Try again next cycle
2022-11-15T17:56:40.531Z,1668535000.531 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:40.785Z,1668535000.785 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:41.035Z,1668535001.035 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:41.196Z,1668535001.196 [MultiRay](INFO): All lights off failed! Try again next cycle
2022-11-15T17:56:41.287Z,1668535001.287 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:41.539Z,1668535001.539 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:41.791Z,1668535001.791 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:42.004Z,1668535002.004 [MultiRay](INFO): All lights off failed! Try again next cycle
2022-11-15T17:56:42.012Z,1668535002.012 [multiray_test:C.Wait](INFO): Done Waiting.
2022-11-15T17:56:42.012Z,1668535002.012 [multiray_test:C.Wait] Stopped
2022-11-15T17:56:42.013Z,1668535002.013 [multiray_test:C.Wait](DEBUG): Uninitialize Wait Component.
2022-11-15T17:56:42.013Z,1668535002.013 [multiray_test:D] Running Loop=1
2022-11-15T17:56:42.043Z,1668535002.043 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:42.295Z,1668535002.295 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:42.327Z,1668535002.327 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2022-11-15T17:56:42.327Z,1668535002.327 [CTD_Seabird] Communications Fault, FailCount= 2
2022-11-15T17:56:42.327Z,1668535002.327 [CTD_Seabird](ERROR): Communications Fault
2022-11-15T17:56:42.461Z,1668535002.461 [multiray_test:D] Stopped
2022-11-15T17:56:42.461Z,1668535002.461 [multiray_test:E.Wait] Running Loop=1
2022-11-15T17:56:42.461Z,1668535002.461 [multiray_test:E.Wait](DEBUG): Initialize Wait Component.
2022-11-15T17:56:42.469Z,1668535002.469 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2022-11-15T17:56:42.547Z,1668535002.547 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:42.731Z,1668535002.731 [CTD_Seabird](INFO): Powering down
2022-11-15T17:56:42.804Z,1668535002.804 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:43.051Z,1668535003.051 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:43.303Z,1668535003.303 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:43.555Z,1668535003.555 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:43.556Z,1668535003.556 [DAT](FAULT): failed to enter command mode
2022-11-15T17:56:43.676Z,1668535003.676 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2022-11-15T17:56:43.676Z,1668535003.676 [CTD_Seabird] No Fault, FailCount= 2
2022-11-15T17:56:43.859Z,1668535003.859 [DAT](INFO): entering command mode
2022-11-15T17:56:44.059Z,1668535004.059 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:44.079Z,1668535004.079 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2022-11-15T17:56:44.311Z,1668535004.311 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:44.563Z,1668535004.563 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:44.815Z,1668535004.815 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:45.067Z,1668535005.067 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:45.319Z,1668535005.319 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:45.571Z,1668535005.571 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:45.823Z,1668535005.823 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:46.077Z,1668535006.077 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:46.327Z,1668535006.327 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:46.579Z,1668535006.579 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:46.831Z,1668535006.831 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:47.083Z,1668535007.083 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:47.335Z,1668535007.335 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:47.587Z,1668535007.587 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:47.839Z,1668535007.839 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:48.073Z,1668535008.073 [multiray_test:E.Wait](INFO): Done Waiting.
2022-11-15T17:56:48.073Z,1668535008.073 [multiray_test:E.Wait] Stopped
2022-11-15T17:56:48.073Z,1668535008.073 [multiray_test:E.Wait](DEBUG): Uninitialize Wait Component.
2022-11-15T17:56:48.074Z,1668535008.074 [multiray_test:F] Running Loop=1
2022-11-15T17:56:48.091Z,1668535008.091 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:48.343Z,1668535008.343 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:48.569Z,1668535008.569 [multiray_test:F] Stopped
2022-11-15T17:56:48.569Z,1668535008.569 [multiray_test:G.Wait] Running Loop=1
2022-11-15T17:56:48.569Z,1668535008.569 [multiray_test:G.Wait](DEBUG): Initialize Wait Component.
2022-11-15T17:56:48.595Z,1668535008.595 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:48.847Z,1668535008.847 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:49.099Z,1668535009.099 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:49.351Z,1668535009.351 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:49.603Z,1668535009.603 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:49.855Z,1668535009.855 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:50.107Z,1668535010.107 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:50.359Z,1668535010.359 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:50.611Z,1668535010.611 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:50.863Z,1668535010.863 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:51.115Z,1668535011.115 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:51.367Z,1668535011.367 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:51.619Z,1668535011.619 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:51.871Z,1668535011.871 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:52.123Z,1668535012.123 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:52.375Z,1668535012.375 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:52.627Z,1668535012.627 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:52.879Z,1668535012.879 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:53.131Z,1668535013.131 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:53.383Z,1668535013.383 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:53.635Z,1668535013.635 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:53.887Z,1668535013.887 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:54.129Z,1668535014.129 [multiray_test:G.Wait](INFO): Done Waiting.
2022-11-15T17:56:54.129Z,1668535014.129 [multiray_test:G.Wait] Stopped
2022-11-15T17:56:54.129Z,1668535014.129 [multiray_test:G.Wait](DEBUG): Uninitialize Wait Component.
2022-11-15T17:56:54.129Z,1668535014.129 [multiray_test:H] Running Loop=1
2022-11-15T17:56:54.139Z,1668535014.139 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:54.391Z,1668535014.391 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:54.570Z,1668535014.570 [multiray_test:H] Stopped
2022-11-15T17:56:54.571Z,1668535014.571 [multiray_test:I.Wait] Running Loop=1
2022-11-15T17:56:54.571Z,1668535014.571 [multiray_test:I.Wait](DEBUG): Initialize Wait Component.
2022-11-15T17:56:54.643Z,1668535014.643 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:54.895Z,1668535014.895 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:55.147Z,1668535015.147 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:55.336Z,1668535015.336 [MultiRay](INFO): All lights off failed! Try again next cycle
2022-11-15T17:56:55.399Z,1668535015.399 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:55.651Z,1668535015.651 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:55.903Z,1668535015.903 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:56.144Z,1668535016.144 [MultiRay](INFO): All lights off failed! Try again next cycle
2022-11-15T17:56:56.155Z,1668535016.155 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:56.407Z,1668535016.407 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:56.659Z,1668535016.659 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:56.911Z,1668535016.911 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:56.952Z,1668535016.952 [MultiRay](INFO): All lights off failed! Try again next cycle
2022-11-15T17:56:57.131Z,1668535017.131 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2022-11-15T17:56:57.131Z,1668535017.131 [CTD_Seabird] Communications Fault, FailCount= 3
2022-11-15T17:56:57.131Z,1668535017.131 [CTD_Seabird](ERROR): Communications Fault
2022-11-15T17:56:57.163Z,1668535017.163 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:57.414Z,1668535017.414 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2022-11-15T17:56:57.414Z,1668535017.414 [CBIT](FAULT): Communications Fault in component: CTD_Seabird
2022-11-15T17:56:57.415Z,1668535017.415 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:57.535Z,1668535017.535 [CTD_Seabird](INFO): Powering down
2022-11-15T17:56:57.667Z,1668535017.667 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:57.760Z,1668535017.760 [MultiRay](INFO): All lights off failed! Try again next cycle
2022-11-15T17:56:57.919Z,1668535017.919 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:58.174Z,1668535018.174 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:58.423Z,1668535018.423 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:58.568Z,1668535018.568 [MultiRay](INFO): All lights off failed! Try again next cycle
2022-11-15T17:56:58.675Z,1668535018.675 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:58.927Z,1668535018.927 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:58.927Z,1668535018.927 [DAT](FAULT): failed to enter command mode
2022-11-15T17:56:59.231Z,1668535019.231 [DAT](INFO): entering command mode
2022-11-15T17:56:59.376Z,1668535019.376 [MultiRay](INFO): All lights off failed! Try again next cycle
2022-11-15T17:56:59.431Z,1668535019.431 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:59.683Z,1668535019.683 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:56:59.935Z,1668535019.935 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:00.184Z,1668535020.184 [MultiRay](INFO): All lights off failed! Try again next cycle
2022-11-15T17:57:00.187Z,1668535020.187 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:00.209Z,1668535020.209 [multiray_test:I.Wait](INFO): Done Waiting.
2022-11-15T17:57:00.209Z,1668535020.209 [multiray_test:I.Wait] Stopped
2022-11-15T17:57:00.209Z,1668535020.209 [multiray_test:I.Wait](DEBUG): Uninitialize Wait Component.
2022-11-15T17:57:00.209Z,1668535020.209 [multiray_test:J] Running Loop=1
2022-11-15T17:57:00.439Z,1668535020.439 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:00.645Z,1668535020.645 [multiray_test:J] Stopped
2022-11-15T17:57:00.645Z,1668535020.645 [multiray_test:K.Wait] Running Loop=1
2022-11-15T17:57:00.645Z,1668535020.645 [multiray_test:K.Wait](DEBUG): Initialize Wait Component.
2022-11-15T17:57:00.691Z,1668535020.691 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:00.943Z,1668535020.943 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:01.195Z,1668535021.195 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:01.447Z,1668535021.447 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:01.699Z,1668535021.699 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:01.951Z,1668535021.951 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:02.203Z,1668535022.203 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:02.235Z,1668535022.235 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2022-11-15T17:57:02.235Z,1668535022.235 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2
2022-11-15T17:57:02.235Z,1668535022.235 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2022-11-15T17:57:02.236Z,1668535022.236 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2022-11-15T17:57:02.236Z,1668535022.236 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 2
2022-11-15T17:57:02.236Z,1668535022.236 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2022-11-15T17:57:02.256Z,1668535022.256 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2022-11-15T17:57:02.256Z,1668535022.256 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2022-11-15T17:57:02.455Z,1668535022.455 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:02.672Z,1668535022.672 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2022-11-15T17:57:02.673Z,1668535022.673 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2
2022-11-15T17:57:02.673Z,1668535022.673 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2022-11-15T17:57:02.673Z,1668535022.673 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 2
2022-11-15T17:57:02.707Z,1668535022.707 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:02.959Z,1668535022.959 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:03.031Z,1668535023.031 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2022-11-15T17:57:03.211Z,1668535023.211 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:03.463Z,1668535023.463 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:03.715Z,1668535023.715 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:03.967Z,1668535023.967 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:04.090Z,1668535024.090 [CommandExec](IMPORTANT): got command run ./Missions/Maintenance/multiray_test.xml
2022-11-15T17:57:04.090Z,1668535024.090 [MissionManager](INFO): Uninitializing Mission multiray_test
2022-11-15T17:57:04.090Z,1668535024.090 [multiray_test] Stopped
2022-11-15T17:57:04.090Z,1668535024.090 [multiray_test](DEBUG): Aggregate::uninitialize multiray_test
2022-11-15T17:57:04.090Z,1668535024.090 [multiray_test:A] Stopped
2022-11-15T17:57:04.090Z,1668535024.090 [multiray_test:K.Wait] Stopped
2022-11-15T17:57:04.091Z,1668535024.091 [multiray_test:K.Wait](DEBUG): Uninitialize Wait Component.
2022-11-15T17:57:04.095Z,1668535024.095 [MissionManager](INFO): Loading Mission from file: ./Missions/Maintenance/multiray_test.xml
2022-11-15T17:57:04.178Z,1668535024.178 [MissionManager](INFO): DefineArg multiray_test.MissionTimeout = 5.000000 min
2022-11-15T17:57:04.180Z,1668535024.180 [MissionManager](INFO): DefineArg multiray_test.LightDuration = 5.000000 s
2022-11-15T17:57:04.184Z,1668535024.184 [MissionManager](INFO): DefineArg multiray_test.LightMode0 = 0.000000 count
2022-11-15T17:57:04.186Z,1668535024.186 [MissionManager](INFO): DefineArg multiray_test.LightMode1 = 1.000000 count
2022-11-15T17:57:04.188Z,1668535024.188 [MissionManager](INFO): DefineArg multiray_test.LightMode2 = 2.000000 count
2022-11-15T17:57:04.190Z,1668535024.190 [MissionManager](INFO): DefineArg multiray_test.EnabledMultiray = 1 bool
2022-11-15T17:57:04.194Z,1668535024.194 [multiray_test:C.Wait](DEBUG): Construct Wait.
2022-11-15T17:57:04.196Z,1668535024.196 [multiray_test:E.Wait](DEBUG): Construct Wait.
2022-11-15T17:57:04.199Z,1668535024.199 [multiray_test:G.Wait](DEBUG): Construct Wait.
2022-11-15T17:57:04.202Z,1668535024.202 [multiray_test:I.Wait](DEBUG): Construct Wait.
2022-11-15T17:57:04.219Z,1668535024.219 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:04.272Z,1668535024.272 [multiray_test:K.Wait](DEBUG): Construct Wait.
2022-11-15T17:57:04.274Z,1668535024.274 [multiray_test:M.Wait](DEBUG): Construct Wait.
2022-11-15T17:57:04.293Z,1668535024.293 [multiray_test:O.Wait](DEBUG): Construct Wait.
2022-11-15T17:57:04.295Z,1668535024.295 [multiray_test:Q.Wait](DEBUG): Construct Wait.
2022-11-15T17:57:04.298Z,1668535024.298 [multiray_test:R.Wait](DEBUG): Construct Wait.
2022-11-15T17:57:04.313Z,1668535024.313 [multiray_test:T.Wait](DEBUG): Construct Wait.
2022-11-15T17:57:04.332Z,1668535024.332 [MissionManager](DEBUG): 
<?xml version="1.0" encoding="UTF-8"?>

<Mission xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"
         xmlns="Tethys"
         xmlns:Guidance="Tethys/Guidance"
         xmlns:Units="Tethys/Units"
         xmlns:Sample="Tethys/Sample"
         xmlns:Sensor="Tethys/Sensor"
         xsi:schemaLocation="Tethys http://okeanids.mbari.org/tethys/Xml/Tethys.xsd
                             Tethys/Units http://okeanids.mbari.org/tethys/Xml/Units.xsd
                             Tethys/Sensor http://okeanids.mbari.org/tethys/Xml/Sensor.xsd"
       Id="multiray_test">

    <Description>
        This mission is designed to run in the lab only. Cycles through MultiRay light modes
    </Description>

    <DefineArg Name="MissionTimeout"><Description>
        How long to let the mission run.
    </Description><Units:minute/><Value>5</Value></DefineArg>

    <DefineArg Name="LightDuration"><Description>
        How long to wait before changing light modes
    </Description><Units:second/><Value>5</Value></DefineArg>

    <DefineArg Name="LightMode0"><Description>
        Light mode = 0
    </Description><Units:count/><Value>0</Value></DefineArg>

    <DefineArg Name="LightMode1"><Description>
        Light mode = 1
    </Description><Units:count/><Value>1</Value></DefineArg>

    <DefineArg Name="LightMode2"><Description>
        Light mode = 2
    </Description><Units:count/><Value>2</Value></DefineArg>

    <DefineArg Name="EnabledMultiray"><Description>
        Automatically set to true if the Multiray is enabled.
    </Description><Science:MultiRay.loadAtStartup/></DefineArg>

    <Timeout Duration="MissionTimeout"/>



    <ReadData Strategy="MinError">
        <While>
            <Arg Name="EnabledMultiray"/>
        </While>
    <Sensor:MultiRay.lightModeLog/>
    </ReadData>


    <!-- <ReadDatum>
            <Sensor:MultiRay.lightModeLog/>
    </ReadDatum> -->

    <Assign><Sequence/><Sensor:MultiRay.lightModeCommand/><Arg Name="LightMode0"/></Assign>    
    <Guidance:Wait>
                <Sequence/>
                <Setting><Guidance:Wait.duration/><Arg Name="LightDuration"/></Setting>
            </Guidance:Wait>

    <Assign><Sequence/><Sensor:MultiRay.lightModeCommand/><Arg Name="LightMode1"/></Assign>    
    <Guidance:Wait>
                <Sequence/>
                <Setting><Guidance:Wait.duration/><Arg Name="LightDuration"/></Setting>
            </Guidance:Wait>

    <Assign><Sequence/><Sensor:MultiRay.lightModeCommand/><Arg Name="LightMode2"/></Assign>    
    <Guidance:Wait>
                <Sequence/>
                <Setting><Guidance:Wait.duration/><Arg Name="LightDuration"/></Setting>
            </Guidance:Wait>

    <Assign><Sequence/><Sensor:MultiRay.lightModeCommand/><Arg Name="LightMode0"/></Assign>    
    <Guidance:Wait>
                <Sequence/>
                <Setting><Guidance:Wait.duration/><Arg Name="LightDuration"/></Setting>
            </Guidance:Wait>
    
    <Assign><Sequence/><Sensor:MultiRay.lightModeCommand/><Arg Name="LightMode1"/></Assign>    
    <Guidance:Wait>
                <Sequence/>
                <Setting><Guidance:Wait.duration/><Arg Name="LightDuration"/></Setting>
            </Guidance:Wait>

    <Assign><Sequence/><Sensor:MultiRay.lightModeCommand/><Arg Name="LightMode2"/></Assign>    
    <Guidance:Wait>
                <Sequence/>
                <Setting><Guidance:Wait.duration/><Arg Name="LightDuration"/></Setting>
            </Guidance:Wait>

    <Assign><Sequence/><Sensor:MultiRay.lightModeCommand/><Arg Name="LightMode0"/></Assign>    
    <Guidance:Wait>
                <Sequence/>
                <Setting><Guidance:Wait.duration/><Arg Name="LightDuration"/></Setting>
            </Guidance:Wait>

    <Assign><Sequence/><Sensor:MultiRay.lightModeCommand/><Arg Name="LightMode1"/></Assign>    
    <Guidance:Wait>
                <Sequence/>
                <Setting><Guidance:Wait.duration/><Arg Name="LightDuration"/></Setting>
            </Guidance:Wait>

    <Assign><Sequence/><Sensor:MultiRay.lightModeCommand/><Arg Name="LightMode2"/></Assign>    
    <Guidance:Wait>
                <Sequence/>
                <Setting><Guidance:Wait.duration/><Arg Name="LightDuration"/></Setting>
            </Guidance:Wait>

    <Assign><Sequence/><Sensor:MultiRay.lightModeCommand/><Arg Name="LightMode0"/></Assign>    
    <Guidance:Wait>
                <Sequence/>
                <Setting><Guidance:Wait.duration/><Arg Name="LightDuration"/></Setting>
            </Guidance:Wait>

</Mission>


2022-11-15T17:57:04.334Z,1668535024.334 [CommandExec](IMPORTANT): Running ./Missions/Maintenance/multiray_test.xml
2022-11-15T17:57:04.384Z,1668535024.384 [MissionManager](IMPORTANT): Started mission multiray_test
2022-11-15T17:57:04.385Z,1668535024.385 [multiray_test] Running Loop=1
2022-11-15T17:57:04.385Z,1668535024.385 [multiray_test](DEBUG): Aggregate::initialize multiray_test
2022-11-15T17:57:04.385Z,1668535024.385 [multiray_test:A] Running Loop=1
2022-11-15T17:57:04.385Z,1668535024.385 [multiray_test:B] Running Loop=1
2022-11-15T17:57:04.386Z,1668535024.386 [multiray_test:B] Stopped
2022-11-15T17:57:04.386Z,1668535024.386 [multiray_test:C.Wait] Running Loop=1
2022-11-15T17:57:04.386Z,1668535024.386 [multiray_test:C.Wait](DEBUG): Initialize Wait Component.
2022-11-15T17:57:04.386Z,1668535024.386 [multiray_test:A] Running Loop=1
2022-11-15T17:57:04.387Z,1668535024.387 [multiray_test:A](DEBUG): Initialize ReadDataComponent to sense MultiRay.lightModeLog
2022-11-15T17:57:04.472Z,1668535024.472 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:04.723Z,1668535024.723 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:04.975Z,1668535024.975 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:05.227Z,1668535025.227 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:05.479Z,1668535025.479 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:05.731Z,1668535025.731 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:05.984Z,1668535025.984 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:06.239Z,1668535026.239 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:06.491Z,1668535026.491 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:06.743Z,1668535026.743 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:06.995Z,1668535026.995 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:07.247Z,1668535027.247 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:07.499Z,1668535027.499 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:07.751Z,1668535027.751 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:08.003Z,1668535028.003 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:08.257Z,1668535028.257 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:08.507Z,1668535028.507 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:08.759Z,1668535028.759 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:09.011Z,1668535029.011 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:09.263Z,1668535029.263 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:09.515Z,1668535029.515 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:09.767Z,1668535029.767 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:10.019Z,1668535030.019 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:10.276Z,1668535030.276 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:10.292Z,1668535030.292 [multiray_test:C.Wait](INFO): Done Waiting.
2022-11-15T17:57:10.292Z,1668535030.292 [multiray_test:C.Wait] Stopped
2022-11-15T17:57:10.292Z,1668535030.292 [multiray_test:C.Wait](DEBUG): Uninitialize Wait Component.
2022-11-15T17:57:10.292Z,1668535030.292 [multiray_test:D] Running Loop=1
2022-11-15T17:57:10.523Z,1668535030.523 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:10.697Z,1668535030.697 [multiray_test:D] Stopped
2022-11-15T17:57:10.697Z,1668535030.697 [multiray_test:E.Wait] Running Loop=1
2022-11-15T17:57:10.697Z,1668535030.697 [multiray_test:E.Wait](DEBUG): Initialize Wait Component.
2022-11-15T17:57:10.775Z,1668535030.775 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:11.027Z,1668535031.027 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:11.279Z,1668535031.279 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:11.531Z,1668535031.531 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:11.783Z,1668535031.783 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:12.035Z,1668535032.035 [DAT](FAULT): failed to initialize, no bytes available on serial interface
2022-11-15T17:57:12.035Z,1668535032.035 [DAT] Communications Fault, FailCount= 4
2022-11-15T17:57:12.035Z,1668535032.035 [DAT](ERROR): Communications Fault
2022-11-15T17:57:12.354Z,1668535032.354 [CBIT](ERROR): Communications Fault in component: DAT
2022-11-15T17:57:12.439Z,1668535032.439 [DAT](INFO): Powering down
2022-11-15T17:57:13.569Z,1668535033.569 [CBIT](INFO): Clearing failed state for component DAT
2022-11-15T17:57:13.569Z,1668535033.569 [DAT] No Fault, FailCount= 4
2022-11-15T17:57:15.495Z,1668535035.495 [DAT](INFO): Powering up
2022-11-15T17:57:15.495Z,1668535035.495 [DAT](DEBUG): Initializing DAT.
2022-11-15T17:57:16.388Z,1668535036.388 [multiray_test:E.Wait](INFO): Done Waiting.
2022-11-15T17:57:16.388Z,1668535036.388 [multiray_test:E.Wait] Stopped
2022-11-15T17:57:16.388Z,1668535036.388 [multiray_test:E.Wait](DEBUG): Uninitialize Wait Component.
2022-11-15T17:57:16.388Z,1668535036.388 [multiray_test:F] Running Loop=1
2022-11-15T17:57:16.801Z,1668535036.801 [multiray_test:F] Stopped
2022-11-15T17:57:16.801Z,1668535036.801 [multiray_test:G.Wait] Running Loop=1
2022-11-15T17:57:16.801Z,1668535036.801 [multiray_test:G.Wait](DEBUG): Initialize Wait Component.
2022-11-15T17:57:22.438Z,1668535042.438 [multiray_test:G.Wait](INFO): Done Waiting.
2022-11-15T17:57:22.439Z,1668535042.439 [multiray_test:G.Wait] Stopped
2022-11-15T17:57:22.439Z,1668535042.439 [multiray_test:G.Wait](DEBUG): Uninitialize Wait Component.
2022-11-15T17:57:22.439Z,1668535042.439 [multiray_test:H] Running Loop=1
2022-11-15T17:57:22.861Z,1668535042.861 [multiray_test:H] Stopped
2022-11-15T17:57:22.861Z,1668535042.861 [multiray_test:I.Wait] Running Loop=1
2022-11-15T17:57:22.862Z,1668535042.862 [multiray_test:I.Wait](DEBUG): Initialize Wait Component.
2022-11-15T17:57:23.616Z,1668535043.616 [MultiRay](INFO): All lights off failed! Try again next cycle
2022-11-15T17:57:24.424Z,1668535044.424 [MultiRay](INFO): All lights off failed! Try again next cycle
2022-11-15T17:57:25.232Z,1668535045.232 [MultiRay](INFO): All lights off failed! Try again next cycle
2022-11-15T17:57:26.040Z,1668535046.040 [MultiRay](INFO): All lights off failed! Try again next cycle
2022-11-15T17:57:26.845Z,1668535046.845 [MultiRay](INFO): All lights off failed! Try again next cycle
2022-11-15T17:57:27.656Z,1668535047.656 [MultiRay](INFO): All lights off failed! Try again next cycle
2022-11-15T17:57:28.466Z,1668535048.466 [MultiRay](INFO): All lights off failed! Try again next cycle
2022-11-15T17:57:28.507Z,1668535048.507 [multiray_test:I.Wait](INFO): Done Waiting.
2022-11-15T17:57:28.507Z,1668535048.507 [multiray_test:I.Wait] Stopped
2022-11-15T17:57:28.507Z,1668535048.507 [multiray_test:I.Wait](DEBUG): Uninitialize Wait Component.
2022-11-15T17:57:28.507Z,1668535048.507 [multiray_test:J] Running Loop=1
2022-11-15T17:57:28.930Z,1668535048.930 [multiray_test:J] Stopped
2022-11-15T17:57:28.930Z,1668535048.930 [multiray_test:K.Wait] Running Loop=1
2022-11-15T17:57:28.930Z,1668535048.930 [multiray_test:K.Wait](DEBUG): Initialize Wait Component.
2022-11-15T17:57:30.125Z,1668535050.125 [DAT](INFO): commRate: 800
2022-11-15T17:57:32.191Z,1668535052.191 [DAT](INFO): entering command mode
2022-11-15T17:57:32.391Z,1668535052.391 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:32.643Z,1668535052.643 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:32.900Z,1668535052.900 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:33.147Z,1668535053.147 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:33.399Z,1668535053.399 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:33.651Z,1668535053.651 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:33.903Z,1668535053.903 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:34.157Z,1668535054.157 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:34.407Z,1668535054.407 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:34.533Z,1668535054.533 [multiray_test:K.Wait](INFO): Done Waiting.
2022-11-15T17:57:34.533Z,1668535054.533 [multiray_test:K.Wait] Stopped
2022-11-15T17:57:34.533Z,1668535054.533 [multiray_test:K.Wait](DEBUG): Uninitialize Wait Component.
2022-11-15T17:57:34.533Z,1668535054.533 [multiray_test:L] Running Loop=1
2022-11-15T17:57:34.659Z,1668535054.659 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:34.911Z,1668535054.911 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:34.977Z,1668535054.977 [multiray_test:L] Stopped
2022-11-15T17:57:34.977Z,1668535054.977 [multiray_test:M.Wait] Running Loop=1
2022-11-15T17:57:34.977Z,1668535054.977 [multiray_test:M.Wait](DEBUG): Initialize Wait Component.
2022-11-15T17:57:35.163Z,1668535055.163 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:35.415Z,1668535055.415 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:35.667Z,1668535055.667 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:35.919Z,1668535055.919 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:36.173Z,1668535056.173 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:36.423Z,1668535056.423 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:36.675Z,1668535056.675 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:36.927Z,1668535056.927 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:37.179Z,1668535057.179 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:37.431Z,1668535057.431 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:37.683Z,1668535057.683 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:37.935Z,1668535057.935 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:38.187Z,1668535058.187 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:38.439Z,1668535058.439 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:38.691Z,1668535058.691 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:38.943Z,1668535058.943 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:39.195Z,1668535059.195 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:39.447Z,1668535059.447 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:39.699Z,1668535059.699 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:39.951Z,1668535059.951 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:40.205Z,1668535060.205 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:40.455Z,1668535060.455 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:40.633Z,1668535060.633 [multiray_test:M.Wait](INFO): Done Waiting.
2022-11-15T17:57:40.633Z,1668535060.633 [multiray_test:M.Wait] Stopped
2022-11-15T17:57:40.633Z,1668535060.633 [multiray_test:M.Wait](DEBUG): Uninitialize Wait Component.
2022-11-15T17:57:40.633Z,1668535060.633 [multiray_test:N] Running Loop=1
2022-11-15T17:57:40.707Z,1668535060.707 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:40.959Z,1668535060.959 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:41.032Z,1668535061.032 [multiray_test:N] Stopped
2022-11-15T17:57:41.032Z,1668535061.032 [multiray_test:O.Wait] Running Loop=1
2022-11-15T17:57:41.033Z,1668535061.033 [multiray_test:O.Wait](DEBUG): Initialize Wait Component.
2022-11-15T17:57:41.211Z,1668535061.211 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:41.463Z,1668535061.463 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:41.715Z,1668535061.715 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:41.900Z,1668535061.900 [MultiRay](INFO): All lights off failed! Try again next cycle
2022-11-15T17:57:41.967Z,1668535061.967 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:42.221Z,1668535062.221 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:42.471Z,1668535062.471 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:42.612Z,1668535062.612 [MultiRay](INFO): All lights off failed! Try again next cycle
2022-11-15T17:57:42.723Z,1668535062.723 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:42.975Z,1668535062.975 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:43.227Z,1668535063.227 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:43.408Z,1668535063.408 [MultiRay](INFO): All lights off failed! Try again next cycle
2022-11-15T17:57:43.479Z,1668535063.479 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:43.731Z,1668535063.731 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:43.983Z,1668535063.983 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:44.235Z,1668535064.235 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:44.277Z,1668535064.277 [MultiRay](INFO): All lights off failed! Try again next cycle
2022-11-15T17:57:44.487Z,1668535064.487 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:44.739Z,1668535064.739 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:44.996Z,1668535064.996 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:45.043Z,1668535065.043 [MultiRay](INFO): All lights off failed! Try again next cycle
2022-11-15T17:57:45.247Z,1668535065.247 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:45.499Z,1668535065.499 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:45.751Z,1668535065.751 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:45.836Z,1668535065.836 [MultiRay](INFO): All lights off failed! Try again next cycle
2022-11-15T17:57:46.003Z,1668535066.003 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:46.257Z,1668535066.257 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:46.507Z,1668535066.507 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:46.644Z,1668535066.644 [MultiRay](INFO): All lights off failed! Try again next cycle
2022-11-15T17:57:46.668Z,1668535066.668 [multiray_test:O.Wait](INFO): Done Waiting.
2022-11-15T17:57:46.669Z,1668535066.669 [multiray_test:O.Wait] Stopped
2022-11-15T17:57:46.669Z,1668535066.669 [multiray_test:O.Wait](DEBUG): Uninitialize Wait Component.
2022-11-15T17:57:46.669Z,1668535066.669 [multiray_test:P] Running Loop=1
2022-11-15T17:57:46.759Z,1668535066.759 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:47.011Z,1668535067.011 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:47.089Z,1668535067.089 [multiray_test:P] Stopped
2022-11-15T17:57:47.089Z,1668535067.089 [multiray_test:Q.Wait] Running Loop=1
2022-11-15T17:57:47.089Z,1668535067.089 [multiray_test:Q.Wait](DEBUG): Initialize Wait Component.
2022-11-15T17:57:47.264Z,1668535067.264 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:47.264Z,1668535067.264 [DAT](FAULT): failed to enter command mode
2022-11-15T17:57:47.567Z,1668535067.567 [DAT](INFO): entering command mode
2022-11-15T17:57:47.767Z,1668535067.767 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:48.019Z,1668535068.019 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:48.274Z,1668535068.274 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:48.523Z,1668535068.523 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:48.775Z,1668535068.775 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:49.027Z,1668535069.027 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:49.279Z,1668535069.279 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:49.531Z,1668535069.531 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:49.783Z,1668535069.783 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:50.035Z,1668535070.035 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:50.287Z,1668535070.287 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:50.539Z,1668535070.539 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:50.791Z,1668535070.791 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:51.043Z,1668535071.043 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:51.295Z,1668535071.295 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:51.551Z,1668535071.551 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:51.803Z,1668535071.803 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:52.055Z,1668535072.055 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:52.307Z,1668535072.307 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:52.559Z,1668535072.559 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:52.713Z,1668535072.713 [multiray_test:Q.Wait](INFO): Done Waiting.
2022-11-15T17:57:52.713Z,1668535072.713 [multiray_test:Q.Wait] Stopped
2022-11-15T17:57:52.713Z,1668535072.713 [multiray_test:Q.Wait](DEBUG): Uninitialize Wait Component.
2022-11-15T17:57:52.713Z,1668535072.713 [multiray_test:U] Running Loop=1
2022-11-15T17:57:52.811Z,1668535072.811 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:53.063Z,1668535073.063 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:53.163Z,1668535073.163 [multiray_test:U] Stopped
2022-11-15T17:57:53.163Z,1668535073.163 [multiray_test:R.Wait] Running Loop=1
2022-11-15T17:57:53.163Z,1668535073.163 [multiray_test:R.Wait](DEBUG): Initialize Wait Component.
2022-11-15T17:57:53.315Z,1668535073.315 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:53.567Z,1668535073.567 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:53.819Z,1668535073.819 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:54.071Z,1668535074.071 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:54.323Z,1668535074.323 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:54.575Z,1668535074.575 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:54.827Z,1668535074.827 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:55.079Z,1668535075.079 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:55.331Z,1668535075.331 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:55.583Z,1668535075.583 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:55.835Z,1668535075.835 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:56.087Z,1668535076.087 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:56.339Z,1668535076.339 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:56.591Z,1668535076.591 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:56.843Z,1668535076.843 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:57.095Z,1668535077.095 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:57.347Z,1668535077.347 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:57.599Z,1668535077.599 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:57.851Z,1668535077.851 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:58.104Z,1668535078.104 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:58.355Z,1668535078.355 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:58.607Z,1668535078.607 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:58.805Z,1668535078.805 [multiray_test:R.Wait](INFO): Done Waiting.
2022-11-15T17:57:58.805Z,1668535078.805 [multiray_test:R.Wait] Stopped
2022-11-15T17:57:58.805Z,1668535078.805 [multiray_test:R.Wait](DEBUG): Uninitialize Wait Component.
2022-11-15T17:57:58.805Z,1668535078.805 [multiray_test:S] Running Loop=1
2022-11-15T17:57:58.859Z,1668535078.859 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:59.111Z,1668535079.111 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:59.220Z,1668535079.220 [multiray_test:S] Stopped
2022-11-15T17:57:59.220Z,1668535079.220 [multiray_test:T.Wait] Running Loop=1
2022-11-15T17:57:59.220Z,1668535079.220 [multiray_test:T.Wait](DEBUG): Initialize Wait Component.
2022-11-15T17:57:59.363Z,1668535079.363 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:59.617Z,1668535079.617 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:59.867Z,1668535079.867 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:57:59.976Z,1668535079.976 [MultiRay](INFO): All lights off failed! Try again next cycle
2022-11-15T17:58:00.119Z,1668535080.119 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:00.372Z,1668535080.372 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:00.623Z,1668535080.623 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:00.784Z,1668535080.784 [MultiRay](INFO): All lights off failed! Try again next cycle
2022-11-15T17:58:00.875Z,1668535080.875 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:01.127Z,1668535081.127 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:01.379Z,1668535081.379 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:01.602Z,1668535081.602 [MultiRay](INFO): All lights off failed! Try again next cycle
2022-11-15T17:58:01.631Z,1668535081.631 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:01.883Z,1668535081.883 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:02.135Z,1668535082.135 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:02.392Z,1668535082.392 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:02.397Z,1668535082.397 [MultiRay](INFO): All lights off failed! Try again next cycle
2022-11-15T17:58:02.639Z,1668535082.639 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:02.639Z,1668535082.639 [DAT](FAULT): failed to enter command mode
2022-11-15T17:58:02.951Z,1668535082.951 [DAT](INFO): entering command mode
2022-11-15T17:58:03.151Z,1668535083.151 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:03.205Z,1668535083.205 [MultiRay](INFO): All lights off failed! Try again next cycle
2022-11-15T17:58:03.403Z,1668535083.403 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:03.655Z,1668535083.655 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:03.907Z,1668535083.907 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:04.016Z,1668535084.016 [MultiRay](INFO): All lights off failed! Try again next cycle
2022-11-15T17:58:04.159Z,1668535084.159 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:04.411Z,1668535084.411 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:04.663Z,1668535084.663 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:04.824Z,1668535084.824 [MultiRay](INFO): All lights off failed! Try again next cycle
2022-11-15T17:58:04.853Z,1668535084.853 [multiray_test:T.Wait](INFO): Done Waiting.
2022-11-15T17:58:04.853Z,1668535084.853 [multiray_test:T.Wait] Stopped
2022-11-15T17:58:04.853Z,1668535084.853 [multiray_test:T.Wait](DEBUG): Uninitialize Wait Component.
2022-11-15T17:58:04.854Z,1668535084.854 [multiray_test](INFO): Completed multiray_test
2022-11-15T17:58:04.854Z,1668535084.854 [MissionManager](INFO): multiray_test is completed.
2022-11-15T17:58:04.854Z,1668535084.854 [MissionManager](INFO): Uninitializing Mission multiray_test
2022-11-15T17:58:04.854Z,1668535084.854 [multiray_test] Stopped
2022-11-15T17:58:04.854Z,1668535084.854 [multiray_test](DEBUG): Aggregate::uninitialize multiray_test
2022-11-15T17:58:04.854Z,1668535084.854 [multiray_test:A] Stopped
2022-11-15T17:58:04.915Z,1668535084.915 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:05.167Z,1668535085.167 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:05.239Z,1668535085.239 [MissionManager](IMPORTANT): Started mission Default
2022-11-15T17:58:05.239Z,1668535085.239 [Default] Running Loop=1
2022-11-15T17:58:05.239Z,1668535085.239 [Default](DEBUG): Aggregate::initialize Default
2022-11-15T17:58:05.240Z,1668535085.240 [Default:B.GoToSurface] Running Loop=1
2022-11-15T17:58:05.240Z,1668535085.240 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2022-11-15T17:58:05.240Z,1668535085.240 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2022-11-15T17:58:05.240Z,1668535085.240 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2022-11-15T17:58:05.241Z,1668535085.241 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2022-11-15T17:58:05.241Z,1668535085.241 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2022-11-15T17:58:05.242Z,1668535085.242 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2022-11-15T17:58:05.242Z,1668535085.242 [Default:A.Wait] Running Loop=1
2022-11-15T17:58:05.242Z,1668535085.242 [Default:A.Wait](DEBUG): Initialize Wait Component.
2022-11-15T17:58:05.419Z,1668535085.419 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:05.671Z,1668535085.671 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:05.923Z,1668535085.923 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:06.175Z,1668535086.175 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:06.432Z,1668535086.432 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:06.679Z,1668535086.679 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:06.931Z,1668535086.931 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:07.183Z,1668535087.183 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:07.435Z,1668535087.435 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:07.687Z,1668535087.687 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:07.939Z,1668535087.939 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:08.191Z,1668535088.191 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:08.443Z,1668535088.443 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:08.695Z,1668535088.695 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:08.947Z,1668535088.947 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:09.199Z,1668535089.199 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:09.451Z,1668535089.451 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:09.703Z,1668535089.703 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:09.955Z,1668535089.955 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:10.207Z,1668535090.207 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:10.459Z,1668535090.459 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:10.711Z,1668535090.711 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:10.963Z,1668535090.963 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:11.215Z,1668535091.215 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:11.467Z,1668535091.467 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:11.719Z,1668535091.719 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:11.971Z,1668535091.971 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:12.223Z,1668535092.223 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:12.475Z,1668535092.475 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:12.727Z,1668535092.727 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:12.979Z,1668535092.979 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:13.231Z,1668535093.231 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:13.483Z,1668535093.483 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:13.735Z,1668535093.735 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:13.987Z,1668535093.987 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:14.239Z,1668535094.239 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:14.491Z,1668535094.491 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:14.743Z,1668535094.743 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:14.995Z,1668535094.995 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:15.247Z,1668535095.247 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:15.499Z,1668535095.499 [DAT](FAULT): failed to initialize, no bytes available on serial interface
2022-11-15T17:58:15.499Z,1668535095.499 [DAT] Communications Fault, FailCount= 5
2022-11-15T17:58:15.499Z,1668535095.499 [DAT](ERROR): Communications Fault
2022-11-15T17:58:15.758Z,1668535095.758 [CBIT](ERROR): Communications Fault in component: DAT
2022-11-15T17:58:15.903Z,1668535095.903 [DAT](INFO): Powering down
2022-11-15T17:58:16.973Z,1668535096.973 [CBIT](INFO): Clearing failed state for component DAT
2022-11-15T17:58:16.973Z,1668535096.973 [DAT] No Fault, FailCount= 5
2022-11-15T17:58:18.592Z,1668535098.592 [Default:A.Wait](INFO): Done Waiting.
2022-11-15T17:58:18.592Z,1668535098.592 [Default:A.Wait] Stopped
2022-11-15T17:58:18.592Z,1668535098.592 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2022-11-15T17:58:18.959Z,1668535098.959 [DAT](INFO): Powering up
2022-11-15T17:58:18.959Z,1668535098.959 [DAT](DEBUG): Initializing DAT.
2022-11-15T17:58:19.002Z,1668535099.002 [Default:CheckIn] Running Loop=1
2022-11-15T17:58:19.002Z,1668535099.002 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2022-11-15T17:58:19.002Z,1668535099.002 [Default:CheckIn:Read_GPS] Running Loop=1
2022-11-15T17:58:19.401Z,1668535099.401 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2022-11-15T17:58:33.573Z,1668535113.573 [DAT](INFO): commRate: 800
2022-11-15T17:58:35.639Z,1668535115.639 [DAT](INFO): entering command mode
2022-11-15T17:58:35.839Z,1668535115.839 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:36.091Z,1668535116.091 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:36.347Z,1668535116.347 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:36.599Z,1668535116.599 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:36.851Z,1668535116.851 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:37.103Z,1668535117.103 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:37.355Z,1668535117.355 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:37.607Z,1668535117.607 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:37.859Z,1668535117.859 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:38.111Z,1668535118.111 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:38.363Z,1668535118.363 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:38.615Z,1668535118.615 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:38.867Z,1668535118.867 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:39.119Z,1668535119.119 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:39.371Z,1668535119.371 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:39.623Z,1668535119.623 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:39.875Z,1668535119.875 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:40.127Z,1668535120.127 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:40.379Z,1668535120.379 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:40.631Z,1668535120.631 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:40.883Z,1668535120.883 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:41.135Z,1668535121.135 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:41.387Z,1668535121.387 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:41.640Z,1668535121.640 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:41.891Z,1668535121.891 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:42.143Z,1668535122.143 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:42.396Z,1668535122.396 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:42.647Z,1668535122.647 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:42.899Z,1668535122.899 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:43.151Z,1668535123.151 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:43.403Z,1668535123.403 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:43.608Z,1668535123.608 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2022-11-15T17:58:43.656Z,1668535123.656 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:43.907Z,1668535123.907 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:44.159Z,1668535124.159 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:44.411Z,1668535124.411 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:44.663Z,1668535124.663 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:44.915Z,1668535124.915 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:45.167Z,1668535125.167 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:45.419Z,1668535125.419 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:45.671Z,1668535125.671 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:45.923Z,1668535125.923 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:46.175Z,1668535126.175 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:46.428Z,1668535126.428 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:46.679Z,1668535126.679 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:46.931Z,1668535126.931 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:47.183Z,1668535127.183 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:47.435Z,1668535127.435 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:47.687Z,1668535127.687 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:47.939Z,1668535127.939 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:48.191Z,1668535128.191 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:48.448Z,1668535128.448 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:48.695Z,1668535128.695 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:48.947Z,1668535128.947 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:49.199Z,1668535129.199 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:49.451Z,1668535129.451 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:49.703Z,1668535129.703 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:49.955Z,1668535129.955 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:50.207Z,1668535130.207 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:50.459Z,1668535130.459 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:50.711Z,1668535130.711 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:50.711Z,1668535130.711 [DAT](FAULT): failed to enter command mode
2022-11-15T17:58:51.015Z,1668535131.015 [DAT](INFO): entering command mode
2022-11-15T17:58:51.215Z,1668535131.215 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:51.467Z,1668535131.467 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:51.719Z,1668535131.719 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:51.971Z,1668535131.971 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:52.223Z,1668535132.223 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:52.475Z,1668535132.475 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:52.727Z,1668535132.727 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:52.983Z,1668535132.983 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:53.235Z,1668535133.235 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:53.487Z,1668535133.487 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:53.739Z,1668535133.739 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:53.991Z,1668535133.991 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:54.243Z,1668535134.243 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:54.495Z,1668535134.495 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:54.747Z,1668535134.747 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:54.999Z,1668535134.999 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:55.251Z,1668535135.251 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:55.503Z,1668535135.503 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:55.755Z,1668535135.755 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:56.007Z,1668535136.007 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:56.259Z,1668535136.259 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:56.511Z,1668535136.511 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:56.763Z,1668535136.763 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:57.015Z,1668535137.015 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:57.267Z,1668535137.267 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:57.519Z,1668535137.519 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:57.771Z,1668535137.771 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:58.023Z,1668535138.023 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:58.275Z,1668535138.275 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:58.527Z,1668535138.527 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:58.779Z,1668535138.779 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:59.031Z,1668535139.031 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:59.283Z,1668535139.283 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:59.535Z,1668535139.535 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:58:59.787Z,1668535139.787 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:59:00.039Z,1668535140.039 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:59:00.291Z,1668535140.291 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:59:00.543Z,1668535140.543 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:59:00.796Z,1668535140.796 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:59:01.047Z,1668535141.047 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:59:01.299Z,1668535141.299 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:59:01.551Z,1668535141.551 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:59:01.803Z,1668535141.803 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:59:02.055Z,1668535142.055 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:59:02.307Z,1668535142.307 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:59:02.559Z,1668535142.559 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:59:02.811Z,1668535142.811 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:59:03.063Z,1668535143.063 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:59:03.315Z,1668535143.315 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:59:03.414Z,1668535143.414 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2022-11-15T17:59:03.414Z,1668535143.414 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3
2022-11-15T17:59:03.414Z,1668535143.414 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2022-11-15T17:59:03.416Z,1668535143.416 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2022-11-15T17:59:03.416Z,1668535143.416 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 3
2022-11-15T17:59:03.416Z,1668535143.416 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2022-11-15T17:59:03.429Z,1668535143.429 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2022-11-15T17:59:03.429Z,1668535143.429 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2022-11-15T17:59:03.567Z,1668535143.567 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:59:03.819Z,1668535143.819 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:59:03.898Z,1668535143.898 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2022-11-15T17:59:03.898Z,1668535143.898 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3
2022-11-15T17:59:03.898Z,1668535143.898 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2022-11-15T17:59:03.898Z,1668535143.898 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 3
2022-11-15T17:59:04.071Z,1668535144.071 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:59:04.234Z,1668535144.234 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2022-11-15T17:59:04.323Z,1668535144.323 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:59:04.575Z,1668535144.575 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:59:04.827Z,1668535144.827 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:59:05.079Z,1668535145.079 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:59:05.331Z,1668535145.331 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:59:05.583Z,1668535145.583 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:59:05.835Z,1668535145.835 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:59:06.087Z,1668535146.087 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:59:06.087Z,1668535146.087 [DAT](FAULT): failed to enter command mode
2022-11-15T17:59:06.391Z,1668535146.391 [DAT](INFO): entering command mode
2022-11-15T17:59:06.591Z,1668535146.591 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:59:06.843Z,1668535146.843 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:59:07.095Z,1668535147.095 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:59:07.347Z,1668535147.347 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:59:07.599Z,1668535147.599 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:59:07.851Z,1668535147.851 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:59:08.103Z,1668535148.103 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:59:08.355Z,1668535148.355 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:59:08.607Z,1668535148.607 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:59:08.684Z,1668535148.684 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL
2022-11-15T17:59:08.684Z,1668535148.684 [WetLabsBB2FL] No Fault, FailCount= 5
2022-11-15T17:59:08.828Z,1668535148.828 [WetLabsBB2FL](INFO): Powering up
2022-11-15T17:59:08.859Z,1668535148.859 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:59:09.111Z,1668535149.111 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:59:09.363Z,1668535149.363 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:59:09.615Z,1668535149.615 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:59:09.868Z,1668535149.868 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:59:10.119Z,1668535150.119 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:59:10.371Z,1668535150.371 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:59:10.623Z,1668535150.623 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:59:10.875Z,1668535150.875 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:59:11.127Z,1668535151.127 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:59:11.379Z,1668535151.379 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:59:11.499Z,1668535151.499 [CBIT](INFO): Clearing failed state for component AHRS_M2
2022-11-15T17:59:11.499Z,1668535151.499 [AHRS_M2] No Fault, FailCount= 5
2022-11-15T17:59:11.631Z,1668535151.631 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:59:11.760Z,1668535151.760 [CommandExec](IMPORTANT): got command restart application
2022-11-15T17:59:11.879Z,1668535151.879 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2022-11-15T17:59:11.883Z,1668535151.883 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:59:12.135Z,1668535152.135 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:59:12.387Z,1668535152.387 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:59:12.639Z,1668535152.639 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:59:12.763Z,1668535152.763 [Supervisor](INFO): Stop Mission called by Supervisor::terminate
2022-11-15T17:59:12.763Z,1668535152.763 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread.
2022-11-15T17:59:12.763Z,1668535152.763 [CommandExec](INFO): Uninitializing the command executive.
2022-11-15T17:59:12.763Z,1668535152.763 [CommandExec](INFO): Uninitializing the command scheduler.
2022-11-15T17:59:12.764Z,1668535152.764 [CommandExec ThreadHandler](INFO): Thread cancelled.
2022-11-15T17:59:12.767Z,1668535152.767 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup.  Bye!
2022-11-15T17:59:12.767Z,1668535152.767 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2022-11-15T17:59:12.767Z,1668535152.767 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2022-11-15T17:59:12.768Z,1668535152.768 [NavChartDb](INFO): Join timeout helper Thread ID is 7942
2022-11-15T17:59:12.827Z,1668535152.827 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2022-11-15T17:59:12.827Z,1668535152.827 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2022-11-15T17:59:12.833Z,1668535152.833 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2022-11-15T17:59:12.833Z,1668535152.833 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2022-11-15T17:59:12.833Z,1668535152.833 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 7943
2022-11-15T17:59:12.891Z,1668535152.891 [DAT](DEBUG): checking for command mode acknowledgment
2022-11-15T17:59:12.955Z,1668535152.955 [WetLabsBB2FL](INFO): Powering down
2022-11-15T17:59:12.956Z,1668535152.956 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread.
2022-11-15T17:59:12.956Z,1668535152.956 [WetLabsBB2FL](INFO): Powering down
2022-11-15T17:59:12.957Z,1668535152.957 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2022-11-15T17:59:12.963Z,1668535152.963 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler
2022-11-15T17:59:12.963Z,1668535152.963 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2022-11-15T17:59:12.963Z,1668535152.963 [CTD_Seabird](INFO): Join timeout helper Thread ID is 7944
2022-11-15T17:59:13.007Z,1668535153.007 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread.
2022-11-15T17:59:13.007Z,1668535153.007 [CTD_Seabird](INFO): Powering down
2022-11-15T17:59:13.019Z,1668535153.019 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2022-11-15T17:59:13.027Z,1668535153.027 [ComponentRegistry](INFO): Shutting down DAT ThreadHandler
2022-11-15T17:59:13.027Z,1668535153.027 [DAT ThreadHandler](INFO): Thread cancelled.
2022-11-15T17:59:13.027Z,1668535153.027 [DAT](INFO): Join timeout helper Thread ID is 7945
2022-11-15T17:59:13.143Z,1668535153.143 [DAT](INFO): Powering down
2022-11-15T17:59:13.215Z,1668535153.215 [DAT ThreadHandler](INFO): Uninitializing protected caller thread.
2022-11-15T17:59:13.215Z,1668535153.215 [DAT](INFO): Powering down
2022-11-15T17:59:13.217Z,1668535153.217 [DAT ThreadHandler](INFO): Thread cancelled.
2022-11-15T17:59:13.223Z,1668535153.223 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2022-11-15T17:59:13.223Z,1668535153.223 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2022-11-15T17:59:13.223Z,1668535153.223 [Radio_Surface](INFO): Join timeout helper Thread ID is 7946
2022-11-15T17:59:13.235Z,1668535153.235 [Radio_Surface](INFO): Powering down
2022-11-15T17:59:13.236Z,1668535153.236 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2022-11-15T17:59:13.236Z,1668535153.236 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2022-11-15T17:59:13.244Z,1668535153.244 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler
2022-11-15T17:59:13.244Z,1668535153.244 [Onboard ThreadHandler](INFO): Thread cancelled.
2022-11-15T17:59:13.244Z,1668535153.244 [Onboard](INFO): Join timeout helper Thread ID is 7947
2022-11-15T17:59:13.807Z,1668535153.807 [DataOverHttps](INFO): Radio surface powered OFF, will not connect.
2022-11-15T17:59:15.435Z,1668535155.435 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2022-11-15T17:59:15.859Z,1668535155.859 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2022-11-15T17:59:16.251Z,1668535156.251 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2022-11-15T17:59:16.635Z,1668535156.635 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread.
2022-11-15T17:59:16.635Z,1668535156.635 [Onboard ThreadHandler](INFO): Thread cancelled.
2022-11-15T17:59:16.651Z,1668535156.651 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler
2022-11-15T17:59:16.652Z,1668535156.652 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2022-11-15T17:59:16.652Z,1668535156.652 [DataOverHttps](INFO): Join timeout helper Thread ID is 7948
2022-11-15T17:59:16.663Z,1668535156.663 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2022-11-15T17:59:16.819Z,1668535156.819 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread.
2022-11-15T17:59:16.819Z,1668535156.819 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2022-11-15T17:59:16.831Z,1668535156.831 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler
2022-11-15T17:59:16.831Z,1668535156.831 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2022-11-15T17:59:16.832Z,1668535156.832 [BackseatComponent](INFO): Join timeout helper Thread ID is 7949
2022-11-15T17:59:16.939Z,1668535156.939 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread.
2022-11-15T17:59:16.940Z,1668535156.940 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2022-11-15T17:59:16.955Z,1668535156.955 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2022-11-15T17:59:16.955Z,1668535156.955 [logger ThreadHandler](INFO): Thread cancelled.
2022-11-15T17:59:16.956Z,1668535156.956 [logger](INFO): Join timeout helper Thread ID is 7950
2022-11-15T17:59:16.991Z,1668535156.991 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2022-11-15T17:59:16.991Z,1668535156.991 [logger ThreadHandler](INFO): Thread cancelled.
2022-11-15T17:59:16.995Z,1668535156.995 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2022-11-15T17:59:16.996Z,1668535156.996 [CommandLine ThreadHandler](INFO): Thread cancelled.
2022-11-15T17:59:16.996Z,1668535156.996 [CommandLine](INFO): Join timeout helper Thread ID is 7951
2022-11-15T17:59:17.047Z,1668535157.047 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2022-11-15T17:59:17.047Z,1668535157.047 [CommandLine ThreadHandler](INFO): Thread cancelled.
2022-11-15T17:59:17.055Z,1668535157.055 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler
2022-11-15T17:59:17.055Z,1668535157.055 [CommandExec ThreadHandler](INFO): Thread cancelled.
2022-11-15T17:59:17.056Z,1668535157.056 [CommandExec](INFO): Join timeout helper Thread ID is 7952
2022-11-15T17:59:17.057Z,1668535157.057 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2022-11-15T17:59:17.057Z,1668535157.057 [controlThread ThreadHandler](INFO): Thread cancelled.
2022-11-15T17:59:17.057Z,1668535157.057 [controlThread](INFO): Join timeout helper Thread ID is 7953
2022-11-15T17:59:17.059Z,1668535157.059 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout
2022-11-15T17:59:17.080Z,1668535157.080 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2022-11-15T17:59:17.080Z,1668535157.080 [controlThread](DEBUG): Uninitializing ControlThread
2022-11-15T17:59:17.080Z,1668535157.080 [AHRS_M2](INFO): Powering down
2022-11-15T17:59:17.152Z,1668535157.152 [MultiRay](INFO): Powering down.
2022-11-15T17:59:17.153Z,1668535157.153 [NAL9602](INFO): Powering down
2022-11-15T17:59:17.155Z,1668535157.155 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2022-11-15T17:59:17.156Z,1668535157.156 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2022-11-15T17:59:17.156Z,1668535157.156 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2022-11-15T17:59:17.157Z,1668535157.157 [MissionManager](INFO): Uninitializing Mission Default
2022-11-15T17:59:17.157Z,1668535157.157 [Default] Stopped
2022-11-15T17:59:17.157Z,1668535157.157 [Default](DEBUG): Aggregate::uninitialize Default
2022-11-15T17:59:17.157Z,1668535157.157 [Default:B.GoToSurface] Stopped
2022-11-15T17:59:17.157Z,1668535157.157 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2022-11-15T17:59:17.157Z,1668535157.157 [Default:CheckIn] Stopped
2022-11-15T17:59:17.157Z,1668535157.157 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2022-11-15T17:59:17.158Z,1668535157.158 [Default:CheckIn:Read_GPS] Stopped
2022-11-15T17:59:17.160Z,1668535157.160 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2022-11-15T17:59:17.161Z,1668535157.161 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2022-11-15T17:59:17.161Z,1668535157.161 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2022-11-15T17:59:17.161Z,1668535157.161 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2022-11-15T17:59:17.161Z,1668535157.161 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2022-11-15T17:59:17.162Z,1668535157.162 [BuoyancyServo](INFO): Powering down
2022-11-15T17:59:17.175Z,1668535157.175 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2022-11-15T17:59:17.175Z,1668535157.175 [ElevatorServo](INFO): Powering down
2022-11-15T17:59:17.176Z,1668535157.176 [MassServo](DEBUG): Uninitialize Mass Servo.
2022-11-15T17:59:17.176Z,1668535157.176 [MassServo](INFO): Powering down
2022-11-15T17:59:17.177Z,1668535157.177 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2022-11-15T17:59:17.177Z,1668535157.177 [RudderServo](INFO): Powering down
2022-11-15T17:59:17.178Z,1668535157.178 [ThrusterHE](DEBUG): Uninitialize Thruster Servo.
2022-11-15T17:59:17.178Z,1668535157.178 [ThrusterHE](INFO): Powering down
2022-11-15T17:59:17.179Z,1668535157.179 [SBIT](DEBUG): Uninitialize SBIT Component.
2022-11-15T17:59:17.179Z,1668535157.179 [IBIT](DEBUG): Uninitialize IBIT Component.
2022-11-15T17:59:17.179Z,1668535157.179 [CBIT](DEBUG): Uninitialize CBIT Component.
2022-11-15T17:59:17.179Z,1668535157.179 [CBIT](DEBUG): Powering off loads.
2022-11-15T17:59:17.190Z,1668535157.190 [CBIT](DEBUG): Disabling WDT.
2022-11-15T17:59:17.202Z,1668535157.202 [CBIT](DEBUG): Opening all GF detection circuits.
2022-11-15T17:59:17.204Z,1668535157.204 [controlThread ThreadHandler](INFO): Thread cancelled.
2022-11-15T17:59:17.227Z,1668535157.227 [DAT ThreadHandler](INFO): Thread cancelled.
2022-11-15T17:59:17.232Z,1668535157.232 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2022-11-15T17:59:17.235Z,1668535157.235 [Onboard ThreadHandler](INFO): Thread cancelled.
2022-11-15T17:59:17.242Z,1668535157.242 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2022-11-15T17:59:17.286Z,1668535157.286 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2022-11-15T17:59:17.346Z,1668535157.346 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2022-11-15T17:59:17.349Z,1668535157.349 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2022-11-15T17:59:17.398Z,1668535157.398 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2022-11-15T17:59:17.442Z,1668535157.442 [logger ThreadHandler](INFO): Thread cancelled.