2022-11-10T23:17:58.275Z,1668122278.275 [Supervisor](DEBUG): Initializing supervisor.
2022-11-10T23:17:58.279Z,1668122278.279 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2022-11-10T23:17:58.280Z,1668122278.280 [SyncHandler](INFO): Protected caller Thread ID is 985
2022-11-10T23:17:58.280Z,1668122278.280 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2022-11-10T23:17:58.281Z,1668122278.281 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2022-11-10T23:17:58.281Z,1668122278.281 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 986
2022-11-10T23:17:58.285Z,1668122278.285 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2022-11-10T23:17:58.303Z,1668122278.303 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread.
2022-11-10T23:17:58.304Z,1668122278.304 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2022-11-10T23:17:58.304Z,1668122278.304 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 987
2022-11-10T23:17:58.308Z,1668122278.308 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2022-11-10T23:17:58.309Z,1668122278.309 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2022-11-10T23:17:58.309Z,1668122278.309 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 988
2022-11-10T23:17:58.312Z,1668122278.312 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2022-11-10T23:17:58.312Z,1668122278.312 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0
2022-11-10T23:17:58.313Z,1668122278.313 [logger ThreadHandler](INFO): Protected caller Thread ID is 989
2022-11-10T23:17:58.316Z,1668122278.316 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2022-11-10T23:17:58.317Z,1668122278.317 [Supervisor](INFO): Looking for Config files in directory: Config/
2022-11-10T23:17:58.318Z,1668122278.318 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2022-11-10T23:17:58.728Z,1668122278.728 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2022-11-10T23:17:58.729Z,1668122278.729 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg
2022-11-10T23:17:58.935Z,1668122278.935 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock
2022-11-10T23:17:58.936Z,1668122278.936 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2022-11-10T23:17:59.109Z,1668122279.109 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2022-11-10T23:17:59.110Z,1668122279.110 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2022-11-10T23:17:59.212Z,1668122279.212 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2022-11-10T23:17:59.213Z,1668122279.213 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2022-11-10T23:17:59.573Z,1668122279.573 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2022-11-10T23:17:59.574Z,1668122279.574 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2022-11-10T23:17:59.890Z,1668122279.890 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2022-11-10T23:17:59.890Z,1668122279.890 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2022-11-10T23:17:59.982Z,1668122279.982 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2022-11-10T23:17:59.983Z,1668122279.983 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2022-11-10T23:18:00.262Z,1668122280.262 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2022-11-10T23:18:00.263Z,1668122280.263 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2022-11-10T23:18:00.828Z,1668122280.828 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2022-11-10T23:18:00.828Z,1668122280.828 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2022-11-10T23:18:01.167Z,1668122281.167 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2022-11-10T23:18:01.168Z,1668122281.168 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2022-11-10T23:18:01.246Z,1668122281.246 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2022-11-10T23:18:01.448Z,1668122281.448 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2022-11-10T23:18:01.448Z,1668122281.448 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2022-11-10T23:18:01.580Z,1668122281.580 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2022-11-10T23:18:01.580Z,1668122281.580 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2022-11-10T23:18:02.286Z,1668122282.286 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2022-11-10T23:18:02.287Z,1668122282.287 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2022-11-10T23:18:02.364Z,1668122282.364 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2022-11-10T23:18:02.641Z,1668122282.641 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2022-11-10T23:18:02.643Z,1668122282.643 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-galene/
2022-11-10T23:18:02.644Z,1668122282.644 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/vehicle.cfg
2022-11-10T23:18:02.814Z,1668122282.814 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/logger.cfg
2022-11-10T23:18:02.904Z,1668122282.904 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Servo.cfg
2022-11-10T23:18:03.012Z,1668122283.012 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Control.cfg
2022-11-10T23:18:03.108Z,1668122283.108 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/secure.cfg
2022-11-10T23:18:03.189Z,1668122283.189 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Simulator.cfg
2022-11-10T23:18:03.272Z,1668122283.272 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Science.cfg
2022-11-10T23:18:03.381Z,1668122283.381 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/BIT.cfg
2022-11-10T23:18:03.476Z,1668122283.476 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Sensor.cfg
2022-11-10T23:18:03.625Z,1668122283.625 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Battery.cfg
2022-11-10T23:18:03.883Z,1668122283.883 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2022-11-10T23:18:03.884Z,1668122283.884 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Navigation.cfg
2022-11-10T23:18:03.975Z,1668122283.975 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-galene/root/
2022-11-10T23:18:03.975Z,1668122283.975 [Supervisor](FAULT): Ignoring configuration overrides from Data/persisted.cfg
2022-11-10T23:18:03.977Z,1668122283.977 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2022-11-10T23:18:04.280Z,1668122284.280 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2022-11-10T23:18:04.281Z,1668122284.281 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2022-11-10T23:18:04.392Z,1668122284.392 [DeadReckonUsingMultipleVelocitySources] Loaded
2022-11-10T23:18:04.392Z,1668122284.392 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2022-11-10T23:18:04.431Z,1668122284.431 [DeadReckonUsingSpeedCalculator] Loaded
2022-11-10T23:18:04.431Z,1668122284.431 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread.
2022-11-10T23:18:04.444Z,1668122284.444 [NavChart] Loaded
2022-11-10T23:18:04.445Z,1668122284.445 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2022-11-10T23:18:04.450Z,1668122284.450 [UniversalFixResidualReporter] Loaded
2022-11-10T23:18:04.450Z,1668122284.450 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2022-11-10T23:18:04.451Z,1668122284.451 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2022-11-10T23:18:04.451Z,1668122284.451 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2022-11-10T23:18:04.462Z,1668122284.462 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2022-11-10T23:18:04.462Z,1668122284.462 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2022-11-10T23:18:04.737Z,1668122284.737 [CTD_Seabird] Loaded
2022-11-10T23:18:04.737Z,1668122284.737 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread.
2022-11-10T23:18:04.738Z,1668122284.738 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 4065A4E0
2022-11-10T23:18:04.739Z,1668122284.739 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 1072
2022-11-10T23:18:04.810Z,1668122284.810 [PAR_Licor] Loaded
2022-11-10T23:18:04.811Z,1668122284.811 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2022-11-10T23:18:05.062Z,1668122285.062 [WetLabsBB2FL] Loaded
2022-11-10T23:18:05.062Z,1668122285.062 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2022-11-10T23:18:05.063Z,1668122285.063 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 4068A4E0
2022-11-10T23:18:05.064Z,1668122285.064 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 1073
2022-11-10T23:18:05.064Z,1668122285.064 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2022-11-10T23:18:05.065Z,1668122285.065 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2022-11-10T23:18:05.183Z,1668122285.183 [VerticalControl](DEBUG): Construct VerticalControl.
2022-11-10T23:18:05.259Z,1668122285.259 [VerticalControl] Loaded
2022-11-10T23:18:05.260Z,1668122285.260 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2022-11-10T23:18:05.262Z,1668122285.262 [HorizontalControl](DEBUG): Construct HorizontalControl.
2022-11-10T23:18:05.369Z,1668122285.369 [HorizontalControl] Loaded
2022-11-10T23:18:05.369Z,1668122285.369 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2022-11-10T23:18:05.372Z,1668122285.372 [SpeedControl](DEBUG): Construct SpeedControl.
2022-11-10T23:18:05.375Z,1668122285.375 [SpeedControl] Loaded
2022-11-10T23:18:05.376Z,1668122285.376 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2022-11-10T23:18:05.378Z,1668122285.378 [LoopControl](DEBUG): Construct LoopControl.
2022-11-10T23:18:05.379Z,1668122285.379 [LoopControl] Loaded
2022-11-10T23:18:05.379Z,1668122285.379 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2022-11-10T23:18:05.415Z,1668122285.415 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2022-11-10T23:18:05.416Z,1668122285.416 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2022-11-10T23:18:05.551Z,1668122285.551 [DepthRateCalculator] Loaded
2022-11-10T23:18:05.551Z,1668122285.551 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2022-11-10T23:18:05.556Z,1668122285.556 [PitchRateCalculator] Loaded
2022-11-10T23:18:05.556Z,1668122285.556 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2022-11-10T23:18:05.565Z,1668122285.565 [SpeedCalculator] Loaded
2022-11-10T23:18:05.566Z,1668122285.566 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2022-11-10T23:18:05.570Z,1668122285.570 [YawRateCalculator] Loaded
2022-11-10T23:18:05.570Z,1668122285.570 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2022-11-10T23:18:05.588Z,1668122285.588 [ElevatorOffsetCalculator] Loaded
2022-11-10T23:18:05.589Z,1668122285.589 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2022-11-10T23:18:05.589Z,1668122285.589 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2022-11-10T23:18:05.590Z,1668122285.590 [Module Loader](DEBUG): Loading Module at Modules/Dock.so
2022-11-10T23:18:05.840Z,1668122285.840 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking)
2022-11-10T23:18:05.840Z,1668122285.840 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2022-11-10T23:18:05.897Z,1668122285.897 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2022-11-10T23:18:05.897Z,1668122285.897 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2022-11-10T23:18:06.019Z,1668122286.019 [BuoyancyServo] Loaded
2022-11-10T23:18:06.019Z,1668122286.019 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2022-11-10T23:18:06.039Z,1668122286.039 [ElevatorServo] Loaded
2022-11-10T23:18:06.039Z,1668122286.039 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2022-11-10T23:18:06.058Z,1668122286.058 [MassServo] Loaded
2022-11-10T23:18:06.059Z,1668122286.059 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2022-11-10T23:18:06.077Z,1668122286.077 [RudderServo] Loaded
2022-11-10T23:18:06.078Z,1668122286.078 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2022-11-10T23:18:06.092Z,1668122286.092 [ThrusterHE] Loaded
2022-11-10T23:18:06.092Z,1668122286.092 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread.
2022-11-10T23:18:06.093Z,1668122286.093 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2022-11-10T23:18:06.093Z,1668122286.093 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2022-11-10T23:18:06.243Z,1668122286.243 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2022-11-10T23:18:06.243Z,1668122286.243 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2022-11-10T23:18:06.648Z,1668122286.648 [AHRS_M2] Loaded
2022-11-10T23:18:06.649Z,1668122286.649 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread.
2022-11-10T23:18:06.684Z,1668122286.684 [BackseatComponent] Loaded
2022-11-10T23:18:06.684Z,1668122286.684 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread.
2022-11-10T23:18:06.685Z,1668122286.685 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 40A854E0
2022-11-10T23:18:06.685Z,1668122286.685 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 1074
2022-11-10T23:18:06.688Z,1668122286.688 [LcmUniversalReporter] Loaded
2022-11-10T23:18:06.689Z,1668122286.689 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread.
2022-11-10T23:18:07.515Z,1668122287.515 [BPC1] Loaded
2022-11-10T23:18:07.515Z,1668122287.515 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2022-11-10T23:18:07.589Z,1668122287.589 [DataOverHttps] Loaded
2022-11-10T23:18:07.589Z,1668122287.589 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2022-11-10T23:18:07.590Z,1668122287.590 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 40AB54E0
2022-11-10T23:18:07.590Z,1668122287.590 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 1075
2022-11-10T23:18:07.611Z,1668122287.611 [Depth_Keller] Loaded
2022-11-10T23:18:07.611Z,1668122287.611 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2022-11-10T23:18:07.616Z,1668122287.616 [DropWeight] Loaded
2022-11-10T23:18:07.616Z,1668122287.616 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2022-11-10T23:18:07.635Z,1668122287.635 [MultiRay] Loaded
2022-11-10T23:18:07.635Z,1668122287.635 [ComponentRegistry](DEBUG): SyncComponent "MultiRay" handled in the control thread.
2022-11-10T23:18:07.698Z,1668122287.698 [NAL9602] Loaded
2022-11-10T23:18:07.698Z,1668122287.698 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2022-11-10T23:18:07.728Z,1668122287.728 [Onboard] Loaded
2022-11-10T23:18:07.729Z,1668122287.729 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread.
2022-11-10T23:18:07.730Z,1668122287.730 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 40AE54E0
2022-11-10T23:18:07.730Z,1668122287.730 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 1076
2022-11-10T23:18:07.736Z,1668122287.736 [PowerOnly](INFO): Adding load control power supply at /dev/loadC3
2022-11-10T23:18:07.747Z,1668122287.747 [PowerOnly] Loaded
2022-11-10T23:18:07.748Z,1668122287.748 [ComponentRegistry](DEBUG): SyncComponent "PowerOnly" handled in the control thread.
2022-11-10T23:18:07.760Z,1668122287.760 [Power24vConverter] Loaded
2022-11-10T23:18:07.760Z,1668122287.760 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread.
2022-11-10T23:18:07.773Z,1668122287.773 [Radio_Surface] Loaded
2022-11-10T23:18:07.774Z,1668122287.774 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2022-11-10T23:18:07.775Z,1668122287.775 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 40B154E0
2022-11-10T23:18:07.775Z,1668122287.775 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 1077
2022-11-10T23:18:07.868Z,1668122287.868 [DAT] Loaded
2022-11-10T23:18:07.869Z,1668122287.869 [ComponentRegistry](DEBUG): Component "DAT" handled in its own thread.
2022-11-10T23:18:07.870Z,1668122287.870 [DAT ThreadHandler](DEBUG): Created PCaller Thread at 40B454E0
2022-11-10T23:18:07.870Z,1668122287.870 [DAT ThreadHandler](INFO): Protected caller Thread ID is 1078
2022-11-10T23:18:07.871Z,1668122287.871 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2022-11-10T23:18:07.871Z,1668122287.871 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2022-11-10T23:18:08.010Z,1668122288.010 [SBIT](DEBUG): Construct Startup Built In Test.
2022-11-10T23:18:08.020Z,1668122288.020 [SBIT] Loaded
2022-11-10T23:18:08.021Z,1668122288.021 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2022-11-10T23:18:08.024Z,1668122288.024 [IBIT](DEBUG): Construct Initiated Built In Test.
2022-11-10T23:18:08.036Z,1668122288.036 [IBIT] Loaded
2022-11-10T23:18:08.036Z,1668122288.036 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2022-11-10T23:18:08.042Z,1668122288.042 [CBIT](DEBUG): Construct Continuous Built In Test.
2022-11-10T23:18:08.146Z,1668122288.146 [CBIT] Loaded
2022-11-10T23:18:08.146Z,1668122288.146 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2022-11-10T23:18:08.146Z,1668122288.146 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2022-11-10T23:18:08.147Z,1668122288.147 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2022-11-10T23:18:08.173Z,1668122288.173 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2022-11-10T23:18:08.180Z,1668122288.180 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2022-11-10T23:18:08.182Z,1668122288.182 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2022-11-10T23:18:08.193Z,1668122288.193 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2022-11-10T23:18:08.194Z,1668122288.194 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40BD34E0
2022-11-10T23:18:08.195Z,1668122288.195 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 1079
2022-11-10T23:18:08.199Z,1668122288.199 [Supervisor](INFO): Main Thread ID is 984
2022-11-10T23:18:08.199Z,1668122288.199 [Supervisor](DEBUG): Running supervisor.
2022-11-10T23:18:08.200Z,1668122288.200 [CommandExec ThreadHandler](INFO): Handler Thread ID is 1080
2022-11-10T23:18:08.201Z,1668122288.201 [CommandExec](INFO): Initializing the command executive.
2022-11-10T23:18:08.202Z,1668122288.202 [CommandLine ThreadHandler](INFO): Handler Thread ID is 1081
2022-11-10T23:18:08.204Z,1668122288.204 [controlThread ThreadHandler](INFO): Handler Thread ID is 1082
2022-11-10T23:18:08.205Z,1668122288.205 [controlThread](DEBUG): Initializing ControlThread
2022-11-10T23:18:08.206Z,1668122288.206 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2022-11-10T23:18:08.206Z,1668122288.206 [NavChart](DEBUG): Initialize NavChart Navigation.
2022-11-10T23:18:08.207Z,1668122288.207 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2022-11-10T23:18:08.212Z,1668122288.212 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2022-11-10T23:18:08.213Z,1668122288.213 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2022-11-10T23:18:08.214Z,1668122288.214 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2022-11-10T23:18:08.214Z,1668122288.214 [LoopControl](DEBUG): Initialize LoopControlComponent.
2022-11-10T23:18:08.215Z,1668122288.215 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2022-11-10T23:18:08.215Z,1668122288.215 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2022-11-10T23:18:08.215Z,1668122288.215 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2022-11-10T23:18:08.216Z,1668122288.216 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2022-11-10T23:18:08.216Z,1668122288.216 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2022-11-10T23:18:08.222Z,1668122288.222 [SBIT](INFO): Initialize SBIT Component.
2022-11-10T23:18:08.222Z,1668122288.222 [SBIT](IMPORTANT): git: 2022-10-11-51-g7e730fbb4
2022-11-10T23:18:08.222Z,1668122288.222 [SBIT](INFO): git hash: 7e730fbb43c13a073d28c5497927e5ede41039ea
2022-11-10T23:18:08.223Z,1668122288.223 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2022-11-10T23:18:08.224Z,1668122288.224 [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-10T23:18:08.225Z,1668122288.225 [SBIT](INFO): Beginning SBIT in 28.000000 seconds.
2022-11-10T23:18:08.226Z,1668122288.226 [IBIT](INFO): Initialize IBIT Component.
2022-11-10T23:18:08.226Z,1668122288.226 [CBIT](DEBUG): Initialize CBIT Component.
2022-11-10T23:18:08.227Z,1668122288.227 [logger ThreadHandler](INFO): Handler Thread ID is 1083
2022-11-10T23:18:08.239Z,1668122288.239 [CBIT](DEBUG): Initialized mux pins.
2022-11-10T23:18:08.239Z,1668122288.239 [CBIT](FAULT): LAST RESTART WAS UNINTENTIONAL.
2022-11-10T23:18:08.240Z,1668122288.240 [CBIT](DEBUG): Initializing the watchdog timer.
2022-11-10T23:18:08.248Z,1668122288.248 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 1084
2022-11-10T23:18:08.248Z,1668122288.248 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2022-11-10T23:18:08.253Z,1668122288.253 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 1086
2022-11-10T23:18:08.256Z,1668122288.256 [WetLabsBB2FL](INFO): Powering up
2022-11-10T23:18:08.257Z,1668122288.257 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 1088
2022-11-10T23:18:08.263Z,1668122288.263 [CBIT](CRITICAL): Watchdog Timer failed to initialize.
2022-11-10T23:18:08.263Z,1668122288.263 [CBIT] Hardware Fault, FailCount= 1
2022-11-10T23:18:08.264Z,1668122288.264 [CBIT](ERROR): Hardware Fault
2022-11-10T23:18:08.264Z,1668122288.264 [CBIT](DEBUG): Initializing heartbeat.
2022-11-10T23:18:08.265Z,1668122288.265 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 1089
2022-11-10T23:18:08.266Z,1668122288.266 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2022-11-10T23:18:08.276Z,1668122288.276 [Onboard ThreadHandler](INFO): Handler Thread ID is 1090
2022-11-10T23:18:08.293Z,1668122288.293 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 1091
2022-11-10T23:18:08.316Z,1668122288.316 [DAT ThreadHandler](INFO): Handler Thread ID is 1092
2022-11-10T23:18:08.317Z,1668122288.317 [DAT](INFO): Powering up
2022-11-10T23:18:08.317Z,1668122288.317 [DAT](DEBUG): Initializing DAT.
2022-11-10T23:18:08.320Z,1668122288.320 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 1094
2022-11-10T23:18:08.323Z,1668122288.323 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2022-11-10T23:18:08.324Z,1668122288.324 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2022-11-10T23:18:08.324Z,1668122288.324 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2022-11-10T23:18:08.324Z,1668122288.324 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2022-11-10T23:18:08.324Z,1668122288.324 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2022-11-10T23:18:08.324Z,1668122288.324 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2022-11-10T23:18:08.324Z,1668122288.324 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2022-11-10T23:18:08.325Z,1668122288.325 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2022-11-10T23:18:08.335Z,1668122288.335 [CBIT](DEBUG): Deactivating GF circuits.
2022-11-10T23:18:08.336Z,1668122288.336 [CBIT](DEBUG): Deactivating emergency mode.
2022-11-10T23:18:08.371Z,1668122288.371 [CBIT](DEBUG): Backplane powered.
2022-11-10T23:18:08.372Z,1668122288.372 [MissionManager](INFO): Loading Mission from file: Missions/Startup.xml
2022-11-10T23:18:08.385Z,1668122288.385 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2022-11-10T23:18:08.416Z,1668122288.416 [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-10T23:18:08.417Z,1668122288.417 [MissionManager](INFO): Loading Mission from file: Missions/Default.xml
2022-11-10T23:18:08.494Z,1668122288.494 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2022-11-10T23:18:08.495Z,1668122288.495 [Default:A.Wait](DEBUG): Construct Wait.
2022-11-10T23:18:08.497Z,1668122288.497 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2022-11-10T23:18:08.541Z,1668122288.541 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2022-11-10T23:18:08.543Z,1668122288.543 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2022-11-10T23:18:08.561Z,1668122288.561 [Default:E.Execute](DEBUG): Construct Execute.
2022-11-10T23:18:08.564Z,1668122288.564 [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-10T23:18:08.580Z,1668122288.580 [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-10T23:18:08.612Z,1668122288.612 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2022-11-10T23:18:08.685Z,1668122288.685 [MultiRay](INFO): Start
2022-11-10T23:18:08.685Z,1668122288.685 [MultiRay](INFO): Powering up MultiRay Lights
2022-11-10T23:18:08.700Z,1668122288.700 [Radio_Surface](INFO): Powering up
2022-11-10T23:18:08.732Z,1668122288.732 [Power24vConverter](INFO): Powering up.
2022-11-10T23:18:08.765Z,1668122288.765 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2022-11-10T23:18:08.772Z,1668122288.772 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2022-11-10T23:18:08.773Z,1668122288.773 [ElevatorServo](DEBUG): Initializing EZServoServo.
2022-11-10T23:18:08.780Z,1668122288.780 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2022-11-10T23:18:08.781Z,1668122288.781 [MassServo](DEBUG): Initializing EZServoServo.
2022-11-10T23:18:08.788Z,1668122288.788 [MassServo](DEBUG): Initializing MassServo.
2022-11-10T23:18:08.788Z,1668122288.788 [RudderServo](DEBUG): Initializing EZServoServo.
2022-11-10T23:18:08.796Z,1668122288.796 [RudderServo](DEBUG): Initializing RudderServo.
2022-11-10T23:18:08.804Z,1668122288.804 [ThrusterHE](DEBUG): Initializing EZServoServo.
2022-11-10T23:18:08.812Z,1668122288.812 [ThrusterHE](DEBUG): Initializing ThrusterHE.
2022-11-10T23:18:08.813Z,1668122288.813 [CBIT](DEBUG): Uninitialize CBIT Component.
2022-11-10T23:18:08.813Z,1668122288.813 [CBIT](DEBUG): Powering off loads.
2022-11-10T23:18:08.823Z,1668122288.823 [CBIT](DEBUG): Disabling WDT.
2022-11-10T23:18:08.835Z,1668122288.835 [CBIT](DEBUG): Opening all GF detection circuits.
2022-11-10T23:18:09.049Z,1668122289.049 [DropWeight](CRITICAL): DROP WEIGHT MISSING.

2022-11-10T23:18:09.049Z,1668122289.049 [DropWeight] Hardware Fault, FailCount= 1
2022-11-10T23:18:09.049Z,1668122289.049 [DropWeight](ERROR): Hardware Fault
2022-11-10T23:18:09.049Z,1668122289.049 [MultiRay](INFO): Starting
2022-11-10T23:18:09.049Z,1668122289.049 [MultiRay](INFO): Finished reading config
2022-11-10T23:18:09.064Z,1668122289.064 [MultiRay](IMPORTANT): Recieved MultiRay unrecognized response
2022-11-10T23:18:09.076Z,1668122289.076 [MultiRay](IMPORTANT): Recieved MultiRay unrecognized response
2022-11-10T23:18:09.076Z,1668122289.076 [MultiRay](IMPORTANT): All lights off
2022-11-10T23:18:09.400Z,1668122289.400 [MultiRay](INFO): Runnable
2022-11-10T23:18:09.727Z,1668122289.727 [RudderServo](ERROR): Rudder initialization uart error serial timeout
2022-11-10T23:18:09.728Z,1668122289.728 [RudderServo](FAULT): Rudder failed to initialize
2022-11-10T23:18:09.728Z,1668122289.728 [RudderServo] Communications Fault, FailCount= 1
2022-11-10T23:18:09.728Z,1668122289.728 [RudderServo](ERROR): Communications Fault
2022-11-10T23:18:09.824Z,1668122289.824 [MultiRay](INFO): Pause
2022-11-10T23:18:10.419Z,1668122290.419 [BuoyancyServo](ERROR): Buoyancy initialization uart error serial timeout
2022-11-10T23:18:10.419Z,1668122290.419 [BuoyancyServo](FAULT): Buoyancy failed to initialize
2022-11-10T23:18:10.420Z,1668122290.420 [BuoyancyServo] Communications Fault, FailCount= 1
2022-11-10T23:18:10.420Z,1668122290.420 [BuoyancyServo](ERROR): Communications Fault
2022-11-10T23:18:10.731Z,1668122290.731 [ElevatorServo](ERROR): Elevator initialization uart error I:serial timeout
2022-11-10T23:18:10.731Z,1668122290.731 [ElevatorServo](FAULT): Elevator failed to initialize
2022-11-10T23:18:10.732Z,1668122290.732 [ElevatorServo] Communications Fault, FailCount= 1
2022-11-10T23:18:10.732Z,1668122290.732 [ElevatorServo](ERROR): Communications Fault
2022-11-10T23:18:10.733Z,1668122290.733 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2022-11-10T23:18:10.733Z,1668122290.733 [RudderServo](INFO): Powering down
2022-11-10T23:18:10.789Z,1668122290.789 [MultiRay](INFO): Paused
2022-11-10T23:18:10.809Z,1668122290.809 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2022-11-10T23:18:10.810Z,1668122290.810 [ElevatorServo](INFO): Powering down
2022-11-10T23:18:10.820Z,1668122290.820 [RudderServo](FAULT): LCB fault:  Current Limiter Activated.
2022-11-10T23:18:10.821Z,1668122290.821 [RudderServo] Hardware Fault, FailCount= 1
2022-11-10T23:18:10.821Z,1668122290.821 [RudderServo](ERROR): Hardware Fault
2022-11-10T23:18:10.821Z,1668122290.821 [ThrusterHE](FAULT): Thruster failed to initialize
2022-11-10T23:18:10.821Z,1668122290.821 [ThrusterHE] Communications Fault, FailCount= 1
2022-11-10T23:18:10.821Z,1668122290.821 [ThrusterHE](ERROR): Communications Fault
2022-11-10T23:18:11.152Z,1668122291.152 [MultiRay](INFO): Paused
2022-11-10T23:18:11.167Z,1668122291.167 [ElevatorServo](FAULT): LCB fault:  Current Limiter Activated.
2022-11-10T23:18:11.167Z,1668122291.167 [ElevatorServo] Hardware Fault, FailCount= 1
2022-11-10T23:18:11.167Z,1668122291.167 [ElevatorServo](ERROR): Hardware Fault
2022-11-10T23:18:11.168Z,1668122291.168 [RudderServo](DEBUG): Initializing EZServoServo.
2022-11-10T23:18:11.288Z,1668122291.288 [RudderServo](DEBUG): Initializing RudderServo.
2022-11-10T23:18:11.289Z,1668122291.289 [ThrusterHE](DEBUG): Uninitialize Thruster Servo.
2022-11-10T23:18:11.289Z,1668122291.289 [ThrusterHE](INFO): Powering down
2022-11-10T23:18:11.556Z,1668122291.556 [MultiRay](INFO): Paused
2022-11-10T23:18:11.571Z,1668122291.571 [ElevatorServo](DEBUG): Initializing EZServoServo.
2022-11-10T23:18:11.692Z,1668122291.692 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2022-11-10T23:18:12.283Z,1668122292.283 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T23:18:12.289Z,1668122292.289 [MultiRay](INFO): Paused
2022-11-10T23:18:12.627Z,1668122292.627 [MassServo](FAULT): Mass shifter EEPROM initialization uart error serial timeout
2022-11-10T23:18:12.627Z,1668122292.627 [MassServo] Communications Fault, FailCount= 1
2022-11-10T23:18:12.627Z,1668122292.627 [MassServo](ERROR): Communications Fault
2022-11-10T23:18:13.079Z,1668122293.079 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T23:18:13.084Z,1668122293.084 [MultiRay](INFO): Paused
2022-11-10T23:18:13.127Z,1668122293.127 [MassServo](DEBUG): Uninitialize Mass Servo.
2022-11-10T23:18:13.127Z,1668122293.127 [MassServo](INFO): Powering down
2022-11-10T23:18:13.507Z,1668122293.507 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T23:18:13.512Z,1668122293.512 [MultiRay](INFO): Paused
2022-11-10T23:18:13.547Z,1668122293.547 [WetLabsBB2FL] Communications Fault, FailCount= 1
2022-11-10T23:18:13.547Z,1668122293.547 [WetLabsBB2FL](ERROR): Communications Fault
2022-11-10T23:18:13.560Z,1668122293.560 [MassServo](FAULT): LCB fault:  Current Limiter Activated.
2022-11-10T23:18:13.561Z,1668122293.561 [MassServo] Hardware Fault, FailCount= 1
2022-11-10T23:18:13.561Z,1668122293.561 [MassServo](ERROR): Hardware Fault
2022-11-10T23:18:13.943Z,1668122293.943 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T23:18:13.948Z,1668122293.948 [MultiRay](INFO): Paused
2022-11-10T23:18:13.979Z,1668122293.979 [MassServo](DEBUG): Initializing EZServoServo.
2022-11-10T23:18:14.047Z,1668122294.047 [WetLabsBB2FL](INFO): Powering down
2022-11-10T23:18:14.100Z,1668122294.100 [MassServo](DEBUG): Initializing MassServo.
2022-11-10T23:18:14.443Z,1668122294.443 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T23:18:14.448Z,1668122294.448 [MultiRay](INFO): Paused
2022-11-10T23:18:14.452Z,1668122294.452 [WetLabsBB2FL](FAULT): LCB fault:  Current Limiter Activated.
2022-11-10T23:18:14.452Z,1668122294.452 [WetLabsBB2FL] Hardware Fault, FailCount= 1
2022-11-10T23:18:14.452Z,1668122294.452 [WetLabsBB2FL](ERROR): Hardware Fault
2022-11-10T23:18:14.875Z,1668122294.875 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T23:18:14.880Z,1668122294.880 [MultiRay](INFO): Paused
2022-11-10T23:18:15.283Z,1668122295.283 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T23:18:15.296Z,1668122295.296 [MultiRay](INFO): Paused
2022-11-10T23:18:15.715Z,1668122295.715 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T23:18:15.720Z,1668122295.720 [MultiRay](INFO): Paused
2022-11-10T23:18:16.143Z,1668122296.143 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T23:18:16.148Z,1668122296.148 [MultiRay](INFO): Paused
2022-11-10T23:18:16.575Z,1668122296.575 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T23:18:16.580Z,1668122296.580 [MultiRay](INFO): Paused
2022-11-10T23:18:16.999Z,1668122296.999 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T23:18:17.004Z,1668122297.004 [MultiRay](INFO): Paused
2022-11-10T23:18:17.419Z,1668122297.419 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T23:18:17.424Z,1668122297.424 [MultiRay](INFO): Paused
2022-11-10T23:18:17.831Z,1668122297.831 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T23:18:17.836Z,1668122297.836 [MultiRay](INFO): Paused
2022-11-10T23:18:18.247Z,1668122298.247 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T23:18:18.252Z,1668122298.252 [MultiRay](INFO): Paused
2022-11-10T23:18:18.659Z,1668122298.659 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T23:18:18.665Z,1668122298.665 [MultiRay](INFO): Paused
2022-11-10T23:18:19.079Z,1668122299.079 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T23:18:19.084Z,1668122299.084 [MultiRay](INFO): Paused
2022-11-10T23:18:19.503Z,1668122299.503 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T23:18:19.508Z,1668122299.508 [MultiRay](INFO): Paused
2022-11-10T23:18:19.919Z,1668122299.919 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T23:18:19.924Z,1668122299.924 [MultiRay](INFO): Paused
2022-11-10T23:18:20.339Z,1668122300.339 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T23:18:20.344Z,1668122300.344 [MultiRay](INFO): Paused
2022-11-10T23:18:20.779Z,1668122300.779 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T23:18:20.785Z,1668122300.785 [MultiRay](INFO): Paused
2022-11-10T23:18:21.199Z,1668122301.199 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T23:18:21.205Z,1668122301.205 [MultiRay](INFO): Paused
2022-11-10T23:18:21.300Z,1668122301.300 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2022-11-10T23:18:21.300Z,1668122301.300 [CTD_Seabird] Communications Fault, FailCount= 1
2022-11-10T23:18:21.300Z,1668122301.300 [CTD_Seabird](ERROR): Communications Fault
2022-11-10T23:18:21.615Z,1668122301.615 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-11-10T23:18:21.615Z,1668122301.615 [AHRS_M2](FAULT): Failed to initialize within timeout.
2022-11-10T23:18:21.616Z,1668122301.616 [AHRS_M2] Communications Fault, FailCount= 1
2022-11-10T23:18:21.616Z,1668122301.616 [AHRS_M2](ERROR): Communications Fault
2022-11-10T23:18:21.624Z,1668122301.624 [MultiRay](INFO): Paused
2022-11-10T23:18:21.704Z,1668122301.704 [CTD_Seabird](INFO): Powering down
2022-11-10T23:18:21.720Z,1668122301.720 [AHRS_M2](INFO): Powering down
2022-11-10T23:18:21.797Z,1668122301.797 [MultiRay](INFO): Paused
2022-11-10T23:18:22.056Z,1668122302.056 [MultiRay](INFO): Paused
2022-11-10T23:18:22.240Z,1668122302.240 [CTD_Seabird](FAULT): LCB fault:  Hardware Overcurrent Shutdown. Current Limiter Activated.
2022-11-10T23:18:22.240Z,1668122302.240 [CTD_Seabird] Hardware Fault, FailCount= 1
2022-11-10T23:18:22.240Z,1668122302.240 [CTD_Seabird](ERROR): Hardware Fault
2022-11-10T23:18:22.460Z,1668122302.460 [MultiRay](INFO): Paused
2022-11-10T23:18:22.864Z,1668122302.864 [MultiRay](INFO): Paused
2022-11-10T23:18:23.268Z,1668122303.268 [MultiRay](INFO): Paused
2022-11-10T23:18:23.672Z,1668122303.672 [MultiRay](INFO): Paused
2022-11-10T23:18:24.076Z,1668122304.076 [MultiRay](INFO): Paused
2022-11-10T23:18:24.500Z,1668122304.500 [MultiRay](INFO): Paused
2022-11-10T23:18:24.884Z,1668122304.884 [MultiRay](INFO): Paused
2022-11-10T23:18:25.288Z,1668122305.288 [MultiRay](INFO): Paused
2022-11-10T23:18:25.692Z,1668122305.692 [MultiRay](INFO): Paused
2022-11-10T23:18:26.100Z,1668122306.100 [MultiRay](INFO): Paused
2022-11-10T23:18:26.509Z,1668122306.509 [MultiRay](INFO): Paused
2022-11-10T23:18:26.904Z,1668122306.904 [MultiRay](INFO): Paused
2022-11-10T23:18:27.308Z,1668122307.308 [MultiRay](INFO): Paused
2022-11-10T23:18:27.712Z,1668122307.712 [MultiRay](INFO): Paused
2022-11-10T23:18:28.112Z,1668122308.112 [MultiRay](INFO): Paused
2022-11-10T23:18:28.520Z,1668122308.520 [MultiRay](INFO): Paused
2022-11-10T23:18:28.924Z,1668122308.924 [MultiRay](INFO): Paused
2022-11-10T23:18:29.328Z,1668122309.328 [MultiRay](INFO): Paused
2022-11-10T23:18:29.732Z,1668122309.732 [MultiRay](INFO): Paused
2022-11-10T23:18:30.141Z,1668122310.141 [MultiRay](INFO): Paused
2022-11-10T23:18:30.540Z,1668122310.540 [MultiRay](INFO): Paused
2022-11-10T23:18:30.944Z,1668122310.944 [MultiRay](INFO): Paused
2022-11-10T23:18:31.348Z,1668122311.348 [MultiRay](INFO): Paused
2022-11-10T23:18:31.752Z,1668122311.752 [MultiRay](INFO): Paused
2022-11-10T23:18:32.156Z,1668122312.156 [MultiRay](INFO): Paused
2022-11-10T23:18:32.560Z,1668122312.560 [MultiRay](INFO): Paused
2022-11-10T23:18:32.964Z,1668122312.964 [MultiRay](INFO): Paused
2022-11-10T23:18:33.372Z,1668122313.372 [MultiRay](INFO): Paused
2022-11-10T23:18:33.796Z,1668122313.796 [MultiRay](INFO): Paused
2022-11-10T23:18:34.172Z,1668122314.172 [MultiRay](INFO): Paused
2022-11-10T23:18:34.580Z,1668122314.580 [MultiRay](INFO): Paused
2022-11-10T23:18:34.988Z,1668122314.988 [MultiRay](INFO): Paused
2022-11-10T23:18:35.388Z,1668122315.388 [MultiRay](INFO): Paused
2022-11-10T23:18:35.792Z,1668122315.792 [MultiRay](INFO): Paused
2022-11-10T23:18:36.196Z,1668122316.196 [MultiRay](INFO): Paused
2022-11-10T23:18:36.600Z,1668122316.600 [MultiRay](INFO): Paused
2022-11-10T23:18:37.012Z,1668122317.012 [MultiRay](INFO): Paused
2022-11-10T23:18:37.047Z,1668122317.047 [SBIT](IMPORTANT): Beginning Startup BIT
2022-11-10T23:18:37.408Z,1668122317.408 [MultiRay](INFO): Paused
2022-11-10T23:18:37.832Z,1668122317.832 [MultiRay](INFO): Paused
2022-11-10T23:18:37.833Z,1668122317.833 [NAL9602](INFO): Powering up NAL9602
2022-11-10T23:18:38.220Z,1668122318.220 [MultiRay](INFO): Paused
2022-11-10T23:18:38.620Z,1668122318.620 [MultiRay](INFO): Paused
2022-11-10T23:18:39.032Z,1668122319.032 [MultiRay](INFO): Paused
2022-11-10T23:18:39.428Z,1668122319.428 [MultiRay](INFO): Paused
2022-11-10T23:18:39.832Z,1668122319.832 [MultiRay](INFO): Paused
2022-11-10T23:18:40.236Z,1668122320.236 [MultiRay](INFO): Paused
2022-11-10T23:18:40.640Z,1668122320.640 [MultiRay](INFO): Paused
2022-11-10T23:18:41.048Z,1668122321.048 [MultiRay](INFO): Paused
2022-11-10T23:18:41.448Z,1668122321.448 [MultiRay](INFO): Paused
2022-11-10T23:18:41.852Z,1668122321.852 [MultiRay](INFO): Paused
2022-11-10T23:18:42.256Z,1668122322.256 [MultiRay](INFO): Paused
2022-11-10T23:18:42.660Z,1668122322.660 [MultiRay](INFO): Paused
2022-11-10T23:18:43.064Z,1668122323.064 [MultiRay](INFO): Paused
2022-11-10T23:18:43.468Z,1668122323.468 [MultiRay](INFO): Paused
2022-11-10T23:18:43.872Z,1668122323.872 [MultiRay](INFO): Paused
2022-11-10T23:18:44.276Z,1668122324.276 [MultiRay](INFO): Paused
2022-11-10T23:18:44.688Z,1668122324.688 [MultiRay](INFO): Paused
2022-11-10T23:18:45.078Z,1668122325.078 [MultiRay](INFO): Paused
2022-11-10T23:18:45.488Z,1668122325.488 [MultiRay](INFO): Paused
2022-11-10T23:18:45.892Z,1668122325.892 [MultiRay](INFO): Paused
2022-11-10T23:18:46.298Z,1668122326.298 [MultiRay](INFO): Paused
2022-11-10T23:18:46.700Z,1668122326.700 [MultiRay](INFO): Paused
2022-11-10T23:18:47.104Z,1668122327.104 [MultiRay](INFO): Paused
2022-11-10T23:18:47.508Z,1668122327.508 [MultiRay](INFO): Paused
2022-11-10T23:18:47.917Z,1668122327.917 [MultiRay](INFO): Paused
2022-11-10T23:18:48.340Z,1668122328.340 [MultiRay](INFO): Paused
2022-11-10T23:18:48.720Z,1668122328.720 [MultiRay](INFO): Paused
2022-11-10T23:18:49.124Z,1668122329.124 [MultiRay](INFO): Paused
2022-11-10T23:18:49.536Z,1668122329.536 [MultiRay](INFO): Paused
2022-11-10T23:18:49.932Z,1668122329.932 [MultiRay](INFO): Paused
2022-11-10T23:18:50.336Z,1668122330.336 [MultiRay](INFO): Paused
2022-11-10T23:18:50.369Z,1668122330.369 [SBIT](ERROR): Could not read elevatorAngleReader_.
2022-11-10T23:18:50.370Z,1668122330.370 [SBIT](ERROR): Could not read rudderAngleReader_.
2022-11-10T23:18:50.370Z,1668122330.370 [SBIT](ERROR): Could not read massPosReader_.
2022-11-10T23:18:50.740Z,1668122330.740 [MultiRay](INFO): Paused
2022-11-10T23:18:51.141Z,1668122331.141 [MultiRay](INFO): Paused
2022-11-10T23:18:51.548Z,1668122331.548 [MultiRay](INFO): Paused
2022-11-10T23:18:51.953Z,1668122331.953 [MultiRay](INFO): Paused
2022-11-10T23:18:52.358Z,1668122332.358 [MultiRay](INFO): Paused
2022-11-10T23:18:52.760Z,1668122332.760 [MultiRay](INFO): Paused
2022-11-10T23:18:53.159Z,1668122333.159 [MultiRay](INFO): Paused
2022-11-10T23:18:53.569Z,1668122333.569 [MultiRay](INFO): Paused
2022-11-10T23:18:53.976Z,1668122333.976 [MultiRay](INFO): Paused
2022-11-10T23:18:54.371Z,1668122334.371 [MultiRay](INFO): Paused
2022-11-10T23:18:54.785Z,1668122334.785 [MultiRay](INFO): Paused
2022-11-10T23:18:55.188Z,1668122335.188 [MultiRay](INFO): Paused
2022-11-10T23:18:55.589Z,1668122335.589 [MultiRay](INFO): Paused
2022-11-10T23:18:55.996Z,1668122335.996 [MultiRay](INFO): Paused
2022-11-10T23:18:56.400Z,1668122336.400 [MultiRay](INFO): Paused
2022-11-10T23:18:56.801Z,1668122336.801 [MultiRay](INFO): Paused
2022-11-10T23:18:57.205Z,1668122337.205 [MultiRay](INFO): Paused
2022-11-10T23:18:57.612Z,1668122337.612 [MultiRay](INFO): Paused
2022-11-10T23:18:58.014Z,1668122338.014 [MultiRay](INFO): Paused
2022-11-10T23:18:58.417Z,1668122338.417 [MultiRay](INFO): Paused
2022-11-10T23:18:58.418Z,1668122338.418 [NAL9602](ERROR): NAL9602 initialization error.
2022-11-10T23:18:58.418Z,1668122338.418 [NAL9602] Communications Fault, FailCount= 1
2022-11-10T23:18:58.418Z,1668122338.418 [NAL9602](ERROR): Communications Fault
2022-11-10T23:18:58.884Z,1668122338.884 [MultiRay](INFO): Paused
2022-11-10T23:18:58.885Z,1668122338.885 [NAL9602](INFO): Powering down
2022-11-10T23:18:59.228Z,1668122339.228 [MultiRay](INFO): Paused
2022-11-10T23:18:59.629Z,1668122339.629 [MultiRay](INFO): Paused
2022-11-10T23:19:00.033Z,1668122340.033 [MultiRay](INFO): Paused
2022-11-10T23:19:00.437Z,1668122340.437 [MultiRay](INFO): Paused
2022-11-10T23:19:00.844Z,1668122340.844 [MultiRay](INFO): Paused
2022-11-10T23:19:01.246Z,1668122341.246 [MultiRay](INFO): Paused
2022-11-10T23:19:01.651Z,1668122341.651 [MultiRay](INFO): Paused
2022-11-10T23:19:02.056Z,1668122342.056 [MultiRay](INFO): Paused
2022-11-10T23:19:02.457Z,1668122342.457 [MultiRay](INFO): Paused
2022-11-10T23:19:02.855Z,1668122342.855 [MultiRay](INFO): Paused
2022-11-10T23:19:03.263Z,1668122343.263 [MultiRay](INFO): Paused
2022-11-10T23:19:03.672Z,1668122343.672 [MultiRay](INFO): Paused
2022-11-10T23:19:04.073Z,1668122344.073 [MultiRay](INFO): Paused
2022-11-10T23:19:04.480Z,1668122344.480 [MultiRay](INFO): Paused
2022-11-10T23:19:04.884Z,1668122344.884 [MultiRay](INFO): Paused
2022-11-10T23:19:05.201Z,1668122345.201 [CommandExec](IMPORTANT): got command show stack
2022-11-10T23:19:05.201Z,1668122345.201 [CommandExec](IMPORTANT): Behavior Stack:

2022-11-10T23:19:05.201Z,1668122345.201 [MissionManager](IMPORTANT): Mission loaded, but not running.
2022-11-10T23:19:05.288Z,1668122345.288 [MultiRay](INFO): Paused
2022-11-10T23:19:05.689Z,1668122345.689 [MultiRay](INFO): Paused
2022-11-10T23:19:06.096Z,1668122346.096 [MultiRay](INFO): Paused
2022-11-10T23:19:06.498Z,1668122346.498 [MultiRay](INFO): Paused
2022-11-10T23:19:06.906Z,1668122346.906 [MultiRay](INFO): Paused
2022-11-10T23:19:07.302Z,1668122347.302 [MultiRay](INFO): Paused
2022-11-10T23:19:07.709Z,1668122347.709 [MultiRay](INFO): Paused
2022-11-10T23:19:08.117Z,1668122348.117 [MultiRay](INFO): Paused
2022-11-10T23:19:08.524Z,1668122348.524 [MultiRay](INFO): Paused
2022-11-10T23:19:08.568Z,1668122348.568 [DAT](FAULT): failed to initialize, no bytes available on serial interface
2022-11-10T23:19:08.568Z,1668122348.568 [DAT] Communications Fault, FailCount= 1
2022-11-10T23:19:08.568Z,1668122348.568 [DAT](ERROR): Communications Fault
2022-11-10T23:19:08.924Z,1668122348.924 [MultiRay](INFO): Paused
2022-11-10T23:19:08.971Z,1668122348.971 [DAT](INFO): Powering down
2022-11-10T23:19:09.354Z,1668122349.354 [MultiRay](INFO): Paused
2022-11-10T23:19:09.448Z,1668122349.448 [DAT](FAULT): LCB fault:  Hardware Overcurrent Shutdown. Current Limiter Activated.
2022-11-10T23:19:09.448Z,1668122349.448 [DAT] Hardware Fault, FailCount= 1
2022-11-10T23:19:09.448Z,1668122349.448 [DAT](ERROR): Hardware Fault
2022-11-10T23:19:09.756Z,1668122349.756 [MultiRay](INFO): Paused
2022-11-10T23:19:10.136Z,1668122350.136 [MultiRay](INFO): Paused
2022-11-10T23:19:10.540Z,1668122350.540 [MultiRay](INFO): Paused
2022-11-10T23:19:10.942Z,1668122350.942 [MultiRay](INFO): Paused
2022-11-10T23:19:11.348Z,1668122351.348 [MultiRay](INFO): Paused
2022-11-10T23:19:11.749Z,1668122351.749 [MultiRay](INFO): Paused
2022-11-10T23:19:12.154Z,1668122352.154 [MultiRay](INFO): Paused
2022-11-10T23:19:12.558Z,1668122352.558 [MultiRay](INFO): Paused
2022-11-10T23:19:12.964Z,1668122352.964 [MultiRay](INFO): Paused
2022-11-10T23:19:13.376Z,1668122353.376 [MultiRay](INFO): Paused
2022-11-10T23:19:13.773Z,1668122353.773 [MultiRay](INFO): Paused
2022-11-10T23:19:14.174Z,1668122354.174 [MultiRay](INFO): Paused
2022-11-10T23:19:14.580Z,1668122354.580 [MultiRay](INFO): Paused
2022-11-10T23:19:15.012Z,1668122355.012 [MultiRay](INFO): Paused
2022-11-10T23:19:15.417Z,1668122355.417 [MultiRay](INFO): Paused
2022-11-10T23:19:15.817Z,1668122355.817 [MultiRay](INFO): Paused
2022-11-10T23:19:16.221Z,1668122356.221 [MultiRay](INFO): Paused
2022-11-10T23:19:16.598Z,1668122356.598 [MultiRay](INFO): Paused
2022-11-10T23:19:17.007Z,1668122357.007 [MultiRay](INFO): Paused
2022-11-10T23:19:17.017Z,1668122357.017 [SBIT](ERROR): Could not read elevatorAngleReader_.
2022-11-10T23:19:17.017Z,1668122357.017 [SBIT](ERROR): Could not read rudderAngleReader_.
2022-11-10T23:19:17.017Z,1668122357.017 [SBIT](ERROR): Could not read massPosReader_.
2022-11-10T23:19:17.017Z,1668122357.017 [SBIT](FAULT): Control surface position failure.
2022-11-10T23:19:17.408Z,1668122357.408 [MultiRay](INFO): Paused
2022-11-10T23:19:17.810Z,1668122357.810 [MultiRay](INFO): Paused
2022-11-10T23:19:18.216Z,1668122358.216 [MultiRay](INFO): Paused
2022-11-10T23:19:18.614Z,1668122358.614 [MultiRay](INFO): Paused
2022-11-10T23:19:19.022Z,1668122359.022 [MultiRay](INFO): Paused
2022-11-10T23:19:19.426Z,1668122359.426 [MultiRay](INFO): Paused
2022-11-10T23:19:19.823Z,1668122359.823 [MultiRay](INFO): Paused
2022-11-10T23:19:20.236Z,1668122360.236 [MultiRay](INFO): Paused
2022-11-10T23:19:20.640Z,1668122360.640 [MultiRay](INFO): Paused
2022-11-10T23:19:21.042Z,1668122361.042 [MultiRay](INFO): Paused
2022-11-10T23:19:21.448Z,1668122361.448 [MultiRay](INFO): Paused
2022-11-10T23:19:21.849Z,1668122361.849 [MultiRay](INFO): Paused
2022-11-10T23:19:22.254Z,1668122362.254 [MultiRay](INFO): Paused
2022-11-10T23:19:22.658Z,1668122362.658 [MultiRay](INFO): Paused
2022-11-10T23:19:23.064Z,1668122363.064 [MultiRay](INFO): Paused
2022-11-10T23:19:23.468Z,1668122363.468 [MultiRay](INFO): Paused
2022-11-10T23:19:23.872Z,1668122363.872 [MultiRay](INFO): Paused
2022-11-10T23:19:24.274Z,1668122364.274 [MultiRay](INFO): Paused
2022-11-10T23:19:24.678Z,1668122364.678 [MultiRay](INFO): Paused
2022-11-10T23:19:25.088Z,1668122365.088 [MultiRay](INFO): Paused
2022-11-10T23:19:25.488Z,1668122365.488 [MultiRay](INFO): Paused
2022-11-10T23:19:25.890Z,1668122365.890 [MultiRay](INFO): Paused
2022-11-10T23:19:26.296Z,1668122366.296 [MultiRay](INFO): Paused
2022-11-10T23:19:26.704Z,1668122366.704 [MultiRay](INFO): Paused
2022-11-10T23:19:27.209Z,1668122367.209 [MultiRay](INFO): Paused
2022-11-10T23:19:27.519Z,1668122367.519 [MultiRay](INFO): Paused
2022-11-10T23:19:27.936Z,1668122367.936 [MultiRay](INFO): Paused
2022-11-10T23:19:28.346Z,1668122368.346 [MultiRay](INFO): Paused
2022-11-10T23:19:28.718Z,1668122368.718 [MultiRay](INFO): Paused
2022-11-10T23:19:29.122Z,1668122369.122 [MultiRay](INFO): Paused
2022-11-10T23:19:29.526Z,1668122369.526 [MultiRay](INFO): Paused
2022-11-10T23:19:29.932Z,1668122369.932 [MultiRay](INFO): Paused
2022-11-10T23:19:30.335Z,1668122370.335 [MultiRay](INFO): Paused
2022-11-10T23:19:30.738Z,1668122370.738 [MultiRay](INFO): Paused
2022-11-10T23:19:30.764Z,1668122370.764 [SBIT](ERROR): Could not read elevatorAngleReader_.
2022-11-10T23:19:30.764Z,1668122370.764 [SBIT](ERROR): Could not read rudderAngleReader_.
2022-11-10T23:19:30.764Z,1668122370.764 [SBIT](ERROR): Could not read massPosReader_.
2022-11-10T23:19:30.764Z,1668122370.764 [SBIT](FAULT): Control surface position failure.
2022-11-10T23:19:31.144Z,1668122371.144 [MultiRay](INFO): Paused
2022-11-10T23:19:31.154Z,1668122371.154 [SBIT](CRITICAL): SBIT FAILED
2022-11-10T23:19:31.154Z,1668122371.154 [SBIT](FAULT): Ignoring configuration overrides from Data/persisted.cfg
2022-11-10T23:19:31.548Z,1668122371.548 [MultiRay](INFO): Paused
2022-11-10T23:19:31.554Z,1668122371.554 [MissionManager](IMPORTANT): Started mission Startup
2022-11-10T23:19:31.554Z,1668122371.554 [Startup] Running Loop=1
2022-11-10T23:19:31.554Z,1668122371.554 [Startup](DEBUG): Aggregate::initialize Startup
2022-11-10T23:19:31.554Z,1668122371.554 [Startup:A.GoToSurface] Running Loop=1
2022-11-10T23:19:31.554Z,1668122371.554 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2022-11-10T23:19:31.555Z,1668122371.555 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2022-11-10T23:19:31.555Z,1668122371.555 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2022-11-10T23:19:31.556Z,1668122371.556 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2022-11-10T23:19:31.556Z,1668122371.556 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2022-11-10T23:19:31.556Z,1668122371.556 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2022-11-10T23:19:31.558Z,1668122371.558 [Startup:StartupSatComms] Running Loop=1
2022-11-10T23:19:31.558Z,1668122371.558 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2022-11-10T23:19:31.558Z,1668122371.558 [Startup:StartupSatComms:A] Running Loop=1
2022-11-10T23:19:31.952Z,1668122371.952 [MultiRay](INFO): Paused
2022-11-10T23:19:31.958Z,1668122371.958 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2022-11-10T23:19:32.356Z,1668122372.356 [MultiRay](INFO): Paused
2022-11-10T23:19:32.758Z,1668122372.758 [MultiRay](INFO): Paused
2022-11-10T23:19:33.155Z,1668122373.155 [MultiRay](INFO): Paused
2022-11-10T23:19:33.568Z,1668122373.568 [MultiRay](INFO): Paused
2022-11-10T23:19:33.972Z,1668122373.972 [MultiRay](INFO): Paused
2022-11-10T23:19:34.374Z,1668122374.374 [MultiRay](INFO): Paused
2022-11-10T23:19:34.780Z,1668122374.780 [MultiRay](INFO): Paused
2022-11-10T23:19:35.189Z,1668122375.189 [MultiRay](INFO): Paused
2022-11-10T23:19:35.588Z,1668122375.588 [MultiRay](INFO): Paused
2022-11-10T23:19:35.990Z,1668122375.990 [MultiRay](INFO): Paused
2022-11-10T23:19:36.396Z,1668122376.396 [MultiRay](INFO): Paused
2022-11-10T23:19:36.798Z,1668122376.798 [MultiRay](INFO): Paused
2022-11-10T23:19:37.206Z,1668122377.206 [MultiRay](INFO): Paused
2022-11-10T23:19:37.608Z,1668122377.608 [MultiRay](INFO): Paused
2022-11-10T23:19:38.010Z,1668122378.010 [MultiRay](INFO): Paused
2022-11-10T23:19:38.417Z,1668122378.417 [MultiRay](INFO): Paused
2022-11-10T23:19:38.823Z,1668122378.823 [MultiRay](INFO): Paused
2022-11-10T23:19:39.276Z,1668122379.276 [MultiRay](INFO): Paused
2022-11-10T23:19:39.699Z,1668122379.699 [MultiRay](INFO): Paused
2022-11-10T23:19:40.048Z,1668122380.048 [MultiRay](INFO): Paused
2022-11-10T23:19:40.468Z,1668122380.468 [MultiRay](INFO): Paused
2022-11-10T23:19:40.852Z,1668122380.852 [MultiRay](INFO): Paused
2022-11-10T23:19:41.240Z,1668122381.240 [MultiRay](INFO): Paused
2022-11-10T23:19:41.647Z,1668122381.647 [MultiRay](INFO): Paused
2022-11-10T23:19:42.052Z,1668122382.052 [MultiRay](INFO): Paused
2022-11-10T23:19:42.454Z,1668122382.454 [MultiRay](INFO): Paused
2022-11-10T23:19:42.858Z,1668122382.858 [MultiRay](INFO): Paused
2022-11-10T23:19:43.264Z,1668122383.264 [MultiRay](INFO): Paused
2022-11-10T23:19:43.672Z,1668122383.672 [MultiRay](INFO): Paused
2022-11-10T23:19:44.070Z,1668122384.070 [MultiRay](INFO): Paused
2022-11-10T23:19:44.474Z,1668122384.474 [MultiRay](INFO): Paused
2022-11-10T23:19:44.880Z,1668122384.880 [MultiRay](INFO): Paused
2022-11-10T23:19:45.282Z,1668122385.282 [MultiRay](INFO): Paused
2022-11-10T23:19:45.690Z,1668122385.690 [MultiRay](INFO): Paused
2022-11-10T23:19:46.086Z,1668122386.086 [MultiRay](INFO): Paused
2022-11-10T23:19:46.494Z,1668122386.494 [MultiRay](INFO): Paused
2022-11-10T23:19:46.900Z,1668122386.900 [MultiRay](INFO): Paused
2022-11-10T23:19:47.303Z,1668122387.303 [MultiRay](INFO): Paused
2022-11-10T23:19:47.706Z,1668122387.706 [MultiRay](INFO): Paused
2022-11-10T23:19:48.110Z,1668122388.110 [MultiRay](INFO): Paused
2022-11-10T23:19:48.517Z,1668122388.517 [MultiRay](INFO): Paused
2022-11-10T23:19:48.920Z,1668122388.920 [MultiRay](INFO): Paused
2022-11-10T23:19:49.324Z,1668122389.324 [MultiRay](INFO): Paused
2022-11-10T23:19:49.728Z,1668122389.728 [MultiRay](INFO): Paused
2022-11-10T23:19:50.132Z,1668122390.132 [MultiRay](INFO): Paused
2022-11-10T23:19:50.536Z,1668122390.536 [MultiRay](INFO): Paused
2022-11-10T23:19:50.940Z,1668122390.940 [MultiRay](INFO): Paused
2022-11-10T23:19:51.342Z,1668122391.342 [MultiRay](INFO): Paused
2022-11-10T23:19:51.848Z,1668122391.848 [MultiRay](INFO): Paused
2022-11-10T23:19:52.163Z,1668122392.163 [MultiRay](INFO): Paused
2022-11-10T23:19:52.576Z,1668122392.576 [MultiRay](INFO): Paused
2022-11-10T23:19:52.981Z,1668122392.981 [MultiRay](INFO): Paused
2022-11-10T23:19:53.381Z,1668122393.381 [MultiRay](INFO): Paused
2022-11-10T23:19:53.762Z,1668122393.762 [MultiRay](INFO): Paused
2022-11-10T23:19:54.174Z,1668122394.174 [MultiRay](INFO): Paused
2022-11-10T23:19:54.574Z,1668122394.574 [MultiRay](INFO): Paused
2022-11-10T23:19:54.972Z,1668122394.972 [MultiRay](INFO): Paused
2022-11-10T23:19:55.385Z,1668122395.385 [MultiRay](INFO): Paused
2022-11-10T23:19:55.787Z,1668122395.787 [MultiRay](INFO): Paused
2022-11-10T23:19:56.190Z,1668122396.190 [MultiRay](INFO): Paused
2022-11-10T23:19:56.594Z,1668122396.594 [MultiRay](INFO): Paused
2022-11-10T23:19:57.000Z,1668122397.000 [MultiRay](INFO): Paused
2022-11-10T23:19:57.404Z,1668122397.404 [MultiRay](INFO): Paused
2022-11-10T23:19:57.810Z,1668122397.810 [MultiRay](INFO): Paused
2022-11-10T23:19:58.210Z,1668122398.210 [MultiRay](INFO): Paused
2022-11-10T23:19:58.614Z,1668122398.614 [MultiRay](INFO): Paused
2022-11-10T23:19:59.020Z,1668122399.020 [MultiRay](INFO): Paused
2022-11-10T23:19:59.422Z,1668122399.422 [MultiRay](INFO): Paused
2022-11-10T23:19:59.826Z,1668122399.826 [MultiRay](INFO): Paused
2022-11-10T23:20:00.232Z,1668122400.232 [MultiRay](INFO): Paused
2022-11-10T23:20:00.632Z,1668122400.632 [MultiRay](INFO): Paused
2022-11-10T23:20:01.038Z,1668122401.038 [MultiRay](INFO): Paused
2022-11-10T23:20:01.442Z,1668122401.442 [MultiRay](INFO): Paused
2022-11-10T23:20:01.848Z,1668122401.848 [MultiRay](INFO): Paused
2022-11-10T23:20:02.252Z,1668122402.252 [MultiRay](INFO): Paused
2022-11-10T23:20:02.656Z,1668122402.656 [MultiRay](INFO): Paused
2022-11-10T23:20:03.058Z,1668122403.058 [MultiRay](INFO): Paused
2022-11-10T23:20:03.512Z,1668122403.512 [MultiRay](INFO): Paused
2022-11-10T23:20:03.924Z,1668122403.924 [MultiRay](INFO): Paused
2022-11-10T23:20:04.293Z,1668122404.293 [MultiRay](INFO): Paused
2022-11-10T23:20:04.704Z,1668122404.704 [MultiRay](INFO): Paused
2022-11-10T23:20:05.089Z,1668122405.089 [MultiRay](INFO): Paused
2022-11-10T23:20:05.482Z,1668122405.482 [MultiRay](INFO): Paused
2022-11-10T23:20:05.888Z,1668122405.888 [MultiRay](INFO): Paused
2022-11-10T23:20:06.292Z,1668122406.292 [MultiRay](INFO): Paused
2022-11-10T23:20:06.694Z,1668122406.694 [MultiRay](INFO): Paused
2022-11-10T23:20:07.092Z,1668122407.092 [MultiRay](INFO): Paused
2022-11-10T23:20:07.504Z,1668122407.504 [MultiRay](INFO): Paused
2022-11-10T23:20:07.908Z,1668122407.908 [MultiRay](INFO): Paused
2022-11-10T23:20:08.303Z,1668122408.303 [MultiRay](INFO): Paused
2022-11-10T23:20:08.308Z,1668122408.308 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2022-11-10T23:20:08.308Z,1668122408.308 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2022-11-10T23:20:08.308Z,1668122408.308 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2022-11-10T23:20:08.310Z,1668122408.310 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2022-11-10T23:20:08.310Z,1668122408.310 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 1
2022-11-10T23:20:08.310Z,1668122408.310 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2022-11-10T23:20:08.720Z,1668122408.720 [MultiRay](INFO): Paused
2022-11-10T23:20:09.121Z,1668122409.121 [MultiRay](INFO): Paused
2022-11-10T23:20:09.522Z,1668122409.522 [MultiRay](INFO): Paused
2022-11-10T23:20:09.928Z,1668122409.928 [MultiRay](INFO): Paused
2022-11-10T23:20:10.332Z,1668122410.332 [MultiRay](INFO): Paused
2022-11-10T23:20:10.734Z,1668122410.734 [MultiRay](INFO): Paused
2022-11-10T23:20:11.138Z,1668122411.138 [MultiRay](INFO): Paused
2022-11-10T23:20:11.542Z,1668122411.542 [MultiRay](INFO): Paused
2022-11-10T23:20:11.946Z,1668122411.946 [MultiRay](INFO): Paused
2022-11-10T23:20:12.355Z,1668122412.355 [MultiRay](INFO): Paused
2022-11-10T23:20:12.756Z,1668122412.756 [MultiRay](INFO): Paused
2022-11-10T23:20:13.160Z,1668122413.160 [MultiRay](INFO): Paused
2022-11-10T23:20:13.564Z,1668122413.564 [MultiRay](INFO): Paused
2022-11-10T23:20:13.971Z,1668122413.971 [MultiRay](INFO): Paused
2022-11-10T23:20:14.370Z,1668122414.370 [MultiRay](INFO): Paused
2022-11-10T23:20:14.774Z,1668122414.774 [MultiRay](INFO): Paused
2022-11-10T23:20:15.181Z,1668122415.181 [MultiRay](INFO): Paused
2022-11-10T23:20:15.636Z,1668122415.636 [MultiRay](INFO): Paused
2022-11-10T23:20:16.061Z,1668122416.061 [MultiRay](INFO): Paused
2022-11-10T23:20:16.408Z,1668122416.408 [MultiRay](INFO): Paused
2022-11-10T23:20:16.824Z,1668122416.824 [MultiRay](INFO): Paused
2022-11-10T23:20:17.213Z,1668122417.213 [MultiRay](INFO): Paused
2022-11-10T23:20:17.604Z,1668122417.604 [MultiRay](INFO): Paused
2022-11-10T23:20:18.006Z,1668122418.006 [MultiRay](INFO): Paused
2022-11-10T23:20:18.415Z,1668122418.415 [MultiRay](INFO): Paused
2022-11-10T23:20:18.821Z,1668122418.821 [MultiRay](INFO): Paused
2022-11-10T23:20:19.212Z,1668122419.212 [MultiRay](INFO): Paused
2022-11-10T23:20:19.624Z,1668122419.624 [MultiRay](INFO): Paused
2022-11-10T23:20:20.028Z,1668122420.028 [MultiRay](INFO): Paused
2022-11-10T23:20:20.425Z,1668122420.425 [MultiRay](INFO): Paused
2022-11-10T23:20:20.838Z,1668122420.838 [MultiRay](INFO): Paused
2022-11-10T23:20:21.238Z,1668122421.238 [MultiRay](INFO): Paused
2022-11-10T23:20:21.642Z,1668122421.642 [MultiRay](INFO): Paused
2022-11-10T23:20:22.049Z,1668122422.049 [MultiRay](INFO): Paused
2022-11-10T23:20:22.451Z,1668122422.451 [MultiRay](INFO): Paused
2022-11-10T23:20:22.854Z,1668122422.854 [MultiRay](INFO): Paused
2022-11-10T23:20:23.258Z,1668122423.258 [MultiRay](INFO): Paused
2022-11-10T23:20:23.660Z,1668122423.660 [MultiRay](INFO): Paused
2022-11-10T23:20:24.068Z,1668122424.068 [MultiRay](INFO): Paused
2022-11-10T23:20:24.472Z,1668122424.472 [MultiRay](INFO): Paused
2022-11-10T23:20:24.874Z,1668122424.874 [MultiRay](INFO): Paused
2022-11-10T23:20:25.279Z,1668122425.279 [MultiRay](INFO): Paused
2022-11-10T23:20:25.684Z,1668122425.684 [MultiRay](INFO): Paused
2022-11-10T23:20:26.088Z,1668122426.088 [MultiRay](INFO): Paused
2022-11-10T23:20:26.490Z,1668122426.490 [MultiRay](INFO): Paused
2022-11-10T23:20:26.896Z,1668122426.896 [MultiRay](INFO): Paused
2022-11-10T23:20:27.304Z,1668122427.304 [MultiRay](INFO): Paused
2022-11-10T23:20:27.756Z,1668122427.756 [MultiRay](INFO): Paused
2022-11-10T23:20:28.178Z,1668122428.178 [MultiRay](INFO): Paused
2022-11-10T23:20:28.528Z,1668122428.528 [MultiRay](INFO): Paused
2022-11-10T23:20:28.944Z,1668122428.944 [MultiRay](INFO): Paused
2022-11-10T23:20:29.329Z,1668122429.329 [MultiRay](INFO): Paused
2022-11-10T23:20:29.718Z,1668122429.718 [MultiRay](INFO): Paused
2022-11-10T23:20:30.126Z,1668122430.126 [MultiRay](INFO): Paused
2022-11-10T23:20:30.532Z,1668122430.532 [MultiRay](INFO): Paused
2022-11-10T23:20:30.934Z,1668122430.934 [MultiRay](INFO): Paused
2022-11-10T23:20:31.338Z,1668122431.338 [MultiRay](INFO): Paused
2022-11-10T23:20:31.744Z,1668122431.744 [MultiRay](INFO): Paused
2022-11-10T23:20:31.750Z,1668122431.750 [Startup:StartupSatComms:A](INFO): Timed out from 2022-11-10T23:19:31.6Z
2022-11-10T23:20:31.750Z,1668122431.750 [Startup:StartupSatComms:A] Stopped
2022-11-10T23:20:31.750Z,1668122431.750 [Startup:StartupSatComms:B] Running Loop=1
2022-11-10T23:20:32.152Z,1668122432.152 [MultiRay](INFO): Paused
2022-11-10T23:20:32.157Z,1668122432.157 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2022-11-10T23:20:32.550Z,1668122432.550 [MultiRay](INFO): Paused
2022-11-10T23:20:32.954Z,1668122432.954 [MultiRay](INFO): Paused
2022-11-10T23:20:33.358Z,1668122433.358 [MultiRay](INFO): Paused
2022-11-10T23:20:33.760Z,1668122433.760 [MultiRay](INFO): Paused
2022-11-10T23:20:34.168Z,1668122434.168 [MultiRay](INFO): Paused
2022-11-10T23:20:34.570Z,1668122434.570 [MultiRay](INFO): Paused
2022-11-10T23:20:34.968Z,1668122434.968 [MultiRay](INFO): Paused
2022-11-10T23:20:35.381Z,1668122435.381 [MultiRay](INFO): Paused
2022-11-10T23:20:35.784Z,1668122435.784 [MultiRay](INFO): Paused
2022-11-10T23:20:36.186Z,1668122436.186 [MultiRay](INFO): Paused
2022-11-10T23:20:36.592Z,1668122436.592 [MultiRay](INFO): Paused
2022-11-10T23:20:36.996Z,1668122436.996 [MultiRay](INFO): Paused
2022-11-10T23:20:37.400Z,1668122437.400 [MultiRay](INFO): Paused
2022-11-10T23:20:37.802Z,1668122437.802 [MultiRay](INFO): Paused
2022-11-10T23:20:38.206Z,1668122438.206 [MultiRay](INFO): Paused
2022-11-10T23:20:38.613Z,1668122438.613 [MultiRay](INFO): Paused
2022-11-10T23:20:39.016Z,1668122439.016 [MultiRay](INFO): Paused
2022-11-10T23:20:39.472Z,1668122439.472 [MultiRay](INFO): Paused
2022-11-10T23:20:39.822Z,1668122439.822 [MultiRay](INFO): Paused
2022-11-10T23:20:40.244Z,1668122440.244 [MultiRay](INFO): Paused
2022-11-10T23:20:40.693Z,1668122440.693 [MultiRay](INFO): Paused
2022-11-10T23:20:41.041Z,1668122441.041 [MultiRay](INFO): Paused
2022-11-10T23:20:41.449Z,1668122441.449 [MultiRay](INFO): Paused
2022-11-10T23:20:41.860Z,1668122441.860 [MultiRay](INFO): Paused
2022-11-10T23:20:42.248Z,1668122442.248 [MultiRay](INFO): Paused
2022-11-10T23:20:42.650Z,1668122442.650 [MultiRay](INFO): Paused
2022-11-10T23:20:43.056Z,1668122443.056 [MultiRay](INFO): Paused
2022-11-10T23:20:43.460Z,1668122443.460 [MultiRay](INFO): Paused
2022-11-10T23:20:43.866Z,1668122443.866 [MultiRay](INFO): Paused
2022-11-10T23:20:44.266Z,1668122444.266 [MultiRay](INFO): Paused
2022-11-10T23:20:44.670Z,1668122444.670 [MultiRay](INFO): Paused
2022-11-10T23:20:45.072Z,1668122445.072 [MultiRay](INFO): Paused
2022-11-10T23:20:45.484Z,1668122445.484 [MultiRay](INFO): Paused
2022-11-10T23:20:45.882Z,1668122445.882 [MultiRay](INFO): Paused
2022-11-10T23:20:46.286Z,1668122446.286 [MultiRay](INFO): Paused
2022-11-10T23:20:46.690Z,1668122446.690 [MultiRay](INFO): Paused
2022-11-10T23:20:47.096Z,1668122447.096 [MultiRay](INFO): Paused
2022-11-10T23:20:47.498Z,1668122447.498 [MultiRay](INFO): Paused
2022-11-10T23:20:47.902Z,1668122447.902 [MultiRay](INFO): Paused
2022-11-10T23:20:48.306Z,1668122448.306 [MultiRay](INFO): Paused
2022-11-10T23:20:48.709Z,1668122448.709 [MultiRay](INFO): Paused
2022-11-10T23:20:48.812Z,1668122448.812 [CommandExec](IMPORTANT): got command show stack
2022-11-10T23:20:48.813Z,1668122448.813 [CommandExec](IMPORTANT): Behavior Stack:

2022-11-10T23:20:48.813Z,1668122448.813 [Startup](IMPORTANT): Priority 0: Startup:A.GoToSurface
2022-11-10T23:20:48.813Z,1668122448.813 [Startup:StartupSatComms](IMPORTANT): Priority 1: Startup:StartupSatComms:B
2022-11-10T23:20:49.112Z,1668122449.112 [MultiRay](INFO): Paused
2022-11-10T23:20:49.518Z,1668122449.518 [MultiRay](INFO): Paused
2022-11-10T23:20:49.922Z,1668122449.922 [MultiRay](INFO): Paused
2022-11-10T23:20:50.326Z,1668122450.326 [MultiRay](INFO): Paused
2022-11-10T23:20:50.730Z,1668122450.730 [MultiRay](INFO): Paused
2022-11-10T23:20:51.134Z,1668122451.134 [MultiRay](INFO): Paused
2022-11-10T23:20:51.591Z,1668122451.591 [MultiRay](INFO): Paused
2022-11-10T23:20:51.949Z,1668122451.949 [MultiRay](INFO): Paused
2022-11-10T23:20:52.361Z,1668122452.361 [MultiRay](INFO): Paused
2022-11-10T23:20:52.810Z,1668122452.810 [MultiRay](INFO): Paused
2022-11-10T23:20:53.161Z,1668122453.161 [MultiRay](INFO): Paused
2022-11-10T23:20:53.572Z,1668122453.572 [MultiRay](INFO): Paused
2022-11-10T23:20:53.980Z,1668122453.980 [MultiRay](INFO): Paused
2022-11-10T23:20:54.368Z,1668122454.368 [MultiRay](INFO): Paused
2022-11-10T23:20:54.770Z,1668122454.770 [MultiRay](INFO): Paused
2022-11-10T23:20:55.172Z,1668122455.172 [MultiRay](INFO): Paused
2022-11-10T23:20:55.578Z,1668122455.578 [MultiRay](INFO): Paused
2022-11-10T23:20:55.986Z,1668122455.986 [MultiRay](INFO): Paused
2022-11-10T23:20:56.386Z,1668122456.386 [MultiRay](INFO): Paused
2022-11-10T23:20:56.790Z,1668122456.790 [MultiRay](INFO): Paused
2022-11-10T23:20:57.196Z,1668122457.196 [MultiRay](INFO): Paused
2022-11-10T23:20:57.599Z,1668122457.599 [MultiRay](INFO): Paused
2022-11-10T23:20:57.995Z,1668122457.995 [MultiRay](INFO): Paused
2022-11-10T23:20:58.405Z,1668122458.405 [MultiRay](INFO): Paused
2022-11-10T23:20:58.810Z,1668122458.810 [MultiRay](INFO): Paused
2022-11-10T23:20:59.216Z,1668122459.216 [MultiRay](INFO): Paused
2022-11-10T23:20:59.620Z,1668122459.620 [MultiRay](INFO): Paused
2022-11-10T23:21:00.022Z,1668122460.022 [MultiRay](INFO): Paused
2022-11-10T23:21:00.428Z,1668122460.428 [MultiRay](INFO): Paused
2022-11-10T23:21:00.832Z,1668122460.832 [MultiRay](INFO): Paused
2022-11-10T23:21:01.236Z,1668122461.236 [MultiRay](INFO): Paused
2022-11-10T23:21:01.638Z,1668122461.638 [MultiRay](INFO): Paused
2022-11-10T23:21:02.045Z,1668122462.045 [MultiRay](INFO): Paused
2022-11-10T23:21:02.446Z,1668122462.446 [MultiRay](INFO): Paused
2022-11-10T23:21:02.850Z,1668122462.850 [MultiRay](INFO): Paused
2022-11-10T23:21:03.307Z,1668122463.307 [MultiRay](INFO): Paused
2022-11-10T23:21:03.668Z,1668122463.668 [MultiRay](INFO): Paused
2022-11-10T23:21:04.077Z,1668122464.077 [MultiRay](INFO): Paused
2022-11-10T23:21:04.526Z,1668122464.526 [MultiRay](INFO): Paused
2022-11-10T23:21:04.877Z,1668122464.877 [MultiRay](INFO): Paused
2022-11-10T23:21:05.288Z,1668122465.288 [MultiRay](INFO): Paused
2022-11-10T23:21:05.688Z,1668122465.688 [MultiRay](INFO): Paused
2022-11-10T23:21:06.088Z,1668122466.088 [MultiRay](INFO): Paused
2022-11-10T23:21:06.486Z,1668122466.486 [MultiRay](INFO): Paused
2022-11-10T23:21:06.892Z,1668122466.892 [MultiRay](INFO): Paused
2022-11-10T23:21:07.296Z,1668122467.296 [MultiRay](INFO): Paused
2022-11-10T23:21:07.693Z,1668122467.693 [MultiRay](INFO): Paused
2022-11-10T23:21:08.098Z,1668122468.098 [MultiRay](INFO): Paused
2022-11-10T23:21:08.506Z,1668122468.506 [MultiRay](INFO): Paused
2022-11-10T23:21:08.903Z,1668122468.903 [MultiRay](INFO): Paused
2022-11-10T23:21:09.316Z,1668122469.316 [MultiRay](INFO): Paused
2022-11-10T23:21:09.720Z,1668122469.720 [MultiRay](INFO): Paused
2022-11-10T23:21:10.115Z,1668122470.115 [MultiRay](INFO): Paused
2022-11-10T23:21:10.528Z,1668122470.528 [MultiRay](INFO): Paused
2022-11-10T23:21:10.932Z,1668122470.932 [MultiRay](INFO): Paused
2022-11-10T23:21:11.336Z,1668122471.336 [MultiRay](INFO): Paused
2022-11-10T23:21:11.740Z,1668122471.740 [MultiRay](INFO): Paused
2022-11-10T23:21:12.142Z,1668122472.142 [MultiRay](INFO): Paused
2022-11-10T23:21:12.548Z,1668122472.548 [MultiRay](INFO): Paused
2022-11-10T23:21:12.952Z,1668122472.952 [MultiRay](INFO): Paused
2022-11-10T23:21:13.356Z,1668122473.356 [MultiRay](INFO): Paused
2022-11-10T23:21:13.758Z,1668122473.758 [MultiRay](INFO): Paused
2022-11-10T23:21:14.164Z,1668122474.164 [MultiRay](INFO): Paused
2022-11-10T23:21:14.568Z,1668122474.568 [MultiRay](INFO): Paused
2022-11-10T23:21:14.970Z,1668122474.970 [MultiRay](INFO): Paused
2022-11-10T23:21:15.427Z,1668122475.427 [MultiRay](INFO): Paused
2022-11-10T23:21:15.785Z,1668122475.785 [MultiRay](INFO): Paused
2022-11-10T23:21:16.197Z,1668122476.197 [MultiRay](INFO): Paused
2022-11-10T23:21:16.647Z,1668122476.647 [MultiRay](INFO): Paused
2022-11-10T23:21:16.996Z,1668122476.996 [MultiRay](INFO): Paused
2022-11-10T23:21:17.408Z,1668122477.408 [MultiRay](INFO): Paused
2022-11-10T23:21:17.816Z,1668122477.816 [MultiRay](INFO): Paused
2022-11-10T23:21:18.204Z,1668122478.204 [MultiRay](INFO): Paused
2022-11-10T23:21:18.606Z,1668122478.606 [MultiRay](INFO): Paused
2022-11-10T23:21:19.012Z,1668122479.012 [MultiRay](INFO): Paused
2022-11-10T23:21:19.416Z,1668122479.416 [MultiRay](INFO): Paused
2022-11-10T23:21:19.818Z,1668122479.818 [MultiRay](INFO): Paused
2022-11-10T23:21:20.222Z,1668122480.222 [MultiRay](INFO): Paused
2022-11-10T23:21:20.628Z,1668122480.628 [MultiRay](INFO): Paused
2022-11-10T23:21:21.030Z,1668122481.030 [MultiRay](INFO): Paused
2022-11-10T23:21:21.434Z,1668122481.434 [MultiRay](INFO): Paused
2022-11-10T23:21:21.838Z,1668122481.838 [MultiRay](INFO): Paused
2022-11-10T23:21:22.242Z,1668122482.242 [MultiRay](INFO): Paused
2022-11-10T23:21:22.649Z,1668122482.649 [MultiRay](INFO): Paused
2022-11-10T23:21:23.051Z,1668122483.051 [MultiRay](INFO): Paused
2022-11-10T23:21:23.471Z,1668122483.471 [MultiRay](INFO): Paused
2022-11-10T23:21:23.871Z,1668122483.871 [MultiRay](INFO): Paused
2022-11-10T23:21:24.270Z,1668122484.270 [MultiRay](INFO): Paused
2022-11-10T23:21:24.684Z,1668122484.684 [MultiRay](INFO): Paused
2022-11-10T23:21:25.080Z,1668122485.080 [MultiRay](INFO): Paused
2022-11-10T23:21:25.476Z,1668122485.476 [MultiRay](INFO): Paused
2022-11-10T23:21:25.879Z,1668122485.879 [MultiRay](INFO): Paused
2022-11-10T23:21:26.284Z,1668122486.284 [MultiRay](INFO): Paused
2022-11-10T23:21:26.688Z,1668122486.688 [MultiRay](INFO): Paused
2022-11-10T23:21:27.090Z,1668122487.090 [MultiRay](INFO): Paused
2022-11-10T23:21:27.547Z,1668122487.547 [MultiRay](INFO): Paused
2022-11-10T23:21:27.905Z,1668122487.905 [MultiRay](INFO): Paused
2022-11-10T23:21:28.316Z,1668122488.316 [MultiRay](INFO): Paused
2022-11-10T23:21:28.722Z,1668122488.722 [MultiRay](INFO): Paused
2022-11-10T23:21:29.110Z,1668122489.110 [MultiRay](INFO): Paused
2022-11-10T23:21:29.514Z,1668122489.514 [MultiRay](INFO): Paused
2022-11-10T23:21:29.922Z,1668122489.922 [MultiRay](INFO): Paused
2022-11-10T23:21:30.324Z,1668122490.324 [MultiRay](INFO): Paused
2022-11-10T23:21:30.726Z,1668122490.726 [MultiRay](INFO): Paused
2022-11-10T23:21:31.132Z,1668122491.132 [MultiRay](INFO): Paused
2022-11-10T23:21:31.534Z,1668122491.534 [MultiRay](INFO): Paused
2022-11-10T23:21:31.938Z,1668122491.938 [MultiRay](INFO): Paused
2022-11-10T23:21:31.943Z,1668122491.943 [Startup:StartupSatComms:B](INFO): Timed out from 2022-11-10T23:20:31.7Z
2022-11-10T23:21:31.943Z,1668122491.943 [Startup:StartupSatComms:B] Stopped
2022-11-10T23:21:31.943Z,1668122491.943 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2022-11-10T23:21:31.944Z,1668122491.944 [Startup:StartupSatComms] Stopped
2022-11-10T23:21:31.944Z,1668122491.944 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2022-11-10T23:21:31.944Z,1668122491.944 [Startup](INFO): Completed Startup
2022-11-10T23:21:31.945Z,1668122491.945 [MissionManager](INFO): Startup is completed.
2022-11-10T23:21:31.945Z,1668122491.945 [MissionManager](INFO): Uninitializing Mission Startup
2022-11-10T23:21:31.945Z,1668122491.945 [Startup] Stopped
2022-11-10T23:21:31.945Z,1668122491.945 [Startup](DEBUG): Aggregate::uninitialize Startup
2022-11-10T23:21:31.945Z,1668122491.945 [Startup:A.GoToSurface] Stopped
2022-11-10T23:21:31.945Z,1668122491.945 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2022-11-10T23:21:32.340Z,1668122492.340 [MultiRay](INFO): Paused
2022-11-10T23:21:32.350Z,1668122492.350 [MissionManager](IMPORTANT): Started mission Default
2022-11-10T23:21:32.350Z,1668122492.350 [Default] Running Loop=1
2022-11-10T23:21:32.351Z,1668122492.351 [Default](DEBUG): Aggregate::initialize Default
2022-11-10T23:21:32.351Z,1668122492.351 [Default:B.GoToSurface] Running Loop=1
2022-11-10T23:21:32.351Z,1668122492.351 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2022-11-10T23:21:32.351Z,1668122492.351 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2022-11-10T23:21:32.352Z,1668122492.352 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2022-11-10T23:21:32.352Z,1668122492.352 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2022-11-10T23:21:32.352Z,1668122492.352 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2022-11-10T23:21:32.353Z,1668122492.353 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2022-11-10T23:21:32.353Z,1668122492.353 [Default:A.Wait] Running Loop=1
2022-11-10T23:21:32.353Z,1668122492.353 [Default:A.Wait](DEBUG): Initialize Wait Component.
2022-11-10T23:21:32.749Z,1668122492.749 [MultiRay](INFO): Paused
2022-11-10T23:21:33.150Z,1668122493.150 [MultiRay](INFO): Paused
2022-11-10T23:21:33.554Z,1668122493.554 [MultiRay](INFO): Paused
2022-11-10T23:21:33.960Z,1668122493.960 [MultiRay](INFO): Paused
2022-11-10T23:21:34.364Z,1668122494.364 [MultiRay](INFO): Paused
2022-11-10T23:21:34.768Z,1668122494.768 [MultiRay](INFO): Paused
2022-11-10T23:21:35.170Z,1668122495.170 [MultiRay](INFO): Paused
2022-11-10T23:21:35.576Z,1668122495.576 [MultiRay](INFO): Paused
2022-11-10T23:21:35.980Z,1668122495.980 [MultiRay](INFO): Paused
2022-11-10T23:21:36.384Z,1668122496.384 [MultiRay](INFO): Paused
2022-11-10T23:21:36.849Z,1668122496.849 [MultiRay](INFO): Paused
2022-11-10T23:21:37.200Z,1668122497.200 [MultiRay](INFO): Paused
2022-11-10T23:21:37.608Z,1668122497.608 [MultiRay](INFO): Paused
2022-11-10T23:21:38.016Z,1668122498.016 [MultiRay](INFO): Paused
2022-11-10T23:21:38.402Z,1668122498.402 [MultiRay](INFO): Paused
2022-11-10T23:21:38.808Z,1668122498.808 [MultiRay](INFO): Paused
2022-11-10T23:21:39.210Z,1668122499.210 [MultiRay](INFO): Paused
2022-11-10T23:21:39.618Z,1668122499.618 [MultiRay](INFO): Paused
2022-11-10T23:21:40.018Z,1668122500.018 [MultiRay](INFO): Paused
2022-11-10T23:21:40.422Z,1668122500.422 [MultiRay](INFO): Paused
2022-11-10T23:21:40.882Z,1668122500.882 [MultiRay](INFO): Paused
2022-11-10T23:21:41.239Z,1668122501.239 [MultiRay](INFO): Paused
2022-11-10T23:21:41.646Z,1668122501.646 [MultiRay](INFO): Paused
2022-11-10T23:21:42.049Z,1668122502.049 [MultiRay](INFO): Paused
2022-11-10T23:21:42.442Z,1668122502.442 [MultiRay](INFO): Paused
2022-11-10T23:21:42.848Z,1668122502.848 [MultiRay](INFO): Paused
2022-11-10T23:21:43.253Z,1668122503.253 [MultiRay](INFO): Paused
2022-11-10T23:21:43.296Z,1668122503.296 [CommandExec](IMPORTANT): got command run ./Missions/Maintenance/multiray_test.xml
2022-11-10T23:21:43.297Z,1668122503.297 [MissionManager](INFO): Loading Mission from file: ./Missions/Maintenance/multiray_test.xml
2022-11-10T23:21:43.362Z,1668122503.362 [MissionManager](INFO): DefineArg multiray_test.MissionTimeout = 5.000000 min
2022-11-10T23:21:43.379Z,1668122503.379 [MissionManager](INFO): DefineArg multiray_test.LightDuration = 5.000000 s
2022-11-10T23:21:43.382Z,1668122503.382 [MissionManager](INFO): DefineArg multiray_test.LightMode0 = 0.000000 count
2022-11-10T23:21:43.385Z,1668122503.385 [MissionManager](INFO): DefineArg multiray_test.LightMode1 = 1.000000 count
2022-11-10T23:21:43.388Z,1668122503.388 [MissionManager](INFO): DefineArg multiray_test.LightMode2 = 2.000000 count
2022-11-10T23:21:43.391Z,1668122503.391 [MissionManager](INFO): DefineArg multiray_test.EnabledMultiray = 1 bool
2022-11-10T23:21:43.396Z,1668122503.396 [multiray_test:C.Wait](DEBUG): Construct Wait.
2022-11-10T23:21:43.399Z,1668122503.399 [multiray_test:E.Wait](DEBUG): Construct Wait.
2022-11-10T23:21:43.402Z,1668122503.402 [multiray_test:G.Wait](DEBUG): Construct Wait.
2022-11-10T23:21:43.405Z,1668122503.405 [multiray_test:I.Wait](DEBUG): Construct Wait.
2022-11-10T23:21:43.408Z,1668122503.408 [multiray_test:K.Wait](DEBUG): Construct Wait.
2022-11-10T23:21:43.411Z,1668122503.411 [multiray_test:M.Wait](DEBUG): Construct Wait.
2022-11-10T23:21:43.414Z,1668122503.414 [multiray_test:O.Wait](DEBUG): Construct Wait.
2022-11-10T23:21:43.446Z,1668122503.446 [multiray_test:Q.Wait](DEBUG): Construct Wait.
2022-11-10T23:21:43.479Z,1668122503.479 [multiray_test:R.Wait](DEBUG): Construct Wait.
2022-11-10T23:21:43.482Z,1668122503.482 [multiray_test:T.Wait](DEBUG): Construct Wait.
2022-11-10T23:21:43.501Z,1668122503.501 [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-10T23:21:43.503Z,1668122503.503 [CommandExec](IMPORTANT): Running ./Missions/Maintenance/multiray_test.xml
2022-11-10T23:21:43.652Z,1668122503.652 [MultiRay](INFO): Paused
2022-11-10T23:21:43.656Z,1668122503.656 [Default] Stopped
2022-11-10T23:21:43.656Z,1668122503.656 [Default](DEBUG): Aggregate::uninitialize Default
2022-11-10T23:21:43.657Z,1668122503.657 [Default:A.Wait] Stopped
2022-11-10T23:21:43.657Z,1668122503.657 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2022-11-10T23:21:43.657Z,1668122503.657 [Default:B.GoToSurface] Stopped
2022-11-10T23:21:43.657Z,1668122503.657 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2022-11-10T23:21:43.657Z,1668122503.657 [MissionManager](IMPORTANT): Started mission multiray_test
2022-11-10T23:21:43.657Z,1668122503.657 [multiray_test] Running Loop=1
2022-11-10T23:21:43.657Z,1668122503.657 [multiray_test](DEBUG): Aggregate::initialize multiray_test
2022-11-10T23:21:43.657Z,1668122503.657 [multiray_test:A] Running Loop=1
2022-11-10T23:21:43.658Z,1668122503.658 [multiray_test:B] Running Loop=1
2022-11-10T23:21:43.658Z,1668122503.658 [multiray_test:B] Stopped
2022-11-10T23:21:43.658Z,1668122503.658 [multiray_test:C.Wait] Running Loop=1
2022-11-10T23:21:43.658Z,1668122503.658 [multiray_test:C.Wait](DEBUG): Initialize Wait Component.
2022-11-10T23:21:43.658Z,1668122503.658 [multiray_test:A] Running Loop=1
2022-11-10T23:21:43.659Z,1668122503.659 [multiray_test:A](DEBUG): Initialize ReadDataComponent to sense MultiRay.lightModeLog
2022-11-10T23:21:44.060Z,1668122504.060 [MultiRay](INFO): Paused
2022-11-10T23:21:44.464Z,1668122504.464 [MultiRay](INFO): Resume
2022-11-10T23:21:44.495Z,1668122504.495 [MultiRay](INFO): Finish turning things back on in Resume
2022-11-10T23:21:44.866Z,1668122504.866 [MultiRay](INFO): Runnable
2022-11-10T23:21:44.866Z,1668122504.866 [MultiRay](IMPORTANT): New light mode loaded
2022-11-10T23:21:44.866Z,1668122504.866 [MultiRay](IMPORTANT): Turning off all lights
2022-11-10T23:21:44.880Z,1668122504.880 [MultiRay](IMPORTANT): Recieved MultiRay unrecognized response
2022-11-10T23:21:44.908Z,1668122504.908 [MultiRay](IMPORTANT): Recieved MultiRay unrecognized response
2022-11-10T23:21:44.909Z,1668122504.909 [MultiRay](IMPORTANT): All lights off
2022-11-10T23:21:45.270Z,1668122505.270 [MultiRay](INFO): Pause
2022-11-10T23:21:45.675Z,1668122505.675 [MultiRay](INFO): Paused
2022-11-10T23:21:46.078Z,1668122506.078 [MultiRay](INFO): Paused
2022-11-10T23:21:46.482Z,1668122506.482 [MultiRay](INFO): Paused
2022-11-10T23:21:46.888Z,1668122506.888 [MultiRay](INFO): Paused
2022-11-10T23:21:47.292Z,1668122507.292 [MultiRay](INFO): Paused
2022-11-10T23:21:47.694Z,1668122507.694 [MultiRay](INFO): Paused
2022-11-10T23:21:48.098Z,1668122508.098 [MultiRay](INFO): Paused
2022-11-10T23:21:48.504Z,1668122508.504 [MultiRay](INFO): Paused
2022-11-10T23:21:48.908Z,1668122508.908 [MultiRay](INFO): Paused
2022-11-10T23:21:49.312Z,1668122509.312 [MultiRay](INFO): Paused
2022-11-10T23:21:49.317Z,1668122509.317 [multiray_test:C.Wait](INFO): Done Waiting.
2022-11-10T23:21:49.317Z,1668122509.317 [multiray_test:C.Wait] Stopped
2022-11-10T23:21:49.317Z,1668122509.317 [multiray_test:C.Wait](DEBUG): Uninitialize Wait Component.
2022-11-10T23:21:49.317Z,1668122509.317 [multiray_test:D] Running Loop=1
2022-11-10T23:21:49.714Z,1668122509.714 [MultiRay](INFO): Paused
2022-11-10T23:21:49.719Z,1668122509.719 [multiray_test:D] Stopped
2022-11-10T23:21:49.719Z,1668122509.719 [multiray_test:E.Wait] Running Loop=1
2022-11-10T23:21:49.719Z,1668122509.719 [multiray_test:E.Wait](DEBUG): Initialize Wait Component.
2022-11-10T23:21:50.120Z,1668122510.120 [MultiRay](INFO): Paused
2022-11-10T23:21:50.580Z,1668122510.580 [MultiRay](INFO): Resume
2022-11-10T23:21:50.607Z,1668122510.607 [MultiRay](INFO): Finish turning things back on in Resume
2022-11-10T23:21:50.950Z,1668122510.950 [MultiRay](INFO): Runnable
2022-11-10T23:21:50.951Z,1668122510.951 [MultiRay](IMPORTANT): New light mode loaded
2022-11-10T23:21:50.951Z,1668122510.951 [MultiRay](IMPORTANT): Turning on red lights
2022-11-10T23:21:50.951Z,1668122510.951 [MultiRay](IMPORTANT): set change mode state to change array
2022-11-10T23:21:50.951Z,1668122510.951 [MultiRay](IMPORTANT): in case for change led array
2022-11-10T23:21:50.964Z,1668122510.964 [MultiRay](IMPORTANT): Recieved MultiRay unrecognized response
2022-11-10T23:21:50.976Z,1668122510.976 [MultiRay](IMPORTANT): Recieved MultiRay unrecognized response
2022-11-10T23:21:50.977Z,1668122510.977 [MultiRay](IMPORTANT): Change LED array command successful
2022-11-10T23:21:50.977Z,1668122510.977 [MultiRay](IMPORTANT): in case for change led brightness
2022-11-10T23:21:50.993Z,1668122510.993 [MultiRay](IMPORTANT): Recieved MultiRay unrecognized response
2022-11-10T23:21:51.007Z,1668122511.007 [MultiRay](IMPORTANT): Recieved MultiRay unrecognized response
2022-11-10T23:21:51.008Z,1668122511.008 [MultiRay](INFO): Red lights on
2022-11-10T23:21:51.348Z,1668122511.348 [MultiRay](INFO): Runnable
2022-11-10T23:21:51.749Z,1668122511.749 [MultiRay](INFO): Runnable
2022-11-10T23:21:52.138Z,1668122512.138 [MultiRay](INFO): Runnable
2022-11-10T23:21:52.542Z,1668122512.542 [MultiRay](INFO): Runnable
2022-11-10T23:21:52.948Z,1668122512.948 [MultiRay](INFO): Runnable
2022-11-10T23:21:53.352Z,1668122513.352 [MultiRay](INFO): Runnable
2022-11-10T23:21:53.813Z,1668122513.813 [MultiRay](INFO): Runnable
2022-11-10T23:21:54.165Z,1668122514.165 [MultiRay](INFO): Runnable
2022-11-10T23:21:54.576Z,1668122514.576 [MultiRay](INFO): Runnable
2022-11-10T23:21:54.984Z,1668122514.984 [MultiRay](INFO): Runnable
2022-11-10T23:21:55.370Z,1668122515.370 [MultiRay](INFO): Runnable
2022-11-10T23:21:55.384Z,1668122515.384 [multiray_test:E.Wait](INFO): Done Waiting.
2022-11-10T23:21:55.384Z,1668122515.384 [multiray_test:E.Wait] Stopped
2022-11-10T23:21:55.384Z,1668122515.384 [multiray_test:E.Wait](DEBUG): Uninitialize Wait Component.
2022-11-10T23:21:55.384Z,1668122515.384 [multiray_test:F] Running Loop=1
2022-11-10T23:21:55.777Z,1668122515.777 [MultiRay](INFO): Runnable
2022-11-10T23:21:55.781Z,1668122515.781 [multiray_test:F] Stopped
2022-11-10T23:21:55.782Z,1668122515.782 [multiray_test:G.Wait] Running Loop=1
2022-11-10T23:21:55.782Z,1668122515.782 [multiray_test:G.Wait](DEBUG): Initialize Wait Component.
2022-11-10T23:21:56.180Z,1668122516.180 [MultiRay](INFO): Runnable
2022-11-10T23:21:56.181Z,1668122516.181 [MultiRay](IMPORTANT): New light mode loaded
2022-11-10T23:21:56.181Z,1668122516.181 [MultiRay](IMPORTANT): Turning on white lights
2022-11-10T23:21:56.181Z,1668122516.181 [MultiRay](IMPORTANT): set change mode state to change array
2022-11-10T23:21:56.181Z,1668122516.181 [MultiRay](IMPORTANT): in case for change led array
2022-11-10T23:21:56.196Z,1668122516.196 [MultiRay](IMPORTANT): Recieved MultiRay unrecognized response
2022-11-10T23:21:56.225Z,1668122516.225 [MultiRay](IMPORTANT): Recieved MultiRay unrecognized response
2022-11-10T23:21:56.226Z,1668122516.226 [MultiRay](IMPORTANT): Change LED array command successful
2022-11-10T23:21:56.226Z,1668122516.226 [MultiRay](IMPORTANT): in case for change led brightness
2022-11-10T23:21:56.240Z,1668122516.240 [MultiRay](IMPORTANT): Recieved MultiRay unrecognized response
2022-11-10T23:21:56.253Z,1668122516.253 [MultiRay](IMPORTANT): Recieved MultiRay unrecognized response
2022-11-10T23:21:56.253Z,1668122516.253 [MultiRay](INFO): White lights on
2022-11-10T23:21:56.580Z,1668122516.580 [MultiRay](INFO): Runnable
2022-11-10T23:21:56.986Z,1668122516.986 [MultiRay](INFO): Runnable
2022-11-10T23:21:57.383Z,1668122517.383 [MultiRay](INFO): Runnable
2022-11-10T23:21:57.796Z,1668122517.796 [MultiRay](INFO): Runnable
2022-11-10T23:21:58.198Z,1668122518.198 [MultiRay](INFO): Runnable
2022-11-10T23:21:58.602Z,1668122518.602 [MultiRay](INFO): Runnable
2022-11-10T23:21:59.008Z,1668122519.008 [MultiRay](INFO): Runnable
2022-11-10T23:21:59.412Z,1668122519.412 [MultiRay](INFO): Runnable
2022-11-10T23:21:59.814Z,1668122519.814 [MultiRay](INFO): Runnable
2022-11-10T23:22:00.218Z,1668122520.218 [MultiRay](INFO): Runnable
2022-11-10T23:22:00.622Z,1668122520.622 [MultiRay](INFO): Runnable
2022-11-10T23:22:01.026Z,1668122521.026 [MultiRay](INFO): Runnable
2022-11-10T23:22:01.434Z,1668122521.434 [MultiRay](INFO): Runnable
2022-11-10T23:22:01.439Z,1668122521.439 [multiray_test:G.Wait](INFO): Done Waiting.
2022-11-10T23:22:01.439Z,1668122521.439 [multiray_test:G.Wait] Stopped
2022-11-10T23:22:01.440Z,1668122521.440 [multiray_test:G.Wait](DEBUG): Uninitialize Wait Component.
2022-11-10T23:22:01.440Z,1668122521.44