2022-11-10T01:20:46.264Z,1668043246.264 [Supervisor](DEBUG): Initializing supervisor.
2022-11-10T01:20:46.269Z,1668043246.269 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2022-11-10T01:20:46.270Z,1668043246.270 [SyncHandler](INFO): Protected caller Thread ID is 1489
2022-11-10T01:20:46.271Z,1668043246.271 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2022-11-10T01:20:46.272Z,1668043246.272 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2022-11-10T01:20:46.272Z,1668043246.272 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 1490
2022-11-10T01:20:46.277Z,1668043246.277 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2022-11-10T01:20:46.295Z,1668043246.295 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread.
2022-11-10T01:20:46.296Z,1668043246.296 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2022-11-10T01:20:46.296Z,1668043246.296 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 1491
2022-11-10T01:20:46.301Z,1668043246.301 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2022-11-10T01:20:46.302Z,1668043246.302 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2022-11-10T01:20:46.302Z,1668043246.302 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 1492
2022-11-10T01:20:46.304Z,1668043246.304 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2022-11-10T01:20:46.305Z,1668043246.305 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0
2022-11-10T01:20:46.306Z,1668043246.306 [logger ThreadHandler](INFO): Protected caller Thread ID is 1493
2022-11-10T01:20:46.310Z,1668043246.310 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2022-11-10T01:20:46.310Z,1668043246.310 [Supervisor](INFO): Looking for Config files in directory: Config/
2022-11-10T01:20:46.312Z,1668043246.312 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2022-11-10T01:20:46.723Z,1668043246.723 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2022-11-10T01:20:46.723Z,1668043246.723 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg
2022-11-10T01:20:46.931Z,1668043246.931 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock
2022-11-10T01:20:46.932Z,1668043246.932 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2022-11-10T01:20:47.109Z,1668043247.109 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2022-11-10T01:20:47.109Z,1668043247.109 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2022-11-10T01:20:47.214Z,1668043247.214 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2022-11-10T01:20:47.214Z,1668043247.214 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2022-11-10T01:20:47.568Z,1668043247.568 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2022-11-10T01:20:47.569Z,1668043247.569 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2022-11-10T01:20:47.876Z,1668043247.876 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2022-11-10T01:20:47.877Z,1668043247.877 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2022-11-10T01:20:47.971Z,1668043247.971 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2022-11-10T01:20:47.972Z,1668043247.972 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2022-11-10T01:20:48.230Z,1668043248.230 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2022-11-10T01:20:48.231Z,1668043248.231 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2022-11-10T01:20:49.282Z,1668043249.282 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2022-11-10T01:20:49.283Z,1668043249.283 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2022-11-10T01:20:49.642Z,1668043249.642 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2022-11-10T01:20:49.643Z,1668043249.643 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2022-11-10T01:20:49.764Z,1668043249.764 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2022-11-10T01:20:50.238Z,1668043250.238 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2022-11-10T01:20:50.238Z,1668043250.238 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2022-11-10T01:20:50.522Z,1668043250.522 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2022-11-10T01:20:50.523Z,1668043250.523 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2022-11-10T01:20:51.229Z,1668043251.229 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2022-11-10T01:20:51.230Z,1668043251.230 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2022-11-10T01:20:51.309Z,1668043251.309 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2022-11-10T01:20:51.588Z,1668043251.588 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2022-11-10T01:20:51.590Z,1668043251.590 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-galene/
2022-11-10T01:20:51.591Z,1668043251.591 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/vehicle.cfg
2022-11-10T01:20:51.763Z,1668043251.763 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/logger.cfg
2022-11-10T01:20:51.855Z,1668043251.855 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Servo.cfg
2022-11-10T01:20:51.965Z,1668043251.965 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Control.cfg
2022-11-10T01:20:52.063Z,1668043252.063 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/secure.cfg
2022-11-10T01:20:52.147Z,1668043252.147 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Simulator.cfg
2022-11-10T01:20:52.232Z,1668043252.232 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Science.cfg
2022-11-10T01:20:52.343Z,1668043252.343 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/BIT.cfg
2022-11-10T01:20:52.440Z,1668043252.440 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Sensor.cfg
2022-11-10T01:20:52.591Z,1668043252.591 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Battery.cfg
2022-11-10T01:20:52.850Z,1668043252.850 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2022-11-10T01:20:52.851Z,1668043252.851 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Navigation.cfg
2022-11-10T01:20:52.944Z,1668043252.944 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-galene/root/
2022-11-10T01:20:52.944Z,1668043252.944 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg
2022-11-10T01:20:52.957Z,1668043252.957 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2022-11-10T01:20:53.266Z,1668043253.266 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2022-11-10T01:20:53.266Z,1668043253.266 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2022-11-10T01:20:53.381Z,1668043253.381 [DeadReckonUsingMultipleVelocitySources] Loaded
2022-11-10T01:20:53.382Z,1668043253.382 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2022-11-10T01:20:53.421Z,1668043253.421 [DeadReckonUsingSpeedCalculator] Loaded
2022-11-10T01:20:53.421Z,1668043253.421 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread.
2022-11-10T01:20:53.435Z,1668043253.435 [NavChart] Loaded
2022-11-10T01:20:53.435Z,1668043253.435 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2022-11-10T01:20:53.441Z,1668043253.441 [UniversalFixResidualReporter] Loaded
2022-11-10T01:20:53.441Z,1668043253.441 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2022-11-10T01:20:53.441Z,1668043253.441 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2022-11-10T01:20:53.442Z,1668043253.442 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2022-11-10T01:20:53.452Z,1668043253.452 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2022-11-10T01:20:53.453Z,1668043253.453 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2022-11-10T01:20:53.612Z,1668043253.612 [PAR_Licor] Loaded
2022-11-10T01:20:53.613Z,1668043253.613 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2022-11-10T01:20:53.645Z,1668043253.645 [WetLabsBB2FL] Loaded
2022-11-10T01:20:53.645Z,1668043253.645 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2022-11-10T01:20:53.646Z,1668043253.646 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 4065A4E0
2022-11-10T01:20:53.647Z,1668043253.647 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 1575
2022-11-10T01:20:53.648Z,1668043253.648 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2022-11-10T01:20:53.648Z,1668043253.648 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2022-11-10T01:20:53.699Z,1668043253.699 [VerticalControl](DEBUG): Construct VerticalControl.
2022-11-10T01:20:53.760Z,1668043253.760 [VerticalControl] Loaded
2022-11-10T01:20:53.761Z,1668043253.761 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2022-11-10T01:20:53.763Z,1668043253.763 [HorizontalControl](DEBUG): Construct HorizontalControl.
2022-11-10T01:20:53.806Z,1668043253.806 [HorizontalControl] Loaded
2022-11-10T01:20:53.806Z,1668043253.806 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2022-11-10T01:20:53.809Z,1668043253.809 [SpeedControl](DEBUG): Construct SpeedControl.
2022-11-10T01:20:53.812Z,1668043253.812 [SpeedControl] Loaded
2022-11-10T01:20:53.812Z,1668043253.812 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2022-11-10T01:20:53.815Z,1668043253.815 [LoopControl](DEBUG): Construct LoopControl.
2022-11-10T01:20:53.816Z,1668043253.816 [LoopControl] Loaded
2022-11-10T01:20:53.816Z,1668043253.816 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2022-11-10T01:20:53.816Z,1668043253.816 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2022-11-10T01:20:53.817Z,1668043253.817 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2022-11-10T01:20:53.867Z,1668043253.867 [DepthRateCalculator] Loaded
2022-11-10T01:20:53.867Z,1668043253.867 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2022-11-10T01:20:53.872Z,1668043253.872 [PitchRateCalculator] Loaded
2022-11-10T01:20:53.872Z,1668043253.872 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2022-11-10T01:20:53.882Z,1668043253.882 [SpeedCalculator] Loaded
2022-11-10T01:20:53.882Z,1668043253.882 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2022-11-10T01:20:53.886Z,1668043253.886 [YawRateCalculator] Loaded
2022-11-10T01:20:53.887Z,1668043253.887 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2022-11-10T01:20:53.905Z,1668043253.905 [ElevatorOffsetCalculator] Loaded
2022-11-10T01:20:53.905Z,1668043253.905 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2022-11-10T01:20:53.906Z,1668043253.906 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2022-11-10T01:20:53.906Z,1668043253.906 [Module Loader](DEBUG): Loading Module at Modules/Dock.so
2022-11-10T01:20:54.000Z,1668043254.000 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking)
2022-11-10T01:20:54.001Z,1668043254.001 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2022-11-10T01:20:54.059Z,1668043254.059 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2022-11-10T01:20:54.060Z,1668043254.060 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2022-11-10T01:20:54.186Z,1668043254.186 [BuoyancyServo] Loaded
2022-11-10T01:20:54.186Z,1668043254.186 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2022-11-10T01:20:54.207Z,1668043254.207 [ElevatorServo] Loaded
2022-11-10T01:20:54.207Z,1668043254.207 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2022-11-10T01:20:54.226Z,1668043254.226 [MassServo] Loaded
2022-11-10T01:20:54.227Z,1668043254.227 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2022-11-10T01:20:54.245Z,1668043254.245 [RudderServo] Loaded
2022-11-10T01:20:54.246Z,1668043254.246 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2022-11-10T01:20:54.260Z,1668043254.260 [ThrusterHE] Loaded
2022-11-10T01:20:54.261Z,1668043254.261 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread.
2022-11-10T01:20:54.261Z,1668043254.261 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2022-11-10T01:20:54.262Z,1668043254.262 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2022-11-10T01:20:54.416Z,1668043254.416 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2022-11-10T01:20:54.417Z,1668043254.417 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2022-11-10T01:20:54.839Z,1668043254.839 [AHRS_M2] Loaded
2022-11-10T01:20:54.839Z,1668043254.839 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread.
2022-11-10T01:20:54.875Z,1668043254.875 [BackseatComponent] Loaded
2022-11-10T01:20:54.875Z,1668043254.875 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread.
2022-11-10T01:20:54.876Z,1668043254.876 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 40A554E0
2022-11-10T01:20:54.877Z,1668043254.877 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 1576
2022-11-10T01:20:54.879Z,1668043254.879 [LcmUniversalReporter] Loaded
2022-11-10T01:20:54.880Z,1668043254.880 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread.
2022-11-10T01:20:56.188Z,1668043256.188 [BPC1] Loaded
2022-11-10T01:20:56.189Z,1668043256.189 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2022-11-10T01:20:56.263Z,1668043256.263 [DataOverHttps] Loaded
2022-11-10T01:20:56.263Z,1668043256.263 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2022-11-10T01:20:56.264Z,1668043256.264 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 40A854E0
2022-11-10T01:20:56.264Z,1668043256.264 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 1577
2022-11-10T01:20:56.286Z,1668043256.286 [Depth_Keller] Loaded
2022-11-10T01:20:56.286Z,1668043256.286 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2022-11-10T01:20:56.291Z,1668043256.291 [DropWeight] Loaded
2022-11-10T01:20:56.291Z,1668043256.291 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2022-11-10T01:20:56.311Z,1668043256.311 [MultiRay] Loaded
2022-11-10T01:20:56.311Z,1668043256.311 [ComponentRegistry](DEBUG): SyncComponent "MultiRay" handled in the control thread.
2022-11-10T01:20:56.374Z,1668043256.374 [NAL9602] Loaded
2022-11-10T01:20:56.374Z,1668043256.374 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2022-11-10T01:20:56.406Z,1668043256.406 [Onboard] Loaded
2022-11-10T01:20:56.406Z,1668043256.406 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread.
2022-11-10T01:20:56.407Z,1668043256.407 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 40AB54E0
2022-11-10T01:20:56.407Z,1668043256.407 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 1578
2022-11-10T01:20:56.414Z,1668043256.414 [PowerOnly](INFO): Adding load control power supply at /dev/loadC3
2022-11-10T01:20:56.425Z,1668043256.425 [PowerOnly] Loaded
2022-11-10T01:20:56.425Z,1668043256.425 [ComponentRegistry](DEBUG): SyncComponent "PowerOnly" handled in the control thread.
2022-11-10T01:20:56.437Z,1668043256.437 [Power24vConverter] Loaded
2022-11-10T01:20:56.438Z,1668043256.438 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread.
2022-11-10T01:20:56.451Z,1668043256.451 [Radio_Surface] Loaded
2022-11-10T01:20:56.451Z,1668043256.451 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2022-11-10T01:20:56.453Z,1668043256.453 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 40AE54E0
2022-11-10T01:20:56.453Z,1668043256.453 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 1579
2022-11-10T01:20:56.548Z,1668043256.548 [DAT] Loaded
2022-11-10T01:20:56.548Z,1668043256.548 [ComponentRegistry](DEBUG): Component "DAT" handled in its own thread.
2022-11-10T01:20:56.549Z,1668043256.549 [DAT ThreadHandler](DEBUG): Created PCaller Thread at 40B154E0
2022-11-10T01:20:56.549Z,1668043256.549 [DAT ThreadHandler](INFO): Protected caller Thread ID is 1580
2022-11-10T01:20:56.550Z,1668043256.550 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2022-11-10T01:20:56.550Z,1668043256.550 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2022-11-10T01:20:56.694Z,1668043256.694 [SBIT](DEBUG): Construct Startup Built In Test.
2022-11-10T01:20:56.703Z,1668043256.703 [SBIT] Loaded
2022-11-10T01:20:56.703Z,1668043256.703 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2022-11-10T01:20:56.706Z,1668043256.706 [IBIT](DEBUG): Construct Initiated Built In Test.
2022-11-10T01:20:56.720Z,1668043256.720 [IBIT] Loaded
2022-11-10T01:20:56.720Z,1668043256.720 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2022-11-10T01:20:56.726Z,1668043256.726 [CBIT](DEBUG): Construct Continuous Built In Test.
2022-11-10T01:20:56.831Z,1668043256.831 [CBIT] Loaded
2022-11-10T01:20:56.831Z,1668043256.831 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2022-11-10T01:20:56.832Z,1668043256.832 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2022-11-10T01:20:56.832Z,1668043256.832 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2022-11-10T01:20:56.860Z,1668043256.860 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2022-11-10T01:20:56.866Z,1668043256.866 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2022-11-10T01:20:56.869Z,1668043256.869 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2022-11-10T01:20:56.881Z,1668043256.881 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2022-11-10T01:20:56.882Z,1668043256.882 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40BA34E0
2022-11-10T01:20:56.882Z,1668043256.882 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 1581
2022-11-10T01:20:56.887Z,1668043256.887 [Supervisor](INFO): Main Thread ID is 756
2022-11-10T01:20:56.887Z,1668043256.887 [Supervisor](DEBUG): Running supervisor.
2022-11-10T01:20:56.887Z,1668043256.887 [CommandExec ThreadHandler](INFO): Handler Thread ID is 1582
2022-11-10T01:20:56.888Z,1668043256.888 [CommandExec](INFO): Initializing the command executive.
2022-11-10T01:20:56.889Z,1668043256.889 [CommandLine ThreadHandler](INFO): Handler Thread ID is 1583
2022-11-10T01:20:56.891Z,1668043256.891 [controlThread ThreadHandler](INFO): Handler Thread ID is 1584
2022-11-10T01:20:56.892Z,1668043256.892 [controlThread](DEBUG): Initializing ControlThread
2022-11-10T01:20:56.893Z,1668043256.893 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2022-11-10T01:20:56.894Z,1668043256.894 [NavChart](DEBUG): Initialize NavChart Navigation.
2022-11-10T01:20:56.894Z,1668043256.894 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2022-11-10T01:20:56.897Z,1668043256.897 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2022-11-10T01:20:56.898Z,1668043256.898 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2022-11-10T01:20:56.899Z,1668043256.899 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2022-11-10T01:20:56.899Z,1668043256.899 [LoopControl](DEBUG): Initialize LoopControlComponent.
2022-11-10T01:20:56.900Z,1668043256.900 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2022-11-10T01:20:56.900Z,1668043256.900 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2022-11-10T01:20:56.901Z,1668043256.901 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2022-11-10T01:20:56.901Z,1668043256.901 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2022-11-10T01:20:56.902Z,1668043256.902 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2022-11-10T01:20:56.910Z,1668043256.910 [SBIT](INFO): Initialize SBIT Component.
2022-11-10T01:20:56.911Z,1668043256.911 [SBIT](IMPORTANT): git: 2022-10-11-51-g7e730fbb4
2022-11-10T01:20:56.911Z,1668043256.911 [SBIT](INFO): git hash: 7e730fbb43c13a073d28c5497927e5ede41039ea
2022-11-10T01:20:56.911Z,1668043256.911 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2022-11-10T01:20:56.913Z,1668043256.913 [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-10T01:20:56.914Z,1668043256.914 [SBIT](INFO): Beginning SBIT in 109.000000 seconds.
2022-11-10T01:20:56.914Z,1668043256.914 [IBIT](INFO): Initialize IBIT Component.
2022-11-10T01:20:56.915Z,1668043256.915 [CBIT](DEBUG): Initialize CBIT Component.
2022-11-10T01:20:56.916Z,1668043256.916 [logger ThreadHandler](INFO): Handler Thread ID is 1585
2022-11-10T01:20:56.928Z,1668043256.928 [CBIT](DEBUG): Initialized mux pins.
2022-11-10T01:20:56.928Z,1668043256.928 [CBIT](DEBUG): Initializing the watchdog timer.
2022-11-10T01:20:56.937Z,1668043256.937 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 1586
2022-11-10T01:20:56.941Z,1668043256.941 [WetLabsBB2FL](INFO): Powering up
2022-11-10T01:20:56.942Z,1668043256.942 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 1588
2022-11-10T01:20:56.949Z,1668043256.949 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 1589
2022-11-10T01:20:56.950Z,1668043256.950 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2022-11-10T01:20:56.952Z,1668043256.952 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2022-11-10T01:20:56.953Z,1668043256.953 [CBIT](DEBUG): Initializing heartbeat.
2022-11-10T01:20:56.961Z,1668043256.961 [Onboard ThreadHandler](INFO): Handler Thread ID is 1590
2022-11-10T01:20:56.991Z,1668043256.991 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 1591
2022-11-10T01:20:57.001Z,1668043257.001 [DAT ThreadHandler](INFO): Handler Thread ID is 1592
2022-11-10T01:20:57.001Z,1668043257.001 [DAT](INFO): Powering up
2022-11-10T01:20:57.002Z,1668043257.002 [DAT](DEBUG): Initializing DAT.
2022-11-10T01:20:57.005Z,1668043257.005 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 1594
2022-11-10T01:20:57.008Z,1668043257.008 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2022-11-10T01:20:57.008Z,1668043257.008 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2022-11-10T01:20:57.009Z,1668043257.009 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2022-11-10T01:20:57.009Z,1668043257.009 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2022-11-10T01:20:57.009Z,1668043257.009 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2022-11-10T01:20:57.009Z,1668043257.009 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2022-11-10T01:20:57.009Z,1668043257.009 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2022-11-10T01:20:57.009Z,1668043257.009 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2022-11-10T01:20:57.024Z,1668043257.024 [CBIT](DEBUG): Deactivating GF circuits.
2022-11-10T01:20:57.024Z,1668043257.024 [CBIT](DEBUG): Deactivating emergency mode.
2022-11-10T01:20:57.060Z,1668043257.060 [CBIT](DEBUG): Backplane powered.
2022-11-10T01:20:57.061Z,1668043257.061 [MissionManager](INFO): Loading Mission from file: Missions/Startup.xml
2022-11-10T01:20:57.074Z,1668043257.074 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2022-11-10T01:20:57.098Z,1668043257.098 [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-10T01:20:57.099Z,1668043257.099 [MissionManager](INFO): Loading Mission from file: Missions/Default.xml
2022-11-10T01:20:57.173Z,1668043257.173 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2022-11-10T01:20:57.174Z,1668043257.174 [Default:A.Wait](DEBUG): Construct Wait.
2022-11-10T01:20:57.196Z,1668043257.196 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2022-11-10T01:20:57.208Z,1668043257.208 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2022-11-10T01:20:57.235Z,1668043257.235 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2022-11-10T01:20:57.250Z,1668043257.250 [Default:E.Execute](DEBUG): Construct Execute.
2022-11-10T01:20:57.261Z,1668043257.261 [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-10T01:20:57.266Z,1668043257.266 [controlThread](DEBUG): Component order: CycleStarter,PAR_Licor,AHRS_M2,BPC1,Depth_Keller,DropWeight,MultiRay,NAL9602,PowerOnly,Power24vConverter,PAR_Licor,Depth_Keller,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-10T01:20:57.274Z,1668043257.274 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2022-11-10T01:20:57.351Z,1668043257.351 [MultiRay](INFO): Start
2022-11-10T01:20:57.351Z,1668043257.351 [MultiRay](INFO): Powering up MultiRay Lights
2022-11-10T01:20:57.385Z,1668043257.385 [Power24vConverter](INFO): Powering up.
2022-11-10T01:20:57.392Z,1668043257.392 [Radio_Surface](INFO): Powering up
2022-11-10T01:20:57.434Z,1668043257.434 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2022-11-10T01:20:57.441Z,1668043257.441 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2022-11-10T01:20:57.442Z,1668043257.442 [ElevatorServo](DEBUG): Initializing EZServoServo.
2022-11-10T01:20:57.453Z,1668043257.453 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2022-11-10T01:20:57.454Z,1668043257.454 [MassServo](DEBUG): Initializing EZServoServo.
2022-11-10T01:20:57.461Z,1668043257.461 [MassServo](DEBUG): Initializing MassServo.
2022-11-10T01:20:57.461Z,1668043257.461 [RudderServo](DEBUG): Initializing EZServoServo.
2022-11-10T01:20:57.469Z,1668043257.469 [RudderServo](DEBUG): Initializing RudderServo.
2022-11-10T01:20:57.469Z,1668043257.469 [ThrusterHE](DEBUG): Initializing EZServoServo.
2022-11-10T01:20:57.480Z,1668043257.480 [ThrusterHE](DEBUG): Initializing ThrusterHE.
2022-11-10T01:20:57.707Z,1668043257.707 [DropWeight](CRITICAL): DROP WEIGHT MISSING.

2022-11-10T01:20:57.707Z,1668043257.707 [DropWeight] Hardware Fault, FailCount= 1
2022-11-10T01:20:57.707Z,1668043257.707 [DropWeight](ERROR): Hardware Fault
2022-11-10T01:20:57.708Z,1668043257.708 [MultiRay](INFO): Starting
2022-11-10T01:20:57.708Z,1668043257.708 [MultiRay](INFO): Finished reading config
2022-11-10T01:20:57.733Z,1668043257.733 [MultiRay](DEBUG): Recieved MultiRay unrecognized response
2022-11-10T01:20:57.744Z,1668043257.744 [MultiRay](DEBUG): Recieved MultiRay unrecognized response
2022-11-10T01:20:57.744Z,1668043257.744 [MultiRay](IMPORTANT): All lights off
2022-11-10T01:20:57.791Z,1668043257.791 [CommandExec](FAULT): Scheduling is paused
2022-11-10T01:20:57.792Z,1668043257.792 [CBIT](INFO): Critical error at 20221110T012057
2022-11-10T01:20:57.792Z,1668043257.792 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals
2022-11-10T01:20:57.803Z,1668043257.803 [CBIT](ERROR): Hardware Fault in component: DropWeight
2022-11-10T01:20:57.803Z,1668043257.803 [CBIT](CRITICAL): Hardware Fault in component: DropWeight
2022-11-10T01:20:58.085Z,1668043258.085 [MultiRay](INFO): Runnable
2022-11-10T01:20:58.424Z,1668043258.424 [RudderServo](ERROR): Rudder initialization uart error serial timeout
2022-11-10T01:20:58.424Z,1668043258.424 [RudderServo](FAULT): Rudder failed to initialize
2022-11-10T01:20:58.424Z,1668043258.424 [RudderServo] Communications Fault, FailCount= 1
2022-11-10T01:20:58.425Z,1668043258.425 [RudderServo](ERROR): Communications Fault
2022-11-10T01:20:58.426Z,1668043258.426 [CBIT](INFO): Critical error at 20221110T012057
2022-11-10T01:20:58.429Z,1668043258.429 [CBIT](ERROR): Communications Fault in component: RudderServo
2022-11-10T01:20:58.489Z,1668043258.489 [MultiRay](INFO): Pause
2022-11-10T01:20:58.869Z,1668043258.869 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2022-11-10T01:20:58.869Z,1668043258.869 [RudderServo](INFO): Powering down
2022-11-10T01:20:58.917Z,1668043258.917 [MultiRay](INFO): Paused
2022-11-10T01:20:59.297Z,1668043259.297 [MultiRay](INFO): Paused
2022-11-10T01:20:59.313Z,1668043259.313 [RudderServo](DEBUG): Initializing EZServoServo.
2022-11-10T01:20:59.433Z,1668043259.433 [RudderServo](DEBUG): Initializing RudderServo.
2022-11-10T01:20:59.437Z,1668043259.437 [CBIT](INFO): Clearing failed state for component RudderServo
2022-11-10T01:20:59.437Z,1668043259.437 [RudderServo] No Fault, FailCount= 1
2022-11-10T01:20:59.705Z,1668043259.705 [MultiRay](INFO): Paused
2022-11-10T01:21:00.105Z,1668043260.105 [MultiRay](INFO): Paused
2022-11-10T01:21:00.832Z,1668043260.832 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:21:00.837Z,1668043260.837 [MultiRay](INFO): Paused
2022-11-10T01:21:01.304Z,1668043261.304 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:21:01.309Z,1668043261.309 [MultiRay](INFO): Paused
2022-11-10T01:21:01.728Z,1668043261.728 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:21:01.733Z,1668043261.733 [MultiRay](INFO): Paused
2022-11-10T01:21:02.192Z,1668043262.192 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:21:02.198Z,1668043262.198 [MultiRay](INFO): Paused
2022-11-10T01:21:02.232Z,1668043262.232 [WetLabsBB2FL] Communications Fault, FailCount= 1
2022-11-10T01:21:02.232Z,1668043262.232 [WetLabsBB2FL](ERROR): Communications Fault
2022-11-10T01:21:02.301Z,1668043262.301 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL
2022-11-10T01:21:02.644Z,1668043262.644 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:21:02.646Z,1668043262.646 [MultiRay](INFO): Paused
2022-11-10T01:21:02.736Z,1668043262.736 [WetLabsBB2FL](INFO): Powering down
2022-11-10T01:21:03.088Z,1668043263.088 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:21:03.101Z,1668043263.101 [MultiRay](INFO): Paused
2022-11-10T01:21:03.217Z,1668043263.217 [ThrusterHE](ERROR): Zero Speed Commanded.
2022-11-10T01:21:03.612Z,1668043263.612 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:21:03.617Z,1668043263.617 [MultiRay](INFO): Paused
2022-11-10T01:21:03.920Z,1668043263.920 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL
2022-11-10T01:21:03.920Z,1668043263.920 [WetLabsBB2FL] No Fault, FailCount= 1
2022-11-10T01:21:03.950Z,1668043263.950 [WetLabsBB2FL](INFO): Powering up
2022-11-10T01:21:04.260Z,1668043264.260 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:21:04.265Z,1668043264.265 [MultiRay](INFO): Paused
2022-11-10T01:21:04.808Z,1668043264.808 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:21:04.813Z,1668043264.813 [MultiRay](INFO): Paused
2022-11-10T01:21:05.272Z,1668043265.272 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:21:05.277Z,1668043265.277 [MultiRay](INFO): Paused
2022-11-10T01:21:05.712Z,1668043265.712 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:21:05.718Z,1668043265.718 [MultiRay](INFO): Paused
2022-11-10T01:21:06.140Z,1668043266.140 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:21:06.145Z,1668043266.145 [MultiRay](INFO): Paused
2022-11-10T01:21:06.576Z,1668043266.576 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:21:06.581Z,1668043266.581 [MultiRay](INFO): Paused
2022-11-10T01:21:06.996Z,1668043266.996 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:21:07.005Z,1668043267.005 [MultiRay](INFO): Paused
2022-11-10T01:21:07.436Z,1668043267.436 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:21:07.441Z,1668043267.441 [MultiRay](INFO): Paused
2022-11-10T01:21:07.864Z,1668043267.864 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:21:07.870Z,1668043267.870 [MultiRay](INFO): Paused
2022-11-10T01:21:08.296Z,1668043268.296 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:21:08.301Z,1668043268.301 [MultiRay](INFO): Paused
2022-11-10T01:21:08.741Z,1668043268.741 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:21:08.745Z,1668043268.745 [MultiRay](INFO): Paused
2022-11-10T01:21:09.156Z,1668043269.156 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:21:09.161Z,1668043269.161 [MultiRay](INFO): Paused
2022-11-10T01:21:09.244Z,1668043269.244 [WetLabsBB2FL] Communications Fault, FailCount= 2
2022-11-10T01:21:09.244Z,1668043269.244 [WetLabsBB2FL](ERROR): Communications Fault
2022-11-10T01:21:09.592Z,1668043269.592 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:21:09.597Z,1668043269.597 [MultiRay](INFO): Paused
2022-11-10T01:21:09.665Z,1668043269.665 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL
2022-11-10T01:21:09.744Z,1668043269.744 [WetLabsBB2FL](INFO): Powering down
2022-11-10T01:21:10.024Z,1668043270.024 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:21:10.029Z,1668043270.029 [MultiRay](INFO): Paused
2022-11-10T01:21:10.448Z,1668043270.448 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:21:10.448Z,1668043270.448 [AHRS_M2](FAULT): Failed to initialize within timeout.
2022-11-10T01:21:10.449Z,1668043270.449 [AHRS_M2] Communications Fault, FailCount= 1
2022-11-10T01:21:10.449Z,1668043270.449 [AHRS_M2](ERROR): Communications Fault
2022-11-10T01:21:10.457Z,1668043270.457 [MultiRay](INFO): Paused
2022-11-10T01:21:10.525Z,1668043270.525 [CBIT](ERROR): Communications Fault in component: AHRS_M2
2022-11-10T01:21:10.569Z,1668043270.569 [AHRS_M2](INFO): Powering down
2022-11-10T01:21:10.646Z,1668043270.646 [MultiRay](INFO): Paused
2022-11-10T01:21:10.732Z,1668043270.732 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL
2022-11-10T01:21:10.732Z,1668043270.732 [WetLabsBB2FL] No Fault, FailCount= 2
2022-11-10T01:21:10.941Z,1668043270.941 [MultiRay](INFO): Paused
2022-11-10T01:21:10.966Z,1668043270.966 [WetLabsBB2FL](INFO): Powering up
2022-11-10T01:21:11.345Z,1668043271.345 [MultiRay](INFO): Paused
2022-11-10T01:21:11.401Z,1668043271.401 [CBIT](INFO): Clearing failed state for component AHRS_M2
2022-11-10T01:21:11.401Z,1668043271.401 [AHRS_M2] No Fault, FailCount= 1
2022-11-10T01:21:11.745Z,1668043271.745 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2022-11-10T01:21:11.757Z,1668043271.757 [MultiRay](INFO): Paused
2022-11-10T01:21:11.907Z,1668043271.907 [DAT](INFO): commRate: 800
2022-11-10T01:21:12.153Z,1668043272.153 [MultiRay](INFO): Paused
2022-11-10T01:21:12.557Z,1668043272.557 [MultiRay](INFO): Paused
2022-11-10T01:21:12.961Z,1668043272.961 [MultiRay](INFO): Paused
2022-11-10T01:21:13.365Z,1668043273.365 [MultiRay](INFO): Paused
2022-11-10T01:21:13.769Z,1668043273.769 [MultiRay](INFO): Paused
2022-11-10T01:21:13.972Z,1668043273.972 [DAT](INFO): entering command mode
2022-11-10T01:21:14.173Z,1668043274.173 [DAT](INFO): setting verbose to 3
2022-11-10T01:21:14.185Z,1668043274.185 [MultiRay](INFO): Paused
2022-11-10T01:21:14.426Z,1668043274.426 [DAT](INFO): set verbose to 3
2022-11-10T01:21:14.426Z,1668043274.426 [DAT](INFO): setting DatVerbose to 27440
2022-11-10T01:21:14.577Z,1668043274.577 [MultiRay](INFO): Paused
2022-11-10T01:21:14.678Z,1668043274.678 [DAT](INFO): set DatVerbose to 27440
2022-11-10T01:21:14.678Z,1668043274.678 [DAT](INFO): setting transmit power to 8
2022-11-10T01:21:14.930Z,1668043274.930 [DAT](INFO): set transmit power to 8
2022-11-10T01:21:14.930Z,1668043274.930 [DAT](INFO): setting local address to 10
2022-11-10T01:21:15.182Z,1668043275.182 [DAT](INFO): set local address to 10
2022-11-10T01:21:15.183Z,1668043275.183 [DAT](INFO): Setting time to: 1:21:15 And date to:11/10/2022
2022-11-10T01:21:15.300Z,1668043275.300 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:21:15.305Z,1668043275.305 [MultiRay](INFO): Paused
2022-11-10T01:21:15.435Z,1668043275.435 [DAT](INFO): Local DAT time set to Thu Nov 10, 2022  01:21:15  

2022-11-10T01:21:15.748Z,1668043275.748 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:21:15.758Z,1668043275.758 [MultiRay](INFO): Paused
2022-11-10T01:21:16.168Z,1668043276.168 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:21:16.177Z,1668043276.177 [MultiRay](INFO): Paused
2022-11-10T01:21:16.256Z,1668043276.256 [WetLabsBB2FL] Communications Fault, FailCount= 3
2022-11-10T01:21:16.256Z,1668043276.256 [WetLabsBB2FL](ERROR): Communications Fault
2022-11-10T01:21:16.265Z,1668043276.265 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL
2022-11-10T01:21:16.620Z,1668043276.620 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:21:16.625Z,1668043276.625 [MultiRay](INFO): Paused
2022-11-10T01:21:16.773Z,1668043276.773 [WetLabsBB2FL](INFO): Powering down
2022-11-10T01:21:17.089Z,1668043277.089 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:21:17.095Z,1668043277.095 [MultiRay](INFO): Paused
2022-11-10T01:21:17.548Z,1668043277.548 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:21:17.553Z,1668043277.553 [MultiRay](INFO): Paused
2022-11-10T01:21:17.635Z,1668043277.635 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL
2022-11-10T01:21:17.636Z,1668043277.636 [WetLabsBB2FL] No Fault, FailCount= 3
2022-11-10T01:21:17.964Z,1668043277.964 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:21:17.969Z,1668043277.969 [MultiRay](INFO): Paused
2022-11-10T01:21:17.986Z,1668043277.986 [WetLabsBB2FL](INFO): Powering up
2022-11-10T01:21:18.380Z,1668043278.380 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:21:18.385Z,1668043278.385 [MultiRay](INFO): Paused
2022-11-10T01:21:18.800Z,1668043278.800 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:21:18.805Z,1668043278.805 [MultiRay](INFO): Paused
2022-11-10T01:21:19.224Z,1668043279.224 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:21:19.230Z,1668043279.230 [MultiRay](INFO): Paused
2022-11-10T01:21:19.648Z,1668043279.648 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:21:19.653Z,1668043279.653 [MultiRay](INFO): Paused
2022-11-10T01:21:20.064Z,1668043280.064 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:21:20.069Z,1668043280.069 [MultiRay](INFO): Paused
2022-11-10T01:21:20.480Z,1668043280.480 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:21:20.485Z,1668043280.485 [MultiRay](INFO): Paused
2022-11-10T01:21:20.928Z,1668043280.928 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:21:20.933Z,1668043280.933 [MultiRay](INFO): Paused
2022-11-10T01:21:21.372Z,1668043281.372 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:21:21.377Z,1668043281.377 [MultiRay](INFO): Paused
2022-11-10T01:21:21.796Z,1668043281.796 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:21:21.801Z,1668043281.801 [MultiRay](INFO): Paused
2022-11-10T01:21:22.224Z,1668043282.224 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:21:22.229Z,1668043282.229 [MultiRay](INFO): Paused
2022-11-10T01:21:22.636Z,1668043282.636 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:21:22.645Z,1668043282.645 [MultiRay](INFO): Paused
2022-11-10T01:21:23.048Z,1668043283.048 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:21:23.053Z,1668043283.053 [MultiRay](INFO): Paused
2022-11-10T01:21:23.284Z,1668043283.284 [WetLabsBB2FL] Communications Fault, FailCount= 4
2022-11-10T01:21:23.284Z,1668043283.284 [WetLabsBB2FL](ERROR): Communications Fault
2022-11-10T01:21:23.464Z,1668043283.464 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:21:23.469Z,1668043283.469 [MultiRay](INFO): Paused
2022-11-10T01:21:23.541Z,1668043283.541 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL
2022-11-10T01:21:23.784Z,1668043283.784 [WetLabsBB2FL](INFO): Powering down
2022-11-10T01:21:23.900Z,1668043283.900 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:21:23.905Z,1668043283.905 [MultiRay](INFO): Paused
2022-11-10T01:21:24.328Z,1668043284.328 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:21:24.333Z,1668043284.333 [MultiRay](INFO): Paused
2022-11-10T01:21:24.764Z,1668043284.764 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:21:24.764Z,1668043284.764 [AHRS_M2](FAULT): Failed to initialize within timeout.
2022-11-10T01:21:24.764Z,1668043284.764 [AHRS_M2] Communications Fault, FailCount= 2
2022-11-10T01:21:24.764Z,1668043284.764 [AHRS_M2](ERROR): Communications Fault
2022-11-10T01:21:24.794Z,1668043284.794 [MultiRay](INFO): Paused
2022-11-10T01:21:24.850Z,1668043284.850 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL
2022-11-10T01:21:24.850Z,1668043284.850 [WetLabsBB2FL] No Fault, FailCount= 4
2022-11-10T01:21:24.851Z,1668043284.851 [CBIT](ERROR): Communications Fault in component: AHRS_M2
2022-11-10T01:21:24.906Z,1668043284.906 [AHRS_M2](INFO): Powering down
2022-11-10T01:21:24.982Z,1668043284.982 [MultiRay](INFO): Paused
2022-11-10T01:21:24.998Z,1668043284.998 [WetLabsBB2FL](INFO): Powering up
2022-11-10T01:21:25.269Z,1668043285.269 [MultiRay](INFO): Paused
2022-11-10T01:21:25.673Z,1668043285.673 [MultiRay](INFO): Paused
2022-11-10T01:21:25.733Z,1668043285.733 [CBIT](INFO): Clearing failed state for component AHRS_M2
2022-11-10T01:21:25.733Z,1668043285.733 [AHRS_M2] No Fault, FailCount= 2
2022-11-10T01:21:26.081Z,1668043286.081 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2022-11-10T01:21:26.098Z,1668043286.098 [MultiRay](INFO): Paused
2022-11-10T01:21:26.481Z,1668043286.481 [MultiRay](INFO): Paused
2022-11-10T01:21:26.482Z,1668043286.482 [NAL9602](INFO): Powering up NAL9602
2022-11-10T01:21:26.885Z,1668043286.885 [MultiRay](INFO): Paused
2022-11-10T01:21:27.289Z,1668043287.289 [MultiRay](INFO): Paused
2022-11-10T01:21:27.701Z,1668043287.701 [MultiRay](INFO): Paused
2022-11-10T01:21:28.097Z,1668043288.097 [MultiRay](INFO): Paused
2022-11-10T01:21:28.514Z,1668043288.514 [MultiRay](INFO): Paused
2022-11-10T01:21:28.909Z,1668043288.909 [MultiRay](INFO): Paused
2022-11-10T01:21:29.620Z,1668043289.620 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:21:29.625Z,1668043289.625 [MultiRay](INFO): Paused
2022-11-10T01:21:30.056Z,1668043290.056 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:21:30.061Z,1668043290.061 [MultiRay](INFO): Paused
2022-11-10T01:21:30.296Z,1668043290.296 [WetLabsBB2FL] Communications Fault, FailCount= 5
2022-11-10T01:21:30.296Z,1668043290.296 [WetLabsBB2FL](ERROR): Communications Fault
2022-11-10T01:21:30.524Z,1668043290.524 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:21:30.529Z,1668043290.529 [MultiRay](INFO): Paused
2022-11-10T01:21:30.606Z,1668043290.606 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL
2022-11-10T01:21:30.607Z,1668043290.607 [CBIT](FAULT): Communications Fault in component: WetLabsBB2FL
2022-11-10T01:21:30.797Z,1668043290.797 [WetLabsBB2FL](INFO): Powering down
2022-11-10T01:21:30.940Z,1668043290.940 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:21:30.945Z,1668043290.945 [MultiRay](INFO): Paused
2022-11-10T01:21:31.372Z,1668043291.372 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:21:31.377Z,1668043291.377 [MultiRay](INFO): Paused
2022-11-10T01:21:31.796Z,1668043291.796 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:21:31.801Z,1668043291.801 [MultiRay](INFO): Paused
2022-11-10T01:21:32.220Z,1668043292.220 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:21:32.226Z,1668043292.226 [MultiRay](INFO): Paused
2022-11-10T01:21:32.640Z,1668043292.640 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:21:32.645Z,1668043292.645 [MultiRay](INFO): Paused
2022-11-10T01:21:33.064Z,1668043293.064 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:21:33.069Z,1668043293.069 [MultiRay](INFO): Paused
2022-11-10T01:21:33.552Z,1668043293.552 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:21:33.557Z,1668043293.557 [MultiRay](INFO): Paused
2022-11-10T01:21:33.992Z,1668043293.992 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:21:33.997Z,1668043293.997 [MultiRay](INFO): Paused
2022-11-10T01:21:34.408Z,1668043294.408 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:21:34.413Z,1668043294.413 [MultiRay](INFO): Paused
2022-11-10T01:21:34.824Z,1668043294.824 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:21:34.829Z,1668043294.829 [MultiRay](INFO): Paused
2022-11-10T01:21:35.244Z,1668043295.244 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:21:35.249Z,1668043295.249 [MultiRay](INFO): Paused
2022-11-10T01:21:35.660Z,1668043295.660 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:21:35.665Z,1668043295.665 [MultiRay](INFO): Paused
2022-11-10T01:21:36.076Z,1668043296.076 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:21:36.081Z,1668043296.081 [MultiRay](INFO): Paused
2022-11-10T01:21:36.488Z,1668043296.488 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:21:36.493Z,1668043296.493 [MultiRay](INFO): Paused
2022-11-10T01:21:36.904Z,1668043296.904 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:21:36.909Z,1668043296.909 [MultiRay](INFO): Paused
2022-11-10T01:21:37.364Z,1668043297.364 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:21:37.370Z,1668043297.370 [MultiRay](INFO): Paused
2022-11-10T01:21:37.371Z,1668043297.371 [NAL9602](INFO): NAL9602 initialized
2022-11-10T01:21:37.788Z,1668043297.788 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:21:37.793Z,1668043297.793 [MultiRay](INFO): Paused
2022-11-10T01:21:38.200Z,1668043298.200 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:21:38.206Z,1668043298.206 [MultiRay](INFO): Paused
2022-11-10T01:21:38.624Z,1668043298.624 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:21:38.629Z,1668043298.629 [MultiRay](INFO): Paused
2022-11-10T01:21:39.064Z,1668043299.064 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:21:39.064Z,1668043299.064 [AHRS_M2](FAULT): Failed to initialize within timeout.
2022-11-10T01:21:39.064Z,1668043299.064 [AHRS_M2] Communications Fault, FailCount= 3
2022-11-10T01:21:39.065Z,1668043299.065 [AHRS_M2](ERROR): Communications Fault
2022-11-10T01:21:39.069Z,1668043299.069 [MultiRay](INFO): Paused
2022-11-10T01:21:39.191Z,1668043299.191 [CBIT](ERROR): Communications Fault in component: AHRS_M2
2022-11-10T01:21:39.199Z,1668043299.199 [AHRS_M2](INFO): Powering down
2022-11-10T01:21:39.277Z,1668043299.277 [MultiRay](INFO): Paused
2022-11-10T01:21:39.617Z,1668043299.617 [MultiRay](INFO): Paused
2022-11-10T01:21:40.013Z,1668043300.013 [MultiRay](INFO): Paused
2022-11-10T01:21:40.086Z,1668043300.086 [CBIT](INFO): Clearing failed state for component AHRS_M2
2022-11-10T01:21:40.086Z,1668043300.086 [AHRS_M2] No Fault, FailCount= 3
2022-11-10T01:21:40.413Z,1668043300.413 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2022-11-10T01:21:40.430Z,1668043300.430 [MultiRay](INFO): Paused
2022-11-10T01:21:40.821Z,1668043300.821 [MultiRay](INFO): Paused
2022-11-10T01:21:41.233Z,1668043301.233 [MultiRay](INFO): Paused
2022-11-10T01:21:41.629Z,1668043301.629 [MultiRay](INFO): Paused
2022-11-10T01:21:42.033Z,1668043302.033 [MultiRay](INFO): Paused
2022-11-10T01:21:42.437Z,1668043302.437 [MultiRay](INFO): Paused
2022-11-10T01:21:42.845Z,1668043302.845 [MultiRay](INFO): Paused
2022-11-10T01:21:43.253Z,1668043303.253 [MultiRay](INFO): Paused
2022-11-10T01:21:43.968Z,1668043303.968 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:21:43.974Z,1668043303.974 [MultiRay](INFO): Paused
2022-11-10T01:21:44.404Z,1668043304.404 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:21:44.417Z,1668043304.417 [MultiRay](INFO): Paused
2022-11-10T01:21:44.840Z,1668043304.840 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:21:44.845Z,1668043304.845 [MultiRay](INFO): Paused
2022-11-10T01:21:45.256Z,1668043305.256 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:21:45.258Z,1668043305.258 [MultiRay](INFO): Paused
2022-11-10T01:21:45.680Z,1668043305.680 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:21:45.689Z,1668043305.689 [MultiRay](INFO): Paused
2022-11-10T01:21:46.120Z,1668043306.120 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:21:46.129Z,1668043306.129 [MultiRay](INFO): Paused
2022-11-10T01:21:46.576Z,1668043306.576 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:21:46.581Z,1668043306.581 [MultiRay](INFO): Paused
2022-11-10T01:21:47.006Z,1668043307.006 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:21:47.019Z,1668043307.019 [MultiRay](INFO): Paused
2022-11-10T01:21:47.432Z,1668043307.432 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:21:47.442Z,1668043307.442 [MultiRay](INFO): Paused
2022-11-10T01:21:47.840Z,1668043307.840 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:21:47.850Z,1668043307.850 [MultiRay](INFO): Paused
2022-11-10T01:21:48.264Z,1668043308.264 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:21:48.273Z,1668043308.273 [MultiRay](INFO): Paused
2022-11-10T01:21:48.688Z,1668043308.688 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:21:48.697Z,1668043308.697 [MultiRay](INFO): Paused
2022-11-10T01:21:49.100Z,1668043309.100 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:21:49.109Z,1668043309.109 [MultiRay](INFO): Paused
2022-11-10T01:21:49.524Z,1668043309.524 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:21:49.533Z,1668043309.533 [MultiRay](INFO): Paused
2022-11-10T01:21:49.944Z,1668043309.944 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:21:49.953Z,1668043309.953 [MultiRay](INFO): Paused
2022-11-10T01:21:50.360Z,1668043310.360 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:21:50.369Z,1668043310.369 [MultiRay](INFO): Paused
2022-11-10T01:21:50.800Z,1668043310.800 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:21:50.817Z,1668043310.817 [MultiRay](INFO): Paused
2022-11-10T01:21:51.240Z,1668043311.240 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:21:51.249Z,1668043311.249 [MultiRay](INFO): Paused
2022-11-10T01:21:51.676Z,1668043311.676 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:21:51.685Z,1668043311.685 [MultiRay](INFO): Paused
2022-11-10T01:21:52.136Z,1668043312.136 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:21:52.142Z,1668043312.142 [MultiRay](INFO): Paused
2022-11-10T01:21:52.552Z,1668043312.552 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:21:52.561Z,1668043312.561 [MultiRay](INFO): Paused
2022-11-10T01:21:52.964Z,1668043312.964 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:21:52.973Z,1668043312.973 [MultiRay](INFO): Paused
2022-11-10T01:21:53.372Z,1668043313.372 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:21:53.372Z,1668043313.372 [AHRS_M2](FAULT): Failed to initialize within timeout.
2022-11-10T01:21:53.372Z,1668043313.372 [AHRS_M2] Communications Fault, FailCount= 4
2022-11-10T01:21:53.372Z,1668043313.372 [AHRS_M2](ERROR): Communications Fault
2022-11-10T01:21:53.381Z,1668043313.381 [MultiRay](INFO): Paused
2022-11-10T01:21:53.433Z,1668043313.433 [CBIT](ERROR): Communications Fault in component: AHRS_M2
2022-11-10T01:21:53.463Z,1668043313.463 [AHRS_M2](INFO): Powering down
2022-11-10T01:21:53.538Z,1668043313.538 [MultiRay](INFO): Paused
2022-11-10T01:21:53.871Z,1668043313.871 [MultiRay](INFO): Paused
2022-11-10T01:21:54.275Z,1668043314.275 [MultiRay](INFO): Paused
2022-11-10T01:21:54.325Z,1668043314.325 [CBIT](INFO): Clearing failed state for component AHRS_M2
2022-11-10T01:21:54.325Z,1668043314.325 [AHRS_M2] No Fault, FailCount= 4
2022-11-10T01:21:54.677Z,1668043314.677 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2022-11-10T01:21:54.687Z,1668043314.687 [MultiRay](INFO): Paused
2022-11-10T01:21:55.085Z,1668043315.085 [MultiRay](INFO): Paused
2022-11-10T01:21:55.489Z,1668043315.489 [MultiRay](INFO): Paused
2022-11-10T01:21:55.891Z,1668043315.891 [MultiRay](INFO): Paused
2022-11-10T01:21:56.295Z,1668043316.295 [MultiRay](INFO): Paused
2022-11-10T01:21:56.700Z,1668043316.700 [MultiRay](INFO): Paused
2022-11-10T01:21:57.105Z,1668043317.105 [MultiRay](INFO): Paused
2022-11-10T01:21:57.507Z,1668043317.507 [MultiRay](INFO): Paused
2022-11-10T01:21:58.232Z,1668043318.232 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:21:58.270Z,1668043318.270 [MultiRay](INFO): Paused
2022-11-10T01:21:58.684Z,1668043318.684 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:21:58.717Z,1668043318.717 [MultiRay](INFO): Paused
2022-11-10T01:21:59.128Z,1668043319.128 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:21:59.137Z,1668043319.137 [MultiRay](INFO): Paused
2022-11-10T01:21:59.548Z,1668043319.548 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:21:59.557Z,1668043319.557 [MultiRay](INFO): Paused
2022-11-10T01:22:00.072Z,1668043320.072 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:22:00.081Z,1668043320.081 [MultiRay](INFO): Paused
2022-11-10T01:22:00.504Z,1668043320.504 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:22:00.521Z,1668043320.521 [MultiRay](INFO): Paused
2022-11-10T01:22:00.960Z,1668043320.960 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:22:00.969Z,1668043320.969 [MultiRay](INFO): Paused
2022-11-10T01:22:01.396Z,1668043321.396 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:22:01.405Z,1668043321.405 [MultiRay](INFO): Paused
2022-11-10T01:22:01.852Z,1668043321.852 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:22:01.869Z,1668043321.869 [MultiRay](INFO): Paused
2022-11-10T01:22:02.292Z,1668043322.292 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:22:02.301Z,1668043322.301 [MultiRay](INFO): Paused
2022-11-10T01:22:02.728Z,1668043322.728 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:22:02.737Z,1668043322.737 [MultiRay](INFO): Paused
2022-11-10T01:22:03.156Z,1668043323.156 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:22:03.174Z,1668043323.174 [MultiRay](INFO): Paused
2022-11-10T01:22:03.572Z,1668043323.572 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:22:03.589Z,1668043323.589 [MultiRay](INFO): Paused
2022-11-10T01:22:04.000Z,1668043324.000 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:22:04.016Z,1668043324.016 [MultiRay](INFO): Paused
2022-11-10T01:22:04.448Z,1668043324.448 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:22:04.490Z,1668043324.490 [MultiRay](INFO): Paused
2022-11-10T01:22:04.900Z,1668043324.900 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:22:04.925Z,1668043324.925 [MultiRay](INFO): Paused
2022-11-10T01:22:05.352Z,1668043325.352 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:22:05.382Z,1668043325.382 [MultiRay](INFO): Paused
2022-11-10T01:22:05.812Z,1668043325.812 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:22:05.854Z,1668043325.854 [MultiRay](INFO): Paused
2022-11-10T01:22:06.296Z,1668043326.296 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:22:06.305Z,1668043326.305 [MultiRay](INFO): Paused
2022-11-10T01:22:06.760Z,1668043326.760 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:22:06.769Z,1668043326.769 [MultiRay](INFO): Paused
2022-11-10T01:22:07.216Z,1668043327.216 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:22:07.226Z,1668043327.226 [MultiRay](INFO): Paused
2022-11-10T01:22:07.696Z,1668043327.696 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:22:07.696Z,1668043327.696 [AHRS_M2](FAULT): Failed to initialize within timeout.
2022-11-10T01:22:07.696Z,1668043327.696 [AHRS_M2] Communications Fault, FailCount= 5
2022-11-10T01:22:07.696Z,1668043327.696 [AHRS_M2](ERROR): Communications Fault
2022-11-10T01:22:07.705Z,1668043327.705 [MultiRay](INFO): Paused
2022-11-10T01:22:07.757Z,1668043327.757 [CBIT](ERROR): Communications Fault in component: AHRS_M2
2022-11-10T01:22:07.758Z,1668043327.758 [CBIT](CRITICAL): Communications Fault in component: AHRS_M2
2022-11-10T01:22:07.797Z,1668043327.797 [AHRS_M2](INFO): Powering down
2022-11-10T01:22:07.886Z,1668043327.886 [MultiRay](INFO): Paused
2022-11-10T01:22:07.904Z,1668043327.904 [CBIT](INFO): Critical error at 20221110T012207
2022-11-10T01:22:08.189Z,1668043328.189 [MultiRay](INFO): Paused
2022-11-10T01:22:08.579Z,1668043328.579 [MultiRay](INFO): Paused
2022-11-10T01:22:08.986Z,1668043328.986 [MultiRay](INFO): Paused
2022-11-10T01:22:09.389Z,1668043329.389 [MultiRay](INFO): Paused
2022-11-10T01:22:09.791Z,1668043329.791 [MultiRay](INFO): Paused
2022-11-10T01:22:10.196Z,1668043330.196 [MultiRay](INFO): Paused
2022-11-10T01:22:10.601Z,1668043330.601 [MultiRay](INFO): Paused
2022-11-10T01:22:11.003Z,1668043331.003 [MultiRay](INFO): Paused
2022-11-10T01:22:11.407Z,1668043331.407 [MultiRay](INFO): Paused
2022-11-10T01:22:11.811Z,1668043331.811 [MultiRay](INFO): Paused
2022-11-10T01:22:12.212Z,1668043332.212 [MultiRay](INFO): Paused
2022-11-10T01:22:12.624Z,1668043332.624 [MultiRay](INFO): Paused
2022-11-10T01:22:13.023Z,1668043333.023 [MultiRay](INFO): Paused
2022-11-10T01:22:13.429Z,1668043333.429 [MultiRay](INFO): Paused
2022-11-10T01:22:13.833Z,1668043333.833 [MultiRay](INFO): Paused
2022-11-10T01:22:14.237Z,1668043334.237 [MultiRay](INFO): Paused
2022-11-10T01:22:14.637Z,1668043334.637 [MultiRay](INFO): Paused
2022-11-10T01:22:15.043Z,1668043335.043 [MultiRay](INFO): Paused
2022-11-10T01:22:15.444Z,1668043335.444 [MultiRay](INFO): Paused
2022-11-10T01:22:15.853Z,1668043335.853 [MultiRay](INFO): Paused
2022-11-10T01:22:16.256Z,1668043336.256 [MultiRay](INFO): Paused
2022-11-10T01:22:16.659Z,1668043336.659 [MultiRay](INFO): Paused
2022-11-10T01:22:17.061Z,1668043337.061 [MultiRay](INFO): Paused
2022-11-10T01:22:17.468Z,1668043337.468 [MultiRay](INFO): Paused
2022-11-10T01:22:17.871Z,1668043337.871 [MultiRay](INFO): Paused
2022-11-10T01:22:18.399Z,1668043338.399 [MultiRay](INFO): Paused
2022-11-10T01:22:18.690Z,1668043338.690 [MultiRay](INFO): Paused
2022-11-10T01:22:19.109Z,1668043339.109 [MultiRay](INFO): Paused
2022-11-10T01:22:19.518Z,1668043339.518 [MultiRay](INFO): Paused
2022-11-10T01:22:19.891Z,1668043339.891 [MultiRay](INFO): Paused
2022-11-10T01:22:20.292Z,1668043340.292 [MultiRay](INFO): Paused
2022-11-10T01:22:20.701Z,1668043340.701 [MultiRay](INFO): Paused
2022-11-10T01:22:21.104Z,1668043341.104 [MultiRay](INFO): Paused
2022-11-10T01:22:21.509Z,1668043341.509 [MultiRay](INFO): Paused
2022-11-10T01:22:21.911Z,1668043341.911 [MultiRay](INFO): Paused
2022-11-10T01:22:22.316Z,1668043342.316 [MultiRay](INFO): Paused
2022-11-10T01:22:22.721Z,1668043342.721 [MultiRay](INFO): Paused
2022-11-10T01:22:23.123Z,1668043343.123 [MultiRay](INFO): Paused
2022-11-10T01:22:23.527Z,1668043343.527 [MultiRay](INFO): Paused
2022-11-10T01:22:23.931Z,1668043343.931 [MultiRay](INFO): Paused
2022-11-10T01:22:24.337Z,1668043344.337 [MultiRay](INFO): Paused
2022-11-10T01:22:24.741Z,1668043344.741 [MultiRay](INFO): Paused
2022-11-10T01:22:25.143Z,1668043345.143 [MultiRay](INFO): Paused
2022-11-10T01:22:25.547Z,1668043345.547 [MultiRay](INFO): Paused
2022-11-10T01:22:25.951Z,1668043345.951 [MultiRay](INFO): Paused
2022-11-10T01:22:26.361Z,1668043346.361 [MultiRay](INFO): Paused
2022-11-10T01:22:26.759Z,1668043346.759 [MultiRay](INFO): Paused
2022-11-10T01:22:27.163Z,1668043347.163 [MultiRay](INFO): Paused
2022-11-10T01:22:27.567Z,1668043347.567 [MultiRay](INFO): Paused
2022-11-10T01:22:27.973Z,1668043347.973 [MultiRay](INFO): Paused
2022-11-10T01:22:28.375Z,1668043348.375 [MultiRay](INFO): Paused
2022-11-10T01:22:28.779Z,1668043348.779 [MultiRay](INFO): Paused
2022-11-10T01:22:29.183Z,1668043349.183 [MultiRay](INFO): Paused
2022-11-10T01:22:29.589Z,1668043349.589 [MultiRay](INFO): Paused
2022-11-10T01:22:29.993Z,1668043349.993 [MultiRay](INFO): Paused
2022-11-10T01:22:30.395Z,1668043350.395 [MultiRay](INFO): Paused
2022-11-10T01:22:30.801Z,1668043350.801 [MultiRay](INFO): Paused
2022-11-10T01:22:31.261Z,1668043351.261 [MultiRay](INFO): Paused
2022-11-10T01:22:31.696Z,1668043351.696 [MultiRay](INFO): Paused
2022-11-10T01:22:32.065Z,1668043352.065 [MultiRay](INFO): Paused
2022-11-10T01:22:32.441Z,1668043352.441 [MultiRay](INFO): Paused
2022-11-10T01:22:32.837Z,1668043352.837 [MultiRay](INFO): Paused
2022-11-10T01:22:33.223Z,1668043353.223 [MultiRay](INFO): Paused
2022-11-10T01:22:33.627Z,1668043353.627 [MultiRay](INFO): Paused
2022-11-10T01:22:34.031Z,1668043354.031 [MultiRay](INFO): Paused
2022-11-10T01:22:34.437Z,1668043354.437 [MultiRay](INFO): Paused
2022-11-10T01:22:34.840Z,1668043354.840 [MultiRay](INFO): Paused
2022-11-10T01:22:35.243Z,1668043355.243 [MultiRay](INFO): Paused
2022-11-10T01:22:35.647Z,1668043355.647 [MultiRay](INFO): Paused
2022-11-10T01:22:36.047Z,1668043356.047 [MultiRay](INFO): Paused
2022-11-10T01:22:36.458Z,1668043356.458 [MultiRay](INFO): Paused
2022-11-10T01:22:36.861Z,1668043356.861 [MultiRay](INFO): Paused
2022-11-10T01:22:37.263Z,1668043357.263 [MultiRay](INFO): Paused
2022-11-10T01:22:37.667Z,1668043357.667 [MultiRay](INFO): Paused
2022-11-10T01:22:38.066Z,1668043358.066 [MultiRay](INFO): Paused
2022-11-10T01:22:38.473Z,1668043358.473 [MultiRay](INFO): Paused
2022-11-10T01:22:38.879Z,1668043358.879 [MultiRay](INFO): Paused
2022-11-10T01:22:39.283Z,1668043359.283 [MultiRay](INFO): Paused
2022-11-10T01:22:39.689Z,1668043359.689 [MultiRay](INFO): Paused
2022-11-10T01:22:40.092Z,1668043360.092 [MultiRay](INFO): Paused
2022-11-10T01:22:40.497Z,1668043360.497 [MultiRay](INFO): Paused
2022-11-10T01:22:40.899Z,1668043360.899 [MultiRay](INFO): Paused
2022-11-10T01:22:41.306Z,1668043361.306 [MultiRay](INFO): Paused
2022-11-10T01:22:41.707Z,1668043361.707 [MultiRay](INFO): Paused
2022-11-10T01:22:42.113Z,1668043362.113 [MultiRay](INFO): Paused
2022-11-10T01:22:42.517Z,1668043362.517 [MultiRay](INFO): Paused
2022-11-10T01:22:42.921Z,1668043362.921 [MultiRay](INFO): Paused
2022-11-10T01:22:43.325Z,1668043363.325 [MultiRay](INFO): Paused
2022-11-10T01:22:43.727Z,1668043363.727 [MultiRay](INFO): Paused
2022-11-10T01:22:44.133Z,1668043364.133 [MultiRay](INFO): Paused
2022-11-10T01:22:44.538Z,1668043364.538 [MultiRay](INFO): Paused
2022-11-10T01:22:45.057Z,1668043365.057 [MultiRay](INFO): Paused
2022-11-10T01:22:45.353Z,1668043365.353 [MultiRay](INFO): Paused
2022-11-10T01:22:45.777Z,1668043365.777 [MultiRay](INFO): Paused
2022-11-10T01:22:46.178Z,1668043366.178 [MultiRay](INFO): Paused
2022-11-10T01:22:46.555Z,1668043366.555 [MultiRay](INFO): Paused
2022-11-10T01:22:46.583Z,1668043366.583 [SBIT](IMPORTANT): Beginning Startup BIT
2022-11-10T01:22:46.588Z,1668043366.588 [CBIT](IMPORTANT): Beginning ground fault scan
2022-11-10T01:22:46.961Z,1668043366.961 [MultiRay](INFO): Paused
2022-11-10T01:22:47.363Z,1668043367.363 [MultiRay](INFO): Paused
2022-11-10T01:22:47.769Z,1668043367.769 [MultiRay](INFO): Paused
2022-11-10T01:22:48.185Z,1668043368.185 [MultiRay](INFO): Paused
2022-11-10T01:22:48.575Z,1668043368.575 [MultiRay](INFO): Paused
2022-11-10T01:22:48.979Z,1668043368.979 [MultiRay](INFO): Paused
2022-11-10T01:22:49.385Z,1668043369.385 [MultiRay](INFO): Paused
2022-11-10T01:22:49.784Z,1668043369.784 [MultiRay](INFO): Paused
2022-11-10T01:22:50.191Z,1668043370.191 [MultiRay](INFO): Paused
2022-11-10T01:22:50.597Z,1668043370.597 [MultiRay](INFO): Paused
2022-11-10T01:22:51.001Z,1668043371.001 [MultiRay](INFO): Paused
2022-11-10T01:22:51.403Z,1668043371.403 [MultiRay](INFO): Paused
2022-11-10T01:22:51.807Z,1668043371.807 [MultiRay](INFO): Paused
2022-11-10T01:22:52.211Z,1668043372.211 [MultiRay](INFO): Paused
2022-11-10T01:22:52.617Z,1668043372.617 [MultiRay](INFO): Paused
2022-11-10T01:22:53.021Z,1668043373.021 [MultiRay](INFO): Paused
2022-11-10T01:22:53.425Z,1668043373.425 [MultiRay](INFO): Paused
2022-11-10T01:22:53.824Z,1668043373.824 [MultiRay](INFO): Paused
2022-11-10T01:22:54.232Z,1668043374.232 [MultiRay](INFO): Paused
2022-11-10T01:22:54.640Z,1668043374.640 [MultiRay](INFO): Paused
2022-11-10T01:22:55.039Z,1668043375.039 [MultiRay](INFO): Paused
2022-11-10T01:22:55.443Z,1668043375.443 [MultiRay](INFO): Paused
2022-11-10T01:22:55.849Z,1668043375.849 [MultiRay](INFO): Paused
2022-11-10T01:22:56.253Z,1668043376.253 [MultiRay](INFO): Paused
2022-11-10T01:22:56.661Z,1668043376.661 [MultiRay](INFO): Paused
2022-11-10T01:22:57.079Z,1668043377.079 [MultiRay](INFO): Paused
2022-11-10T01:22:57.102Z,1668043377.102 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2022-11-10T01:22:57.102Z,1668043377.102 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2022-11-10T01:22:57.102Z,1668043377.102 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2022-11-10T01:22:57.103Z,1668043377.103 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2022-11-10T01:22:57.103Z,1668043377.103 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 1
2022-11-10T01:22:57.103Z,1668043377.103 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2022-11-10T01:22:57.161Z,1668043377.161 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2022-11-10T01:22:57.162Z,1668043377.162 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2022-11-10T01:22:57.459Z,1668043377.459 [MultiRay](INFO): Paused
2022-11-10T01:22:57.514Z,1668043377.514 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2022-11-10T01:22:57.514Z,1668043377.514 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2022-11-10T01:22:57.514Z,1668043377.514 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2022-11-10T01:22:57.514Z,1668043377.514 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 1
2022-11-10T01:22:57.527Z,1668043377.527 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): -0.006369
CHAN A1 (24V): 0.000377
CHAN A2 (12V): -0.005540
CHAN A3 (5V): -0.002580
CHAN B0 (3.3V): -0.000380
CHAN B1 (3.15aV): -0.001094
CHAN B2 (3.15bV): -0.001571
CHAN B3 (GND): -0.000333
OPEN: 0.004624
Full Scale: +/- 1 mA
2022-11-10T01:22:57.870Z,1668043377.870 [MultiRay](INFO): Paused
2022-11-10T01:22:57.896Z,1668043377.896 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2022-11-10T01:22:58.389Z,1668043378.389 [MultiRay](INFO): Paused
2022-11-10T01:22:58.686Z,1668043378.686 [MultiRay](INFO): Paused
2022-11-10T01:22:59.102Z,1668043379.102 [MultiRay](INFO): Paused
2022-11-10T01:22:59.510Z,1668043379.510 [MultiRay](INFO): Paused
2022-11-10T01:22:59.887Z,1668043379.887 [MultiRay](INFO): Paused
2022-11-10T01:23:00.291Z,1668043380.291 [MultiRay](INFO): Paused
2022-11-10T01:23:00.697Z,1668043380.697 [MultiRay](INFO): Paused
2022-11-10T01:23:01.097Z,1668043381.097 [MultiRay](INFO): Paused
2022-11-10T01:23:01.505Z,1668043381.505 [MultiRay](INFO): Paused
2022-11-10T01:23:01.907Z,1668043381.907 [MultiRay](INFO): Paused
2022-11-10T01:23:02.313Z,1668043382.313 [MultiRay](INFO): Paused
2022-11-10T01:23:02.715Z,1668043382.715 [MultiRay](INFO): Paused
2022-11-10T01:23:03.119Z,1668043383.119 [MultiRay](INFO): Paused
2022-11-10T01:23:03.523Z,1668043383.523 [MultiRay](INFO): Paused
2022-11-10T01:23:03.927Z,1668043383.927 [MultiRay](INFO): Paused
2022-11-10T01:23:04.331Z,1668043384.331 [MultiRay](INFO): Paused
2022-11-10T01:23:04.737Z,1668043384.737 [MultiRay](INFO): Paused
2022-11-10T01:23:05.139Z,1668043385.139 [MultiRay](INFO): Paused
2022-11-10T01:23:05.543Z,1668043385.543 [MultiRay](INFO): Paused
2022-11-10T01:23:05.949Z,1668043385.949 [MultiRay](INFO): Paused
2022-11-10T01:23:06.353Z,1668043386.353 [MultiRay](INFO): Paused
2022-11-10T01:23:06.755Z,1668043386.755 [MultiRay](INFO): Paused
2022-11-10T01:23:07.159Z,1668043387.159 [MultiRay](INFO): Paused
2022-11-10T01:23:07.563Z,1668043387.563 [MultiRay](INFO): Paused
2022-11-10T01:23:07.969Z,1668043387.969 [MultiRay](INFO): Paused
2022-11-10T01:23:08.372Z,1668043388.372 [MultiRay](INFO): Paused
2022-11-10T01:23:08.775Z,1668043388.775 [MultiRay](INFO): Paused
2022-11-10T01:23:09.179Z,1668043389.179 [MultiRay](INFO): Paused
2022-11-10T01:23:09.583Z,1668043389.583 [MultiRay](INFO): Paused
2022-11-10T01:23:09.993Z,1668043389.993 [MultiRay](INFO): Paused
2022-11-10T01:23:10.391Z,1668043390.391 [MultiRay](INFO): Paused
2022-11-10T01:23:10.797Z,1668043390.797 [MultiRay](INFO): Paused
2022-11-10T01:23:11.213Z,1668043391.213 [MultiRay](INFO): Paused
2022-11-10T01:23:11.726Z,1668043391.726 [MultiRay](INFO): Paused
2022-11-10T01:23:12.018Z,1668043392.018 [MultiRay](INFO): Paused
2022-11-10T01:23:12.449Z,1668043392.449 [MultiRay](INFO): Paused
2022-11-10T01:23:12.835Z,1668043392.835 [MultiRay](INFO): Paused
2022-11-10T01:23:13.222Z,1668043393.222 [MultiRay](INFO): Paused
2022-11-10T01:23:13.625Z,1668043393.625 [MultiRay](INFO): Paused
2022-11-10T01:23:14.032Z,1668043394.032 [MultiRay](INFO): Paused
2022-11-10T01:23:14.431Z,1668043394.431 [MultiRay](INFO): Paused
2022-11-10T01:23:14.835Z,1668043394.835 [MultiRay](INFO): Paused
2022-11-10T01:23:15.240Z,1668043395.240 [MultiRay](INFO): Paused
2022-11-10T01:23:15.649Z,1668043395.649 [MultiRay](INFO): Paused
2022-11-10T01:23:16.047Z,1668043396.047 [MultiRay](INFO): Paused
2022-11-10T01:23:16.451Z,1668043396.451 [MultiRay](INFO): Paused
2022-11-10T01:23:16.857Z,1668043396.857 [MultiRay](INFO): Paused
2022-11-10T01:23:17.265Z,1668043397.265 [MultiRay](INFO): Paused
2022-11-10T01:23:17.665Z,1668043397.665 [MultiRay](INFO): Paused
2022-11-10T01:23:18.067Z,1668043398.067 [MultiRay](INFO): Paused
2022-11-10T01:23:18.473Z,1668043398.473 [MultiRay](INFO): Paused
2022-11-10T01:23:18.877Z,1668043398.877 [MultiRay](INFO): Paused
2022-11-10T01:23:19.279Z,1668043399.279 [MultiRay](INFO): Paused
2022-11-10T01:23:19.681Z,1668043399.681 [MultiRay](INFO): Paused
2022-11-10T01:23:20.085Z,1668043400.085 [MultiRay](INFO): Paused
2022-11-10T01:23:20.489Z,1668043400.489 [MultiRay](INFO): Paused
2022-11-10T01:23:20.893Z,1668043400.893 [MultiRay](INFO): Paused
2022-11-10T01:23:21.297Z,1668043401.297 [MultiRay](INFO): Paused
2022-11-10T01:23:21.717Z,1668043401.717 [MultiRay](INFO): Paused
2022-11-10T01:23:22.125Z,1668043402.125 [MultiRay](INFO): Paused
2022-11-10T01:23:22.509Z,1668043402.509 [MultiRay](INFO): Paused
2022-11-10T01:23:22.913Z,1668043402.913 [MultiRay](INFO): Paused
2022-11-10T01:23:23.319Z,1668043403.319 [MultiRay](INFO): Paused
2022-11-10T01:23:23.725Z,1668043403.725 [MultiRay](INFO): Paused
2022-11-10T01:23:24.128Z,1668043404.128 [MultiRay](INFO): Paused
2022-11-10T01:23:24.531Z,1668043404.531 [MultiRay](INFO): Paused
2022-11-10T01:23:24.783Z,1668043404.783 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004831
2022-11-10T01:23:25.053Z,1668043405.053 [MultiRay](INFO): Paused
2022-11-10T01:23:25.354Z,1668043405.354 [MultiRay](INFO): Paused
2022-11-10T01:23:25.765Z,1668043405.765 [MultiRay](INFO): Paused
2022-11-10T01:23:26.170Z,1668043406.170 [MultiRay](INFO): Paused
2022-11-10T01:23:26.547Z,1668043406.547 [MultiRay](INFO): Paused
2022-11-10T01:23:26.957Z,1668043406.957 [MultiRay](INFO): Paused
2022-11-10T01:23:27.361Z,1668043407.361 [MultiRay](INFO): Paused
2022-11-10T01:23:27.765Z,1668043407.765 [MultiRay](INFO): Paused
2022-11-10T01:23:28.167Z,1668043408.167 [MultiRay](INFO): Paused
2022-11-10T01:23:28.573Z,1668043408.573 [MultiRay](INFO): Paused
2022-11-10T01:23:28.977Z,1668043408.977 [MultiRay](INFO): Paused
2022-11-10T01:23:29.379Z,1668043409.379 [MultiRay](INFO): Paused
2022-11-10T01:23:29.783Z,1668043409.783 [MultiRay](INFO): Paused
2022-11-10T01:23:30.182Z,1668043410.182 [MultiRay](INFO): Paused
2022-11-10T01:23:30.591Z,1668043410.591 [MultiRay](INFO): Paused
2022-11-10T01:23:30.995Z,1668043410.995 [MultiRay](INFO): Paused
2022-11-10T01:23:31.399Z,1668043411.399 [MultiRay](INFO): Paused
2022-11-10T01:23:31.803Z,1668043411.803 [MultiRay](INFO): Paused
2022-11-10T01:23:32.211Z,1668043412.211 [MultiRay](INFO): Paused
2022-11-10T01:23:32.613Z,1668043412.613 [MultiRay](INFO): Paused
2022-11-10T01:23:33.015Z,1668043413.015 [MultiRay](INFO): Paused
2022-11-10T01:23:33.421Z,1668043413.421 [MultiRay](INFO): Paused
2022-11-10T01:23:33.827Z,1668043413.827 [MultiRay](INFO): Paused
2022-11-10T01:23:34.227Z,1668043414.227 [MultiRay](INFO): Paused
2022-11-10T01:23:34.633Z,1668043414.633 [MultiRay](INFO): Paused
2022-11-10T01:23:35.035Z,1668043415.035 [MultiRay](INFO): Paused
2022-11-10T01:23:35.439Z,1668043415.439 [MultiRay](INFO): Paused
2022-11-10T01:23:35.843Z,1668043415.843 [MultiRay](INFO): Paused
2022-11-10T01:23:36.247Z,1668043416.247 [MultiRay](INFO): Paused
2022-11-10T01:23:36.653Z,1668043416.653 [MultiRay](INFO): Paused
2022-11-10T01:23:37.059Z,1668043417.059 [MultiRay](INFO): Paused
2022-11-10T01:23:37.461Z,1668043417.461 [MultiRay](INFO): Paused
2022-11-10T01:23:37.863Z,1668043417.863 [MultiRay](INFO): Paused
2022-11-10T01:23:38.323Z,1668043418.323 [MultiRay](INFO): Paused
2022-11-10T01:23:38.742Z,1668043418.742 [MultiRay](INFO): Paused
2022-11-10T01:23:39.110Z,1668043419.110 [MultiRay](INFO): Paused
2022-11-10T01:23:39.509Z,1668043419.509 [MultiRay](INFO): Paused
2022-11-10T01:23:39.890Z,1668043419.890 [MultiRay](INFO): Paused
2022-11-10T01:23:40.289Z,1668043420.289 [MultiRay](INFO): Paused
2022-11-10T01:23:40.693Z,1668043420.693 [MultiRay](INFO): Paused
2022-11-10T01:23:40.721Z,1668043420.721 [SBIT](IMPORTANT): SBIT PASSED
2022-11-10T01:23:40.721Z,1668043420.721 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2022-11-10T01:23:40.722Z,1668043420.722 [SBIT](IMPORTANT): BackseatComponent.needs24v=1 bool;

2022-11-10T01:23:40.722Z,1668043420.722 [SBIT](IMPORTANT): BuoyancyServo.fastPumpCoefficient=6 none;

2022-11-10T01:23:40.722Z,1668043420.722 [SBIT](IMPORTANT): CBIT.gf24Offset=149 microampere;

2022-11-10T01:23:40.722Z,1668043420.722 [SBIT](IMPORTANT): CBIT.gfScanTimeout=2 hour;

2022-11-10T01:23:40.722Z,1668043420.722 [SBIT](IMPORTANT): CTD_Seabird.loadAtStartup=0 bool;

2022-11-10T01:23:40.722Z,1668043420.722 [SBIT](IMPORTANT): DAT.surfaceThreshold=-1 meter;

2022-11-10T01:23:40.722Z,1668043420.722 [SBIT](IMPORTANT): Express none _.ayeris_disk_space;

2022-11-10T01:23:40.723Z,1668043420.723 [SBIT](IMPORTANT): Express linearApproximation _.ayeris_particle_counts 250.000000 count;

2022-11-10T01:23:40.723Z,1668043420.723 [SBIT](IMPORTANT): Express none _.ayeris_particle_size;

2022-11-10T01:23:40.723Z,1668043420.723 [SBIT](IMPORTANT): IBIT.batteryCapacityThreshold=5 ampere_hour;

2022-11-10T01:23:40.723Z,1668043420.723 [SBIT](IMPORTANT): IBIT.batteryVoltageThreshold=11 volt;

2022-11-10T01:23:40.723Z,1668043420.723 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=210.367112 cubic_centimeter;

2022-11-10T01:23:40.723Z,1668043420.723 [SBIT](IMPORTANT): VerticalControl.massDefault=22.333859 millimeter;

2022-11-10T01:23:41.094Z,1668043421.094 [MultiRay](INFO): Paused
2022-11-10T01:23:41.106Z,1668043421.106 [MissionManager](IMPORTANT): Started mission Startup
2022-11-10T01:23:41.107Z,1668043421.107 [Startup] Running Loop=1
2022-11-10T01:23:41.107Z,1668043421.107 [Startup](DEBUG): Aggregate::initialize Startup
2022-11-10T01:23:41.107Z,1668043421.107 [Startup:A.GoToSurface] Running Loop=1
2022-11-10T01:23:41.107Z,1668043421.107 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2022-11-10T01:23:41.108Z,1668043421.108 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2022-11-10T01:23:41.108Z,1668043421.108 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2022-11-10T01:23:41.109Z,1668043421.109 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2022-11-10T01:23:41.109Z,1668043421.109 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2022-11-10T01:23:41.109Z,1668043421.109 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2022-11-10T01:23:41.111Z,1668043421.111 [Startup:StartupSatComms] Running Loop=1
2022-11-10T01:23:41.111Z,1668043421.111 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2022-11-10T01:23:41.111Z,1668043421.111 [Startup:StartupSatComms:A] Running Loop=1
2022-11-10T01:23:41.503Z,1668043421.503 [MultiRay](INFO): Paused
2022-11-10T01:23:41.511Z,1668043421.511 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2022-11-10T01:23:41.905Z,1668043421.905 [MultiRay](INFO): Paused
2022-11-10T01:23:42.305Z,1668043422.305 [MultiRay](INFO): Paused
2022-11-10T01:23:42.711Z,1668043422.711 [MultiRay](INFO): Paused
2022-11-10T01:23:43.111Z,1668043423.111 [MultiRay](INFO): Paused
2022-11-10T01:23:43.522Z,1668043423.522 [MultiRay](INFO): Paused
2022-11-10T01:23:43.925Z,1668043423.925 [MultiRay](INFO): Paused
2022-11-10T01:23:44.327Z,1668043424.327 [MultiRay](INFO): Paused
2022-11-10T01:23:44.731Z,1668043424.731 [MultiRay](INFO): Paused
2022-11-10T01:23:45.135Z,1668043425.135 [MultiRay](INFO): Paused
2022-11-10T01:23:45.544Z,1668043425.544 [MultiRay](INFO): Paused
2022-11-10T01:23:45.943Z,1668043425.943 [MultiRay](INFO): Paused
2022-11-10T01:23:46.349Z,1668043426.349 [MultiRay](INFO): Paused
2022-11-10T01:23:46.750Z,1668043426.750 [MultiRay](INFO): Paused
2022-11-10T01:23:47.159Z,1668043427.159 [MultiRay](INFO): Paused
2022-11-10T01:23:47.559Z,1668043427.559 [MultiRay](INFO): Paused
2022-11-10T01:23:47.963Z,1668043427.963 [MultiRay](INFO): Paused
2022-11-10T01:23:48.369Z,1668043428.369 [MultiRay](INFO): Paused
2022-11-10T01:23:48.777Z,1668043428.777 [MultiRay](INFO): Paused
2022-11-10T01:23:49.178Z,1668043429.178 [MultiRay](INFO): Paused
2022-11-10T01:23:49.579Z,1668043429.579 [MultiRay](INFO): Paused
2022-11-10T01:23:49.980Z,1668043429.980 [MultiRay](INFO): Paused
2022-11-10T01:23:50.388Z,1668043430.388 [MultiRay](INFO): Paused
2022-11-10T01:23:50.796Z,1668043430.796 [MultiRay](INFO): Paused
2022-11-10T01:23:51.195Z,1668043431.195 [MultiRay](INFO): Paused
2022-11-10T01:23:51.662Z,1668043431.662 [MultiRay](INFO): Paused
2022-11-10T01:23:52.088Z,1668043432.088 [MultiRay](INFO): Paused
2022-11-10T01:23:52.422Z,1668043432.422 [MultiRay](INFO): Paused
2022-11-10T01:23:52.837Z,1668043432.837 [MultiRay](INFO): Paused
2022-11-10T01:23:53.229Z,1668043433.229 [MultiRay](INFO): Paused
2022-11-10T01:23:53.619Z,1668043433.619 [MultiRay](INFO): Paused
2022-11-10T01:23:54.025Z,1668043434.025 [MultiRay](INFO): Paused
2022-11-10T01:23:54.427Z,1668043434.427 [MultiRay](INFO): Paused
2022-11-10T01:23:54.834Z,1668043434.834 [MultiRay](INFO): Paused
2022-11-10T01:23:55.233Z,1668043435.233 [MultiRay](INFO): Paused
2022-11-10T01:23:55.641Z,1668043435.641 [MultiRay](INFO): Paused
2022-11-10T01:23:56.041Z,1668043436.041 [MultiRay](INFO): Paused
2022-11-10T01:23:56.445Z,1668043436.445 [MultiRay](INFO): Paused
2022-11-10T01:23:56.850Z,1668043436.850 [MultiRay](INFO): Paused
2022-11-10T01:23:57.261Z,1668043437.261 [MultiRay](INFO): Paused
2022-11-10T01:23:57.657Z,1668043437.657 [MultiRay](INFO): Paused
2022-11-10T01:23:58.061Z,1668043438.061 [MultiRay](INFO): Paused
2022-11-10T01:23:58.467Z,1668043438.467 [MultiRay](INFO): Paused
2022-11-10T01:23:58.873Z,1668043438.873 [MultiRay](INFO): Paused
2022-11-10T01:23:59.277Z,1668043439.277 [MultiRay](INFO): Paused
2022-11-10T01:23:59.679Z,1668043439.679 [MultiRay](INFO): Paused
2022-11-10T01:24:00.083Z,1668043440.083 [MultiRay](INFO): Paused
2022-11-10T01:24:00.485Z,1668043440.485 [MultiRay](INFO): Paused
2022-11-10T01:24:00.519Z,1668043440.519 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL
2022-11-10T01:24:00.519Z,1668043440.519 [WetLabsBB2FL] No Fault, FailCount= 5
2022-11-10T01:24:00.722Z,1668043440.722 [WetLabsBB2FL](INFO): Powering up
2022-11-10T01:24:00.894Z,1668043440.894 [MultiRay](INFO): Paused
2022-11-10T01:24:01.295Z,1668043441.295 [MultiRay](INFO): Paused
2022-11-10T01:24:01.699Z,1668043441.699 [MultiRay](INFO): Paused
2022-11-10T01:24:02.103Z,1668043442.103 [MultiRay](INFO): Paused
2022-11-10T01:24:02.507Z,1668043442.507 [MultiRay](INFO): Paused
2022-11-10T01:24:02.911Z,1668043442.911 [MultiRay](INFO): Paused
2022-11-10T01:24:03.315Z,1668043443.315 [MultiRay](INFO): Paused
2022-11-10T01:24:03.721Z,1668043443.721 [MultiRay](INFO): Paused
2022-11-10T01:24:04.126Z,1668043444.126 [MultiRay](INFO): Paused
2022-11-10T01:24:04.585Z,1668043444.585 [MultiRay](INFO): Paused
2022-11-10T01:24:04.939Z,1668043444.939 [MultiRay](INFO): Paused
2022-11-10T01:24:05.404Z,1668043445.404 [MultiRay](INFO): Paused
2022-11-10T01:24:05.769Z,1668043445.769 [MultiRay](INFO): Paused
2022-11-10T01:24:06.036Z,1668043446.036 [WetLabsBB2FL] Communications Fault, FailCount= 1
2022-11-10T01:24:06.036Z,1668043446.036 [WetLabsBB2FL](ERROR): Communications Fault
2022-11-10T01:24:06.155Z,1668043446.155 [MultiRay](INFO): Paused
2022-11-10T01:24:06.190Z,1668043446.190 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL
2022-11-10T01:24:06.541Z,1668043446.541 [WetLabsBB2FL](INFO): Powering down
2022-11-10T01:24:06.565Z,1668043446.565 [MultiRay](INFO): Paused
2022-11-10T01:24:06.947Z,1668043446.947 [MultiRay](INFO): Paused
2022-11-10T01:24:07.358Z,1668043447.358 [MultiRay](INFO): Paused
2022-11-10T01:24:07.374Z,1668043447.374 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL
2022-11-10T01:24:07.374Z,1668043447.374 [WetLabsBB2FL] No Fault, FailCount= 1
2022-11-10T01:24:07.754Z,1668043447.754 [WetLabsBB2FL](INFO): Powering up
2022-11-10T01:24:07.758Z,1668043447.758 [MultiRay](INFO): Paused
2022-11-10T01:24:08.162Z,1668043448.162 [MultiRay](INFO): Paused
2022-11-10T01:24:08.570Z,1668043448.570 [MultiRay](INFO): Paused
2022-11-10T01:24:08.971Z,1668043448.971 [MultiRay](INFO): Paused
2022-11-10T01:24:09.375Z,1668043449.375 [MultiRay](INFO): Paused
2022-11-10T01:24:09.779Z,1668043449.779 [MultiRay](INFO): Paused
2022-11-10T01:24:10.185Z,1668043450.185 [MultiRay](INFO): Paused
2022-11-10T01:24:10.590Z,1668043450.590 [MultiRay](INFO): Paused
2022-11-10T01:24:10.993Z,1668043450.993 [MultiRay](INFO): Paused
2022-11-10T01:24:11.397Z,1668043451.397 [MultiRay](INFO): Paused
2022-11-10T01:24:11.799Z,1668043451.799 [MultiRay](INFO): Paused
2022-11-10T01:24:12.203Z,1668043452.203 [MultiRay](INFO): Paused
2022-11-10T01:24:12.608Z,1668043452.608 [MultiRay](INFO): Paused
2022-11-10T01:24:13.013Z,1668043453.013 [MultiRay](INFO): Paused
2022-11-10T01:24:13.056Z,1668043453.056 [WetLabsBB2FL] Communications Fault, FailCount= 2
2022-11-10T01:24:13.056Z,1668043453.056 [WetLabsBB2FL](ERROR): Communications Fault
2022-11-10T01:24:13.417Z,1668043453.417 [MultiRay](INFO): Paused
2022-11-10T01:24:13.433Z,1668043453.433 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL
2022-11-10T01:24:13.557Z,1668043453.557 [WetLabsBB2FL](INFO): Powering down
2022-11-10T01:24:13.825Z,1668043453.825 [MultiRay](INFO): Paused
2022-11-10T01:24:14.225Z,1668043454.225 [MultiRay](INFO): Paused
2022-11-10T01:24:14.629Z,1668043454.629 [MultiRay](INFO): Paused
2022-11-10T01:24:14.657Z,1668043454.657 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL
2022-11-10T01:24:14.657Z,1668043454.657 [WetLabsBB2FL] No Fault, FailCount= 2
2022-11-10T01:24:14.771Z,1668043454.771 [WetLabsBB2FL](INFO): Powering up
2022-11-10T01:24:15.033Z,1668043455.033 [MultiRay](INFO): Paused
2022-11-10T01:24:15.435Z,1668043455.435 [MultiRay](INFO): Paused
2022-11-10T01:24:15.841Z,1668043455.841 [MultiRay](INFO): Paused
2022-11-10T01:24:16.245Z,1668043456.245 [MultiRay](INFO): Paused
2022-11-10T01:24:16.647Z,1668043456.647 [MultiRay](INFO): Paused
2022-11-10T01:24:17.051Z,1668043457.051 [MultiRay](INFO): Paused
2022-11-10T01:24:17.453Z,1668043457.453 [MultiRay](INFO): Paused
2022-11-10T01:24:17.917Z,1668043457.917 [MultiRay](INFO): Paused
2022-11-10T01:24:18.273Z,1668043458.273 [MultiRay](INFO): Paused
2022-11-10T01:24:18.734Z,1668043458.734 [MultiRay](INFO): Paused
2022-11-10T01:24:19.094Z,1668043459.094 [MultiRay](INFO): Paused
2022-11-10T01:24:19.489Z,1668043459.489 [MultiRay](INFO): Paused
2022-11-10T01:24:19.896Z,1668043459.896 [MultiRay](INFO): Paused
2022-11-10T01:24:20.068Z,1668043460.068 [WetLabsBB2FL] Communications Fault, FailCount= 3
2022-11-10T01:24:20.068Z,1668043460.068 [WetLabsBB2FL](ERROR): Communications Fault
2022-11-10T01:24:20.282Z,1668043460.282 [MultiRay](INFO): Paused
2022-11-10T01:24:20.297Z,1668043460.297 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL
2022-11-10T01:24:20.569Z,1668043460.569 [WetLabsBB2FL](INFO): Powering down
2022-11-10T01:24:20.684Z,1668043460.684 [MultiRay](INFO): Paused
2022-11-10T01:24:21.093Z,1668043461.093 [MultiRay](INFO): Paused
2022-11-10T01:24:21.497Z,1668043461.497 [MultiRay](INFO): Paused
2022-11-10T01:24:21.533Z,1668043461.533 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL
2022-11-10T01:24:21.533Z,1668043461.533 [WetLabsBB2FL] No Fault, FailCount= 3
2022-11-10T01:24:21.781Z,1668043461.781 [WetLabsBB2FL](INFO): Powering up
2022-11-10T01:24:21.902Z,1668043461.902 [MultiRay](INFO): Paused
2022-11-10T01:24:22.305Z,1668043462.305 [MultiRay](INFO): Paused
2022-11-10T01:24:22.708Z,1668043462.708 [MultiRay](INFO): Paused
2022-11-10T01:24:23.111Z,1668043463.111 [MultiRay](INFO): Paused
2022-11-10T01:24:23.511Z,1668043463.511 [MultiRay](INFO): Paused
2022-11-10T01:24:23.917Z,1668043463.917 [MultiRay](INFO): Paused
2022-11-10T01:24:24.324Z,1668043464.324 [MultiRay](INFO): Paused
2022-11-10T01:24:24.727Z,1668043464.727 [MultiRay](INFO): Paused
2022-11-10T01:24:25.131Z,1668043465.131 [MultiRay](INFO): Paused
2022-11-10T01:24:25.537Z,1668043465.537 [MultiRay](INFO): Paused
2022-11-10T01:24:25.941Z,1668043465.941 [MultiRay](INFO): Paused
2022-11-10T01:24:26.343Z,1668043466.343 [MultiRay](INFO): Paused
2022-11-10T01:24:26.747Z,1668043466.747 [MultiRay](INFO): Paused
2022-11-10T01:24:27.080Z,1668043467.080 [WetLabsBB2FL] Communications Fault, FailCount= 4
2022-11-10T01:24:27.080Z,1668043467.080 [WetLabsBB2FL](ERROR): Communications Fault
2022-11-10T01:24:27.171Z,1668043467.171 [MultiRay](INFO): Paused
2022-11-10T01:24:27.204Z,1668043467.204 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL
2022-11-10T01:24:27.558Z,1668043467.558 [MultiRay](INFO): Paused
2022-11-10T01:24:27.581Z,1668043467.581 [WetLabsBB2FL](INFO): Powering down
2022-11-10T01:24:27.968Z,1668043467.968 [MultiRay](INFO): Paused
2022-11-10T01:24:28.363Z,1668043468.363 [MultiRay](INFO): Paused
2022-11-10T01:24:28.401Z,1668043468.401 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL
2022-11-10T01:24:28.401Z,1668043468.401 [WetLabsBB2FL] No Fault, FailCount= 4
2022-11-10T01:24:28.769Z,1668043468.769 [MultiRay](INFO): Paused
2022-11-10T01:24:28.794Z,1668043468.794 [WetLabsBB2FL](INFO): Powering up
2022-11-10T01:24:29.181Z,1668043469.181 [MultiRay](INFO): Paused
2022-11-10T01:24:29.575Z,1668043469.575 [MultiRay](INFO): Paused
2022-11-10T01:24:29.976Z,1668043469.976 [MultiRay](INFO): Paused
2022-11-10T01:24:30.385Z,1668043470.385 [MultiRay](INFO): Paused
2022-11-10T01:24:30.785Z,1668043470.785 [MultiRay](INFO): Paused
2022-11-10T01:24:31.295Z,1668043471.295 [MultiRay](INFO): Paused
2022-11-10T01:24:31.326Z,1668043471.326 [CommandExec](IMPORTANT): got command show stack
2022-11-10T01:24:31.326Z,1668043471.326 [CommandExec](IMPORTANT): Behavior Stack:

2022-11-10T01:24:31.326Z,1668043471.326 [Startup](IMPORTANT): Priority 0: Startup:A.GoToSurface
2022-11-10T01:24:31.326Z,1668043471.326 [Startup:StartupSatComms](IMPORTANT): Priority 1: Startup:StartupSatComms:A
2022-11-10T01:24:31.629Z,1668043471.629 [MultiRay](INFO): Paused
2022-11-10T01:24:32.127Z,1668043472.127 [MultiRay](INFO): Paused
2022-11-10T01:24:32.425Z,1668043472.425 [MultiRay](INFO): Paused
2022-11-10T01:24:32.829Z,1668043472.829 [MultiRay](INFO): Paused
2022-11-10T01:24:33.221Z,1668043473.221 [MultiRay](INFO): Paused
2022-11-10T01:24:33.614Z,1668043473.614 [MultiRay](INFO): Paused
2022-11-10T01:24:34.030Z,1668043474.030 [MultiRay](INFO): Paused
2022-11-10T01:24:34.092Z,1668043474.092 [WetLabsBB2FL] Communications Fault, FailCount= 5
2022-11-10T01:24:34.093Z,1668043474.093 [WetLabsBB2FL](ERROR): Communications Fault
2022-11-10T01:24:34.424Z,1668043474.424 [MultiRay](INFO): Paused
2022-11-10T01:24:34.441Z,1668043474.441 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL
2022-11-10T01:24:34.442Z,1668043474.442 [CBIT](FAULT): Communications Fault in component: WetLabsBB2FL
2022-11-10T01:24:34.592Z,1668043474.592 [WetLabsBB2FL](INFO): Powering down
2022-11-10T01:24:34.833Z,1668043474.833 [MultiRay](INFO): Paused
2022-11-10T01:24:35.231Z,1668043475.231 [MultiRay](INFO): Paused
2022-11-10T01:24:35.637Z,1668043475.637 [MultiRay](INFO): Paused
2022-11-10T01:24:36.041Z,1668043476.041 [MultiRay](INFO): Paused
2022-11-10T01:24:36.446Z,1668043476.446 [MultiRay](INFO): Paused
2022-11-10T01:24:36.847Z,1668043476.847 [MultiRay](INFO): Paused
2022-11-10T01:24:37.251Z,1668043477.251 [MultiRay](INFO): Paused
2022-11-10T01:24:37.652Z,1668043477.652 [MultiRay](INFO): Paused
2022-11-10T01:24:38.061Z,1668043478.061 [MultiRay](INFO): Paused
2022-11-10T01:24:38.462Z,1668043478.462 [MultiRay](INFO): Paused
2022-11-10T01:24:38.867Z,1668043478.867 [MultiRay](INFO): Paused
2022-11-10T01:24:39.271Z,1668043479.271 [MultiRay](INFO): Paused
2022-11-10T01:24:39.679Z,1668043479.679 [MultiRay](INFO): Paused
2022-11-10T01:24:40.085Z,1668043480.085 [MultiRay](INFO): Paused
2022-11-10T01:24:40.485Z,1668043480.485 [MultiRay](INFO): Paused
2022-11-10T01:24:40.889Z,1668043480.889 [MultiRay](INFO): Paused
2022-11-10T01:24:41.292Z,1668043481.292 [MultiRay](INFO): Paused
2022-11-10T01:24:41.306Z,1668043481.306 [Startup:StartupSatComms:A](INFO): Timed out from 2022-11-10T01:23:41.1Z
2022-11-10T01:24:41.306Z,1668043481.306 [Startup:StartupSatComms:A] Stopped
2022-11-10T01:24:41.306Z,1668043481.306 [Startup:StartupSatComms:B] Running Loop=1
2022-11-10T01:24:41.695Z,1668043481.695 [MultiRay](INFO): Paused
2022-11-10T01:24:41.703Z,1668043481.703 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2022-11-10T01:24:42.452Z,1668043482.452 [MultiRay](INFO): Paused
2022-11-10T01:24:42.861Z,1668043482.861 [MultiRay](INFO): Paused
2022-11-10T01:24:43.194Z,1668043483.194 [DAT](DEBUG): In sendingFillBuffer, set commsState_ = SENDING_TRANSMIT
2022-11-10T01:24:43.195Z,1668043483.195 [DAT](INFO): setting remote address to 1
2022-11-10T01:24:43.261Z,1668043483.261 [MultiRay](INFO): Paused
2022-11-10T01:24:43.450Z,1668043483.450 [DAT](INFO): set remote address to 1
2022-11-10T01:24:43.450Z,1668043483.450 [DAT](INFO): entering online mode
2022-11-10T01:24:43.665Z,1668043483.665 [MultiRay](INFO): Paused
2022-11-10T01:24:43.703Z,1668043483.703 [DAT](INFO): commRate: 800
2022-11-10T01:24:43.703Z,1668043483.703 [DAT](INFO): online mode acknowledged
2022-11-10T01:24:43.703Z,1668043483.703 [DAT](DEBUG): In sendingTransmit, set commsState_ = SENDING_TRANSMIT_VERIFY
2022-11-10T01:24:44.069Z,1668043484.069 [MultiRay](INFO): Paused
2022-11-10T01:24:44.529Z,1668043484.529 [MultiRay](INFO): Paused
2022-11-10T01:24:44.902Z,1668043484.902 [MultiRay](INFO): Paused
2022-11-10T01:24:45.289Z,1668043485.289 [MultiRay](INFO): Paused
2022-11-10T01:24:45.799Z,1668043485.799 [MultiRay](INFO): Paused
2022-11-10T01:24:46.102Z,1668043486.102 [MultiRay](INFO): Paused
2022-11-10T01:24:46.501Z,1668043486.501 [MultiRay](INFO): Paused
2022-11-10T01:24:46.905Z,1668043486.905 [MultiRay](INFO): Paused
2022-11-10T01:24:46.978Z,1668043486.978 [DAT](DEBUG): In parseResponses, set commsState_ = SENDING_ACK_WAITING
2022-11-10T01:24:47.299Z,1668043487.299 [MultiRay](INFO): Paused
2022-11-10T01:24:47.705Z,1668043487.705 [MultiRay](INFO): Paused
2022-11-10T01:24:48.105Z,1668043488.105 [MultiRay](INFO): Paused
2022-11-10T01:24:48.509Z,1668043488.509 [MultiRay](INFO): Paused
2022-11-10T01:24:48.920Z,1668043488.920 [MultiRay](INFO): Paused
2022-11-10T01:24:49.320Z,1668043489.320 [MultiRay](INFO): Paused
2022-11-10T01:24:49.692Z,1668043489.692 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20221110T010558/Courier0007.lzma
2022-11-10T01:24:49.723Z,1668043489.723 [MultiRay](INFO): Paused
2022-11-10T01:24:50.127Z,1668043490.127 [MultiRay](INFO): Paused
2022-11-10T01:24:50.533Z,1668043490.533 [MultiRay](INFO): Paused
2022-11-10T01:24:50.694Z,1668043490.694 [DataOverHttps](INFO): Moved sent file to Logs/20221110T010558/Courier0007.lzma.bak
2022-11-10T01:24:50.694Z,1668043490.694 [DataOverHttps](INFO): SBD MOMSN=17278756
2022-11-10T01:24:50.932Z,1668043490.932 [MultiRay](INFO): Paused
2022-11-10T01:24:51.341Z,1668043491.341 [MultiRay](INFO): Paused
2022-11-10T01:24:51.766Z,1668043491.766 [MultiRay](INFO): Paused
2022-11-10T01:24:52.145Z,1668043492.145 [MultiRay](INFO): Paused
2022-11-10T01:24:52.556Z,1668043492.556 [MultiRay](INFO): Paused
2022-11-10T01:24:52.957Z,1668043492.957 [MultiRay](INFO): Paused
2022-11-10T01:24:53.359Z,1668043493.359 [MultiRay](INFO): Paused
2022-11-10T01:24:53.759Z,1668043493.759 [MultiRay](INFO): Paused
2022-11-10T01:24:54.165Z,1668043494.165 [MultiRay](INFO): Paused
2022-11-10T01:24:54.569Z,1668043494.569 [MultiRay](INFO): Paused
2022-11-10T01:24:54.973Z,1668043494.973 [MultiRay](INFO): Paused
2022-11-10T01:24:55.377Z,1668043495.377 [MultiRay](INFO): Paused
2022-11-10T01:24:55.781Z,1668043495.781 [MultiRay](INFO): Paused
2022-11-10T01:24:56.185Z,1668043496.185 [MultiRay](INFO): Paused
2022-11-10T01:24:56.602Z,1668043496.602 [MultiRay](INFO): Paused
2022-11-10T01:24:56.993Z,1668043496.993 [MultiRay](INFO): Paused
2022-11-10T01:24:57.401Z,1668043497.401 [MultiRay](INFO): Paused
2022-11-10T01:24:57.803Z,1668043497.803 [MultiRay](INFO): Paused
2022-11-10T01:24:58.073Z,1668043498.073 [DAT](DEBUG): In sendingAckWaiting, timeout so set commsState_ = SENDING_FILL_BUFFER
2022-11-10T01:24:58.264Z,1668043498.264 [MultiRay](INFO): Paused
2022-11-10T01:24:58.288Z,1668043498.288 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2022-11-10T01:24:58.288Z,1668043498.288 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2
2022-11-10T01:24:58.288Z,1668043498.288 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2022-11-10T01:24:58.290Z,1668043498.290 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2022-11-10T01:24:58.290Z,1668043498.290 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 2
2022-11-10T01:24:58.290Z,1668043498.290 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2022-11-10T01:24:58.301Z,1668043498.301 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2022-11-10T01:24:58.301Z,1668043498.301 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2022-11-10T01:24:58.617Z,1668043498.617 [MultiRay](INFO): Paused
2022-11-10T01:24:58.686Z,1668043498.686 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2022-11-10T01:24:58.686Z,1668043498.686 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2
2022-11-10T01:24:58.686Z,1668043498.686 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2022-11-10T01:24:58.686Z,1668043498.686 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 2
2022-11-10T01:24:59.127Z,1668043499.127 [DAT](DEBUG): In sendingFillBuffer, set commsState_ = SENDING_TRANSMIT
2022-11-10T01:24:59.128Z,1668043499.128 [MultiRay](INFO): Paused
2022-11-10T01:24:59.134Z,1668043499.134 [DAT](DEBUG): In sendingTransmit, set commsState_ = SENDING_TRANSMIT_VERIFY
2022-11-10T01:24:59.176Z,1668043499.176 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2022-11-10T01:24:59.437Z,1668043499.437 [MultiRay](INFO): Paused
2022-11-10T01:24:59.837Z,1668043499.837 [MultiRay](INFO): Paused
2022-11-10T01:25:00.241Z,1668043500.241 [MultiRay](INFO): Paused
2022-11-10T01:25:00.631Z,1668043500.631 [MultiRay](INFO): Paused
2022-11-10T01:25:01.037Z,1668043501.037 [MultiRay](INFO): Paused
2022-11-10T01:25:01.448Z,1668043501.448 [MultiRay](INFO): Paused
2022-11-10T01:25:01.845Z,1668043501.845 [MultiRay](INFO): Paused
2022-11-10T01:25:02.249Z,1668043502.249 [MultiRay](INFO): Paused
2022-11-10T01:25:02.406Z,1668043502.406 [DAT](DEBUG): In parseResponses, set commsState_ = SENDING_ACK_WAITING
2022-11-10T01:25:02.650Z,1668043502.650 [MultiRay](INFO): Paused
2022-11-10T01:25:03.057Z,1668043503.057 [MultiRay](INFO): Paused
2022-11-10T01:25:03.465Z,1668043503.465 [MultiRay](INFO): Paused
2022-11-10T01:25:03.861Z,1668043503.861 [MultiRay](INFO): Paused
2022-11-10T01:25:04.267Z,1668043504.267 [MultiRay](INFO): Paused
2022-11-10T01:25:04.669Z,1668043504.669 [MultiRay](INFO): Paused
2022-11-10T01:25:05.073Z,1668043505.073 [MultiRay](INFO): Paused
2022-11-10T01:25:05.477Z,1668043505.477 [MultiRay](INFO): Paused
2022-11-10T01:25:05.884Z,1668043505.884 [MultiRay](INFO): Paused
2022-11-10T01:25:06.208Z,1668043506.208 [DataOverHttps](INFO): Sending 273 bytes from file Logs/20221110T012046/Courier0000.lzma
2022-11-10T01:25:06.290Z,1668043506.290 [MultiRay](INFO): Paused
2022-11-10T01:25:06.691Z,1668043506.691 [MultiRay](INFO): Paused
2022-11-10T01:25:07.094Z,1668043507.094 [MultiRay](INFO): Paused
2022-11-10T01:25:07.210Z,1668043507.210 [DataOverHttps](INFO): Moved sent file to Logs/20221110T012046/Courier0000.lzma.bak
2022-11-10T01:25:07.210Z,1668043507.210 [DataOverHttps](INFO): SBD MOMSN=17278758
2022-11-10T01:25:07.505Z,1668043507.505 [MultiRay](INFO): Paused
2022-11-10T01:25:07.903Z,1668043507.903 [MultiRay](INFO): Paused
2022-11-10T01:25:08.305Z,1668043508.305 [MultiRay](INFO): Paused
2022-11-10T01:25:08.709Z,1668043508.709 [MultiRay](INFO): Paused
2022-11-10T01:25:09.117Z,1668043509.117 [MultiRay](INFO): Paused
2022-11-10T01:25:09.532Z,1668043509.532 [MultiRay](INFO): Paused
2022-11-10T01:25:09.919Z,1668043509.919 [MultiRay](INFO): Paused
2022-11-10T01:25:10.327Z,1668043510.327 [MultiRay](INFO): Paused
2022-11-10T01:25:10.734Z,1668043510.734 [MultiRay](INFO): Paused
2022-11-10T01:25:11.137Z,1668043511.137 [MultiRay](INFO): Paused
2022-11-10T01:25:11.649Z,1668043511.649 [MultiRay](INFO): Paused
2022-11-10T01:25:11.949Z,1668043511.949 [MultiRay](INFO): Paused
2022-11-10T01:25:12.357Z,1668043512.357 [MultiRay](INFO): Paused
2022-11-10T01:25:12.872Z,1668043512.872 [MultiRay](INFO): Paused
2022-11-10T01:25:13.167Z,1668043513.167 [MultiRay](INFO): Paused
2022-11-10T01:25:13.589Z,1668043513.589 [MultiRay](INFO): Paused
2022-11-10T01:25:13.973Z,1668043513.973 [MultiRay](INFO): Paused
2022-11-10T01:25:14.369Z,1668043514.369 [MultiRay](INFO): Paused
2022-11-10T01:25:14.777Z,1668043514.777 [MultiRay](INFO): Paused
2022-11-10T01:25:15.173Z,1668043515.173 [MultiRay](INFO): Paused
2022-11-10T01:25:15.579Z,1668043515.579 [MultiRay](INFO): Paused
2022-11-10T01:25:15.987Z,1668043515.987 [MultiRay](INFO): Paused
2022-11-10T01:25:16.385Z,1668043516.385 [MultiRay](INFO): Paused
2022-11-10T01:25:16.791Z,1668043516.791 [MultiRay](INFO): Paused
2022-11-10T01:25:17.210Z,1668043517.210 [MultiRay](INFO): Paused
2022-11-10T01:25:17.599Z,1668043517.599 [MultiRay](INFO): Paused
2022-11-10T01:25:18.008Z,1668043518.008 [MultiRay](INFO): Paused
2022-11-10T01:25:18.405Z,1668043518.405 [MultiRay](INFO): Paused
2022-11-10T01:25:18.807Z,1668043518.807 [MultiRay](INFO): Paused
2022-11-10T01:25:19.211Z,1668043519.211 [MultiRay](INFO): Paused
2022-11-10T01:25:19.620Z,1668043519.620 [MultiRay](INFO): Paused
2022-11-10T01:25:20.042Z,1668043520.042 [MultiRay](INFO): Paused
2022-11-10T01:25:20.425Z,1668043520.425 [MultiRay](INFO): Paused
2022-11-10T01:25:20.565Z,1668043520.565 [DAT](DEBUG): In sendingAckWaiting, timeout so set commsState_ = SENDING_FILL_BUFFER
2022-11-10T01:25:20.853Z,1668043520.853 [MultiRay](INFO): Paused
2022-11-10T01:25:21.265Z,1668043521.265 [MultiRay](INFO): Paused
2022-11-10T01:25:21.681Z,1668043521.681 [MultiRay](INFO): Paused
2022-11-10T01:25:22.085Z,1668043522.085 [MultiRay](INFO): Paused
2022-11-10T01:25:22.167Z,1668043522.167 [DAT](DEBUG): In sendingFillBuffer, set commsState_ = SENDING_TRANSMIT
2022-11-10T01:25:22.180Z,1668043522.180 [DAT](DEBUG): In sendingTransmit, set commsState_ = SENDING_TRANSMIT_VERIFY
2022-11-10T01:25:22.469Z,1668043522.469 [MultiRay](INFO): Paused
2022-11-10T01:25:22.495Z,1668043522.495 [Startup:StartupSatComms:B] Stopped
2022-11-10T01:25:22.495Z,1668043522.495 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2022-11-10T01:25:22.495Z,1668043522.495 [Startup:StartupSatComms] Stopped
2022-11-10T01:25:22.495Z,1668043522.495 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2022-11-10T01:25:22.500Z,1668043522.500 [Startup](INFO): Completed Startup
2022-11-10T01:25:22.501Z,1668043522.501 [MissionManager](INFO): Startup is completed.
2022-11-10T01:25:22.501Z,1668043522.501 [MissionManager](INFO): Uninitializing Mission Startup
2022-11-10T01:25:22.501Z,1668043522.501 [Startup] Stopped
2022-11-10T01:25:22.501Z,1668043522.501 [Startup](DEBUG): Aggregate::uninitialize Startup
2022-11-10T01:25:22.501Z,1668043522.501 [Startup:A.GoToSurface] Stopped
2022-11-10T01:25:22.501Z,1668043522.501 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2022-11-10T01:25:22.873Z,1668043522.873 [MultiRay](INFO): Paused
2022-11-10T01:25:22.885Z,1668043522.885 [MissionManager](IMPORTANT): Started mission Default
2022-11-10T01:25:22.885Z,1668043522.885 [Default] Running Loop=1
2022-11-10T01:25:22.885Z,1668043522.885 [Default](DEBUG): Aggregate::initialize Default
2022-11-10T01:25:22.885Z,1668043522.885 [Default:B.GoToSurface] Running Loop=1
2022-11-10T01:25:22.886Z,1668043522.886 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2022-11-10T01:25:22.886Z,1668043522.886 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2022-11-10T01:25:22.886Z,1668043522.886 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2022-11-10T01:25:22.886Z,1668043522.886 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2022-11-10T01:25:22.887Z,1668043522.887 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2022-11-10T01:25:22.887Z,1668043522.887 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2022-11-10T01:25:22.887Z,1668043522.887 [Default:A.Wait] Running Loop=1
2022-11-10T01:25:22.887Z,1668043522.887 [Default:A.Wait](DEBUG): Initialize Wait Component.
2022-11-10T01:25:23.280Z,1668043523.280 [MultiRay](INFO): Paused
2022-11-10T01:25:23.681Z,1668043523.681 [MultiRay](INFO): Paused
2022-11-10T01:25:24.085Z,1668043524.085 [MultiRay](INFO): Paused
2022-11-10T01:25:24.489Z,1668043524.489 [MultiRay](INFO): Paused
2022-11-10T01:25:24.953Z,1668043524.953 [MultiRay](INFO): Paused
2022-11-10T01:25:25.327Z,1668043525.327 [MultiRay](INFO): Paused
2022-11-10T01:25:25.450Z,1668043525.450 [DAT](DEBUG): In parseResponses, set commsState_ = SENDING_ACK_WAITING
2022-11-10T01:25:25.478Z,1668043525.478 [DataOverHttps](INFO): Sending 1253 bytes from file Logs/20221110T002255/Express0001.lzma
2022-11-10T01:25:25.723Z,1668043525.723 [MultiRay](INFO): Paused
2022-11-10T01:25:26.125Z,1668043526.125 [MultiRay](INFO): Paused
2022-11-10T01:25:26.478Z,1668043526.478 [DataOverHttps](INFO): Moved sent file to Logs/20221110T002255/Express0001.lzma.bak
2022-11-10T01:25:26.478Z,1668043526.478 [DataOverHttps](INFO): SBD MOMSN=17278764
2022-11-10T01:25:26.586Z,1668043526.586 [MultiRay](INFO): Paused
2022-11-10T01:25:26.918Z,1668043526.918 [MultiRay](INFO): Paused
2022-11-10T01:25:27.333Z,1668043527.333 [MultiRay](INFO): Paused
2022-11-10T01:25:27.741Z,1668043527.741 [MultiRay](INFO): Paused
2022-11-10T01:25:28.127Z,1668043528.127 [MultiRay](INFO): Paused
2022-11-10T01:25:28.536Z,1668043528.536 [MultiRay](INFO): Paused
2022-11-10T01:25:28.935Z,1668043528.935 [MultiRay](INFO): Paused
2022-11-10T01:25:29.339Z,1668043529.339 [MultiRay](INFO): Paused
2022-11-10T01:25:29.737Z,1668043529.737 [MultiRay](INFO): Paused
2022-11-10T01:25:30.149Z,1668043530.149 [MultiRay](INFO): Paused
2022-11-10T01:25:30.549Z,1668043530.549 [MultiRay](INFO): Paused
2022-11-10T01:25:30.953Z,1668043530.953 [MultiRay](INFO): Paused
2022-11-10T01:25:31.357Z,1668043531.357 [MultiRay](INFO): Paused
2022-11-10T01:25:31.777Z,1668043531.777 [MultiRay](INFO): Paused
2022-11-10T01:25:32.165Z,1668043532.165 [MultiRay](INFO): Paused
2022-11-10T01:25:32.569Z,1668043532.569 [MultiRay](INFO): Paused
2022-11-10T01:25:32.980Z,1668043532.980 [MultiRay](INFO): Paused
2022-11-10T01:25:33.381Z,1668043533.381 [MultiRay](INFO): Paused
2022-11-10T01:25:33.783Z,1668043533.783 [MultiRay](INFO): Paused
2022-11-10T01:25:34.187Z,1668043534.187 [MultiRay](INFO): Paused
2022-11-10T01:25:34.593Z,1668043534.593 [MultiRay](INFO): Paused
2022-11-10T01:25:34.997Z,1668043534.997 [MultiRay](INFO): Paused
2022-11-10T01:25:35.399Z,1668043535.399 [MultiRay](INFO): Paused
2022-11-10T01:25:35.803Z,1668043535.803 [MultiRay](INFO): Paused
2022-11-10T01:25:36.209Z,1668043536.209 [MultiRay](INFO): Paused
2022-11-10T01:25:36.216Z,1668043536.216 [Default:A.Wait](INFO): Done Waiting.
2022-11-10T01:25:36.217Z,1668043536.217 [Default:A.Wait] Stopped
2022-11-10T01:25:36.217Z,1668043536.217 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2022-11-10T01:25:36.609Z,1668043536.609 [MultiRay](INFO): Paused
2022-11-10T01:25:36.636Z,1668043536.636 [Default:CheckIn] Running Loop=1
2022-11-10T01:25:36.636Z,1668043536.636 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2022-11-10T01:25:36.636Z,1668043536.636 [Default:CheckIn:Read_GPS] Running Loop=1
2022-11-10T01:25:37.015Z,1668043537.015 [MultiRay](INFO): Paused
2022-11-10T01:25:37.023Z,1668043537.023 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2022-11-10T01:25:37.421Z,1668043537.421 [MultiRay](INFO): Paused
2022-11-10T01:25:37.825Z,1668043537.825 [MultiRay](INFO): Paused
2022-11-10T01:25:38.284Z,1668043538.284 [MultiRay](INFO): Paused
2022-11-10T01:25:38.639Z,1668043538.639 [MultiRay](INFO): Paused
2022-11-10T01:25:39.049Z,1668043539.049 [MultiRay](INFO): Paused
2022-11-10T01:25:39.457Z,1668043539.457 [MultiRay](INFO): Paused
2022-11-10T01:25:39.901Z,1668043539.901 [MultiRay](INFO): Paused
2022-11-10T01:25:40.253Z,1668043540.253 [MultiRay](INFO): Paused
2022-11-10T01:25:40.661Z,1668043540.661 [MultiRay](INFO): Paused
2022-11-10T01:25:41.055Z,1668043541.055 [MultiRay](INFO): Paused
2022-11-10T01:25:41.478Z,1668043541.478 [MultiRay](INFO): Paused
2022-11-10T01:25:41.865Z,1668043541.865 [MultiRay](INFO): Paused
2022-11-10T01:25:42.269Z,1668043542.269 [MultiRay](INFO): Paused
2022-11-10T01:25:42.673Z,1668043542.673 [MultiRay](INFO): Paused
2022-11-10T01:25:43.078Z,1668043543.078 [MultiRay](INFO): Paused
2022-11-10T01:25:43.481Z,1668043543.481 [MultiRay](INFO): Paused
2022-11-10T01:25:43.593Z,1668043543.593 [DAT](DEBUG): In sendingAckWaiting, timeout so set commsState_ = SENDING_FILL_BUFFER
2022-11-10T01:25:43.845Z,1668043543.845 [DAT](DEBUG): In sendingFillBuffer, set commsState_ = SENDING_TRANSMIT
2022-11-10T01:25:43.883Z,1668043543.883 [MultiRay](INFO): Paused
2022-11-10T01:25:44.097Z,1668043544.097 [DAT](DEBUG): In sendingTransmit, set commsState_ = SENDING_TRANSMIT_VERIFY
2022-11-10T01:25:44.287Z,1668043544.287 [MultiRay](INFO): Paused
2022-11-10T01:25:44.693Z,1668043544.693 [MultiRay](INFO): Paused
2022-11-10T01:25:45.095Z,1668043545.095 [MultiRay](INFO): Paused
2022-11-10T01:25:45.499Z,1668043545.499 [MultiRay](INFO): Paused
2022-11-10T01:25:45.905Z,1668043545.905 [MultiRay](INFO): Paused
2022-11-10T01:25:46.309Z,1668043546.309 [MultiRay](INFO): Paused
2022-11-10T01:25:46.711Z,1668043546.711 [MultiRay](INFO): Paused
2022-11-10T01:25:47.117Z,1668043547.117 [MultiRay](INFO): Paused
2022-11-10T01:25:47.378Z,1668043547.378 [DAT](DEBUG): In parseResponses, set commsState_ = SENDING_ACK_WAITING
2022-11-10T01:25:47.521Z,1668043547.521 [MultiRay](INFO): Paused
2022-11-10T01:25:47.925Z,1668043547.925 [MultiRay](INFO): Paused
2022-11-10T01:25:48.329Z,1668043548.329 [MultiRay](INFO): Paused
2022-11-10T01:25:48.731Z,1668043548.731 [MultiRay](INFO): Paused
2022-11-10T01:25:49.135Z,1668043549.135 [MultiRay](INFO): Paused
2022-11-10T01:25:49.541Z,1668043549.541 [MultiRay](INFO): Paused
2022-11-10T01:25:49.945Z,1668043549.945 [MultiRay](INFO): Paused
2022-11-10T01:25:50.347Z,1668043550.347 [MultiRay](INFO): Paused
2022-11-10T01:25:50.751Z,1668043550.751 [MultiRay](INFO): Paused
2022-11-10T01:25:51.156Z,1668043551.156 [MultiRay](INFO): Paused
2022-11-10T01:25:51.616Z,1668043551.616 [MultiRay](INFO): Paused
2022-11-10T01:25:51.967Z,1668043551.967 [MultiRay](INFO): Paused
2022-11-10T01:25:52.386Z,1668043552.386 [MultiRay](INFO): Paused
2022-11-10T01:25:52.789Z,1668043552.789 [MultiRay](INFO): Paused
2022-11-10T01:25:53.177Z,1668043553.177 [MultiRay](INFO): Paused
2022-11-10T01:25:53.581Z,1668043553.581 [MultiRay](INFO): Paused
2022-11-10T01:25:54.043Z,1668043554.043 [MultiRay](INFO): Paused
2022-11-10T01:25:54.394Z,1668043554.394 [MultiRay](INFO): Paused
2022-11-10T01:25:54.809Z,1668043554.809 [MultiRay](INFO): Paused
2022-11-10T01:25:55.209Z,1668043555.209 [MultiRay](INFO): Paused
2022-11-10T01:25:55.599Z,1668043555.599 [MultiRay](INFO): Paused
2022-11-10T01:25:56.003Z,1668043556.003 [MultiRay](INFO): Paused
2022-11-10T01:25:56.408Z,1668043556.408 [MultiRay](INFO): Paused
2022-11-10T01:25:56.814Z,1668043556.814 [MultiRay](INFO): Paused
2022-11-10T01:25:57.231Z,1668043557.231 [MultiRay](INFO): Paused
2022-11-10T01:25:57.619Z,1668043557.619 [MultiRay](INFO): Paused
2022-11-10T01:25:58.025Z,1668043558.025 [MultiRay](INFO): Paused
2022-11-10T01:25:58.427Z,1668043558.427 [MultiRay](INFO): Paused
2022-11-10T01:25:58.827Z,1668043558.827 [MultiRay](INFO): Paused
2022-11-10T01:25:59.234Z,1668043559.234 [MultiRay](INFO): Paused
2022-11-10T01:25:59.641Z,1668043559.641 [MultiRay](INFO): Paused
2022-11-10T01:26:00.043Z,1668043560.043 [MultiRay](INFO): Paused
2022-11-10T01:26:00.447Z,1668043560.447 [MultiRay](INFO): Paused
2022-11-10T01:26:00.851Z,1668043560.851 [MultiRay](INFO): Paused
2022-11-10T01:26:01.256Z,1668043561.256 [MultiRay](INFO): Paused
2022-11-10T01:26:01.661Z,1668043561.661 [MultiRay](INFO): Paused
2022-11-10T01:26:02.063Z,1668043562.063 [MultiRay](INFO): Paused
2022-11-10T01:26:02.469Z,1668043562.469 [MultiRay](INFO): Paused
2022-11-10T01:26:02.873Z,1668043562.873 [MultiRay](INFO): Paused
2022-11-10T01:26:03.277Z,1668043563.277 [MultiRay](INFO): Paused
2022-11-10T01:26:03.684Z,1668043563.684 [MultiRay](INFO): Paused
2022-11-10T01:26:04.081Z,1668043564.081 [MultiRay](INFO): Paused
2022-11-10T01:26:04.488Z,1668043564.488 [MultiRay](INFO): Paused
2022-11-10T01:26:05.002Z,1668043565.002 [MultiRay](INFO): Paused
2022-11-10T01:26:05.313Z,1668043565.313 [MultiRay](INFO): Paused
2022-11-10T01:26:05.537Z,1668043565.537 [DAT](DEBUG): In sendingAckWaiting, hit max timeouts so set commsState_ = SENDING_VERIFIED
2022-11-10T01:26:05.537Z,1668043565.537 [DAT](ERROR): Ack receipt timeout failure.
2022-11-10T01:26:05.709Z,1668043565.709 [MultiRay](INFO): Paused
2022-11-10T01:26:05.789Z,1668043565.789 [DAT](DEBUG): In sendingVerified, sbd done so set commsState_ = SENDING_FILL_BUFFER
2022-11-10T01:26:06.041Z,1668043566.041 [DAT](DEBUG): In sendingFillBuffer, set commsState_ = SENDING_TRANSMIT
2022-11-10T01:26:06.117Z,1668043566.117 [MultiRay](INFO): Paused
2022-11-10T01:26:06.293Z,1668043566.293 [DAT](DEBUG): In sendingTransmit, set commsState_ = SENDING_TRANSMIT_VERIFY
2022-11-10T01:26:06.505Z,1668043566.505 [MultiRay](INFO): Paused
2022-11-10T01:26:06.909Z,1668043566.909 [MultiRay](INFO): Paused
2022-11-10T01:26:07.316Z,1668043567.316 [MultiRay](INFO): Paused
2022-11-10T01:26:07.823Z,1668043567.823 [MultiRay](INFO): Paused
2022-11-10T01:26:08.129Z,1668043568.129 [MultiRay](INFO): Paused
2022-11-10T01:26:08.538Z,1668043568.538 [MultiRay](INFO): Paused
2022-11-10T01:26:08.932Z,1668043568.932 [MultiRay](INFO): Paused
2022-11-10T01:26:09.352Z,1668043569.352 [MultiRay](INFO): Paused
2022-11-10T01:26:09.570Z,1668043569.570 [DAT](DEBUG): In parseResponses, set commsState_ = SENDING_ACK_WAITING
2022-11-10T01:26:09.739Z,1668043569.739 [MultiRay](INFO): Paused
2022-11-10T01:26:10.143Z,1668043570.143 [MultiRay](INFO): Paused
2022-11-10T01:26:10.552Z,1668043570.552 [MultiRay](INFO): Paused
2022-11-10T01:26:10.951Z,1668043570.951 [MultiRay](INFO): Paused
2022-11-10T01:26:11.355Z,1668043571.355 [MultiRay](INFO): Paused
2022-11-10T01:26:11.759Z,1668043571.759 [MultiRay](INFO): Paused
2022-11-10T01:26:12.164Z,1668043572.164 [MultiRay](INFO): Paused
2022-11-10T01:26:12.573Z,1668043572.573 [MultiRay](INFO): Paused
2022-11-10T01:26:12.971Z,1668043572.971 [MultiRay](INFO): Paused
2022-11-10T01:26:13.375Z,1668043573.375 [MultiRay](INFO): Paused
2022-11-10T01:26:13.781Z,1668043573.781 [MultiRay](INFO): Paused
2022-11-10T01:26:14.185Z,1668043574.185 [MultiRay](INFO): Paused
2022-11-10T01:26:14.587Z,1668043574.587 [MultiRay](INFO): Paused
2022-11-10T01:26:14.991Z,1668043574.991 [MultiRay](INFO): Paused
2022-11-10T01:26:15.401Z,1668043575.401 [MultiRay](INFO): Paused
2022-11-10T01:26:15.801Z,1668043575.801 [MultiRay](INFO): Paused
2022-11-10T01:26:16.203Z,1668043576.203 [MultiRay](INFO): Paused
2022-11-10T01:26:16.607Z,1668043576.607 [MultiRay](INFO): Paused
2022-11-10T01:26:17.011Z,1668043577.011 [MultiRay](INFO): Paused
2022-11-10T01:26:17.413Z,1668043577.413 [MultiRay](INFO): Paused
2022-11-10T01:26:17.821Z,1668043577.821 [MultiRay](INFO): Paused
2022-11-10T01:26:18.280Z,1668043578.280 [MultiRay](INFO): Paused
2022-11-10T01:26:18.635Z,1668043578.635 [MultiRay](INFO): Paused
2022-11-10T01:26:19.045Z,1668043579.045 [MultiRay](INFO): Paused
2022-11-10T01:26:19.457Z,1668043579.457 [MultiRay](INFO): Paused
2022-11-10T01:26:19.839Z,1668043579.839 [MultiRay](INFO): Paused
2022-11-10T01:26:20.243Z,1668043580.243 [MultiRay](INFO): Paused
2022-11-10T01:26:20.645Z,1668043580.645 [MultiRay](INFO): Paused
2022-11-10T01:26:21.053Z,1668043581.053 [MultiRay](INFO): Paused
2022-11-10T01:26:21.512Z,1668043581.512 [MultiRay](INFO): Paused
2022-11-10T01:26:21.866Z,1668043581.866 [MultiRay](INFO): Paused
2022-11-10T01:26:22.278Z,1668043582.278 [MultiRay](INFO): Paused
2022-11-10T01:26:22.681Z,1668043582.681 [MultiRay](INFO): Paused
2022-11-10T01:26:23.071Z,1668043583.071 [MultiRay](INFO): Paused
2022-11-10T01:26:23.475Z,1668043583.475 [MultiRay](INFO): Paused
2022-11-10T01:26:23.879Z,1668043583.879 [MultiRay](INFO): Paused
2022-11-10T01:26:24.283Z,1668043584.283 [MultiRay](INFO): Paused
2022-11-10T01:26:24.688Z,1668043584.688 [MultiRay](INFO): Paused
2022-11-10T01:26:25.091Z,1668043585.091 [MultiRay](INFO): Paused
2022-11-10T01:26:25.495Z,1668043585.495 [MultiRay](INFO): Paused
2022-11-10T01:26:25.902Z,1668043585.902 [MultiRay](INFO): Paused
2022-11-10T01:26:26.305Z,1668043586.305 [MultiRay](INFO): Paused
2022-11-10T01:26:26.710Z,1668043586.710 [MultiRay](INFO): Paused
2022-11-10T01:26:27.111Z,1668043587.111 [MultiRay](INFO): Paused
2022-11-10T01:26:27.515Z,1668043587.515 [MultiRay](INFO): Paused
2022-11-10T01:26:27.717Z,1668043587.717 [DAT](DEBUG): In sendingAckWaiting, timeout so set commsState_ = SENDING_FILL_BUFFER
2022-11-10T01:26:27.919Z,1668043587.919 [MultiRay](INFO): Paused
2022-11-10T01:26:27.969Z,1668043587.969 [DAT](DEBUG): In sendingFillBuffer, set commsState_ = SENDING_TRANSMIT
2022-11-10T01:26:28.221Z,1668043588.221 [DAT](DEBUG): In sendingTransmit, set commsState_ = SENDING_TRANSMIT_VERIFY
2022-11-10T01:26:28.321Z,1668043588.321 [MultiRay](INFO): Paused
2022-11-10T01:26:28.726Z,1668043588.726 [MultiRay](INFO): Paused
2022-11-10T01:26:29.131Z,1668043589.131 [MultiRay](INFO): Paused
2022-11-10T01:26:29.537Z,1668043589.537 [MultiRay](INFO): Paused
2022-11-10T01:26:29.941Z,1668043589.941 [MultiRay](INFO): Paused
2022-11-10T01:26:30.340Z,1668043590.340 [MultiRay](INFO): Paused
2022-11-10T01:26:30.748Z,1668043590.748 [MultiRay](INFO): Paused
2022-11-10T01:26:31.151Z,1668043591.151 [MultiRay](INFO): Paused
2022-11-10T01:26:31.502Z,1668043591.502 [DAT](DEBUG): In parseResponses, set commsState_ = SENDING_ACK_WAITING
2022-11-10T01:26:31.555Z,1668043591.555 [MultiRay](INFO): Paused
2022-11-10T01:26:32.018Z,1668043592.018 [MultiRay](INFO): Paused
2022-11-10T01:26:32.387Z,1668043592.387 [MultiRay](INFO): Paused
2022-11-10T01:26:32.788Z,1668043592.788 [MultiRay](INFO): Paused
2022-11-10T01:26:33.189Z,1668043593.189 [MultiRay](INFO): Paused
2022-11-10T01:26:33.575Z,1668043593.575 [MultiRay](INFO): Paused
2022-11-10T01:26:33.979Z,1668043593.979 [MultiRay](INFO): Paused
2022-11-10T01:26:34.438Z,1668043594.438 [MultiRay](INFO): Paused
2022-11-10T01:26:34.795Z,1668043594.795 [MultiRay](INFO): Paused
2022-11-10T01:26:35.205Z,1668043595.205 [MultiRay](INFO): Paused
2022-11-10T01:26:35.605Z,1668043595.605 [MultiRay](INFO): Paused
2022-11-10T01:26:35.999Z,1668043595.999 [MultiRay](INFO): Paused
2022-11-10T01:26:36.403Z,1668043596.403 [MultiRay](INFO): Paused
2022-11-10T01:26:36.809Z,1668043596.809 [MultiRay](INFO): Paused
2022-11-10T01:26:37.213Z,1668043597.213 [MultiRay](INFO): Paused
2022-11-10T01:26:37.617Z,1668043597.617 [MultiRay](INFO): Paused
2022-11-10T01:26:38.019Z,1668043598.019 [MultiRay](INFO): Paused
2022-11-10T01:26:38.423Z,1668043598.423 [MultiRay](INFO): Paused
2022-11-10T01:26:38.827Z,1668043598.827 [MultiRay](INFO): Paused
2022-11-10T01:26:39.236Z,1668043599.236 [MultiRay](INFO): Paused
2022-11-10T01:26:39.635Z,1668043599.635 [MultiRay](INFO): Paused
2022-11-10T01:26:40.039Z,1668043600.039 [MultiRay](INFO): Paused
2022-11-10T01:26:40.445Z,1668043600.445 [MultiRay](INFO): Paused
2022-11-10T01:26:40.446Z,1668043600.446 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2022-11-10T01:26:40.849Z,1668043600.849 [MultiRay](INFO): Paused
2022-11-10T01:26:41.249Z,1668043601.249 [MultiRay](INFO): Paused
2022-11-10T01:26:41.653Z,1668043601.653 [MultiRay](INFO): Paused
2022-11-10T01:26:42.057Z,1668043602.057 [MultiRay](INFO): Paused
2022-11-10T01:26:42.469Z,1668043602.469 [MultiRay](INFO): Paused
2022-11-10T01:26:42.865Z,1668043602.865 [MultiRay](INFO): Paused
2022-11-10T01:26:43.269Z,1668043603.269 [MultiRay](INFO): Paused
2022-11-10T01:26:43.673Z,1668043603.673 [MultiRay](INFO): Paused
2022-11-10T01:26:44.080Z,1668043604.080 [MultiRay](INFO): Paused
2022-11-10T01:26:44.485Z,1668043604.485 [MultiRay](INFO): Paused
2022-11-10T01:26:44.887Z,1668043604.887 [MultiRay](INFO): Paused
2022-11-10T01:26:45.353Z,1668043605.353 [MultiRay](INFO): Paused
2022-11-10T01:26:45.704Z,1668043605.704 [MultiRay](INFO): Paused
2022-11-10T01:26:46.113Z,1668043606.113 [MultiRay](INFO): Paused
2022-11-10T01:26:46.514Z,1668043606.514 [MultiRay](INFO): Paused
2022-11-10T01:26:46.907Z,1668043606.907 [MultiRay](INFO): Paused
2022-11-10T01:26:47.313Z,1668043607.313 [MultiRay](INFO): Paused
2022-11-10T01:26:47.774Z,1668043607.774 [MultiRay](INFO): Paused
2022-11-10T01:26:48.122Z,1668043608.122 [MultiRay](INFO): Paused
2022-11-10T01:26:48.533Z,1668043608.533 [MultiRay](INFO): Paused
2022-11-10T01:26:48.946Z,1668043608.946 [MultiRay](INFO): Paused
2022-11-10T01:26:49.335Z,1668043609.335 [MultiRay](INFO): Paused
2022-11-10T01:26:49.653Z,1668043609.653 [DAT](DEBUG): In sendingAckWaiting, timeout so set commsState_ = SENDING_FILL_BUFFER
2022-11-10T01:26:49.733Z,1668043609.733 [MultiRay](INFO): Paused
2022-11-10T01:26:49.905Z,1668043609.905 [DAT](DEBUG): In sendingFillBuffer, set commsState_ = SENDING_TRANSMIT
2022-11-10T01:26:50.141Z,1668043610.141 [MultiRay](INFO): Paused
2022-11-10T01:26:50.157Z,1668043610.157 [DAT](DEBUG): In sendingTransmit, set commsState_ = SENDING_TRANSMIT_VERIFY
2022-11-10T01:26:50.541Z,1668043610.541 [MultiRay](INFO): Paused
2022-11-10T01:26:50.949Z,1668043610.949 [MultiRay](INFO): Paused
2022-11-10T01:26:51.351Z,1668043611.351 [MultiRay](INFO): Paused
2022-11-10T01:26:51.756Z,1668043611.756 [MultiRay](INFO): Paused
2022-11-10T01:26:52.161Z,1668043612.161 [MultiRay](INFO): Paused
2022-11-10T01:26:52.565Z,1668043612.565 [MultiRay](INFO): Paused
2022-11-10T01:26:52.967Z,1668043612.967 [MultiRay](INFO): Paused
2022-11-10T01:26:53.369Z,1668043613.369 [MultiRay](INFO): Paused
2022-11-10T01:26:53.438Z,1668043613.438 [DAT](DEBUG): In parseResponses, set commsState_ = SENDING_ACK_WAITING
2022-11-10T01:26:53.777Z,1668043613.777 [MultiRay](INFO): Paused
2022-11-10T01:26:54.179Z,1668043614.179 [MultiRay](INFO): Paused
2022-11-10T01:26:54.583Z,1668043614.583 [MultiRay](INFO): Paused
2022-11-10T01:26:54.987Z,1668043614.987 [MultiRay](INFO): Paused
2022-11-10T01:26:55.389Z,1668043615.389 [MultiRay](INFO): Paused
2022-11-10T01:26:55.797Z,1668043615.797 [MultiRay](INFO): Paused
2022-11-10T01:26:56.199Z,1668043616.199 [MultiRay](INFO): Paused
2022-11-10T01:26:56.605Z,1668043616.605 [MultiRay](INFO): Paused
2022-11-10T01:26:57.009Z,1668043617.009 [MultiRay](INFO): Paused
2022-11-10T01:26:57.413Z,1668043617.413 [MultiRay](INFO): Paused
2022-11-10T01:26:57.811Z,1668043617.811 [MultiRay](INFO): Paused
2022-11-10T01:26:58.221Z,1668043618.221 [MultiRay](INFO): Paused
2022-11-10T01:26:58.680Z,1668043618.680 [MultiRay](INFO): Paused
2022-11-10T01:26:59.053Z,1668043619.053 [MultiRay](INFO): Paused
2022-11-10T01:26:59.452Z,1668043619.452 [MultiRay](INFO): Paused
2022-11-10T01:26:59.469Z,1668043619.469 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2022-11-10T01:26:59.469Z,1668043619.469 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3
2022-11-10T01:26:59.469Z,1668043619.469 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2022-11-10T01:26:59.471Z,1668043619.471 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2022-11-10T01:26:59.471Z,1668043619.471 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 3
2022-11-10T01:26:59.471Z,1668043619.471 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2022-11-10T01:26:59.482Z,1668043619.482 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2022-11-10T01:26:59.482Z,1668043619.482 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2022-11-10T01:26:59.857Z,1668043619.857 [MultiRay](INFO): Paused
2022-11-10T01:26:59.888Z,1668043619.888 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2022-11-10T01:26:59.888Z,1668043619.888 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3
2022-11-10T01:26:59.889Z,1668043619.889 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2022-11-10T01:26:59.889Z,1668043619.889 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 3
2022-11-10T01:27:00.237Z,1668043620.237 [MultiRay](INFO): Paused
2022-11-10T01:27:00.244Z,1668043620.244 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2022-11-10T01:27:00.645Z,1668043620.645 [MultiRay](INFO): Paused
2022-11-10T01:27:01.047Z,1668043621.047 [MultiRay](INFO): Paused
2022-11-10T01:27:01.511Z,1668043621.511 [MultiRay](INFO): Paused
2022-11-10T01:27:01.861Z,1668043621.861 [MultiRay](INFO): Paused
2022-11-10T01:27:02.283Z,1668043622.283 [MultiRay](INFO): Paused
2022-11-10T01:27:02.663Z,1668043622.663 [MultiRay](INFO): Paused
2022-11-10T01:27:03.078Z,1668043623.078 [MultiRay](INFO): Paused
2022-11-10T01:27:03.468Z,1668043623.468 [MultiRay](INFO): Paused
2022-11-10T01:27:03.877Z,1668043623.877 [MultiRay](INFO): Paused
2022-11-10T01:27:04.279Z,1668043624.279 [MultiRay](INFO): Paused
2022-11-10T01:27:04.296Z,1668043624.296 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL
2022-11-10T01:27:04.296Z,1668043624.296 [WetLabsBB2FL] No Fault, FailCount= 5
2022-11-10T01:27:04.498Z,1668043624.498 [WetLabsBB2FL](INFO): Powering up
2022-11-10T01:27:04.682Z,1668043624.682 [MultiRay](INFO): Paused
2022-11-10T01:27:05.089Z,1668043625.089 [MultiRay](INFO): Paused
2022-11-10T01:27:05.495Z,1668043625.495 [MultiRay](INFO): Paused
2022-11-10T01:27:05.897Z,1668043625.897 [MultiRay](INFO): Paused
2022-11-10T01:27:06.300Z,1668043626.300 [MultiRay](INFO): Paused
2022-11-10T01:27:06.705Z,1668043626.705 [MultiRay](INFO): Paused
2022-11-10T01:27:07.112Z,1668043627.112 [MultiRay](INFO): Paused
2022-11-10T01:27:07.513Z,1668043627.513 [MultiRay](INFO): Paused
2022-11-10T01:27:07.915Z,1668043627.915 [MultiRay](INFO): Paused
2022-11-10T01:27:07.966Z,1668043627.966 [CBIT](INFO): Clearing failed state for component AHRS_M2
2022-11-10T01:27:07.966Z,1668043627.966 [AHRS_M2] No Fault, FailCount= 5
2022-11-10T01:27:08.315Z,1668043628.315 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2022-11-10T01:27:08.325Z,1668043628.325 [MultiRay](INFO): Paused
2022-11-10T01:27:08.725Z,1668043628.725 [MultiRay](INFO): Paused
2022-11-10T01:27:09.129Z,1668043629.129 [MultiRay](INFO): Paused
2022-11-10T01:27:09.531Z,1668043629.531 [MultiRay](INFO): Paused
2022-11-10T01:27:09.788Z,1668043629.788 [WetLabsBB2FL] Communications Fault, FailCount= 1
2022-11-10T01:27:09.788Z,1668043629.788 [WetLabsBB2FL](ERROR): Communications Fault
2022-11-10T01:27:09.933Z,1668043629.933 [MultiRay](INFO): Paused
2022-11-10T01:27:09.950Z,1668043629.950 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL
2022-11-10T01:27:10.289Z,1668043630.289 [WetLabsBB2FL](INFO): Powering down
2022-11-10T01:27:10.352Z,1668043630.352 [MultiRay](INFO): Paused
2022-11-10T01:27:10.745Z,1668043630.745 [MultiRay](INFO): Paused
2022-11-10T01:27:11.147Z,1668043631.147 [MultiRay](INFO): Paused
2022-11-10T01:27:11.192Z,1668043631.192 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL
2022-11-10T01:27:11.192Z,1668043631.192 [WetLabsBB2FL] No Fault, FailCount= 1
2022-11-10T01:27:11.502Z,1668043631.502 [WetLabsBB2FL](INFO): Powering up
2022-11-10T01:27:11.601Z,1668043631.601 [DAT](DEBUG): In sendingAckWaiting, timeout so set commsState_ = SENDING_FILL_BUFFER
2022-11-10T01:27:11.853Z,1668043631.853 [DAT](DEBUG): In sendingFillBuffer, set commsState_ = SENDING_TRANSMIT
2022-11-10T01:27:11.888Z,1668043631.888 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:27:11.959Z,1668043631.959 [MultiRay](INFO): Paused
2022-11-10T01:27:12.105Z,1668043632.105 [DAT](DEBUG): In sendingTransmit, set commsState_ = SENDING_TRANSMIT_VERIFY
2022-11-10T01:27:12.404Z,1668043632.404 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:27:12.437Z,1668043632.437 [MultiRay](INFO): Paused
2022-11-10T01:27:12.836Z,1668043632.836 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:27:12.857Z,1668043632.857 [MultiRay](INFO): Paused
2022-11-10T01:27:13.284Z,1668043633.284 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:27:13.313Z,1668043633.313 [MultiRay](INFO): Paused
2022-11-10T01:27:13.736Z,1668043633.736 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:27:13.745Z,1668043633.745 [MultiRay](INFO): Paused
2022-11-10T01:27:14.049Z,1668043634.049 [CommandExec](IMPORTANT): got command show stack
2022-11-10T01:27:14.049Z,1668043634.049 [CommandExec](IMPORTANT): Behavior Stack:

2022-11-10T01:27:14.050Z,1668043634.050 [Default](IMPORTANT): Priority 0: Default:B.GoToSurface
2022-11-10T01:27:14.050Z,1668043634.050 [Default:CheckIn](IMPORTANT): Priority 1: Default:CheckIn:Read_GPS
2022-11-10T01:27:14.196Z,1668043634.196 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:27:14.205Z,1668043634.205 [MultiRay](INFO): Paused
2022-11-10T01:27:14.656Z,1668043634.656 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:27:14.728Z,1668043634.728 [MultiRay](INFO): Paused
2022-11-10T01:27:15.168Z,1668043635.168 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:27:15.185Z,1668043635.185 [MultiRay](INFO): Paused
2022-11-10T01:27:15.382Z,1668043635.382 [DAT](DEBUG): In parseResponses, set commsState_ = SENDING_ACK_WAITING
2022-11-10T01:27:15.600Z,1668043635.600 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:27:15.629Z,1668043635.629 [MultiRay](INFO): Paused
2022-11-10T01:27:16.032Z,1668043636.032 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:27:16.046Z,1668043636.046 [MultiRay](INFO): Paused
2022-11-10T01:27:16.464Z,1668043636.464 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:27:16.469Z,1668043636.469 [MultiRay](INFO): Paused
2022-11-10T01:27:16.796Z,1668043636.796 [WetLabsBB2FL] Communications Fault, FailCount= 2
2022-11-10T01:27:16.796Z,1668043636.796 [WetLabsBB2FL](ERROR): Communications Fault
2022-11-10T01:27:16.872Z,1668043636.872 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:27:16.878Z,1668043636.878 [MultiRay](INFO): Paused
2022-11-10T01:27:16.974Z,1668043636.974 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL
2022-11-10T01:27:17.297Z,1668043637.297 [WetLabsBB2FL](INFO): Powering down
2022-11-10T01:27:17.351Z,1668043637.351 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:27:17.359Z,1668043637.359 [MultiRay](INFO): Paused
2022-11-10T01:27:17.788Z,1668043637.788 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:27:17.793Z,1668043637.793 [MultiRay](INFO): Paused
2022-11-10T01:27:18.244Z,1668043638.244 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:27:18.249Z,1668043638.249 [MultiRay](INFO): Paused
2022-11-10T01:27:18.275Z,1668043638.275 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL
2022-11-10T01:27:18.275Z,1668043638.275 [WetLabsBB2FL] No Fault, FailCount= 2
2022-11-10T01:27:18.521Z,1668043638.521 [WetLabsBB2FL](INFO): Powering up
2022-11-10T01:27:18.668Z,1668043638.668 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:27:18.673Z,1668043638.673 [MultiRay](INFO): Paused
2022-11-10T01:27:19.096Z,1668043639.096 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:27:19.101Z,1668043639.101 [MultiRay](INFO): Paused
2022-11-10T01:27:19.516Z,1668043639.516 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:27:19.525Z,1668043639.525 [MultiRay](INFO): Paused
2022-11-10T01:27:19.940Z,1668043639.940 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:27:19.958Z,1668043639.958 [MultiRay](INFO): Paused
2022-11-10T01:27:20.396Z,1668043640.396 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:27:20.406Z,1668043640.406 [MultiRay](INFO): Paused
2022-11-10T01:27:20.860Z,1668043640.860 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:27:20.869Z,1668043640.869 [MultiRay](INFO): Paused
2022-11-10T01:27:21.284Z,1668043641.284 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:27:21.284Z,1668043641.284 [AHRS_M2](FAULT): Failed to initialize within timeout.
2022-11-10T01:27:21.284Z,1668043641.284 [AHRS_M2] Communications Fault, FailCount= 1
2022-11-10T01:27:21.284Z,1668043641.284 [AHRS_M2](ERROR): Communications Fault
2022-11-10T01:27:21.293Z,1668043641.293 [MultiRay](INFO): Paused
2022-11-10T01:27:21.350Z,1668043641.350 [CBIT](ERROR): Communications Fault in component: AHRS_M2
2022-11-10T01:27:21.377Z,1668043641.377 [AHRS_M2](INFO): Powering down
2022-11-10T01:27:21.457Z,1668043641.457 [MultiRay](INFO): Paused
2022-11-10T01:27:21.771Z,1668043641.771 [MultiRay](INFO): Paused
2022-11-10T01:27:22.175Z,1668043642.175 [MultiRay](INFO): Paused
2022-11-10T01:27:22.220Z,1668043642.220 [CBIT](INFO): Clearing failed state for component AHRS_M2
2022-11-10T01:27:22.221Z,1668043642.221 [AHRS_M2] No Fault, FailCount= 1
2022-11-10T01:27:22.573Z,1668043642.573 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2022-11-10T01:27:22.583Z,1668043642.583 [MultiRay](INFO): Paused
2022-11-10T01:27:22.983Z,1668043642.983 [MultiRay](INFO): Paused
2022-11-10T01:27:23.389Z,1668043643.389 [MultiRay](INFO): Paused
2022-11-10T01:27:23.789Z,1668043643.789 [MultiRay](INFO): Paused
2022-11-10T01:27:23.804Z,1668043643.804 [WetLabsBB2FL] Communications Fault, FailCount= 3
2022-11-10T01:27:23.804Z,1668043643.804 [WetLabsBB2FL](ERROR): Communications Fault
2022-11-10T01:27:23.849Z,1668043643.849 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL
2022-11-10T01:27:24.197Z,1668043644.197 [MultiRay](INFO): Paused
2022-11-10T01:27:24.305Z,1668043644.305 [WetLabsBB2FL](INFO): Powering down
2022-11-10T01:27:24.597Z,1668043644.597 [MultiRay](INFO): Paused
2022-11-10T01:27:25.005Z,1668043645.005 [MultiRay](INFO): Paused
2022-11-10T01:27:25.470Z,1668043645.470 [MultiRay](INFO): Paused
2022-11-10T01:27:25.486Z,1668043645.486 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL
2022-11-10T01:27:25.486Z,1668043645.486 [WetLabsBB2FL] No Fault, FailCount= 3
2022-11-10T01:27:25.518Z,1668043645.518 [WetLabsBB2FL](INFO): Powering up
2022-11-10T01:27:26.136Z,1668043646.136 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:27:26.147Z,1668043646.147 [MultiRay](INFO): Paused
2022-11-10T01:27:26.568Z,1668043646.568 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:27:26.589Z,1668043646.589 [MultiRay](INFO): Paused
2022-11-10T01:27:27.024Z,1668043647.024 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:27:27.046Z,1668043647.046 [MultiRay](INFO): Paused
2022-11-10T01:27:27.484Z,1668043647.484 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:27:27.494Z,1668043647.494 [MultiRay](INFO): Paused
2022-11-10T01:27:27.908Z,1668043647.908 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:27:27.987Z,1668043647.987 [MultiRay](INFO): Paused
2022-11-10T01:27:28.148Z,1668043648.148 [CommandExec](IMPORTANT): got command run ./Missions/Maintenance/multiray_test.xml
2022-11-10T01:27:28.148Z,1668043648.148 [MissionManager](INFO): Loading Mission from file: ./Missions/Maintenance/multiray_test.xml
2022-11-10T01:27:28.210Z,1668043648.210 [MissionManager](INFO): DefineArg multiray_test.MissionTimeout = 5.000000 min
2022-11-10T01:27:28.213Z,1668043648.213 [MissionManager](INFO): DefineArg multiray_test.LightDuration = 5.000000 s
2022-11-10T01:27:28.216Z,1668043648.216 [MissionManager](INFO): DefineArg multiray_test.LightMode0 = 0.000000 count
2022-11-10T01:27:28.219Z,1668043648.219 [MissionManager](INFO): DefineArg multiray_test.LightMode1 = 1.000000 count
2022-11-10T01:27:28.222Z,1668043648.222 [MissionManager](INFO): DefineArg multiray_test.LightMode2 = 2.000000 count
2022-11-10T01:27:28.225Z,1668043648.225 [MissionManager](INFO): DefineArg multiray_test.EnabledMultiray = 1 bool
2022-11-10T01:27:28.249Z,1668043648.249 [multiray_test:C.Wait](DEBUG): Construct Wait.
2022-11-10T01:27:28.257Z,1668043648.257 [multiray_test:E.Wait](DEBUG): Construct Wait.
2022-11-10T01:27:28.270Z,1668043648.270 [multiray_test:G.Wait](DEBUG): Construct Wait.
2022-11-10T01:27:28.277Z,1668043648.277 [multiray_test:I.Wait](DEBUG): Construct Wait.
2022-11-10T01:27:28.284Z,1668043648.284 [multiray_test:K.Wait](DEBUG): Construct Wait.
2022-11-10T01:27:28.287Z,1668043648.287 [multiray_test:M.Wait](DEBUG): Construct Wait.
2022-11-10T01:27:28.295Z,1668043648.295 [multiray_test:O.Wait](DEBUG): Construct Wait.
2022-11-10T01:27:28.298Z,1668043648.298 [multiray_test:Q.Wait](DEBUG): Construct Wait.
2022-11-10T01:27:28.309Z,1668043648.309 [multiray_test:R.Wait](DEBUG): Construct Wait.
2022-11-10T01:27:28.317Z,1668043648.317 [multiray_test:T.Wait](DEBUG): Construct Wait.
2022-11-10T01:27:28.326Z,1668043648.326 [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-10T01:27:28.333Z,1668043648.333 [CommandExec](IMPORTANT): Running ./Missions/Maintenance/multiray_test.xml
2022-11-10T01:27:28.408Z,1668043648.408 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:27:28.419Z,1668043648.419 [MultiRay](INFO): Paused
2022-11-10T01:27:28.442Z,1668043648.442 [Default] Stopped
2022-11-10T01:27:28.442Z,1668043648.443 [Default](DEBUG): Aggregate::uninitialize Default
2022-11-10T01:27:28.443Z,1668043648.443 [Default:B.GoToSurface] Stopped
2022-11-10T01:27:28.443Z,1668043648.443 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2022-11-10T01:27:28.443Z,1668043648.443 [Default:CheckIn] Stopped
2022-11-10T01:27:28.443Z,1668043648.443 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2022-11-10T01:27:28.443Z,1668043648.443 [Default:CheckIn:Read_GPS] Stopped
2022-11-10T01:27:28.443Z,1668043648.443 [MissionManager](IMPORTANT): Started mission multiray_test
2022-11-10T01:27:28.443Z,1668043648.443 [multiray_test] Running Loop=1
2022-11-10T01:27:28.443Z,1668043648.443 [multiray_test](DEBUG): Aggregate::initialize multiray_test
2022-11-10T01:27:28.444Z,1668043648.444 [multiray_test:A] Running Loop=1
2022-11-10T01:27:28.444Z,1668043648.444 [multiray_test:B] Running Loop=1
2022-11-10T01:27:28.444Z,1668043648.444 [multiray_test:B] Stopped
2022-11-10T01:27:28.444Z,1668043648.444 [multiray_test:C.Wait] Running Loop=1
2022-11-10T01:27:28.444Z,1668043648.444 [multiray_test:C.Wait](DEBUG): Initialize Wait Component.
2022-11-10T01:27:28.445Z,1668043648.445 [multiray_test:A] Running Loop=1
2022-11-10T01:27:28.445Z,1668043648.445 [multiray_test:A](DEBUG): Initialize ReadDataComponent to sense MultiRay.lightModeLog
2022-11-10T01:27:28.820Z,1668043648.820 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:27:28.841Z,1668043648.841 [MultiRay](INFO): Paused
2022-11-10T01:27:29.272Z,1668043649.272 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:27:29.294Z,1668043649.294 [MultiRay](INFO): Resume
2022-11-10T01:27:29.320Z,1668043649.320 [MultiRay](INFO): Finish turning things back on in Resume
2022-11-10T01:27:29.764Z,1668043649.764 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:27:29.773Z,1668043649.773 [MultiRay](INFO): Runnable
2022-11-10T01:27:29.774Z,1668043649.774 [MultiRay](IMPORTANT): New light mode loaded
2022-11-10T01:27:29.774Z,1668043649.774 [MultiRay](IMPORTANT): Turning off all lights
2022-11-10T01:27:29.802Z,1668043649.802 [MultiRay](DEBUG): Recieved MultiRay unrecognized response
2022-11-10T01:27:29.832Z,1668043649.832 [MultiRay](DEBUG): Recieved MultiRay unrecognized response
2022-11-10T01:27:29.844Z,1668043649.844 [MultiRay](DEBUG): Recieved MultiRay unrecognized response
2022-11-10T01:27:29.858Z,1668043649.858 [MultiRay](DEBUG): Recieved MultiRay unrecognized response
2022-11-10T01:27:29.873Z,1668043649.873 [MultiRay](IMPORTANT): Recieved MultiRay acknowledge
2022-11-10T01:27:29.885Z,1668043649.885 [MultiRay](DEBUG): Recieved MultiRay unrecognized response
2022-11-10T01:27:29.886Z,1668043649.886 [MultiRay](IMPORTANT): All lights off
2022-11-10T01:27:30.352Z,1668043650.352 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:27:30.361Z,1668043650.361 [MultiRay](INFO): Pause
2022-11-10T01:27:30.812Z,1668043650.812 [WetLabsBB2FL] Communications Fault, FailCount= 4
2022-11-10T01:27:30.812Z,1668043650.812 [WetLabsBB2FL](ERROR): Communications Fault
2022-11-10T01:27:31.028Z,1668043651.028 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:27:31.037Z,1668043651.037 [MultiRay](INFO): Paused
2022-11-10T01:27:31.053Z,1668043651.053 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL
2022-11-10T01:27:31.312Z,1668043651.312 [WetLabsBB2FL](INFO): Powering down
2022-11-10T01:27:31.456Z,1668043651.456 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:27:31.872Z,1668043651.872 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:27:32.294Z,1668043652.294 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:27:32.368Z,1668043652.368 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL
2022-11-10T01:27:32.368Z,1668043652.368 [WetLabsBB2FL] No Fault, FailCount= 4
2022-11-10T01:27:32.526Z,1668043652.526 [WetLabsBB2FL](INFO): Powering up
2022-11-10T01:27:32.748Z,1668043652.748 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:27:33.204Z,1668043653.204 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:27:33.589Z,1668043653.589 [DAT](DEBUG): In sendingAckWaiting, hit max timeouts so set commsState_ = SENDING_VERIFIED
2022-11-10T01:27:33.590Z,1668043653.590 [DAT](ERROR): Ack receipt timeout failure.
2022-11-10T01:27:33.614Z,1668043653.614 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:27:33.841Z,1668043653.841 [DAT](DEBUG): In sendingVerified, sbd done so set commsState_ = SENDING_FILL_BUFFER
2022-11-10T01:27:34.040Z,1668043654.040 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:27:34.057Z,1668043654.057 [multiray_test:C.Wait](INFO): Done Waiting.
2022-11-10T01:27:34.058Z,1668043654.058 [multiray_test:C.Wait] Stopped
2022-11-10T01:27:34.058Z,1668043654.058 [multiray_test:C.Wait](DEBUG): Uninitialize Wait Component.
2022-11-10T01:27:34.058Z,1668043654.058 [multiray_test:D] Running Loop=1
2022-11-10T01:27:34.480Z,1668043654.480 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:27:34.503Z,1668043654.503 [multiray_test:D] Stopped
2022-11-10T01:27:34.503Z,1668043654.503 [multiray_test:E.Wait] Running Loop=1
2022-11-10T01:27:34.503Z,1668043654.503 [multiray_test:E.Wait](DEBUG): Initialize Wait Component.
2022-11-10T01:27:34.896Z,1668043654.896 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:27:35.336Z,1668043655.336 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:27:35.788Z,1668043655.788 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:27:35.788Z,1668043655.788 [AHRS_M2](FAULT): Failed to initialize within timeout.
2022-11-10T01:27:35.788Z,1668043655.788 [AHRS_M2] Communications Fault, FailCount= 2
2022-11-10T01:27:35.788Z,1668043655.788 [AHRS_M2](ERROR): Communications Fault
2022-11-10T01:27:35.858Z,1668043655.858 [CBIT](ERROR): Communications Fault in component: AHRS_M2
2022-11-10T01:27:35.912Z,1668043655.912 [AHRS_M2](INFO): Powering down
2022-11-10T01:27:36.700Z,1668043656.700 [CBIT](INFO): Clearing failed state for component AHRS_M2
2022-11-10T01:27:36.700Z,1668043656.700 [AHRS_M2] No Fault, FailCount= 2
2022-11-10T01:27:37.081Z,1668043657.081 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2022-11-10T01:27:37.816Z,1668043657.816 [WetLabsBB2FL] Communications Fault, FailCount= 5
2022-11-10T01:27:37.816Z,1668043657.816 [WetLabsBB2FL](ERROR): Communications Fault
2022-11-10T01:27:37.922Z,1668043657.922 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL
2022-11-10T01:27:37.923Z,1668043657.923 [CBIT](FAULT): Communications Fault in component: WetLabsBB2FL
2022-11-10T01:27:38.321Z,1668043658.321 [WetLabsBB2FL](INFO): Powering down
2022-11-10T01:27:39.942Z,1668043659.942 [multiray_test:E.Wait](INFO): Done Waiting.
2022-11-10T01:27:39.942Z,1668043659.942 [multiray_test:E.Wait] Stopped
2022-11-10T01:27:39.942Z,1668043659.942 [multiray_test:E.Wait](DEBUG): Uninitialize Wait Component.
2022-11-10T01:27:39.943Z,1668043659.943 [multiray_test:F] Running Loop=1
2022-11-10T01:27:40.652Z,1668043660.652 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:27:40.682Z,1668043660.682 [multiray_test:F] Stopped
2022-11-10T01:27:40.682Z,1668043660.682 [multiray_test:G.Wait] Running Loop=1
2022-11-10T01:27:40.682Z,1668043660.682 [multiray_test:G.Wait](DEBUG): Initialize Wait Component.
2022-11-10T01:27:41.084Z,1668043661.084 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:27:41.536Z,1668043661.536 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:27:42.036Z,1668043662.036 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:27:42.500Z,1668043662.500 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:27:42.924Z,1668043662.924 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:27:43.348Z,1668043663.348 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:27:43.756Z,1668043663.756 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:27:44.200Z,1668043664.200 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:27:44.644Z,1668043664.644 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:27:45.076Z,1668043665.076 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:27:45.492Z,1668043665.492 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:27:45.908Z,1668043665.908 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:27:46.328Z,1668043666.328 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:27:46.356Z,1668043666.356 [multiray_test:G.Wait](INFO): Done Waiting.
2022-11-10T01:27:46.356Z,1668043666.356 [multiray_test:G.Wait] Stopped
2022-11-10T01:27:46.356Z,1668043666.356 [multiray_test:G.Wait](DEBUG): Uninitialize Wait Component.
2022-11-10T01:27:46.356Z,1668043666.356 [multiray_test:H] Running Loop=1
2022-11-10T01:27:46.744Z,1668043666.744 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:27:46.790Z,1668043666.790 [multiray_test:H] Stopped
2022-11-10T01:27:46.790Z,1668043666.790 [multiray_test:I.Wait] Running Loop=1
2022-11-10T01:27:46.790Z,1668043666.790 [multiray_test:I.Wait](DEBUG): Initialize Wait Component.
2022-11-10T01:27:47.188Z,1668043667.188 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:27:47.636Z,1668043667.636 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:27:48.068Z,1668043668.068 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:27:48.508Z,1668043668.508 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:27:48.928Z,1668043668.928 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:27:49.344Z,1668043669.344 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:27:49.760Z,1668043669.760 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:27:50.188Z,1668043670.188 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:27:50.188Z,1668043670.188 [AHRS_M2](FAULT): Failed to initialize within timeout.
2022-11-10T01:27:50.188Z,1668043670.188 [AHRS_M2] Communications Fault, FailCount= 3
2022-11-10T01:27:50.188Z,1668043670.188 [AHRS_M2](ERROR): Communications Fault
2022-11-10T01:27:50.247Z,1668043670.247 [CBIT](ERROR): Communications Fault in component: AHRS_M2
2022-11-10T01:27:50.313Z,1668043670.313 [AHRS_M2](INFO): Powering down
2022-11-10T01:27:51.087Z,1668043671.087 [CBIT](INFO): Clearing failed state for component AHRS_M2
2022-11-10T01:27:51.087Z,1668043671.087 [AHRS_M2] No Fault, FailCount= 3
2022-11-10T01:27:51.473Z,1668043671.473 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2022-11-10T01:27:52.349Z,1668043672.349 [multiray_test:I.Wait](INFO): Done Waiting.
2022-11-10T01:27:52.349Z,1668043672.349 [multiray_test:I.Wait] Stopped
2022-11-10T01:27:52.349Z,1668043672.349 [multiray_test:I.Wait](DEBUG): Uninitialize Wait Component.
2022-11-10T01:27:52.350Z,1668043672.350 [multiray_test:J] Running Loop=1
2022-11-10T01:27:52.821Z,1668043672.821 [multiray_test:J] Stopped
2022-11-10T01:27:52.821Z,1668043672.821 [multiray_test:K.Wait] Running Loop=1
2022-11-10T01:27:52.821Z,1668043672.821 [multiray_test:K.Wait](DEBUG): Initialize Wait Component.
2022-11-10T01:27:55.016Z,1668043675.016 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:27:55.520Z,1668043675.520 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:27:55.964Z,1668043675.964 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:27:56.412Z,1668043676.412 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:27:56.621Z,1668043676.621 [CommandExec](IMPORTANT): got command show stack
2022-11-10T01:27:56.622Z,1668043676.622 [CommandExec](IMPORTANT): Behavior Stack:

2022-11-10T01:27:56.622Z,1668043676.622 [multiray_test](IMPORTANT): Priority 0: multiray_test:A
2022-11-10T01:27:56.622Z,1668043676.622 [multiray_test](IMPORTANT): Priority 1: multiray_test:K.Wait
2022-11-10T01:27:56.844Z,1668043676.844 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:27:57.256Z,1668043677.256 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:27:57.668Z,1668043677.668 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:27:58.108Z,1668043678.108 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:27:58.156Z,1668043678.156 [multiray_test:K.Wait](INFO): Done Waiting.
2022-11-10T01:27:58.157Z,1668043678.157 [multiray_test:K.Wait] Stopped
2022-11-10T01:27:58.157Z,1668043678.157 [multiray_test:K.Wait](DEBUG): Uninitialize Wait Component.
2022-11-10T01:27:58.157Z,1668043678.157 [multiray_test:L] Running Loop=1
2022-11-10T01:27:58.560Z,1668043678.560 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:27:58.605Z,1668043678.605 [multiray_test:L] Stopped
2022-11-10T01:27:58.605Z,1668043678.605 [multiray_test:M.Wait] Running Loop=1
2022-11-10T01:27:58.606Z,1668043678.606 [multiray_test:M.Wait](DEBUG): Initialize Wait Component.
2022-11-10T01:27:59.000Z,1668043679.000 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:27:59.444Z,1668043679.444 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:27:59.860Z,1668043679.860 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:28:00.276Z,1668043680.276 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:28:00.692Z,1668043680.692 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:28:01.116Z,1668043681.116 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:28:01.564Z,1668043681.564 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:28:02.000Z,1668043682.000 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:28:02.420Z,1668043682.420 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:28:02.836Z,1668043682.836 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:28:03.252Z,1668043683.252 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:28:03.676Z,1668043683.676 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:28:04.124Z,1668043684.124 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:28:04.171Z,1668043684.171 [multiray_test:M.Wait](INFO): Done Waiting.
2022-11-10T01:28:04.172Z,1668043684.172 [multiray_test:M.Wait] Stopped
2022-11-10T01:28:04.172Z,1668043684.172 [multiray_test:M.Wait](DEBUG): Uninitialize Wait Component.
2022-11-10T01:28:04.172Z,1668043684.172 [multiray_test:N] Running Loop=1
2022-11-10T01:28:04.576Z,1668043684.576 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:28:04.576Z,1668043684.576 [AHRS_M2](FAULT): Failed to initialize within timeout.
2022-11-10T01:28:04.576Z,1668043684.576 [AHRS_M2] Communications Fault, FailCount= 4
2022-11-10T01:28:04.576Z,1668043684.576 [AHRS_M2](ERROR): Communications Fault
2022-11-10T01:28:04.610Z,1668043684.610 [multiray_test:N] Stopped
2022-11-10T01:28:04.610Z,1668043684.610 [multiray_test:O.Wait] Running Loop=1
2022-11-10T01:28:04.610Z,1668043684.610 [multiray_test:O.Wait](DEBUG): Initialize Wait Component.
2022-11-10T01:28:04.620Z,1668043684.620 [CBIT](ERROR): Communications Fault in component: AHRS_M2
2022-11-10T01:28:04.685Z,1668043684.685 [AHRS_M2](INFO): Powering down
2022-11-10T01:28:05.455Z,1668043685.455 [CBIT](INFO): Clearing failed state for component AHRS_M2
2022-11-10T01:28:05.455Z,1668043685.455 [AHRS_M2] No Fault, FailCount= 4
2022-11-10T01:28:05.841Z,1668043685.841 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2022-11-10T01:28:09.396Z,1668043689.396 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:28:09.840Z,1668043689.840 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:28:09.868Z,1668043689.868 [multiray_test:O.Wait](INFO): Done Waiting.
2022-11-10T01:28:09.868Z,1668043689.868 [multiray_test:O.Wait] Stopped
2022-11-10T01:28:09.869Z,1668043689.869 [multiray_test:O.Wait](DEBUG): Uninitialize Wait Component.
2022-11-10T01:28:09.869Z,1668043689.869 [multiray_test:P] Running Loop=1
2022-11-10T01:28:10.268Z,1668043690.268 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:28:10.302Z,1668043690.302 [multiray_test:P] Stopped
2022-11-10T01:28:10.302Z,1668043690.302 [multiray_test:Q.Wait] Running Loop=1
2022-11-10T01:28:10.302Z,1668043690.302 [multiray_test:Q.Wait](DEBUG): Initialize Wait Component.
2022-11-10T01:28:10.704Z,1668043690.704 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:28:11.140Z,1668043691.140 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:28:11.560Z,1668043691.560 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:28:11.980Z,1668043691.980 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:28:12.404Z,1668043692.404 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:28:12.828Z,1668043692.828 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:28:13.268Z,1668043693.268 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:28:13.708Z,1668043693.708 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:28:14.152Z,1668043694.152 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:28:14.584Z,1668043694.584 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:28:15.004Z,1668043695.004 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:28:15.424Z,1668043695.424 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:28:15.852Z,1668043695.852 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:28:15.909Z,1668043695.909 [multiray_test:Q.Wait](INFO): Done Waiting.
2022-11-10T01:28:15.909Z,1668043695.909 [multiray_test:Q.Wait] Stopped
2022-11-10T01:28:15.909Z,1668043695.909 [multiray_test:Q.Wait](DEBUG): Uninitialize Wait Component.
2022-11-10T01:28:15.910Z,1668043695.910 [multiray_test:U] Running Loop=1
2022-11-10T01:28:16.304Z,1668043696.304 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:28:16.365Z,1668043696.365 [multiray_test:U] Stopped
2022-11-10T01:28:16.365Z,1668043696.365 [multiray_test:R.Wait] Running Loop=1
2022-11-10T01:28:16.365Z,1668043696.365 [multiray_test:R.Wait](DEBUG): Initialize Wait Component.
2022-11-10T01:28:16.808Z,1668043696.808 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:28:17.260Z,1668043697.260 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:28:17.676Z,1668043697.676 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:28:18.088Z,1668043698.088 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:28:18.504Z,1668043698.504 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:28:18.920Z,1668043698.920 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T01:28:18.920Z,1668043698.920 [AHRS_M2](FAULT): Failed to initialize within timeout.
2022-11-10T01:28:18.920Z,1668043698.920 [AHRS_M2] Communications Fault, FailCount= 5
2022-11-10T01:28:18.920Z,1668043698.920 [AHRS_M2](ERROR): Communications Fault
2022-11-10T01:28:19.038Z,1668043699.038 [CBIT](ERROR): Communications Fault in component: AHRS_M2
2022-11-10T01:28:19.038Z,1668043699.038 [CBIT](CRITICAL): Communications Fault in component: AHRS_M2
2022-11-10T01:28:19.098Z,1668043699.098 [AHRS_M2](INFO): Powering down
2022-11-10T01:28:19.238Z,1668043699.238 [CBIT](INFO): Critical error at 20221110T012819
2022-11-10T01:28:19.238Z,1668043699.238 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals
2022-11-10T01:28:19.495Z,1668043699.495 [MissionManager](INFO): MissionManager is completed.
2022-11-10T01:28:19.495Z,1668043699.495 [MissionManager](INFO): Uninitializing Mission multiray_test
2022-11-10T01:28:19.495Z,1668043699.495 [multiray_test] Stopped
2022-11-10T01:28:19.495Z,1668043699.495 [multiray_test](DEBUG): Aggregate::uninitialize multiray_test
2022-11-10T01:28:19.495Z,1668043699.495 [multiray_test:A] Stopped
2022-11-10T01:28:19.495Z,1668043699.495 [multiray_test:R.Wait] Stopped
2022-11-10T01:28:19.496Z,1668043699.496 [multiray_test:R.Wait](DEBUG): Uninitialize Wait Component.
2022-11-10T01:28:19.889Z,1668043699.889 [MissionManager](IMPORTANT): Started mission Default
2022-11-10T01:28:19.889Z,1668043699.889 [Default] Running Loop=1
2022-11-10T01:28:19.889Z,1668043699.889 [Default](DEBUG): Aggregate::initialize Default
2022-11-10T01:28:19.889Z,1668043699.889 [Default:B.GoToSurface] Running Loop=1
2022-11-10T01:28:19.889Z,1668043699.889 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2022-11-10T01:28:19.889Z,1668043699.889 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2022-11-10T01:28:19.890Z,1668043699.890 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2022-11-10T01:28:19.890Z,1668043699.890 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2022-11-10T01:28:19.890Z,1668043699.890 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2022-11-10T01:28:19.891Z,1668043699.891 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2022-11-10T01:28:19.891Z,1668043699.891 [Default:A.Wait] Running Loop=1
2022-11-10T01:28:19.891Z,1668043699.891 [Default:A.Wait](DEBUG): Initialize Wait Component.
2022-11-10T01:28:25.522Z,1668043705.522 [BPC1](INFO): Calculating totals. Valid battery stick count: 56. Valid reserve battery stick count: 6.
2022-11-10T01:28:25.525Z,1668043705.525 [BPC1](INFO): Received data from all battery sticks.
2022-11-10T01:28:33.227Z,1668043713.227 [Default:A.Wait](INFO): Done Waiting.
2022-11-10T01:28:33.227Z,1668043713.227 [Default:A.Wait] Stopped
2022-11-10T01:28:33.227Z,1668043713.227 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2022-11-10T01:28:33.602Z,1668043713.602 [Default:CheckIn] Running Loop=1
2022-11-10T01:28:33.602Z,1668043713.602 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2022-11-10T01:28:33.603Z,1668043713.603 [Default:CheckIn:Read_GPS] Running Loop=1
2022-11-10T01:29:00.263Z,1668043740.263 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2022-11-10T01:29:00.264Z,1668043740.264 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4
2022-11-10T01:29:00.264Z,1668043740.264 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2022-11-10T01:29:00.265Z,1668043740.265 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2022-11-10T01:29:00.266Z,1668043740.266 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 4
2022-11-10T01:29:00.266Z,1668043740.266 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2022-11-10T01:29:00.276Z,1668043740.276 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2022-11-10T01:29:00.277Z,1668043740.277 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2022-11-10T01:29:00.713Z,1668043740.713 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2022-11-10T01:29:00.713Z,1668043740.713 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4
2022-11-10T01:29:00.713Z,1668043740.713 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2022-11-10T01:29:00.714Z,1668043740.714 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 4
2022-11-10T01:29:01.098Z,1668043741.098 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2022-11-10T01:29:50.793Z,1668043790.793 [CommandExec](IMPORTANT): got command run ./Missions/Maintenance/multiray_test.xml
2022-11-10T01:29:50.794Z,1668043790.794 [MissionManager](INFO): Loading Mission from file: ./Missions/Maintenance/multiray_test.xml
2022-11-10T01:29:50.879Z,1668043790.879 [MissionManager](INFO): DefineArg multiray_test.MissionTimeout = 5.000000 min
2022-11-10T01:29:50.882Z,1668043790.882 [MissionManager](INFO): DefineArg multiray_test.LightDuration = 5.000000 s
2022-11-10T01:29:50.884Z,1668043790.884 [MissionManager](INFO): DefineArg multiray_test.LightMode0 = 0.000000 count
2022-11-10T01:29:50.886Z,1668043790.886 [MissionManager](INFO): DefineArg multiray_test.LightMode1 = 1.000000 count
2022-11-10T01:29:50.888Z,1668043790.888 [MissionManager](INFO): DefineArg multiray_test.LightMode2 = 2.000000 count
2022-11-10T01:29:50.890Z,1668043790.890 [MissionManager](INFO): DefineArg multiray_test.EnabledMultiray = 1 bool
2022-11-10T01:29:50.894Z,1668043790.894 [multiray_test:C.Wait](DEBUG): Construct Wait.
2022-11-10T01:29:50.897Z,1668043790.897 [multiray_test:E.Wait](DEBUG): Construct Wait.
2022-11-10T01:29:50.899Z,1668043790.899 [multiray_test:G.Wait](DEBUG): Construct Wait.
2022-11-10T01:29:50.902Z,1668043790.902 [multiray_test:I.Wait](DEBUG): Construct Wait.
2022-11-10T01:29:50.905Z,1668043790.905 [multiray_test:K.Wait](DEBUG): Construct Wait.
2022-11-10T01:29:50.908Z,1668043790.908 [multiray_test:M.Wait](DEBUG): Construct Wait.
2022-11-10T01:29:50.911Z,1668043790.911 [multiray_test:O.Wait](DEBUG): Construct Wait.
2022-11-10T01:29:50.941Z,1668043790.941 [multiray_test:Q.Wait](DEBUG): Construct Wait.
2022-11-10T01:29:50.944Z,1668043790.944 [multiray_test:R.Wait](DEBUG): Construct Wait.
2022-11-10T01:29:50.951Z,1668043790.951 [multiray_test:T.Wait](DEBUG): Construct Wait.
2022-11-10T01:29:50.978Z,1668043790.978 [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-10T01:29:50.980Z,1668043790.980 [CommandExec](IMPORTANT): Running ./Missions/Maintenance/multiray_test.xml
2022-11-10T01:29:51.177Z,1668043791.177 [Default] Stopped
2022-11-10T01:29:51.177Z,1668043791.177 [Default](DEBUG): Aggregate::uninitialize Default
2022-11-10T01:29:51.177Z,1668043791.177 [Default:B.GoToSurface] Stopped
2022-11-10T01:29:51.177Z,1668043791.177 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2022-11-10T01:29:51.177Z,1668043791.177 [Default:CheckIn] Stopped
2022-11-10T01:29:51.177Z,1668043791.177 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2022-11-10T01:29:51.177Z,1668043791.177 [Default:CheckIn:Read_GPS] Stopped
2022-11-10T01:29:51.177Z,1668043791.177 [MissionManager](IMPORTANT): Started mission multiray_test
2022-11-10T01:29:51.178Z,1668043791.178 [multiray_test] Running Loop=1
2022-11-10T01:29:51.178Z,1668043791.178 [multiray_test](DEBUG): Aggregate::initialize multiray_test
2022-11-10T01:29:51.178Z,1668043791.178 [multiray_test:A] Running Loop=1
2022-11-10T01:29:51.178Z,1668043791.178 [multiray_test:B] Running Loop=1
2022-11-10T01:29:51.179Z,1668043791.179 [multiray_test:B] Stopped
2022-11-10T01:29:51.179Z,1668043791.179 [multiray_test:C.Wait] Running Loop=1
2022-11-10T01:29:51.179Z,1668043791.179 [multiray_test:C.Wait](DEBUG): Initialize Wait Component.
2022-11-10T01:29:51.179Z,1668043791.179 [multiray_test:A] Running Loop=1
2022-11-10T01:29:51.180Z,1668043791.180 [multiray_test:A](DEBUG): Initialize ReadDataComponent to sense MultiRay.lightModeLog
2022-11-10T01:29:56.828Z,1668043796.828 [multiray_test:C.Wait](INFO): Done Waiting.
2022-11-10T01:29:56.828Z,1668043796.828 [multiray_test:C.Wait] Stopped
2022-11-10T01:29:56.828Z,1668043796.828 [multiray_test:C.Wait](DEBUG): Uninitialize Wait Component.
2022-11-10T01:29:56.828Z,1668043796.828 [multiray_test:D] Running Loop=1
2022-11-10T01:29:57.227Z,1668043797.227 [multiray_test:D] Stopped
2022-11-10T01:29:57.227Z,1668043797.227 [multiray_test:E.Wait] Running Loop=1
2022-11-10T01:29:57.227Z,1668043797.227 [multiray_test:E.Wait](DEBUG): Initialize Wait Component.
2022-11-10T01:30:02.906Z,1668043802.906 [multiray_test:E.Wait](INFO): Done Waiting.
2022-11-10T01:30:02.906Z,1668043802.906 [multiray_test:E.Wait] Stopped
2022-11-10T01:30:02.906Z,1668043802.906 [multiray_test:E.Wait](DEBUG): Uninitialize Wait Component.
2022-11-10T01:30:02.906Z,1668043802.906 [multiray_test:F] Running Loop=1
2022-11-10T01:30:03.317Z,1668043803.317 [multiray_test:F] Stopped
2022-11-10T01:30:03.318Z,1668043803.318 [multiray_test:G.Wait] Running Loop=1
2022-11-10T01:30:03.318Z,1668043803.318 [multiray_test:G.Wait](DEBUG): Initialize Wait Component.
2022-11-10T01:30:07.221Z,1668043807.221 [CommandExec](IMPORTANT): got command restart application
2022-11-10T01:30:08.162Z,1668043808.162 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL
2022-11-10T01:30:08.162Z,1668043808.162 [WetLabsBB2FL] No Fault, FailCount= 5
2022-11-10T01:30:08.224Z,1668043808.224 [Supervisor](INFO): Stop Mission called by Supervisor::terminate
2022-11-10T01:30:08.225Z,1668043808.225 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread.
2022-11-10T01:30:08.225Z,1668043808.225 [CommandExec](INFO): Uninitializing the command executive.
2022-11-10T01:30:08.225Z,1668043808.225 [CommandExec](INFO): Uninitializing the command scheduler.
2022-11-10T01:30:08.225Z,1668043808.225 [CommandExec ThreadHandler](INFO): Thread cancelled.
2022-11-10T01:30:08.227Z,1668043808.227 [WetLabsBB2FL](INFO): Powering up
2022-11-10T01:30:08.292Z,1668043808.292 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup.  Bye!
2022-11-10T01:30:08.292Z,1668043808.292 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2022-11-10T01:30:08.292Z,1668043808.292 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2022-11-10T01:30:08.293Z,1668043808.293 [NavChartDb](INFO): Join timeout helper Thread ID is 1638
2022-11-10T01:30:08.550Z,1668043808.550 [MissionManager](INFO): MissionManager is completed.
2022-11-10T01:30:08.550Z,1668043808.550 [MissionManager](INFO): Uninitializing Mission multiray_test
2022-11-10T01:30:08.550Z,1668043808.550 [multiray_test] Stopped
2022-11-10T01:30:08.550Z,1668043808.550 [multiray_test](DEBUG): Aggregate::uninitialize multiray_test
2022-11-10T01:30:08.550Z,1668043808.550 [multiray_test:A] Stopped
2022-11-10T01:30:08.550Z,1668043808.550 [multiray_test:G.Wait] Stopped
2022-11-10T01:30:08.550Z,1668043808.550 [multiray_test:G.Wait](DEBUG): Uninitialize Wait Component.
2022-11-10T01:30:08.664Z,1668043808.664 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2022-11-10T01:30:08.665Z,1668043808.665 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2022-11-10T01:30:08.685Z,1668043808.685 [ComponentRegistry](INFO): Shutting down DAT ThreadHandler
2022-11-10T01:30:08.685Z,1668043808.685 [DAT ThreadHandler](INFO): Thread cancelled.
2022-11-10T01:30:08.685Z,1668043808.685 [DAT](INFO): Join timeout helper Thread ID is 1639
2022-11-10T01:30:08.920Z,1668043808.920 [DAT](INFO): Powering down
2022-11-10T01:30:08.971Z,1668043808.971 [MissionManager](IMPORTANT): Started mission Default
2022-11-10T01:30:08.971Z,1668043808.971 [Default] Running Loop=1
2022-11-10T01:30:08.971Z,1668043808.971 [Default](DEBUG): Aggregate::initialize Default
2022-11-10T01:30:08.971Z,1668043808.971 [Default:B.GoToSurface] Running Loop=1
2022-11-10T01:30:08.971Z,1668043808.971 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2022-11-10T01:30:08.972Z,1668043808.972 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2022-11-10T01:30:08.972Z,1668043808.972 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2022-11-10T01:30:08.972Z,1668043808.972 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2022-11-10T01:30:08.973Z,1668043808.973 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2022-11-10T01:30:08.973Z,1668043808.973 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2022-11-10T01:30:08.973Z,1668043808.973 [Default:A.Wait] Running Loop=1
2022-11-10T01:30:08.973Z,1668043808.973 [Default:A.Wait](DEBUG): Initialize Wait Component.
2022-11-10T01:30:08.993Z,1668043808.993 [DAT ThreadHandler](INFO): Uninitializing protected caller thread.
2022-11-10T01:30:08.993Z,1668043808.993 [DAT](INFO): Powering down
2022-11-10T01:30:08.994Z,1668043808.994 [DAT ThreadHandler](INFO): Thread cancelled.
2022-11-10T01:30:09.004Z,1668043809.004 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2022-11-10T01:30:09.004Z,1668043809.004 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2022-11-10T01:30:09.005Z,1668043809.005 [Radio_Surface](INFO): Join timeout helper Thread ID is 1640
2022-11-10T01:30:09.084Z,1668043809.084 [Radio_Surface](INFO): Powering down
2022-11-10T01:30:09.085Z,1668043809.085 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2022-11-10T01:30:09.085Z,1668043809.085 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2022-11-10T01:30:09.100Z,1668043809.100 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler
2022-11-10T01:30:09.100Z,1668043809.100 [Onboard ThreadHandler](INFO): Thread cancelled.
2022-11-10T01:30:09.101Z,1668043809.101 [Onboard](INFO): Join timeout helper Thread ID is 1641
2022-11-10T01:30:09.681Z,1668043809.681 [DataOverHttps](INFO): Radio surface powered OFF, will not connect.
2022-11-10T01:30:12.416Z,1668043812.416 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread.
2022-11-10T01:30:12.417Z,1668043812.417 [Onboard ThreadHandler](INFO): Thread cancelled.
2022-11-10T01:30:12.434Z,1668043812.434 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler
2022-11-10T01:30:12.434Z,1668043812.434 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2022-11-10T01:30:12.434Z,1668043812.434 [DataOverHttps](INFO): Join timeout helper Thread ID is 1642
2022-11-10T01:30:12.692Z,1668043812.692 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread.
2022-11-10T01:30:12.693Z,1668043812.693 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2022-11-10T01:30:12.709Z,1668043812.709 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler
2022-11-10T01:30:12.709Z,1668043812.709 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2022-11-10T01:30:12.710Z,1668043812.710 [BackseatComponent](INFO): Join timeout helper Thread ID is 1643
2022-11-10T01:30:12.845Z,1668043812.845 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread.
2022-11-10T01:30:12.845Z,1668043812.845 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2022-11-10T01:30:12.853Z,1668043812.853 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2022-11-10T01:30:12.853Z,1668043812.853 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2022-11-10T01:30:12.854Z,1668043812.854 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 1644
2022-11-10T01:30:13.020Z,1668043813.020 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread.
2022-11-10T01:30:13.116Z,1668043813.116 [WetLabsBB2FL](INFO): Powering down
2022-11-10T01:30:13.117Z,1668043813.117 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2022-11-10T01:30:13.133Z,1668043813.133 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2022-11-10T01:30:13.133Z,1668043813.133 [logger ThreadHandler](INFO): Thread cancelled.
2022-11-10T01:30:13.133Z,1668043813.133 [logger](INFO): Join timeout helper Thread ID is 1645
2022-11-10T01:30:13.156Z,1668043813.156 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2022-11-10T01:30:13.157Z,1668043813.157 [logger ThreadHandler](INFO): Thread cancelled.
2022-11-10T01:30:13.173Z,1668043813.173 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2022-11-10T01:30:13.173Z,1668043813.173 [CommandLine ThreadHandler](INFO): Thread cancelled.
2022-11-10T01:30:13.173Z,1668043813.173 [CommandLine](INFO): Join timeout helper Thread ID is 1646
2022-11-10T01:30:13.260Z,1668043813.260 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2022-11-10T01:30:13.261Z,1668043813.261 [CommandLine ThreadHandler](INFO): Thread cancelled.
2022-11-10T01:30:13.273Z,1668043813.273 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler
2022-11-10T01:30:13.273Z,1668043813.273 [CommandExec ThreadHandler](INFO): Thread cancelled.
2022-11-10T01:30:13.273Z,1668043813.273 [CommandExec](INFO): Join timeout helper Thread ID is 1647
2022-11-10T01:30:13.275Z,1668043813.275 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2022-11-10T01:30:13.275Z,1668043813.275 [controlThread ThreadHandler](INFO): Thread cancelled.
2022-11-10T01:30:13.275Z,1668043813.275 [controlThread](INFO): Join timeout helper Thread ID is 1648
2022-11-10T01:30:13.368Z,1668043813.368 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2022-11-10T01:30:13.369Z,1668043813.369 [controlThread](DEBUG): Uninitializing ControlThread
2022-11-10T01:30:13.369Z,1668043813.369 [AHRS_M2](INFO): Powering down
2022-11-10T01:30:13.371Z,1668043813.371 [MultiRay](INFO): Powering down.
2022-11-10T01:30:13.371Z,1668043813.371 [NAL9602](INFO): Powering down
2022-11-10T01:30:13.373Z,1668043813.373 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2022-11-10T01:30:13.374Z,1668043813.374 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2022-11-10T01:30:13.374Z,1668043813.374 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2022-11-10T01:30:13.375Z,1668043813.375 [MissionManager](INFO): Uninitializing Mission Default
2022-11-10T01:30:13.375Z,1668043813.375 [Default] Stopped
2022-11-10T01:30:13.375Z,1668043813.375 [Default](DEBUG): Aggregate::uninitialize Default
2022-11-10T01:30:13.375Z,1668043813.375 [Default:A.Wait] Stopped
2022-11-10T01:30:13.375Z,1668043813.375 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2022-11-10T01:30:13.375Z,1668043813.375 [Default:B.GoToSurface] Stopped
2022-11-10T01:30:13.375Z,1668043813.375 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2022-11-10T01:30:13.378Z,1668043813.378 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2022-11-10T01:30:13.378Z,1668043813.378 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2022-11-10T01:30:13.378Z,1668043813.378 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2022-11-10T01:30:13.378Z,1668043813.378 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2022-11-10T01:30:13.379Z,1668043813.379 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2022-11-10T01:30:13.379Z,1668043813.379 [BuoyancyServo](INFO): Powering down
2022-11-10T01:30:13.392Z,1668043813.392 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2022-11-10T01:30:13.392Z,1668043813.392 [ElevatorServo](INFO): Powering down
2022-11-10T01:30:13.393Z,1668043813.393 [MassServo](DEBUG): Uninitialize Mass Servo.
2022-11-10T01:30:13.393Z,1668043813.393 [MassServo](INFO): Powering down
2022-11-10T01:30:13.394Z,1668043813.394 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2022-11-10T01:30:13.394Z,1668043813.394 [RudderServo](INFO): Powering down
2022-11-10T01:30:13.395Z,1668043813.395 [ThrusterHE](DEBUG): Uninitialize Thruster Servo.
2022-11-10T01:30:13.395Z,1668043813.395 [ThrusterHE](INFO): Powering down
2022-11-10T01:30:13.396Z,1668043813.396 [SBIT](DEBUG): Uninitialize SBIT Component.
2022-11-10T01:30:13.397Z,1668043813.397 [IBIT](DEBUG): Uninitialize IBIT Component.
2022-11-10T01:30:13.397Z,1668043813.397 [CBIT](DEBUG): Uninitialize CBIT Component.
2022-11-10T01:30:13.397Z,1668043813.397 [CBIT](DEBUG): Powering off loads.
2022-11-10T01:30:13.408Z,1668043813.408 [CBIT](DEBUG): Disabling WDT.
2022-11-10T01:30:13.420Z,1668043813.420 [CBIT](DEBUG): Opening all GF detection circuits.
2022-11-10T01:30:13.421Z,1668043813.421 [controlThread ThreadHandler](INFO): Thread cancelled.
2022-11-10T01:30:13.459Z,1668043813.459 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2022-11-10T01:30:13.505Z,1668043813.505 [DAT ThreadHandler](INFO): Thread cancelled.
2022-11-10T01:30:13.509Z,1668043813.509 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2022-11-10T01:30:13.512Z,1668043813.512 [Onboard ThreadHandler](INFO): Thread cancelled.
2022-11-10T01:30:13.519Z,1668043813.519 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2022-11-10T01:30:13.563Z,1668043813.563 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2022-11-10T01:30:13.604Z,1668043813.604 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2022-11-10T01:30:13.665Z,1668043813.665 [logger ThreadHandler](INFO): Thread cancelled.