2022-08-09T20:42:25.191Z,1660077745.191 [Supervisor](DEBUG): Initializing supervisor.
2022-08-09T20:42:25.195Z,1660077745.195 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2022-08-09T20:42:25.196Z,1660077745.196 [SyncHandler](INFO): Protected caller Thread ID is 746
2022-08-09T20:42:25.196Z,1660077745.196 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2022-08-09T20:42:25.197Z,1660077745.197 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2022-08-09T20:42:25.198Z,1660077745.198 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 747
2022-08-09T20:42:25.202Z,1660077745.202 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2022-08-09T20:42:25.219Z,1660077745.219 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread.
2022-08-09T20:42:25.219Z,1660077745.219 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2022-08-09T20:42:25.220Z,1660077745.220 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 748
2022-08-09T20:42:25.224Z,1660077745.224 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2022-08-09T20:42:25.225Z,1660077745.225 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2022-08-09T20:42:25.225Z,1660077745.225 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 749
2022-08-09T20:42:25.227Z,1660077745.227 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2022-08-09T20:42:25.228Z,1660077745.228 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0
2022-08-09T20:42:25.229Z,1660077745.229 [logger ThreadHandler](INFO): Protected caller Thread ID is 750
2022-08-09T20:42:25.232Z,1660077745.232 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2022-08-09T20:42:25.232Z,1660077745.232 [Supervisor](INFO): Looking for Config files in directory: Config/
2022-08-09T20:42:25.236Z,1660077745.236 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2022-08-09T20:42:25.713Z,1660077745.713 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2022-08-09T20:42:25.714Z,1660077745.714 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2022-08-09T20:42:25.927Z,1660077745.927 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2022-08-09T20:42:25.929Z,1660077745.929 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2022-08-09T20:42:26.011Z,1660077746.011 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg
2022-08-09T20:42:26.229Z,1660077746.229 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock
2022-08-09T20:42:26.230Z,1660077746.230 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2022-08-09T20:42:26.311Z,1660077746.311 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2022-08-09T20:42:26.409Z,1660077746.409 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2022-08-09T20:42:26.410Z,1660077746.410 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2022-08-09T20:42:26.740Z,1660077746.740 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2022-08-09T20:42:26.740Z,1660077746.740 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2022-08-09T20:42:26.881Z,1660077746.881 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2022-08-09T20:42:26.882Z,1660077746.882 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2022-08-09T20:42:27.380Z,1660077747.380 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2022-08-09T20:42:27.382Z,1660077747.382 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2022-08-09T20:42:27.562Z,1660077747.562 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2022-08-09T20:42:27.564Z,1660077747.564 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2022-08-09T20:42:27.925Z,1660077747.925 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2022-08-09T20:42:27.926Z,1660077747.926 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2022-08-09T20:42:28.196Z,1660077748.196 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2022-08-09T20:42:28.198Z,1660077748.198 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2022-08-09T20:42:28.308Z,1660077748.308 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2022-08-09T20:42:28.310Z,1660077748.310 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2022-08-09T20:42:28.997Z,1660077748.997 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2022-08-09T20:42:28.998Z,1660077748.998 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2022-08-09T20:42:29.322Z,1660077749.322 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2022-08-09T20:42:29.323Z,1660077749.323 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2022-08-09T20:42:29.543Z,1660077749.543 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2022-08-09T20:42:29.545Z,1660077749.545 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-triton/
2022-08-09T20:42:29.547Z,1660077749.547 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/vehicle.cfg
2022-08-09T20:42:29.737Z,1660077749.737 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/secure.cfg
2022-08-09T20:42:29.822Z,1660077749.822 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Science.cfg
2022-08-09T20:42:29.960Z,1660077749.960 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Simulator.cfg
2022-08-09T20:42:30.048Z,1660077750.048 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Battery.cfg
2022-08-09T20:42:30.308Z,1660077750.308 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2022-08-09T20:42:30.309Z,1660077750.309 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/logger.cfg
2022-08-09T20:42:30.412Z,1660077750.412 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Servo.cfg
2022-08-09T20:42:30.522Z,1660077750.522 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Navigation.cfg
2022-08-09T20:42:30.630Z,1660077750.630 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Sensor.cfg
2022-08-09T20:42:30.800Z,1660077750.800 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Control.cfg
2022-08-09T20:42:31.576Z,1660077751.576 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/BIT.cfg
2022-08-09T20:42:31.845Z,1660077751.845 [Supervisor](FAULT): Ignoring configuration overrides from Data/persisted.cfg
2022-08-09T20:42:31.848Z,1660077751.848 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2022-08-09T20:42:31.858Z,1660077751.858 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2022-08-09T20:42:31.859Z,1660077751.859 [Module Loader](DEBUG): Loading Module at Modules/Dock.so
2022-08-09T20:42:31.949Z,1660077751.949 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking)
2022-08-09T20:42:31.949Z,1660077751.949 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2022-08-09T20:42:31.997Z,1660077751.997 [VerticalControl](DEBUG): Construct VerticalControl.
2022-08-09T20:42:32.054Z,1660077752.054 [VerticalControl] Loaded
2022-08-09T20:42:32.054Z,1660077752.054 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2022-08-09T20:42:32.057Z,1660077752.057 [HorizontalControl](DEBUG): Construct HorizontalControl.
2022-08-09T20:42:32.097Z,1660077752.097 [HorizontalControl] Loaded
2022-08-09T20:42:32.097Z,1660077752.097 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2022-08-09T20:42:32.100Z,1660077752.100 [SpeedControl](DEBUG): Construct SpeedControl.
2022-08-09T20:42:32.103Z,1660077752.103 [SpeedControl] Loaded
2022-08-09T20:42:32.103Z,1660077752.103 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2022-08-09T20:42:32.105Z,1660077752.105 [LoopControl](DEBUG): Construct LoopControl.
2022-08-09T20:42:32.106Z,1660077752.106 [LoopControl] Loaded
2022-08-09T20:42:32.106Z,1660077752.106 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2022-08-09T20:42:32.107Z,1660077752.107 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2022-08-09T20:42:32.107Z,1660077752.107 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2022-08-09T20:42:32.228Z,1660077752.228 [BuoyancyServo] Loaded
2022-08-09T20:42:32.228Z,1660077752.228 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2022-08-09T20:42:32.248Z,1660077752.248 [ElevatorServo] Loaded
2022-08-09T20:42:32.248Z,1660077752.248 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2022-08-09T20:42:32.266Z,1660077752.266 [MassServo] Loaded
2022-08-09T20:42:32.266Z,1660077752.266 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2022-08-09T20:42:32.284Z,1660077752.284 [RudderServo] Loaded
2022-08-09T20:42:32.284Z,1660077752.284 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2022-08-09T20:42:32.299Z,1660077752.299 [ThrusterHE] Loaded
2022-08-09T20:42:32.299Z,1660077752.299 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread.
2022-08-09T20:42:32.299Z,1660077752.299 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2022-08-09T20:42:32.300Z,1660077752.300 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2022-08-09T20:42:32.349Z,1660077752.349 [DepthRateCalculator] Loaded
2022-08-09T20:42:32.349Z,1660077752.349 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2022-08-09T20:42:32.354Z,1660077752.354 [PitchRateCalculator] Loaded
2022-08-09T20:42:32.354Z,1660077752.354 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2022-08-09T20:42:32.363Z,1660077752.363 [SpeedCalculator] Loaded
2022-08-09T20:42:32.364Z,1660077752.364 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2022-08-09T20:42:32.368Z,1660077752.368 [YawRateCalculator] Loaded
2022-08-09T20:42:32.368Z,1660077752.368 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2022-08-09T20:42:32.386Z,1660077752.386 [ElevatorOffsetCalculator] Loaded
2022-08-09T20:42:32.386Z,1660077752.386 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2022-08-09T20:42:32.386Z,1660077752.386 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2022-08-09T20:42:32.387Z,1660077752.387 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2022-08-09T20:42:32.498Z,1660077752.498 [DeadReckonUsingMultipleVelocitySources] Loaded
2022-08-09T20:42:32.498Z,1660077752.498 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2022-08-09T20:42:32.512Z,1660077752.512 [NavChart] Loaded
2022-08-09T20:42:32.512Z,1660077752.512 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2022-08-09T20:42:32.517Z,1660077752.517 [UniversalFixResidualReporter] Loaded
2022-08-09T20:42:32.517Z,1660077752.517 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2022-08-09T20:42:32.518Z,1660077752.518 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2022-08-09T20:42:32.518Z,1660077752.518 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2022-08-09T20:42:32.895Z,1660077752.895 [AHRS_M2] Loaded
2022-08-09T20:42:32.895Z,1660077752.895 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread.
2022-08-09T20:42:32.930Z,1660077752.930 [BackseatComponent] Loaded
2022-08-09T20:42:32.930Z,1660077752.930 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread.
2022-08-09T20:42:32.934Z,1660077752.934 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 408D04E0
2022-08-09T20:42:32.934Z,1660077752.934 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 843
2022-08-09T20:42:32.937Z,1660077752.937 [LcmUniversalReporter] Loaded
2022-08-09T20:42:32.937Z,1660077752.937 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread.
2022-08-09T20:42:33.727Z,1660077753.727 [BPC1] Loaded
2022-08-09T20:42:33.728Z,1660077753.728 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2022-08-09T20:42:33.799Z,1660077753.799 [DataOverHttps] Loaded
2022-08-09T20:42:33.799Z,1660077753.799 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2022-08-09T20:42:33.800Z,1660077753.800 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 409004E0
2022-08-09T20:42:33.800Z,1660077753.800 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 844
2022-08-09T20:42:33.820Z,1660077753.820 [Depth_Keller] Loaded
2022-08-09T20:42:33.821Z,1660077753.821 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2022-08-09T20:42:33.825Z,1660077753.825 [DropWeight] Loaded
2022-08-09T20:42:33.826Z,1660077753.826 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2022-08-09T20:42:33.886Z,1660077753.886 [NAL9602] Loaded
2022-08-09T20:42:33.887Z,1660077753.887 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2022-08-09T20:42:33.916Z,1660077753.916 [Onboard] Loaded
2022-08-09T20:42:33.916Z,1660077753.916 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread.
2022-08-09T20:42:33.917Z,1660077753.917 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 409304E0
2022-08-09T20:42:33.917Z,1660077753.917 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 845
2022-08-09T20:42:33.929Z,1660077753.929 [Power24vConverter] Loaded
2022-08-09T20:42:33.929Z,1660077753.929 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread.
2022-08-09T20:42:33.945Z,1660077753.945 [Radio_Surface] Loaded
2022-08-09T20:42:33.945Z,1660077753.945 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2022-08-09T20:42:33.946Z,1660077753.946 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 409604E0
2022-08-09T20:42:33.947Z,1660077753.947 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 846
2022-08-09T20:42:34.037Z,1660077754.037 [DAT] Loaded
2022-08-09T20:42:34.038Z,1660077754.038 [ComponentRegistry](DEBUG): Component "DAT" handled in its own thread.
2022-08-09T20:42:34.039Z,1660077754.039 [DAT ThreadHandler](DEBUG): Created PCaller Thread at 409904E0
2022-08-09T20:42:34.039Z,1660077754.039 [DAT ThreadHandler](INFO): Protected caller Thread ID is 847
2022-08-09T20:42:34.040Z,1660077754.040 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2022-08-09T20:42:34.040Z,1660077754.040 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2022-08-09T20:42:34.103Z,1660077754.103 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2022-08-09T20:42:34.104Z,1660077754.104 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2022-08-09T20:42:34.243Z,1660077754.243 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2022-08-09T20:42:34.243Z,1660077754.243 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2022-08-09T20:42:34.270Z,1660077754.270 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2022-08-09T20:42:34.271Z,1660077754.271 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2022-08-09T20:42:34.437Z,1660077754.437 [CTD_Seabird] Loaded
2022-08-09T20:42:34.437Z,1660077754.437 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread.
2022-08-09T20:42:34.438Z,1660077754.438 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40ABB4E0
2022-08-09T20:42:34.438Z,1660077754.438 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 848
2022-08-09T20:42:34.459Z,1660077754.459 [PAR_Licor] Loaded
2022-08-09T20:42:34.459Z,1660077754.459 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2022-08-09T20:42:34.489Z,1660077754.489 [WetLabsBB2FL] Loaded
2022-08-09T20:42:34.489Z,1660077754.489 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2022-08-09T20:42:34.490Z,1660077754.490 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40AEB4E0
2022-08-09T20:42:34.490Z,1660077754.490 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 849
2022-08-09T20:42:34.491Z,1660077754.491 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2022-08-09T20:42:34.492Z,1660077754.492 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2022-08-09T20:42:34.785Z,1660077754.785 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2022-08-09T20:42:34.786Z,1660077754.786 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2022-08-09T20:42:34.922Z,1660077754.922 [SBIT](DEBUG): Construct Startup Built In Test.
2022-08-09T20:42:34.931Z,1660077754.931 [SBIT] Loaded
2022-08-09T20:42:34.931Z,1660077754.931 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2022-08-09T20:42:34.934Z,1660077754.934 [IBIT](DEBUG): Construct Initiated Built In Test.
2022-08-09T20:42:34.947Z,1660077754.947 [IBIT] Loaded
2022-08-09T20:42:34.947Z,1660077754.947 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2022-08-09T20:42:34.952Z,1660077754.952 [CBIT](DEBUG): Construct Continuous Built In Test.
2022-08-09T20:42:35.055Z,1660077755.055 [CBIT] Loaded
2022-08-09T20:42:35.055Z,1660077755.055 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2022-08-09T20:42:35.055Z,1660077755.055 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2022-08-09T20:42:35.061Z,1660077755.061 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2022-08-09T20:42:35.064Z,1660077755.064 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2022-08-09T20:42:35.075Z,1660077755.075 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2022-08-09T20:42:35.077Z,1660077755.077 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40BCE4E0
2022-08-09T20:42:35.077Z,1660077755.077 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 850
2022-08-09T20:42:35.081Z,1660077755.081 [Supervisor](INFO): Main Thread ID is 745
2022-08-09T20:42:35.081Z,1660077755.081 [Supervisor](DEBUG): Running supervisor.
2022-08-09T20:42:35.082Z,1660077755.082 [CommandExec ThreadHandler](INFO): Handler Thread ID is 851
2022-08-09T20:42:35.083Z,1660077755.083 [CommandExec](INFO): Initializing the command executive.
2022-08-09T20:42:35.084Z,1660077755.084 [CommandLine ThreadHandler](INFO): Handler Thread ID is 852
2022-08-09T20:42:35.086Z,1660077755.086 [controlThread ThreadHandler](INFO): Handler Thread ID is 853
2022-08-09T20:42:35.087Z,1660077755.087 [controlThread](DEBUG): Initializing ControlThread
2022-08-09T20:42:35.087Z,1660077755.087 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2022-08-09T20:42:35.089Z,1660077755.089 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2022-08-09T20:42:35.090Z,1660077755.090 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2022-08-09T20:42:35.090Z,1660077755.090 [LoopControl](DEBUG): Initialize LoopControlComponent.
2022-08-09T20:42:35.091Z,1660077755.091 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2022-08-09T20:42:35.092Z,1660077755.092 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2022-08-09T20:42:35.092Z,1660077755.092 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2022-08-09T20:42:35.092Z,1660077755.092 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2022-08-09T20:42:35.092Z,1660077755.092 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2022-08-09T20:42:35.094Z,1660077755.094 [NavChart](DEBUG): Initialize NavChart Navigation.
2022-08-09T20:42:35.094Z,1660077755.094 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2022-08-09T20:42:35.103Z,1660077755.103 [SBIT](INFO): Initialize SBIT Component.
2022-08-09T20:42:35.103Z,1660077755.103 [SBIT](IMPORTANT): git: 2022-08-02
2022-08-09T20:42:35.103Z,1660077755.103 [SBIT](INFO): git hash: f84e5919489b70ff94ab72b61eefa777bac519a0
2022-08-09T20:42:35.103Z,1660077755.103 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2022-08-09T20:42:35.104Z,1660077755.104 [SBIT](INFO): Kernel Reporting Different Version From Configuration.
Kernel Expected: #1 PREEMPT Tue Dec 18 21:19:28 PST 2018
Kernel Reported: #1 PREEMPT Wed Mar 17 08:23:48 PDT 2021
2022-08-09T20:42:35.106Z,1660077755.106 [SBIT](INFO): Beginning SBIT in 90.000000 seconds.
2022-08-09T20:42:35.106Z,1660077755.106 [IBIT](INFO): Initialize IBIT Component.
2022-08-09T20:42:35.107Z,1660077755.107 [CBIT](DEBUG): Initialize CBIT Component.
2022-08-09T20:42:35.108Z,1660077755.108 [logger ThreadHandler](INFO): Handler Thread ID is 854
2022-08-09T20:42:35.118Z,1660077755.118 [CBIT](DEBUG): Initialized mux pins.
2022-08-09T20:42:35.118Z,1660077755.118 [CBIT](FAULT): LAST RESTART WAS UNINTENTIONAL.
2022-08-09T20:42:35.118Z,1660077755.118 [CBIT](DEBUG): Initializing the watchdog timer.
2022-08-09T20:42:35.127Z,1660077755.127 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 855
2022-08-09T20:42:35.139Z,1660077755.139 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 856
2022-08-09T20:42:35.140Z,1660077755.140 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2022-08-09T20:42:35.142Z,1660077755.142 [CBIT](CRITICAL): Watchdog Timer failed to initialize.
2022-08-09T20:42:35.142Z,1660077755.142 [CBIT] Hardware Fault, FailCount= 1
2022-08-09T20:42:35.142Z,1660077755.142 [CBIT](ERROR): Hardware Fault
2022-08-09T20:42:35.143Z,1660077755.143 [CBIT](DEBUG): Initializing heartbeat.
2022-08-09T20:42:35.151Z,1660077755.151 [Onboard ThreadHandler](INFO): Handler Thread ID is 857
2022-08-09T20:42:35.168Z,1660077755.168 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 858
2022-08-09T20:42:35.191Z,1660077755.191 [DAT ThreadHandler](INFO): Handler Thread ID is 859
2022-08-09T20:42:35.191Z,1660077755.191 [DAT](INFO): Powering up
2022-08-09T20:42:35.192Z,1660077755.192 [DAT](DEBUG): Initializing DAT.
2022-08-09T20:42:35.196Z,1660077755.196 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 861
2022-08-09T20:42:35.196Z,1660077755.196 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2022-08-09T20:42:35.199Z,1660077755.199 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 863
2022-08-09T20:42:35.203Z,1660077755.203 [WetLabsBB2FL](INFO): Powering up
2022-08-09T20:42:35.204Z,1660077755.204 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 865
2022-08-09T20:42:35.212Z,1660077755.212 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2MI01M.000
2022-08-09T20:42:35.212Z,1660077755.212 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2MI01M.000
2022-08-09T20:42:35.212Z,1660077755.212 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2MI80M.000
2022-08-09T20:42:35.213Z,1660077755.213 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2MI80M.000
2022-08-09T20:42:35.213Z,1660077755.213 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4MI57M.000
2022-08-09T20:42:35.213Z,1660077755.213 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4MI57M.000
2022-08-09T20:42:35.213Z,1660077755.213 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4MI56M.000
2022-08-09T20:42:35.213Z,1660077755.213 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4MI56M.000
2022-08-09T20:42:35.213Z,1660077755.213 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4MI90M.000
2022-08-09T20:42:35.213Z,1660077755.213 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4MI90M.000
2022-08-09T20:42:35.214Z,1660077755.214 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4MI89M.000
2022-08-09T20:42:35.214Z,1660077755.214 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4MI89M.000
2022-08-09T20:42:35.214Z,1660077755.214 [CBIT](DEBUG): Deactivating GF circuits.
2022-08-09T20:42:35.214Z,1660077755.214 [CBIT](DEBUG): Deactivating emergency mode.
2022-08-09T20:42:35.215Z,1660077755.215 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2MI79M.000
2022-08-09T20:42:35.215Z,1660077755.215 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2MI79M.000
2022-08-09T20:42:35.215Z,1660077755.215 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4MN1DD.000
2022-08-09T20:42:35.215Z,1660077755.215 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4MN1DD.000
2022-08-09T20:42:35.215Z,1660077755.215 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4MN1DE.000
2022-08-09T20:42:35.216Z,1660077755.216 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4MN1DE.000
2022-08-09T20:42:35.216Z,1660077755.216 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4MN1DF.000
2022-08-09T20:42:35.216Z,1660077755.216 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4MN1DF.000
2022-08-09T20:42:35.216Z,1660077755.216 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4MN1DG.000
2022-08-09T20:42:35.216Z,1660077755.216 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4MN1DG.000
2022-08-09T20:42:35.216Z,1660077755.216 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4MN1DH.000
2022-08-09T20:42:35.217Z,1660077755.217 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4MN1DH.000
2022-08-09T20:42:35.217Z,1660077755.217 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4MN1CC.000
2022-08-09T20:42:35.217Z,1660077755.217 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4MN1CC.000
2022-08-09T20:42:35.217Z,1660077755.217 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4MN1CD.000
2022-08-09T20:42:35.217Z,1660077755.217 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4MN1CD.000
2022-08-09T20:42:35.217Z,1660077755.217 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4MN1CE.000
2022-08-09T20:42:35.218Z,1660077755.218 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4MN1CE.000
2022-08-09T20:42:35.218Z,1660077755.218 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4WI1QE.000
2022-08-09T20:42:35.218Z,1660077755.218 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4WI1QE.000
2022-08-09T20:42:35.219Z,1660077755.219 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4WI1QF.000
2022-08-09T20:42:35.219Z,1660077755.219 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4WI1QF.000
2022-08-09T20:42:35.219Z,1660077755.219 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4WI1QG.000
2022-08-09T20:42:35.219Z,1660077755.219 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4WI1QG.000
2022-08-09T20:42:35.219Z,1660077755.219 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4WI1PB.000
2022-08-09T20:42:35.219Z,1660077755.219 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4WI1PB.000
2022-08-09T20:42:35.220Z,1660077755.220 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4WI1PC.000
2022-08-09T20:42:35.220Z,1660077755.220 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4WI1PC.000
2022-08-09T20:42:35.220Z,1660077755.220 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4WI1PD.000
2022-08-09T20:42:35.220Z,1660077755.220 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4WI1PD.000
2022-08-09T20:42:35.220Z,1660077755.220 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4WI1PE.000
2022-08-09T20:42:35.220Z,1660077755.220 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4WI1PE.000
2022-08-09T20:42:35.221Z,1660077755.221 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4WI1PF.000
2022-08-09T20:42:35.221Z,1660077755.221 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4WI1PF.000
2022-08-09T20:42:35.221Z,1660077755.221 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4WI1PG.000
2022-08-09T20:42:35.221Z,1660077755.221 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4WI1PG.000
2022-08-09T20:42:35.221Z,1660077755.221 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5WI22M.000
2022-08-09T20:42:35.222Z,1660077755.222 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5WI22M.000
2022-08-09T20:42:35.250Z,1660077755.250 [CBIT](DEBUG): Backplane powered.
2022-08-09T20:42:35.251Z,1660077755.251 [MissionManager](INFO): Loading Mission from file: Missions/Startup.xml
2022-08-09T20:42:35.265Z,1660077755.265 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2022-08-09T20:42:35.301Z,1660077755.301 [MissionManager](DEBUG): 
<?xml version="1.0" encoding="UTF-8"?>
<Mission xmlns="Tethys"
       xmlns:Control="Tethys/Control"
       xmlns:Guidance="Tethys/Guidance" 
       xmlns:Units="Tethys/Units"
       xmlns:Universal="Tethys/Universal"
       xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"
       xsi:schemaLocation="Tethys http://okeanids.mbari.org/tethys/Xml/Tethys.xsd
                           Tethys/Control http://okeanids.mbari.org/tethys/Xml/Control.xsd
                           Tethys/Guidance http://okeanids.mbari.org/tethys/Xml/Guidance.xsd
                           Tethys/Units http://okeanids.mbari.org/tethys/Xml/Units.xsd
                           Tethys/Universal http://okeanids.mbari.org/tethys/Xml/Universal.xsd"
       Id="Startup">

    <Guidance:GoToSurface>
        <Progression/>
    </Guidance:GoToSurface>

    <Aggregate Id="StartupSatComms">

        <Sequence/>

        <ReadDatum>
            <Timeout Duration="P1M" />
            <Universal:latitude_fix/>
        </ReadDatum>

        <ReadDatum>
            <Timeout Duration="P1M" />
            <Universal:platform_communications/>
        </ReadDatum>

    </Aggregate>

