2022-11-02T21:32:51.073Z,1667424771.073 [Supervisor](DEBUG): Initializing supervisor. 2022-11-02T21:32:51.078Z,1667424771.078 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2022-11-02T21:32:51.078Z,1667424771.078 [SyncHandler](INFO): Protected caller Thread ID is 835 2022-11-02T21:32:51.079Z,1667424771.079 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2022-11-02T21:32:51.080Z,1667424771.080 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2022-11-02T21:32:51.080Z,1667424771.080 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 836 2022-11-02T21:32:51.084Z,1667424771.084 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2022-11-02T21:32:51.102Z,1667424771.102 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread. 2022-11-02T21:32:51.103Z,1667424771.103 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2022-11-02T21:32:51.103Z,1667424771.103 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 837 2022-11-02T21:32:51.108Z,1667424771.108 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2022-11-02T21:32:51.109Z,1667424771.109 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2022-11-02T21:32:51.109Z,1667424771.109 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 838 2022-11-02T21:32:51.111Z,1667424771.111 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2022-11-02T21:32:51.112Z,1667424771.112 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0 2022-11-02T21:32:51.112Z,1667424771.112 [logger ThreadHandler](INFO): Protected caller Thread ID is 839 2022-11-02T21:32:51.116Z,1667424771.116 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2022-11-02T21:32:51.117Z,1667424771.117 [Supervisor](INFO): Looking for Config files in directory: Config/ 2022-11-02T21:32:51.121Z,1667424771.121 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2022-11-02T21:32:51.548Z,1667424771.548 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2022-11-02T21:32:51.550Z,1667424771.550 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg 2022-11-02T21:32:51.764Z,1667424771.764 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock 2022-11-02T21:32:51.765Z,1667424771.765 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2022-11-02T21:32:51.949Z,1667424771.949 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2022-11-02T21:32:51.949Z,1667424771.949 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2022-11-02T21:32:52.056Z,1667424772.056 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2022-11-02T21:32:52.056Z,1667424772.056 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2022-11-02T21:32:52.422Z,1667424772.422 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2022-11-02T21:32:52.424Z,1667424772.424 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2022-11-02T21:32:52.744Z,1667424772.744 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2022-11-02T21:32:52.746Z,1667424772.746 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2022-11-02T21:32:52.842Z,1667424772.842 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2022-11-02T21:32:52.844Z,1667424772.844 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2022-11-02T21:32:53.061Z,1667424773.061 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2022-11-02T21:32:53.063Z,1667424773.063 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2022-11-02T21:32:53.569Z,1667424773.569 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2022-11-02T21:32:53.570Z,1667424773.570 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2022-11-02T21:32:53.921Z,1667424773.921 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2022-11-02T21:32:53.923Z,1667424773.923 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2022-11-02T21:32:54.004Z,1667424774.004 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2022-11-02T21:32:54.214Z,1667424774.214 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2022-11-02T21:32:54.214Z,1667424774.214 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2022-11-02T21:32:54.360Z,1667424774.360 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2022-11-02T21:32:54.360Z,1667424774.360 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2022-11-02T21:32:55.860Z,1667424775.860 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2022-11-02T21:32:55.860Z,1667424775.860 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2022-11-02T21:32:55.940Z,1667424775.940 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2022-11-02T21:32:56.227Z,1667424776.227 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2022-11-02T21:32:56.229Z,1667424776.229 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-galene/ 2022-11-02T21:32:56.232Z,1667424776.232 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/vehicle.cfg 2022-11-02T21:32:56.411Z,1667424776.411 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/logger.cfg 2022-11-02T21:32:56.503Z,1667424776.503 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Servo.cfg 2022-11-02T21:32:56.616Z,1667424776.616 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Control.cfg 2022-11-02T21:32:56.716Z,1667424776.716 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/secure.cfg 2022-11-02T21:32:56.800Z,1667424776.800 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Simulator.cfg 2022-11-02T21:32:56.885Z,1667424776.885 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Science.cfg 2022-11-02T21:32:56.999Z,1667424776.999 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/BIT.cfg 2022-11-02T21:32:57.097Z,1667424777.097 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Sensor.cfg 2022-11-02T21:32:57.296Z,1667424777.296 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Battery.cfg 2022-11-02T21:32:57.557Z,1667424777.557 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2022-11-02T21:32:57.558Z,1667424777.558 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Navigation.cfg 2022-11-02T21:32:57.651Z,1667424777.651 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg 2022-11-02T21:32:57.670Z,1667424777.670 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2022-11-02T21:32:58.027Z,1667424778.027 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2022-11-02T21:32:58.029Z,1667424778.029 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2022-11-02T21:32:58.166Z,1667424778.166 [DeadReckonUsingMultipleVelocitySources] Loaded 2022-11-02T21:32:58.167Z,1667424778.167 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2022-11-02T21:32:58.206Z,1667424778.206 [DeadReckonUsingSpeedCalculator] Loaded 2022-11-02T21:32:58.206Z,1667424778.206 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread. 2022-11-02T21:32:58.220Z,1667424778.220 [NavChart] Loaded 2022-11-02T21:32:58.220Z,1667424778.220 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2022-11-02T21:32:58.225Z,1667424778.225 [UniversalFixResidualReporter] Loaded 2022-11-02T21:32:58.226Z,1667424778.226 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2022-11-02T21:32:58.226Z,1667424778.226 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2022-11-02T21:32:58.227Z,1667424778.227 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2022-11-02T21:32:58.243Z,1667424778.243 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2022-11-02T21:32:58.243Z,1667424778.243 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2022-11-02T21:32:58.447Z,1667424778.447 [PAR_Licor] Loaded 2022-11-02T21:32:58.448Z,1667424778.448 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread. 2022-11-02T21:32:58.479Z,1667424778.479 [WetLabsBB2FL] Loaded 2022-11-02T21:32:58.480Z,1667424778.480 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread. 2022-11-02T21:32:58.481Z,1667424778.481 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 4065A4E0 2022-11-02T21:32:58.481Z,1667424778.481 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 922 2022-11-02T21:32:58.482Z,1667424778.482 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2022-11-02T21:32:58.484Z,1667424778.484 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2022-11-02T21:32:58.552Z,1667424778.552 [VerticalControl](DEBUG): Construct VerticalControl. 2022-11-02T21:32:58.613Z,1667424778.613 [VerticalControl] Loaded 2022-11-02T21:32:58.613Z,1667424778.613 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2022-11-02T21:32:58.616Z,1667424778.616 [HorizontalControl](DEBUG): Construct HorizontalControl. 2022-11-02T21:32:58.658Z,1667424778.658 [HorizontalControl] Loaded 2022-11-02T21:32:58.658Z,1667424778.658 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2022-11-02T21:32:58.661Z,1667424778.661 [SpeedControl](DEBUG): Construct SpeedControl. 2022-11-02T21:32:58.664Z,1667424778.664 [SpeedControl] Loaded 2022-11-02T21:32:58.664Z,1667424778.664 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2022-11-02T21:32:58.667Z,1667424778.667 [LoopControl](DEBUG): Construct LoopControl. 2022-11-02T21:32:58.668Z,1667424778.668 [LoopControl] Loaded 2022-11-02T21:32:58.668Z,1667424778.668 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2022-11-02T21:32:58.668Z,1667424778.668 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2022-11-02T21:32:58.670Z,1667424778.670 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2022-11-02T21:32:58.739Z,1667424778.739 [DepthRateCalculator] Loaded 2022-11-02T21:32:58.740Z,1667424778.740 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2022-11-02T21:32:58.744Z,1667424778.744 [PitchRateCalculator] Loaded 2022-11-02T21:32:58.745Z,1667424778.745 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2022-11-02T21:32:58.754Z,1667424778.754 [SpeedCalculator] Loaded 2022-11-02T21:32:58.754Z,1667424778.754 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2022-11-02T21:32:58.759Z,1667424778.759 [YawRateCalculator] Loaded 2022-11-02T21:32:58.759Z,1667424778.759 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2022-11-02T21:32:58.777Z,1667424778.777 [ElevatorOffsetCalculator] Loaded 2022-11-02T21:32:58.778Z,1667424778.778 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread. 2022-11-02T21:32:58.778Z,1667424778.778 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2022-11-02T21:32:58.780Z,1667424778.780 [Module Loader](DEBUG): Loading Module at Modules/Dock.so 2022-11-02T21:32:58.897Z,1667424778.897 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking) 2022-11-02T21:32:58.899Z,1667424778.899 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2022-11-02T21:32:58.983Z,1667424778.983 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2022-11-02T21:32:58.984Z,1667424778.984 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2022-11-02T21:32:59.133Z,1667424779.133 [BuoyancyServo] Loaded 2022-11-02T21:32:59.134Z,1667424779.134 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2022-11-02T21:32:59.154Z,1667424779.154 [ElevatorServo] Loaded 2022-11-02T21:32:59.154Z,1667424779.154 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2022-11-02T21:32:59.173Z,1667424779.173 [MassServo] Loaded 2022-11-02T21:32:59.173Z,1667424779.173 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2022-11-02T21:32:59.192Z,1667424779.192 [RudderServo] Loaded 2022-11-02T21:32:59.192Z,1667424779.192 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2022-11-02T21:32:59.207Z,1667424779.207 [ThrusterHE] Loaded 2022-11-02T21:32:59.207Z,1667424779.207 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread. 2022-11-02T21:32:59.207Z,1667424779.207 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2022-11-02T21:32:59.208Z,1667424779.208 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2022-11-02T21:32:59.394Z,1667424779.394 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2022-11-02T21:32:59.395Z,1667424779.395 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2022-11-02T21:33:00.660Z,1667424780.660 [AHRS_M2] Loaded 2022-11-02T21:33:00.660Z,1667424780.660 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread. 2022-11-02T21:33:00.909Z,1667424780.909 [BackseatComponent] Loaded 2022-11-02T21:33:00.910Z,1667424780.910 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread. 2022-11-02T21:33:00.911Z,1667424780.911 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 40A554E0 2022-11-02T21:33:00.911Z,1667424780.911 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 923 2022-11-02T21:33:00.914Z,1667424780.914 [LcmUniversalReporter] Loaded 2022-11-02T21:33:00.914Z,1667424780.914 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread. 2022-11-02T21:33:01.728Z,1667424781.728 [BPC1] Loaded 2022-11-02T21:33:01.728Z,1667424781.728 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2022-11-02T21:33:01.870Z,1667424781.870 [DataOverHttps] Loaded 2022-11-02T21:33:01.870Z,1667424781.870 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread. 2022-11-02T21:33:01.872Z,1667424781.872 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 40A854E0 2022-11-02T21:33:01.872Z,1667424781.872 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 924 2022-11-02T21:33:01.893Z,1667424781.893 [Depth_Keller] Loaded 2022-11-02T21:33:01.893Z,1667424781.893 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2022-11-02T21:33:01.898Z,1667424781.898 [DropWeight] Loaded 2022-11-02T21:33:01.898Z,1667424781.898 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread. 2022-11-02T21:33:01.916Z,1667424781.916 [MultiRay] Loaded 2022-11-02T21:33:01.916Z,1667424781.916 [ComponentRegistry](DEBUG): SyncComponent "MultiRay" handled in the control thread. 2022-11-02T21:33:01.978Z,1667424781.978 [NAL9602] Loaded 2022-11-02T21:33:01.978Z,1667424781.978 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2022-11-02T21:33:02.009Z,1667424782.009 [Onboard] Loaded 2022-11-02T21:33:02.009Z,1667424782.009 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread. 2022-11-02T21:33:02.010Z,1667424782.010 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 40AB54E0 2022-11-02T21:33:02.011Z,1667424782.011 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 925 2022-11-02T21:33:02.017Z,1667424782.017 [PowerOnly](INFO): Adding load control power supply at /dev/loadC3 2022-11-02T21:33:02.028Z,1667424782.028 [PowerOnly] Loaded 2022-11-02T21:33:02.028Z,1667424782.028 [ComponentRegistry](DEBUG): SyncComponent "PowerOnly" handled in the control thread. 2022-11-02T21:33:02.040Z,1667424782.040 [Power24vConverter] Loaded 2022-11-02T21:33:02.040Z,1667424782.040 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread. 2022-11-02T21:33:02.054Z,1667424782.054 [Radio_Surface] Loaded 2022-11-02T21:33:02.054Z,1667424782.054 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2022-11-02T21:33:02.055Z,1667424782.055 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 40AE54E0 2022-11-02T21:33:02.055Z,1667424782.055 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 926 2022-11-02T21:33:02.148Z,1667424782.148 [DAT] Loaded 2022-11-02T21:33:02.149Z,1667424782.149 [ComponentRegistry](DEBUG): Component "DAT" handled in its own thread. 2022-11-02T21:33:02.150Z,1667424782.150 [DAT ThreadHandler](DEBUG): Created PCaller Thread at 40B154E0 2022-11-02T21:33:02.150Z,1667424782.150 [DAT ThreadHandler](INFO): Protected caller Thread ID is 927 2022-11-02T21:33:02.151Z,1667424782.151 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2022-11-02T21:33:02.151Z,1667424782.151 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2022-11-02T21:33:02.322Z,1667424782.322 [SBIT](DEBUG): Construct Startup Built In Test. 2022-11-02T21:33:02.331Z,1667424782.331 [SBIT] Loaded 2022-11-02T21:33:02.332Z,1667424782.332 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2022-11-02T21:33:02.335Z,1667424782.335 [IBIT](DEBUG): Construct Initiated Built In Test. 2022-11-02T21:33:02.349Z,1667424782.349 [IBIT] Loaded 2022-11-02T21:33:02.349Z,1667424782.349 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2022-11-02T21:33:02.354Z,1667424782.354 [CBIT](DEBUG): Construct Continuous Built In Test. 2022-11-02T21:33:02.459Z,1667424782.459 [CBIT] Loaded 2022-11-02T21:33:02.460Z,1667424782.460 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2022-11-02T21:33:02.460Z,1667424782.460 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2022-11-02T21:33:02.461Z,1667424782.461 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2022-11-02T21:33:02.504Z,1667424782.504 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2022-11-02T21:33:02.511Z,1667424782.511 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2022-11-02T21:33:02.514Z,1667424782.514 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2022-11-02T21:33:02.526Z,1667424782.526 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2022-11-02T21:33:02.527Z,1667424782.527 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40BA34E0 2022-11-02T21:33:02.527Z,1667424782.527 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 928 2022-11-02T21:33:02.532Z,1667424782.532 [Supervisor](INFO): Main Thread ID is 829 2022-11-02T21:33:02.532Z,1667424782.532 [Supervisor](DEBUG): Running supervisor. 2022-11-02T21:33:02.532Z,1667424782.532 [CommandExec ThreadHandler](INFO): Handler Thread ID is 929 2022-11-02T21:33:02.533Z,1667424782.533 [CommandExec](INFO): Initializing the command executive. 2022-11-02T21:33:02.534Z,1667424782.534 [CommandLine ThreadHandler](INFO): Handler Thread ID is 930 2022-11-02T21:33:02.536Z,1667424782.536 [controlThread ThreadHandler](INFO): Handler Thread ID is 931 2022-11-02T21:33:02.537Z,1667424782.537 [controlThread](DEBUG): Initializing ControlThread 2022-11-02T21:33:02.538Z,1667424782.538 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2022-11-02T21:33:02.539Z,1667424782.539 [NavChart](DEBUG): Initialize NavChart Navigation. 2022-11-02T21:33:02.539Z,1667424782.539 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2022-11-02T21:33:02.543Z,1667424782.543 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2022-11-02T21:33:02.545Z,1667424782.545 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2022-11-02T21:33:02.546Z,1667424782.546 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2022-11-02T21:33:02.546Z,1667424782.546 [LoopControl](DEBUG): Initialize LoopControlComponent. 2022-11-02T21:33:02.547Z,1667424782.547 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2022-11-02T21:33:02.547Z,1667424782.547 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2022-11-02T21:33:02.548Z,1667424782.548 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2022-11-02T21:33:02.548Z,1667424782.548 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2022-11-02T21:33:02.548Z,1667424782.548 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator. 2022-11-02T21:33:02.553Z,1667424782.553 [SBIT](INFO): Initialize SBIT Component. 2022-11-02T21:33:02.554Z,1667424782.554 [SBIT](IMPORTANT): git: 2022-10-11-37-g3067145cf 2022-11-02T21:33:02.554Z,1667424782.554 [SBIT](INFO): git hash: 3067145cfe0a71a9d335ed48764d88f81a84ec20 2022-11-02T21:33:02.554Z,1667424782.554 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2022-11-02T21:33:02.555Z,1667424782.555 [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-02T21:33:02.557Z,1667424782.557 [SBIT](INFO): Beginning SBIT in 109.000000 seconds. 2022-11-02T21:33:02.557Z,1667424782.557 [IBIT](INFO): Initialize IBIT Component. 2022-11-02T21:33:02.558Z,1667424782.558 [CBIT](DEBUG): Initialize CBIT Component. 2022-11-02T21:33:02.559Z,1667424782.559 [logger ThreadHandler](INFO): Handler Thread ID is 932 2022-11-02T21:33:02.571Z,1667424782.571 [CBIT](DEBUG): Initialized mux pins. 2022-11-02T21:33:02.571Z,1667424782.571 [CBIT](DEBUG): Initializing the watchdog timer. 2022-11-02T21:33:02.580Z,1667424782.580 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 933 2022-11-02T21:33:02.584Z,1667424782.584 [WetLabsBB2FL](INFO): Powering up 2022-11-02T21:33:02.585Z,1667424782.585 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 935 2022-11-02T21:33:02.592Z,1667424782.592 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 936 2022-11-02T21:33:02.593Z,1667424782.593 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2022-11-02T21:33:02.595Z,1667424782.595 [CBIT](INFO): Last reboot was NOT due to watchdog timer. 2022-11-02T21:33:02.596Z,1667424782.596 [CBIT](DEBUG): Initializing heartbeat. 2022-11-02T21:33:02.604Z,1667424782.604 [Onboard ThreadHandler](INFO): Handler Thread ID is 937 2022-11-02T21:33:02.621Z,1667424782.621 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 938 2022-11-02T21:33:02.644Z,1667424782.644 [DAT ThreadHandler](INFO): Handler Thread ID is 939 2022-11-02T21:33:02.644Z,1667424782.644 [DAT](INFO): Powering up 2022-11-02T21:33:02.645Z,1667424782.645 [DAT](DEBUG): Initializing DAT. 2022-11-02T21:33:02.648Z,1667424782.648 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 941 2022-11-02T21:33:02.656Z,1667424782.656 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000 2022-11-02T21:33:02.657Z,1667424782.657 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000 2022-11-02T21:33:02.657Z,1667424782.657 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000 2022-11-02T21:33:02.657Z,1667424782.657 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000 2022-11-02T21:33:02.657Z,1667424782.657 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000 2022-11-02T21:33:02.657Z,1667424782.657 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000 2022-11-02T21:33:02.658Z,1667424782.658 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000 2022-11-02T21:33:02.658Z,1667424782.658 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000 2022-11-02T21:33:02.667Z,1667424782.667 [CBIT](DEBUG): Deactivating GF circuits. 2022-11-02T21:33:02.667Z,1667424782.667 [CBIT](DEBUG): Deactivating emergency mode. 2022-11-02T21:33:02.703Z,1667424782.703 [CBIT](DEBUG): Backplane powered. 2022-11-02T21:33:02.704Z,1667424782.704 [MissionManager](INFO): Loading Mission from file: Missions/Startup.xml 2022-11-02T21:33:02.741Z,1667424782.741 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2022-11-02T21:33:02.765Z,1667424782.765 [MissionManager](DEBUG): 2022-11-02T21:33:02.766Z,1667424782.766 [MissionManager](INFO): Loading Mission from file: Missions/Default.xml 2022-11-02T21:33:02.864Z,1667424782.864 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min 2022-11-02T21:33:02.865Z,1667424782.865 [Default:A.Wait](DEBUG): Construct Wait. 2022-11-02T21:33:02.867Z,1667424782.867 [Default:B.GoToSurface](DEBUG): Construct GoToSurface. 2022-11-02T21:33:02.886Z,1667424782.886 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2022-11-02T21:33:02.929Z,1667424782.929 [Default:CheckIn:C.Wait](DEBUG): Construct Wait. 2022-11-02T21:33:02.935Z,1667424782.935 [Default:E.Execute](DEBUG): Construct Execute. 2022-11-02T21:33:02.950Z,1667424782.950 [MissionManager](DEBUG): 0 Wait a moment to see if the scheduler starts a new mission before starting to actually run Default. 13 Burn on Dropped weight due to communications timeout. 5 Default mission has been running for Restarting logs and Default mission. restart logs 2022-11-02T21:33:02.955Z,1667424782.955 [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-02T21:33:02.988Z,1667424782.988 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2022-11-02T21:33:03.027Z,1667424783.027 [Radio_Surface](INFO): Powering up 2022-11-02T21:33:03.132Z,1667424783.132 [Depth_Keller](ERROR): Pressure reading out of range: 1628.471313 decibar 2022-11-02T21:33:03.133Z,1667424783.133 [MultiRay](INFO): Powering up MultiRay Lights 2022-11-02T21:33:03.176Z,1667424783.176 [Power24vConverter](INFO): Powering up. 2022-11-02T21:33:03.184Z,1667424783.184 [DepthRateCalculator](ERROR): Depth measurement is not active 2022-11-02T21:33:03.217Z,1667424783.217 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2022-11-02T21:33:03.223Z,1667424783.223 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2022-11-02T21:33:03.225Z,1667424783.225 [ElevatorServo](DEBUG): Initializing EZServoServo. 2022-11-02T21:33:03.231Z,1667424783.231 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2022-11-02T21:33:03.232Z,1667424783.232 [MassServo](DEBUG): Initializing EZServoServo. 2022-11-02T21:33:03.239Z,1667424783.239 [MassServo](DEBUG): Initializing MassServo. 2022-11-02T21:33:03.240Z,1667424783.240 [RudderServo](DEBUG): Initializing EZServoServo. 2022-11-02T21:33:03.247Z,1667424783.247 [RudderServo](DEBUG): Initializing RudderServo. 2022-11-02T21:33:03.248Z,1667424783.248 [ThrusterHE](DEBUG): Initializing EZServoServo. 2022-11-02T21:33:03.255Z,1667424783.255 [ThrusterHE](DEBUG): Initializing ThrusterHE. 2022-11-02T21:33:03.406Z,1667424783.406 [DropWeight](CRITICAL): DROP WEIGHT MISSING. 2022-11-02T21:33:03.407Z,1667424783.407 [DropWeight] Hardware Fault, FailCount= 1 2022-11-02T21:33:03.407Z,1667424783.407 [DropWeight](ERROR): Hardware Fault 2022-11-02T21:33:03.432Z,1667424783.432 [MultiRay](IMPORTANT): All lights off 2022-11-02T21:33:03.477Z,1667424783.477 [CommandExec](FAULT): Scheduling is paused 2022-11-02T21:33:03.478Z,1667424783.478 [CBIT](INFO): Critical error at 20221102T213303 2022-11-02T21:33:03.478Z,1667424783.478 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals 2022-11-02T21:33:03.489Z,1667424783.489 [CBIT](ERROR): Hardware Fault in component: DropWeight 2022-11-02T21:33:03.489Z,1667424783.489 [CBIT](CRITICAL): Hardware Fault in component: DropWeight 2022-11-02T21:33:04.099Z,1667424784.099 [RudderServo](ERROR): Rudder initialization uart error serial timeout 2022-11-02T21:33:04.099Z,1667424784.099 [RudderServo](FAULT): Rudder failed to initialize 2022-11-02T21:33:04.100Z,1667424784.100 [RudderServo] Communications Fault, FailCount= 1 2022-11-02T21:33:04.100Z,1667424784.100 [RudderServo](ERROR): Communications Fault 2022-11-02T21:33:04.101Z,1667424784.101 [CBIT](INFO): Critical error at 20221102T213303 2022-11-02T21:33:04.104Z,1667424784.104 [CBIT](ERROR): Communications Fault in component: RudderServo 2022-11-02T21:33:04.340Z,1667424784.340 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2022-11-02T21:33:04.340Z,1667424784.340 [RudderServo](INFO): Powering down 2022-11-02T21:33:05.004Z,1667424785.004 [RudderServo](DEBUG): Initializing EZServoServo. 2022-11-02T21:33:05.124Z,1667424785.124 [RudderServo](DEBUG): Initializing RudderServo. 2022-11-02T21:33:05.128Z,1667424785.128 [CBIT](INFO): Clearing failed state for component RudderServo 2022-11-02T21:33:05.128Z,1667424785.128 [RudderServo] No Fault, FailCount= 1 2022-11-02T21:33:05.195Z,1667424785.195 [WetLabsBB2FL](INFO): Powering down 2022-11-02T21:33:08.972Z,1667424788.972 [ThrusterHE](ERROR): Zero Speed Commanded. 2022-11-02T21:33:18.018Z,1667424798.018 [DAT](INFO): commRate: 800 2022-11-02T21:33:20.083Z,1667424800.083 [DAT](INFO): entering command mode 2022-11-02T21:33:20.284Z,1667424800.284 [DAT](INFO): setting verbose to 3 2022-11-02T21:33:20.537Z,1667424800.537 [DAT](INFO): set verbose to 3 2022-11-02T21:33:20.537Z,1667424800.537 [DAT](INFO): setting DatVerbose to 27440 2022-11-02T21:33:20.789Z,1667424800.789 [DAT](INFO): set DatVerbose to 27440 2022-11-02T21:33:20.790Z,1667424800.790 [DAT](INFO): setting transmit power to 8 2022-11-02T21:33:21.041Z,1667424801.041 [DAT](INFO): set transmit power to 8 2022-11-02T21:33:21.041Z,1667424801.041 [DAT](INFO): setting local address to 10 2022-11-02T21:33:21.293Z,1667424801.293 [DAT](INFO): set local address to 10 2022-11-02T21:33:21.294Z,1667424801.294 [DAT](INFO): Setting time to: 21:33:21 And date to:11/2/2022 2022-11-02T21:33:21.545Z,1667424801.545 [DAT](INFO): Local DAT time set to Wed Nov 2, 2022 21:33:21 2022-11-02T21:33:32.109Z,1667424812.109 [NAL9602](INFO): Powering up NAL9602 2022-11-02T21:33:42.997Z,1667424822.997 [NAL9602](INFO): NAL9602 initialized 2022-11-02T21:34:03.863Z,1667424843.863 [CommandExec](IMPORTANT): got command run ./Missions/Maintenance/multiray_mode1.xml 2022-11-02T21:34:03.863Z,1667424843.863 [MissionManager](INFO): Loading Mission from file: ./Missions/Maintenance/multiray_mode1.xml 2022-11-02T21:34:03.900Z,1667424843.900 [MissionManager](INFO): DefineArg multiray_lab.MissionTimeout = 1.000000 min 2022-11-02T21:34:03.903Z,1667424843.903 [MissionManager](INFO): DefineArg multiray_lab.LightDuration = 1.000000 s 2022-11-02T21:34:03.906Z,1667424843.906 [MissionManager](INFO): DefineArg multiray_lab.LightMode0 = 0.000000 count 2022-11-02T21:34:03.909Z,1667424843.909 [MissionManager](INFO): DefineArg multiray_lab.LightMode1 = 1.000000 count 2022-11-02T21:34:03.913Z,1667424843.913 [MissionManager](INFO): DefineArg multiray_lab.LightMode2 = 2.000000 count 2022-11-02T21:34:03.919Z,1667424843.919 [MissionManager](DEBUG): This mission is designed to run in the lab only. Turns on and off MultiRay lights. How long to let the mission run. 1 How long to wait before turning on / off lights, default 1 second 1 Light mode = 0 0 Light mode = 1 1 Light mode = 2 2 2022-11-02T21:34:03.921Z,1667424843.921 [CommandExec](IMPORTANT): Running ./Missions/Maintenance/multiray_mode1.xml 2022-11-02T21:34:52.126Z,1667424892.126 [SBIT](IMPORTANT): Beginning Startup BIT 2022-11-02T21:34:52.131Z,1667424892.131 [CBIT](IMPORTANT): Beginning ground fault scan 2022-11-02T21:35:02.293Z,1667424902.293 [CommandExec](IMPORTANT): got command run ./Missions/Maintenance/multiray_mode1.xml 2022-11-02T21:35:02.294Z,1667424902.294 [MissionManager](INFO): Uninitializing Mission multiray_lab 2022-11-02T21:35:02.295Z,1667424902.295 [MissionManager](INFO): Loading Mission from file: ./Missions/Maintenance/multiray_mode1.xml 2022-11-02T21:35:02.341Z,1667424902.341 [MissionManager](INFO): DefineArg multiray_lab.MissionTimeout = 1.000000 min 2022-11-02T21:35:02.346Z,1667424902.346 [MissionManager](INFO): DefineArg multiray_lab.LightDuration = 1.000000 s 2022-11-02T21:35:02.348Z,1667424902.348 [MissionManager](INFO): DefineArg multiray_lab.LightMode0 = 0.000000 count 2022-11-02T21:35:02.350Z,1667424902.350 [MissionManager](INFO): DefineArg multiray_lab.LightMode1 = 1.000000 count 2022-11-02T21:35:02.352Z,1667424902.352 [MissionManager](INFO): DefineArg multiray_lab.LightMode2 = 2.000000 count 2022-11-02T21:35:02.357Z,1667424902.357 [MissionManager](DEBUG): This mission is designed to run in the lab only. Turns on and off MultiRay lights. How long to let the mission run. 1 How long to wait before turning on / off lights, default 1 second 1 Light mode = 0 0 Light mode = 1 1 Light mode = 2 2 2022-11-02T21:35:02.359Z,1667424902.359 [CommandExec](IMPORTANT): Running ./Missions/Maintenance/multiray_mode1.xml 2022-11-02T21:35:03.069Z,1667424903.069 [CBIT](IMPORTANT): No ground fault detected mA: CHAN A0 (Batt): 0.013639 CHAN A1 (24V): 0.000717 CHAN A2 (12V): -0.004922 CHAN A3 (5V): -0.003164 CHAN B0 (3.3V): -0.001036 CHAN B1 (3.15aV): -0.001684 CHAN B2 (3.15bV): -0.002077 CHAN B3 (GND): -0.000516 OPEN: 0.006354 Full Scale: +/- 1 mA 2022-11-02T21:35:07.746Z,1667424907.746 [CommandExec](IMPORTANT): got command run ./Missions/Maintenance/multiray_mode1.xml 2022-11-02T21:35:07.750Z,1667424907.750 [MissionManager](INFO): Uninitializing Mission multiray_lab 2022-11-02T21:35:07.771Z,1667424907.771 [MissionManager](INFO): Loading Mission from file: ./Missions/Maintenance/multiray_mode1.xml 2022-11-02T21:35:07.798Z,1667424907.798 [MissionManager](INFO): DefineArg multiray_lab.MissionTimeout = 1.000000 min 2022-11-02T21:35:07.801Z,1667424907.801 [MissionManager](INFO): DefineArg multiray_lab.LightDuration = 1.000000 s 2022-11-02T21:35:07.803Z,1667424907.803 [MissionManager](INFO): DefineArg multiray_lab.LightMode0 = 0.000000 count 2022-11-02T21:35:07.841Z,1667424907.841 [MissionManager](INFO): DefineArg multiray_lab.LightMode1 = 1.000000 count 2022-11-02T21:35:07.843Z,1667424907.843 [MissionManager](INFO): DefineArg multiray_lab.LightMode2 = 2.000000 count 2022-11-02T21:35:07.863Z,1667424907.863 [MissionManager](DEBUG): This mission is designed to run in the lab only. Turns on and off MultiRay lights. How long to let the mission run. 1 How long to wait before turning on / off lights, default 1 second 1 Light mode = 0 0 Light mode = 1 1 Light mode = 2 2 2022-11-02T21:35:07.865Z,1667424907.865 [CommandExec](IMPORTANT): Running ./Missions/Maintenance/multiray_mode1.xml 2022-11-02T21:34:33.981Z,1667424873.981 [CommandExec](IMPORTANT): got command run ./Missions/Maintenance/multiray_mode1.xml 2022-11-02T21:34:33.981Z,1667424873.981 [MissionManager](INFO): Uninitializing Mission multiray_lab 2022-11-02T21:34:33.982Z,1667424873.982 [MissionManager](INFO): Loading Mission from file: ./Missions/Maintenance/multiray_mode1.xml 2022-11-02T21:34:34.023Z,1667424874.023 [MissionManager](INFO): DefineArg multiray_lab.MissionTimeout = 1.000000 min 2022-11-02T21:34:34.025Z,1667424874.025 [MissionManager](INFO): DefineArg multiray_lab.LightDuration = 1.000000 s 2022-11-02T21:34:34.027Z,1667424874.027 [MissionManager](INFO): DefineArg multiray_lab.LightMode0 = 0.000000 count 2022-11-02T21:34:34.029Z,1667424874.029 [MissionManager](INFO): DefineArg multiray_lab.LightMode1 = 1.000000 count 2022-11-02T21:34:34.031Z,1667424874.031 [MissionManager](INFO): DefineArg multiray_lab.LightMode2 = 2.000000 count 2022-11-02T21:34:34.036Z,1667424874.036 [MissionManager](DEBUG): This mission is designed to run in the lab only. Turns on and off MultiRay lights. How long to let the mission run. 1 How long to wait before turning on / off lights, default 1 second 1 Light mode = 0 0 Light mode = 1 1 Light mode = 2 2 2022-11-02T21:34:34.038Z,1667424874.038 [CommandExec](IMPORTANT): Running ./Missions/Maintenance/multiray_mode1.xml 2022-11-02T21:35:02.369Z,1667424902.369 [BPC1](ERROR): BPC1A: No match for serial number 1717 in BPC1A's battery stick inventory (sticks 1-32 in onboard configuration file). 2022-11-02T21:35:05.310Z,1667424905.310 [CommandExec](IMPORTANT): got command run ./Missions/Maintenance/multiray_mode1.xml 2022-11-02T21:35:05.310Z,1667424905.310 [MissionManager](INFO): Uninitializing Mission multiray_lab 2022-11-02T21:35:05.311Z,1667424905.311 [MissionManager](INFO): Loading Mission from file: ./Missions/Maintenance/multiray_mode1.xml 2022-11-02T21:35:05.329Z,1667424905.329 [MissionManager](INFO): DefineArg multiray_lab.MissionTimeout = 1.000000 min 2022-11-02T21:35:05.331Z,1667424905.331 [MissionManager](INFO): DefineArg multiray_lab.LightDuration = 1.000000 s 2022-11-02T21:35:05.365Z,1667424905.365 [MissionManager](INFO): DefineArg multiray_lab.LightMode0 = 0.000000 count 2022-11-02T21:35:05.368Z,1667424905.368 [MissionManager](INFO): DefineArg multiray_lab.LightMode1 = 1.000000 count 2022-11-02T21:35:05.369Z,1667424905.369 [MissionManager](INFO): DefineArg multiray_lab.LightMode2 = 2.000000 count 2022-11-02T21:35:05.375Z,1667424905.375 [MissionManager](DEBUG): This mission is designed to run in the lab only. Turns on and off MultiRay lights. How long to let the mission run. 1 How long to wait before turning on / off lights, default 1 second 1 Light mode = 0 0 Light mode = 1 1 Light mode = 2 2 2022-11-02T21:35:05.376Z,1667424905.376 [CommandExec](IMPORTANT): Running ./Missions/Maintenance/multiray_mode1.xml 2022-11-02T21:35:46.030Z,1667424946.030 [SBIT](IMPORTANT): SBIT PASSED 2022-11-02T21:35:46.030Z,1667424946.030 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg 2022-11-02T21:35:46.031Z,1667424946.031 [SBIT](IMPORTANT): BackseatComponent.needs24v=1 bool; 2022-11-02T21:35:46.032Z,1667424946.032 [SBIT](IMPORTANT): BuoyancyServo.fastPumpCoefficient=6 none; 2022-11-02T21:35:46.032Z,1667424946.032 [SBIT](IMPORTANT): CBIT.gf24Offset=149 microampere; 2022-11-02T21:35:46.032Z,1667424946.032 [SBIT](IMPORTANT): CBIT.gfScanTimeout=2 hour; 2022-11-02T21:35:46.032Z,1667424946.032 [SBIT](IMPORTANT): CTD_Seabird.loadAtStartup=0 bool; 2022-11-02T21:35:46.032Z,1667424946.032 [SBIT](IMPORTANT): DAT.surfaceThreshold=-1 meter; 2022-11-02T21:35:46.032Z,1667424946.032 [SBIT](IMPORTANT): Express none _.ayeris_disk_space; 2022-11-02T21:35:46.032Z,1667424946.032 [SBIT](IMPORTANT): Express linearApproximation _.ayeris_particle_counts 250.000000 count; 2022-11-02T21:35:46.032Z,1667424946.032 [SBIT](IMPORTANT): Express none _.ayeris_particle_size; 2022-11-02T21:35:46.033Z,1667424946.033 [SBIT](IMPORTANT): IBIT.batteryCapacityThreshold=5 ampere_hour; 2022-11-02T21:35:46.033Z,1667424946.033 [SBIT](IMPORTANT): IBIT.batteryVoltageThreshold=11 volt; 2022-11-02T21:35:46.033Z,1667424946.033 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=210.367112 cubic_centimeter; 2022-11-02T21:35:46.033Z,1667424946.033 [SBIT](IMPORTANT): VerticalControl.massDefault=22.333859 millimeter; 2022-11-02T21:35:46.449Z,1667424946.449 [MissionManager](IMPORTANT): Started mission Startup 2022-11-02T21:35:46.449Z,1667424946.449 [Startup] Running Loop=1 2022-11-02T21:35:46.450Z,1667424946.450 [Startup](DEBUG): Aggregate::initialize Startup 2022-11-02T21:35:46.450Z,1667424946.450 [Startup:A.GoToSurface] Running Loop=1 2022-11-02T21:35:46.450Z,1667424946.450 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2022-11-02T21:35:46.450Z,1667424946.450 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2022-11-02T21:35:46.451Z,1667424946.451 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2022-11-02T21:35:46.451Z,1667424946.451 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2022-11-02T21:35:46.452Z,1667424946.452 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2022-11-02T21:35:46.453Z,1667424946.453 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2022-11-02T21:35:46.456Z,1667424946.456 [Startup:StartupSatComms] Running Loop=1 2022-11-02T21:35:46.456Z,1667424946.456 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms 2022-11-02T21:35:46.457Z,1667424946.457 [Startup:StartupSatComms:A] Running Loop=1 2022-11-02T21:35:46.866Z,1667424946.866 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix 2022-11-02T21:35:59.814Z,1667424959.814 [CommandExec](IMPORTANT): got command run ./Missions/Maintenance/multiray_mode1.xml 2022-11-02T21:35:59.814Z,1667424959.814 [MissionManager](INFO): Uninitializing Mission multiray_lab 2022-11-02T21:35:59.815Z,1667424959.815 [MissionManager](INFO): Loading Mission from file: ./Missions/Maintenance/multiray_mode1.xml 2022-11-02T21:35:59.901Z,1667424959.901 [MissionManager](INFO): DefineArg multiray_lab.MissionTimeout = 1.000000 min 2022-11-02T21:35:59.903Z,1667424959.903 [MissionManager](INFO): DefineArg multiray_lab.LightDuration = 1.000000 s 2022-11-02T21:35:59.909Z,1667424959.909 [MissionManager](INFO): DefineArg multiray_lab.LightMode0 = 0.000000 count 2022-11-02T21:35:59.915Z,1667424959.915 [MissionManager](INFO): DefineArg multiray_lab.LightMode1 = 1.000000 count 2022-11-02T21:35:59.917Z,1667424959.917 [MissionManager](INFO): DefineArg multiray_lab.LightMode2 = 2.000000 count 2022-11-02T21:35:59.926Z,1667424959.926 [MissionManager](DEBUG): This mission is designed to run in the lab only. Turns on and off MultiRay lights. How long to let the mission run. 1 How long to wait before turning on / off lights, default 1 second 1 Light mode = 0 0 Light mode = 1 1 Light mode = 2 2 2022-11-02T21:35:59.951Z,1667424959.951 [CommandExec](IMPORTANT): Running ./Missions/Maintenance/multiray_mode1.xml 2022-11-02T21:36:02.604Z,1667424962.604 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1 2022-11-02T21:36:02.604Z,1667424962.604 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2022-11-02T21:36:02.605Z,1667424962.605 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 1 2022-11-02T21:36:02.605Z,1667424962.605 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2022-11-02T21:36:02.620Z,1667424962.620 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2022-11-02T21:36:02.620Z,1667424962.620 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2022-11-02T21:36:02.997Z,1667424962.997 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2022-11-02T21:36:02.997Z,1667424962.997 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1 2022-11-02T21:36:02.997Z,1667424962.997 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2022-11-02T21:36:02.997Z,1667424962.997 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 1 2022-11-02T21:36:03.257Z,1667424963.257 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004472 2022-11-02T21:36:03.385Z,1667424963.385 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2022-11-02T21:36:34.758Z,1667424994.758 [CommandExec](IMPORTANT): got command run ./Missions/Maintenance/multiray_mode1.xml 2022-11-02T21:36:34.758Z,1667424994.758 [MissionManager](INFO): Uninitializing Mission multiray_lab 2022-11-02T21:36:34.764Z,1667424994.764 [MissionManager](INFO): Loading Mission from file: ./Missions/Maintenance/multiray_mode1.xml 2022-11-02T21:36:34.832Z,1667424994.832 [MissionManager](INFO): DefineArg multiray_lab.MissionTimeout = 1.000000 min 2022-11-02T21:36:34.834Z,1667424994.834 [MissionManager](INFO): DefineArg multiray_lab.LightDuration = 1.000000 s 2022-11-02T21:36:34.841Z,1667424994.841 [MissionManager](INFO): DefineArg multiray_lab.LightMode0 = 0.000000 count 2022-11-02T21:36:34.843Z,1667424994.843 [MissionManager](INFO): DefineArg multiray_lab.LightMode1 = 1.000000 count 2022-11-02T21:36:34.849Z,1667424994.849 [MissionManager](INFO): DefineArg multiray_lab.LightMode2 = 2.000000 count 2022-11-02T21:36:34.857Z,1667424994.857 [MissionManager](DEBUG): This mission is designed to run in the lab only. Turns on and off MultiRay lights. How long to let the mission run. 1 How long to wait before turning on / off lights, default 1 second 1 Light mode = 0 0 Light mode = 1 1 Light mode = 2 2 2022-11-02T21:36:34.859Z,1667424994.859 [CommandExec](IMPORTANT): Running ./Missions/Maintenance/multiray_mode1.xml 2022-11-02T21:36:46.634Z,1667425006.634 [Startup:StartupSatComms:A](INFO): Timed out from 2022-11-02T21:35:46.5Z 2022-11-02T21:36:46.634Z,1667425006.634 [Startup:StartupSatComms:A] Stopped 2022-11-02T21:36:46.635Z,1667425006.635 [Startup:StartupSatComms:B] Running Loop=1 2022-11-02T21:36:47.043Z,1667425007.043 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications 2022-11-02T21:36:48.688Z,1667425008.688 [DAT](DEBUG): In sendingFillBuffer, set commsState_ = SENDING_TRANSMIT 2022-11-02T21:36:48.690Z,1667425008.690 [DAT](INFO): setting remote address to 1 2022-11-02T21:36:48.941Z,1667425008.941 [DAT](INFO): set remote address to 1 2022-11-02T21:36:48.942Z,1667425008.942 [DAT](INFO): entering online mode 2022-11-02T21:36:49.194Z,1667425009.194 [DAT](INFO): commRate: 800 2022-11-02T21:36:49.194Z,1667425009.194 [DAT](INFO): online mode acknowledged 2022-11-02T21:36:49.194Z,1667425009.194 [DAT](DEBUG): In sendingTransmit, set commsState_ = SENDING_TRANSMIT_VERIFY 2022-11-02T21:36:52.469Z,1667425012.469 [DAT](DEBUG): In parseResponses, set commsState_ = SENDING_ACK_WAITING 2022-11-02T21:36:55.171Z,1667425015.171 [DataOverHttps](INFO): Sending 169 bytes from file Logs/20221102T175003/Courier0004.lzma 2022-11-02T21:36:56.173Z,1667425016.173 [DataOverHttps](INFO): Moved sent file to Logs/20221102T175003/Courier0004.lzma.bak 2022-11-02T21:36:56.174Z,1667425016.174 [DataOverHttps](INFO): SBD MOMSN=17269886 2022-11-02T21:37:04.773Z,1667425024.773 [CommandExec](IMPORTANT): got command run ./Missions/Maintenance/multiray_mode1.xml 2022-11-02T21:37:04.773Z,1667425024.773 [MissionManager](INFO): Uninitializing Mission multiray_lab 2022-11-02T21:37:04.775Z,1667425024.775 [MissionManager](INFO): Loading Mission from file: ./Missions/Maintenance/multiray_mode1.xml 2022-11-02T21:37:04.806Z,1667425024.806 [MissionManager](INFO): DefineArg multiray_lab.MissionTimeout = 1.000000 min 2022-11-02T21:37:04.809Z,1667425024.809 [MissionManager](INFO): DefineArg multiray_lab.LightDuration = 1.000000 s 2022-11-02T21:37:04.814Z,1667425024.814 [MissionManager](INFO): DefineArg multiray_lab.LightMode0 = 0.000000 count 2022-11-02T21:37:04.833Z,1667425024.833 [MissionManager](INFO): DefineArg multiray_lab.LightMode1 = 1.000000 count 2022-11-02T21:37:04.839Z,1667425024.839 [MissionManager](INFO): DefineArg multiray_lab.LightMode2 = 2.000000 count 2022-11-02T21:37:04.848Z,1667425024.848 [MissionManager](DEBUG): This mission is designed to run in the lab only. Turns on and off MultiRay lights. How long to let the mission run. 1 How long to wait before turning on / off lights, default 1 second 1 Light mode = 0 0 Light mode = 1 1 Light mode = 2 2 2022-11-02T21:37:04.850Z,1667425024.850 [CommandExec](IMPORTANT): Running ./Missions/Maintenance/multiray_mode1.xml 2022-11-02T21:37:07.588Z,1667425027.588 [DAT](DEBUG): In sendingAckWaiting, timeout so set commsState_ = SENDING_FILL_BUFFER 2022-11-02T21:37:09.085Z,1667425029.085 [DAT](DEBUG): In sendingFillBuffer, set commsState_ = SENDING_TRANSMIT 2022-11-02T21:37:09.091Z,1667425029.091 [DAT](DEBUG): In sendingTransmit, set commsState_ = SENDING_TRANSMIT_VERIFY 2022-11-02T21:37:12.195Z,1667425032.195 [CommandExec](IMPORTANT): got command run ./Missions/Maintenance/multiray_mode1.xml 2022-11-02T21:37:12.195Z,1667425032.195 [MissionManager](INFO): Uninitializing Mission multiray_lab 2022-11-02T21:37:12.201Z,1667425032.201 [MissionManager](INFO): Loading Mission from file: ./Missions/Maintenance/multiray_mode1.xml 2022-11-02T21:37:12.264Z,1667425032.264 [MissionManager](INFO): DefineArg multiray_lab.MissionTimeout = 1.000000 min 2022-11-02T21:37:12.266Z,1667425032.266 [MissionManager](INFO): DefineArg multiray_lab.LightDuration = 1.000000 s 2022-11-02T21:37:12.273Z,1667425032.273 [MissionManager](INFO): DefineArg multiray_lab.LightMode0 = 0.000000 count 2022-11-02T21:37:12.287Z,1667425032.287 [MissionManager](INFO): DefineArg multiray_lab.LightMode1 = 1.000000 count 2022-11-02T21:37:12.298Z,1667425032.298 [MissionManager](INFO): DefineArg multiray_lab.LightMode2 = 2.000000 count 2022-11-02T21:37:12.310Z,1667425032.310 [MissionManager](DEBUG): This mission is designed to run in the lab only. Turns on and off MultiRay lights. How long to let the mission run. 1 How long to wait before turning on / off lights, default 1 second 1 Light mode = 0 0 Light mode = 1 1 Light mode = 2 2 2022-11-02T21:37:12.320Z,1667425032.320 [CommandExec](IMPORTANT): Running ./Missions/Maintenance/multiray_mode1.xml 2022-11-02T21:37:12.365Z,1667425032.365 [DAT](DEBUG): In parseResponses, set commsState_ = SENDING_ACK_WAITING 2022-11-02T21:37:12.952Z,1667425032.952 [DataOverHttps](INFO): Sending 313 bytes from file Logs/20221102T204552/Courier0000.lzma 2022-11-02T21:37:13.953Z,1667425033.953 [DataOverHttps](INFO): Moved sent file to Logs/20221102T204552/Courier0000.lzma.bak 2022-11-02T21:37:13.953Z,1667425033.953 [DataOverHttps](INFO): SBD MOMSN=17269888 2022-11-02T21:37:19.939Z,1667425039.939 [CommandExec](IMPORTANT): got command run ./Missions/Maintenance/multiray_mode1.xml 2022-11-02T21:37:19.953Z,1667425039.953 [MissionManager](INFO): Uninitializing Mission multiray_lab 2022-11-02T21:37:19.954Z,1667425039.954 [MissionManager](INFO): Loading Mission from file: ./Missions/Maintenance/multiray_mode1.xml 2022-11-02T21:37:19.994Z,1667425039.994 [MissionManager](INFO): DefineArg multiray_lab.MissionTimeout = 1.000000 min 2022-11-02T21:37:20.027Z,1667425040.027 [MissionManager](INFO): DefineArg multiray_lab.LightDuration = 1.000000 s 2022-11-02T21:37:20.029Z,1667425040.029 [MissionManager](INFO): DefineArg multiray_lab.LightMode0 = 0.000000 count 2022-11-02T21:37:20.036Z,1667425040.036 [MissionManager](INFO): DefineArg multiray_lab.LightMode1 = 1.000000 count 2022-11-02T21:37:20.038Z,1667425040.038 [MissionManager](INFO): DefineArg multiray_lab.LightMode2 = 2.000000 count 2022-11-02T21:37:20.047Z,1667425040.047 [MissionManager](DEBUG): This mission is designed to run in the lab only. Turns on and off MultiRay lights. How long to let the mission run. 1 How long to wait before turning on / off lights, default 1 second 1 Light mode = 0 0 Light mode = 1 1 Light mode = 2 2 2022-11-02T21:37:20.077Z,1667425040.077 [CommandExec](IMPORTANT): Running ./Missions/Maintenance/multiray_mode1.xml 2022-11-02T21:37:29.861Z,1667425049.861 [DataOverHttps](INFO): Sending 313 bytes from file Logs/20221102T204734/Courier0000.lzma 2022-11-02T21:37:30.861Z,1667425050.861 [DataOverHttps](INFO): Moved sent file to Logs/20221102T204734/Courier0000.lzma.bak 2022-11-02T21:37:30.861Z,1667425050.861 [DataOverHttps](INFO): SBD MOMSN=17269895 2022-11-02T21:37:31.516Z,1667425051.516 [DAT](DEBUG): In sendingAckWaiting, timeout so set commsState_ = SENDING_FILL_BUFFER 2022-11-02T21:37:32.997Z,1667425052.997 [DAT](DEBUG): In sendingFillBuffer, set commsState_ = SENDING_TRANSMIT 2022-11-02T21:37:32.998Z,1667425052.998 [DAT](DEBUG): In sendingTransmit, set commsState_ = SENDING_TRANSMIT_VERIFY 2022-11-02T21:37:36.273Z,1667425056.273 [DAT](DEBUG): In parseResponses, set commsState_ = SENDING_ACK_WAITING 2022-11-02T21:37:41.454Z,1667425061.454 [CommandExec](IMPORTANT): got command run ./Missions/Maintenance/multiray_mode1.xml 2022-11-02T21:37:41.454Z,1667425061.454 [MissionManager](INFO): Uninitializing Mission multiray_lab 2022-11-02T21:37:41.456Z,1667425061.456 [MissionManager](INFO): Loading Mission from file: ./Missions/Maintenance/multiray_mode1.xml 2022-11-02T21:37:41.501Z,1667425061.501 [MissionManager](INFO): DefineArg multiray_lab.MissionTimeout = 1.000000 min 2022-11-02T21:37:41.504Z,1667425061.504 [MissionManager](INFO): DefineArg multiray_lab.LightDuration = 1.000000 s 2022-11-02T21:37:41.506Z,1667425061.506 [MissionManager](INFO): DefineArg multiray_lab.LightMode0 = 0.000000 count 2022-11-02T21:37:41.508Z,1667425061.508 [MissionManager](INFO): DefineArg multiray_lab.LightMode1 = 1.000000 count 2022-11-02T21:37:41.510Z,1667425061.510 [MissionManager](INFO): DefineArg multiray_lab.LightMode2 = 2.000000 count 2022-11-02T21:37:41.514Z,1667425061.514 [MissionManager](DEBUG): This mission is designed to run in the lab only. Turns on and off MultiRay lights. How long to let the mission run. 1 How long to wait before turning on / off lights, default 1 second 1 Light mode = 0 0 Light mode = 1 1 Light mode = 2 2 2022-11-02T21:37:41.516Z,1667425061.516 [CommandExec](IMPORTANT): Running ./Missions/Maintenance/multiray_mode1.xml 2022-11-02T21:37:46.938Z,1667425066.938 [Startup:StartupSatComms:B](INFO): Timed out from 2022-11-02T21:36:46.6Z 2022-11-02T21:37:46.938Z,1667425066.938 [Startup:StartupSatComms:B] Stopped 2022-11-02T21:37:46.938Z,1667425066.938 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms 2022-11-02T21:37:46.938Z,1667425066.938 [Startup:StartupSatComms] Stopped 2022-11-02T21:37:46.938Z,1667425066.938 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms 2022-11-02T21:37:46.939Z,1667425066.939 [Startup](INFO): Completed Startup 2022-11-02T21:37:46.943Z,1667425066.943 [MissionManager](INFO): Startup is completed. 2022-11-02T21:37:46.944Z,1667425066.944 [MissionManager](INFO): Uninitializing Mission Startup 2022-11-02T21:37:46.944Z,1667425066.944 [Startup] Stopped 2022-11-02T21:37:46.944Z,1667425066.944 [Startup](DEBUG): Aggregate::uninitialize Startup 2022-11-02T21:37:46.944Z,1667425066.944 [Startup:A.GoToSurface] Stopped 2022-11-02T21:37:46.944Z,1667425066.944 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2022-11-02T21:37:47.347Z,1667425067.347 [MissionManager](IMPORTANT): Started mission multiray_lab 2022-11-02T21:37:47.348Z,1667425067.348 [multiray_lab] Running Loop=1 2022-11-02T21:37:47.348Z,1667425067.348 [multiray_lab](DEBUG): Aggregate::initialize multiray_lab 2022-11-02T21:37:47.380Z,1667425067.380 [DAT](DEBUG): In sendingAckWaiting, timeout so set commsState_ = SENDING_FILL_BUFFER 2022-11-02T21:37:47.632Z,1667425067.632 [DAT](DEBUG): In sendingFillBuffer, set commsState_ = SENDING_TRANSMIT 2022-11-02T21:37:47.884Z,1667425067.884 [DAT](DEBUG): In sendingTransmit, set commsState_ = SENDING_TRANSMIT_VERIFY 2022-11-02T21:37:48.255Z,1667425068.255 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20221102T204734/Courier0004.lzma 2022-11-02T21:37:48.530Z,1667425068.530 [multiray_lab](INFO): Timed out from 2022-11-02T21:37:47.3Z 2022-11-02T21:37:48.530Z,1667425068.530 [multiray_lab:A_Timeout] Running Loop=1 2022-11-02T21:37:48.530Z,1667425068.530 [multiray_lab:A_Timeout](DEBUG): Aggregate::initialize multiray_lab:A_Timeout 2022-11-02T21:37:48.531Z,1667425068.531 [multiray_lab:A_Timeout:A] Running Loop=1 2022-11-02T21:37:48.531Z,1667425068.531 [multiray_lab:A_Timeout:A] Stopped 2022-11-02T21:37:48.531Z,1667425068.531 [multiray_lab:A_Timeout](INFO): Completed multiray_lab:A_Timeout 2022-11-02T21:37:48.531Z,1667425068.531 [MissionManager](INFO): multiray_lab is completed. 2022-11-02T21:37:48.532Z,1667425068.532 [MissionManager](INFO): Uninitializing Mission multiray_lab 2022-11-02T21:37:48.532Z,1667425068.532 [multiray_lab] Stopped 2022-11-02T21:37:48.532Z,1667425068.532 [multiray_lab](DEBUG): Aggregate::uninitialize multiray_lab 2022-11-02T21:37:48.953Z,1667425068.953 [MultiRay](INFO): Red lights on 2022-11-02T21:37:49.003Z,1667425069.003 [MissionManager](IMPORTANT): Started mission Default 2022-11-02T21:37:49.004Z,1667425069.004 [Default] Running Loop=1 2022-11-02T21:37:49.004Z,1667425069.004 [Default](DEBUG): Aggregate::initialize Default 2022-11-02T21:37:49.004Z,1667425069.004 [Default:B.GoToSurface] Running Loop=1 2022-11-02T21:37:49.004Z,1667425069.004 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2022-11-02T21:37:49.005Z,1667425069.005 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2022-11-02T21:37:49.005Z,1667425069.005 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2022-11-02T21:37:49.005Z,1667425069.005 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2022-11-02T21:37:49.005Z,1667425069.005 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2022-11-02T21:37:49.006Z,1667425069.006 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2022-11-02T21:37:49.006Z,1667425069.006 [Default:A.Wait] Running Loop=1 2022-11-02T21:37:49.006Z,1667425069.006 [Default:A.Wait](DEBUG): Initialize Wait Component. 2022-11-02T21:37:49.257Z,1667425069.257 [DataOverHttps](INFO): Moved sent file to Logs/20221102T204734/Courier0004.lzma.bak 2022-11-02T21:37:49.257Z,1667425069.257 [DataOverHttps](INFO): SBD MOMSN=17269902 2022-11-02T21:37:51.112Z,1667425071.112 [CommandExec](IMPORTANT): got command run ./Missions/Maintenance/multiray_mode1.xml 2022-11-02T21:37:51.113Z,1667425071.113 [MissionManager](INFO): Loading Mission from file: ./Missions/Maintenance/multiray_mode1.xml 2022-11-02T21:37:51.187Z,1667425071.187 [MissionManager](INFO): DefineArg multiray_lab.MissionTimeout = 1.000000 min 2022-11-02T21:37:51.216Z,1667425071.216 [MissionManager](INFO): DefineArg multiray_lab.LightDuration = 1.000000 s 2022-11-02T21:37:51.218Z,1667425071.218 [MissionManager](INFO): DefineArg multiray_lab.LightMode0 = 0.000000 count 2022-11-02T21:37:51.261Z,1667425071.261 [MissionManager](INFO): DefineArg multiray_lab.LightMode1 = 1.000000 count 2022-11-02T21:37:51.266Z,1667425071.266 [MissionManager](INFO): DefineArg multiray_lab.LightMode2 = 2.000000 count 2022-11-02T21:37:51.290Z,1667425071.290 [MissionManager](DEBUG): This mission is designed to run in the lab only. Turns on and off MultiRay lights. How long to let the mission run. 1 How long to wait before turning on / off lights, default 1 second 1 Light mode = 0 0 Light mode = 1 1 Light mode = 2 2 2022-11-02T21:37:51.293Z,1667425071.293 [CommandExec](IMPORTANT): Running ./Missions/Maintenance/multiray_mode1.xml 2022-11-02T21:37:51.369Z,1667425071.369 [Default] Stopped 2022-11-02T21:37:51.369Z,1667425071.369 [Default](DEBUG): Aggregate::uninitialize Default 2022-11-02T21:37:51.369Z,1667425071.369 [Default:A.Wait] Stopped 2022-11-02T21:37:51.369Z,1667425071.369 [Default:A.Wait](DEBUG): Uninitialize Wait Component. 2022-11-02T21:37:51.369Z,1667425071.369 [Default:B.GoToSurface] Stopped 2022-11-02T21:37:51.369Z,1667425071.369 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2022-11-02T21:37:51.370Z,1667425071.370 [MissionManager](IMPORTANT): Started mission multiray_lab 2022-11-02T21:37:51.370Z,1667425071.370 [multiray_lab] Running Loop=1 2022-11-02T21:37:51.370Z,1667425071.370 [multiray_lab](DEBUG): Aggregate::initialize multiray_lab 2022-11-02T21:37:52.601Z,1667425072.601 [multiray_lab](INFO): Timed out from 2022-11-02T21:37:51.4Z 2022-11-02T21:37:52.602Z,1667425072.602 [multiray_lab:A_Timeout] Running Loop=1 2022-11-02T21:37:52.602Z,1667425072.602 [multiray_lab:A_Timeout](DEBUG): Aggregate::initialize multiray_lab:A_Timeout 2022-11-02T21:37:52.603Z,1667425072.603 [multiray_lab:A_Timeout:A] Running Loop=1 2022-11-02T21:37:52.611Z,1667425072.611 [multiray_lab:A_Timeout:A] Stopped 2022-11-02T21:37:52.612Z,1667425072.612 [multiray_lab:A_Timeout](INFO): Completed multiray_lab:A_Timeout 2022-11-02T21:37:52.612Z,1667425072.612 [MissionManager](INFO): multiray_lab is completed. 2022-11-02T21:37:52.612Z,1667425072.612 [MissionManager](INFO): Uninitializing Mission multiray_lab 2022-11-02T21:37:52.612Z,1667425072.612 [multiray_lab] Stopped 2022-11-02T21:37:52.612Z,1667425072.612 [multiray_lab](DEBUG): Aggregate::uninitialize multiray_lab 2022-11-02T21:37:53.013Z,1667425073.013 [MultiRay](INFO): Red lights on 2022-11-02T21:37:53.062Z,1667425073.062 [MissionManager](IMPORTANT): Started mission Default 2022-11-02T21:37:53.062Z,1667425073.062 [Default] Running Loop=1 2022-11-02T21:37:53.062Z,1667425073.062 [Default](DEBUG): Aggregate::initialize Default 2022-11-02T21:37:53.062Z,1667425073.062 [Default:B.GoToSurface] Running Loop=1 2022-11-02T21:37:53.062Z,1667425073.062 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2022-11-02T21:37:53.062Z,1667425073.062 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2022-11-02T21:37:53.063Z,1667425073.063 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2022-11-02T21:37:53.063Z,1667425073.063 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2022-11-02T21:37:53.072Z,1667425073.072 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2022-11-02T21:37:53.072Z,1667425073.072 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2022-11-02T21:37:53.072Z,1667425073.072 [Default:A.Wait] Running Loop=1 2022-11-02T21:37:53.072Z,1667425073.072 [Default:A.Wait](DEBUG): Initialize Wait Component. 2022-11-02T21:37:57.964Z,1667425077.964 [DAT](FAULT): Buffer send receipt timeout failure. 2022-11-02T21:37:57.964Z,1667425077.964 [DAT](DEBUG): In sendingTransmitVerify, timeout so go online and set commsState_ = SENDING_FILL_BUFFER 2022-11-02T21:37:58.222Z,1667425078.222 [DAT](DEBUG): In sendingFillBuffer, set commsState_ = SENDING_TRANSMIT 2022-11-02T21:37:58.472Z,1667425078.472 [DAT](INFO): entering online mode 2022-11-02T21:37:58.724Z,1667425078.724 [DAT](DEBUG): checking for online mode acknowledgment 2022-11-02T21:37:58.976Z,1667425078.976 [DAT](DEBUG): checking for online mode acknowledgment 2022-11-02T21:37:59.228Z,1667425079.228 [DAT](DEBUG): checking for online mode acknowledgment 2022-11-02T21:37:59.454Z,1667425079.454 [CommandExec](IMPORTANT): got command run ./Missions/Maintenance/multiray_mode0.xml 2022-11-02T21:37:59.455Z,1667425079.455 [MissionManager](INFO): Loading Mission from file: ./Missions/Maintenance/multiray_mode0.xml 2022-11-02T21:37:59.480Z,1667425079.480 [DAT](DEBUG): checking for online mode acknowledgment 2022-11-02T21:37:59.511Z,1667425079.511 [MissionManager](INFO): DefineArg multiray_lab.MissionTimeout = 1.000000 min 2022-11-02T21:37:59.525Z,1667425079.525 [MissionManager](INFO): DefineArg multiray_lab.LightDuration = 1.000000 s 2022-11-02T21:37:59.536Z,1667425079.536 [MissionManager](INFO): DefineArg multiray_lab.LightMode0 = 0.000000 count 2022-11-02T21:37:59.538Z,1667425079.538 [MissionManager](INFO): DefineArg multiray_lab.LightMode1 = 1.000000 count 2022-11-02T21:37:59.544Z,1667425079.544 [MissionManager](INFO): DefineArg multiray_lab.LightMode2 = 2.000000 count 2022-11-02T21:37:59.552Z,1667425079.552 [MissionManager](DEBUG): This mission is designed to run in the lab only. Turns on and off MultiRay lights. How long to let the mission run. 1 How long to wait before turning on / off lights, default 1 second 1 Light mode = 0 0 Light mode = 1 1 Light mode = 2 2 2022-11-02T21:37:59.554Z,1667425079.554 [CommandExec](IMPORTANT): Running ./Missions/Maintenance/multiray_mode0.xml 2022-11-02T21:37:59.732Z,1667425079.732 [DAT](DEBUG): checking for online mode acknowledgment 2022-11-02T21:37:59.857Z,1667425079.857 [Default] Stopped 2022-11-02T21:37:59.857Z,1667425079.857 [Default](DEBUG): Aggregate::uninitialize Default 2022-11-02T21:37:59.857Z,1667425079.857 [Default:A.Wait] Stopped 2022-11-02T21:37:59.857Z,1667425079.857 [Default:A.Wait](DEBUG): Uninitialize Wait Component. 2022-11-02T21:37:59.857Z,1667425079.857 [Default:B.GoToSurface] Stopped 2022-11-02T21:37:59.857Z,1667425079.857 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2022-11-02T21:37:59.857Z,1667425079.857 [MissionManager](IMPORTANT): Started mission multiray_lab 2022-11-02T21:37:59.858Z,1667425079.858 [multiray_lab] Running Loop=1 2022-11-02T21:37:59.858Z,1667425079.858 [multiray_lab](DEBUG): Aggregate::initialize multiray_lab 2022-11-02T21:37:59.984Z,1667425079.984 [DAT](DEBUG): checking for online mode acknowledgment 2022-11-02T21:38:00.236Z,1667425080.236 [DAT](DEBUG): checking for online mode acknowledgment 2022-11-02T21:38:00.488Z,1667425080.488 [DAT](DEBUG): checking for online mode acknowledgment 2022-11-02T21:38:00.740Z,1667425080.740 [DAT](DEBUG): checking for online mode acknowledgment 2022-11-02T21:38:00.992Z,1667425080.992 [DAT](DEBUG): checking for online mode acknowledgment 2022-11-02T21:38:01.058Z,1667425081.058 [multiray_lab](INFO): Timed out from 2022-11-02T21:37:59.9Z 2022-11-02T21:38:01.058Z,1667425081.058 [multiray_lab:A_Timeout] Running Loop=1 2022-11-02T21:38:01.058Z,1667425081.058 [multiray_lab:A_Timeout](DEBUG): Aggregate::initialize multiray_lab:A_Timeout 2022-11-02T21:38:01.058Z,1667425081.058 [multiray_lab:A_Timeout:A] Running Loop=1 2022-11-02T21:38:01.059Z,1667425081.059 [multiray_lab:A_Timeout:A] Stopped 2022-11-02T21:38:01.059Z,1667425081.059 [multiray_lab:A_Timeout](INFO): Completed multiray_lab:A_Timeout 2022-11-02T21:38:01.059Z,1667425081.059 [MissionManager](INFO): multiray_lab is completed. 2022-11-02T21:38:01.059Z,1667425081.059 [MissionManager](INFO): Uninitializing Mission multiray_lab 2022-11-02T21:38:01.059Z,1667425081.059 [multiray_lab] Stopped 2022-11-02T21:38:01.060Z,1667425081.060 [multiray_lab](DEBUG): Aggregate::uninitialize multiray_lab 2022-11-02T21:38:01.245Z,1667425081.245 [DAT](DEBUG): checking for online mode acknowledgment 2022-11-02T21:38:01.484Z,1667425081.484 [MultiRay](IMPORTANT): All lights off 2022-11-02T21:38:01.496Z,1667425081.496 [DAT](DEBUG): checking for online mode acknowledgment 2022-11-02T21:38:01.503Z,1667425081.503 [MissionManager](IMPORTANT): Started mission Default 2022-11-02T21:38:01.519Z,1667425081.519 [Default] Running Loop=1 2022-11-02T21:38:01.520Z,1667425081.520 [Default](DEBUG): Aggregate::initialize Default 2022-11-02T21:38:01.520Z,1667425081.520 [Default:B.GoToSurface] Running Loop=1 2022-11-02T21:38:01.520Z,1667425081.520 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2022-11-02T21:38:01.520Z,1667425081.520 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2022-11-02T21:38:01.520Z,1667425081.520 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2022-11-02T21:38:01.521Z,1667425081.521 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2022-11-02T21:38:01.521Z,1667425081.521 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2022-11-02T21:38:01.521Z,1667425081.521 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2022-11-02T21:38:01.522Z,1667425081.522 [Default:A.Wait] Running Loop=1 2022-11-02T21:38:01.522Z,1667425081.522 [Default:A.Wait](DEBUG): Initialize Wait Component. 2022-11-02T21:38:01.748Z,1667425081.748 [DAT](DEBUG): checking for online mode acknowledgment 2022-11-02T21:38:01.000Z,1667425082.000 [DAT](DEBUG): checking for online mode acknowledgment 2022-11-02T21:38:02.252Z,1667425082.252 [DAT](DEBUG): checking for online mode acknowledgment 2022-11-02T21:38:02.504Z,1667425082.504 [DAT](DEBUG): checking for online mode acknowledgment 2022-11-02T21:38:02.756Z,1667425082.756 [DAT](DEBUG): checking for online mode acknowledgment 2022-11-02T21:38:03.008Z,1667425083.008 [DAT](DEBUG): checking for online mode acknowledgment 2022-11-02T21:38:03.260Z,1667425083.260 [DAT](DEBUG): checking for online mode acknowledgment 2022-11-02T21:38:03.512Z,1667425083.512 [DAT](DEBUG): checking for online mode acknowledgment 2022-11-02T21:38:03.764Z,1667425083.764 [DAT](DEBUG): checking for online mode acknowledgment 2022-11-02T21:38:04.016Z,1667425084.016 [DAT](DEBUG): checking for online mode acknowledgment 2022-11-02T21:38:04.236Z,1667425084.236 [CommandExec](IMPORTANT): got command quit 2022-11-02T21:38:04.269Z,1667425084.269 [DAT](DEBUG): checking for online mode acknowledgment 2022-11-02T21:38:04.520Z,1667425084.520 [DAT](DEBUG): checking for online mode acknowledgment 2022-11-02T21:38:04.772Z,1667425084.772 [DAT](DEBUG): checking for online mode acknowledgment 2022-11-02T21:38:05.024Z,1667425085.024 [DAT](DEBUG): checking for online mode acknowledgment 2022-11-02T21:38:05.239Z,1667425085.239 [Supervisor](INFO): Stop Mission called by Supervisor::terminate 2022-11-02T21:38:05.240Z,1667425085.240 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread. 2022-11-02T21:38:05.240Z,1667425085.240 [CommandExec](INFO): Uninitializing the command executive. 2022-11-02T21:38:05.240Z,1667425085.240 [CommandExec](INFO): Uninitializing the command scheduler. 2022-11-02T21:38:05.240Z,1667425085.240 [CommandExec ThreadHandler](INFO): Thread cancelled. 2022-11-02T21:38:05.276Z,1667425085.276 [DAT](DEBUG): checking for online mode acknowledgment 2022-11-02T21:38:05.427Z,1667425085.427 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2022-11-02T21:38:05.427Z,1667425085.427 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2022-11-02T21:38:05.428Z,1667425085.428 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2022-11-02T21:38:05.428Z,1667425085.428 [NavChartDb](INFO): Join timeout helper Thread ID is 972 2022-11-02T21:38:05.528Z,1667425085.528 [DAT](DEBUG): checking for online mode acknowledgment 2022-11-02T21:38:05.628Z,1667425085.628 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2022-11-02T21:38:05.628Z,1667425085.628 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2022-11-02T21:38:05.635Z,1667425085.635 [ComponentRegistry](INFO): Shutting down DAT ThreadHandler 2022-11-02T21:38:05.635Z,1667425085.635 [DAT ThreadHandler](INFO): Thread cancelled. 2022-11-02T21:38:05.636Z,1667425085.636 [DAT](INFO): Join timeout helper Thread ID is 973 2022-11-02T21:38:05.780Z,1667425085.780 [DAT](INFO): Powering down 2022-11-02T21:38:05.848Z,1667425085.848 [DAT ThreadHandler](INFO): Uninitializing protected caller thread. 2022-11-02T21:38:05.848Z,1667425085.848 [DAT](INFO): Powering down 2022-11-02T21:38:05.849Z,1667425085.849 [DAT ThreadHandler](INFO): Thread cancelled. 2022-11-02T21:38:05.855Z,1667425085.855 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2022-11-02T21:38:05.855Z,1667425085.855 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2022-11-02T21:38:05.856Z,1667425085.856 [Radio_Surface](INFO): Join timeout helper Thread ID is 974 2022-11-02T21:38:05.980Z,1667425085.980 [Radio_Surface](INFO): Powering down 2022-11-02T21:38:05.981Z,1667425085.981 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2022-11-02T21:38:05.981Z,1667425085.981 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2022-11-02T21:38:05.000Z,1667425086.000 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler 2022-11-02T21:38:05.000Z,1667425086.000 [Onboard ThreadHandler](INFO): Thread cancelled. 2022-11-02T21:38:06.000Z,1667425086.000 [Onboard](INFO): Join timeout helper Thread ID is 975 2022-11-02T21:38:06.001Z,1667425086.001 [DataOverHttps](INFO): Radio surface powered OFF, will not connect. 2022-11-02T21:38:09.036Z,1667425089.036 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread. 2022-11-02T21:38:09.036Z,1667425089.036 [Onboard ThreadHandler](INFO): Thread cancelled. 2022-11-02T21:38:09.057Z,1667425089.057 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler 2022-11-02T21:38:09.057Z,1667425089.057 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2022-11-02T21:38:09.057Z,1667425089.057 [DataOverHttps](INFO): Join timeout helper Thread ID is 976 2022-11-02T21:38:10.015Z,1667425090.015 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread. 2022-11-02T21:38:10.016Z,1667425090.016 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2022-11-02T21:38:10.032Z,1667425090.032 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler 2022-11-02T21:38:10.033Z,1667425090.033 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2022-11-02T21:38:10.033Z,1667425090.033 [BackseatComponent](INFO): Join timeout helper Thread ID is 977 2022-11-02T21:38:10.192Z,1667425090.192 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread. 2022-11-02T21:38:10.192Z,1667425090.192 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2022-11-02T21:38:10.202Z,1667425090.202 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler 2022-11-02T21:38:10.202Z,1667425090.202 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2022-11-02T21:38:10.203Z,1667425090.203 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 978 2022-11-02T21:38:10.404Z,1667425090.404 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread. 2022-11-02T21:38:10.404Z,1667425090.404 [WetLabsBB2FL](INFO): Powering down 2022-11-02T21:38:10.405Z,1667425090.405 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2022-11-02T21:38:10.424Z,1667425090.424 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2022-11-02T21:38:10.424Z,1667425090.424 [logger ThreadHandler](INFO): Thread cancelled. 2022-11-02T21:38:10.425Z,1667425090.425 [logger](INFO): Join timeout helper Thread ID is 979 2022-11-02T21:38:10.465Z,1667425090.465 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2022-11-02T21:38:10.465Z,1667425090.465 [logger ThreadHandler](INFO): Thread cancelled. 2022-11-02T21:38:10.480Z,1667425090.480 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2022-11-02T21:38:10.480Z,1667425090.480 [CommandLine ThreadHandler](INFO): Thread cancelled. 2022-11-02T21:38:10.481Z,1667425090.481 [CommandLine](INFO): Join timeout helper Thread ID is 980 2022-11-02T21:38:10.536Z,1667425090.536 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2022-11-02T21:38:10.536Z,1667425090.536 [CommandLine ThreadHandler](INFO): Thread cancelled. 2022-11-02T21:38:10.540Z,1667425090.540 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler 2022-11-02T21:38:10.540Z,1667425090.540 [CommandExec ThreadHandler](INFO): Thread cancelled. 2022-11-02T21:38:10.541Z,1667425090.541 [CommandExec](INFO): Join timeout helper Thread ID is 981 2022-11-02T21:38:10.542Z,1667425090.542 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2022-11-02T21:38:10.542Z,1667425090.542 [controlThread ThreadHandler](INFO): Thread cancelled. 2022-11-02T21:38:10.542Z,1667425090.542 [controlThread](INFO): Join timeout helper Thread ID is 982 2022-11-02T21:38:10.724Z,1667425090.724 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2022-11-02T21:38:10.724Z,1667425090.724 [controlThread](DEBUG): Uninitializing ControlThread 2022-11-02T21:38:10.724Z,1667425090.724 [AHRS_M2](INFO): Powering down 2022-11-02T21:38:10.797Z,1667425090.797 [MultiRay](INFO): Powering down. 2022-11-02T21:38:10.798Z,1667425090.798 [NAL9602](INFO): Powering down 2022-11-02T21:38:10.800Z,1667425090.800 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator. 2022-11-02T21:38:10.800Z,1667425090.800 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator. 2022-11-02T21:38:10.801Z,1667425090.801 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2022-11-02T21:38:10.802Z,1667425090.802 [MissionManager](INFO): Uninitializing Mission Default 2022-11-02T21:38:10.802Z,1667425090.802 [Default] Stopped 2022-11-02T21:38:10.802Z,1667425090.802 [Default](DEBUG): Aggregate::uninitialize Default 2022-11-02T21:38:10.802Z,1667425090.802 [Default:A.Wait] Stopped 2022-11-02T21:38:10.802Z,1667425090.802 [Default:A.Wait](DEBUG): Uninitialize Wait Component. 2022-11-02T21:38:10.802Z,1667425090.802 [Default:B.GoToSurface] Stopped 2022-11-02T21:38:10.802Z,1667425090.802 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2022-11-02T21:38:10.805Z,1667425090.805 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2022-11-02T21:38:10.805Z,1667425090.805 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2022-11-02T21:38:10.805Z,1667425090.805 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2022-11-02T21:38:10.806Z,1667425090.806 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2022-11-02T21:38:10.806Z,1667425090.806 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2022-11-02T21:38:10.806Z,1667425090.806 [BuoyancyServo](INFO): Powering down 2022-11-02T21:38:10.820Z,1667425090.820 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2022-11-02T21:38:10.820Z,1667425090.820 [ElevatorServo](INFO): Powering down 2022-11-02T21:38:10.821Z,1667425090.821 [MassServo](DEBUG): Uninitialize Mass Servo. 2022-11-02T21:38:10.821Z,1667425090.821 [MassServo](INFO): Powering down 2022-11-02T21:38:10.821Z,1667425090.821 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2022-11-02T21:38:10.822Z,1667425090.822 [RudderServo](INFO): Powering down 2022-11-02T21:38:10.822Z,1667425090.822 [ThrusterHE](DEBUG): Uninitialize Thruster Servo. 2022-11-02T21:38:10.823Z,1667425090.823 [ThrusterHE](INFO): Powering down 2022-11-02T21:38:10.823Z,1667425090.823 [SBIT](DEBUG): Uninitialize SBIT Component. 2022-11-02T21:38:10.824Z,1667425090.824 [IBIT](DEBUG): Uninitialize IBIT Component. 2022-11-02T21:38:10.824Z,1667425090.824 [CBIT](DEBUG): Uninitialize CBIT Component. 2022-11-02T21:38:10.824Z,1667425090.824 [CBIT](DEBUG): Powering off loads. 2022-11-02T21:38:10.835Z,1667425090.835 [CBIT](DEBUG): Disabling WDT. 2022-11-02T21:38:10.847Z,1667425090.847 [CBIT](DEBUG): Opening all GF detection circuits. 2022-11-02T21:38:10.848Z,1667425090.848 [controlThread ThreadHandler](INFO): Thread cancelled. 2022-11-02T21:38:10.882Z,1667425090.882 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2022-11-02T21:38:10.929Z,1667425090.929 [DAT ThreadHandler](INFO): Thread cancelled. 2022-11-02T21:38:10.933Z,1667425090.933 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2022-11-02T21:38:10.936Z,1667425090.936 [Onboard ThreadHandler](INFO): Thread cancelled. 2022-11-02T21:38:10.943Z,1667425090.943 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2022-11-02T21:38:10.986Z,1667425090.986 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2022-11-02T21:38:11.028Z,1667425091.028 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2022-11-02T21:38:11.084Z,1667425091.084 [logger ThreadHandler](INFO): Thread cancelled.