2024-03-25T22:16:01.748Z,1711404961.748 [Supervisor](DEBUG): Initializing supervisor. 2024-03-25T22:16:01.753Z,1711404961.753 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2024-03-25T22:16:01.753Z,1711404961.753 [SyncHandler](INFO): Protected caller Thread ID is 2752 2024-03-25T22:16:01.754Z,1711404961.754 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2024-03-25T22:16:01.755Z,1711404961.755 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2024-03-25T22:16:01.755Z,1711404961.755 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 2753 2024-03-25T22:16:01.759Z,1711404961.759 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2024-03-25T22:16:01.776Z,1711404961.776 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread. 2024-03-25T22:16:01.777Z,1711404961.777 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2024-03-25T22:16:01.778Z,1711404961.778 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 2754 2024-03-25T22:16:01.782Z,1711404961.782 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2024-03-25T22:16:01.783Z,1711404961.783 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2024-03-25T22:16:01.783Z,1711404961.783 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 2755 2024-03-25T22:16:01.785Z,1711404961.785 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2024-03-25T22:16:01.786Z,1711404961.786 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0 2024-03-25T22:16:01.786Z,1711404961.786 [logger ThreadHandler](INFO): Protected caller Thread ID is 2756 2024-03-25T22:16:01.790Z,1711404961.790 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2024-03-25T22:16:01.790Z,1711404961.790 [Supervisor](INFO): Looking for Config files in directory: Config/ 2024-03-25T22:16:01.792Z,1711404961.792 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2024-03-25T22:16:02.006Z,1711404962.006 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2024-03-25T22:16:02.007Z,1711404962.007 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2024-03-25T22:16:02.117Z,1711404962.117 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2024-03-25T22:16:02.118Z,1711404962.118 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2024-03-25T22:16:02.215Z,1711404962.215 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2024-03-25T22:16:02.216Z,1711404962.216 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2024-03-25T22:16:02.732Z,1711404962.732 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2024-03-25T22:16:02.732Z,1711404962.732 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2024-03-25T22:16:03.135Z,1711404963.135 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2024-03-25T22:16:03.136Z,1711404963.136 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2024-03-25T22:16:03.482Z,1711404963.482 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2024-03-25T22:16:03.483Z,1711404963.483 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2024-03-25T22:16:03.679Z,1711404963.679 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2024-03-25T22:16:03.679Z,1711404963.679 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2024-03-25T22:16:03.759Z,1711404963.759 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2024-03-25T22:16:03.841Z,1711404963.841 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2024-03-25T22:16:04.256Z,1711404964.256 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2024-03-25T22:16:04.257Z,1711404964.257 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2024-03-25T22:16:04.544Z,1711404964.544 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2024-03-25T22:16:04.545Z,1711404964.545 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2024-03-25T22:16:05.069Z,1711404965.069 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2024-03-25T22:16:05.069Z,1711404965.069 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2024-03-25T22:16:05.296Z,1711404965.296 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2024-03-25T22:16:05.297Z,1711404965.297 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg 2024-03-25T22:16:05.545Z,1711404965.545 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock 2024-03-25T22:16:05.546Z,1711404965.546 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2024-03-25T22:16:05.687Z,1711404965.687 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2024-03-25T22:16:05.688Z,1711404965.688 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2024-03-25T22:16:06.578Z,1711404966.578 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2024-03-25T22:16:06.580Z,1711404966.580 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-galene/ 2024-03-25T22:16:06.581Z,1711404966.581 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/secure.cfg 2024-03-25T22:16:06.799Z,1711404966.799 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/vehicle.cfg 2024-03-25T22:16:07.002Z,1711404967.002 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Battery.cfg 2024-03-25T22:16:07.480Z,1711404967.480 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2024-03-25T22:16:07.480Z,1711404967.480 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Science.cfg 2024-03-25T22:16:07.707Z,1711404967.707 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Control.cfg 2024-03-25T22:16:07.809Z,1711404967.809 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/logger.cfg 2024-03-25T22:16:07.903Z,1711404967.903 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Servo.cfg 2024-03-25T22:16:08.013Z,1711404968.013 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Navigation.cfg 2024-03-25T22:16:08.110Z,1711404968.110 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Simulator.cfg 2024-03-25T22:16:08.197Z,1711404968.197 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/BIT.cfg 2024-03-25T22:16:08.289Z,1711404968.289 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/workSite.cfg 2024-03-25T22:16:08.373Z,1711404968.373 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Sensor.cfg 2024-03-25T22:16:08.542Z,1711404968.542 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-galene/root/ 2024-03-25T22:16:08.542Z,1711404968.542 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg 2024-03-25T22:16:08.548Z,1711404968.548 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2024-03-25T22:16:08.600Z,1711404968.600 [DepthRateCalculator] Loaded 2024-03-25T22:16:08.601Z,1711404968.601 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2024-03-25T22:16:08.606Z,1711404968.606 [PitchRateCalculator] Loaded 2024-03-25T22:16:08.606Z,1711404968.606 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2024-03-25T22:16:08.617Z,1711404968.617 [SpeedCalculator] Loaded 2024-03-25T22:16:08.617Z,1711404968.617 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2024-03-25T22:16:08.622Z,1711404968.622 [YawRateCalculator] Loaded 2024-03-25T22:16:08.622Z,1711404968.622 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2024-03-25T22:16:08.644Z,1711404968.644 [ElevatorOffsetCalculator] Loaded 2024-03-25T22:16:08.644Z,1711404968.644 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread. 2024-03-25T22:16:08.644Z,1711404968.644 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2024-03-25T22:16:08.645Z,1711404968.645 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2024-03-25T22:16:08.671Z,1711404968.671 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2024-03-25T22:16:08.672Z,1711404968.672 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2024-03-25T22:16:08.682Z,1711404968.682 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2024-03-25T22:16:08.682Z,1711404968.682 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2024-03-25T22:16:09.103Z,1711404969.103 [AHRS_M2] Loaded 2024-03-25T22:16:09.104Z,1711404969.103 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread. 2024-03-25T22:16:09.138Z,1711404969.138 [BackseatComponent] Loaded 2024-03-25T22:16:09.138Z,1711404969.138 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread. 2024-03-25T22:16:09.139Z,1711404969.139 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 4084E4E0 2024-03-25T22:16:09.140Z,1711404969.140 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 2842 2024-03-25T22:16:09.142Z,1711404969.142 [LcmUniversalReporter] Loaded 2024-03-25T22:16:09.143Z,1711404969.143 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread. 2024-03-25T22:16:09.926Z,1711404969.926 [BPC1] Loaded 2024-03-25T22:16:09.926Z,1711404969.926 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2024-03-25T22:16:10.004Z,1711404970.004 [DataOverHttps] Loaded 2024-03-25T22:16:10.004Z,1711404970.004 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread. 2024-03-25T22:16:10.005Z,1711404970.005 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 4087E4E0 2024-03-25T22:16:10.006Z,1711404970.006 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 2843 2024-03-25T22:16:10.025Z,1711404970.025 [Depth_Keller] Loaded 2024-03-25T22:16:10.026Z,1711404970.026 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2024-03-25T22:16:10.030Z,1711404970.030 [DropWeight] Loaded 2024-03-25T22:16:10.031Z,1711404970.031 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread. 2024-03-25T22:16:10.049Z,1711404970.049 [MultiRay] Loaded 2024-03-25T22:16:10.049Z,1711404970.049 [ComponentRegistry](DEBUG): SyncComponent "MultiRay" handled in the control thread. 2024-03-25T22:16:10.111Z,1711404970.111 [NAL9602] Loaded 2024-03-25T22:16:10.111Z,1711404970.111 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2024-03-25T22:16:10.140Z,1711404970.140 [Onboard] Loaded 2024-03-25T22:16:10.140Z,1711404970.140 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread. 2024-03-25T22:16:10.141Z,1711404970.141 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 408AE4E0 2024-03-25T22:16:10.142Z,1711404970.142 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 2844 2024-03-25T22:16:10.147Z,1711404970.147 [PowerOnly](INFO): Adding load control power supply at /dev/loadC3 2024-03-25T22:16:10.159Z,1711404970.159 [PowerOnly] Loaded 2024-03-25T22:16:10.159Z,1711404970.159 [ComponentRegistry](DEBUG): SyncComponent "PowerOnly" handled in the control thread. 2024-03-25T22:16:10.170Z,1711404970.170 [Power24vConverter] Loaded 2024-03-25T22:16:10.171Z,1711404970.171 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread. 2024-03-25T22:16:10.185Z,1711404970.185 [Radio_Surface] Loaded 2024-03-25T22:16:10.185Z,1711404970.185 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2024-03-25T22:16:10.186Z,1711404970.186 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 408DE4E0 2024-03-25T22:16:10.186Z,1711404970.186 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 2845 2024-03-25T22:16:10.276Z,1711404970.276 [DAT] Loaded 2024-03-25T22:16:10.276Z,1711404970.276 [ComponentRegistry](DEBUG): Component "DAT" handled in its own thread. 2024-03-25T22:16:10.277Z,1711404970.277 [DAT ThreadHandler](DEBUG): Created PCaller Thread at 4090E4E0 2024-03-25T22:16:10.278Z,1711404970.278 [DAT ThreadHandler](INFO): Protected caller Thread ID is 2846 2024-03-25T22:16:10.278Z,1711404970.278 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2024-03-25T22:16:10.279Z,1711404970.279 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2024-03-25T22:16:10.389Z,1711404970.389 [DeadReckonUsingMultipleVelocitySources] Loaded 2024-03-25T22:16:10.389Z,1711404970.389 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2024-03-25T22:16:10.430Z,1711404970.430 [DeadReckonUsingSpeedCalculator] Loaded 2024-03-25T22:16:10.431Z,1711404970.431 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread. 2024-03-25T22:16:10.444Z,1711404970.444 [NavChart] Loaded 2024-03-25T22:16:10.445Z,1711404970.445 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2024-03-25T22:16:10.450Z,1711404970.450 [UniversalFixResidualReporter] Loaded 2024-03-25T22:16:10.450Z,1711404970.450 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2024-03-25T22:16:10.451Z,1711404970.451 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2024-03-25T22:16:10.451Z,1711404970.451 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2024-03-25T22:16:10.593Z,1711404970.593 [SBIT](DEBUG): Construct Startup Built In Test. 2024-03-25T22:16:10.607Z,1711404970.607 [SBIT] Loaded 2024-03-25T22:16:10.607Z,1711404970.607 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2024-03-25T22:16:10.610Z,1711404970.610 [IBIT](DEBUG): Construct Initiated Built In Test. 2024-03-25T22:16:10.623Z,1711404970.623 [IBIT] Loaded 2024-03-25T22:16:10.623Z,1711404970.623 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2024-03-25T22:16:10.629Z,1711404970.629 [CBIT](DEBUG): Construct Continuous Built In Test. 2024-03-25T22:16:10.732Z,1711404970.732 [CBIT] Loaded 2024-03-25T22:16:10.732Z,1711404970.732 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2024-03-25T22:16:10.733Z,1711404970.733 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2024-03-25T22:16:10.733Z,1711404970.733 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2024-03-25T22:16:10.902Z,1711404970.902 [CTD_Seabird] Loaded 2024-03-25T22:16:10.903Z,1711404970.903 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread. 2024-03-25T22:16:10.904Z,1711404970.904 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40A164E0 2024-03-25T22:16:10.904Z,1711404970.904 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 2847 2024-03-25T22:16:10.924Z,1711404970.924 [PAR_Licor] Loaded 2024-03-25T22:16:10.924Z,1711404970.924 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread. 2024-03-25T22:16:10.966Z,1711404970.966 [WetLabsBB2FL] Loaded 2024-03-25T22:16:10.966Z,1711404970.966 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread. 2024-03-25T22:16:10.967Z,1711404970.967 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40A464E0 2024-03-25T22:16:10.968Z,1711404970.968 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 2848 2024-03-25T22:16:10.968Z,1711404970.968 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2024-03-25T22:16:10.969Z,1711404970.969 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2024-03-25T22:16:11.100Z,1711404971.100 [BuoyancyServo] Loaded 2024-03-25T22:16:11.101Z,1711404971.101 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2024-03-25T22:16:11.122Z,1711404971.122 [ElevatorServo] Loaded 2024-03-25T22:16:11.122Z,1711404971.122 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2024-03-25T22:16:11.143Z,1711404971.143 [MassServo] Loaded 2024-03-25T22:16:11.143Z,1711404971.143 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2024-03-25T22:16:11.163Z,1711404971.163 [RudderServo] Loaded 2024-03-25T22:16:11.164Z,1711404971.164 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2024-03-25T22:16:11.180Z,1711404971.180 [ThrusterHE] Loaded 2024-03-25T22:16:11.180Z,1711404971.180 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread. 2024-03-25T22:16:11.180Z,1711404971.180 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2024-03-25T22:16:11.181Z,1711404971.181 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2024-03-25T22:16:11.233Z,1711404971.233 [VerticalControl](DEBUG): Construct VerticalControl. 2024-03-25T22:16:11.283Z,1711404971.283 [VerticalControl] Loaded 2024-03-25T22:16:11.284Z,1711404971.284 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2024-03-25T22:16:11.286Z,1711404971.286 [HorizontalControl](DEBUG): Construct HorizontalControl. 2024-03-25T22:16:11.325Z,1711404971.325 [HorizontalControl] Loaded 2024-03-25T22:16:11.325Z,1711404971.325 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2024-03-25T22:16:11.328Z,1711404971.328 [SpeedControl](DEBUG): Construct SpeedControl. 2024-03-25T22:16:11.329Z,1711404971.329 [SpeedControl] Loaded 2024-03-25T22:16:11.330Z,1711404971.330 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2024-03-25T22:16:11.332Z,1711404971.332 [LoopControl](DEBUG): Construct LoopControl. 2024-03-25T22:16:11.333Z,1711404971.333 [LoopControl] Loaded 2024-03-25T22:16:11.333Z,1711404971.333 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2024-03-25T22:16:11.334Z,1711404971.334 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2024-03-25T22:16:11.334Z,1711404971.334 [Module Loader](DEBUG): Loading Module at Modules/Dock.so 2024-03-25T22:16:11.447Z,1711404971.447 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking) 2024-03-25T22:16:11.448Z,1711404971.448 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2024-03-25T22:16:11.595Z,1711404971.595 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2024-03-25T22:16:11.596Z,1711404971.596 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2024-03-25T22:16:12.327Z,1711404972.327 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2024-03-25T22:16:12.328Z,1711404972.328 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2024-03-25T22:16:12.384Z,1711404972.384 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2024-03-25T22:16:12.390Z,1711404972.390 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2024-03-25T22:16:12.393Z,1711404972.393 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2024-03-25T22:16:12.404Z,1711404972.404 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2024-03-25T22:16:12.405Z,1711404972.405 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40C234E0 2024-03-25T22:16:12.405Z,1711404972.405 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 2849 2024-03-25T22:16:12.410Z,1711404972.410 [Supervisor](INFO): Main Thread ID is 2751 2024-03-25T22:16:12.410Z,1711404972.410 [Supervisor](DEBUG): Running supervisor. 2024-03-25T22:16:12.410Z,1711404972.410 [CommandExec ThreadHandler](INFO): Handler Thread ID is 2850 2024-03-25T22:16:12.411Z,1711404972.411 [CommandExec](INFO): Initializing the command executive. 2024-03-25T22:16:12.413Z,1711404972.413 [CommandLine ThreadHandler](INFO): Handler Thread ID is 2851 2024-03-25T22:16:12.415Z,1711404972.415 [controlThread ThreadHandler](INFO): Handler Thread ID is 2852 2024-03-25T22:16:12.415Z,1711404972.415 [controlThread](DEBUG): Initializing ControlThread 2024-03-25T22:16:12.416Z,1711404972.416 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2024-03-25T22:16:12.417Z,1711404972.417 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2024-03-25T22:16:12.417Z,1711404972.417 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2024-03-25T22:16:12.417Z,1711404972.417 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2024-03-25T22:16:12.418Z,1711404972.418 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator. 2024-03-25T22:16:12.426Z,1711404972.426 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-03-25T22:16:12.426Z,1711404972.426 [NavChart](DEBUG): Initialize NavChart Navigation. 2024-03-25T22:16:12.427Z,1711404972.427 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2024-03-25T22:16:12.427Z,1711404972.427 [SBIT](INFO): Initialize SBIT Component. 2024-03-25T22:16:12.427Z,1711404972.427 [SBIT](IMPORTANT): git: 2024-03-20_A 2024-03-25T22:16:12.428Z,1711404972.428 [SBIT](INFO): git hash: 558126c10e432fdab8233783f7bd135b95fbb11f 2024-03-25T22:16:12.428Z,1711404972.428 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2024-03-25T22:16:12.429Z,1711404972.429 [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 2024-03-25T22:16:12.430Z,1711404972.430 [SBIT](INFO): Beginning SBIT in 24.000000 seconds. 2024-03-25T22:16:12.431Z,1711404972.431 [IBIT](INFO): Initialize IBIT Component. 2024-03-25T22:16:12.432Z,1711404972.432 [CBIT](DEBUG): Initialize CBIT Component. 2024-03-25T22:16:12.433Z,1711404972.433 [logger ThreadHandler](INFO): Handler Thread ID is 2853 2024-03-25T22:16:12.443Z,1711404972.443 [CBIT](DEBUG): Initialized mux pins. 2024-03-25T22:16:12.443Z,1711404972.443 [CBIT](DEBUG): Initializing the watchdog timer. 2024-03-25T22:16:12.452Z,1711404972.452 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 2854 2024-03-25T22:16:12.464Z,1711404972.464 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 2855 2024-03-25T22:16:12.465Z,1711404972.465 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2024-03-25T22:16:12.467Z,1711404972.467 [CBIT](INFO): Last reboot was NOT due to watchdog timer. 2024-03-25T22:16:12.468Z,1711404972.468 [CBIT](DEBUG): Initializing heartbeat. 2024-03-25T22:16:12.476Z,1711404972.476 [Onboard ThreadHandler](INFO): Handler Thread ID is 2856 2024-03-25T22:16:12.493Z,1711404972.493 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 2857 2024-03-25T22:16:12.516Z,1711404972.516 [DAT ThreadHandler](INFO): Handler Thread ID is 2858 2024-03-25T22:16:12.517Z,1711404972.517 [DAT](INFO): Powering up 2024-03-25T22:16:12.517Z,1711404972.517 [DAT](DEBUG): Initializing DAT. 2024-03-25T22:16:12.521Z,1711404972.521 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 2860 2024-03-25T22:16:12.521Z,1711404972.521 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2024-03-25T22:16:12.524Z,1711404972.524 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 2862 2024-03-25T22:16:12.528Z,1711404972.528 [WetLabsBB2FL](INFO): Powering up 2024-03-25T22:16:12.529Z,1711404972.529 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 2864 2024-03-25T22:16:12.532Z,1711404972.532 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000 2024-03-25T22:16:12.532Z,1711404972.532 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000 2024-03-25T22:16:12.532Z,1711404972.532 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000 2024-03-25T22:16:12.532Z,1711404972.532 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000 2024-03-25T22:16:12.533Z,1711404972.533 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000 2024-03-25T22:16:12.533Z,1711404972.533 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000 2024-03-25T22:16:12.533Z,1711404972.533 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000 2024-03-25T22:16:12.533Z,1711404972.533 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000 2024-03-25T22:16:12.539Z,1711404972.539 [CBIT](DEBUG): Deactivating GF circuits. 2024-03-25T22:16:12.539Z,1711404972.539 [CBIT](DEBUG): Deactivating emergency mode. 2024-03-25T22:16:12.579Z,1711404972.579 [CBIT](DEBUG): Backplane powered. 2024-03-25T22:16:12.585Z,1711404972.585 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2024-03-25T22:16:12.586Z,1711404972.586 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2024-03-25T22:16:12.587Z,1711404972.587 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2024-03-25T22:16:12.588Z,1711404972.588 [LoopControl](DEBUG): Initialize LoopControlComponent. 2024-03-25T22:16:12.588Z,1711404972.588 [MissionManager](IMPORTANT): Using TethysL tl-to-tx parser 2024-03-25T22:16:12.589Z,1711404972.589 [MissionManager](INFO): Loading Mission from file: Missions/Startup.tl 2024-03-25T22:16:12.589Z,1711404972.589 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Startup.tl 2024-03-25T22:16:12.590Z,1711404972.590 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Startup.tl 2024-03-25T22:16:12.632Z,1711404972.632 [MissionManager](DEBUG): TethyslAPI: Missions/Startup.tl translated into: 2024-03-25T22:16:12.641Z,1711404972.641 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2024-03-25T22:16:12.684Z,1711404972.684 [MissionManager](DEBUG): mission Startup { behavior Guidance:GoToSurface { run in progression } aggregate StartupSatComms { run in sequence readDatum { timeout duration=P1M Universal:latitude_fix } readDatum { timeout duration=P1M Universal:platform_communications } } } 2024-03-25T22:16:12.685Z,1711404972.685 [MissionManager](INFO): Loading Mission from file: Missions/Default.xml 2024-03-25T22:16:12.722Z,1711404972.722 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min 2024-03-25T22:16:12.735Z,1711404972.735 [Default:A.Wait](DEBUG): Construct Wait. 2024-03-25T22:16:12.738Z,1711404972.738 [Default:B.GoToSurface](DEBUG): Construct GoToSurface. 2024-03-25T22:16:12.765Z,1711404972.765 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2024-03-25T22:16:12.769Z,1711404972.769 [Default:CheckIn:C.Wait](DEBUG): Construct Wait. 2024-03-25T22:16:12.775Z,1711404972.775 [Default:E.Execute](DEBUG): Construct Execute. 2024-03-25T22:16:12.778Z,1711404972.778 [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 2024-03-25T22:16:12.802Z,1711404972.802 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,DropWeight,MultiRay,NAL9602,PowerOnly,Power24vConverter,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,DeadReckonUsingSpeedCalculator,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter, 2024-03-25T22:16:12.811Z,1711404972.811 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2024-03-25T22:16:12.865Z,1711404972.865 [MultiRay](INFO): Powering up MultiRay Lights 2024-03-25T22:16:12.899Z,1711404972.899 [Radio_Surface](INFO): Powering up 2024-03-25T22:16:12.908Z,1711404972.908 [PowerOnly](INFO): Powering up loadControl 2024-03-25T22:16:12.928Z,1711404972.928 [Power24vConverter](INFO): Powering up. 2024-03-25T22:16:12.960Z,1711404972.960 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2024-03-25T22:16:12.967Z,1711404972.967 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2024-03-25T22:16:12.968Z,1711404972.968 [ElevatorServo](DEBUG): Initializing EZServoServo. 2024-03-25T22:16:12.975Z,1711404972.975 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2024-03-25T22:16:12.976Z,1711404972.976 [MassServo](DEBUG): Initializing EZServoServo. 2024-03-25T22:16:12.983Z,1711404972.983 [MassServo](DEBUG): Initializing MassServo. 2024-03-25T22:16:12.984Z,1711404972.984 [RudderServo](DEBUG): Initializing EZServoServo. 2024-03-25T22:16:12.991Z,1711404972.991 [RudderServo](DEBUG): Initializing RudderServo. 2024-03-25T22:16:12.992Z,1711404972.992 [ThrusterHE](DEBUG): Initializing EZServoServo. 2024-03-25T22:16:12.999Z,1711404972.999 [ThrusterHE](DEBUG): Initializing ThrusterHE. 2024-03-25T22:16:13.260Z,1711404973.260 [DropWeight](CRITICAL): DROP WEIGHT MISSING. 2024-03-25T22:16:13.261Z,1711404973.261 [DropWeight] Hardware Fault, FailCount= 1 2024-03-25T22:16:13.261Z,1711404973.261 [DropWeight](ERROR): Hardware Fault 2024-03-25T22:16:13.342Z,1711404973.342 [CommandExec](FAULT): Scheduling is paused 2024-03-25T22:16:13.342Z,1711404973.342 [CBIT](INFO): Critical error at 20240325T221613 2024-03-25T22:16:13.342Z,1711404973.342 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals 2024-03-25T22:16:13.349Z,1711404973.349 [CBIT](ERROR): Hardware Fault in component: DropWeight 2024-03-25T22:16:13.350Z,1711404973.350 [CBIT](CRITICAL): Hardware Fault in component: DropWeight 2024-03-25T22:16:13.645Z,1711404973.645 [CBIT](INFO): Critical error at 20240325T221613 2024-03-25T22:16:16.603Z,1711404976.603 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2024-03-25T22:16:17.007Z,1711404977.007 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2024-03-25T22:16:17.640Z,1711404977.640 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2024-03-25T22:16:17.823Z,1711404977.823 [WetLabsBB2FL] Communications Fault, FailCount= 1 2024-03-25T22:16:17.823Z,1711404977.823 [WetLabsBB2FL](ERROR): Communications Fault 2024-03-25T22:16:18.075Z,1711404978.075 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2024-03-25T22:16:18.323Z,1711404978.323 [WetLabsBB2FL](INFO): Powering down 2024-03-25T22:16:18.334Z,1711404978.334 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2024-03-25T22:16:18.667Z,1711404978.667 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2024-03-25T22:16:19.063Z,1711404979.063 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2024-03-25T22:16:19.171Z,1711404979.171 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2024-03-25T22:16:19.172Z,1711404979.172 [WetLabsBB2FL] No Fault, FailCount= 1 2024-03-25T22:16:19.503Z,1711404979.503 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2024-03-25T22:16:19.537Z,1711404979.537 [WetLabsBB2FL](INFO): Powering up 2024-03-25T22:16:20.007Z,1711404980.007 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2024-03-25T22:16:20.431Z,1711404980.431 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2024-03-25T22:16:20.903Z,1711404980.903 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2024-03-25T22:16:20.984Z,1711404980.984 [BuoyancyServo](FAULT): Invalid EZ Servo response:"" 2024-03-25T22:16:20.984Z,1711404980.984 [BuoyancyServo] Communications Fault, FailCount= 1 2024-03-25T22:16:20.984Z,1711404980.984 [BuoyancyServo](ERROR): Communications Fault 2024-03-25T22:16:21.021Z,1711404981.021 [CBIT](ERROR): Communications Fault in component: BuoyancyServo 2024-03-25T22:16:21.356Z,1711404981.356 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2024-03-25T22:16:21.779Z,1711404981.779 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2024-03-25T22:16:22.167Z,1711404982.167 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2024-03-25T22:16:22.570Z,1711404982.570 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2024-03-25T22:16:23.055Z,1711404983.055 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2024-03-25T22:16:23.076Z,1711404983.076 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2024-03-25T22:16:23.076Z,1711404983.076 [BuoyancyServo](INFO): Powering down 2024-03-25T22:16:23.539Z,1711404983.539 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2024-03-25T22:16:23.943Z,1711404983.943 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2024-03-25T22:16:23.970Z,1711404983.970 [CBIT](INFO): Clearing failed state for component BuoyancyServo 2024-03-25T22:16:23.970Z,1711404983.970 [BuoyancyServo] No Fault, FailCount= 1 2024-03-25T22:16:24.343Z,1711404984.343 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2024-03-25T22:16:24.373Z,1711404984.373 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2024-03-25T22:16:24.374Z,1711404984.374 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2024-03-25T22:16:24.747Z,1711404984.747 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2024-03-25T22:16:24.847Z,1711404984.847 [WetLabsBB2FL] Communications Fault, FailCount= 2 2024-03-25T22:16:24.848Z,1711404984.848 [WetLabsBB2FL](ERROR): Communications Fault 2024-03-25T22:16:24.876Z,1711404984.876 [DAT](INFO): DAT read: 2024-03-25T22:16:24.877Z,1711404984.877 [DAT](INFO): DAT read: Teledyne Benthos DAT-900 Series 2024-03-25T22:16:25.151Z,1711404985.151 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2024-03-25T22:16:25.169Z,1711404985.169 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2024-03-25T22:16:25.347Z,1711404985.347 [WetLabsBB2FL](INFO): Powering down 2024-03-25T22:16:25.551Z,1711404985.551 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2024-03-25T22:16:25.571Z,1711404985.571 [CTD_Seabird](FAULT): Failed to initialize within timeout. 2024-03-25T22:16:25.571Z,1711404985.571 [CTD_Seabird] Communications Fault, FailCount= 1 2024-03-25T22:16:25.571Z,1711404985.571 [CTD_Seabird](ERROR): Communications Fault 2024-03-25T22:16:25.656Z,1711404985.656 [CBIT](ERROR): Communications Fault in component: CTD_Seabird 2024-03-25T22:16:25.976Z,1711404985.976 [CTD_Seabird](INFO): Powering down 2024-03-25T22:16:26.007Z,1711404986.007 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2024-03-25T22:16:26.007Z,1711404986.007 [AHRS_M2](FAULT): Failed to initialize within timeout. 2024-03-25T22:16:26.007Z,1711404986.007 [AHRS_M2] Communications Fault, FailCount= 1 2024-03-25T22:16:26.007Z,1711404986.007 [AHRS_M2](ERROR): Communications Fault 2024-03-25T22:16:26.078Z,1711404986.078 [CBIT](ERROR): Communications Fault in component: AHRS_M2 2024-03-25T22:16:26.111Z,1711404986.111 [AHRS_M2](INFO): Powering down 2024-03-25T22:16:26.220Z,1711404986.220 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2024-03-25T22:16:26.220Z,1711404986.220 [WetLabsBB2FL] No Fault, FailCount= 2 2024-03-25T22:16:26.561Z,1711404986.561 [WetLabsBB2FL](INFO): Powering up 2024-03-25T22:16:26.648Z,1711404986.648 [DAT](INFO): DAT read: MF Frequency Band 2024-03-25T22:16:26.649Z,1711404986.649 [DAT](INFO): DAT read: Directional Acoustic Transponder version 8.15.0 2024-03-25T22:16:26.650Z,1711404986.650 [DAT](INFO): DAT read: Mar 25 2024 22:16:20 2024-03-25T22:16:26.978Z,1711404986.978 [CBIT](INFO): Clearing failed state for component AHRS_M2 2024-03-25T22:16:26.978Z,1711404986.978 [AHRS_M2] No Fault, FailCount= 1 2024-03-25T22:16:26.979Z,1711404986.979 [CBIT](INFO): Clearing failed state for component CTD_Seabird 2024-03-25T22:16:26.979Z,1711404986.979 [CTD_Seabird] No Fault, FailCount= 1 2024-03-25T22:16:27.309Z,1711404987.309 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2024-03-25T22:16:27.319Z,1711404987.319 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2024-03-25T22:16:27.908Z,1711404987.908 [DAT](INFO): DAT read: Features enabled [Bearing] 2024-03-25T22:16:27.909Z,1711404987.909 [DAT](INFO): DAT read: CONNECT 00800 bits/sec 1 of 4, Rate 1/2 CC 12.50ms MGP 2024-03-25T22:16:27.910Z,1711404987.910 [DAT](INFO): commRate: 800 2024-03-25T22:16:28.215Z,1711404988.215 [BuoyancyServo](FAULT): Invalid EZ Servo response:"" 2024-03-25T22:16:28.215Z,1711404988.215 [BuoyancyServo] Communications Fault, FailCount= 2 2024-03-25T22:16:28.215Z,1711404988.215 [BuoyancyServo](ERROR): Communications Fault 2024-03-25T22:16:28.225Z,1711404988.225 [CBIT](ERROR): Communications Fault in component: BuoyancyServo 2024-03-25T22:16:29.441Z,1711404989.441 [CommandExec](IMPORTANT): got command report mod platform_buoyancy_position 2024-03-25T22:16:29.975Z,1711404989.975 [DAT](INFO): entering command mode 2024-03-25T22:16:30.150Z,1711404990.150 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2024-03-25T22:16:30.150Z,1711404990.150 [BuoyancyServo](INFO): Powering down 2024-03-25T22:16:30.176Z,1711404990.176 [DAT](INFO): DAT read: 2024-03-25T22:16:30.176Z,1711404990.176 [DAT](INFO): DAT read: user:1> 2024-03-25T22:16:30.176Z,1711404990.176 [DAT](INFO): setting verbose to 3 2024-03-25T22:16:30.428Z,1711404990.428 [DAT](INFO): DAT read: user:1> 2024-03-25T22:16:30.429Z,1711404990.429 [DAT](INFO): DAT read: Verbose | 3 2024-03-25T22:16:30.429Z,1711404990.429 [DAT](INFO): set verbose to 3 2024-03-25T22:16:30.429Z,1711404990.429 [DAT](INFO): setting DatVerbose to 27440 2024-03-25T22:16:30.680Z,1711404990.680 [DAT](INFO): DAT read: user:2> 2024-03-25T22:16:30.681Z,1711404990.681 [DAT](INFO): DAT read: DatVerbose | 27440 2024-03-25T22:16:30.681Z,1711404990.681 [DAT](INFO): set DatVerbose to 27440 2024-03-25T22:16:30.681Z,1711404990.681 [DAT](INFO): setting transmit power to 8 2024-03-25T22:16:30.859Z,1711404990.859 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2024-03-25T22:16:30.932Z,1711404990.932 [DAT](INFO): DAT read: user:3> 2024-03-25T22:16:30.933Z,1711404990.933 [DAT](INFO): DAT read: TxPower | 8 (Max) 2024-03-25T22:16:30.933Z,1711404990.933 [DAT](INFO): set transmit power to 8 2024-03-25T22:16:30.933Z,1711404990.933 [DAT](INFO): setting local address to 9 2024-03-25T22:16:31.184Z,1711404991.184 [DAT](INFO): DAT read: user:4> 2024-03-25T22:16:31.185Z,1711404991.185 [DAT](INFO): DAT read: LocalAddr | 9 2024-03-25T22:16:31.185Z,1711404991.185 [DAT](INFO): set local address to 9 2024-03-25T22:16:31.186Z,1711404991.186 [DAT](INFO): Setting time to: 22:16:31 And date to:3/25/2024 2024-03-25T22:16:31.275Z,1711404991.275 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2024-03-25T22:16:31.293Z,1711404991.293 [CBIT](INFO): Clearing failed state for component BuoyancyServo 2024-03-25T22:16:31.293Z,1711404991.293 [BuoyancyServo] No Fault, FailCount= 2 2024-03-25T22:16:31.436Z,1711404991.436 [DAT](INFO): DAT read: user:5> 2024-03-25T22:16:31.437Z,1711404991.437 [DAT](INFO): DAT read: Mon Mar 25, 2024 22:16:31 2024-03-25T22:16:31.437Z,1711404991.437 [DAT](INFO): Local DAT time set to Mon Mar 25, 2024 22:16:31 2024-03-25T22:16:31.667Z,1711404991.667 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2024-03-25T22:16:31.695Z,1711404991.695 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2024-03-25T22:16:31.696Z,1711404991.696 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2024-03-25T22:16:31.851Z,1711404991.851 [WetLabsBB2FL] Communications Fault, FailCount= 3 2024-03-25T22:16:31.851Z,1711404991.851 [WetLabsBB2FL](ERROR): Communications Fault 2024-03-25T22:16:32.071Z,1711404992.071 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2024-03-25T22:16:32.109Z,1711404992.109 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2024-03-25T22:16:32.352Z,1711404992.352 [WetLabsBB2FL](INFO): Powering down 2024-03-25T22:16:32.483Z,1711404992.483 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2024-03-25T22:16:32.943Z,1711404992.943 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2024-03-25T22:16:33.355Z,1711404993.355 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2024-03-25T22:16:33.380Z,1711404993.380 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2024-03-25T22:16:33.380Z,1711404993.380 [WetLabsBB2FL] No Fault, FailCount= 3 2024-03-25T22:16:33.564Z,1711404993.564 [WetLabsBB2FL](INFO): Powering up 2024-03-25T22:16:33.755Z,1711404993.755 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2024-03-25T22:16:34.163Z,1711404994.163 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2024-03-25T22:16:34.627Z,1711404994.627 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2024-03-25T22:16:34.670Z,1711404994.670 [Reporter](INFO): platform_buoyancy_position 107.278412 cc 2024-03-25T22:16:35.003Z,1711404995.003 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2024-03-25T22:16:35.087Z,1711404995.087 [BuoyancyServo](FAULT): Invalid EZ Servo response:"" 2024-03-25T22:16:35.087Z,1711404995.087 [BuoyancyServo] Communications Fault, FailCount= 3 2024-03-25T22:16:35.087Z,1711404995.087 [BuoyancyServo](ERROR): Communications Fault 2024-03-25T22:16:35.093Z,1711404995.093 [CBIT](ERROR): Communications Fault in component: BuoyancyServo 2024-03-25T22:16:35.423Z,1711404995.423 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2024-03-25T22:16:35.827Z,1711404995.827 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2024-03-25T22:16:36.235Z,1711404996.235 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2024-03-25T22:16:36.631Z,1711404996.631 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2024-03-25T22:16:37.035Z,1711404997.035 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2024-03-25T22:16:37.092Z,1711404997.092 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2024-03-25T22:16:37.093Z,1711404997.093 [BuoyancyServo](INFO): Powering down 2024-03-25T22:16:37.225Z,1711404997.225 [SBIT](IMPORTANT): Beginning Startup BIT 2024-03-25T22:16:37.229Z,1711404997.229 [CBIT](IMPORTANT): Beginning ground fault scan 2024-03-25T22:16:37.571Z,1711404997.571 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2024-03-25T22:16:37.999Z,1711404997.999 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2024-03-25T22:16:38.080Z,1711404998.080 [CBIT](INFO): Clearing failed state for component BuoyancyServo 2024-03-25T22:16:38.080Z,1711404998.080 [BuoyancyServo] No Fault, FailCount= 3 2024-03-25T22:16:38.427Z,1711404998.427 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2024-03-25T22:16:38.479Z,1711404998.479 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2024-03-25T22:16:38.516Z,1711404998.516 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2024-03-25T22:16:38.855Z,1711404998.855 [WetLabsBB2FL] Communications Fault, FailCount= 4 2024-03-25T22:16:38.855Z,1711404998.855 [WetLabsBB2FL](ERROR): Communications Fault 2024-03-25T22:16:38.887Z,1711404998.887 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2024-03-25T22:16:39.024Z,1711404999.024 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2024-03-25T22:16:39.355Z,1711404999.355 [WetLabsBB2FL](INFO): Powering down 2024-03-25T22:16:39.455Z,1711404999.455 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2024-03-25T22:16:39.991Z,1711404999.991 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2024-03-25T22:16:40.372Z,1711405000.372 [CTD_Seabird](FAULT): Failed to initialize within timeout. 2024-03-25T22:16:40.372Z,1711405000.372 [CTD_Seabird] Communications Fault, FailCount= 2 2024-03-25T22:16:40.372Z,1711405000.372 [CTD_Seabird](ERROR): Communications Fault 2024-03-25T22:16:40.563Z,1711405000.563 [AHRS_M2](ERROR): Format BitStream UART error: serial timeout 2024-03-25T22:16:40.563Z,1711405000.563 [AHRS_M2](FAULT): Failed to initialize within timeout. 2024-03-25T22:16:40.563Z,1711405000.563 [AHRS_M2] Communications Fault, FailCount= 2 2024-03-25T22:16:40.564Z,1711405000.564 [AHRS_M2](ERROR): Communications Fault 2024-03-25T22:16:40.569Z,1711405000.569 [NAL9602](INFO): Powering up NAL9602 2024-03-25T22:16:40.741Z,1711405000.741 [CBIT](ERROR): Communications Fault in component: AHRS_M2 2024-03-25T22:16:40.741Z,1711405000.741 [CBIT](ERROR): Communications Fault in component: CTD_Seabird 2024-03-25T22:16:40.741Z,1711405000.741 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2024-03-25T22:16:40.742Z,1711405000.742 [WetLabsBB2FL] No Fault, FailCount= 4 2024-03-25T22:16:40.750Z,1711405000.750 [AHRS_M2](INFO): Powering down 2024-03-25T22:16:40.776Z,1711405000.776 [CTD_Seabird](INFO): Powering down 2024-03-25T22:16:40.977Z,1711405000.977 [WetLabsBB2FL](INFO): Powering up 2024-03-25T22:16:41.365Z,1711405001.365 [Reporter](INFO): platform_buoyancy_position 107.144135 cc 2024-03-25T22:16:41.700Z,1711405001.700 [BuoyancyServo](FAULT): Invalid EZ Servo response:"" 2024-03-25T22:16:41.700Z,1711405001.700 [BuoyancyServo] Communications Fault, FailCount= 4 2024-03-25T22:16:41.700Z,1711405001.700 [BuoyancyServo](ERROR): Communications Fault 2024-03-25T22:16:41.764Z,1711405001.764 [CBIT](INFO): Clearing failed state for component AHRS_M2 2024-03-25T22:16:41.764Z,1711405001.764 [AHRS_M2] No Fault, FailCo