</Mission>


2022-08-09T20:42:35.301Z,1660077755.301 [MissionManager](INFO): Loading Mission from file: Missions/Default.xml
2022-08-09T20:42:35.375Z,1660077755.375 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2022-08-09T20:42:35.376Z,1660077755.376 [Default:A.Wait](DEBUG): Construct Wait.
2022-08-09T20:42:35.390Z,1660077755.390 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2022-08-09T20:42:35.421Z,1660077755.421 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2022-08-09T20:42:35.440Z,1660077755.440 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2022-08-09T20:42:35.450Z,1660077755.450 [Default:E.Execute](DEBUG): Construct Execute.
2022-08-09T20:42:35.459Z,1660077755.459 [MissionManager](DEBUG): 
<?xml version="1.0" encoding="UTF-8"?>
<Mission xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"
         xmlns="Tethys"
         xmlns:Units="Tethys/Units"
         xmlns:Guidance="Tethys/Guidance"
         xmlns:Universal="Tethys/Universal"
         xsi:schemaLocation="Tethys http://okeanids.mbari.org/tethys/Xml/Tethys.xsd
                             Tethys/Units http://okeanids.mbari.org/tethys/Xml/Units.xsd
                             Tethys/Guidance http://okeanids.mbari.org/tethys/Xml/Guidance.xsd
                             Tethys/Universal http://okeanids.mbari.org/tethys/Xml/Universal.xsd"
         Id="Default">

    <DefineArg Name="ElapsedSinceDefaultStarted"><Units:minute/><Value>0</Value></DefineArg>

    <Guidance:Wait>
        <Description>
            Wait a moment to see if the scheduler starts a new mission before
            starting to actually run Default.
        </Description>
        <Sequence/>
        <Setting><Guidance:Wait.duration/><Units:second/><Value>13</Value></Setting>
    </Guidance:Wait>

    <Guidance:GoToSurface>
        <Progression/>
    </Guidance:GoToSurface>

    <Aggregate Id="CheckIn">

        <Sequence Repeat="288"/>

        <ReadDatum Id="Read_GPS">
            <Timeout Duration="P5M"/>
            <Universal:time_fix/>
        </ReadDatum>

        <ReadDatum Id="Read_Iridium">
            <Timeout Duration="P4H">
                <Guidance:Execute>
                    <Sequence/>
                    <Setting><Guidance:Execute.command/><String>Burn on</String></Setting>
                </Guidance:Execute>
                <Syslog Severity="Critical">Dropped weight due to communications timeout.</Syslog>
            </Timeout>
            <Universal:platform_communications/>
        </ReadDatum>

        <Guidance:Wait>
            <Sequence/>
            <Setting><Guidance:Wait.duration/><Units:minute/><Value>5</Value></Setting>
        </Guidance:Wait>

        <Assign><Sequence/><Arg Name="ElapsedSinceDefaultStarted"/><Elapsed><Universal:mission_started/></Elapsed></Assign>

        <Syslog Severity="Important">Default mission has been running for <Arg Name="ElapsedSinceDefaultStarted"/><Units:minute/></Syslog>

    </Aggregate>

    <Syslog Severity="Important">Restarting logs and Default mission.</Syslog>

    <Guidance:Execute>
        <Sequence/>
        <Setting><Guidance:Execute.command/><String>restart logs</String></Setting>
    </Guidance:Execute>

