2021-08-03T17:20:25.633Z,1628011225.633 [Supervisor](DEBUG): Initializing supervisor.
2021-08-03T17:20:25.638Z,1628011225.638 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2021-08-03T17:20:25.638Z,1628011225.638 [SyncHandler](INFO): Protected caller Thread ID is 813
2021-08-03T17:20:25.639Z,1628011225.639 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2021-08-03T17:20:25.640Z,1628011225.640 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2021-08-03T17:20:25.640Z,1628011225.640 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 814
2021-08-03T17:20:25.644Z,1628011225.644 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2021-08-03T17:20:25.664Z,1628011225.664 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2021-08-03T17:20:25.665Z,1628011225.665 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2021-08-03T17:20:25.666Z,1628011225.666 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 815
2021-08-03T17:20:25.668Z,1628011225.668 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2021-08-03T17:20:25.669Z,1628011225.669 [logger ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2021-08-03T17:20:25.669Z,1628011225.669 [logger ThreadHandler](INFO): Protected caller Thread ID is 816
2021-08-03T17:20:25.673Z,1628011225.673 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2021-08-03T17:20:25.673Z,1628011225.673 [Supervisor](INFO): Looking for Config files in directory: Config/
2021-08-03T17:20:25.677Z,1628011225.677 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2021-08-03T17:20:26.101Z,1628011226.101 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2021-08-03T17:20:26.103Z,1628011226.103 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg
2021-08-03T17:20:26.319Z,1628011226.319 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock
2021-08-03T17:20:26.321Z,1628011226.321 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2021-08-03T17:20:26.515Z,1628011226.515 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2021-08-03T17:20:26.516Z,1628011226.516 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2021-08-03T17:20:26.624Z,1628011226.624 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2021-08-03T17:20:26.624Z,1628011226.624 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2021-08-03T17:20:26.997Z,1628011226.997 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2021-08-03T17:20:26.997Z,1628011226.997 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2021-08-03T17:20:27.335Z,1628011227.335 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2021-08-03T17:20:27.336Z,1628011227.336 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2021-08-03T17:20:27.433Z,1628011227.433 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2021-08-03T17:20:27.434Z,1628011227.434 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2021-08-03T17:20:27.584Z,1628011227.584 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2021-08-03T17:20:27.585Z,1628011227.585 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2021-08-03T17:20:28.139Z,1628011228.139 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2021-08-03T17:20:28.140Z,1628011228.140 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2021-08-03T17:20:28.499Z,1628011228.499 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2021-08-03T17:20:28.501Z,1628011228.501 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2021-08-03T17:20:28.583Z,1628011228.583 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2021-08-03T17:20:28.792Z,1628011228.792 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2021-08-03T17:20:28.792Z,1628011228.792 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2021-08-03T17:20:28.920Z,1628011228.920 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2021-08-03T17:20:28.921Z,1628011228.921 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2021-08-03T17:20:29.802Z,1628011229.802 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2021-08-03T17:20:29.803Z,1628011229.803 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2021-08-03T17:20:29.884Z,1628011229.884 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2021-08-03T17:20:30.135Z,1628011230.135 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2021-08-03T17:20:30.137Z,1628011230.137 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-galene/
2021-08-03T17:20:30.139Z,1628011230.139 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/vehicle.cfg
2021-08-03T17:20:30.312Z,1628011230.312 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/logger.cfg
2021-08-03T17:20:30.407Z,1628011230.407 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Servo.cfg
2021-08-03T17:20:30.519Z,1628011230.519 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Control.cfg
2021-08-03T17:20:30.621Z,1628011230.621 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/secure.cfg
2021-08-03T17:20:30.705Z,1628011230.705 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Simulator.cfg
2021-08-03T17:20:30.793Z,1628011230.793 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Science.cfg
2021-08-03T17:20:30.907Z,1628011230.907 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/BIT.cfg
2021-08-03T17:20:31.007Z,1628011231.007 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Sensor.cfg
2021-08-03T17:20:31.151Z,1628011231.151 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Battery.cfg
2021-08-03T17:20:31.413Z,1628011231.413 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2021-08-03T17:20:31.413Z,1628011231.413 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Navigation.cfg
2021-08-03T17:20:31.509Z,1628011231.509 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg
2021-08-03T17:20:31.524Z,1628011231.524 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2021-08-03T17:20:31.920Z,1628011231.920 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2021-08-03T17:20:31.921Z,1628011231.921 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2021-08-03T17:20:32.022Z,1628011232.022 [DeadReckonUsingMultipleVelocitySources] Loaded
2021-08-03T17:20:32.022Z,1628011232.022 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2021-08-03T17:20:32.057Z,1628011232.057 [DeadReckonUsingSpeedCalculator] Loaded
2021-08-03T17:20:32.057Z,1628011232.057 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread.
2021-08-03T17:20:32.070Z,1628011232.070 [NavChart] Loaded
2021-08-03T17:20:32.071Z,1628011232.071 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2021-08-03T17:20:32.076Z,1628011232.076 [UniversalFixResidualReporter] Loaded
2021-08-03T17:20:32.077Z,1628011232.077 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2021-08-03T17:20:32.077Z,1628011232.077 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2021-08-03T17:20:32.078Z,1628011232.078 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2021-08-03T17:20:32.094Z,1628011232.094 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2021-08-03T17:20:32.095Z,1628011232.095 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2021-08-03T17:20:32.321Z,1628011232.321 [ESPComponent] Loaded
2021-08-03T17:20:32.322Z,1628011232.322 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread.
2021-08-03T17:20:32.323Z,1628011232.323 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2021-08-03T17:20:32.323Z,1628011232.323 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2021-08-03T17:20:32.396Z,1628011232.396 [VerticalControl](DEBUG): Construct VerticalControl.
2021-08-03T17:20:32.457Z,1628011232.457 [VerticalControl] Loaded
2021-08-03T17:20:32.457Z,1628011232.457 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2021-08-03T17:20:32.460Z,1628011232.460 [HorizontalControl](DEBUG): Construct HorizontalControl.
2021-08-03T17:20:32.499Z,1628011232.499 [HorizontalControl] Loaded
2021-08-03T17:20:32.499Z,1628011232.499 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2021-08-03T17:20:32.501Z,1628011232.501 [SpeedControl](DEBUG): Construct SpeedControl.
2021-08-03T17:20:32.505Z,1628011232.505 [SpeedControl] Loaded
2021-08-03T17:20:32.505Z,1628011232.505 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2021-08-03T17:20:32.507Z,1628011232.507 [LoopControl](DEBUG): Construct LoopControl.
2021-08-03T17:20:32.508Z,1628011232.508 [LoopControl] Loaded
2021-08-03T17:20:32.508Z,1628011232.508 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2021-08-03T17:20:32.509Z,1628011232.509 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2021-08-03T17:20:32.509Z,1628011232.509 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2021-08-03T17:20:32.570Z,1628011232.570 [DepthRateCalculator] Loaded
2021-08-03T17:20:32.571Z,1628011232.571 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2021-08-03T17:20:32.575Z,1628011232.575 [PitchRateCalculator] Loaded
2021-08-03T17:20:32.576Z,1628011232.576 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2021-08-03T17:20:32.585Z,1628011232.585 [SpeedCalculator] Loaded
2021-08-03T17:20:32.585Z,1628011232.585 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2021-08-03T17:20:32.599Z,1628011232.599 [TempGradientCalculator] Loaded
2021-08-03T17:20:32.599Z,1628011232.599 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread.
2021-08-03T17:20:32.604Z,1628011232.604 [YawRateCalculator] Loaded
2021-08-03T17:20:32.604Z,1628011232.604 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2021-08-03T17:20:32.621Z,1628011232.621 [ElevatorOffsetCalculator] Loaded
2021-08-03T17:20:32.622Z,1628011232.622 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2021-08-03T17:20:32.622Z,1628011232.622 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2021-08-03T17:20:32.623Z,1628011232.623 [Module Loader](DEBUG): Loading Module at Modules/Dock.so
2021-08-03T17:20:32.745Z,1628011232.745 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking)
2021-08-03T17:20:32.745Z,1628011232.745 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2021-08-03T17:20:32.829Z,1628011232.829 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2021-08-03T17:20:32.830Z,1628011232.830 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2021-08-03T17:20:32.981Z,1628011232.981 [BuoyancyServo] Loaded
2021-08-03T17:20:32.982Z,1628011232.982 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2021-08-03T17:20:33.001Z,1628011233.001 [ElevatorServo] Loaded
2021-08-03T17:20:33.001Z,1628011233.001 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2021-08-03T17:20:33.020Z,1628011233.020 [MassServo] Loaded
2021-08-03T17:20:33.020Z,1628011233.020 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2021-08-03T17:20:33.038Z,1628011233.038 [RudderServo] Loaded
2021-08-03T17:20:33.039Z,1628011233.039 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2021-08-03T17:20:33.056Z,1628011233.056 [ThrusterServo] Loaded
2021-08-03T17:20:33.056Z,1628011233.056 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread.
2021-08-03T17:20:33.057Z,1628011233.057 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2021-08-03T17:20:33.059Z,1628011233.059 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2021-08-03T17:20:33.196Z,1628011233.196 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2021-08-03T17:20:33.197Z,1628011233.197 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2021-08-03T17:20:34.609Z,1628011234.609 [BPC1] Loaded
2021-08-03T17:20:34.609Z,1628011234.609 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2021-08-03T17:20:34.748Z,1628011234.748 [DataOverHttps] Loaded
2021-08-03T17:20:34.748Z,1628011234.748 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2021-08-03T17:20:34.750Z,1628011234.750 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 409B34E0
2021-08-03T17:20:34.750Z,1628011234.750 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 898
2021-08-03T17:20:34.771Z,1628011234.771 [Depth_Keller] Loaded
2021-08-03T17:20:34.771Z,1628011234.771 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2021-08-03T17:20:34.831Z,1628011234.831 [NAL9602] Loaded
2021-08-03T17:20:34.832Z,1628011234.832 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2021-08-03T17:20:34.858Z,1628011234.858 [Onboard](ERROR): Can't open SysFS node file: /sys/class/power_supply/ds2782-0/voltage_now
2021-08-03T17:20:34.859Z,1628011234.859 [Onboard](ERROR): Can't open SysFS node file: /sys/class/power_supply/ds2782-0/current_now
2021-08-03T17:20:34.859Z,1628011234.859 [Onboard](ERROR): Can't open SysFS node file: /sys/class/power_supply/ds2782-0/charge_now
2021-08-03T17:20:34.860Z,1628011234.860 [Onboard](ERROR): Can't open SysFS node file: /sys/class/power_supply/ds2782-0/charge_full
2021-08-03T17:20:34.861Z,1628011234.861 [Onboard](ERROR): Can't open SysFS node file: /sys/class/power_supply/ds2782-1/voltage_now
2021-08-03T17:20:34.861Z,1628011234.861 [Onboard](ERROR): Can't open SysFS node file: /sys/class/power_supply/ds2782-1/current_now
2021-08-03T17:20:34.862Z,1628011234.862 [Onboard](ERROR): Can't open SysFS node file: /sys/class/power_supply/ds2782-1/charge_now
2021-08-03T17:20:34.862Z,1628011234.862 [Onboard](ERROR): Can't open SysFS node file: /sys/class/power_supply/ds2782-1/charge_full
2021-08-03T17:20:34.862Z,1628011234.862 [Onboard] Loaded
2021-08-03T17:20:34.863Z,1628011234.863 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread.
2021-08-03T17:20:34.864Z,1628011234.864 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 409E34E0
2021-08-03T17:20:34.864Z,1628011234.864 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 899
2021-08-03T17:20:34.877Z,1628011234.877 [Power24vConverter] Loaded
2021-08-03T17:20:34.877Z,1628011234.877 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread.
2021-08-03T17:20:34.890Z,1628011234.890 [Radio_Surface] Loaded
2021-08-03T17:20:34.891Z,1628011234.891 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2021-08-03T17:20:34.892Z,1628011234.892 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 40A134E0
2021-08-03T17:20:34.892Z,1628011234.892 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 900
2021-08-03T17:20:34.976Z,1628011234.976 [DAT] Loaded
2021-08-03T17:20:34.976Z,1628011234.976 [ComponentRegistry](DEBUG): SyncComponent "DAT" handled in the control thread.
2021-08-03T17:20:34.976Z,1628011234.976 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2021-08-03T17:20:34.977Z,1628011234.977 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2021-08-03T17:20:35.683Z,1628011235.683 [SBIT](DEBUG): Construct Startup Built In Test.
2021-08-03T17:20:35.692Z,1628011235.692 [SBIT] Loaded
2021-08-03T17:20:35.693Z,1628011235.693 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2021-08-03T17:20:35.695Z,1628011235.695 [IBIT](DEBUG): Construct Initiated Built In Test.
2021-08-03T17:20:35.709Z,1628011235.709 [IBIT] Loaded
2021-08-03T17:20:35.710Z,1628011235.710 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2021-08-03T17:20:35.716Z,1628011235.716 [CBIT](DEBUG): Construct Continuous Built In Test.
2021-08-03T17:20:35.819Z,1628011235.819 [CBIT] Loaded
2021-08-03T17:20:35.819Z,1628011235.819 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2021-08-03T17:20:35.819Z,1628011235.819 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2021-08-03T17:20:35.820Z,1628011235.820 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2021-08-03T17:20:35.864Z,1628011235.864 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2021-08-03T17:20:35.870Z,1628011235.870 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2021-08-03T17:20:35.873Z,1628011235.873 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2021-08-03T17:20:35.883Z,1628011235.883 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2021-08-03T17:20:35.884Z,1628011235.884 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40A9E4E0
2021-08-03T17:20:35.885Z,1628011235.885 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 901
2021-08-03T17:20:35.889Z,1628011235.889 [Supervisor](INFO): Main Thread ID is 809
2021-08-03T17:20:35.889Z,1628011235.889 [Supervisor](DEBUG): Running supervisor.
2021-08-03T17:20:35.890Z,1628011235.890 [CommandLine ThreadHandler](INFO): Handler Thread ID is 902
2021-08-03T17:20:35.892Z,1628011235.892 [controlThread ThreadHandler](INFO): Handler Thread ID is 903
2021-08-03T17:20:35.893Z,1628011235.893 [controlThread](DEBUG): Initializing ControlThread
2021-08-03T17:20:35.894Z,1628011235.894 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2021-08-03T17:20:35.895Z,1628011235.895 [NavChart](DEBUG): Initialize NavChart Navigation.
2021-08-03T17:20:35.895Z,1628011235.895 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2021-08-03T17:20:35.896Z,1628011235.896 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2021-08-03T17:20:35.898Z,1628011235.898 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2021-08-03T17:20:35.898Z,1628011235.898 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2021-08-03T17:20:35.899Z,1628011235.899 [LoopControl](DEBUG): Initialize LoopControlComponent.
2021-08-03T17:20:35.899Z,1628011235.899 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2021-08-03T17:20:35.900Z,1628011235.900 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2021-08-03T17:20:35.900Z,1628011235.900 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2021-08-03T17:20:35.900Z,1628011235.900 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator.
2021-08-03T17:20:35.901Z,1628011235.901 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2021-08-03T17:20:35.901Z,1628011235.901 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2021-08-03T17:20:35.908Z,1628011235.908 [SBIT](INFO): Initialize SBIT Component.
2021-08-03T17:20:35.908Z,1628011235.908 [SBIT](IMPORTANT): git: 2021-06-24-10-g1c68dac98
2021-08-03T17:20:35.908Z,1628011235.908 [SBIT](INFO): git hash: 1c68dac98e3954a039edc16fe17de653428a8fd0
2021-08-03T17:20:35.909Z,1628011235.909 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2021-08-03T17:20:35.910Z,1628011235.910 [SBIT](INFO): Kernel Reporting Different Version From Configuration.
Kernel Expected: #2 PREEMPT Thu Jan 11 20:13:48 PST 2018
Kernel Reported: #1 PREEMPT Thu Feb 21 11:17:40 PST 2019
2021-08-03T17:20:35.911Z,1628011235.911 [SBIT](INFO): Beginning SBIT in 20.000000 seconds.
2021-08-03T17:20:35.912Z,1628011235.912 [IBIT](INFO): Initialize IBIT Component.
2021-08-03T17:20:35.913Z,1628011235.913 [CBIT](DEBUG): Initialize CBIT Component.
2021-08-03T17:20:35.914Z,1628011235.914 [logger ThreadHandler](INFO): Handler Thread ID is 904
2021-08-03T17:20:35.927Z,1628011235.927 [CBIT](DEBUG): Initialized mux pins.
2021-08-03T17:20:35.927Z,1628011235.927 [CBIT](DEBUG): Initializing the watchdog timer.
2021-08-03T17:20:35.931Z,1628011235.931 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 905
2021-08-03T17:20:35.932Z,1628011235.932 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2021-08-03T17:20:35.939Z,1628011235.939 [Onboard ThreadHandler](INFO): Handler Thread ID is 906
2021-08-03T17:20:35.952Z,1628011235.952 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2021-08-03T17:20:35.952Z,1628011235.952 [CBIT](DEBUG): Initializing heartbeat.
2021-08-03T17:20:35.959Z,1628011235.959 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 907
2021-08-03T17:20:35.975Z,1628011235.975 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 908
2021-08-03T17:20:35.984Z,1628011235.984 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2021-08-03T17:20:35.984Z,1628011235.984 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2021-08-03T17:20:35.984Z,1628011235.984 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2021-08-03T17:20:35.985Z,1628011235.985 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2021-08-03T17:20:35.985Z,1628011235.985 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2021-08-03T17:20:35.985Z,1628011235.985 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2021-08-03T17:20:35.985Z,1628011235.985 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000
2021-08-03T17:20:35.985Z,1628011235.985 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000
2021-08-03T17:20:35.985Z,1628011235.985 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2021-08-03T17:20:35.986Z,1628011235.986 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2021-08-03T17:20:35.986Z,1628011235.986 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000
2021-08-03T17:20:35.986Z,1628011235.986 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000
2021-08-03T17:20:35.986Z,1628011235.986 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000
2021-08-03T17:20:35.986Z,1628011235.986 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000
2021-08-03T17:20:35.987Z,1628011235.987 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000
2021-08-03T17:20:35.987Z,1628011235.987 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000
2021-08-03T17:20:36.023Z,1628011236.023 [CBIT](DEBUG): Deactivating GF circuits.
2021-08-03T17:20:36.023Z,1628011236.023 [CBIT](DEBUG): Deactivating emergency mode.
2021-08-03T17:20:36.059Z,1628011236.059 [CBIT](DEBUG): Backplane powered.
2021-08-03T17:20:36.060Z,1628011236.060 [MissionManager](INFO): Loading Mission from file: Missions/Startup.xml
2021-08-03T17:20:36.087Z,1628011236.087 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2021-08-03T17:20:36.131Z,1628011236.131 [MissionManager](DEBUG):
2021-08-03T17:20:36.132Z,1628011236.132 [MissionManager](INFO): Loading Mission from file: Missions/Default.xml
2021-08-03T17:20:36.213Z,1628011236.213 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2021-08-03T17:20:36.231Z,1628011236.231 [Default:A.Wait](DEBUG): Construct Wait.
2021-08-03T17:20:36.233Z,1628011236.233 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2021-08-03T17:20:36.254Z,1628011236.254 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2021-08-03T17:20:36.293Z,1628011236.293 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2021-08-03T17:20:36.307Z,1628011236.307 [Default:E.Execute](DEBUG): Construct Execute.
2021-08-03T17:20:36.327Z,1628011236.327 [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
2021-08-03T17:20:36.331Z,1628011236.331 [controlThread](DEBUG): Component order: CycleStarter,ESPComponent,BPC1,Depth_Keller,NAL9602,Power24vConverter,DAT,Depth_Keller,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,DeadReckonUsingSpeedCalculator,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter,
2021-08-03T17:20:36.363Z,1628011236.363 [Radio_Surface](INFO): Powering up
2021-08-03T17:20:36.376Z,1628011236.376 [Depth_Keller](ERROR): Pressure reading out of range: 815.405518 decibar
2021-08-03T17:20:36.376Z,1628011236.376 [Power24vConverter](INFO): Powering up.
2021-08-03T17:20:36.377Z,1628011236.377 [DAT](INFO): Powering up
2021-08-03T17:20:36.377Z,1628011236.377 [DAT](DEBUG): Initializing DAT.
2021-08-03T17:20:36.399Z,1628011236.399 [DepthRateCalculator](ERROR): Depth measurement is not active
2021-08-03T17:20:36.645Z,1628011236.645 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2021-08-03T17:20:36.651Z,1628011236.651 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2021-08-03T17:20:36.652Z,1628011236.652 [ElevatorServo](DEBUG): Initializing EZServoServo.
2021-08-03T17:20:36.659Z,1628011236.659 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2021-08-03T17:20:36.660Z,1628011236.660 [MassServo](DEBUG): Initializing EZServoServo.
2021-08-03T17:20:36.667Z,1628011236.667 [MassServo](DEBUG): Initializing MassServo.
2021-08-03T17:20:36.668Z,1628011236.668 [RudderServo](DEBUG): Initializing EZServoServo.
2021-08-03T17:20:36.675Z,1628011236.675 [RudderServo](DEBUG): Initializing RudderServo.
2021-08-03T17:20:36.676Z,1628011236.676 [ThrusterServo](DEBUG): Initializing EZServoServo.
2021-08-03T17:20:36.683Z,1628011236.683 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2021-08-03T17:20:40.196Z,1628011240.196 [BuoyancyServo](FAULT): Invalid EZ Servo response:""
2021-08-03T17:20:40.196Z,1628011240.196 [BuoyancyServo] Communications Fault, FailCount= 1
2021-08-03T17:20:40.196Z,1628011240.196 [BuoyancyServo](ERROR): Communications Fault
2021-08-03T17:20:40.196Z,1628011240.196 [BuoyancyServo](FAULT): Buoyancy engine reporting null position
2021-08-03T17:20:40.196Z,1628011240.196 [BuoyancyServo] Hardware Fault, FailCount= 1
2021-08-03T17:20:40.196Z,1628011240.196 [BuoyancyServo](ERROR): Hardware Fault
2021-08-03T17:20:40.228Z,1628011240.228 [CBIT](ERROR): Hardware Fault in component: BuoyancyServo
2021-08-03T17:20:41.043Z,1628011241.043 [MassServo](FAULT): Invalid EZ Servo response:"715"
2021-08-03T17:20:41.043Z,1628011241.043 [MassServo] Communications Fault, FailCount= 1
2021-08-03T17:20:41.043Z,1628011241.043 [MassServo](ERROR): Communications Fault
2021-08-03T17:20:41.044Z,1628011241.044 [MassServo](FAULT): Mass Shifter error waiting for homing. Uart error: no error
2021-08-03T17:20:41.044Z,1628011241.044 [MassServo] Hardware Fault, FailCount= 1
2021-08-03T17:20:41.044Z,1628011241.044 [MassServo](ERROR): Hardware Fault
2021-08-03T17:20:41.071Z,1628011241.071 [MassServo](FAULT): Reading outside of valid range:1094836.000000
2021-08-03T17:20:41.259Z,1628011241.259 [CBIT](ERROR): Hardware Fault in component: MassServo
2021-08-03T17:20:41.301Z,1628011241.301 [MassServo](DEBUG): Uninitialize Mass Servo.
2021-08-03T17:20:41.301Z,1628011241.301 [MassServo](INFO): Powering down
2021-08-03T17:20:42.087Z,1628011242.087 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2021-08-03T17:20:42.087Z,1628011242.087 [BuoyancyServo](INFO): Powering down
2021-08-03T17:20:42.220Z,1628011242.220 [MassServo](DEBUG): Initializing EZServoServo.
2021-08-03T17:20:42.340Z,1628011242.340 [MassServo](DEBUG): Initializing MassServo.
2021-08-03T17:20:42.344Z,1628011242.344 [CBIT](INFO): Clearing failed state for component MassServo
2021-08-03T17:20:42.344Z,1628011242.344 [MassServo] No Fault, FailCount= 1
2021-08-03T17:20:42.900Z,1628011242.900 [CBIT](INFO): Clearing failed state for component BuoyancyServo
2021-08-03T17:20:42.900Z,1628011242.900 [BuoyancyServo] No Fault, FailCount= 1
2021-08-03T17:20:43.299Z,1628011243.299 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2021-08-03T17:20:43.300Z,1628011243.300 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2021-08-03T17:20:46.387Z,1628011246.387 [MassServo](ERROR): isCommunicating uart error serial timeout
2021-08-03T17:20:46.387Z,1628011246.387 [MassServo](FAULT): Invalid EZ Servo response:"\n"
2021-08-03T17:20:46.387Z,1628011246.387 [MassServo] Communications Fault, FailCount= 2
2021-08-03T17:20:46.387Z,1628011246.387 [MassServo](ERROR): Communications Fault
2021-08-03T17:20:46.387Z,1628011246.387 [MassServo](FAULT): Mass Shifter error waiting for homing. Uart error: serial timeout
2021-08-03T17:20:46.388Z,1628011246.388 [MassServo] Hardware Fault, FailCount= 2
2021-08-03T17:20:46.388Z,1628011246.388 [MassServo](ERROR): Hardware Fault
2021-08-03T17:20:46.415Z,1628011246.415 [CBIT](ERROR): Hardware Fault in component: MassServo
2021-08-03T17:20:46.775Z,1628011246.775 [BuoyancyServo](FAULT): Invalid EZ Servo response:""
2021-08-03T17:20:46.775Z,1628011246.775 [BuoyancyServo] Communications Fault, FailCount= 2
2021-08-03T17:20:46.775Z,1628011246.775 [BuoyancyServo](ERROR): Communications Fault
2021-08-03T17:20:46.775Z,1628011246.775 [BuoyancyServo](FAULT): Buoyancy engine reporting null position
2021-08-03T17:20:46.775Z,1628011246.775 [BuoyancyServo] Hardware Fault, FailCount= 2
2021-08-03T17:20:46.775Z,1628011246.775 [BuoyancyServo](ERROR): Hardware Fault
2021-08-03T17:20:46.776Z,1628011246.776 [MassServo](DEBUG): Uninitialize Mass Servo.
2021-08-03T17:20:46.776Z,1628011246.776 [MassServo](INFO): Powering down
2021-08-03T17:20:46.781Z,1628011246.781 [CBIT](ERROR): Hardware Fault in component: BuoyancyServo
2021-08-03T17:20:47.495Z,1628011247.495 [CBIT](INFO): Clearing failed state for component MassServo
2021-08-03T17:20:47.495Z,1628011247.495 [MassServo] No Fault, FailCount= 0
2021-08-03T17:20:47.743Z,1628011247.743 [MassServo](DEBUG): Initializing EZServoServo.
2021-08-03T17:20:47.751Z,1628011247.751 [MassServo](DEBUG): Initializing MassServo.
2021-08-03T17:20:48.551Z,1628011248.551 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2021-08-03T17:20:48.551Z,1628011248.551 [BuoyancyServo](INFO): Powering down
2021-08-03T17:20:49.408Z,1628011249.408 [CBIT](INFO): Clearing failed state for component BuoyancyServo
2021-08-03T17:20:49.408Z,1628011249.408 [BuoyancyServo] No Fault, FailCount= 2
2021-08-03T17:20:49.763Z,1628011249.763 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2021-08-03T17:20:49.771Z,1628011249.771 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2021-08-03T17:20:54.507Z,1628011254.507 [BuoyancyServo](ERROR): getPosition uart error serial timeout
2021-08-03T17:20:54.507Z,1628011254.507 [BuoyancyServo](FAULT): Buoyancy getPosition uart error.serial timeout
2021-08-03T17:20:54.507Z,1628011254.507 [BuoyancyServo] Communications Fault, FailCount= 3
2021-08-03T17:20:54.507Z,1628011254.507 [BuoyancyServo](ERROR): Communications Fault
2021-08-03T17:20:54.520Z,1628011254.520 [CBIT](ERROR): Communications Fault in component: BuoyancyServo
2021-08-03T17:20:56.172Z,1628011256.172 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2021-08-03T17:20:56.172Z,1628011256.172 [BuoyancyServo](INFO): Powering down
2021-08-03T17:20:56.578Z,1628011256.578 [SBIT](IMPORTANT): Beginning Startup BIT
2021-08-03T17:20:56.586Z,1628011256.586 [CBIT](IMPORTANT): Beginning ground fault scan
2021-08-03T17:20:57.179Z,1628011257.179 [ElevatorServo](FAULT): Invalid EZ Servo response:""
2021-08-03T17:20:57.179Z,1628011257.179 [ElevatorServo] Communications Fault, FailCount= 1
2021-08-03T17:20:57.179Z,1628011257.179 [ElevatorServo](ERROR): Communications Fault
2021-08-03T17:20:57.179Z,1628011257.179 [ElevatorServo](ERROR): Elevator reporting null position
2021-08-03T17:20:57.188Z,1628011257.188 [CBIT](INFO): Clearing failed state for component BuoyancyServo
2021-08-03T17:20:57.189Z,1628011257.189 [BuoyancyServo] No Fault, FailCount= 3
2021-08-03T17:20:57.190Z,1628011257.190 [CBIT](ERROR): Communications Fault in component: ElevatorServo
2021-08-03T17:20:57.369Z,1628011257.369 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2021-08-03T17:20:57.375Z,1628011257.375 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2021-08-03T17:20:57.376Z,1628011257.376 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2021-08-03T17:20:57.376Z,1628011257.376 [ElevatorServo](INFO): Powering down
2021-08-03T17:20:58.175Z,1628011258.175 [ElevatorServo](DEBUG): Initializing EZServoServo.
2021-08-03T17:20:58.292Z,1628011258.292 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2021-08-03T17:20:58.567Z,1628011258.567 [CBIT](INFO): Clearing failed state for component ElevatorServo
2021-08-03T17:20:58.567Z,1628011258.567 [ElevatorServo] No Fault, FailCount= 1
2021-08-03T17:21:00.115Z,1628011260.115 [MassServo](FAULT): Invalid EZ Servo response:""
2021-08-03T17:21:00.115Z,1628011260.115 [MassServo] Communications Fault, FailCount= 1
2021-08-03T17:21:00.115Z,1628011260.115 [MassServo](ERROR): Communications Fault
2021-08-03T17:21:00.161Z,1628011260.161 [CBIT](ERROR): Communications Fault in component: MassServo
2021-08-03T17:21:00.352Z,1628011260.352 [MassServo](DEBUG): Uninitialize Mass Servo.
2021-08-03T17:21:00.352Z,1628011260.352 [MassServo](INFO): Powering down
2021-08-03T17:21:00.931Z,1628011260.931 [RudderServo](FAULT): Invalid EZ Servo response:"4"
2021-08-03T17:21:00.931Z,1628011260.931 [RudderServo] Communications Fault, FailCount= 1
2021-08-03T17:21:00.931Z,1628011260.931 [RudderServo](ERROR): Communications Fault
2021-08-03T17:21:00.931Z,1628011260.931 [RudderServo](ERROR): Rudder reporting null position
2021-08-03T17:21:00.945Z,1628011260.945 [CBIT](ERROR): Communications Fault in component: RudderServo
2021-08-03T17:21:01.443Z,1628011261.443 [BuoyancyServo](FAULT): Invalid EZ Servo response:""
2021-08-03T17:21:01.443Z,1628011261.443 [BuoyancyServo] Communications Fault, FailCount= 4
2021-08-03T17:21:01.443Z,1628011261.443 [BuoyancyServo](ERROR): Communications Fault
2021-08-03T17:21:01.443Z,1628011261.443 [BuoyancyServo](FAULT): Buoyancy engine reporting null position
2021-08-03T17:21:01.443Z,1628011261.443 [BuoyancyServo] Hardware Fault, FailCount= 4
2021-08-03T17:21:01.443Z,1628011261.443 [BuoyancyServo](ERROR): Hardware Fault
2021-08-03T17:21:01.683Z,1628011261.683 [MassServo](DEBUG): Initializing EZServoServo.
2021-08-03T17:21:01.804Z,1628011261.804 [MassServo](DEBUG): Initializing MassServo.
2021-08-03T17:21:01.805Z,1628011261.805 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2021-08-03T17:21:01.805Z,1628011261.805 [RudderServo](INFO): Powering down
2021-08-03T17:21:01.810Z,1628011261.810 [CBIT](ERROR): Hardware Fault in component: BuoyancyServo
2021-08-03T17:21:01.810Z,1628011261.810 [CBIT](INFO): Clearing failed state for component MassServo
2021-08-03T17:21:01.810Z,1628011261.810 [MassServo] No Fault, FailCount= 1
2021-08-03T17:21:02.451Z,1628011262.451 [ElevatorServo](FAULT): Invalid EZ Servo response:""
2021-08-03T17:21:02.451Z,1628011262.451 [ElevatorServo] Communications Fault, FailCount= 2
2021-08-03T17:21:02.451Z,1628011262.451 [ElevatorServo](ERROR): Communications Fault
2021-08-03T17:21:02.451Z,1628011262.451 [ElevatorServo](ERROR): Elevator reporting null position
2021-08-03T17:21:02.452Z,1628011262.452 [RudderServo](DEBUG): Initializing EZServoServo.
2021-08-03T17:21:02.568Z,1628011262.568 [RudderServo](DEBUG): Initializing RudderServo.
2021-08-03T17:21:02.573Z,1628011262.573 [CBIT](ERROR): Communications Fault in component: ElevatorServo
2021-08-03T17:21:02.573Z,1628011262.573 [CBIT](INFO): Clearing failed state for component RudderServo
2021-08-03T17:21:02.573Z,1628011262.573 [RudderServo] No Fault, FailCount= 1
2021-08-03T17:21:02.711Z,1628011262.711 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2021-08-03T17:21:02.711Z,1628011262.711 [ElevatorServo](INFO): Powering down
2021-08-03T17:21:03.395Z,1628011263.395 [RudderServo](ERROR): Rudder initialization uart error serial timeout
2021-08-03T17:21:03.395Z,1628011263.395 [RudderServo](FAULT): Rudder failed to initialize
2021-08-03T17:21:03.395Z,1628011263.395 [RudderServo] Communications Fault, FailCount= 2
2021-08-03T17:21:03.395Z,1628011263.395 [RudderServo](ERROR): Communications Fault
2021-08-03T17:21:03.400Z,1628011263.400 [CBIT](ERROR): Communications Fault in component: RudderServo
2021-08-03T17:21:03.514Z,1628011263.514 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2021-08-03T17:21:03.514Z,1628011263.514 [BuoyancyServo](INFO): Powering down
2021-08-03T17:21:03.651Z,1628011263.651 [ElevatorServo](DEBUG): Initializing EZServoServo.
2021-08-03T17:21:03.772Z,1628011263.772 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2021-08-03T17:21:03.773Z,1628011263.773 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2021-08-03T17:21:03.773Z,1628011263.773 [RudderServo](INFO): Powering down
2021-08-03T17:21:03.778Z,1628011263.778 [CBIT](INFO): Clearing failed state for component ElevatorServo
2021-08-03T17:21:03.779Z,1628011263.779 [ElevatorServo] No Fault, FailCount= 2
2021-08-03T17:21:04.292Z,1628011264.292 [RudderServo](DEBUG): Initializing EZServoServo.
2021-08-03T17:21:04.408Z,1628011264.408 [RudderServo](DEBUG): Initializing RudderServo.
2021-08-03T17:21:04.414Z,1628011264.414 [CBIT](INFO): Clearing failed state for component BuoyancyServo
2021-08-03T17:21:04.414Z,1628011264.414 [BuoyancyServo] No Fault, FailCount= 4
2021-08-03T17:21:04.414Z,1628011264.414 [CBIT](INFO): Clearing failed state for component RudderServo
2021-08-03T17:21:04.414Z,1628011264.414 [RudderServo] No Fault, FailCount= 2
2021-08-03T17:21:04.695Z,1628011264.695 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2021-08-03T17:21:04.703Z,1628011264.703 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2021-08-03T17:21:05.231Z,1628011265.231 [RudderServo](ERROR): Rudder initialization uart error serial timeout
2021-08-03T17:21:05.231Z,1628011265.231 [RudderServo](FAULT): Rudder failed to initialize
2021-08-03T17:21:05.231Z,1628011265.231 [RudderServo] Communications Fault, FailCount= 3
2021-08-03T17:21:05.231Z,1628011265.231 [RudderServo](ERROR): Communications Fault
2021-08-03T17:21:05.236Z,1628011265.236 [CBIT](ERROR): Communications Fault in component: RudderServo
2021-08-03T17:21:05.236Z,1628011265.236 [CBIT](CRITICAL): Communications Fault in component: RudderServo
2021-08-03T17:21:05.368Z,1628011265.368 [NAL9602](INFO): Powering up NAL9602
2021-08-03T17:21:05.419Z,1628011265.419 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2021-08-03T17:21:05.420Z,1628011265.420 [RudderServo](INFO): Powering down
2021-08-03T17:21:05.424Z,1628011265.424 [CommandLine](FAULT): Scheduling is paused
2021-08-03T17:21:05.425Z,1628011265.425 [CBIT](INFO): Critical error at 20210803T172105
2021-08-03T17:21:05.425Z,1628011265.425 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals
2021-08-03T17:21:06.440Z,1628011266.440 [RudderServo](DEBUG): Initializing EZServoServo.
2021-08-03T17:21:06.560Z,1628011266.560 [RudderServo](DEBUG): Initializing RudderServo.
2021-08-03T17:21:06.903Z,1628011266.903 [MassServo](FAULT): Invalid EZ Servo response:""
2021-08-03T17:21:06.903Z,1628011266.903 [MassServo] Communications Fault, FailCount= 2
2021-08-03T17:21:06.903Z,1628011266.903 [MassServo](ERROR): Communications Fault
2021-08-03T17:21:06.908Z,1628011266.908 [CBIT](ERROR): Communications Fault in component: MassServo
2021-08-03T17:21:07.363Z,1628011267.363 [ElevatorServo](FAULT): Invalid EZ Servo response:""
2021-08-03T17:21:07.363Z,1628011267.363 [ElevatorServo] Communications Fault, FailCount= 3
2021-08-03T17:21:07.363Z,1628011267.363 [ElevatorServo](ERROR): Communications Fault
2021-08-03T17:21:07.363Z,1628011267.363 [ElevatorServo](ERROR): Elevator reporting null position
2021-08-03T17:21:07.364Z,1628011267.364 [MassServo](DEBUG): Uninitialize Mass Servo.
2021-08-03T17:21:07.364Z,1628011267.364 [MassServo](INFO): Powering down
2021-08-03T17:21:07.377Z,1628011267.377 [CBIT](ERROR): Communications Fault in component: ElevatorServo
2021-08-03T17:21:07.378Z,1628011267.378 [CBIT](CRITICAL): Communications Fault in component: ElevatorServo
2021-08-03T17:21:07.731Z,1628011267.731 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2021-08-03T17:21:07.731Z,1628011267.731 [ElevatorServo](INFO): Powering down
2021-08-03T17:21:07.735Z,1628011267.735 [CBIT](INFO): Critical error at 20210803T172107
2021-08-03T17:21:07.912Z,1628011267.912 [MassServo](DEBUG): Initializing EZServoServo.
2021-08-03T17:21:08.028Z,1628011268.028 [MassServo](DEBUG): Initializing MassServo.
2021-08-03T17:21:08.033Z,1628011268.033 [CBIT](INFO): Clearing failed state for component MassServo
2021-08-03T17:21:08.034Z,1628011268.034 [MassServo] No Fault, FailCount= 2
2021-08-03T17:21:08.043Z,1628011268.043 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): 0.008244
CHAN A1 (24V): 0.001835
CHAN A2 (12V): -0.004964
CHAN A3 (5V): -0.003011
CHAN B0 (3.3V): 0.000040
CHAN B1 (3.15aV): -0.001509
CHAN B2 (3.15bV): -0.000966
CHAN B3 (GND): 0.000588
OPEN: 0.003278
Full Scale Calc: 4.765 mA, -1.589 mA
2021-08-03T17:21:08.499Z,1628011268.499 [BuoyancyServo](FAULT): Invalid EZ Servo response:""
2021-08-03T17:21:08.499Z,1628011268.499 [BuoyancyServo] Communications Fault, FailCount= 5
2021-08-03T17:21:08.499Z,1628011268.499 [BuoyancyServo](ERROR): Communications Fault
2021-08-03T17:21:08.499Z,1628011268.499 [BuoyancyServo](FAULT): Buoyancy engine reporting null position
2021-08-03T17:21:08.499Z,1628011268.499 [BuoyancyServo] Hardware Fault, FailCount= 5
2021-08-03T17:21:08.499Z,1628011268.499 [BuoyancyServo](ERROR): Hardware Fault
2021-08-03T17:21:08.500Z,1628011268.500 [ElevatorServo](DEBUG): Initializing EZServoServo.
2021-08-03T17:21:08.620Z,1628011268.620 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2021-08-03T17:21:08.625Z,1628011268.625 [CBIT](ERROR): Hardware Fault in component: BuoyancyServo
2021-08-03T17:21:09.900Z,1628011269.900 [SBIT](ERROR): Could not read elevatorAngleReader_.
2021-08-03T17:21:09.900Z,1628011269.900 [SBIT](ERROR): Could not read rudderAngleReader_.
2021-08-03T17:21:09.901Z,1628011269.901 [SBIT](ERROR): Could not read massPosReader_.
2021-08-03T17:21:10.303Z,1628011270.303 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2021-08-03T17:21:10.304Z,1628011270.304 [BuoyancyServo](INFO): Powering down
2021-08-03T17:21:11.138Z,1628011271.138 [CBIT](INFO): Clearing failed state for component BuoyancyServo
2021-08-03T17:21:11.138Z,1628011271.138 [BuoyancyServo] No Fault, FailCount= 5
2021-08-03T17:21:11.525Z,1628011271.525 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2021-08-03T17:21:11.531Z,1628011271.531 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2021-08-03T17:21:11.739Z,1628011271.739 [MassServo](FAULT): Invalid EZ Servo response:"566"
2021-08-03T17:21:11.739Z,1628011271.739 [MassServo] Communications Fault, FailCount= 3
2021-08-03T17:21:11.739Z,1628011271.739 [MassServo](ERROR): Communications Fault
2021-08-03T17:21:11.740Z,1628011271.740 [MassServo](FAULT): Mass Shifter error waiting for homing. Uart error: no error
2021-08-03T17:21:11.740Z,1628011271.740 [MassServo] Hardware Fault, FailCount= 3
2021-08-03T17:21:11.740Z,1628011271.740 [MassServo](ERROR): Hardware Fault
2021-08-03T17:21:11.775Z,1628011271.775 [MassServo](FAULT): Reading outside of valid range:1099784.000000
2021-08-03T17:21:11.780Z,1628011271.780 [CBIT](ERROR): Hardware Fault in component: MassServo
2021-08-03T17:21:11.932Z,1628011271.932 [MassServo](DEBUG): Uninitialize Mass Servo.
2021-08-03T17:21:11.932Z,1628011271.932 [MassServo](INFO): Powering down
2021-08-03T17:21:12.867Z,1628011272.867 [MassServo](DEBUG): Initializing EZServoServo.
2021-08-03T17:21:12.988Z,1628011272.988 [MassServo](DEBUG): Initializing MassServo.
2021-08-03T17:21:12.993Z,1628011272.993 [CBIT](INFO): Clearing failed state for component MassServo
2021-08-03T17:21:12.993Z,1628011272.993 [MassServo] No Fault, FailCount= 3
2021-08-03T17:21:15.363Z,1628011275.363 [BuoyancyServo](FAULT): Invalid EZ Servo response:""
2021-08-03T17:21:15.363Z,1628011275.363 [BuoyancyServo] Communications Fault, FailCount= 6
2021-08-03T17:21:15.363Z,1628011275.363 [BuoyancyServo](ERROR): Communications Fault
2021-08-03T17:21:15.363Z,1628011275.363 [BuoyancyServo](FAULT): Buoyancy engine reporting null position
2021-08-03T17:21:15.363Z,1628011275.363 [BuoyancyServo] Hardware Fault, FailCount= 6
2021-08-03T17:21:15.363Z,1628011275.363 [BuoyancyServo](ERROR): Hardware Fault
2021-08-03T17:21:15.368Z,1628011275.368 [CBIT](ERROR): Hardware Fault in component: BuoyancyServo
2021-08-03T17:21:16.356Z,1628011276.356 [NAL9602](INFO): NAL9602 initialized
2021-08-03T17:21:16.479Z,1628011276.479 [MassServo](ERROR): getPosition uart error serial timeout
2021-08-03T17:21:16.479Z,1628011276.479 [MassServo](FAULT): Invalid EZ Servo response:"\n"
2021-08-03T17:21:16.479Z,1628011276.479 [MassServo] Communications Fault, FailCount= 4
2021-08-03T17:21:16.479Z,1628011276.479 [MassServo](ERROR): Communications Fault
2021-08-03T17:21:16.500Z,1628011276.500 [CBIT](ERROR): Communications Fault in component: MassServo
2021-08-03T17:21:16.767Z,1628011276.767 [MassServo](DEBUG): Uninitialize Mass Servo.
2021-08-03T17:21:16.768Z,1628011276.768 [MassServo](INFO): Powering down
2021-08-03T17:21:17.197Z,1628011277.197 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2021-08-03T17:21:17.197Z,1628011277.197 [BuoyancyServo](INFO): Powering down
2021-08-03T17:21:17.593Z,1628011277.593 [MassServo](DEBUG): Initializing EZServoServo.
2021-08-03T17:21:17.708Z,1628011277.708 [MassServo](DEBUG): Initializing MassServo.
2021-08-03T17:21:17.713Z,1628011277.713 [CBIT](INFO): Clearing failed state for component MassServo
2021-08-03T17:21:17.713Z,1628011277.713 [MassServo] No Fault, FailCount= 4
2021-08-03T17:21:18.009Z,1628011278.009 [CBIT](INFO): Clearing failed state for component BuoyancyServo
2021-08-03T17:21:18.010Z,1628011278.010 [BuoyancyServo] No Fault, FailCount= 6
2021-08-03T17:21:18.400Z,1628011278.400 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2021-08-03T17:21:18.420Z,1628011278.420 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2021-08-03T17:21:20.167Z,1628011280.167 [CommandLine](IMPORTANT): got command quit
2021-08-03T17:21:21.171Z,1628011281.171 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2021-08-03T17:21:21.171Z,1628011281.171 [CommandLine ThreadHandler](INFO): Thread cancelled.
2021-08-03T17:21:21.179Z,1628011281.179 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye!
2021-08-03T17:21:21.179Z,1628011281.179 [CommandLine ThreadHandler](INFO): Thread cancelled.
2021-08-03T17:21:21.179Z,1628011281.179 [CommandLine](INFO): Join timeout helper Thread ID is 938
2021-08-03T17:21:21.235Z,1628011281.235 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2021-08-03T17:21:21.235Z,1628011281.235 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2021-08-03T17:21:21.236Z,1628011281.236 [NavChartDb](INFO): Join timeout helper Thread ID is 939
2021-08-03T17:21:21.843Z,1628011281.843 [MassServo](FAULT): Invalid EZ Servo response:""
2021-08-03T17:21:21.843Z,1628011281.843 [MassServo] Communications Fault, FailCount= 5
2021-08-03T17:21:21.843Z,1628011281.843 [MassServo](ERROR): Communications Fault
2021-08-03T17:21:21.852Z,1628011281.852 [CBIT](ERROR): Communications Fault in component: MassServo
2021-08-03T17:21:21.852Z,1628011281.852 [CBIT](CRITICAL): Communications Fault in component: MassServo
2021-08-03T17:21:22.263Z,1628011282.263 [BuoyancyServo](FAULT): Invalid EZ Servo response:""
2021-08-03T17:21:22.263Z,1628011282.263 [BuoyancyServo] Communications Fault, FailCount= 7
2021-08-03T17:21:22.263Z,1628011282.263 [BuoyancyServo](ERROR): Communications Fault
2021-08-03T17:21:22.263Z,1628011282.263 [BuoyancyServo](FAULT): Buoyancy engine reporting null position
2021-08-03T17:21:22.263Z,1628011282.263 [BuoyancyServo] Hardware Fault, FailCount= 7
2021-08-03T17:21:22.263Z,1628011282.263 [BuoyancyServo](ERROR): Hardware Fault
2021-08-03T17:21:22.264Z,1628011282.264 [MassServo](DEBUG): Uninitialize Mass Servo.
2021-08-03T17:21:22.264Z,1628011282.264 [MassServo](INFO): Powering down
2021-08-03T17:21:22.267Z,1628011282.267 [CBIT](INFO): Critical error at 20210803T172121
2021-08-03T17:21:22.270Z,1628011282.270 [CBIT](ERROR): Hardware Fault in component: BuoyancyServo
2021-08-03T17:21:22.316Z,1628011282.316 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2021-08-03T17:21:22.317Z,1628011282.317 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2021-08-03T17:21:22.319Z,1628011282.319 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2021-08-03T17:21:22.319Z,1628011282.319 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2021-08-03T17:21:22.319Z,1628011282.319 [Radio_Surface](INFO): Join timeout helper Thread ID is 940
2021-08-03T17:21:22.447Z,1628011282.447 [Radio_Surface](INFO): Powering down
2021-08-03T17:21:22.636Z,1628011282.636 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2021-08-03T17:21:22.636Z,1628011282.636 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2021-08-03T17:21:22.647Z,1628011282.647 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler
2021-08-03T17:21:22.647Z,1628011282.647 [Onboard ThreadHandler](INFO): Thread cancelled.
2021-08-03T17:21:22.647Z,1628011282.647 [Onboard](INFO): Join timeout helper Thread ID is 941
2021-08-03T17:21:22.829Z,1628011282.829 [MassServo](DEBUG): Initializing EZServoServo.
2021-08-03T17:21:22.944Z,1628011282.944 [MassServo](DEBUG): Initializing MassServo.
2021-08-03T17:21:24.052Z,1628011284.052 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2021-08-03T17:21:24.053Z,1628011284.053 [BuoyancyServo](INFO): Powering down
2021-08-03T17:21:24.872Z,1628011284.872 [CBIT](INFO): Clearing failed state for component BuoyancyServo
2021-08-03T17:21:24.872Z,1628011284.872 [BuoyancyServo] No Fault, FailCount= 7
2021-08-03T17:21:25.272Z,1628011285.272 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2021-08-03T17:21:25.273Z,1628011285.273 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2021-08-03T17:21:26.187Z,1628011286.187 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread.
2021-08-03T17:21:26.187Z,1628011286.187 [Onboard ThreadHandler](INFO): Thread cancelled.
2021-08-03T17:21:26.199Z,1628011286.199 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler
2021-08-03T17:21:26.199Z,1628011286.199 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2021-08-03T17:21:26.199Z,1628011286.199 [DataOverHttps](INFO): Join timeout helper Thread ID is 944
2021-08-03T17:21:27.199Z,1628011287.199 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread.
2021-08-03T17:21:27.199Z,1628011287.199 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2021-08-03T17:21:27.220Z,1628011287.220 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2021-08-03T17:21:27.220Z,1628011287.220 [logger ThreadHandler](INFO): Thread cancelled.
2021-08-03T17:21:27.220Z,1628011287.220 [logger](INFO): Join timeout helper Thread ID is 945
2021-08-03T17:21:27.267Z,1628011287.267 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2021-08-03T17:21:27.267Z,1628011287.267 [logger ThreadHandler](INFO): Thread cancelled.
2021-08-03T17:21:27.280Z,1628011287.280 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2021-08-03T17:21:27.280Z,1628011287.280 [CommandLine ThreadHandler](INFO): Thread cancelled.
2021-08-03T17:21:27.280Z,1628011287.280 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2021-08-03T17:21:27.280Z,1628011287.280 [controlThread ThreadHandler](INFO): Thread cancelled.
2021-08-03T17:21:27.280Z,1628011287.280 [controlThread](INFO): Join timeout helper Thread ID is 946
2021-08-03T17:21:27.285Z,1628011287.285 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2021-08-03T17:21:27.285Z,1628011287.285 [controlThread](DEBUG): Uninitializing ControlThread
2021-08-03T17:21:27.288Z,1628011287.288 [NAL9602](INFO): Powering down
2021-08-03T17:21:27.289Z,1628011287.289 [DAT](INFO): Powering down
2021-08-03T17:21:27.408Z,1628011287.408 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2021-08-03T17:21:27.409Z,1628011287.409 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2021-08-03T17:21:27.409Z,1628011287.409 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2021-08-03T17:21:27.410Z,1628011287.410 [MissionManager](INFO): Uninitializing Mission Default
2021-08-03T17:21:27.413Z,1628011287.413 [MissionManager](INFO): Uninitializing Mission Startup
2021-08-03T17:21:27.415Z,1628011287.415 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2021-08-03T17:21:27.415Z,1628011287.415 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2021-08-03T17:21:27.415Z,1628011287.415 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2021-08-03T17:21:27.416Z,1628011287.416 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2021-08-03T17:21:27.416Z,1628011287.416 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2021-08-03T17:21:27.416Z,1628011287.416 [BuoyancyServo](INFO): Powering down
2021-08-03T17:21:27.547Z,1628011287.547 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2021-08-03T17:21:27.547Z,1628011287.547 [ElevatorServo](INFO): Powering down
2021-08-03T17:21:27.548Z,1628011287.548 [MassServo](DEBUG): Uninitialize Mass Servo.
2021-08-03T17:21:27.548Z,1628011287.548 [MassServo](INFO): Powering down
2021-08-03T17:21:27.549Z,1628011287.549 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2021-08-03T17:21:27.549Z,1628011287.549 [RudderServo](INFO): Powering down
2021-08-03T17:21:27.550Z,1628011287.550 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2021-08-03T17:21:27.550Z,1628011287.550 [ThrusterServo](INFO): Powering down
2021-08-03T17:21:27.551Z,1628011287.551 [SBIT](DEBUG): Uninitialize SBIT Component.
2021-08-03T17:21:27.551Z,1628011287.551 [IBIT](DEBUG): Uninitialize IBIT Component.
2021-08-03T17:21:27.552Z,1628011287.552 [CBIT](DEBUG): Uninitialize CBIT Component.
2021-08-03T17:21:27.552Z,1628011287.552 [CBIT](DEBUG): Powering off loads.
2021-08-03T17:21:27.563Z,1628011287.563 [CBIT](DEBUG): Disabling WDT.
2021-08-03T17:21:27.574Z,1628011287.574 [CBIT](DEBUG): Opening all GF detection circuits.
2021-08-03T17:21:27.575Z,1628011287.575 [controlThread ThreadHandler](INFO): Thread cancelled.
2021-08-03T17:21:28.001Z,1628011288.001 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2021-08-03T17:21:28.004Z,1628011288.004 [Onboard ThreadHandler](INFO): Thread cancelled.
2021-08-03T17:21:28.009Z,1628011288.009 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2021-08-03T17:21:28.087Z,1628011288.087 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2021-08-03T17:21:28.146Z,1628011288.146 [logger ThreadHandler](INFO): Thread cancelled.