2021-12-02T00:38:35.818Z,1638405515.818 [Supervisor](DEBUG): Initializing supervisor. 2021-12-02T00:38:35.823Z,1638405515.823 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2021-12-02T00:38:35.824Z,1638405515.824 [SyncHandler](INFO): Protected caller Thread ID is 6153 2021-12-02T00:38:35.824Z,1638405515.824 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2021-12-02T00:38:35.825Z,1638405515.825 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2021-12-02T00:38:35.826Z,1638405515.826 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 6154 2021-12-02T00:38:35.830Z,1638405515.830 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2021-12-02T00:38:35.849Z,1638405515.849 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread. 2021-12-02T00:38:35.850Z,1638405515.850 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2021-12-02T00:38:35.850Z,1638405515.850 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 6155 2021-12-02T00:38:35.854Z,1638405515.854 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2021-12-02T00:38:35.855Z,1638405515.855 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2021-12-02T00:38:35.856Z,1638405515.856 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 6156 2021-12-02T00:38:35.858Z,1638405515.858 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2021-12-02T00:38:35.859Z,1638405515.859 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0 2021-12-02T00:38:35.859Z,1638405515.859 [logger ThreadHandler](INFO): Protected caller Thread ID is 6157 2021-12-02T00:38:35.863Z,1638405515.863 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2021-12-02T00:38:35.864Z,1638405515.864 [Supervisor](INFO): Looking for Config files in directory: Config/ 2021-12-02T00:38:35.865Z,1638405515.865 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2021-12-02T00:38:35.960Z,1638405515.960 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2021-12-02T00:38:35.961Z,1638405515.961 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg 2021-12-02T00:38:36.164Z,1638405516.164 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock 2021-12-02T00:38:36.165Z,1638405516.165 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2021-12-02T00:38:36.393Z,1638405516.393 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2021-12-02T00:38:36.394Z,1638405516.394 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2021-12-02T00:38:36.497Z,1638405516.497 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2021-12-02T00:38:36.498Z,1638405516.498 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2021-12-02T00:38:37.131Z,1638405517.131 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2021-12-02T00:38:37.132Z,1638405517.132 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2021-12-02T00:38:37.639Z,1638405517.639 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2021-12-02T00:38:37.639Z,1638405517.639 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2021-12-02T00:38:38.162Z,1638405518.162 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2021-12-02T00:38:38.163Z,1638405518.163 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2021-12-02T00:38:38.523Z,1638405518.523 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2021-12-02T00:38:38.523Z,1638405518.523 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2021-12-02T00:38:38.841Z,1638405518.841 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2021-12-02T00:38:38.842Z,1638405518.842 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2021-12-02T00:38:39.188Z,1638405519.188 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2021-12-02T00:38:39.189Z,1638405519.189 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2021-12-02T00:38:39.334Z,1638405519.334 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2021-12-02T00:38:39.335Z,1638405519.335 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2021-12-02T00:38:39.462Z,1638405519.462 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2021-12-02T00:38:39.462Z,1638405519.462 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2021-12-02T00:38:39.541Z,1638405519.541 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2021-12-02T00:38:39.618Z,1638405519.618 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2021-12-02T00:38:39.801Z,1638405519.801 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2021-12-02T00:38:39.801Z,1638405519.801 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2021-12-02T00:38:40.011Z,1638405520.011 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2021-12-02T00:38:40.013Z,1638405520.013 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-makai/ 2021-12-02T00:38:40.013Z,1638405520.013 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/secure.cfg 2021-12-02T00:38:40.095Z,1638405520.095 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Battery.cfg 2021-12-02T00:38:40.349Z,1638405520.349 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2021-12-02T00:38:40.350Z,1638405520.350 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Navigation.cfg 2021-12-02T00:38:40.443Z,1638405520.443 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Sensor.cfg 2021-12-02T00:38:40.675Z,1638405520.675 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/vehicle.cfg 2021-12-02T00:38:41.258Z,1638405521.258 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Simulator.cfg 2021-12-02T00:38:41.341Z,1638405521.341 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Servo.cfg 2021-12-02T00:38:41.441Z,1638405521.441 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Control.cfg 2021-12-02T00:38:41.538Z,1638405521.538 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Science.cfg 2021-12-02T00:38:41.692Z,1638405521.692 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/logger.cfg 2021-12-02T00:38:41.792Z,1638405521.792 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/BIT.cfg 2021-12-02T00:38:41.889Z,1638405521.889 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-makai/root/ 2021-12-02T00:38:41.889Z,1638405521.889 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg 2021-12-02T00:38:41.891Z,1638405521.891 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2021-12-02T00:38:41.999Z,1638405521.999 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2021-12-02T00:38:41.999Z,1638405521.999 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2021-12-02T00:38:42.133Z,1638405522.133 [BuoyancyServo] Loaded 2021-12-02T00:38:42.133Z,1638405522.133 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2021-12-02T00:38:42.154Z,1638405522.154 [ElevatorServo] Loaded 2021-12-02T00:38:42.154Z,1638405522.154 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2021-12-02T00:38:42.173Z,1638405522.173 [MassServo] Loaded 2021-12-02T00:38:42.173Z,1638405522.173 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2021-12-02T00:38:42.193Z,1638405522.193 [RudderServo] Loaded 2021-12-02T00:38:42.193Z,1638405522.193 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2021-12-02T00:38:42.212Z,1638405522.212 [ThrusterServo] Loaded 2021-12-02T00:38:42.212Z,1638405522.212 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread. 2021-12-02T00:38:42.212Z,1638405522.212 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2021-12-02T00:38:42.213Z,1638405522.213 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2021-12-02T00:38:42.360Z,1638405522.360 [SBIT](DEBUG): Construct Startup Built In Test. 2021-12-02T00:38:42.375Z,1638405522.375 [SBIT] Loaded 2021-12-02T00:38:42.375Z,1638405522.375 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2021-12-02T00:38:42.378Z,1638405522.378 [IBIT](DEBUG): Construct Initiated Built In Test. 2021-12-02T00:38:42.398Z,1638405522.398 [IBIT] Loaded 2021-12-02T00:38:42.398Z,1638405522.398 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2021-12-02T00:38:42.404Z,1638405522.404 [CBIT](DEBUG): Construct Continuous Built In Test. 2021-12-02T00:38:42.609Z,1638405522.609 [CBIT] Loaded 2021-12-02T00:38:42.609Z,1638405522.609 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2021-12-02T00:38:42.610Z,1638405522.610 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2021-12-02T00:38:42.610Z,1638405522.610 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2021-12-02T00:38:42.786Z,1638405522.786 [CTD_Seabird] Loaded 2021-12-02T00:38:42.787Z,1638405522.787 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread. 2021-12-02T00:38:42.788Z,1638405522.788 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 406554E0 2021-12-02T00:38:42.788Z,1638405522.788 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 6240 2021-12-02T00:38:42.818Z,1638405522.818 [ESPComponent] Loaded 2021-12-02T00:38:42.819Z,1638405522.819 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread. 2021-12-02T00:38:42.838Z,1638405522.838 [PAR_Licor] Loaded 2021-12-02T00:38:42.838Z,1638405522.838 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread. 2021-12-02T00:38:42.869Z,1638405522.869 [WetLabsBB2FL] Loaded 2021-12-02T00:38:42.870Z,1638405522.870 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread. 2021-12-02T00:38:42.871Z,1638405522.871 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 406854E0 2021-12-02T00:38:42.871Z,1638405522.871 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 6241 2021-12-02T00:38:42.872Z,1638405522.872 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2021-12-02T00:38:42.872Z,1638405522.872 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2021-12-02T00:38:42.916Z,1638405522.916 [DepthRateCalculator] Loaded 2021-12-02T00:38:42.916Z,1638405522.916 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2021-12-02T00:38:42.921Z,1638405522.921 [PitchRateCalculator] Loaded 2021-12-02T00:38:42.922Z,1638405522.922 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2021-12-02T00:38:42.932Z,1638405522.932 [SpeedCalculator] Loaded 2021-12-02T00:38:42.932Z,1638405522.932 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2021-12-02T00:38:42.945Z,1638405522.945 [TempGradientCalculator] Loaded 2021-12-02T00:38:42.945Z,1638405522.945 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread. 2021-12-02T00:38:42.950Z,1638405522.950 [YawRateCalculator] Loaded 2021-12-02T00:38:42.950Z,1638405522.950 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2021-12-02T00:38:42.969Z,1638405522.969 [ElevatorOffsetCalculator] Loaded 2021-12-02T00:38:42.969Z,1638405522.969 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread. 2021-12-02T00:38:42.969Z,1638405522.969 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2021-12-02T00:38:42.970Z,1638405522.970 [Module Loader](DEBUG): Loading Module at Modules/Dock.so 2021-12-02T00:38:43.067Z,1638405523.067 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking) 2021-12-02T00:38:43.068Z,1638405523.068 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2021-12-02T00:38:43.097Z,1638405523.097 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2021-12-02T00:38:43.098Z,1638405523.098 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2021-12-02T00:38:43.178Z,1638405523.178 [DeadReckonUsingMultipleVelocitySources] Loaded 2021-12-02T00:38:43.179Z,1638405523.179 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2021-12-02T00:38:43.192Z,1638405523.192 [NavChart] Loaded 2021-12-02T00:38:43.192Z,1638405523.192 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2021-12-02T00:38:43.198Z,1638405523.198 [UniversalFixResidualReporter] Loaded 2021-12-02T00:38:43.198Z,1638405523.198 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2021-12-02T00:38:43.198Z,1638405523.198 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2021-12-02T00:38:43.199Z,1638405523.199 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2021-12-02T00:38:43.601Z,1638405523.601 [AHRS_M2] Loaded 2021-12-02T00:38:43.601Z,1638405523.601 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread. 2021-12-02T00:38:44.311Z,1638405524.311 [BPC1] Loaded 2021-12-02T00:38:44.311Z,1638405524.311 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2021-12-02T00:38:44.384Z,1638405524.384 [DataOverHttps] Loaded 2021-12-02T00:38:44.384Z,1638405524.384 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread. 2021-12-02T00:38:44.385Z,1638405524.385 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 409DB4E0 2021-12-02T00:38:44.386Z,1638405524.386 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 6242 2021-12-02T00:38:44.405Z,1638405524.405 [Depth_Keller] Loaded 2021-12-02T00:38:44.406Z,1638405524.406 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2021-12-02T00:38:44.410Z,1638405524.410 [DropWeight] Loaded 2021-12-02T00:38:44.411Z,1638405524.411 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread. 2021-12-02T00:38:44.447Z,1638405524.447 [DVL_micro] Loaded 2021-12-02T00:38:44.448Z,1638405524.448 [ComponentRegistry](DEBUG): SyncComponent "DVL_micro" handled in the control thread. 2021-12-02T00:38:44.505Z,1638405524.505 [NAL9602] Loaded 2021-12-02T00:38:44.505Z,1638405524.505 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2021-12-02T00:38:44.530Z,1638405524.530 [Onboard] Loaded 2021-12-02T00:38:44.530Z,1638405524.530 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread. 2021-12-02T00:38:44.531Z,1638405524.531 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 40A0B4E0 2021-12-02T00:38:44.532Z,1638405524.532 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 6243 2021-12-02T00:38:44.543Z,1638405524.543 [Power24vConverter] Loaded 2021-12-02T00:38:44.544Z,1638405524.544 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread. 2021-12-02T00:38:44.556Z,1638405524.556 [Radio_Surface] Loaded 2021-12-02T00:38:44.557Z,1638405524.557 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2021-12-02T00:38:44.558Z,1638405524.558 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 40A3B4E0 2021-12-02T00:38:44.558Z,1638405524.558 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 6244 2021-12-02T00:38:44.559Z,1638405524.559 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2021-12-02T00:38:44.560Z,1638405524.560 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2021-12-02T00:38:44.619Z,1638405524.619 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2021-12-02T00:38:44.620Z,1638405524.620 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2021-12-02T00:38:44.675Z,1638405524.675 [VerticalControl](DEBUG): Construct VerticalControl. 2021-12-02T00:38:44.728Z,1638405524.728 [VerticalControl] Loaded 2021-12-02T00:38:44.728Z,1638405524.728 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2021-12-02T00:38:44.731Z,1638405524.731 [HorizontalControl](DEBUG): Construct HorizontalControl. 2021-12-02T00:38:44.765Z,1638405524.765 [HorizontalControl] Loaded 2021-12-02T00:38:44.766Z,1638405524.766 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2021-12-02T00:38:44.768Z,1638405524.768 [SpeedControl](DEBUG): Construct SpeedControl. 2021-12-02T00:38:44.770Z,1638405524.770 [SpeedControl] Loaded 2021-12-02T00:38:44.770Z,1638405524.770 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2021-12-02T00:38:44.773Z,1638405524.773 [LoopControl](DEBUG): Construct LoopControl. 2021-12-02T00:38:44.773Z,1638405524.773 [LoopControl] Loaded 2021-12-02T00:38:44.774Z,1638405524.774 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2021-12-02T00:38:44.774Z,1638405524.774 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2021-12-02T00:38:44.775Z,1638405524.775 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2021-12-02T00:38:44.785Z,1638405524.785 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2021-12-02T00:38:44.786Z,1638405524.786 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2021-12-02T00:38:45.110Z,1638405525.110 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2021-12-02T00:38:45.116Z,1638405525.116 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2021-12-02T00:38:45.119Z,1638405525.119 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2021-12-02T00:38:45.130Z,1638405525.130 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2021-12-02T00:38:45.131Z,1638405525.131 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40B404E0 2021-12-02T00:38:45.132Z,1638405525.132 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 6245 2021-12-02T00:38:45.136Z,1638405525.136 [Supervisor](INFO): Main Thread ID is 6152 2021-12-02T00:38:45.137Z,1638405525.137 [Supervisor](DEBUG): Running supervisor. 2021-12-02T00:38:45.137Z,1638405525.137 [CommandExec ThreadHandler](INFO): Handler Thread ID is 6246 2021-12-02T00:38:45.138Z,1638405525.138 [CommandExec](INFO): Initializing the command executive. 2021-12-02T00:38:45.140Z,1638405525.140 [CommandLine ThreadHandler](INFO): Handler Thread ID is 6247 2021-12-02T00:38:45.142Z,1638405525.142 [controlThread ThreadHandler](INFO): Handler Thread ID is 6248 2021-12-02T00:38:45.142Z,1638405525.142 [controlThread](DEBUG): Initializing ControlThread 2021-12-02T00:38:45.144Z,1638405525.144 [SBIT](INFO): Initialize SBIT Component. 2021-12-02T00:38:45.145Z,1638405525.145 [SBIT](IMPORTANT): git: 2021-11-30_A 2021-12-02T00:38:45.145Z,1638405525.145 [SBIT](INFO): git hash: e825349414ed078c3d6d7ed1042b0342e8cc9ef7 2021-12-02T00:38:45.145Z,1638405525.145 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2021-12-02T00:38:45.147Z,1638405525.147 [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 2021-12-02T00:38:45.148Z,1638405525.148 [SBIT](INFO): Beginning SBIT in 59.000000 seconds. 2021-12-02T00:38:45.148Z,1638405525.148 [IBIT](INFO): Initialize IBIT Component. 2021-12-02T00:38:45.149Z,1638405525.149 [CBIT](DEBUG): Initialize CBIT Component. 2021-12-02T00:38:45.150Z,1638405525.150 [logger ThreadHandler](INFO): Handler Thread ID is 6249 2021-12-02T00:38:45.164Z,1638405525.164 [CBIT](DEBUG): Initialized mux pins. 2021-12-02T00:38:45.164Z,1638405525.164 [CBIT](DEBUG): Initializing the watchdog timer. 2021-12-02T00:38:45.176Z,1638405525.176 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 6250 2021-12-02T00:38:45.177Z,1638405525.177 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2021-12-02T00:38:45.181Z,1638405525.181 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 6252 2021-12-02T00:38:45.184Z,1638405525.184 [WetLabsBB2FL](INFO): Powering up 2021-12-02T00:38:45.185Z,1638405525.185 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 6254 2021-12-02T00:38:45.187Z,1638405525.187 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2021-12-02T00:38:45.188Z,1638405525.188 [CBIT](INFO): Last reboot was NOT due to watchdog timer. 2021-12-02T00:38:45.188Z,1638405525.188 [CBIT](DEBUG): Initializing heartbeat. 2021-12-02T00:38:45.202Z,1638405525.202 [Onboard ThreadHandler](INFO): Handler Thread ID is 6255 2021-12-02T00:38:45.232Z,1638405525.232 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 6256 2021-12-02T00:38:45.236Z,1638405525.236 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 6257 2021-12-02T00:38:45.239Z,1638405525.239 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2MI01M.000 2021-12-02T00:38:45.240Z,1638405525.240 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2MI01M.000 2021-12-02T00:38:45.240Z,1638405525.240 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4MI89M.000 2021-12-02T00:38:45.240Z,1638405525.240 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4MI89M.000 2021-12-02T00:38:45.240Z,1638405525.240 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4MI11M.000 2021-12-02T00:38:45.241Z,1638405525.241 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4MI11M.000 2021-12-02T00:38:45.241Z,1638405525.241 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5MI07M.000 2021-12-02T00:38:45.241Z,1638405525.241 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5MI07M.000 2021-12-02T00:38:45.241Z,1638405525.241 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5OH07M.000 2021-12-02T00:38:45.241Z,1638405525.241 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5OH07M.000 2021-12-02T00:38:45.242Z,1638405525.242 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5OH31M.000 2021-12-02T00:38:45.242Z,1638405525.242 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5OH31M.000 2021-12-02T00:38:45.260Z,1638405525.260 [CBIT](DEBUG): Deactivating GF circuits. 2021-12-02T00:38:45.260Z,1638405525.260 [CBIT](DEBUG): Deactivating emergency mode. 2021-12-02T00:38:45.296Z,1638405525.296 [CBIT](DEBUG): Backplane powered. 2021-12-02T00:38:45.300Z,1638405525.300 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2021-12-02T00:38:45.300Z,1638405525.300 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2021-12-02T00:38:45.301Z,1638405525.301 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2021-12-02T00:38:45.301Z,1638405525.301 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator. 2021-12-02T00:38:45.302Z,1638405525.302 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2021-12-02T00:38:45.302Z,1638405525.302 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator. 2021-12-02T00:38:45.304Z,1638405525.304 [NavChart](DEBUG): Initialize NavChart Navigation. 2021-12-02T00:38:45.304Z,1638405525.304 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2021-12-02T00:38:45.318Z,1638405525.318 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2021-12-02T00:38:45.328Z,1638405525.328 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2021-12-02T00:38:45.329Z,1638405525.329 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2021-12-02T00:38:45.329Z,1638405525.329 [LoopControl](DEBUG): Initialize LoopControlComponent. 2021-12-02T00:38:45.330Z,1638405525.330 [MissionManager](INFO): Loading Mission: Missions/Startup.xml 2021-12-02T00:38:45.384Z,1638405525.384 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2021-12-02T00:38:45.416Z,1638405525.416 [MissionManager](DEBUG): 2021-12-02T00:38:45.417Z,1638405525.417 [MissionManager](INFO): Loading Mission: Missions/Default.xml 2021-12-02T00:38:45.505Z,1638405525.505 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min 2021-12-02T00:38:45.506Z,1638405525.506 [Default:A.Wait](DEBUG): Construct Wait. 2021-12-02T00:38:45.508Z,1638405525.508 [Default:B.GoToSurface](DEBUG): Construct GoToSurface. 2021-12-02T00:38:45.559Z,1638405525.559 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2021-12-02T00:38:45.561Z,1638405525.561 [Default:CheckIn:C.Wait](DEBUG): Construct Wait. 2021-12-02T00:38:45.583Z,1638405525.583 [Default:E.Execute](DEBUG): Construct Execute. 2021-12-02T00:38:45.594Z,1638405525.594 [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-12-02T00:38:45.612Z,1638405525.612 [controlThread](DEBUG): Component order: CycleStarter,ESPComponent,PAR_Licor,AHRS_M2,BPC1,Depth_Keller,DropWeight,DVL_micro,NAL9602,Power24vConverter,PAR_Licor,Depth_Keller,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter, 2021-12-02T00:38:45.636Z,1638405525.636 [Radio_Surface](INFO): Powering up 2021-12-02T00:38:45.638Z,1638405525.638 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2021-12-02T00:38:45.713Z,1638405525.713 [Depth_Keller](ERROR): Pressure reading out of range: 1896.040405 decibar 2021-12-02T00:38:45.725Z,1638405525.725 [Power24vConverter](INFO): Powering up. 2021-12-02T00:38:45.729Z,1638405525.729 [DepthRateCalculator](ERROR): Depth measurement is not active 2021-12-02T00:38:45.770Z,1638405525.770 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2021-12-02T00:38:45.776Z,1638405525.776 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2021-12-02T00:38:45.777Z,1638405525.777 [ElevatorServo](DEBUG): Initializing EZServoServo. 2021-12-02T00:38:45.784Z,1638405525.784 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2021-12-02T00:38:45.785Z,1638405525.785 [MassServo](DEBUG): Initializing EZServoServo. 2021-12-02T00:38:45.796Z,1638405525.796 [MassServo](DEBUG): Initializing MassServo. 2021-12-02T00:38:45.797Z,1638405525.797 [RudderServo](DEBUG): Initializing EZServoServo. 2021-12-02T00:38:45.804Z,1638405525.804 [RudderServo](DEBUG): Initializing RudderServo. 2021-12-02T00:38:45.805Z,1638405525.805 [ThrusterServo](DEBUG): Initializing EZServoServo. 2021-12-02T00:38:45.812Z,1638405525.812 [ThrusterServo](DEBUG): Initializing ThrusterServo. 2021-12-02T00:38:46.072Z,1638405526.072 [DropWeight](CRITICAL): DROP WEIGHT MISSING. 2021-12-02T00:38:46.072Z,1638405526.072 [DropWeight] Hardware Fault, FailCount= 1 2021-12-02T00:38:46.072Z,1638405526.072 [DropWeight](ERROR): Hardware Fault 2021-12-02T00:38:46.119Z,1638405526.119 [CommandExec](FAULT): Scheduling is paused 2021-12-02T00:38:46.120Z,1638405526.120 [CBIT](INFO): Critical error at 20211202T003846 2021-12-02T00:38:46.120Z,1638405526.120 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals 2021-12-02T00:38:46.123Z,1638405526.123 [CBIT](ERROR): Hardware Fault in component: DropWeight 2021-12-02T00:38:46.172Z,1638405526.172 [CBIT](CRITICAL): Hardware Fault in component: DropWeight 2021-12-02T00:38:46.788Z,1638405526.788 [RudderServo](ERROR): Rudder initialization uart error serial timeout 2021-12-02T00:38:46.788Z,1638405526.788 [RudderServo](FAULT): Rudder failed to initialize 2021-12-02T00:38:46.788Z,1638405526.788 [RudderServo] Communications Fault, FailCount= 1 2021-12-02T00:38:46.788Z,1638405526.788 [RudderServo](ERROR): Communications Fault 2021-12-02T00:38:46.884Z,1638405526.884 [ThrusterServo](ERROR): Thruster halt for initialization uart error serial timeout 2021-12-02T00:38:47.200Z,1638405527.200 [ThrusterServo](ERROR): Thruster initialization uart error serial timeout 2021-12-02T00:38:47.200Z,1638405527.200 [ThrusterServo](FAULT): Thruster failed to initialize 2021-12-02T00:38:47.200Z,1638405527.200 [ThrusterServo] Communications Fault, FailCount= 1 2021-12-02T00:38:47.201Z,1638405527.201 [ThrusterServo](ERROR): Communications Fault 2021-12-02T00:38:47.202Z,1638405527.202 [CBIT](INFO): Critical error at 20211202T003846 2021-12-02T00:38:47.205Z,1638405527.205 [CBIT](ERROR): Communications Fault in component: RudderServo 2021-12-02T00:38:47.205Z,1638405527.205 [CBIT](ERROR): Communications Fault in component: ThrusterServo 2021-12-02T00:38:47.604Z,1638405527.604 [BuoyancyServo](ERROR): Buoyancy initialization uart error serial timeout 2021-12-02T00:38:47.604Z,1638405527.604 [BuoyancyServo](FAULT): Buoyancy failed to initialize 2021-12-02T00:38:47.604Z,1638405527.604 [BuoyancyServo] Communications Fault, FailCount= 1 2021-12-02T00:38:47.604Z,1638405527.604 [BuoyancyServo](ERROR): Communications Fault 2021-12-02T00:38:47.916Z,1638405527.916 [ElevatorServo](ERROR): Elevator initialization uart error I:serial timeout 2021-12-02T00:38:47.916Z,1638405527.916 [ElevatorServo](FAULT): Elevator failed to initialize 2021-12-02T00:38:47.916Z,1638405527.916 [ElevatorServo] Communications Fault, FailCount= 1 2021-12-02T00:38:47.916Z,1638405527.916 [ElevatorServo](ERROR): Communications Fault 2021-12-02T00:38:47.919Z,1638405527.919 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2021-12-02T00:38:47.920Z,1638405527.920 [RudderServo](INFO): Powering down 2021-12-02T00:38:47.926Z,1638405527.926 [ThrusterServo](DEBUG): Uninitialize Thruster Servo. 2021-12-02T00:38:47.927Z,1638405527.927 [ThrusterServo](INFO): Powering down 2021-12-02T00:38:47.951Z,1638405527.951 [CBIT](ERROR): Communications Fault in component: BuoyancyServo 2021-12-02T00:38:47.951Z,1638405527.951 [CBIT](ERROR): Communications Fault in component: ElevatorServo 2021-12-02T00:38:48.068Z,1638405528.068 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2021-12-02T00:38:48.068Z,1638405528.068 [ElevatorServo](INFO): Powering down 2021-12-02T00:38:48.413Z,1638405528.413 [RudderServo](DEBUG): Initializing EZServoServo. 2021-12-02T00:38:48.533Z,1638405528.533 [RudderServo](DEBUG): Initializing RudderServo. 2021-12-02T00:38:50.484Z,1638405530.484 [WetLabsBB2FL] Communications Fault, FailCount= 1 2021-12-02T00:38:50.484Z,1638405530.484 [WetLabsBB2FL](ERROR): Communications Fault 2021-12-02T00:38:50.984Z,1638405530.984 [WetLabsBB2FL](INFO): Powering down 2021-12-02T00:38:56.678Z,1638405536.678 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004645 2021-12-02T00:38:58.228Z,1638405538.228 [CTD_Seabird](FAULT): Failed to initialize within timeout. 2021-12-02T00:38:58.228Z,1638405538.228 [CTD_Seabird] Communications Fault, FailCount= 1 2021-12-02T00:38:58.228Z,1638405538.228 [CTD_Seabird](ERROR): Communications Fault 2021-12-02T00:38:58.633Z,1638405538.633 [CTD_Seabird](INFO): Powering down 2021-12-02T00:39:18.656Z,1638405558.656 [CBIT](CRITICAL): Environmental Failure. Press:14.764703 PSI. Humidity:38%. Temp:24 C. ABORTING MISSION 2021-12-02T00:39:18.657Z,1638405558.657 [CBIT](INFO): Clearing failed state for component RudderServo 2021-12-02T00:39:18.657Z,1638405558.657 [RudderServo] No Fault, FailCount= 1 2021-12-02T00:39:18.657Z,1638405558.657 [CBIT](INFO): Clearing failed state for component ThrusterServo 2021-12-02T00:39:18.657Z,1638405558.657 [ThrusterServo] No Fault, FailCount= 1 2021-12-02T00:39:18.657Z,1638405558.657 [CBIT](ERROR): Communications Fault in component: CTD_Seabird 2021-12-02T00:39:18.657Z,1638405558.657 [CBIT](INFO): Clearing failed state for component CTD_Seabird 2021-12-02T00:39:18.658Z,1638405558.658 [CTD_Seabird] No Fault, FailCount= 1 2021-12-02T00:39:18.658Z,1638405558.658 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2021-12-02T00:39:18.658Z,1638405558.658 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2021-12-02T00:39:18.658Z,1638405558.658 [WetLabsBB2FL] No Fault, FailCount= 1 2021-12-02T00:39:18.861Z,1638405558.861 [WetLabsBB2FL](INFO): Powering up 2021-12-02T00:39:18.964Z,1638405558.964 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2021-12-02T00:39:19.032Z,1638405559.032 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-12-02T00:39:19.032Z,1638405559.032 [AHRS_M2](FAULT): Failed to initialize within timeout. 2021-12-02T00:39:19.032Z,1638405559.032 [AHRS_M2] Communications Fault, FailCount= 1 2021-12-02T00:39:19.032Z,1638405559.032 [AHRS_M2](ERROR): Communications Fault 2021-12-02T00:39:19.038Z,1638405559.038 [NAL9602](INFO): Powering up NAL9602 2021-12-02T00:39:19.120Z,1638405559.120 [ElevatorServo](DEBUG): Initializing EZServoServo. 2021-12-02T00:39:19.241Z,1638405559.241 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2021-12-02T00:39:19.285Z,1638405559.285 [ThrusterServo](DEBUG): Initializing EZServoServo. 2021-12-02T00:39:19.292Z,1638405559.292 [ThrusterServo](DEBUG): Initializing ThrusterServo. 2021-12-02T00:39:19.294Z,1638405559.294 [CBIT](INFO): Critical error at 20211202T003918 2021-12-02T00:39:19.296Z,1638405559.296 [CBIT](INFO): Clearing failed state for component ElevatorServo 2021-12-02T00:39:19.296Z,1638405559.296 [ElevatorServo] No Fault, FailCount= 1 2021-12-02T00:39:19.297Z,1638405559.297 [CBIT](ERROR): Communications Fault in component: AHRS_M2 2021-12-02T00:39:19.348Z,1638405559.348 [AHRS_M2](INFO): Powering down 2021-12-02T00:39:19.496Z,1638405559.496 [CBIT](INFO): Clearing failed state for component BuoyancyServo 2021-12-02T00:39:19.496Z,1638405559.496 [BuoyancyServo] No Fault, FailCount= 1 2021-12-02T00:39:19.745Z,1638405559.745 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2021-12-02T00:39:19.865Z,1638405559.865 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2021-12-02T00:39:20.192Z,1638405560.192 [ThrusterServo](ERROR): Thruster halt for initialization uart error serial timeout 2021-12-02T00:39:20.288Z,1638405560.288 [ThrusterServo](ERROR): Thruster initialization uart error serial timeout 2021-12-02T00:39:20.288Z,1638405560.288 [ThrusterServo](FAULT): Thruster failed to initialize 2021-12-02T00:39:20.288Z,1638405560.288 [ThrusterServo] Communications Fault, FailCount= 2 2021-12-02T00:39:20.288Z,1638405560.288 [ThrusterServo](ERROR): Communications Fault 2021-12-02T00:39:20.291Z,1638405560.291 [CBIT](ERROR): Communications Fault in component: ThrusterServo 2021-12-02T00:39:20.680Z,1638405560.680 [ElevatorServo](ERROR): Elevator initialization uart error I:serial timeout 2021-12-02T00:39:20.680Z,1638405560.680 [ElevatorServo](FAULT): Elevator failed to initialize 2021-12-02T00:39:20.680Z,1638405560.680 [ElevatorServo] Communications Fault, FailCount= 2 2021-12-02T00:39:20.680Z,1638405560.680 [ElevatorServo](ERROR): Communications Fault 2021-12-02T00:39:20.710Z,1638405560.710 [ThrusterServo](DEBUG): Uninitialize Thruster Servo. 2021-12-02T00:39:20.710Z,1638405560.710 [ThrusterServo](INFO): Powering down 2021-12-02T00:39:20.743Z,1638405560.743 [CBIT](ERROR): Communications Fault in component: ElevatorServo 2021-12-02T00:39:20.751Z,1638405560.751 [CBIT](INFO): Clearing failed state for component AHRS_M2 2021-12-02T00:39:20.751Z,1638405560.751 [AHRS_M2] No Fault, FailCount= 1 2021-12-02T00:39:20.776Z,1638405560.776 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2021-12-02T00:39:21.168Z,1638405561.168 [BuoyancyServo](ERROR): Buoyancy initialization uart error serial timeout 2021-12-02T00:39:21.168Z,1638405561.168 [BuoyancyServo](FAULT): Buoyancy failed to initialize 2021-12-02T00:39:21.168Z,1638405561.168 [BuoyancyServo] Communications Fault, FailCount= 2 2021-12-02T00:39:21.168Z,1638405561.168 [BuoyancyServo](ERROR): Communications Fault 2021-12-02T00:39:21.169Z,1638405561.169 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2021-12-02T00:39:21.169Z,1638405561.169 [ElevatorServo](INFO): Powering down 2021-12-02T00:39:21.476Z,1638405561.476 [MassServo](ERROR): isCommunicating uart error serial timeout 2021-12-02T00:39:21.476Z,1638405561.476 [MassServo](FAULT): Invalid EZ Servo response:"" 2021-12-02T00:39:21.476Z,1638405561.476 [MassServo] Communications Fault, FailCount= 1 2021-12-02T00:39:21.476Z,1638405561.476 [MassServo](ERROR): Communications Fault 2021-12-02T00:39:21.477Z,1638405561.477 [MassServo](FAULT): Mass Shifter error waiting for homing. Uart error: serial timeout 2021-12-02T00:39:21.477Z,1638405561.477 [MassServo] Hardware Fault, FailCount= 1 2021-12-02T00:39:21.477Z,1638405561.477 [MassServo](ERROR): Hardware Fault 2021-12-02T00:39:21.481Z,1638405561.481 [MassServo](FAULT): Invalid EZ Servo response:"97" 2021-12-02T00:39:21.481Z,1638405561.481 [MassServo] Communications Fault, FailCount= 1 2021-12-02T00:39:21.482Z,1638405561.482 [MassServo](ERROR): Communications Fault 2021-12-02T00:39:21.808Z,1638405561.808 [RudderServo](FAULT): Rudder initialization uart error:serial timeout 2021-12-02T00:39:21.808Z,1638405561.808 [RudderServo] Communications Fault, FailCount= 2 2021-12-02T00:39:21.808Z,1638405561.808 [RudderServo](ERROR): Communications Fault 2021-12-02T00:39:21.812Z,1638405561.812 [CBIT](ERROR): Communications Fault in component: BuoyancyServo 2021-12-02T00:39:21.812Z,1638405561.812 [CBIT](ERROR): Communications Fault in component: MassServo 2021-12-02T00:39:21.812Z,1638405561.812 [CBIT](ERROR): Communications Fault in component: RudderServo 2021-12-02T00:39:21.836Z,1638405561.836 [MassServo](DEBUG): Uninitialize Mass Servo. 2021-12-02T00:39:21.837Z,1638405561.837 [MassServo](INFO): Powering down 2021-12-02T00:39:21.841Z,1638405561.841 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2021-12-02T00:39:21.842Z,1638405561.842 [RudderServo](INFO): Powering down 2021-12-02T00:39:24.180Z,1638405564.180 [WetLabsBB2FL] Communications Fault, FailCount= 2 2021-12-02T00:39:24.180Z,1638405564.180 [WetLabsBB2FL](ERROR): Communications Fault 2021-12-02T00:39:24.680Z,1638405564.680 [WetLabsBB2FL](INFO): Powering down 2021-12-02T00:39:32.016Z,1638405572.016 [CTD_Seabird](FAULT): Failed to initialize within timeout. 2021-12-02T00:39:32.016Z,1638405572.016 [CTD_Seabird] Communications Fault, FailCount= 2 2021-12-02T00:39:32.016Z,1638405572.016 [CTD_Seabird](ERROR): Communications Fault 2021-12-02T00:39:32.420Z,1638405572.420 [CTD_Seabird](INFO): Powering down 2021-12-02T00:39:52.074Z,1638405592.074 [CBIT](INFO): Clearing failed state for component ThrusterServo 2021-12-02T00:39:52.074Z,1638405592.074 [ThrusterServo] No Fault, FailCount= 2 2021-12-02T00:39:52.074Z,1638405592.074 [CBIT](ERROR): Communications Fault in component: CTD_Seabird 2021-12-02T00:39:52.075Z,1638405592.075 [CBIT](INFO): Clearing failed state for component CTD_Seabird 2021-12-02T00:39:52.075Z,1638405592.075 [CTD_Seabird] No Fault, FailCount= 2 2021-12-02T00:39:52.075Z,1638405592.075 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2021-12-02T00:39:52.075Z,1638405592.075 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2021-12-02T00:39:52.075Z,1638405592.075 [WetLabsBB2FL] No Fault, FailCount= 2 2021-12-02T00:39:52.153Z,1638405592.153 [WetLabsBB2FL](INFO): Powering up 2021-12-02T00:39:52.348Z,1638405592.348 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2021-12-02T00:39:52.400Z,1638405592.400 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-12-02T00:39:52.400Z,1638405592.400 [AHRS_M2](FAULT): Failed to initialize within timeout. 2021-12-02T00:39:52.400Z,1638405592.400 [AHRS_M2] Communications Fault, FailCount= 2 2021-12-02T00:39:52.400Z,1638405592.400 [AHRS_M2](ERROR): Communications Fault 2021-12-02T00:39:52.409Z,1638405592.409 [DVL_micro](FAULT): Failed to initialize within timeout. 2021-12-02T00:39:52.409Z,1638405592.409 [DVL_micro] Communications Fault, FailCount= 1 2021-12-02T00:39:52.409Z,1638405592.409 [DVL_micro](ERROR): Communications Fault 2021-12-02T00:39:52.419Z,1638405592.419 [ElevatorServo](DEBUG): Initializing EZServoServo. 2021-12-02T00:39:52.537Z,1638405592.537 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2021-12-02T00:39:52.538Z,1638405592.538 [ThrusterServo](DEBUG): Initializing EZServoServo. 2021-12-02T00:39:52.539Z,1638405592.539 [ThrusterServo](DEBUG): Initializing ThrusterServo. 2021-12-02T00:39:52.540Z,1638405592.540 [SBIT](IMPORTANT): Beginning Startup BIT 2021-12-02T00:39:52.548Z,1638405592.548 [CBIT](INFO): Clearing failed state for component ElevatorServo 2021-12-02T00:39:52.548Z,1638405592.548 [ElevatorServo] No Fault, FailCount= 2 2021-12-02T00:39:52.549Z,1638405592.549 [CBIT](ERROR): Communications Fault in component: AHRS_M2 2021-12-02T00:39:52.549Z,1638405592.549 [CBIT](ERROR): Communications Fault in component: DVL_micro 2021-12-02T00:39:52.550Z,1638405592.550 [CBIT](IMPORTANT): Beginning ground fault scan 2021-12-02T00:39:52.580Z,1638405592.580 [AHRS_M2](INFO): Powering down 2021-12-02T00:39:52.780Z,1638405592.780 [DVL_micro](INFO): Powering down 2021-12-02T00:39:52.823Z,1638405592.823 [MassServo](DEBUG): Initializing EZServoServo. 2021-12-02T00:39:52.941Z,1638405592.941 [MassServo](DEBUG): Initializing MassServo. 2021-12-02T00:39:52.941Z,1638405592.941 [RudderServo](DEBUG): Initializing EZServoServo. 2021-12-02T00:39:53.061Z,1638405593.061 [RudderServo](DEBUG): Initializing RudderServo. 2021-12-02T00:39:53.388Z,1638405593.388 [ThrusterServo](ERROR): Thruster halt for initialization uart error serial timeout 2021-12-02T00:39:53.476Z,1638405593.476 [ThrusterServo](ERROR): Thruster initialization uart error serial timeout 2021-12-02T00:39:53.476Z,1638405593.476 [ThrusterServo](FAULT): Thruster failed to initialize 2021-12-02T00:39:53.476Z,1638405593.476 [ThrusterServo] Communications Fault, FailCount= 3 2021-12-02T00:39:53.476Z,1638405593.476 [ThrusterServo](ERROR): Communications Fault 2021-12-02T00:39:53.480Z,1638405593.480 [CBIT](INFO): Clearing failed state for component BuoyancyServo 2021-12-02T00:39:53.480Z,1638405593.480 [BuoyancyServo] No Fault, FailCount= 2 2021-12-02T00:39:53.480Z,1638405593.480 [CBIT](INFO): Clearing failed state for component MassServo 2021-12-02T00:39:53.481Z,1638405593.481 [MassServo] No Fault, FailCount= 1 2021-12-02T00:39:53.481Z,1638405593.481 [CBIT](INFO): Clearing failed state for component RudderServo 2021-12-02T00:39:53.481Z,1638405593.481 [RudderServo] No Fault, FailCount= 2 2021-12-02T00:39:53.481Z,1638405593.481 [CBIT](ERROR): Communications Fault in component: ThrusterServo 2021-12-02T00:39:53.551Z,1638405593.551 [NAL9602](INFO): NAL9602 initialized 2021-12-02T00:39:53.561Z,1638405593.561 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2021-12-02T00:39:53.681Z,1638405593.681 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2021-12-02T00:39:53.992Z,1638405593.992 [ElevatorServo](ERROR): Elevator initialization uart error I:serial timeout 2021-12-02T00:39:53.992Z,1638405593.992 [ElevatorServo](FAULT): Elevator failed to initialize 2021-12-02T00:39:53.992Z,1638405593.992 [ElevatorServo] Communications Fault, FailCount= 3 2021-12-02T00:39:53.992Z,1638405593.992 [ElevatorServo](ERROR): Communications Fault 2021-12-02T00:39:54.052Z,1638405594.052 [ThrusterServo](DEBUG): Uninitialize Thruster Servo. 2021-12-02T00:39:54.052Z,1638405594.052 [ThrusterServo](INFO): Powering down 2021-12-02T00:39:54.057Z,1638405594.057 [CBIT](ERROR): Communications Fault in component: ElevatorServo 2021-12-02T00:39:54.058Z,1638405594.058 [CBIT](CRITICAL): Communications Fault in component: ElevatorServo 2021-12-02T00:39:54.113Z,1638405594.113 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2021-12-02T00:39:54.113Z,1638405594.113 [ElevatorServo](INFO): Powering down 2021-12-02T00:39:54.121Z,1638405594.121 [CBIT](INFO): Critical error at 20211202T003954 2021-12-02T00:39:54.123Z,1638405594.123 [CBIT](INFO): Clearing failed state for component AHRS_M2 2021-12-02T00:39:54.124Z,1638405594.124 [AHRS_M2] No Fault, FailCount= 2 2021-12-02T00:39:54.124Z,1638405594.124 [CBIT](INFO): Clearing failed state for component DVL_micro 2021-12-02T00:39:54.124Z,1638405594.124 [DVL_micro] No Fault, FailCount= 1 2021-12-02T00:39:54.481Z,1638405594.481 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2021-12-02T00:39:54.844Z,1638405594.844 [BuoyancyServo](ERROR): Buoyancy initialization uart error serial timeout 2021-12-02T00:39:54.844Z,1638405594.844 [BuoyancyServo](FAULT): Buoyancy failed to initialize 2021-12-02T00:39:54.844Z,1638405594.844 [BuoyancyServo] Communications Fault, FailCount= 3 2021-12-02T00:39:54.844Z,1638405594.844 [BuoyancyServo](ERROR): Communications Fault 2021-12-02T00:39:57.444Z,1638405597.444 [WetLabsBB2FL] Communications Fault, FailCount= 3 2021-12-02T00:39:57.444Z,1638405597.444 [WetLabsBB2FL](ERROR): Communications Fault 2021-12-02T00:39:57.944Z,1638405597.944 [WetLabsBB2FL](INFO): Powering down 2021-12-02T00:40:05.400Z,1638405605.400 [CTD_Seabird](FAULT): Failed to initialize within timeout. 2021-12-02T00:40:05.400Z,1638405605.400 [CTD_Seabird] Communications Fault, FailCount= 3 2021-12-02T00:40:05.400Z,1638405605.400 [CTD_Seabird](ERROR): Communications Fault 2021-12-02T00:40:05.804Z,1638405605.804 [CTD_Seabird](INFO): Powering down 2021-12-02T00:40:24.965Z,1638405624.965 [SBIT](ERROR): Could not read elevatorAngleReader_. 2021-12-02T00:40:24.965Z,1638405624.965 [SBIT](ERROR): Could not read rudderAngleReader_. 2021-12-02T00:40:24.965Z,1638405624.965 [SBIT](ERROR): Could not read massPosReader_. 2021-12-02T00:40:24.969Z,1638405624.969 [CBIT](ERROR): Communications Fault in component: BuoyancyServo 2021-12-02T00:40:24.969Z,1638405624.969 [CBIT](INFO): Clearing failed state for component ThrusterServo 2021-12-02T00:40:24.969Z,1638405624.969 [ThrusterServo] No Fault, FailCount= 3 2021-12-02T00:40:24.970Z,1638405624.970 [CBIT](ERROR): Communications Fault in component: CTD_Seabird 2021-12-02T00:40:24.970Z,1638405624.970 [CBIT](FAULT): Communications Fault in component: CTD_Seabird 2021-12-02T00:40:24.970Z,1638405624.970 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2021-12-02T00:40:24.970Z,1638405624.970 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2021-12-02T00:40:24.970Z,1638405624.970 [WetLabsBB2FL] No Fault, FailCount= 3 2021-12-02T00:40:25.013Z,1638405625.013 [WetLabsBB2FL](INFO): Powering up 2021-12-02T00:40:25.380Z,1638405625.380 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-12-02T00:40:25.380Z,1638405625.380 [AHRS_M2](FAULT): Failed to initialize within timeout. 2021-12-02T00:40:25.380Z,1638405625.380 [AHRS_M2] Communications Fault, FailCount= 3 2021-12-02T00:40:25.380Z,1638405625.380 [AHRS_M2](ERROR): Communications Fault 2021-12-02T00:40:25.440Z,1638405625.440 [ElevatorServo](DEBUG): Initializing EZServoServo. 2021-12-02T00:40:25.561Z,1638405625.561 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2021-12-02T00:40:25.562Z,1638405625.562 [ThrusterServo](DEBUG): Initializing EZServoServo. 2021-12-02T00:40:25.563Z,1638405625.563 [ThrusterServo](DEBUG): Initializing ThrusterServo. 2021-12-02T00:40:25.577Z,1638405625.577 [CBIT](ERROR): Communications Fault in component: AHRS_M2 2021-12-02T00:40:25.586Z,1638405625.586 [AHRS_M2](INFO): Powering down 2021-12-02T00:40:25.665Z,1638405625.665 [BPC1](ERROR): BPC1A buffer size (9E8 bytes) exceeded the max device response limit. 2021-12-02T00:40:25.665Z,1638405625.665 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2021-12-02T00:40:26.004Z,1638405626.004 [BPC1](ERROR): BPC1B buffer size (FAD bytes) exceeded the max device response limit. 2021-12-02T00:40:26.005Z,1638405626.005 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2021-12-02T00:40:26.852Z,1638405626.852 [ThrusterServo](ERROR): Thruster halt for initialization uart error serial timeout 2021-12-02T00:40:27.176Z,1638405627.176 [ThrusterServo](ERROR): Thruster initialization uart error serial timeout 2021-12-02T00:40:27.176Z,1638405627.176 [ThrusterServo](FAULT): Thruster failed to initialize 2021-12-02T00:40:27.176Z,1638405627.176 [ThrusterServo] Communications Fault, FailCount= 4 2021-12-02T00:40:27.176Z,1638405627.176 [ThrusterServo](ERROR): Communications Fault 2021-12-02T00:40:27.180Z,1638405627.180 [CBIT](ERROR): Communications Fault in component: ThrusterServo 2021-12-02T00:40:27.181Z,1638405627.181 [CBIT](INFO): Clearing failed state for component AHRS_M2 2021-12-02T00:40:27.181Z,1638405627.181 [AHRS_M2] No Fault, FailCount= 3 2021-12-02T00:40:27.279Z,1638405627.279 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2021-12-02T00:40:27.636Z,1638405627.636 [MassServo](ERROR): isCommunicating uart error serial timeout 2021-12-02T00:40:27.636Z,1638405627.636 [MassServo](FAULT): Invalid EZ Servo response:"" 2021-12-02T00:40:27.636Z,1638405627.636 [MassServo] Communications Fault, FailCount= 2 2021-12-02T00:40:27.636Z,1638405627.636 [MassServo](ERROR): Communications Fault 2021-12-02T00:40:27.636Z,1638405627.636 [MassServo](FAULT): Mass Shifter error waiting for homing. Uart error: serial timeout 2021-12-02T00:40:27.636Z,1638405627.636 [MassServo] Hardware Fault, FailCount= 2 2021-12-02T00:40:27.636Z,1638405627.636 [MassServo](ERROR): Hardware Fault 2021-12-02T00:40:27.640Z,1638405627.640 [MassServo](FAULT): Invalid EZ Servo response:"03" 2021-12-02T00:40:27.641Z,1638405627.641 [MassServo] Communications Fault, FailCount= 2 2021-12-02T00:40:27.641Z,1638405627.641 [MassServo](ERROR): Communications Fault 2021-12-02T00:40:27.675Z,1638405627.675 [ThrusterServo](DEBUG): Uninitialize Thruster Servo. 2021-12-02T00:40:27.675Z,1638405627.675 [ThrusterServo](INFO): Powering down 2021-12-02T00:40:27.684Z,1638405627.684 [CBIT](ERROR): Communications Fault in component: MassServo 2021-12-02T00:40:27.766Z,1638405627.766 [MassServo](DEBUG): Uninitialize Mass Servo. 2021-12-02T00:40:27.766Z,1638405627.766 [MassServo](INFO): Powering down 2021-12-02T00:40:27.809Z,1638405627.809 [CBIT](INFO): Clearing failed state for component BuoyancyServo 2021-12-02T00:40:27.809Z,1638405627.809 [BuoyancyServo] No Fault, FailCount= 3 2021-12-02T00:40:28.144Z,1638405628.144 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2021-12-02T00:40:28.265Z,1638405628.265 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2021-12-02T00:40:28.572Z,1638405628.572 [RudderServo](ERROR): getPosition uart error serial timeout 2021-12-02T00:40:28.572Z,1638405628.572 [RudderServo](FAULT): Rudder uart error - getPosition..serial timeout 2021-12-02T00:40:28.572Z,1638405628.572 [RudderServo] Communications Fault, FailCount= 3 2021-12-02T00:40:28.572Z,1638405628.572 [RudderServo](ERROR): Communications Fault 2021-12-02T00:40:30.305Z,1638405630.305 [WetLabsBB2FL] Communications Fault, FailCount= 4 2021-12-02T00:40:30.305Z,1638405630.305 [WetLabsBB2FL](ERROR): Communications Fault 2021-12-02T00:40:30.804Z,1638405630.804 [WetLabsBB2FL](INFO): Powering down 2021-12-02T00:40:58.799Z,1638405658.799 [SBIT](ERROR): Could not read elevatorAngleReader_. 2021-12-02T00:40:58.800Z,1638405658.800 [SBIT](ERROR): Could not read rudderAngleReader_. 2021-12-02T00:40:58.800Z,1638405658.800 [SBIT](ERROR): Could not read massPosReader_. 2021-12-02T00:40:58.800Z,1638405658.800 [SBIT](FAULT): Control surface position failure. 2021-12-02T00:40:58.803Z,1638405658.803 [CBIT](ERROR): Communications Fault in component: RudderServo 2021-12-02T00:40:58.804Z,1638405658.804 [CBIT](CRITICAL): Communications Fault in component: RudderServo 2021-12-02T00:40:58.804Z,1638405658.804 [CBIT](INFO): Clearing failed state for component ThrusterServo 2021-12-02T00:40:58.804Z,1638405658.804 [ThrusterServo] No Fault, FailCount= 4 2021-12-02T00:40:58.805Z,1638405658.805 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2021-12-02T00:40:58.805Z,1638405658.805 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2021-12-02T00:40:58.805Z,1638405658.805 [WetLabsBB2FL] No Fault, FailCount= 4 2021-12-02T00:40:58.996Z,1638405658.996 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-12-02T00:40:58.996Z,1638405658.996 [AHRS_M2](FAULT): Failed to initialize within timeout. 2021-12-02T00:40:58.996Z,1638405658.996 [AHRS_M2] Communications Fault, FailCount= 4 2021-12-02T00:40:58.996Z,1638405658.996 [AHRS_M2](ERROR): Communications Fault 2021-12-02T00:40:59.000Z,1638405659.000 [DVL_micro](FAULT): Failed to initialize within timeout. 2021-12-02T00:40:59.000Z,1638405659.000 [DVL_micro] Communications Fault, FailCount= 2 2021-12-02T00:40:59.001Z,1638405659.001 [DVL_micro](ERROR): Communications Fault 2021-12-02T00:40:59.052Z,1638405659.052 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2021-12-02T00:40:59.052Z,1638405659.052 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1 2021-12-02T00:40:59.052Z,1638405659.052 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2021-12-02T00:40:59.085Z,1638405659.085 [WetLabsBB2FL](INFO): Powering up 2021-12-02T00:40:59.152Z,1638405659.152 [MassServo](DEBUG): Initializing EZServoServo. 2021-12-02T00:40:59.273Z,1638405659.273 [MassServo](DEBUG): Initializing MassServo. 2021-12-02T00:40:59.273Z,1638405659.273 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2021-12-02T00:40:59.273Z,1638405659.273 [RudderServo](INFO): Powering down 2021-12-02T00:40:59.274Z,1638405659.274 [ThrusterServo](DEBUG): Initializing EZServoServo. 2021-12-02T00:40:59.276Z,1638405659.276 [ThrusterServo](DEBUG): Initializing ThrusterServo. 2021-12-02T00:40:59.278Z,1638405659.278 [CBIT](INFO): Critical error at 20211202T004058 2021-12-02T00:40:59.281Z,1638405659.281 [CBIT](INFO): Clearing failed state for component MassServo 2021-12-02T00:40:59.281Z,1638405659.281 [MassServo] No Fault, FailCount= 2 2021-12-02T00:40:59.282Z,1638405659.282 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2021-12-02T00:40:59.282Z,1638405659.282 [CBIT](ERROR): Communications Fault in component: AHRS_M2 2021-12-02T00:40:59.282Z,1638405659.282 [CBIT](ERROR): Communications Fault in component: DVL_micro 2021-12-02T00:40:59.319Z,1638405659.319 [AHRS_M2](INFO): Powering down 2021-12-02T00:40:59.385Z,1638405659.385 [BPC1](ERROR): BPC1B buffer size (9E8 bytes) exceeded the max device response limit. 2021-12-02T00:40:59.385Z,1638405659.385 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2021-12-02T00:40:59.464Z,1638405659.464 [DVL_micro](INFO): Powering down 2021-12-02T00:40:59.501Z,1638405659.501 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2021-12-02T00:40:59.501Z,1638405659.501 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1 2021-12-02T00:40:59.709Z,1638405659.709 [BPC1](ERROR): BPC1A buffer size (AAC bytes) exceeded the max device response limit. 2021-12-02T00:40:59.710Z,1638405659.710 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2021-12-02T00:40:59.758Z,1638405659.758 [RudderServo](DEBUG): Initializing EZServoServo. 2021-12-02T00:40:59.873Z,1638405659.873 [RudderServo](DEBUG): Initializing RudderServo. 2021-12-02T00:41:00.200Z,1638405660.200 [ThrusterServo](ERROR): Thruster halt for initialization uart error serial timeout 2021-12-02T00:41:00.288Z,1638405660.288 [ThrusterServo](ERROR): Thruster initialization uart error serial timeout 2021-12-02T00:41:00.288Z,1638405660.288 [ThrusterServo](FAULT): Thruster failed to initialize 2021-12-02T00:41:00.288Z,1638405660.288 [ThrusterServo] Communications Fault, FailCount= 5 2021-12-02T00:41:00.288Z,1638405660.288 [ThrusterServo](ERROR): Communications Fault 2021-12-02T00:41:00.293Z,1638405660.293 [CBIT](ERROR): Communications Fault in component: ThrusterServo 2021-12-02T00:41:00.293Z,1638405660.293 [CBIT](CRITICAL): Communications Fault in component: ThrusterServo 2021-12-02T00:41:00.457Z,1638405660.457 [ThrusterServo](DEBUG): Uninitialize Thruster Servo. 2021-12-02T00:41:00.458Z,1638405660.458 [ThrusterServo](INFO): Powering down 2021-12-02T00:41:00.471Z,1638405660.471 [CBIT](INFO): Critical error at 20211202T004100 2021-12-02T00:41:00.482Z,1638405660.482 [CBIT](INFO): Clearing failed state for component AHRS_M2 2021-12-02T00:41:00.482Z,1638405660.482 [AHRS_M2] No Fault, FailCount= 4 2021-12-02T00:41:00.484Z,1638405660.484 [CBIT](INFO): Clearing failed state for component DVL_micro 2021-12-02T00:41:00.484Z,1638405660.484 [DVL_micro] No Fault, FailCount= 2 2021-12-02T00:41:00.806Z,1638405660.806 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2021-12-02T00:41:04.376Z,1638405664.376 [WetLabsBB2FL] Communications Fault, FailCount= 5 2021-12-02T00:41:04.376Z,1638405664.376 [WetLabsBB2FL](ERROR): Communications Fault 2021-12-02T00:41:04.876Z,1638405664.876 [WetLabsBB2FL](INFO): Powering down 2021-12-02T00:41:31.353Z,1638405691.353 [SBIT](ERROR): Could not read elevatorAngleReader_. 2021-12-02T00:41:31.353Z,1638405691.353 [SBIT](ERROR): Could not read rudderAngleReader_. 2021-12-02T00:41:31.354Z,1638405691.354 [SBIT](ERROR): Could not read massPosReader_. 2021-12-02T00:41:31.354Z,1638405691.354 [SBIT](FAULT): Control surface position failure. 2021-12-02T00:41:31.357Z,1638405691.357 [CBIT](INFO): Clearing failed state for component ThrusterServo 2021-12-02T00:41:31.357Z,1638405691.357 [ThrusterServo] No Fault, FailCount= 5 2021-12-02T00:41:31.358Z,1638405691.358 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2021-12-02T00:41:31.358Z,1638405691.358 [CBIT](FAULT): Communications Fault in component: WetLabsBB2FL 2021-12-02T00:41:31.800Z,1638405691.800 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2021-12-02T00:41:31.800Z,1638405691.800 [AHRS_M2](FAULT): Failed to initialize within timeout. 2021-12-02T00:41:31.800Z,1638405691.800 [AHRS_M2] Communications Fault, FailCount= 5 2021-12-02T00:41:31.800Z,1638405691.800 [AHRS_M2](ERROR): Communications Fault 2021-12-02T00:41:31.942Z,1638405691.942 [ThrusterServo](DEBUG): Initializing EZServoServo. 2021-12-02T00:41:31.948Z,1638405691.948 [ThrusterServo](DEBUG): Initializing ThrusterServo. 2021-12-02T00:41:31.949Z,1638405691.949 [SBIT](CRITICAL): SBIT FAILED 2021-12-02T00:41:31.949Z,1638405691.949 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg 2021-12-02T00:41:31.950Z,1638405691.950 [SBIT](IMPORTANT): No configSet variables persisted 2021-12-02T00:41:31.951Z,1638405691.951 [CBIT](INFO): Critical error at 20211202T004131 2021-12-02T00:41:31.954Z,1638405691.954 [CBIT](ERROR): Communications Fault in component: AHRS_M2 2021-12-02T00:41:31.954Z,1638405691.954 [CBIT](CRITICAL): Communications Fault in component: AHRS_M2 2021-12-02T00:41:31.978Z,1638405691.978 [AHRS_M2](INFO): Powering down 2021-12-02T00:41:32.050Z,1638405692.050 [BPC1](ERROR): BPC1B buffer size (9E8 bytes) exceeded the max device response limit. 2021-12-02T00:41:32.050Z,1638405692.050 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2021-12-02T00:41:32.089Z,1638405692.089 [MissionManager](IMPORTANT): Started mission Startup 2021-12-02T00:41:32.089Z,1638405692.089 [Startup] Running Loop=1 2021-12-02T00:41:32.089Z,1638405692.089 [Startup](DEBUG): Aggregate::initialize Startup 2021-12-02T00:41:32.089Z,1638405692.089 [Startup:A.GoToSurface] Running Loop=1 2021-12-02T00:41:32.089Z,1638405692.089 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2021-12-02T00:41:32.090Z,1638405692.090 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2021-12-02T00:41:32.090Z,1638405692.090 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2021-12-02T00:41:32.091Z,1638405692.091 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2021-12-02T00:41:32.091Z,1638405692.091 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2021-12-02T00:41:32.109Z,1638405692.109 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2021-12-02T00:41:32.110Z,1638405692.110 [Startup:StartupSatComms] Running Loop=1 2021-12-02T00:41:32.111Z,1638405692.111 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms 2021-12-02T00:41:32.111Z,1638405692.111 [Startup:StartupSatComms:A] Running Loop=1 2021-12-02T00:41:32.190Z,1638405692.190 [CBIT](INFO): Critical error at 20211202T004131 2021-12-02T00:41:32.440Z,1638405692.440 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix 2021-12-02T00:41:32.788Z,1638405692.788 [ThrusterServo](ERROR): Thruster halt for initialization uart error serial timeout 2021-12-02T00:41:32.880Z,1638405692.880 [ThrusterServo](ERROR): Thruster initialization uart error serial timeout 2021-12-02T00:41:32.880Z,1638405692.880 [ThrusterServo](FAULT): Thruster failed to initialize 2021-12-02T00:41:32.880Z,1638405692.880 [ThrusterServo] Communications Fault, FailCount= 1 2021-12-02T00:41:32.880Z,1638405692.880 [ThrusterServo](ERROR): Communications Fault 2021-12-02T00:41:32.884Z,1638405692.884 [CBIT](ERROR): Communications Fault in component: ThrusterServo 2021-12-02T00:41:33.372Z,1638405693.372 [MassServo](ERROR): isCommunicating uart error serial timeout 2021-12-02T00:41:33.372Z,1638405693.372 [MassServo](FAULT): Invalid EZ Servo response:"" 2021-12-02T00:41:33.372Z,1638405693.372 [MassServo] Communications Fault, FailCount= 3 2021-12-02T00:41:33.372Z,1638405693.372 [MassServo](ERROR): Communications Fault 2021-12-02T00:41:33.372Z,1638405693.372 [MassServo](FAULT): Mass Shifter error waiting for homing. Uart error: serial timeout 2021-12-02T00:41:33.373Z,1638405693.373 [MassServo] Hardware Fault, FailCount= 3 2021-12-02T00:41:33.373Z,1638405693.373 [MassServo](ERROR): Hardware Fault 2021-12-02T00:41:33.444Z,1638405693.444 [MassServo](ERROR): getPosition uart error serial timeout 2021-12-02T00:41:33.445Z,1638405693.445 [MassServo](FAULT): Invalid EZ Servo response:"\n" 2021-12-02T00:41:33.445Z,1638405693.445 [MassServo] Communications Fault, FailCount= 3 2021-12-02T00:41:33.445Z,1638405693.445 [MassServo](ERROR): Communications Fault 2021-12-02T00:41:33.445Z,1638405693.445 [ThrusterServo](DEBUG): Uninitialize Thruster Servo. 2021-12-02T00:41:33.446Z,1638405693.446 [ThrusterServo](INFO): Powering down 2021-12-02T00:41:33.450Z,1638405693.450 [CBIT](ERROR): Communications Fault in component: MassServo 2021-12-02T00:41:33.516Z,1638405693.516 [MassServo](DEBUG): Uninitialize Mass Servo. 2021-12-02T00:41:33.516Z,1638405693.516 [MassServo](INFO): Powering down 2021-12-02T00:42:04.254Z,1638405724.254 [CBIT](INFO): Clearing failed state for component ThrusterServo 2021-12-02T00:42:04.255Z,1638405724.255 [ThrusterServo] No Fault, FailCount= 1 2021-12-02T00:42:04.347Z,1638405724.347 [DVL_micro](FAULT): Failed to initialize within timeout. 2021-12-02T00:42:04.347Z,1638405724.347 [DVL_micro] Communications Fault, FailCount= 3 2021-12-02T00:42:04.347Z,1638405724.347 [DVL_micro](ERROR): Communications Fault 2021-12-02T00:42:04.397Z,1638405724.397 [MassServo](DEBUG): Initializing EZServoServo. 2021-12-02T00:42:04.513Z,1638405724.513 [MassServo](DEBUG): Initializing MassServo. 2021-12-02T00:42:04.514Z,1638405724.514 [ThrusterServo](DEBUG): Initializing EZServoServo. 2021-12-02T00:42:04.515Z,1638405724.515 [ThrusterServo](DEBUG): Initializing ThrusterServo. 2021-12-02T00:42:04.519Z,1638405724.519 [CBIT](INFO): Clearing failed state for component MassServo 2021-12-02T00:42:04.519Z,1638405724.519 [MassServo] No Fault, FailCount= 3 2021-12-02T00:42:04.520Z,1638405724.520 [CBIT](ERROR): Communications Fault in component: DVL_micro 2021-12-02T00:42:04.521Z,1638405724.521 [CBIT](CRITICAL): Communications Fault in component: DVL_micro 2021-12-02T00:42:04.828Z,1638405724.828 [DVL_micro](INFO): Powering down 2021-12-02T00:42:04.860Z,1638405724.860 [CBIT](INFO): Critical error at 20211202T004204 2021-12-02T00:42:05.157Z,1638405725.157 [BPC1](ERROR): BPC1B buffer size (9E8 bytes) exceeded the max device response limit. 2021-12-02T00:42:05.158Z,1638405725.158 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2021-12-02T00:42:05.296Z,1638405725.296 [ThrusterServo](ERROR): Thruster halt for initialization uart error serial timeout 2021-12-02T00:42:05.616Z,1638405725.616 [ThrusterServo](ERROR): Thruster initialization uart error serial timeout 2021-12-02T00:42:05.616Z,1638405725.616 [ThrusterServo](FAULT): Thruster failed to initialize 2021-12-02T00:42:05.616Z,1638405725.616 [ThrusterServo] Communications Fault, FailCount= 2 2021-12-02T00:42:05.616Z,1638405725.616 [ThrusterServo](ERROR): Communications Fault 2021-12-02T00:42:05.620Z,1638405725.620 [CBIT](ERROR): Communications Fault in component: ThrusterServo 2021-12-02T00:42:05.777Z,1638405725.777 [ThrusterServo](DEBUG): Uninitialize Thruster Servo. 2021-12-02T00:42:05.777Z,1638405725.777 [ThrusterServo