</Mission>


2022-08-09T20:42:35.478Z,1660077755.478 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,DropWeight,NAL9602,Power24vConverter,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter,
2022-08-09T20:42:35.492Z,1660077755.492 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2022-08-09T20:42:35.565Z,1660077755.565 [Power24vConverter](INFO): Powering up.
2022-08-09T20:42:35.574Z,1660077755.574 [Radio_Surface](INFO): Powering up
2022-08-09T20:42:35.628Z,1660077755.628 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2022-08-09T20:42:35.636Z,1660077755.636 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2022-08-09T20:42:35.638Z,1660077755.638 [ElevatorServo](DEBUG): Initializing EZServoServo.
2022-08-09T20:42:35.647Z,1660077755.647 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2022-08-09T20:42:35.647Z,1660077755.647 [MassServo](DEBUG): Initializing EZServoServo.
2022-08-09T20:42:35.654Z,1660077755.654 [MassServo](DEBUG): Initializing MassServo.
2022-08-09T20:42:35.655Z,1660077755.655 [RudderServo](DEBUG): Initializing EZServoServo.
2022-08-09T20:42:35.670Z,1660077755.670 [RudderServo](DEBUG): Initializing RudderServo.
2022-08-09T20:42:35.671Z,1660077755.671 [ThrusterHE](DEBUG): Initializing EZServoServo.
2022-08-09T20:42:35.678Z,1660077755.678 [ThrusterHE](DEBUG): Initializing ThrusterHE.
2022-08-09T20:42:35.679Z,1660077755.679 [CBIT](DEBUG): Uninitialize CBIT Component.
2022-08-09T20:42:35.680Z,1660077755.680 [CBIT](DEBUG): Powering off loads.
2022-08-09T20:42:35.690Z,1660077755.690 [CBIT](DEBUG): Disabling WDT.
2022-08-09T20:42:35.702Z,1660077755.702 [CBIT](DEBUG): Opening all GF detection circuits.
2022-08-09T20:42:36.630Z,1660077756.630 [RudderServo](ERROR): Rudder initialization uart error serial timeout
2022-08-09T20:42:36.630Z,1660077756.630 [RudderServo](FAULT): Rudder failed to initialize
2022-08-09T20:42:36.630Z,1660077756.630 [RudderServo] Communications Fault, FailCount= 1
2022-08-09T20:42:36.630Z,1660077756.630 [RudderServo](ERROR): Communications Fault
2022-08-09T20:42:37.062Z,1660077757.062 [BuoyancyServo](ERROR): Buoyancy initialization uart error serial timeout
2022-08-09T20:42:37.062Z,1660077757.062 [BuoyancyServo](FAULT): Buoyancy failed to initialize
2022-08-09T20:42:37.062Z,1660077757.062 [BuoyancyServo] Communications Fault, FailCount= 1
2022-08-09T20:42:37.062Z,1660077757.062 [BuoyancyServo](ERROR): Communications Fault
2022-08-09T20:42:37.374Z,1660077757.374 [ElevatorServo](ERROR): Elevator initialization uart error I:serial timeout
2022-08-09T20:42:37.374Z,1660077757.374 [ElevatorServo](FAULT): Elevator failed to initialize
2022-08-09T20:42:37.374Z,1660077757.374 [ElevatorServo] Communications Fault, FailCount= 1
2022-08-09T20:42:37.375Z,1660077757.375 [ElevatorServo](ERROR): Communications Fault
2022-08-09T20:42:37.376Z,1660077757.376 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2022-08-09T20:42:37.376Z,1660077757.376 [RudderServo](INFO): Powering down
2022-08-09T20:42:37.450Z,1660077757.450 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2022-08-09T20:42:37.450Z,1660077757.450 [ElevatorServo](INFO): Powering down
2022-08-09T20:42:37.809Z,1660077757.809 [ElevatorServo](FAULT): LCB fault:  Current Limiter Activated.
2022-08-09T20:42:37.810Z,1660077757.810 [ElevatorServo] Hardware Fault, FailCount= 1
2022-08-09T20:42:37.810Z,1660077757.810 [ElevatorServo](ERROR): Hardware Fault
2022-08-09T20:42:37.811Z,1660077757.811 [RudderServo](DEBUG): Initializing EZServoServo.
2022-08-09T20:42:37.931Z,1660077757.931 [RudderServo](DEBUG): Initializing RudderServo.
2022-08-09T20:42:37.932Z,1660077757.932 [ThrusterHE](FAULT): Thruster failed to initialize
2022-08-09T20:42:37.932Z,1660077757.932 [ThrusterHE] Communications Fault, FailCount= 1
2022-08-09T20:42:37.932Z,1660077757.932 [ThrusterHE](ERROR): Communications Fault
2022-08-09T20:42:38.211Z,1660077758.211 [ElevatorServo](DEBUG): Initializing EZServoServo.
2022-08-09T20:42:38.331Z,1660077758.331 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2022-08-09T20:42:38.332Z,1660077758.332 [ThrusterHE](DEBUG): Uninitialize Thruster Servo.
2022-08-09T20:42:38.332Z,1660077758.332 [ThrusterHE](INFO): Powering down
2022-08-09T20:42:38.998Z,1660077758.998 [MassServo](FAULT): Mass shifter EEPROM initialization uart error serial timeout
2022-08-09T20:42:38.998Z,1660077758.998 [MassServo] Communications Fault, FailCount= 1
2022-08-09T20:42:38.998Z,1660077758.998 [MassServo](ERROR): Communications Fault
2022-08-09T20:42:39.092Z,1660077759.092 [MassServo](DEBUG): Uninitialize Mass Servo.
2022-08-09T20:42:39.092Z,1660077759.092 [MassServo](INFO): Powering down
2022-08-09T20:42:39.926Z,1660077759.926 [AHRS_M2](ERROR): Clear channel UART error: serial timeout
2022-08-09T20:42:39.977Z,1660077759.977 [MassServo](DEBUG): Initializing EZServoServo.
2022-08-09T20:42:40.095Z,1660077760.095 [MassServo](DEBUG): Initializing MassServo.
2022-08-09T20:42:40.494Z,1660077760.494 [WetLabsBB2FL] Communications Fault, FailCount= 1
2022-08-09T20:42:40.494Z,1660077760.494 [WetLabsBB2FL](ERROR): Communications Fault
2022-08-09T20:42:40.994Z,1660077760.994 [WetLabsBB2FL](INFO): Powering down
2022-08-09T20:42:41.399Z,1660077761.399 [WetLabsBB2FL](FAULT): LCB fault:  Hardware Overcurrent Shutdown. Current Limiter Activated.
2022-08-09T20:42:41.399Z,1660077761.399 [WetLabsBB2FL] Hardware Fault, FailCount= 1
2022-08-09T20:42:41.399Z,1660077761.399 [WetLabsBB2FL](ERROR): Hardware Fault
2022-08-09T20:42:41.926Z,1660077761.926 [AHRS_M2](ERROR): Subscribe Gyro UART error: serial timeout
2022-08-09T20:42:42.039Z,1660077762.039 [Radio_Surface](FAULT): LCB fault:  Hardware Overcurrent Shutdown. Current Limiter Activated.
2022-08-09T20:42:42.039Z,1660077762.039 [Radio_Surface] Hardware Fault, FailCount= 1
2022-08-09T20:42:42.039Z,1660077762.039 [Radio_Surface](ERROR): Hardware Fault
2022-08-09T20:42:42.442Z,1660077762.442 [Radio_Surface](INFO): Powering down
2022-08-09T20:42:42.847Z,1660077762.847 [Radio_Surface](FAULT): LCB fault:  Hardware Overcurrent Shutdown. Current Limiter Activated.
2022-08-09T20:42:43.546Z,1660077763.546 [AHRS_M2](ERROR): Subscribe MagBufferActiveIndex UART error: serial timeout
2022-08-09T20:42:48.246Z,1660077768.246 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2022-08-09T20:42:48.246Z,1660077768.246 [CTD_Seabird] Communications Fault, FailCount= 1
2022-08-09T20:42:48.246Z,1660077768.246 [CTD_Seabird](ERROR): Communications Fault
2022-08-09T20:42:48.651Z,1660077768.651 [CTD_Seabird](INFO): Powering down
2022-08-09T20:42:49.191Z,1660077769.191 [CTD_Seabird](FAULT): LCB fault:  Hardware Overcurrent Shutdown. Current Limiter Activated.
2022-08-09T20:42:49.191Z,1660077769.191 [CTD_Seabird] Hardware Fault, FailCount= 1
2022-08-09T20:42:49.191Z,1660077769.191 [CTD_Seabird](ERROR): Hardware Fault
2022-08-09T20:42:54.366Z,1660077774.366 [AHRS_M2](FAULT): Failed to acquire valid data within timeout.
2022-08-09T20:42:54.366Z,1660077774.366 [AHRS_M2] Data Fault, FailCount= 1
2022-08-09T20:42:54.366Z,1660077774.366 [AHRS_M2](ERROR): Data Fault
2022-08-09T20:42:54.759Z,1660077774.759 [AHRS_M2](INFO): Powering down
2022-08-09T20:43:04.056Z,1660077784.056 [NAL9602](INFO): Powering up NAL9602
2022-08-09T20:43:06.263Z,1660077786.263 [DataOverHttps](INFO): Radio surface powered OFF, will not connect.
2022-08-09T20:43:24.664Z,1660077804.664 [NAL9602](ERROR): NAL9602 initialization error.
2022-08-09T20:43:24.664Z,1660077804.664 [NAL9602] Communications Fault, FailCount= 1
2022-08-09T20:43:24.664Z,1660077804.664 [NAL9602](ERROR): Communications Fault
2022-08-09T20:43:25.065Z,1660077805.065 [NAL9602](INFO): Powering down
2022-08-09T20:43:35.438Z,1660077815.438 [DAT](FAULT): failed to initialize, no bytes available on serial interface
2022-08-09T20:43:35.439Z,1660077815.439 [DAT] Communications Fault, FailCount= 1
2022-08-09T20:43:35.439Z,1660077815.439 [DAT](ERROR): Communications Fault
2022-08-09T20:43:35.842Z,1660077815.842 [DAT](INFO): Powering down
2022-08-09T20:43:36.318Z,1660077816.318 [DAT](FAULT): LCB fault:  Hardware Overcurrent Shutdown. Current Limiter Activated.
2022-08-09T20:43:36.319Z,1660077816.319 [DAT] Hardware Fault, FailCount= 1
2022-08-09T20:43:36.319Z,1660077816.319 [DAT](ERROR): Hardware Fault
2022-08-09T20:43:49.302Z,1660077829.302 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file).
2022-08-09T20:44:02.633Z,1660077842.633 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file).
2022-08-09T20:44:05.882Z,1660077845.882 [SBIT](IMPORTANT): Beginning Startup BIT
2022-08-09T20:44:15.965Z,1660077855.965 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file).
2022-08-09T20:44:19.229Z,1660077859.229 [SBIT](ERROR): Could not read elevatorAngleReader_.
2022-08-09T20:44:19.230Z,1660077859.230 [SBIT](ERROR): Could not read rudderAngleReader_.
2022-08-09T20:44:19.230Z,1660077859.230 [SBIT](ERROR): Could not read massPosReader_.
2022-08-09T20:44:29.297Z,1660077869.297 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file).
2022-08-09T20:44:35.369Z,1660077875.369 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2022-08-09T20:44:35.369Z,1660077875.369 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2022-08-09T20:44:35.369Z,1660077875.369 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2022-08-09T20:44:42.629Z,1660077882.629 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file).
2022-08-09T20:44:45.877Z,1660077885.877 [SBIT](ERROR): Could not read elevatorAngleReader_.
2022-08-09T20:44:45.877Z,1660077885.877 [SBIT](ERROR): Could not read rudderAngleReader_.
2022-08-09T20:44:45.877Z,1660077885.877 [SBIT](ERROR): Could not read massPosReader_.
2022-08-09T20:44:45.877Z,1660077885.877 [SBIT](FAULT): Control surface position failure.
2022-08-09T20:44:55.961Z,1660077895.961 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file).
2022-08-09T20:44:59.613Z,1660077899.613 [SBIT](ERROR): Could not read elevatorAngleReader_.
2022-08-09T20:44:59.613Z,1660077899.613 [SBIT](ERROR): Could not read rudderAngleReader_.
2022-08-09T20:44:59.613Z,1660077899.613 [SBIT](ERROR): Could not read massPosReader_.
2022-08-09T20:44:59.614Z,1660077899.614 [SBIT](FAULT): Control surface position failure.
2022-08-09T20:45:00.009Z,1660077900.009 [SBIT](CRITICAL): SBIT FAILED
2022-08-09T20:45:00.010Z,1660077900.010 [SBIT](FAULT): Ignoring configuration overrides from Data/persisted.cfg
2022-08-09T20:45:00.410Z,1660077900.410 [MissionManager](IMPORTANT): Started mission Startup
2022-08-09T20:45:00.410Z,1660077900.410 [Startup] Running Loop=1
2022-08-09T20:45:00.411Z,1660077900.411 [Startup](DEBUG): Aggregate::initialize Startup
2022-08-09T20:45:00.411Z,1660077900.411 [Startup:A.GoToSurface] Running Loop=1
2022-08-09T20:45:00.411Z,1660077900.411 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2022-08-09T20:45:00.411Z,1660077900.411 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2022-08-09T20:45:00.412Z,1660077900.412 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2022-08-09T20:45:00.412Z,1660077900.412 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2022-08-09T20:45:00.412Z,1660077900.412 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2022-08-09T20:45:00.413Z,1660077900.413 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2022-08-09T20:45:00.414Z,1660077900.414 [Startup:StartupSatComms] Running Loop=1
2022-08-09T20:45:00.415Z,1660077900.415 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2022-08-09T20:45:00.415Z,1660077900.415 [Startup:StartupSatComms:A] Running Loop=1
2022-08-09T20:45:00.826Z,1660077900.826 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2022-08-09T20:46:00.614Z,1660077960.614 [Startup:StartupSatComms:A](INFO): Timed out from 2022-08-09T20:45:00.4Z
2022-08-09T20:46:00.614Z,1660077960.614 [Startup:StartupSatComms:A] Stopped
2022-08-09T20:46:00.614Z,1660077960.614 [Startup:StartupSatComms:B] Running Loop=1
2022-08-09T20:46:01.017Z,1660077961.017 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2022-08-09T20:47:00.808Z,1660078020.808 [Startup:StartupSatComms:B](INFO): Timed out from 2022-08-09T20:46:00.6Z
2022-08-09T20:47:00.808Z,1660078020.808 [Startup:StartupSatComms:B] Stopped
2022-08-09T20:47:00.808Z,1660078020.808 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2022-08-09T20:47:00.808Z,1660078020.808 [Startup:StartupSatComms] Stopped
2022-08-09T20:47:00.809Z,1660078020.809 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2022-08-