2023-05-02T18:43:55.744Z,1683053035.744 [Supervisor](DEBUG): Initializing supervisor.
2023-05-02T18:43:55.748Z,1683053035.748 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2023-05-02T18:43:55.749Z,1683053035.749 [SyncHandler](INFO): Protected caller Thread ID is 1986
2023-05-02T18:43:55.749Z,1683053035.749 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2023-05-02T18:43:55.750Z,1683053035.750 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2023-05-02T18:43:55.751Z,1683053035.751 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 1987
2023-05-02T18:43:55.755Z,1683053035.755 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2023-05-02T18:43:55.772Z,1683053035.772 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread.
2023-05-02T18:43:55.773Z,1683053035.773 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2023-05-02T18:43:55.773Z,1683053035.773 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 1988
2023-05-02T18:43:55.777Z,1683053035.777 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2023-05-02T18:43:55.778Z,1683053035.778 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2023-05-02T18:43:55.779Z,1683053035.779 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 1989
2023-05-02T18:43:55.781Z,1683053035.781 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2023-05-02T18:43:55.782Z,1683053035.782 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0
2023-05-02T18:43:55.782Z,1683053035.782 [logger ThreadHandler](INFO): Protected caller Thread ID is 1990
2023-05-02T18:43:55.786Z,1683053035.786 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2023-05-02T18:43:55.786Z,1683053035.786 [Supervisor](INFO): Looking for Config files in directory: Config/
2023-05-02T18:43:55.788Z,1683053035.788 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg
2023-05-02T18:43:56.002Z,1683053036.002 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock
2023-05-02T18:43:56.003Z,1683053036.003 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2023-05-02T18:43:56.209Z,1683053036.209 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2023-05-02T18:43:56.209Z,1683053036.209 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2023-05-02T18:43:56.300Z,1683053036.300 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2023-05-02T18:43:56.301Z,1683053036.301 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2023-05-02T18:43:56.475Z,1683053036.475 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2023-05-02T18:43:56.475Z,1683053036.475 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2023-05-02T18:43:56.909Z,1683053036.909 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2023-05-02T18:43:56.910Z,1683053036.910 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2023-05-02T18:43:57.013Z,1683053037.013 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2023-05-02T18:43:57.013Z,1683053037.013 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2023-05-02T18:43:57.273Z,1683053037.273 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2023-05-02T18:43:57.274Z,1683053037.274 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2023-05-02T18:43:57.465Z,1683053037.465 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2023-05-02T18:43:57.465Z,1683053037.465 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2023-05-02T18:43:57.931Z,1683053037.931 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2023-05-02T18:43:57.931Z,1683053037.931 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2023-05-02T18:43:58.319Z,1683053038.319 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2023-05-02T18:43:58.319Z,1683053038.319 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2023-05-02T18:43:58.395Z,1683053038.395 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2023-05-02T18:43:58.736Z,1683053038.736 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2023-05-02T18:43:58.736Z,1683053038.736 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2023-05-02T18:43:58.868Z,1683053038.868 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2023-05-02T18:43:58.868Z,1683053038.868 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2023-05-02T18:43:59.575Z,1683053039.575 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2023-05-02T18:43:59.576Z,1683053039.576 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2023-05-02T18:43:59.893Z,1683053039.893 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2023-05-02T18:43:59.894Z,1683053039.894 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2023-05-02T18:43:59.974Z,1683053039.974 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-aku/
2023-05-02T18:43:59.975Z,1683053039.975 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/secure.cfg
2023-05-02T18:44:00.054Z,1683053040.054 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/logger.cfg
2023-05-02T18:44:00.154Z,1683053040.154 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/vehicle.cfg
2023-05-02T18:44:00.308Z,1683053040.308 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/Navigation.cfg
2023-05-02T18:44:00.408Z,1683053040.408 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/BIT.cfg
2023-05-02T18:44:00.508Z,1683053040.508 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/Simulator.cfg
2023-05-02T18:44:00.600Z,1683053040.600 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/Servo.cfg
2023-05-02T18:44:00.706Z,1683053040.706 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/Science.cfg
2023-05-02T18:44:00.828Z,1683053040.828 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/Sensor.cfg
2023-05-02T18:44:00.981Z,1683053040.981 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/Control.cfg
2023-05-02T18:44:01.074Z,1683053041.074 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/Battery.cfg
2023-05-02T18:44:01.333Z,1683053041.333 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2023-05-02T18:44:01.333Z,1683053041.333 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg
2023-05-02T18:44:01.338Z,1683053041.338 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2023-05-02T18:44:01.705Z,1683053041.705 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2023-05-02T18:44:01.705Z,1683053041.705 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2023-05-02T18:44:02.123Z,1683053042.123 [AHRS_M2] Loaded
2023-05-02T18:44:02.123Z,1683053042.123 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread.
2023-05-02T18:44:02.926Z,1683053042.926 [BPC1] Loaded
2023-05-02T18:44:02.926Z,1683053042.926 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2023-05-02T18:44:02.998Z,1683053042.998 [DataOverHttps] Loaded
2023-05-02T18:44:02.999Z,1683053042.999 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2023-05-02T18:44:02.000Z,1683053043.000 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 408684E0
2023-05-02T18:44:03.000Z,1683053043.000 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 2072
2023-05-02T18:44:03.046Z,1683053043.046 [Depth_Keller] Loaded
2023-05-02T18:44:03.047Z,1683053043.047 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2023-05-02T18:44:03.051Z,1683053043.051 [DropWeight] Loaded
2023-05-02T18:44:03.052Z,1683053043.052 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2023-05-02T18:44:03.070Z,1683053043.070 [MultiRay] Loaded
2023-05-02T18:44:03.070Z,1683053043.070 [ComponentRegistry](DEBUG): SyncComponent "MultiRay" handled in the control thread.
2023-05-02T18:44:03.131Z,1683053043.131 [NAL9602] Loaded
2023-05-02T18:44:03.131Z,1683053043.131 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2023-05-02T18:44:03.160Z,1683053043.160 [Onboard] Loaded
2023-05-02T18:44:03.160Z,1683053043.160 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread.
2023-05-02T18:44:03.161Z,1683053043.161 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 408984E0
2023-05-02T18:44:03.162Z,1683053043.162 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 2073
2023-05-02T18:44:03.175Z,1683053043.175 [Power24vConverter] Loaded
2023-05-02T18:44:03.175Z,1683053043.175 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread.
2023-05-02T18:44:03.247Z,1683053043.247 [PNI_TCM] Loaded
2023-05-02T18:44:03.248Z,1683053043.248 [ComponentRegistry](DEBUG): SyncComponent "PNI_TCM" handled in the control thread.
2023-05-02T18:44:03.262Z,1683053043.262 [Radio_Surface] Loaded
2023-05-02T18:44:03.262Z,1683053043.262 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2023-05-02T18:44:03.263Z,1683053043.263 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 408C84E0
2023-05-02T18:44:03.263Z,1683053043.263 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 2074
2023-05-02T18:44:03.352Z,1683053043.352 [DAT] Loaded
2023-05-02T18:44:03.353Z,1683053043.353 [ComponentRegistry](DEBUG): Component "DAT" handled in its own thread.
2023-05-02T18:44:03.354Z,1683053043.354 [DAT ThreadHandler](DEBUG): Created PCaller Thread at 408F84E0
2023-05-02T18:44:03.354Z,1683053043.354 [DAT ThreadHandler](INFO): Protected caller Thread ID is 2075
2023-05-02T18:44:03.355Z,1683053043.355 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2023-05-02T18:44:03.355Z,1683053043.355 [Module Loader](DEBUG): Loading Module at Modules/Dock.so
2023-05-02T18:44:03.457Z,1683053043.457 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking)
2023-05-02T18:44:03.457Z,1683053043.457 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2023-05-02T18:44:03.509Z,1683053043.509 [VerticalControl](DEBUG): Construct VerticalControl.
2023-05-02T18:44:03.568Z,1683053043.568 [VerticalControl] Loaded
2023-05-02T18:44:03.568Z,1683053043.568 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2023-05-02T18:44:03.571Z,1683053043.571 [HorizontalControl](DEBUG): Construct HorizontalControl.
2023-05-02T18:44:03.612Z,1683053043.612 [HorizontalControl] Loaded
2023-05-02T18:44:03.612Z,1683053043.612 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2023-05-02T18:44:03.614Z,1683053043.614 [SpeedControl](DEBUG): Construct SpeedControl.
2023-05-02T18:44:03.618Z,1683053043.618 [SpeedControl] Loaded
2023-05-02T18:44:03.618Z,1683053043.618 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2023-05-02T18:44:03.621Z,1683053043.621 [LoopControl](DEBUG): Construct LoopControl.
2023-05-02T18:44:03.621Z,1683053043.621 [LoopControl] Loaded
2023-05-02T18:44:03.621Z,1683053043.621 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2023-05-02T18:44:03.622Z,1683053043.622 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2023-05-02T18:44:03.622Z,1683053043.622 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2023-05-02T18:44:03.633Z,1683053043.633 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2023-05-02T18:44:03.633Z,1683053043.633 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2023-05-02T18:44:03.660Z,1683053043.660 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2023-05-02T18:44:03.661Z,1683053043.661 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2023-05-02T18:44:03.774Z,1683053043.774 [DeadReckonUsingMultipleVelocitySources] Loaded
2023-05-02T18:44:03.775Z,1683053043.775 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2023-05-02T18:44:03.817Z,1683053043.817 [DeadReckonUsingSpeedCalculator] Loaded
2023-05-02T18:44:03.817Z,1683053043.817 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread.
2023-05-02T18:44:03.858Z,1683053043.858 [DeadReckonWithRespectToSeafloor] Loaded
2023-05-02T18:44:03.859Z,1683053043.859 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonWithRespectToSeafloor" handled in the control thread.
2023-05-02T18:44:03.872Z,1683053043.872 [NavChart] Loaded
2023-05-02T18:44:03.872Z,1683053043.872 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2023-05-02T18:44:03.878Z,1683053043.878 [UniversalFixResidualReporter] Loaded
2023-05-02T18:44:03.878Z,1683053043.878 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2023-05-02T18:44:03.879Z,1683053043.879 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2023-05-02T18:44:03.879Z,1683053043.879 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2023-05-02T18:44:04.021Z,1683053044.021 [SBIT](DEBUG): Construct Startup Built In Test.
2023-05-02T18:44:04.030Z,1683053044.030 [SBIT] Loaded
2023-05-02T18:44:04.030Z,1683053044.030 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2023-05-02T18:44:04.033Z,1683053044.033 [IBIT](DEBUG): Construct Initiated Built In Test.
2023-05-02T18:44:04.054Z,1683053044.054 [IBIT] Loaded
2023-05-02T18:44:04.054Z,1683053044.054 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2023-05-02T18:44:04.068Z,1683053044.068 [CBIT](DEBUG): Construct Continuous Built In Test.
2023-05-02T18:44:04.207Z,1683053044.207 [CBIT] Loaded
2023-05-02T18:44:04.207Z,1683053044.207 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2023-05-02T18:44:04.207Z,1683053044.207 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2023-05-02T18:44:04.208Z,1683053044.208 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2023-05-02T18:44:04.357Z,1683053044.357 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2023-05-02T18:44:04.357Z,1683053044.357 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2023-05-02T18:44:04.488Z,1683053044.488 [BuoyancyServo] Loaded
2023-05-02T18:44:04.488Z,1683053044.488 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2023-05-02T18:44:04.509Z,1683053044.509 [ElevatorServo] Loaded
2023-05-02T18:44:04.509Z,1683053044.509 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2023-05-02T18:44:04.528Z,1683053044.528 [MassServo] Loaded
2023-05-02T18:44:04.529Z,1683053044.529 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2023-05-02T18:44:04.547Z,1683053044.547 [RudderServo] Loaded
2023-05-02T18:44:04.548Z,1683053044.548 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2023-05-02T18:44:04.562Z,1683053044.562 [ThrusterHE] Loaded
2023-05-02T18:44:04.563Z,1683053044.563 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread.
2023-05-02T18:44:04.563Z,1683053044.563 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2023-05-02T18:44:04.564Z,1683053044.564 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2023-05-02T18:44:04.699Z,1683053044.699 [Aanderaa_O2] Loaded
2023-05-02T18:44:04.700Z,1683053044.700 [ComponentRegistry](DEBUG): SyncComponent "Aanderaa_O2" handled in the control thread.
2023-05-02T18:44:04.760Z,1683053044.760 [CTD_Seabird] Loaded
2023-05-02T18:44:04.760Z,1683053044.760 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread.
2023-05-02T18:44:04.761Z,1683053044.761 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40AFC4E0
2023-05-02T18:44:04.762Z,1683053044.762 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 2076
2023-05-02T18:44:04.795Z,1683053044.795 [ESPComponent] Loaded
2023-05-02T18:44:04.795Z,1683053044.795 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread.
2023-05-02T18:44:04.815Z,1683053044.815 [PAR_Licor] Loaded
2023-05-02T18:44:04.815Z,1683053044.815 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2023-05-02T18:44:04.846Z,1683053044.846 [WetLabsBB2FL] Loaded
2023-05-02T18:44:04.847Z,1683053044.847 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2023-05-02T18:44:04.848Z,1683053044.848 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40B2C4E0
2023-05-02T18:44:04.848Z,1683053044.848 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 2077
2023-05-02T18:44:04.849Z,1683053044.849 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2023-05-02T18:44:04.849Z,1683053044.849 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2023-05-02T18:44:04.898Z,1683053044.898 [DepthRateCalculator] Loaded
2023-05-02T18:44:04.899Z,1683053044.899 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2023-05-02T18:44:04.904Z,1683053044.904 [PitchRateCalculator] Loaded
2023-05-02T18:44:04.904Z,1683053044.904 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2023-05-02T18:44:04.913Z,1683053044.913 [SpeedCalculator] Loaded
2023-05-02T18:44:04.913Z,1683053044.913 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2023-05-02T18:44:04.918Z,1683053044.918 [YawRateCalculator] Loaded
2023-05-02T18:44:04.918Z,1683053044.918 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2023-05-02T18:44:04.937Z,1683053044.937 [ElevatorOffsetCalculator] Loaded
2023-05-02T18:44:04.937Z,1683053044.937 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2023-05-02T18:44:04.938Z,1683053044.938 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2023-05-02T18:44:04.938Z,1683053044.938 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2023-05-02T18:44:05.009Z,1683053045.009 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2023-05-02T18:44:05.015Z,1683053045.015 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2023-05-02T18:44:05.018Z,1683053045.018 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2023-05-02T18:44:05.029Z,1683053045.029 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2023-05-02T18:44:05.030Z,1683053045.030 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40BAE4E0
2023-05-02T18:44:05.030Z,1683053045.030 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 2078
2023-05-02T18:44:05.035Z,1683053045.035 [Supervisor](INFO): Main Thread ID is 1985
2023-05-02T18:44:05.035Z,1683053045.035 [Supervisor](DEBUG): Running supervisor.
2023-05-02T18:44:05.036Z,1683053045.036 [CommandExec ThreadHandler](INFO): Handler Thread ID is 2079
2023-05-02T18:44:05.036Z,1683053045.036 [CommandExec](INFO): Initializing the command executive.
2023-05-02T18:44:05.038Z,1683053045.038 [CommandLine ThreadHandler](INFO): Handler Thread ID is 2080
2023-05-02T18:44:05.040Z,1683053045.040 [controlThread ThreadHandler](INFO): Handler Thread ID is 2081
2023-05-02T18:44:05.040Z,1683053045.040 [controlThread](DEBUG): Initializing ControlThread
2023-05-02T18:44:05.046Z,1683053045.046 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2023-05-02T18:44:05.048Z,1683053045.048 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2023-05-02T18:44:05.048Z,1683053045.048 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2023-05-02T18:44:05.049Z,1683053045.049 [LoopControl](DEBUG): Initialize LoopControlComponent.
2023-05-02T18:44:05.050Z,1683053045.050 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2023-05-02T18:44:05.050Z,1683053045.050 [NavChart](DEBUG): Initialize NavChart Navigation.
2023-05-02T18:44:05.051Z,1683053045.051 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2023-05-02T18:44:05.051Z,1683053045.051 [SBIT](INFO): Initialize SBIT Component.
2023-05-02T18:44:05.051Z,1683053045.051 [SBIT](IMPORTANT): git: 2023-02-15A-21-g3d3976af4
2023-05-02T18:44:05.052Z,1683053045.052 [SBIT](INFO): git hash: 3d3976af40c3333a6154de93af21df77ac8c6f9b
2023-05-02T18:44:05.052Z,1683053045.052 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2023-05-02T18:44:05.053Z,1683053045.053 [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
2023-05-02T18:44:05.054Z,1683053045.054 [SBIT](INFO): Beginning SBIT in 20.000000 seconds.
2023-05-02T18:44:05.055Z,1683053045.055 [IBIT](INFO): Initialize IBIT Component.
2023-05-02T18:44:05.056Z,1683053045.056 [CBIT](DEBUG): Initialize CBIT Component.
2023-05-02T18:44:05.057Z,1683053045.057 [logger ThreadHandler](INFO): Handler Thread ID is 2082
2023-05-02T18:44:05.068Z,1683053045.068 [CBIT](DEBUG): Initialized mux pins.
2023-05-02T18:44:05.068Z,1683053045.068 [CBIT](DEBUG): Initializing the watchdog timer.
2023-05-02T18:44:05.076Z,1683053045.076 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 2083
2023-05-02T18:44:05.077Z,1683053045.077 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2023-05-02T18:44:05.088Z,1683053045.088 [Onboard ThreadHandler](INFO): Handler Thread ID is 2084
2023-05-02T18:44:05.092Z,1683053045.092 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2023-05-02T18:44:05.093Z,1683053045.093 [CBIT](DEBUG): Initializing heartbeat.
2023-05-02T18:44:05.109Z,1683053045.109 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 2085
2023-05-02T18:44:05.124Z,1683053045.124 [DAT ThreadHandler](INFO): Handler Thread ID is 2086
2023-05-02T18:44:05.125Z,1683053045.125 [DAT](INFO): Powering up
2023-05-02T18:44:05.125Z,1683053045.125 [DAT](DEBUG): Initializing DAT.
2023-05-02T18:44:05.129Z,1683053045.129 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 2088
2023-05-02T18:44:05.130Z,1683053045.130 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2023-05-02T18:44:05.133Z,1683053045.133 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 2090
2023-05-02T18:44:05.136Z,1683053045.136 [WetLabsBB2FL](INFO): Powering up
2023-05-02T18:44:05.138Z,1683053045.138 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 2092
2023-05-02T18:44:05.141Z,1683053045.141 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2HA05M.000
2023-05-02T18:44:05.141Z,1683053045.141 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2HA05M.000
2023-05-02T18:44:05.141Z,1683053045.141 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3HA20M.000
2023-05-02T18:44:05.142Z,1683053045.142 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3HA20M.000
2023-05-02T18:44:05.142Z,1683053045.142 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4HA51M.000
2023-05-02T18:44:05.142Z,1683053045.142 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4HA51M.000
2023-05-02T18:44:05.142Z,1683053045.142 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4HA51M.000
2023-05-02T18:44:05.142Z,1683053045.142 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4HA51M.000
2023-05-02T18:44:05.142Z,1683053045.142 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5HA53M.000
2023-05-02T18:44:05.143Z,1683053045.143 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5HA53M.000
2023-05-02T18:44:05.143Z,1683053045.143 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5HA55M.000
2023-05-02T18:44:05.143Z,1683053045.143 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5HA55M.000
2023-05-02T18:44:05.164Z,1683053045.164 [CBIT](DEBUG): Deactivating GF circuits.
2023-05-02T18:44:05.164Z,1683053045.164 [CBIT](DEBUG): Deactivating emergency mode.
2023-05-02T18:44:05.200Z,1683053045.200 [CBIT](DEBUG): Backplane powered.
2023-05-02T18:44:05.204Z,1683053045.204 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2023-05-02T18:44:05.205Z,1683053045.205 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2023-05-02T18:44:05.205Z,1683053045.205 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2023-05-02T18:44:05.205Z,1683053045.205 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2023-05-02T18:44:05.206Z,1683053045.206 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2023-05-02T18:44:05.207Z,1683053045.207 [MissionManager](INFO): Loading Mission from file: Missions/Startup.xml
2023-05-02T18:44:05.221Z,1683053045.221 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2023-05-02T18:44:05.253Z,1683053045.253 [MissionManager](DEBUG):
2023-05-02T18:44:05.253Z,1683053045.253 [MissionManager](INFO): Loading Mission from file: Missions/Default.xml
2023-05-02T18:44:05.309Z,1683053045.309 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2023-05-02T18:44:05.310Z,1683053045.310 [Default:A.Wait](DEBUG): Construct Wait.
2023-05-02T18:44:05.312Z,1683053045.312 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2023-05-02T18:44:05.346Z,1683053045.346 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2023-05-02T18:44:05.357Z,1683053045.357 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2023-05-02T18:44:05.363Z,1683053045.363 [Default:E.Execute](DEBUG): Construct Execute.
2023-05-02T18:44:05.366Z,1683053045.366 [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
2023-05-02T18:44:05.375Z,1683053045.375 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,DropWeight,MultiRay,NAL9602,Power24vConverter,PNI_TCM,Aanderaa_O2,ESPComponent,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,DeadReckonUsingSpeedCalculator,DeadReckonWithRespectToSeafloor,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,Reporter,LogSplitter,
2023-05-02T18:44:05.388Z,1683053045.388 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2023-05-02T18:44:05.439Z,1683053045.439 [MultiRay](INFO): Powering up MultiRay Lights
2023-05-02T18:44:05.464Z,1683053045.464 [Power24vConverter](INFO): Powering up.
2023-05-02T18:44:05.506Z,1683053045.506 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2023-05-02T18:44:05.512Z,1683053045.512 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2023-05-02T18:44:05.513Z,1683053045.513 [ElevatorServo](DEBUG): Initializing EZServoServo.
2023-05-02T18:44:05.516Z,1683053045.516 [Radio_Surface](INFO): Powering up
2023-05-02T18:44:05.520Z,1683053045.520 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2023-05-02T18:44:05.521Z,1683053045.521 [MassServo](DEBUG): Initializing EZServoServo.
2023-05-02T18:44:05.528Z,1683053045.528 [MassServo](DEBUG): Initializing MassServo.
2023-05-02T18:44:05.529Z,1683053045.529 [RudderServo](DEBUG): Initializing EZServoServo.
2023-05-02T18:44:05.536Z,1683053045.536 [RudderServo](DEBUG): Initializing RudderServo.
2023-05-02T18:44:05.537Z,1683053045.537 [ThrusterHE](DEBUG): Initializing EZServoServo.
2023-05-02T18:44:05.544Z,1683053045.544 [ThrusterHE](DEBUG): Initializing ThrusterHE.
2023-05-02T18:44:05.837Z,1683053045.837 [DropWeight](CRITICAL): DROP WEIGHT MISSING.
2023-05-02T18:44:05.838Z,1683053045.838 [DropWeight] Hardware Fault, FailCount= 1
2023-05-02T18:44:05.838Z,1683053045.838 [DropWeight](ERROR): Hardware Fault
2023-05-02T18:44:05.939Z,1683053045.939 [CommandExec](FAULT): Scheduling is paused
2023-05-02T18:44:05.940Z,1683053045.940 [CBIT](INFO): Critical error at 20230502T184405
2023-05-02T18:44:05.940Z,1683053045.940 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals
2023-05-02T18:44:05.942Z,1683053045.942 [CBIT](ERROR): Hardware Fault in component: DropWeight
2023-05-02T18:44:05.943Z,1683053045.943 [CBIT](CRITICAL): Hardware Fault in component: DropWeight
2023-05-02T18:44:06.269Z,1683053046.269 [CBIT](INFO): Critical error at 20230502T184405
2023-05-02T18:44:08.610Z,1683053048.610 [AHRS_M2](DEBUG): boresightMatrix m[ decimal 0 0 2 2 f0.0 f0.0 f-1.0 f0.0 f-1.0 f0.0 f-1.0 f0.0 f0.0 ]m set drop
2023-05-02T18:44:09.013Z,1683053049.013 [AHRS_M2](DEBUG): chan0Format 2 set drop
2023-05-02T18:44:09.417Z,1683053049.417 [AHRS_M2](DEBUG): chan0Trigger 5 set drop
2023-05-02T18:44:09.821Z,1683053049.821 [AHRS_M2](DEBUG): chan0Enables array[ 0 15 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 ]array set drop
2023-05-02T18:44:09.821Z,1683053049.821 [AHRS_M2](DEBUG): chan0EnableBit pitch dvid@ set drop
2023-05-02T18:44:10.225Z,1683053050.225 [AHRS_M2](DEBUG): chan0EnableBit roll dvid@ set drop
2023-05-02T18:44:10.424Z,1683053050.424 [WetLabsBB2FL] Communications Fault, FailCount= 1
2023-05-02T18:44:10.424Z,1683053050.424 [WetLabsBB2FL](ERROR): Communications Fault
2023-05-02T18:44:10.629Z,1683053050.629 [AHRS_M2](DEBUG): chan0EnableBit yaw dvid@ set drop
2023-05-02T18:44:10.687Z,1683053050.687 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL
2023-05-02T18:44:10.924Z,1683053050.924 [WetLabsBB2FL](INFO): Powering down
2023-05-02T18:44:11.033Z,1683053051.033 [AHRS_M2](DEBUG): chan0EnableBit magp dvid@ set drop
2023-05-02T18:44:11.088Z,1683053051.088 [ThrusterHE](ERROR): Zero Speed Commanded.
2023-05-02T18:44:11.437Z,1683053051.437 [AHRS_M2](DEBUG): chan0EnableBit accelp dvid@ set drop
2023-05-02T18:44:11.841Z,1683053051.841 [AHRS_M2](DEBUG): chan0EnableBit gyrop dvid@ set drop
2023-05-02T18:44:11.909Z,1683053051.909 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL
2023-05-02T18:44:11.909Z,1683053051.909 [WetLabsBB2FL] No Fault, FailCount= 1
2023-05-02T18:44:12.144Z,1683053052.144 [WetLabsBB2FL](INFO): Powering up
2023-05-02T18:44:12.245Z,1683053052.245 [AHRS_M2](DEBUG): chan0EnableBit yawErrEst dvid@ set drop
2023-05-02T18:44:12.649Z,1683053052.649 [AHRS_M2](DEBUG): chan0EnableBit temperature dvid@ set drop
2023-05-02T18:44:12.654Z,1683053052.654 [PNI_TCM](FAULT): Failed to set parameters during initialization.
2023-05-02T18:44:12.654Z,1683053052.654 [PNI_TCM] Data Fault, FailCount= 1
2023-05-02T18:44:12.654Z,1683053052.654 [PNI_TCM](ERROR): Data Fault
2023-05-02T18:44:12.726Z,1683053052.726 [CBIT](ERROR): Data Fault in component: PNI_TCM
2023-05-02T18:44:13.053Z,1683053053.053 [AHRS_M2](DEBUG): chan0EnableBit magBufferActiveIndex dvid@ set drop
2023-05-02T18:44:13.057Z,1683053053.057 [PNI_TCM](INFO): Powering down
2023-05-02T18:44:13.457Z,1683053053.457 [AHRS_M2](DEBUG): chan0TriggerDivisor 40 set drop
2023-05-02T18:44:14.319Z,1683053054.319 [CBIT](INFO): Clearing failed state for component PNI_TCM
2023-05-02T18:44:14.319Z,1683053054.319 [PNI_TCM] No Fault, FailCount= 1
2023-05-02T18:44:15.148Z,1683053055.148 [CBIT](CRITICAL): Environmental Failure. Press:14.552866 PSI. Humidity:38%. Temp:26 C. ABORTING MISSION
2023-05-02T18:44:15.494Z,1683053055.494 [Aanderaa_O2](FAULT): Failed to initialize within timeout.
2023-05-02T18:44:15.494Z,1683053055.494 [Aanderaa_O2] Communications Fault, FailCount= 1
2023-05-02T18:44:15.494Z,1683053055.494 [Aanderaa_O2](ERROR): Communications Fault
2023-05-02T18:44:15.583Z,1683053055.583 [CBIT](INFO): Critical error at 20230502T184415
2023-05-02T18:44:15.585Z,1683053055.585 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2023-05-02T18:44:16.012Z,1683053056.012 [Aanderaa_O2](INFO): Powering down
2023-05-02T18:44:16.731Z,1683053056.731 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2023-05-02T18:44:16.731Z,1683053056.731 [Aanderaa_O2] No Fault, FailCount= 1
2023-05-02T18:44:17.432Z,1683053057.432 [WetLabsBB2FL] Communications Fault, FailCount= 2
2023-05-02T18:44:17.432Z,1683053057.432 [WetLabsBB2FL](ERROR): Communications Fault
2023-05-02T18:44:17.531Z,1683053057.531 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL
2023-05-02T18:44:17.936Z,1683053057.936 [WetLabsBB2FL](INFO): Powering down
2023-05-02T18:44:18.180Z,1683053058.180 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2023-05-02T18:44:18.180Z,1683053058.180 [CTD_Seabird] Communications Fault, FailCount= 1
2023-05-02T18:44:18.180Z,1683053058.180 [CTD_Seabird](ERROR): Communications Fault
2023-05-02T18:44:18.330Z,1683053058.330 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2023-05-02T18:44:18.585Z,1683053058.585 [CTD_Seabird](INFO): Powering down
2023-05-02T18:44:19.135Z,1683053059.135 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL
2023-05-02T18:44:19.135Z,1683053059.135 [WetLabsBB2FL] No Fault, FailCount= 2
2023-05-02T18:44:19.153Z,1683053059.153 [WetLabsBB2FL](INFO): Powering up
2023-05-02T18:44:19.542Z,1683053059.542 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2023-05-02T18:44:19.542Z,1683053059.542 [CTD_Seabird] No Fault, FailCount= 1
2023-05-02T18:44:19.924Z,1683053059.924 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2023-05-02T18:44:21.946Z,1683053061.946 [PNI_TCM](FAULT): Failed to set parameters during initialization.
2023-05-02T18:44:21.946Z,1683053061.946 [PNI_TCM] Data Fault, FailCount= 2
2023-05-02T18:44:21.946Z,1683053061.946 [PNI_TCM](ERROR): Data Fault
2023-05-02T18:44:21.988Z,1683053061.988 [CBIT](ERROR): Data Fault in component: PNI_TCM
2023-05-02T18:44:22.354Z,1683053062.354 [PNI_TCM](INFO): Powering down
2023-05-02T18:44:23.557Z,1683053063.557 [AHRS_M2](FAULT): Failed to acquire valid data within timeout.
2023-05-02T18:44:23.557Z,1683053063.557 [AHRS_M2] Data Fault, FailCount= 1
2023-05-02T18:44:23.557Z,1683053063.557 [AHRS_M2](ERROR): Data Fault
2023-05-02T18:44:23.593Z,1683053063.593 [CBIT](ERROR): Data Fault in component: AHRS_M2
2023-05-02T18:44:23.594Z,1683053063.594 [CBIT](CRITICAL): Data Fault in component: AHRS_M2
2023-05-02T18:44:23.594Z,1683053063.594 [CBIT](INFO): Clearing failed state for component PNI_TCM
2023-05-02T18:44:23.594Z,1683053063.594 [PNI_TCM] No Fault, FailCount= 2
2023-05-02T18:44:23.993Z,1683053063.993 [CBIT](INFO): Critical error at 20230502T184423
2023-05-02T18:44:24.444Z,1683053064.444 [WetLabsBB2FL] Communications Fault, FailCount= 3
2023-05-02T18:44:24.444Z,1683053064.444 [WetLabsBB2FL](ERROR): Communications Fault
2023-05-02T18:44:24.810Z,1683053064.810 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL
2023-05-02T18:44:24.944Z,1683053064.944 [WetLabsBB2FL](INFO): Powering down
2023-05-02T18:44:25.606Z,1683053065.606 [SBIT](IMPORTANT): Beginning Startup BIT
2023-05-02T18:44:25.610Z,1683053065.610 [CBIT](IMPORTANT): Beginning ground fault scan
2023-05-02T18:44:26.078Z,1683053066.078 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL
2023-05-02T18:44:26.078Z,1683053066.078 [WetLabsBB2FL] No Fault, FailCount= 3
2023-05-02T18:44:26.157Z,1683053066.157 [WetLabsBB2FL](INFO): Powering up
2023-05-02T18:44:27.202Z,1683053067.202 [Aanderaa_O2](FAULT): Failed to initialize within timeout.
2023-05-02T18:44:27.202Z,1683053067.202 [Aanderaa_O2] Communications Fault, FailCount= 2
2023-05-02T18:44:27.202Z,1683053067.202 [Aanderaa_O2](ERROR): Communications Fault
2023-05-02T18:44:27.337Z,1683053067.337 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2023-05-02T18:44:27.724Z,1683053067.724 [Aanderaa_O2](INFO): Powering down
2023-05-02T18:44:28.519Z,1683053068.519 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2023-05-02T18:44:28.519Z,1683053068.519 [Aanderaa_O2] No Fault, FailCount= 2
2023-05-02T18:44:31.235Z,1683053071.235 [PNI_TCM](FAULT): Failed to set parameters during initialization.
2023-05-02T18:44:31.235Z,1683053071.235 [PNI_TCM] Data Fault, FailCount= 3
2023-05-02T18:44:31.235Z,1683053071.235 [PNI_TCM](ERROR): Data Fault
2023-05-02T18:44:31.282Z,1683053071.282 [CBIT](ERROR): Data Fault in component: PNI_TCM
2023-05-02T18:44:31.456Z,1683053071.456 [WetLabsBB2FL] Communications Fault, FailCount= 4
2023-05-02T18:44:31.456Z,1683053071.456 [WetLabsBB2FL](ERROR): Communications Fault
2023-05-02T18:44:31.641Z,1683053071.641 [PNI_TCM](INFO): Powering down
2023-05-02T18:44:31.778Z,1683053071.778 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL
2023-05-02T18:44:31.956Z,1683053071.956 [WetLabsBB2FL](INFO): Powering down
2023-05-02T18:44:32.909Z,1683053072.909 [CBIT](INFO): Clearing failed state for component PNI_TCM
2023-05-02T18:44:32.909Z,1683053072.909 [PNI_TCM] No Fault, FailCount= 3
2023-05-02T18:44:32.909Z,1683053072.909 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL
2023-05-02T18:44:32.910Z,1683053072.910 [WetLabsBB2FL] No Fault, FailCount= 4
2023-05-02T18:44:32.976Z,1683053072.976 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2023-05-02T18:44:32.976Z,1683053072.976 [CTD_Seabird] Communications Fault, FailCount= 2
2023-05-02T18:44:32.976Z,1683053072.976 [CTD_Seabird](ERROR): Communications Fault
2023-05-02T18:44:33.169Z,1683053073.169 [WetLabsBB2FL](INFO): Powering up
2023-05-02T18:44:33.262Z,1683053073.262 [NAL9602](INFO): Powering up NAL9602
2023-05-02T18:44:33.315Z,1683053073.315 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2023-05-02T18:44:33.380Z,1683053073.380 [CTD_Seabird](INFO): Powering down
2023-05-02T18:44:34.525Z,1683053074.525 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2023-05-02T18:44:34.525Z,1683053074.525 [CTD_Seabird] No Fault, FailCount= 2
2023-05-02T18:44:34.724Z,1683053074.724 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2023-05-02T18:44:36.507Z,1683053076.507 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): 0.008789
CHAN A1 (24V): -0.006590
CHAN A2 (12V): -0.000023
CHAN A3 (5V): -0.001503
CHAN B0 (3.3V): -0.001066
CHAN B1 (3.15aV): -0.000926
CHAN B2 (3.15bV): -0.001365
CHAN B3 (GND): -0.001006
OPEN: 0.003726
Full Scale: +/- 1 mA
2023-05-02T18:44:38.460Z,1683053078.460 [WetLabsBB2FL] Communications Fault, FailCount= 5
2023-05-02T18:44:38.460Z,1683053078.460 [WetLabsBB2FL](ERROR): Communications Fault
2023-05-02T18:44:38.532Z,1683053078.532 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL
2023-05-02T18:44:38.532Z,1683053078.532 [CBIT](FAULT): Communications Fault in component: WetLabsBB2FL
2023-05-02T18:44:38.914Z,1683053078.914 [Aanderaa_O2](FAULT): Failed to initialize within timeout.
2023-05-02T18:44:38.914Z,1683053078.914 [Aanderaa_O2] Communications Fault, FailCount= 3
2023-05-02T18:44:38.914Z,1683053078.914 [Aanderaa_O2](ERROR): Communications Fault
2023-05-02T18:44:38.949Z,1683053078.949 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2023-05-02T18:44:38.949Z,1683053078.949 [CBIT](FAULT): Communications Fault in component: Aanderaa_O2
2023-05-02T18:44:38.960Z,1683053078.960 [WetLabsBB2FL](INFO): Powering down
2023-05-02T18:44:39.436Z,1683053079.436 [Aanderaa_O2](INFO): Powering down
2023-05-02T18:44:40.534Z,1683053080.534 [PNI_TCM](FAULT): Failed to set parameters during initialization.
2023-05-02T18:44:40.534Z,1683053080.534 [PNI_TCM] Data Fault, FailCount= 4
2023-05-02T18:44:40.534Z,1683053080.534 [PNI_TCM](ERROR): Data Fault
2023-05-02T18:44:40.600Z,1683053080.600 [CBIT](ERROR): Data Fault in component: PNI_TCM
2023-05-02T18:44:40.938Z,1683053080.938 [PNI_TCM](INFO): Powering down
2023-05-02T18:44:42.245Z,1683053082.245 [CBIT](INFO): Clearing failed state for component PNI_TCM
2023-05-02T18:44:42.245Z,1683053082.245 [PNI_TCM] No Fault, FailCount= 4
2023-05-02T18:44:44.170Z,1683053084.170 [NAL9602](INFO): NAL9602 initialized
2023-05-02T18:44:47.776Z,1683053087.776 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2023-05-02T18:44:47.776Z,1683053087.776 [CTD_Seabird] Communications Fault, FailCount= 3
2023-05-02T18:44:47.776Z,1683053087.776 [CTD_Seabird](ERROR): Communications Fault
2023-05-02T18:44:47.885Z,1683053087.885 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2023-05-02T18:44:47.885Z,1683053087.885 [CBIT](FAULT): Communications Fault in component: CTD_Seabird
2023-05-02T18:44:48.180Z,1683053088.180 [CTD_Seabird](INFO): Powering down
2023-05-02T18:44:49.822Z,1683053089.822 [PNI_TCM](FAULT): Failed to set parameters during initialization.
2023-05-02T18:44:49.822Z,1683053089.822 [PNI_TCM] Data Fault, FailCount= 5
2023-05-02T18:44:49.822Z,1683053089.822 [PNI_TCM](ERROR): Data Fault
2023-05-02T18:44:49.898Z,1683053089.898 [CBIT](ERROR): Data Fault in component: PNI_TCM
2023-05-02T18:44:49.898Z,1683053089.898 [CBIT](CRITICAL): Data Fault in component: PNI_TCM
2023-05-02T18:44:50.230Z,1683053090.230 [PNI_TCM](INFO): Powering down
2023-05-02T18:44:50.366Z,1683053090.366 [CBIT](INFO): Critical error at 20230502T184449
2023-05-02T18:45:05.368Z,1683053105.368 [DAT](FAULT): failed to initialize, no bytes available on serial interface
2023-05-02T18:45:05.368Z,1683053105.368 [DAT] Communications Fault, FailCount= 1
2023-05-02T18:45:05.368Z,1683053105.368 [DAT](ERROR): Communications Fault
2023-05-02T18:45:05.594Z,1683053105.594 [CBIT](ERROR): Communications Fault in component: DAT
2023-05-02T18:45:05.772Z,1683053105.772 [DAT](INFO): Powering down
2023-05-02T18:45:06.824Z,1683053106.824 [CBIT](INFO): Clearing failed state for component DAT
2023-05-02T18:45:06.824Z,1683053106.824 [DAT] No Fault, FailCount= 1
2023-05-02T18:45:08.820Z,1683053108.820 [DAT](INFO): Powering up
2023-05-02T18:45:08.820Z,1683053108.820 [DAT](DEBUG): Initializing DAT.
2023-05-02T18:45:19.742Z,1683053119.742 [SBIT](IMPORTANT): SBIT PASSED
2023-05-02T18:45:19.743Z,1683053119.743 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2023-05-02T18:45:19.744Z,1683053119.744 [SBIT](IMPORTANT): VerticalControl.buoyancyDefault=915 cubic_centimeter;
2023-05-02T18:45:19.744Z,1683053119.744 [SBIT](IMPORTANT): VerticalControl.buoyancyLimitLoCC=0 cubic_centimeter;
2023-05-02T18:45:20.133Z,1683053120.133 [MissionManager](IMPORTANT): Started mission Startup
2023-05-02T18:45:20.134Z,1683053120.134 [Startup] Running Loop=1
2023-05-02T18:45:20.134Z,1683053120.134 [Startup](DEBUG): Aggregate::initialize Startup
2023-05-02T18:45:20.134Z,1683053120.134 [Startup:A.GoToSurface] Running Loop=1
2023-05-02T18:45:20.134Z,1683053120.134 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2023-05-02T18:45:20.134Z,1683053120.134 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2023-05-02T18:45:20.135Z,1683053120.135 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2023-05-02T18:45:20.135Z,1683053120.135 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2023-05-02T18:45:20.136Z,1683053120.136 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2023-05-02T18:45:20.136Z,1683053120.136 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2023-05-02T18:45:20.137Z,1683053120.137 [Startup:StartupSatComms] Running Loop=1
2023-05-02T18:45:20.137Z,1683053120.137 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2023-05-02T18:45:20.137Z,1683053120.137 [Startup:StartupSatComms:A] Running Loop=1
2023-05-02T18:45:20.534Z,1683053120.534 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2023-05-02T18:46:05.400Z,1683053165.400 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2023-05-02T18:46:05.400Z,1683053165.400 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2023-05-02T18:46:05.400Z,1683053165.400 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-05-02T18:46:05.402Z,1683053165.402 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2023-05-02T18:46:05.402Z,1683053165.402 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 1
2023-05-02T18:46:05.402Z,1683053165.402 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2023-05-02T18:46:05.403Z,1683053165.403 [DeadReckonWithRespectToSeafloor](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2023-05-02T18:46:05.404Z,1683053165.404 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1
2023-05-02T18:46:05.404Z,1683053165.404 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2023-05-02T18:46:05.515Z,1683053165.515 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-05-02T18:46:05.515Z,1683053165.515 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2023-05-02T18:46:05.515Z,1683053165.515 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2023-05-02T18:46:05.865Z,1683053165.865 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-05-02T18:46:05.865Z,1683053165.865 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2023-05-02T18:46:05.865Z,1683053165.865 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2023-05-02T18:46:05.866Z,1683053165.866 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 1
2023-05-02T18:46:05.866Z,1683053165.866 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2023-05-02T18:46:05.866Z,1683053165.866 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1
2023-05-02T18:46:06.260Z,1683053166.260 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2023-05-02T18:46:08.832Z,1683053168.832 [DAT](FAULT): failed to initialize, no bytes available on serial interface
2023-05-02T18:46:08.832Z,1683053168.832 [DAT] Communications Fault, FailCount= 2
2023-05-02T18:46:08.832Z,1683053168.832 [DAT](ERROR): Communications Fault
2023-05-02T18:46:09.093Z,1683053169.093 [CBIT](ERROR): Communications Fault in component: DAT
2023-05-02T18:46:09.236Z,1683053169.236 [DAT](INFO): Powering down
2023-05-02T18:46:10.302Z,1683053170.302 [CBIT](INFO): Clearing failed state for component DAT
2023-05-02T18:46:10.302Z,1683053170.302 [DAT] No Fault, FailCount= 2
2023-05-02T18:46:12.285Z,1683053172.285 [DAT](INFO): Powering up
2023-05-02T18:46:12.286Z,1683053172.286 [DAT](DEBUG): Initializing DAT.
2023-05-02T18:46:20.354Z,1683053180.354 [Startup:StartupSatComms:A](INFO): Timed out from 2023-05-02T18:45:20.1Z
2023-05-02T18:46:20.354Z,1683053180.354 [Startup:StartupSatComms:A] Stopped
2023-05-02T18:46:20.354Z,1683053180.354 [Startup:StartupSatComms:B] Running Loop=1
2023-05-02T18:46:20.764Z,1683053180.764 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2023-05-02T18:46:47.958Z,1683053207.958 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004912
2023-05-02T18:46:55.143Z,1683053215.143 [DataOverHttps](INFO): Sending 136 bytes from file Logs/20230502T153941/Courier0055.lzma
2023-05-02T18:46:56.146Z,1683053216.146 [DataOverHttps](INFO): Moved sent file to Logs/20230502T153941/Courier0055.lzma.bak
2023-05-02T18:46:56.146Z,1683053216.146 [DataOverHttps](INFO): SBD MOMSN=18278074
2023-05-02T18:47:08.523Z,1683053228.523 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL
2023-05-02T18:47:08.523Z,1683053228.523 [WetLabsBB2FL] No Fault, FailCount= 5
2023-05-02T18:47:08.917Z,1683053228.917 [WetLabsBB2FL](INFO): Powering up
2023-05-02T18:47:09.297Z,1683053229.297 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2023-05-02T18:47:09.297Z,1683053229.297 [Aanderaa_O2] No Fault, FailCount= 3
2023-05-02T18:47:11.932Z,1683053231.932 [DataOverHttps](INFO): Sending 345 bytes from file Logs/20230502T184355/Courier0000.lzma
2023-05-02T18:47:12.344Z,1683053232.344 [DAT](FAULT): failed to initialize, no bytes available on serial interface
2023-05-02T18:47:12.344Z,1683053232.344 [DAT] Communications Fault, FailCount= 3
2023-05-02T18:47:12.344Z,1683053232.344 [DAT](ERROR): Communications Fault
2023-05-02T18:47:12.513Z,1683053232.513 [CBIT](ERROR): Communications Fault in component: DAT
2023-05-02T18:47:12.748Z,1683053232.748 [DAT](INFO): Powering down
2023-05-02T18:47:12.934Z,1683053232.934 [DataOverHttps](INFO): Moved sent file to Logs/20230502T184355/Courier0000.lzma.bak
2023-05-02T18:47:12.934Z,1683053232.934 [DataOverHttps](INFO): SBD MOMSN=18278079
2023-05-02T18:47:13.853Z,1683053233.853 [CBIT](INFO): Clearing failed state for component DAT
2023-05-02T18:47:13.853Z,1683053233.853 [DAT] No Fault, FailCount= 3
2023-05-02T18:47:14.208Z,1683053234.208 [WetLabsBB2FL] Communications Fault, FailCount= 1
2023-05-02T18:47:14.208Z,1683053234.208 [WetLabsBB2FL](ERROR): Communications Fault
2023-05-02T18:47:14.569Z,1683053234.569 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL
2023-05-02T18:47:14.708Z,1683053234.708 [WetLabsBB2FL](INFO): Powering down
2023-05-02T18:47:15.741Z,1683053235.741 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL
2023-05-02T18:47:15.741Z,1683053235.741 [WetLabsBB2FL] No Fault, FailCount= 1
2023-05-02T18:47:15.796Z,1683053235.796 [DAT](INFO): Powering up
2023-05-02T18:47:15.796Z,1683053235.796 [DAT](DEBUG): Initializing DAT.
2023-05-02T18:47:15.929Z,1683053235.929 [WetLabsBB2FL](INFO): Powering up
2023-05-02T18:47:18.189Z,1683053238.189 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2023-05-02T18:47:18.189Z,1683053238.189 [CTD_Seabird] No Fault, FailCount= 3
2023-05-02T18:47:18.216Z,1683053238.216 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2023-05-02T18:47:19.717Z,1683053239.717 [Aanderaa_O2](FAULT): Failed to initialize within timeout.
2023-05-02T18:47:19.717Z,1683053239.717 [Aanderaa_O2] Communications Fault, FailCount= 1
2023-05-02T18:47:19.717Z,1683053239.717 [Aanderaa_O2](ERROR): Communications Fault
2023-05-02T18:47:19.801Z,1683053239.801 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2023-05-02T18:47:20.232Z,1683053240.232 [Aanderaa_O2](INFO): Powering down
2023-05-02T18:47:20.526Z,1683053240.526 [Startup:StartupSatComms:B](INFO): Timed out from 2023-05-02T18:46:20.4Z
2023-05-02T18:47:20.526Z,1683053240.526 [Startup:StartupSatComms:B] Stopped
2023-05-02T18:47:20.526Z,1683053240.526 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2023-05-02T18:47:20.526Z,1683053240.526 [Startup:StartupSatComms] Stopped
2023-05-02T18:47:20.526Z,1683053240.526 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2023-05-02T18:47:20.527Z,1683053240.527 [Startup](INFO): Completed Startup
2023-05-02T18:47:20.527Z,1683053240.527 [MissionManager](INFO): Startup is completed.
2023-05-02T18:47:20.527Z,1683053240.527 [MissionManager](INFO): Uninitializing Mission Startup
2023-05-02T18:47:20.527Z,1683053240.527 [Startup] Stopped
2023-05-02T18:47:20.527Z,1683053240.527 [Startup](DEBUG): Aggregate::uninitialize Startup
2023-05-02T18:47:20.527Z,1683053240.527 [Startup:A.GoToSurface] Stopped
2023-05-02T18:47:20.527Z,1683053240.527 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2023-05-02T18:47:20.930Z,1683053240.930 [MissionManager](IMPORTANT): Started mission Default
2023-05-02T18:47:20.930Z,1683053240.930 [Default] Running Loop=1
2023-05-02T18:47:20.930Z,1683053240.930 [Default](DEBUG): Aggregate::initialize Default
2023-05-02T18:47:20.930Z,1683053240.930 [Default:B.GoToSurface] Running Loop=1
2023-05-02T18:47:20.930Z,1683053240.930 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2023-05-02T18:47:20.930Z,1683053240.930 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2023-05-02T18:47:20.931Z,1683053240.931 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2023-05-02T18:47:20.931Z,1683053240.931 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2023-05-02T18:47:20.931Z,1683053240.931 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2023-05-02T18:47:20.932Z,1683053240.932 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2023-05-02T18:47:20.932Z,1683053240.932 [Default:A.Wait] Running Loop=1
2023-05-02T18:47:20.932Z,1683053240.932 [Default:A.Wait](DEBUG): Initialize Wait Component.
2023-05-02T18:47:20.994Z,1683053240.994 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2023-05-02T18:47:20.994Z,1683053240.994 [Aanderaa_O2] No Fault, FailCount= 1
2023-05-02T18:47:21.220Z,1683053241.220 [WetLabsBB2FL] Communications Fault, FailCount= 2
2023-05-02T18:47:21.220Z,1683053241.220 [WetLabsBB2FL](ERROR): Communications Fault
2023-05-02T18:47:21.405Z,1683053241.405 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL
2023-05-02T18:47:21.721Z,1683053241.721 [WetLabsBB2FL](INFO): Powering down
2023-05-02T18:47:22.609Z,1683053242.609 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL
2023-05-02T18:47:22.609Z,1683053242.609 [WetLabsBB2FL] No Fault, FailCount= 2
2023-05-02T18:47:22.933Z,1683053242.933 [WetLabsBB2FL](INFO): Powering up
2023-05-02T18:47:28.224Z,1683053248.224 [WetLabsBB2FL] Communications Fault, FailCount= 3
2023-05-02T18:47:28.224Z,1683053248.224 [WetLabsBB2FL](ERROR): Communications Fault
2023-05-02T18:47:28.309Z,1683053248.309 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL
2023-05-02T18:47:28.667Z,1683053248.667 [DataOverHttps](INFO): Sending 513 bytes from file Logs/20230502T153941/Express0056.lzma
2023-05-02T18:47:28.724Z,1683053248.724 [WetLabsBB2FL](INFO): Powering down
2023-05-02T18:47:29.658Z,1683053249.658 [DataOverHttps](INFO): Moved sent file to Logs/20230502T153941/Express0056.lzma.bak
2023-05-02T18:47:29.658Z,1683053249.658 [DataOverHttps](INFO): SBD MOMSN=18278087
2023-05-02T18:47:29.899Z,1683053249.899 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL
2023-05-02T18:47:29.899Z,1683053249.899 [WetLabsBB2FL] No Fault, FailCount= 3
2023-05-02T18:47:29.937Z,1683053249.937 [WetLabsBB2FL](INFO): Powering up
2023-05-02T18:47:31.300Z,1683053251.300 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2023-05-02T18:47:31.300Z,1683053251.300 [CTD_Seabird] Communications Fault, FailCount= 1
2023-05-02T18:47:31.300Z,1683053251.300 [CTD_Seabird](ERROR): Communications Fault
2023-05-02T18:47:31.423Z,1683053251.423 [Aanderaa_O2](FAULT): Failed to initialize within timeout.
2023-05-02T18:47:31.423Z,1683053251.423 [Aanderaa_O2] Communications Fault, FailCount= 2
2023-05-02T18:47:31.423Z,1683053251.423 [Aanderaa_O2](ERROR): Communications Fault
2023-05-02T18:47:31.510Z,1683053251.510 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2023-05-02T18:47:31.510Z,1683053251.510 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2023-05-02T18:47:31.705Z,1683053251.705 [CTD_Seabird](INFO): Powering down
2023-05-02T18:47:31.948Z,1683053251.948 [Aanderaa_O2](INFO): Powering down
2023-05-02T18:47:32.710Z,1683053252.710 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2023-05-02T18:47:32.710Z,1683053252.710 [Aanderaa_O2] No Fault, FailCount= 2
2023-05-02T18:47:32.711Z,1683053252.711 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2023-05-02T18:47:32.711Z,1683053252.711 [CTD_Seabird] No Fault, FailCount= 1
2023-05-02T18:47:33.052Z,1683053253.052 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2023-05-02T18:47:34.290Z,1683053254.290 [Default:A.Wait](INFO): Done Waiting.
2023-05-02T18:47:34.290Z,1683053254.290 [Default:A.Wait] Stopped
2023-05-02T18:47:34.290Z,1683053254.290 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2023-05-02T18:47:34.681Z,1683053254.681 [Default:CheckIn] Running Loop=1
2023-05-02T18:47:34.681Z,1683053254.681 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2023-05-02T18:47:34.681Z,1683053254.681 [Default:CheckIn:Read_GPS] Running Loop=1
2023-05-02T18:47:35.084Z,1683053255.084 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2023-05-02T18:47:35.236Z,1683053255.236 [WetLabsBB2FL] Communications Fault, FailCount= 4
2023-05-02T18:47:35.236Z,1683053255.236 [WetLabsBB2FL](ERROR): Communications Fault
2023-05-02T18:47:35.557Z,1683053255.557 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL
2023-05-02T18:47:35.736Z,1683053255.736 [WetLabsBB2FL](INFO): Powering down
2023-05-02T18:47:36.753Z,1683053256.753 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL
2023-05-02T18:47:36.753Z,1683053256.753 [WetLabsBB2FL] No Fault, FailCount= 4
2023-05-02T18:47:36.949Z,1683053256.949 [WetLabsBB2FL](INFO): Powering up
2023-05-02T18:47:42.240Z,1683053262.240 [WetLabsBB2FL] Communications Fault, FailCount= 5
2023-05-02T18:47:42.240Z,1683053262.240 [WetLabsBB2FL](ERROR): Communications Fault
2023-05-02T18:47:42.397Z,1683053262.397 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL
2023-05-02T18:47:42.397Z,1683053262.397 [CBIT](FAULT): Communications Fault in component: WetLabsBB2FL
2023-05-02T18:47:42.740Z,1683053262.740 [WetLabsBB2FL](INFO): Powering down
2023-05-02T18:47:43.142Z,1683053263.142 [Aanderaa_O2](FAULT): Failed to initialize within timeout.
2023-05-02T18:47:43.142Z,1683053263.142 [Aanderaa_O2] Communications Fault, FailCount= 3
2023-05-02T18:47:43.142Z,1683053263.142 [Aanderaa_O2](ERROR): Communications Fault
2023-05-02T18:47:43.214Z,1683053263.214 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2023-05-02T18:47:43.215Z,1683053263.215 [CBIT](FAULT): Communications Fault in component: Aanderaa_O2
2023-05-02T18:47:43.660Z,1683053263.660 [Aanderaa_O2](INFO): Powering down
2023-05-02T18:47:46.112Z,1683053266.112 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2023-05-02T18:47:46.112Z,1683053266.112 [CTD_Seabird] Communications Fault, FailCount= 2
2023-05-02T18:47:46.112Z,1683053266.112 [CTD_Seabird](ERROR): Communications Fault
2023-05-02T18:47:46.437Z,1683053266.437 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2023-05-02T18:47:46.516Z,1683053266.516 [CTD_Seabird](INFO): Powering down
2023-05-02T18:47:47.649Z,1683053267.649 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2023-05-02T18:47:47.649Z,1683053267.649 [CTD_Seabird] No Fault, FailCount= 2
2023-05-02T18:47:47.856Z,1683053267.856 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2023-05-02T18:48:00.908Z,1683053280.908 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2023-05-02T18:48:00.908Z,1683053280.908 [CTD_Seabird] Communications Fault, FailCount= 3
2023-05-02T18:48:00.908Z,1683053280.908 [CTD_Seabird](ERROR): Communications Fault
2023-05-02T18:48:01.001Z,1683053281.001 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2023-05-02T18:48:01.001Z,1683053281.001 [CBIT](FAULT): Communications Fault in component: CTD_Seabird
2023-05-02T18:48:01.312Z,1683053281.312 [CTD_Seabird](INFO): Powering down
2023-05-02T18:48:06.601Z,1683053286.601 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2023-05-02T18:48:06.601Z,1683053286.601 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2
2023-05-02T18:48:06.601Z,1683053286.601 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-05-02T18:48:06.602Z,1683053286.602 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2023-05-02T18:48:06.602Z,1683053286.602 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 2
2023-05-02T18:48:06.602Z,1683053286.602 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2023-05-02T18:48:06.604Z,1683053286.604 [DeadReckonWithRespectToSeafloor](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2023-05-02T18:48:06.604Z,1683053286.604 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 2
2023-05-02T18:48:06.604Z,1683053286.604 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2023-05-02T18:48:06.675Z,1683053286.675 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-05-02T18:48:06.675Z,1683053286.675 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2023-05-02T18:48:06.676Z,1683053286.676 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2023-05-02T18:48:07.058Z,1683053287.058 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-05-02T18:48:07.058Z,1683053287.058 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2
2023-05-02T18:48:07.059Z,1683053287.059 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2023-05-02T18:48:07.059Z,1683053287.059 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 2
2023-05-02T18:48:07.059Z,1683053287.059 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2023-05-02T18:48:07.059Z,1683053287.059 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 2
2023-05-02T18:48:07.499Z,1683053287.499 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2023-05-02T18:48:15.828Z,1683053295.828 [DAT](FAULT): failed to initialize, no bytes available on serial interface
2023-05-02T18:48:15.828Z,1683053295.828 [DAT] Communications Fault, FailCount= 4
2023-05-02T18:48:15.828Z,1683053295.828 [DAT](ERROR): Communications Fault
2023-05-02T18:48:15.957Z,1683053295.957 [CBIT](ERROR): Communications Fault in component: DAT
2023-05-02T18:48:16.232Z,1683053296.232 [DAT](INFO): Powering down
2023-05-02T18:48:17.166Z,1683053297.166 [CBIT](INFO): Clearing failed state for component DAT
2023-05-02T18:48:17.166Z,1683053297.166 [DAT] No Fault, FailCount= 4
2023-05-02T18:48:19.296Z,1683053299.296 [DAT](INFO): Powering up
2023-05-02T18:48:19.296Z,1683053299.296 [DAT](DEBUG): Initializing DAT.
2023-05-02T18:49:19.304Z,1683053359.304 [DAT](FAULT): failed to initialize, no bytes available on serial interface
2023-05-02T18:49:19.304Z,1683053359.304 [DAT] Communications Fault, FailCount= 5
2023-05-02T18:49:19.304Z,1683053359.304 [DAT](ERROR): Communications Fault
2023-05-02T18:49:19.401Z,1683053359.401 [CBIT](ERROR): Communications Fault in component: DAT
2023-05-02T18:49:19.708Z,1683053359.708 [DAT](INFO): Powering down
2023-05-02T18:49:20.985Z,1683053360.985 [CBIT](INFO): Clearing failed state for component DAT
2023-05-02T18:49:20.985Z,1683053360.985 [DAT] No Fault, FailCount= 5
2023-05-02T18:49:22.756Z,1683053362.756 [DAT](INFO): Powering up
2023-05-02T18:49:22.757Z,1683053362.757 [DAT](DEBUG): Initializing DAT.
2023-05-02T18:49:27.365Z,1683053367.365 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2023-05-02T18:49:28.577Z,1683053368.577 [BPC1](ERROR): BPC1A got IPBS message with 5 sticks (min is 7).
2023-05-02T18:49:31.621Z,1683053371.621 [CommandExec](IMPORTANT): got command quit
2023-05-02T18:49:32.624Z,1683053372.624 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread.
2023-05-02T18:49:32.624Z,1683053372.624 [CommandExec](INFO): Uninitializing the command executive.
2023-05-02T18:49:32.624Z,1683053372.624 [CommandExec](INFO): Uninitializing the command scheduler.
2023-05-02T18:49:32.624Z,1683053372.624 [CommandExec ThreadHandler](INFO): Thread cancelled.
2023-05-02T18:49:32.716Z,1683053372.716 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye!
2023-05-02T18:49:32.716Z,1683053372.716 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2023-05-02T18:49:32.716Z,1683053372.716 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2023-05-02T18:49:32.717Z,1683053372.717 [NavChartDb](INFO): Join timeout helper Thread ID is 2140
2023-05-02T18:49:32.892Z,1683053372.892 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2023-05-02T18:49:32.892Z,1683053372.892 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2023-05-02T18:49:32.896Z,1683053372.896 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2023-05-02T18:49:32.896Z,1683053372.896 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2023-05-02T18:49:32.896Z,1683053372.896 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 2141
2023-05-02T18:49:33.148Z,1683053373.148 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread.
2023-05-02T18:49:33.148Z,1683053373.148 [WetLabsBB2FL](INFO): Powering down
2023-05-02T18:49:33.149Z,1683053373.149 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2023-05-02T18:49:33.160Z,1683053373.160 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler
2023-05-02T18:49:33.160Z,1683053373.160 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2023-05-02T18:49:33.160Z,1683053373.160 [CTD_Seabird](INFO): Join timeout helper Thread ID is 2142
2023-05-02T18:49:33.556Z,1683053373.556 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread.
2023-05-02T18:49:33.556Z,1683053373.556 [CTD_Seabird](INFO): Powering down
2023-05-02T18:49:33.568Z,1683053373.568 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2023-05-02T18:49:33.580Z,1683053373.580 [ComponentRegistry](INFO): Shutting down DAT ThreadHandler
2023-05-02T18:49:33.580Z,1683053373.580 [DAT ThreadHandler](INFO): Thread cancelled.
2023-05-02T18:49:33.580Z,1683053373.580 [DAT](INFO): Join timeout helper Thread ID is 2143
2023-05-02T18:49:33.604Z,1683053373.604 [DAT](INFO): Powering down
2023-05-02T18:49:33.676Z,1683053373.676 [DAT ThreadHandler](INFO): Uninitializing protected caller thread.
2023-05-02T18:49:33.676Z,1683053373.676 [DAT](INFO): Powering down
2023-05-02T18:49:33.677Z,1683053373.677 [DAT ThreadHandler](INFO): Thread cancelled.
2023-05-02T18:49:33.684Z,1683053373.684 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2023-05-02T18:49:33.684Z,1683053373.684 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2023-05-02T18:49:33.684Z,1683053373.684 [Radio_Surface](INFO): Join timeout helper Thread ID is 2144
2023-05-02T18:49:34.004Z,1683053374.004 [Radio_Surface](INFO): Powering down
2023-05-02T18:49:34.005Z,1683053374.005 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2023-05-02T18:49:34.005Z,1683053374.005 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2023-05-02T18:49:34.025Z,1683053374.025 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler
2023-05-02T18:49:34.025Z,1683053374.025 [Onboard ThreadHandler](INFO): Thread cancelled.
2023-05-02T18:49:34.025Z,1683053374.025 [Onboard](INFO): Join timeout helper Thread ID is 2145
2023-05-02T18:49:34.064Z,1683053374.064 [DataOverHttps](INFO): Radio surface powered OFF, will not connect.
2023-05-02T18:49:34.233Z,1683053374.233 [BPC1](ERROR): BPC1A got IPBS message with 5 sticks (min is 7).
2023-05-02T18:49:35.356Z,1683053375.356 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread.
2023-05-02T18:49:35.356Z,1683053375.356 [Onboard ThreadHandler](INFO): Thread cancelled.
2023-05-02T18:49:35.364Z,1683053375.364 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler
2023-05-02T18:49:35.365Z,1683053375.365 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2023-05-02T18:49:35.365Z,1683053375.365 [DataOverHttps](INFO): Join timeout helper Thread ID is 2146
2023-05-02T18:49:36.072Z,1683053376.072 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread.
2023-05-02T18:49:36.072Z,1683053376.072 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2023-05-02T18:49:36.077Z,1683053376.077 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2023-05-02T18:49:36.077Z,1683053376.077 [logger ThreadHandler](INFO): Thread cancelled.
2023-05-02T18:49:36.077Z,1683053376.077 [logger](INFO): Join timeout helper Thread ID is 2147
2023-05-02T18:49:36.100Z,1683053376.100 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2023-05-02T18:49:36.100Z,1683053376.100 [logger ThreadHandler](INFO): Thread cancelled.
2023-05-02T18:49:36.116Z,1683053376.116 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2023-05-02T18:49:36.117Z,1683053376.117 [CommandLine ThreadHandler](INFO): Thread cancelled.
2023-05-02T18:49:36.117Z,1683053376.117 [CommandLine](INFO): Join timeout helper Thread ID is 2148
2023-05-02T18:49:36.156Z,1683053376.156 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2023-05-02T18:49:36.156Z,1683053376.156 [CommandLine ThreadHandler](INFO): Thread cancelled.
2023-05-02T18:49:36.176Z,1683053376.176 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler
2023-05-02T18:49:36.177Z,1683053376.177 [CommandExec ThreadHandler](INFO): Thread cancelled.
2023-05-02T18:49:36.177Z,1683053376.177 [CommandExec](INFO): Join timeout helper Thread ID is 2149
2023-05-02T18:49:36.178Z,1683053376.178 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2023-05-02T18:49:36.178Z,1683053376.178 [controlThread ThreadHandler](INFO): Thread cancelled.
2023-05-02T18:49:36.179Z,1683053376.179 [controlThread](INFO): Join timeout helper Thread ID is 2150
2023-05-02T18:49:36.248Z,1683053376.248 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2023-05-02T18:49:36.248Z,1683053376.248 [controlThread](DEBUG): Uninitializing ControlThread
2023-05-02T18:49:36.250Z,1683053376.250 [MultiRay](INFO): Powering down.
2023-05-02T18:49:36.251Z,1683053376.251 [NAL9602](INFO): Powering down
2023-05-02T18:49:36.252Z,1683053376.252 [PNI_TCM](INFO): Powering down
2023-05-02T18:49:36.253Z,1683053376.253 [Aanderaa_O2](INFO): Powering down
2023-05-02T18:49:36.255Z,1683053376.255 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2023-05-02T18:49:36.256Z,1683053376.256 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2023-05-02T18:49:36.256Z,1683053376.256 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2023-05-02T18:49:36.257Z,1683053376.257 [MissionManager](INFO): Uninitializing Mission Default
2023-05-02T18:49:36.257Z,1683053376.257 [Default] Stopped
2023-05-02T18:49:36.257Z,1683053376.257 [Default](DEBUG): Aggregate::uninitialize Default
2023-05-02T18:49:36.257Z,1683053376.257 [Default:B.GoToSurface] Stopped
2023-05-02T18:49:36.257Z,1683053376.257 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2023-05-02T18:49:36.257Z,1683053376.257 [Default:CheckIn] Stopped
2023-05-02T18:49:36.257Z,1683053376.257 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2023-05-02T18:49:36.257Z,1683053376.257 [Default:CheckIn:Read_GPS] Stopped
2023-05-02T18:49:36.260Z,1683053376.260 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2023-05-02T18:49:36.260Z,1683053376.260 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2023-05-02T18:49:36.260Z,1683053376.260 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2023-05-02T18:49:36.261Z,1683053376.261 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2023-05-02T18:49:36.261Z,1683053376.261 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2023-05-02T18:49:36.261Z,1683053376.261 [BuoyancyServo](INFO): Powering down
2023-05-02T18:49:36.392Z,1683053376.392 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2023-05-02T18:49:36.392Z,1683053376.392 [ElevatorServo](INFO): Powering down
2023-05-02T18:49:36.393Z,1683053376.393 [MassServo](DEBUG): Uninitialize Mass Servo.
2023-05-02T18:49:36.393Z,1683053376.393 [MassServo](INFO): Powering down
2023-05-02T18:49:36.394Z,1683053376.394 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2023-05-02T18:49:36.394Z,1683053376.394 [RudderServo](INFO): Powering down
2023-05-02T18:49:36.395Z,1683053376.395 [ThrusterHE](DEBUG): Uninitialize Thruster Servo.
2023-05-02T18:49:36.395Z,1683053376.395 [ThrusterHE](INFO): Powering down
2023-05-02T18:49:36.396Z,1683053376.396 [SBIT](DEBUG): Uninitialize SBIT Component.
2023-05-02T18:49:36.396Z,1683053376.396 [IBIT](DEBUG): Uninitialize IBIT Component.
2023-05-02T18:49:36.397Z,1683053376.397 [CBIT](DEBUG): Uninitialize CBIT Component.
2023-05-02T18:49:36.397Z,1683053376.397 [CBIT](DEBUG): Powering off loads.
2023-05-02T18:49:36.408Z,1683053376.408 [CBIT](DEBUG): Disabling WDT.
2023-05-02T18:49:36.420Z,1683053376.420 [CBIT](DEBUG): Opening all GF detection circuits.
2023-05-02T18:49:36.421Z,1683053376.421 [controlThread ThreadHandler](INFO): Thread cancelled.
2023-05-02T18:49:36.451Z,1683053376.451 [DAT ThreadHandler](INFO): Thread cancelled.
2023-05-02T18:49:36.456Z,1683053376.456 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2023-05-02T18:49:36.459Z,1683053376.459 [Onboard ThreadHandler](INFO): Thread cancelled.
2023-05-02T18:49:36.466Z,1683053376.466 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2023-05-02T18:49:36.590Z,1683053376.590 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2023-05-02T18:49:36.594Z,1683053376.594 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2023-05-02T18:49:36.613Z,1683053376.613 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2023-05-02T18:49:36.657Z,1683053376.657 [logger ThreadHandler](INFO): Thread cancelled.