2020-08-31T18:21:51.136Z,1598898111.136 [Supervisor](DEBUG): Initializing supervisor.
2020-08-31T18:21:51.149Z,1598898111.149 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2020-08-31T18:21:51.150Z,1598898111.150 [SyncHandler](INFO): Protected caller Thread ID is 1138
2020-08-31T18:21:51.150Z,1598898111.150 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2020-08-31T18:21:51.157Z,1598898111.157 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2020-08-31T18:21:51.158Z,1598898111.158 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 1139
2020-08-31T18:21:51.160Z,1598898111.160 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2020-08-31T18:21:51.188Z,1598898111.188 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2020-08-31T18:21:51.202Z,1598898111.202 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2020-08-31T18:21:51.204Z,1598898111.204 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 1140
2020-08-31T18:21:51.206Z,1598898111.206 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2020-08-31T18:21:51.219Z,1598898111.219 [logger ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2020-08-31T18:21:51.220Z,1598898111.220 [logger ThreadHandler](INFO): Protected caller Thread ID is 1141
2020-08-31T18:21:51.234Z,1598898111.234 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2020-08-31T18:21:51.235Z,1598898111.235 [Supervisor](INFO): Looking for Config files in directory: Config/
2020-08-31T18:21:51.242Z,1598898111.242 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2020-08-31T18:21:51.496Z,1598898111.496 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2020-08-31T18:21:51.496Z,1598898111.496 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2020-08-31T18:21:53.071Z,1598898113.071 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2020-08-31T18:21:53.072Z,1598898113.072 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg
2020-08-31T18:21:53.582Z,1598898113.582 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock
2020-08-31T18:21:53.582Z,1598898113.582 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2020-08-31T18:21:53.763Z,1598898113.763 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample
2020-08-31T18:21:53.764Z,1598898113.764 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2020-08-31T18:21:54.026Z,1598898114.026 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2020-08-31T18:21:54.026Z,1598898114.026 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2020-08-31T18:21:54.238Z,1598898114.238 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2020-08-31T18:21:54.550Z,1598898114.550 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2020-08-31T18:21:54.551Z,1598898114.551 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2020-08-31T18:21:55.287Z,1598898115.287 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2020-08-31T18:21:55.288Z,1598898115.288 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2020-08-31T18:21:56.693Z,1598898116.693 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2020-08-31T18:21:56.694Z,1598898116.694 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2020-08-31T18:21:57.098Z,1598898117.098 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2020-08-31T18:21:57.098Z,1598898117.098 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2020-08-31T18:21:57.603Z,1598898117.603 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2020-08-31T18:21:57.603Z,1598898117.603 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2020-08-31T18:21:58.170Z,1598898118.170 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2020-08-31T18:21:58.170Z,1598898118.170 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2020-08-31T18:21:58.462Z,1598898118.462 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2020-08-31T18:21:58.463Z,1598898118.463 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2020-08-31T18:21:58.757Z,1598898118.757 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2020-08-31T18:21:58.758Z,1598898118.758 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2020-08-31T18:21:59.278Z,1598898119.278 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2020-08-31T18:21:59.279Z,1598898119.279 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2020-08-31T18:21:59.692Z,1598898119.692 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2020-08-31T18:21:59.694Z,1598898119.694 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-pontus/
2020-08-31T18:21:59.695Z,1598898119.695 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/secure.cfg
2020-08-31T18:21:59.789Z,1598898119.789 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Sensor.cfg
2020-08-31T18:22:00.102Z,1598898120.102 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Servo.cfg
2020-08-31T18:22:00.264Z,1598898120.264 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Simulator.cfg
2020-08-31T18:22:00.424Z,1598898120.424 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/logger.cfg
2020-08-31T18:22:00.524Z,1598898120.524 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/vehicle.cfg
2020-08-31T18:22:00.800Z,1598898120.800 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Battery.cfg
2020-08-31T18:22:01.039Z,1598898121.039 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2020-08-31T18:22:01.040Z,1598898121.040 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Navigation.cfg
2020-08-31T18:22:01.236Z,1598898121.236 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/BIT.cfg
2020-08-31T18:22:01.342Z,1598898121.342 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Science.cfg
2020-08-31T18:22:01.571Z,1598898121.571 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Control.cfg
2020-08-31T18:22:01.735Z,1598898121.735 [Supervisor](FAULT): Ignoring configuration overrides from Data/persisted.cfg
2020-08-31T18:22:01.737Z,1598898121.737 [Module Loader](DEBUG): Loading Module at Modules/Dock.so
2020-08-31T18:22:01.818Z,1598898121.818 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking)
2020-08-31T18:22:01.819Z,1598898121.819 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2020-08-31T18:22:02.117Z,1598898122.117 [VerticalControl](DEBUG): Construct VerticalControl.
2020-08-31T18:22:02.580Z,1598898122.580 [VerticalControl] Loaded
2020-08-31T18:22:02.580Z,1598898122.580 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2020-08-31T18:22:02.581Z,1598898122.581 [HorizontalControl](DEBUG): Construct HorizontalControl.
2020-08-31T18:22:02.706Z,1598898122.706 [HorizontalControl] Loaded
2020-08-31T18:22:02.706Z,1598898122.706 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2020-08-31T18:22:02.707Z,1598898122.707 [SpeedControl](DEBUG): Construct SpeedControl.
2020-08-31T18:22:02.712Z,1598898122.712 [SpeedControl] Loaded
2020-08-31T18:22:02.713Z,1598898122.713 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2020-08-31T18:22:02.730Z,1598898122.730 [LoopControl](DEBUG): Construct LoopControl.
2020-08-31T18:22:02.730Z,1598898122.730 [LoopControl] Loaded
2020-08-31T18:22:02.730Z,1598898122.730 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2020-08-31T18:22:02.731Z,1598898122.731 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2020-08-31T18:22:02.731Z,1598898122.731 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2020-08-31T18:22:02.775Z,1598898122.775 [DepthRateCalculator] Loaded
2020-08-31T18:22:02.775Z,1598898122.775 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2020-08-31T18:22:02.781Z,1598898122.781 [PitchRateCalculator] Loaded
2020-08-31T18:22:02.781Z,1598898122.781 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2020-08-31T18:22:02.796Z,1598898122.796 [SpeedCalculator] Loaded
2020-08-31T18:22:02.796Z,1598898122.796 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2020-08-31T18:22:02.820Z,1598898122.820 [TempGradientCalculator] Loaded
2020-08-31T18:22:02.820Z,1598898122.820 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread.
2020-08-31T18:22:02.825Z,1598898122.825 [YawRateCalculator] Loaded
2020-08-31T18:22:02.825Z,1598898122.825 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2020-08-31T18:22:02.858Z,1598898122.858 [ElevatorOffsetCalculator] Loaded
2020-08-31T18:22:02.859Z,1598898122.859 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2020-08-31T18:22:02.859Z,1598898122.859 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2020-08-31T18:22:02.859Z,1598898122.859 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2020-08-31T18:22:02.886Z,1598898122.886 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2020-08-31T18:22:02.886Z,1598898122.886 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2020-08-31T18:22:02.970Z,1598898122.970 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2020-08-31T18:22:02.970Z,1598898122.970 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2020-08-31T18:22:03.342Z,1598898123.342 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2020-08-31T18:22:03.342Z,1598898123.342 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2020-08-31T18:22:03.434Z,1598898123.434 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2020-08-31T18:22:03.434Z,1598898123.434 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2020-08-31T18:22:03.824Z,1598898123.824 [AHRS_M2](DEBUG): LcmSlateWriter::add(): platform_orientation
2020-08-31T18:22:03.828Z,1598898123.828 [AHRS_M2](INFO): created writer for : platform_orientation
2020-08-31T18:22:03.830Z,1598898123.830 [AHRS_M2](DEBUG): LcmSlateWriter::add(): platform_magnetic_orientation
2020-08-31T18:22:03.840Z,1598898123.840 [AHRS_M2](INFO): created writer for : platform_magnetic_orientation
2020-08-31T18:22:03.840Z,1598898123.840 [AHRS_M2](DEBUG): LcmSlateWriter::add(): platform_pitch_angle
2020-08-31T18:22:03.845Z,1598898123.845 [AHRS_M2](INFO): created writer for : platform_pitch_angle
2020-08-31T18:22:03.846Z,1598898123.846 [AHRS_M2](DEBUG): LcmSlateWriter::add(): platform_roll_angle
2020-08-31T18:22:03.851Z,1598898123.851 [AHRS_M2](INFO): created writer for : platform_roll_angle
2020-08-31T18:22:03.976Z,1598898123.976 [AHRS_M2] Loaded
2020-08-31T18:22:03.976Z,1598898123.976 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread.
2020-08-31T18:22:04.058Z,1598898124.058 [DataOverHttps] Loaded
2020-08-31T18:22:04.058Z,1598898124.058 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2020-08-31T18:22:04.059Z,1598898124.059 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 4090D4E0
2020-08-31T18:22:04.060Z,1598898124.060 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 1223
2020-08-31T18:22:04.091Z,1598898124.091 [Depth_Keller] Loaded
2020-08-31T18:22:04.091Z,1598898124.091 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2020-08-31T18:22:04.096Z,1598898124.096 [DropWeight] Loaded
2020-08-31T18:22:04.096Z,1598898124.096 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2020-08-31T18:22:04.250Z,1598898124.250 [NAL9602] Loaded
2020-08-31T18:22:04.250Z,1598898124.250 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2020-08-31T18:22:04.364Z,1598898124.364 [Onboard] Loaded
2020-08-31T18:22:04.364Z,1598898124.364 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread.
2020-08-31T18:22:04.377Z,1598898124.377 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 4093D4E0
2020-08-31T18:22:04.378Z,1598898124.378 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 1224
2020-08-31T18:22:04.398Z,1598898124.398 [Radio_Surface] Loaded
2020-08-31T18:22:04.398Z,1598898124.398 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2020-08-31T18:22:04.399Z,1598898124.399 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 4096D4E0
2020-08-31T18:22:04.399Z,1598898124.399 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 1225
2020-08-31T18:22:04.463Z,1598898124.463 [RDI_Pathfinder] Loaded
2020-08-31T18:22:04.463Z,1598898124.463 [ComponentRegistry](DEBUG): SyncComponent "RDI_Pathfinder" handled in the control thread.
2020-08-31T18:22:04.611Z,1598898124.611 [DAT] Loaded
2020-08-31T18:22:04.611Z,1598898124.611 [ComponentRegistry](DEBUG): SyncComponent "DAT" handled in the control thread.
2020-08-31T18:22:06.592Z,1598898126.592 [BPC1] Loaded
2020-08-31T18:22:06.592Z,1598898126.592 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2020-08-31T18:22:06.630Z,1598898126.630 [AMEcho] Loaded
2020-08-31T18:22:06.630Z,1598898126.630 [ComponentRegistry](DEBUG): SyncComponent "AMEcho" handled in the control thread.
2020-08-31T18:22:06.631Z,1598898126.631 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2020-08-31T18:22:06.631Z,1598898126.631 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2020-08-31T18:22:06.857Z,1598898126.857 [DeadReckonUsingMultipleVelocitySources] Loaded
2020-08-31T18:22:06.857Z,1598898126.857 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2020-08-31T18:22:06.878Z,1598898126.878 [NavChart] Loaded
2020-08-31T18:22:06.878Z,1598898126.878 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2020-08-31T18:22:06.884Z,1598898126.884 [UniversalFixResidualReporter] Loaded
2020-08-31T18:22:06.884Z,1598898126.884 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2020-08-31T18:22:06.885Z,1598898126.885 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2020-08-31T18:22:06.886Z,1598898126.886 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2020-08-31T18:22:07.017Z,1598898127.017 [SBIT](DEBUG): Construct Startup Built In Test.
2020-08-31T18:22:07.028Z,1598898127.028 [SBIT] Loaded
2020-08-31T18:22:07.028Z,1598898127.028 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2020-08-31T18:22:07.029Z,1598898127.029 [IBIT](DEBUG): Construct Initiated Built In Test.
2020-08-31T18:22:07.042Z,1598898127.042 [IBIT] Loaded
2020-08-31T18:22:07.042Z,1598898127.042 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2020-08-31T18:22:07.046Z,1598898127.046 [CBIT](DEBUG): Construct Continuous Built In Test.
2020-08-31T18:22:07.238Z,1598898127.238 [CBIT] Loaded
2020-08-31T18:22:07.239Z,1598898127.239 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2020-08-31T18:22:07.239Z,1598898127.239 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2020-08-31T18:22:07.240Z,1598898127.240 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2020-08-31T18:22:07.363Z,1598898127.363 [BuoyancyServo] Loaded
2020-08-31T18:22:07.363Z,1598898127.363 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2020-08-31T18:22:07.397Z,1598898127.397 [ElevatorServo] Loaded
2020-08-31T18:22:07.397Z,1598898127.397 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2020-08-31T18:22:07.427Z,1598898127.427 [MassServo] Loaded
2020-08-31T18:22:07.427Z,1598898127.427 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2020-08-31T18:22:07.455Z,1598898127.455 [RudderServo] Loaded
2020-08-31T18:22:07.456Z,1598898127.456 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2020-08-31T18:22:07.482Z,1598898127.482 [ThrusterServo] Loaded
2020-08-31T18:22:07.482Z,1598898127.482 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread.
2020-08-31T18:22:07.483Z,1598898127.483 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2020-08-31T18:22:07.483Z,1598898127.483 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2020-08-31T18:22:07.501Z,1598898127.501 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2020-08-31T18:22:07.502Z,1598898127.502 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2020-08-31T18:22:07.831Z,1598898127.831 [BackSeatDriver] Loaded
2020-08-31T18:22:07.832Z,1598898127.832 [ComponentRegistry](DEBUG): Component "BackSeatDriver" handled in its own thread.
2020-08-31T18:22:07.833Z,1598898127.833 [BackSeatDriver ThreadHandler](DEBUG): Created PCaller Thread at 40B034E0
2020-08-31T18:22:07.833Z,1598898127.833 [BackSeatDriver ThreadHandler](INFO): Protected caller Thread ID is 1227
2020-08-31T18:22:07.862Z,1598898127.862 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_density
2020-08-31T18:22:07.867Z,1598898127.867 [CTD_Seabird](INFO): created writer for : sea_water_density
2020-08-31T18:22:07.868Z,1598898127.868 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): depth
2020-08-31T18:22:07.873Z,1598898127.873 [CTD_Seabird](INFO): created writer for : depth
2020-08-31T18:22:07.874Z,1598898127.874 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_pressure
2020-08-31T18:22:07.879Z,1598898127.879 [CTD_Seabird](INFO): created writer for : sea_water_pressure
2020-08-31T18:22:07.879Z,1598898127.879 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_salinity
2020-08-31T18:22:07.885Z,1598898127.885 [CTD_Seabird](INFO): created writer for : sea_water_salinity
2020-08-31T18:22:07.885Z,1598898127.885 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_temperature
2020-08-31T18:22:07.890Z,1598898127.890 [CTD_Seabird](INFO): created writer for : sea_water_temperature
2020-08-31T18:22:07.891Z,1598898127.891 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_electrical_conductivity
2020-08-31T18:22:07.896Z,1598898127.896 [CTD_Seabird](INFO): created writer for : sea_water_electrical_conductivity
2020-08-31T18:22:07.897Z,1598898127.897 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): speed_of_sound_in_sea_water
2020-08-31T18:22:07.902Z,1598898127.902 [CTD_Seabird](INFO): created writer for : speed_of_sound_in_sea_water
2020-08-31T18:22:07.948Z,1598898127.948 [CTD_Seabird] Loaded
2020-08-31T18:22:07.948Z,1598898127.948 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread.
2020-08-31T18:22:07.965Z,1598898127.965 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40B334E0
2020-08-31T18:22:07.966Z,1598898127.966 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 1228
2020-08-31T18:22:08.023Z,1598898128.023 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.Output470
2020-08-31T18:22:08.024Z,1598898128.024 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: Output470
2020-08-31T18:22:08.028Z,1598898128.028 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.Output650
2020-08-31T18:22:08.028Z,1598898128.028 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: Output650
2020-08-31T18:22:08.040Z,1598898128.040 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.OutputChl
2020-08-31T18:22:08.040Z,1598898128.040 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: OutputChl
2020-08-31T18:22:08.045Z,1598898128.045 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.VolumeScatCoeff117deg470nm
2020-08-31T18:22:08.045Z,1598898128.045 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: VolumeScatCoeff117deg470nm
2020-08-31T18:22:08.049Z,1598898128.049 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.VolumeScatCoeff117deg650nm
2020-08-31T18:22:08.049Z,1598898128.049 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: VolumeScatCoeff117deg650nm
2020-08-31T18:22:08.054Z,1598898128.054 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.BackscatteringCoeff470nm
2020-08-31T18:22:08.054Z,1598898128.054 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: BackscatteringCoeff470nm
2020-08-31T18:22:08.058Z,1598898128.058 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.BackscatteringCoeff650nm
2020-08-31T18:22:08.058Z,1598898128.058 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: BackscatteringCoeff650nm
2020-08-31T18:22:08.063Z,1598898128.063 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): mass_concentration_of_chlorophyll_in_sea_water
2020-08-31T18:22:08.068Z,1598898128.068 [WetLabsBB2FL](INFO): created writer for : mass_concentration_of_chlorophyll_in_sea_water
2020-08-31T18:22:08.068Z,1598898128.068 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.bin_median_mass_concentration_of_chlorophyll_in_sea_water
2020-08-31T18:22:08.069Z,1598898128.069 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: bin_median_mass_concentration_of_chlorophyll_in_sea_water
2020-08-31T18:22:08.073Z,1598898128.073 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.bin_mean_mass_concentration_of_chlorophyll_in_sea_water
2020-08-31T18:22:08.073Z,1598898128.073 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: bin_mean_mass_concentration_of_chlorophyll_in_sea_water
2020-08-31T18:22:08.077Z,1598898128.077 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.bin_variance_mass_concentration_of_chlorophyll_in_sea_water
2020-08-31T18:22:08.078Z,1598898128.078 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: bin_variance_mass_concentration_of_chlorophyll_in_sea_water
2020-08-31T18:22:08.083Z,1598898128.083 [WetLabsBB2FL] Loaded
2020-08-31T18:22:08.084Z,1598898128.084 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2020-08-31T18:22:08.086Z,1598898128.086 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40B634E0
2020-08-31T18:22:08.086Z,1598898128.086 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 1229
2020-08-31T18:22:08.087Z,1598898128.087 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2020-08-31T18:22:08.091Z,1598898128.091 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2020-08-31T18:22:08.092Z,1598898128.092 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2020-08-31T18:22:08.099Z,1598898128.099 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2020-08-31T18:22:08.100Z,1598898128.100 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40B934E0
2020-08-31T18:22:08.100Z,1598898128.100 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 1230
2020-08-31T18:22:08.105Z,1598898128.105 [Supervisor](INFO): Main Thread ID is 1137
2020-08-31T18:22:08.105Z,1598898128.105 [Supervisor](DEBUG): Running supervisor.
2020-08-31T18:22:08.106Z,1598898128.106 [CommandLine ThreadHandler](INFO): Handler Thread ID is 1231
2020-08-31T18:22:08.108Z,1598898128.108 [controlThread ThreadHandler](INFO): Handler Thread ID is 1232
2020-08-31T18:22:08.108Z,1598898128.108 [controlThread](DEBUG): Initializing ControlThread
2020-08-31T18:22:08.110Z,1598898128.110 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2020-08-31T18:22:08.111Z,1598898128.111 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2020-08-31T18:22:08.112Z,1598898128.112 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2020-08-31T18:22:08.112Z,1598898128.112 [LoopControl](DEBUG): Initialize LoopControlComponent.
2020-08-31T18:22:08.113Z,1598898128.113 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2020-08-31T18:22:08.113Z,1598898128.113 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2020-08-31T18:22:08.113Z,1598898128.113 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2020-08-31T18:22:08.114Z,1598898128.114 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator.
2020-08-31T18:22:08.114Z,1598898128.114 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2020-08-31T18:22:08.115Z,1598898128.115 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2020-08-31T18:22:08.120Z,1598898128.120 [NavChart](DEBUG): Initialize NavChart Navigation.
2020-08-31T18:22:08.121Z,1598898128.121 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2020-08-31T18:22:08.121Z,1598898128.121 [SBIT](INFO): Initialize SBIT Component.
2020-08-31T18:22:08.122Z,1598898128.122 [SBIT](IMPORTANT): git: 2020-08-31
2020-08-31T18:22:08.122Z,1598898128.122 [SBIT](INFO): git hash: b6c0ec5a69f4280de3f7606c4f2437bb78ebd873
2020-08-31T18:22:08.122Z,1598898128.122 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2020-08-31T18:22:08.123Z,1598898128.123 [SBIT](INFO): Kernel Reporting Different Version From Configuration.
Kernel Expected: #1 PREEMPT Thu Feb 21 11:17:40 PST 2019
Kernel Reported: #1 PREEMPT Thu Aug 6 12:04:53 PDT 2020
2020-08-31T18:22:08.124Z,1598898128.124 [SBIT](INFO): Beginning SBIT in 39.000000 seconds.
2020-08-31T18:22:08.125Z,1598898128.125 [IBIT](INFO): Initialize IBIT Component.
2020-08-31T18:22:08.126Z,1598898128.126 [CBIT](DEBUG): Initialize CBIT Component.
2020-08-31T18:22:08.127Z,1598898128.127 [logger ThreadHandler](INFO): Handler Thread ID is 1233
2020-08-31T18:22:08.137Z,1598898128.137 [CBIT](DEBUG): Initialized mux pins.
2020-08-31T18:22:08.137Z,1598898128.137 [CBIT](FAULT): LAST RESTART WAS UNINTENTIONAL.
2020-08-31T18:22:08.137Z,1598898128.137 [CBIT](DEBUG): Initializing the watchdog timer.
2020-08-31T18:22:08.146Z,1598898128.146 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 1234
2020-08-31T18:22:08.147Z,1598898128.147 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2020-08-31T18:22:08.158Z,1598898128.158 [Onboard ThreadHandler](INFO): Handler Thread ID is 1235
2020-08-31T18:22:08.162Z,1598898128.162 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2020-08-31T18:22:08.162Z,1598898128.162 [CBIT](DEBUG): Initializing heartbeat.
2020-08-31T18:22:08.197Z,1598898128.197 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 1236
2020-08-31T18:22:08.201Z,1598898128.201 [BackSeatDriver ThreadHandler](INFO): Handler Thread ID is 1237
2020-08-31T18:22:08.218Z,1598898128.218 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 1238
2020-08-31T18:22:08.218Z,1598898128.218 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2020-08-31T18:22:08.223Z,1598898128.223 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 1240
2020-08-31T18:22:08.223Z,1598898128.223 [WetLabsBB2FL](INFO): Powering down
2020-08-31T18:22:08.233Z,1598898128.233 [CBIT](DEBUG): Deactivating GF circuits.
2020-08-31T18:22:08.233Z,1598898128.233 [CBIT](DEBUG): Deactivating emergency mode.
2020-08-31T18:22:08.258Z,1598898128.258 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 1241
2020-08-31T18:22:08.261Z,1598898128.261 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2020-08-31T18:22:08.261Z,1598898128.261 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2020-08-31T18:22:08.261Z,1598898128.261 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2020-08-31T18:22:08.262Z,1598898128.262 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2020-08-31T18:22:08.262Z,1598898128.262 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2020-08-31T18:22:08.262Z,1598898128.262 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2020-08-31T18:22:08.262Z,1598898128.262 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000
2020-08-31T18:22:08.262Z,1598898128.262 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000
2020-08-31T18:22:08.262Z,1598898128.262 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2020-08-31T18:22:08.262Z,1598898128.262 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2020-08-31T18:22:08.263Z,1598898128.263 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000
2020-08-31T18:22:08.263Z,1598898128.263 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000
2020-08-31T18:22:08.263Z,1598898128.263 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000
2020-08-31T18:22:08.263Z,1598898128.263 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000
2020-08-31T18:22:08.263Z,1598898128.263 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000
2020-08-31T18:22:08.263Z,1598898128.263 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000
2020-08-31T18:22:08.269Z,1598898128.269 [CBIT](DEBUG): Backplane powered.
2020-08-31T18:22:08.271Z,1598898128.271 [MissionManager](INFO): Loading Mission: Missions/Startup.xml
2020-08-31T18:22:08.285Z,1598898128.285 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2020-08-31T18:22:08.304Z,1598898128.304 [MissionManager](DEBUG): 
<?xml version="1.0" encoding="UTF-8"?>
<Mission xmlns="Tethys"
       xmlns:Control="Tethys/Control"
       xmlns:Guidance="Tethys/Guidance" 
       xmlns:Units="Tethys/Units"
       xmlns:Universal="Tethys/Universal"
       xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"
       xsi:schemaLocation="Tethys http://okeanids.mbari.org/tethys/Xml/Tethys.xsd
                           Tethys/Control http://okeanids.mbari.org/tethys/Xml/Control.xsd
                           Tethys/Guidance http://okeanids.mbari.org/tethys/Xml/Guidance.xsd
                           Tethys/Units http://okeanids.mbari.org/tethys/Xml/Units.xsd
                           Tethys/Universal http://okeanids.mbari.org/tethys/Xml/Universal.xsd"
       Id="Startup">

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

    <Aggregate Id="StartupSatComms">

        <Sequence/>

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

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

    </Aggregate>

</Mission>


2020-08-31T18:22:08.304Z,1598898128.304 [MissionManager](INFO): Loading Mission: Missions/Default.xml
2020-08-31T18:22:08.443Z,1598898128.443 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2020-08-31T18:22:08.444Z,1598898128.444 [Default:A.Wait](DEBUG): Construct Wait.
2020-08-31T18:22:08.454Z,1598898128.454 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2020-08-31T18:22:08.490Z,1598898128.490 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2020-08-31T18:22:08.492Z,1598898128.492 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2020-08-31T18:22:08.514Z,1598898128.514 [Default:E.Execute](DEBUG): Construct Execute.
2020-08-31T18:22:08.520Z,1598898128.520 [MissionManager](DEBUG): 
<?xml version="1.0" encoding="UTF-8"?>
<Mission xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"
         xmlns="Tethys"
         xmlns:Units="Tethys/Units"
         xmlns:Guidance="Tethys/Guidance"
         xmlns:Universal="Tethys/Universal"
         xsi:schemaLocation="Tethys http://okeanids.mbari.org/tethys/Xml/Tethys.xsd
                             Tethys/Units http://okeanids.mbari.org/tethys/Xml/Units.xsd
                             Tethys/Guidance http://okeanids.mbari.org/tethys/Xml/Guidance.xsd
                             Tethys/Universal http://okeanids.mbari.org/tethys/Xml/Universal.xsd"
         Id="Default">

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

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

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

    <Aggregate Id="CheckIn">

        <Sequence Repeat="288"/>

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

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

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

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

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

    </Aggregate>

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

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

</Mission>


2020-08-31T18:22:08.524Z,1598898128.524 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,Depth_Keller,DropWeight,NAL9602,RDI_Pathfinder,DAT,BPC1,AMEcho,Depth_Keller,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter,
2020-08-31T18:22:08.542Z,1598898128.542 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2020-08-31T18:22:08.583Z,1598898128.583 [DAT](INFO): Powered 24V power converter LCB with command: ! echo 1 > /dev/loadB2
2020-08-31T18:22:08.583Z,1598898128.583 [DAT](INFO): Powering up
2020-08-31T18:22:08.583Z,1598898128.583 [DAT](DEBUG): Initializing DAT.
2020-08-31T18:22:08.601Z,1598898128.601 [Radio_Surface](INFO): Powering up
2020-08-31T18:22:08.605Z,1598898128.605 [CommandLine](IMPORTANT): got command ! echo 1 > /dev/loadB2
2020-08-31T18:22:08.646Z,1598898128.646 [AMEcho](INFO): Powering up
2020-08-31T18:22:08.686Z,1598898128.686 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2020-08-31T18:22:08.698Z,1598898128.698 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2020-08-31T18:22:08.699Z,1598898128.699 [ElevatorServo](DEBUG): Initializing EZServoServo.
2020-08-31T18:22:08.713Z,1598898128.713 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2020-08-31T18:22:08.714Z,1598898128.714 [MassServo](DEBUG): Initializing EZServoServo.
2020-08-31T18:22:08.737Z,1598898128.737 [MassServo](DEBUG): Initializing MassServo.
2020-08-31T18:22:08.738Z,1598898128.738 [RudderServo](DEBUG): Initializing EZServoServo.
2020-08-31T18:22:08.771Z,1598898128.771 [RudderServo](DEBUG): Initializing RudderServo.
2020-08-31T18:22:08.772Z,1598898128.772 [ThrusterServo](DEBUG): Initializing EZServoServo.
2020-08-31T18:22:08.787Z,1598898128.787 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2020-08-31T18:22:09.129Z,1598898129.129 [AMEcho](INFO): Powering down
2020-08-31T18:22:09.717Z,1598898129.717 [RudderServo](ERROR): Rudder initialization uart error serial timeout
2020-08-31T18:22:09.717Z,1598898129.717 [RudderServo](FAULT): Rudder failed to initialize
2020-08-31T18:22:09.717Z,1598898129.717 [RudderServo] Communications Fault, FailCount= 1
2020-08-31T18:22:09.717Z,1598898129.717 [RudderServo](ERROR): Communications Fault
2020-08-31T18:22:09.828Z,1598898129.828 [CBIT](ERROR): Communications Fault in component: RudderServo
2020-08-31T18:22:10.012Z,1598898130.012 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2020-08-31T18:22:10.012Z,1598898130.012 [RudderServo](INFO): Powering down
2020-08-31T18:22:10.702Z,1598898130.702 [RudderServo](DEBUG): Initializing EZServoServo.
2020-08-31T18:22:10.830Z,1598898130.830 [RudderServo](DEBUG): Initializing RudderServo.
2020-08-31T18:22:10.834Z,1598898130.834 [CBIT](INFO): Clearing failed state for component RudderServo
2020-08-31T18:22:10.834Z,1598898130.834 [RudderServo] No Fault, FailCount= 1
2020-08-31T18:22:11.825Z,1598898131.825 [ElevatorServo](FAULT): Elevator initialization uart error:serial timeout
2020-08-31T18:22:11.825Z,1598898131.825 [ElevatorServo] Communications Fault, FailCount= 1
2020-08-31T18:22:11.825Z,1598898131.825 [ElevatorServo](ERROR): Communications Fault
2020-08-31T18:22:12.085Z,1598898132.085 [MassServo](FAULT): Mass initialization uart error:serial timeout
2020-08-31T18:22:12.085Z,1598898132.085 [MassServo] Communications Fault, FailCount= 1
2020-08-31T18:22:12.085Z,1598898132.085 [MassServo](ERROR): Communications Fault
2020-08-31T18:22:12.135Z,1598898132.135 [CBIT](ERROR): Communications Fault in component: ElevatorServo
2020-08-31T18:22:12.135Z,1598898132.135 [CBIT](ERROR): Communications Fault in component: MassServo
2020-08-31T18:22:12.252Z,1598898132.252 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2020-08-31T18:22:12.252Z,1598898132.252 [ElevatorServo](INFO): Powering down
2020-08-31T18:22:12.261Z,1598898132.261 [MassServo](DEBUG): Uninitialize Mass Servo.
2020-08-31T18:22:12.261Z,1598898132.261 [MassServo](INFO): Powering down
2020-08-31T18:22:13.030Z,1598898133.030 [ElevatorServo](DEBUG): Initializing EZServoServo.
2020-08-31T18:22:13.152Z,1598898133.152 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2020-08-31T18:22:13.154Z,1598898133.154 [MassServo](DEBUG): Initializing EZServoServo.
2020-08-31T18:22:13.154Z,1598898133.154 [MassServo](DEBUG): Initializing MassServo.
2020-08-31T18:22:13.158Z,1598898133.158 [CBIT](INFO): Clearing failed state for component ElevatorServo
2020-08-31T18:22:13.159Z,1598898133.159 [ElevatorServo] No Fault, FailCount= 1
2020-08-31T18:22:13.159Z,1598898133.159 [CBIT](INFO): Clearing failed state for component MassServo
2020-08-31T18:22:13.159Z,1598898133.159 [MassServo] No Fault, FailCount= 1
2020-08-31T18:22:14.228Z,1598898134.228 [Depth_Keller](ERROR): Pressure reading out of range: 824.648376 decibar
2020-08-31T18:22:14.665Z,1598898134.665 [Radio_Surface](INFO): Powering down
2020-08-31T18:22:15.250Z,1598898135.250 [CTD_Seabird](ERROR): Device message queue exceeded the allowed limit.
2020-08-31T18:22:15.901Z,1598898135.901 [MassServo](FAULT): Mass shifter EEPROM initialization uart error serial timeout
2020-08-31T18:22:15.901Z,1598898135.901 [MassServo] Communications Fault, FailCount= 2
2020-08-31T18:22:15.901Z,1598898135.901 [MassServo](ERROR): Communications Fault
2020-08-31T18:22:15.906Z,1598898135.906 [CBIT](ERROR): Communications Fault in component: MassServo
2020-08-31T18:22:16.001Z,1598898136.001 [MassServo](DEBUG): Uninitialize Mass Servo.
2020-08-31T18:22:16.002Z,1598898136.002 [MassServo](INFO): Powering down
2020-08-31T18:22:16.814Z,1598898136.814 [MassServo](DEBUG): Initializing EZServoServo.
2020-08-31T18:22:16.814Z,1598898136.814 [MassServo](DEBUG): Initializing MassServo.
2020-08-31T18:22:16.831Z,1598898136.831 [CBIT](INFO): Clearing failed state for component MassServo
2020-08-31T18:22:16.831Z,1598898136.831 [MassServo] No Fault, FailCount= 2
2020-08-31T18:22:17.958Z,1598898137.958 [Depth_Keller](ERROR): Pressure reading out of range: 1650.297119 decibar
2020-08-31T18:22:19.609Z,1598898139.609 [MassServo](FAULT): Mass shifter EEPROM initialization uart error serial timeout
2020-08-31T18:22:19.609Z,1598898139.609 [MassServo] Communications Fault, FailCount= 3
2020-08-31T18:22:19.609Z,1598898139.609 [MassServo](ERROR): Communications Fault
2020-08-31T18:22:19.614Z,1598898139.614 [CBIT](ERROR): Communications Fault in component: MassServo
2020-08-31T18:22:19.730Z,1598898139.730 [MassServo](DEBUG): Uninitialize Mass Servo.
2020-08-31T18:22:19.730Z,1598898139.730 [MassServo](INFO): Powering down
2020-08-31T18:22:20.507Z,1598898140.507 [MassServo](DEBUG): Initializing EZServoServo.
2020-08-31T18:22:20.507Z,1598898140.507 [MassServo](DEBUG): Initializing MassServo.
2020-08-31T18:22:20.512Z,1598898140.512 [CBIT](INFO): Clearing failed state for component MassServo
2020-08-31T18:22:20.512Z,1598898140.512 [MassServo] No Fault, FailCount= 3
2020-08-31T18:22:20.729Z,1598898140.729 [Radio_Surface](INFO): Powering up
2020-08-31T18:22:22.849Z,1598898142.849 [MassServo](FAULT): Mass shifter EEPROM initialization uart error serial timeout
2020-08-31T18:22:22.849Z,1598898142.849 [MassServo] Communications Fault, FailCount= 4
2020-08-31T18:22:22.849Z,1598898142.849 [MassServo](ERROR): Communications Fault
2020-08-31T18:22:22.853Z,1598898142.853 [CBIT](ERROR): Communications Fault in component: MassServo
2020-08-31T18:22:22.950Z,1598898142.950 [MassServo](DEBUG): Uninitialize Mass Servo.
2020-08-31T18:22:22.950Z,1598898142.950 [MassServo](INFO): Powering down
2020-08-31T18:22:23.711Z,1598898143.711 [MassServo](DEBUG): Initializing EZServoServo.
2020-08-31T18:22:23.711Z,1598898143.711 [MassServo](DEBUG): Initializing MassServo.
2020-08-31T18:22:23.716Z,1598898143.716 [CBIT](INFO): Clearing failed state for component MassServo
2020-08-31T18:22:23.716Z,1598898143.716 [MassServo] No Fault, FailCount= 4
2020-08-31T18:22:26.118Z,1598898146.118 [MassServo](FAULT): Mass shifter EEPROM initialization uart error serial timeout
2020-08-31T18:22:26.118Z,1598898146.118 [MassServo] Communications Fault, FailCount= 5
2020-08-31T18:22:26.118Z,1598898146.118 [MassServo](ERROR): Communications Fault
2020-08-31T18:22:26.122Z,1598898146.122 [CBIT](ERROR): Communications Fault in component: MassServo
2020-08-31T18:22:26.122Z,1598898146.122 [CBIT](CRITICAL): Communications Fault in component: MassServo
2020-08-31T18:22:26.214Z,1598898146.214 [MassServo](DEBUG): Uninitialize Mass Servo.
2020-08-31T18:22:26.215Z,1598898146.215 [MassServo](INFO): Powering down
2020-08-31T18:22:26.217Z,1598898146.217 [CommandLine](FAULT): Scheduling is paused
2020-08-31T18:22:26.217Z,1598898146.217 [CBIT](INFO): Critical error at 20200831T182226
2020-08-31T18:22:26.218Z,1598898146.218 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals
2020-08-31T18:22:26.995Z,1598898146.995 [MassServo](DEBUG): Initializing EZServoServo.
2020-08-31T18:22:26.995Z,1598898146.995 [MassServo](DEBUG): Initializing MassServo.
2020-08-31T18:22:34.627Z,1598898154.627 [NAL9602](INFO): Powering up NAL9602
2020-08-31T18:22:35.835Z,1598898155.835 [RDI_Pathfinder](ERROR): No DVL communication! Re-initializing
2020-08-31T18:22:35.835Z,1598898155.835 [RDI_Pathfinder] Communications Fault, FailCount= 1
2020-08-31T18:22:35.835Z,1598898155.835 [RDI_Pathfinder](ERROR): Communications Fault
2020-08-31T18:22:35.850Z,1598898155.850 [CBIT](ERROR): Communications Fault in component: RDI_Pathfinder
2020-08-31T18:22:36.243Z,1598898156.243 [RDI_Pathfinder](INFO): Powering down
2020-08-31T18:22:37.057Z,1598898157.057 [CBIT](INFO): Clearing failed state for component RDI_Pathfinder
2020-08-31T18:22:37.058Z,1598898157.058 [RDI_Pathfinder] No Fault, FailCount= 1
2020-08-31T18:22:47.567Z,1598898167.567 [SBIT](IMPORTANT): Beginning Startup BIT
2020-08-31T18:22:47.571Z,1598898167.571 [CBIT](IMPORTANT): Beginning ground fault scan
2020-08-31T18:22:48.281Z,1598898168.281 [ElevatorServo](ERROR): getPosition uart error serial timeout
2020-08-31T18:22:48.281Z,1598898168.281 [ElevatorServo](FAULT): Elevator uart error - getPosition.serial timeout
2020-08-31T18:22:48.281Z,1598898168.281 [ElevatorServo] Communications Fault, FailCount= 2
2020-08-31T18:22:48.281Z,1598898168.281 [ElevatorServo](ERROR): Communications Fault
2020-08-31T18:22:48.286Z,1598898168.286 [CBIT](ERROR): Communications Fault in component: ElevatorServo
2020-08-31T18:22:48.391Z,1598898168.391 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2020-08-31T18:22:48.391Z,1598898168.391 [ElevatorServo](INFO): Powering down
2020-08-31T18:22:49.187Z,1598898169.187 [ElevatorServo](DEBUG): Initializing EZServoServo.
2020-08-31T18:22:49.302Z,1598898169.302 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2020-08-31T18:22:49.417Z,1598898169.417 [CBIT](INFO): Clearing failed state for component ElevatorServo
2020-08-31T18:22:49.418Z,1598898169.418 [ElevatorServo] No Fault, FailCount= 2
2020-08-31T18:22:55.222Z,1598898175.222 [NAL9602](ERROR): NAL9602 initialization error.
2020-08-31T18:22:55.223Z,1598898175.223 [NAL9602] Communications Fault, FailCount= 1
2020-08-31T18:22:55.223Z,1598898175.223 [NAL9602](ERROR): Communications Fault
2020-08-31T18:22:55.325Z,1598898175.325 [CBIT](ERROR): Communications Fault in component: NAL9602
2020-08-31T18:22:55.626Z,1598898175.626 [NAL9602](INFO): Powering down
2020-08-31T18:22:56.547Z,1598898176.547 [CBIT](INFO): Clearing failed state for component NAL9602
2020-08-31T18:22:56.547Z,1598898176.547 [NAL9602] No Fault, FailCount= 1
2020-08-31T18:22:59.369Z,1598898179.369 [CBIT](IMPORTANT): Ground fault detected
mA:
CHAN A0 (Batt): -0.009545
CHAN A1 (24V): 0.038237
CHAN A2 (12V): -0.006830
CHAN A3 (5V): -0.002184
CHAN B0 (3.3V): -0.000225
CHAN B1 (3.15aV): -0.000879
CHAN B2 (3.15bV): -0.000458
CHAN B3 (GND): 0.001371
OPEN: 0.005024
Full Scale Calc: 4.765 mA, -1.589 mA
2020-08-31T18:23:00.599Z,1598898180.599 [SBIT](ERROR): Could not read massPosReader_.
2020-08-31T18:23:01.698Z,1598898181.698 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error
2020-08-31T18:23:08.595Z,1598898188.595 [DAT](FAULT): failed to initialize, no bytes available on serial interface
2020-08-31T18:23:08.595Z,1598898188.595 [DAT] Communications Fault, FailCount= 1
2020-08-31T18:23:08.595Z,1598898188.595 [DAT](ERROR): Communications Fault
2020-08-31T18:23:08.618Z,1598898188.618 [CBIT](ERROR): Communications Fault in component: DAT
2020-08-31T18:23:08.967Z,1598898188.967 [DAT](INFO): Powering down
2020-08-31T18:23:09.848Z,1598898189.848 [CBIT](INFO): Clearing failed state for component DAT
2020-08-31T18:23:09.848Z,1598898189.848 [DAT] No Fault, FailCount= 1
2020-08-31T18:23:11.799Z,1598898191.799 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error
2020-08-31T18:23:12.194Z,1598898192.194 [CommandLine](IMPORTANT): got command ! echo 1 > /dev/loadB2
2020-08-31T18:23:12.206Z,1598898192.206 [DAT](INFO): Powered 24V power converter LCB with command: ! echo 1 > /dev/loadB2
2020-08-31T18:23:12.207Z,1598898192.207 [DAT](INFO): Powering up
2020-08-31T18:23:12.208Z,1598898192.208 [DAT](DEBUG): Initializing DAT.
2020-08-31T18:23:25.555Z,1598898205.555 [RDI_Pathfinder](ERROR): only read 3 of 4 data items
2020-08-31T18:23:25.939Z,1598898205.939 [NAL9602](INFO): Powering up NAL9602
2020-08-31T18:23:26.749Z,1598898206.749 [RDI_Pathfinder](ERROR): No DVL communication! Re-initializing
2020-08-31T18:23:26.749Z,1598898206.749 [RDI_Pathfinder] Communications Fault, FailCount= 1
2020-08-31T18:23:26.749Z,1598898206.749 [RDI_Pathfinder](ERROR): Communications Fault
2020-08-31T18:23:26.766Z,1598898206.766 [CBIT](ERROR): Communications Fault in component: RDI_Pathfinder
2020-08-31T18:23:27.151Z,1598898207.151 [RDI_Pathfinder](INFO): Powering down
2020-08-31T18:23:27.166Z,1598898207.166 [SBIT](ERROR): Could not read massPosReader_.
2020-08-31T18:23:27.166Z,1598898207.166 [SBIT](FAULT): Control surface position failure.
2020-08-31T18:23:27.981Z,1598898207.981 [CBIT](INFO): Clearing failed state for component RDI_Pathfinder
2020-08-31T18:23:27.981Z,1598898207.981 [RDI_Pathfinder] No Fault, FailCount= 1
2020-08-31T18:23:40.901Z,1598898220.901 [SBIT](ERROR): Could not read massPosReader_.
2020-08-31T18:23:40.901Z,1598898220.901 [SBIT](FAULT): Control surface position failure.
2020-08-31T18:23:41.373Z,1598898221.373 [SBIT](CRITICAL): SBIT FAILED
2020-08-31T18:23:41.374Z,1598898221.374 [SBIT](FAULT): Ignoring configuration overrides from Data/persisted.cfg
2020-08-31T18:23:41.375Z,1598898221.375 [CBIT](INFO): Critical error at 20200831T182341
2020-08-31T18:23:41.703Z,1598898221.703 [MissionManager](IMPORTANT): Started mission Startup
2020-08-31T18:23:41.703Z,1598898221.703 [Startup] Running Loop=1
2020-08-31T18:23:41.703Z,1598898221.703 [Startup](DEBUG): Aggregate::initialize Startup
2020-08-31T18:23:41.703Z,1598898221.703 [Startup:A.GoToSurface] Running Loop=1
2020-08-31T18:23:41.703Z,1598898221.703 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2020-08-31T18:23:41.704Z,1598898221.704 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2020-08-31T18:23:41.704Z,1598898221.704 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2020-08-31T18:23:41.705Z,1598898221.705 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2020-08-31T18:23:41.730Z,1598898221.730 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2020-08-31T18:23:41.730Z,1598898221.730 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2020-08-31T18:23:41.732Z,1598898221.732 [Startup:StartupSatComms] Running Loop=1
2020-08-31T18:23:41.732Z,1598898221.732 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2020-08-31T18:23:41.732Z,1598898221.732 [Startup:StartupSatComms:A] Running Loop=1
2020-08-31T18:23:42.108Z,1598898222.108 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2020-08-31T18:23:46.535Z,1598898226.535 [NAL9602](ERROR): NAL9602 initialization error.
2020-08-31T18:23:46.536Z,1598898226.536 [NAL9602] Communications Fault, FailCount= 2
2020-08-31T18:23:46.536Z,1598898226.536 [NAL9602](ERROR): Communications Fault
2020-08-31T18:23:46.559Z,1598898226.559 [CBIT](ERROR): Communications Fault in component: NAL9602
2020-08-31T18:23:46.934Z,1598898226.934 [NAL9602](INFO): Powering down
2020-08-31T18:23:47.790Z,1598898227.790 [CBIT](INFO): Clearing failed state for component NAL9602
2020-08-31T18:23:47.790Z,1598898227.790 [NAL9602] No Fault, FailCount= 2
2020-08-31T18:24:01.897Z,1598898241.897 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error
2020-08-31T18:24:12.399Z,1598898252.399 [DAT](FAULT): failed to initialize; deviceResponse_ loaded: , available: Features enabled Ÿm@
2020-08-31T18:24:12.399Z,1598898252.399 [DAT] Communications Fault, FailCount= 2
2020-08-31T18:24:12.399Z,1598898252.399 [DAT](ERROR): Communications Fault
2020-08-31T18:24:12.415Z,1598898252.415 [CBIT](ERROR): Communications Fault in component: DAT
2020-08-31T18:24:12.800Z,1598898252.800 [DAT](INFO): Powering down
2020-08-31T18:24:13.652Z,1598898253.652 [CBIT](INFO): Clearing failed state for component DAT
2020-08-31T18:24:13.653Z,1598898253.653 [DAT] No Fault, FailCount= 2
2020-08-31T18:24:16.034Z,1598898256.034 [CommandLine](IMPORTANT): got command ! echo 1 > /dev/loadB2
2020-08-31T18:24:16.047Z,1598898256.047 [DAT](INFO): Powered 24V power converter LCB with command: ! echo 1 > /dev/loadB2
2020-08-31T18:24:16.047Z,1598898256.047 [DAT](INFO): Powering up
2020-08-31T18:24:16.048Z,1598898256.048 [DAT](DEBUG): Initializing DAT.
2020-08-31T18:24:17.247Z,1598898257.247 [NAL9602](INFO): Powering up NAL9602
2020-08-31T18:24:17.680Z,1598898257.680 [RDI_Pathfinder](ERROR): only read 3 of 4 data items
2020-08-31T18:24:18.864Z,1598898258.864 [RDI_Pathfinder](ERROR): No DVL communication! Re-initializing
2020-08-31T18:24:18.864Z,1598898258.864 [RDI_Pathfinder] Communications Fault, FailCount= 1
2020-08-31T18:24:18.864Z,1598898258.864 [RDI_Pathfinder](ERROR): Communications Fault
2020-08-31T18:24:18.911Z,1598898258.911 [CBIT](ERROR): Communications Fault in component: RDI_Pathfinder
2020-08-31T18:24:19.267Z,1598898259.267 [RDI_Pathfinder](INFO): Powering down
2020-08-31T18:24:19.270Z,1598898259.270 [AMEcho](INFO): Powering up
2020-08-31T18:24:20.106Z,1598898260.106 [CBIT](INFO): Clearing failed state for component RDI_Pathfinder
2020-08-31T18:24:20.106Z,1598898260.106 [RDI_Pathfinder] No Fault, FailCount= 1
2020-08-31T18:24:23.557Z,1598898263.557 [AMEcho](INFO): Powering down
2020-08-31T18:24:37.844Z,1598898277.844 [NAL9602](ERROR): NAL9602 initialization error.
2020-08-31T18:24:37.844Z,1598898277.844 [NAL9602] Communications Fault, FailCount= 3
2020-08-31T18:24:37.844Z,1598898277.844 [NAL9602](ERROR): Communications Fault
2020-08-31T18:24:37.948Z,1598898277.948 [CBIT](ERROR): Communications Fault in component: NAL9602
2020-08-31T18:24:38.250Z,1598898278.250 [NAL9602](INFO): Powering down
2020-08-31T18:24:39.095Z,1598898279.095 [CBIT](INFO): Clearing failed state for component NAL9602
2020-08-31T18:24:39.095Z,1598898279.095 [NAL9602] No Fault, FailCount= 3
2020-08-31T18:24:41.898Z,1598898281.898 [Startup:StartupSatComms:A](INFO): Timed out from 2020-08-31T18:23:41.7Z
2020-08-31T18:24:41.898Z,1598898281.898 [Startup:StartupSatComms:A] Stopped
2020-08-31T18:24:41.898Z,1598898281.898 [Startup:StartupSatComms:B] Running Loop=1
2020-08-31T18:24:42.332Z,1598898282.332 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2020-08-31T18:24:45.191Z,1598898285.191 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004506
2020-08-31T18:24:51.313Z,1598898291.313 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error
2020-08-31T18:24:52.306Z,1598898292.306 [Depth_Keller](INFO): A/D timeout, 7 tries over 138 ms

2020-08-31T18:24:52.306Z,1598898292.306 [Depth_Keller] Data Fault, FailCount= 1
2020-08-31T18:24:52.306Z,1598898292.306 [Depth_Keller](ERROR): Data Fault
2020-08-31T18:24:52.424Z,1598898292.424 [CBIT](ERROR): Data Fault in component: Depth_Keller
2020-08-31T18:24:52.424Z,1598898292.424 [CBIT](INFO): Clearing failed state for component Depth_Keller
2020-08-31T18:24:52.425Z,1598898292.425 [Depth_Keller] No Fault, FailCount= 1
2020-08-31T18:24:56.594Z,1598898296.594 [DataOverHttps](INFO): Sending 18 bytes from file Logs/20200831T165910/Courier0028.lzma
2020-08-31T18:24:57.583Z,1598898297.583 [DataOverHttps](INFO): Moved sent file to Logs/20200831T165910/Courier0028.lzma.bak
2020-08-31T18:24:57.583Z,1598898297.583 [DataOverHttps](INFO): SBD MOMSN=12625884
2020-08-31T18:25:08.293Z,1598898308.293 [NAL9602](INFO): Powering up NAL9602
2020-08-31T18:25:08.294Z,1598898308.294 [RDI_Pathfinder](ERROR): No DVL communication! Re-initializing
2020-08-31T18:25:08.294Z,1598898308.294 [RDI_Pathfinder] Communications Fault, FailCount= 1
2020-08-31T18:25:08.294Z,1598898308.294 [RDI_Pathfinder](ERROR): Communications Fault
2020-08-31T18:25:08.303Z,1598898308.303 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2020-08-31T18:25:08.303Z,1598898308.303 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-08-31T18:25:08.313Z,1598898308.313 [CBIT](ERROR): Communications Fault in component: RDI_Pathfinder
2020-08-31T18:25:08.313Z,1598898308.313 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-08-31T18:25:08.687Z,1598898308.687 [RDI_Pathfinder](INFO): Powering down
2020-08-31T18:25:08.689Z,1598898308.689 [AMEcho](INFO): Powering up
2020-08-31T18:25:08.738Z,1598898308.738 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-08-31T18:25:08.738Z,1598898308.738 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2020-08-31T18:25:09.523Z,1598898309.523 [CBIT](INFO): Clearing failed state for component RDI_Pathfinder
2020-08-31T18:25:09.523Z,1598898309.523 [RDI_Pathfinder] No Fault, FailCount= 1
2020-08-31T18:25:12.893Z,1598898312.893 [AMEcho](INFO): Powering down
2020-08-31T18:25:14.895Z,1598898314.895 [DataOverHttps](INFO): Sending 232 bytes from file Logs/20200831T182151/Courier0000.lzma
2020-08-31T18:25:15.859Z,1598898315.859 [DataOverHttps](INFO): Moved sent file to Logs/20200831T182151/Courier0000.lzma.bak
2020-08-31T18:25:15.859Z,1598898315.859 [DataOverHttps](INFO): SBD MOMSN=12625886
2020-08-31T18:25:16.359Z,1598898316.359 [DAT](FAULT): failed to initialize; deviceResponse_ loaded: , available: Features enabled Ÿm@ÔE@E@L¡
2020-08-31T18:25:16.359Z,1598898316.359 [DAT] Communications Fault, FailCount= 3
2020-08-31T18:25:16.359Z,1598898316.359 [DAT](ERROR): Communications Fault
2020-08-31T18:25:16.379Z,1598898316.379 [CBIT](ERROR): Communications Fault in component: DAT
2020-08-31T18:25:16.776Z,1598898316.776 [DAT](INFO): Powering down
2020-08-31T18:25:17.607Z,1598898317.607 [CBIT](INFO): Clearing failed state for component DAT
2020-08-31T18:25:17.607Z,1598898317.607 [DAT] No Fault, FailCount= 3
2020-08-31T18:25:20.005Z,1598898320.005 [DAT](INFO): Powered 24V power converter LCB with command: ! echo 1 > /dev/loadB2
2020-08-31T18:25:20.005Z,1598898320.005 [DAT](INFO): Powering up
2020-08-31T18:25:20.005Z,1598898320.005 [DAT](DEBUG): Initializing DAT.
2020-08-31T18:25:20.014Z,1598898320.014 [CommandLine](IMPORTANT): got command ! echo 1 > /dev/loadB2
2020-08-31T18:25:26.916Z,1598898326.916 [RDI_Pathfinder](ERROR): only read 0 of 4 data items
2020-08-31T18:25:28.889Z,1598898328.889 [AHRS_M2](FAULT): Failed to acquire valid data within timeout.
2020-08-31T18:25:28.889Z,1598898328.889 [AHRS_M2] Data Fault, FailCount= 1
2020-08-31T18:25:28.889Z,1598898328.889 [AHRS_M2](ERROR): Data Fault
2020-08-31T18:25:28.911Z,1598898328.911 [NAL9602](ERROR): NAL9602 initialization error.
2020-08-31T18:25:28.912Z,1598898328.912 [NAL9602] Communications Fault, FailCount= 4
2020-08-31T18:25:28.912Z,1598898328.912 [NAL9602](ERROR): Communications Fault
2020-08-31T18:25:28.951Z,1598898328.951 [CBIT](ERROR): Data Fault in component: AHRS_M2
2020-08-31T18:25:28.951Z,1598898328.951 [CBIT](ERROR): Communications Fault in component: NAL9602
2020-08-31T18:25:29.277Z,1598898329.277 [AHRS_M2](INFO): Powering down
2020-08-31T18:25:29.282Z,1598898329.282 [NAL9602](INFO): Powering down
2020-08-31T18:25:30.112Z,1598898330.112 [CBIT](INFO): Clearing failed state for component AHRS_M2
2020-08-31T18:25:30.112Z,1598898330.112 [AHRS_M2] No Fault, FailCount= 1
2020-08-31T18:25:30.112Z,1598898330.112 [CBIT](INFO): Clearing failed state for component NAL9602
2020-08-31T18:25:30.112Z,1598898330.112 [NAL9602] No Fault, FailCount= 4
2020-08-31T18:25:30.489Z,1598898330.489 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2020-08-31T18:25:31.708Z,1598898331.708 [DAT](INFO): unknown deviceResponse_: 12.21

2020-08-31T18:25:32.110Z,1598898332.110 [Depth_Keller](ERROR): Pressure reading out of range: 1650.297119 decibar
2020-08-31T18:25:32.526Z,1598898332.526 [DAT](INFO): commRate: 800
2020-08-31T18:25:32.526Z,1598898332.526 [DAT](INFO): commRate: 800
2020-08-31T18:25:32.919Z,1598898332.919 [DAT](INFO): entering command mode
2020-08-31T18:25:33.323Z,1598898333.323 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:25:33.752Z,1598898333.752 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:25:34.167Z,1598898334.167 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:25:34.553Z,1598898334.553 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:25:34.947Z,1598898334.947 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:25:35.351Z,1598898335.351 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:25:35.767Z,1598898335.767 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:25:36.159Z,1598898336.159 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:25:36.563Z,1598898336.563 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:25:36.972Z,1598898336.972 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:25:37.375Z,1598898337.375 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:25:37.775Z,1598898337.775 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:25:38.179Z,1598898338.179 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:25:38.591Z,1598898338.591 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:25:38.996Z,1598898338.996 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:25:39.391Z,1598898339.391 [RDI_Pathfinder](ERROR): No DVL communication! Re-initializing
2020-08-31T18:25:39.391Z,1598898339.391 [RDI_Pathfinder] Communications Fault, FailCount= 1
2020-08-31T18:25:39.391Z,1598898339.391 [RDI_Pathfinder](ERROR): Communications Fault
2020-08-31T18:25:39.392Z,1598898339.392 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:25:39.411Z,1598898339.411 [CBIT](ERROR): Communications Fault in component: RDI_Pathfinder
2020-08-31T18:25:39.803Z,1598898339.803 [RDI_Pathfinder](INFO): Powering down
2020-08-31T18:25:39.805Z,1598898339.805 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:25:39.806Z,1598898339.806 [AMEcho](INFO): Powering up
2020-08-31T18:25:39.893Z,1598898339.893 [DataOverHttps](INFO): Sending 187 bytes from file Logs/20200831T165910/Express0023.lzma
2020-08-31T18:25:40.204Z,1598898340.204 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:25:40.603Z,1598898340.603 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:25:40.650Z,1598898340.650 [CBIT](INFO): Clearing failed state for component RDI_Pathfinder
2020-08-31T18:25:40.650Z,1598898340.650 [RDI_Pathfinder] No Fault, FailCount= 1
2020-08-31T18:25:40.895Z,1598898340.895 [DataOverHttps](INFO): Moved sent file to Logs/20200831T165910/Express0023.lzma.bak
2020-08-31T18:25:40.895Z,1598898340.895 [DataOverHttps](INFO): SBD MOMSN=12625891
2020-08-31T18:25:41.011Z,1598898341.011 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:25:41.420Z,1598898341.420 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:25:41.817Z,1598898341.817 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:25:42.219Z,1598898342.219 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:25:42.227Z,1598898342.227 [Startup:StartupSatComms:B](INFO): Timed out from 2020-08-31T18:24:41.9Z
2020-08-31T18:25:42.227Z,1598898342.227 [Startup:StartupSatComms:B] Stopped
2020-08-31T18:25:42.227Z,1598898342.227 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2020-08-31T18:25:42.227Z,1598898342.227 [Startup:StartupSatComms] Stopped
2020-08-31T18:25:42.227Z,1598898342.227 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2020-08-31T18:25:42.228Z,1598898342.228 [Startup](INFO): Completed Startup
2020-08-31T18:25:42.228Z,1598898342.228 [MissionManager](INFO): Startup is completed.
2020-08-31T18:25:42.228Z,1598898342.228 [MissionManager](INFO): Uninitializing Mission Startup
2020-08-31T18:25:42.229Z,1598898342.229 [Startup] Stopped
2020-08-31T18:25:42.229Z,1598898342.229 [Startup](DEBUG): Aggregate::uninitialize Startup
2020-08-31T18:25:42.229Z,1598898342.229 [Startup:A.GoToSurface] Stopped
2020-08-31T18:25:42.230Z,1598898342.230 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2020-08-31T18:25:42.636Z,1598898342.636 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:25:42.643Z,1598898342.643 [MissionManager](IMPORTANT): Started mission Default
2020-08-31T18:25:42.643Z,1598898342.643 [Default] Running Loop=1
2020-08-31T18:25:42.643Z,1598898342.643 [Default](DEBUG): Aggregate::initialize Default
2020-08-31T18:25:42.643Z,1598898342.643 [Default:B.GoToSurface] Running Loop=1
2020-08-31T18:25:42.643Z,1598898342.643 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2020-08-31T18:25:42.644Z,1598898342.644 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2020-08-31T18:25:42.644Z,1598898342.644 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2020-08-31T18:25:42.644Z,1598898342.644 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2020-08-31T18:25:42.645Z,1598898342.645 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2020-08-31T18:25:42.646Z,1598898342.646 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2020-08-31T18:25:42.646Z,1598898342.646 [Default:A.Wait] Running Loop=1
2020-08-31T18:25:42.646Z,1598898342.646 [Default:A.Wait](DEBUG): Initialize Wait Component.
2020-08-31T18:25:43.036Z,1598898343.036 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:25:43.439Z,1598898343.439 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:25:43.843Z,1598898343.843 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:25:44.005Z,1598898344.005 [AMEcho](INFO): Powering down
2020-08-31T18:25:44.247Z,1598898344.247 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:25:44.643Z,1598898344.643 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:25:45.047Z,1598898345.047 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:25:45.536Z,1598898345.536 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:25:45.866Z,1598898345.866 [Depth_Keller](ERROR): Pressure reading out of range: 1650.297119 decibar
2020-08-31T18:25:45.868Z,1598898345.868 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:25:46.266Z,1598898346.266 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:25:46.671Z,1598898346.671 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:25:47.075Z,1598898347.075 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:25:47.479Z,1598898347.479 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:25:47.883Z,1598898347.883 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:25:48.293Z,1598898348.293 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:25:48.294Z,1598898348.294 [DAT](FAULT): failed to enter command mode
2020-08-31T18:25:48.696Z,1598898348.696 [DAT](INFO): entering command mode
2020-08-31T18:25:49.100Z,1598898349.100 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:25:49.576Z,1598898349.576 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:25:49.895Z,1598898349.895 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:25:50.311Z,1598898350.311 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:25:50.716Z,1598898350.716 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:25:51.119Z,1598898351.119 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:25:51.523Z,1598898351.523 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:25:51.923Z,1598898351.923 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:25:52.336Z,1598898352.336 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:25:52.735Z,1598898352.735 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:25:53.141Z,1598898353.141 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:25:53.564Z,1598898353.564 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:25:53.951Z,1598898353.951 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:25:54.349Z,1598898354.349 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:25:54.756Z,1598898354.756 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:25:55.163Z,1598898355.163 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:25:55.591Z,1598898355.591 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:25:55.960Z,1598898355.960 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:25:55.971Z,1598898355.971 [Default:A.Wait](INFO): Done Waiting.
2020-08-31T18:25:55.971Z,1598898355.971 [Default:A.Wait] Stopped
2020-08-31T18:25:55.971Z,1598898355.971 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2020-08-31T18:25:56.364Z,1598898356.364 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:25:56.379Z,1598898356.379 [Default:CheckIn] Running Loop=1
2020-08-31T18:25:56.379Z,1598898356.379 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2020-08-31T18:25:56.380Z,1598898356.380 [Default:CheckIn:Read_GPS] Running Loop=1
2020-08-31T18:25:56.773Z,1598898356.773 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:25:56.786Z,1598898356.786 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2020-08-31T18:25:57.172Z,1598898357.172 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:25:57.576Z,1598898357.576 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:25:58.034Z,1598898358.034 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:25:58.463Z,1598898358.463 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:25:58.783Z,1598898358.783 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:25:59.191Z,1598898359.191 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:25:59.590Z,1598898359.590 [NAL9602](INFO): Powering up NAL9602
2020-08-31T18:25:59.592Z,1598898359.592 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:26:00.007Z,1598898360.007 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:26:00.430Z,1598898360.430 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:26:00.803Z,1598898360.803 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:26:01.207Z,1598898361.207 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:26:01.615Z,1598898361.615 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:26:02.015Z,1598898362.015 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:26:02.428Z,1598898362.428 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:26:02.827Z,1598898362.827 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:26:03.236Z,1598898363.236 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:26:03.653Z,1598898363.653 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:26:04.039Z,1598898364.039 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:26:04.039Z,1598898364.039 [DAT](FAULT): failed to enter command mode
2020-08-31T18:26:04.439Z,1598898364.439 [DAT](INFO): entering command mode
2020-08-31T18:26:04.852Z,1598898364.852 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:26:05.252Z,1598898365.252 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:26:05.651Z,1598898365.651 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:26:06.143Z,1598898366.143 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:26:06.471Z,1598898366.471 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:26:06.880Z,1598898366.880 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:26:07.301Z,1598898367.301 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:26:07.695Z,1598898367.695 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:26:08.090Z,1598898368.090 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:26:08.492Z,1598898368.492 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:26:08.896Z,1598898368.896 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:26:09.297Z,1598898369.297 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:26:09.705Z,1598898369.705 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:26:10.190Z,1598898370.190 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:26:10.505Z,1598898370.505 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:26:10.916Z,1598898370.916 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:26:11.322Z,1598898371.322 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:26:11.724Z,1598898371.724 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:26:12.128Z,1598898372.128 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:26:12.532Z,1598898372.532 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:26:12.937Z,1598898372.937 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:26:13.339Z,1598898373.339 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:26:13.744Z,1598898373.744 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:26:14.149Z,1598898374.149 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:26:14.551Z,1598898374.551 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:26:14.960Z,1598898374.960 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:26:15.360Z,1598898375.360 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:26:15.765Z,1598898375.765 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:26:16.172Z,1598898376.172 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:26:16.564Z,1598898376.564 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:26:16.999Z,1598898376.999 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:26:17.372Z,1598898377.372 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:26:17.771Z,1598898377.771 [RDI_Pathfinder](ERROR): No DVL communication! Re-initializing
2020-08-31T18:26:17.771Z,1598898377.771 [RDI_Pathfinder] Communications Fault, FailCount= 1
2020-08-31T18:26:17.771Z,1598898377.771 [RDI_Pathfinder](ERROR): Communications Fault
2020-08-31T18:26:17.772Z,1598898377.772 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:26:17.795Z,1598898377.795 [CBIT](ERROR): Communications Fault in component: RDI_Pathfinder
2020-08-31T18:26:18.185Z,1598898378.185 [RDI_Pathfinder](INFO): Powering down
2020-08-31T18:26:18.189Z,1598898378.189 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:26:18.190Z,1598898378.190 [AMEcho](INFO): Powering up
2020-08-31T18:26:18.588Z,1598898378.588 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:26:18.988Z,1598898378.988 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:26:19.021Z,1598898379.021 [CBIT](INFO): Clearing failed state for component RDI_Pathfinder
2020-08-31T18:26:19.021Z,1598898379.021 [RDI_Pathfinder] No Fault, FailCount= 1
2020-08-31T18:26:19.392Z,1598898379.392 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:26:19.791Z,1598898379.791 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:26:19.791Z,1598898379.791 [DAT](FAULT): failed to enter command mode
2020-08-31T18:26:20.199Z,1598898380.199 [NAL9602](ERROR): NAL9602 initialization error.
2020-08-31T18:26:20.199Z,1598898380.199 [NAL9602] Communications Fault, FailCount= 5
2020-08-31T18:26:20.199Z,1598898380.199 [NAL9602](ERROR): Communications Fault
2020-08-31T18:26:20.200Z,1598898380.200 [DAT](FAULT): failed to initialize; deviceResponse_ loaded: 
, available: user:1>
2020-08-31T18:26:20.200Z,1598898380.200 [DAT] Communications Fault, FailCount= 4
2020-08-31T18:26:20.200Z,1598898380.200 [DAT](ERROR): Communications Fault
2020-08-31T18:26:20.235Z,1598898380.235 [CBIT](ERROR): Communications Fault in component: NAL9602
2020-08-31T18:26:20.236Z,1598898380.236 [CBIT](CRITICAL): Communications Fault in component: NAL9602
2020-08-31T18:26:20.236Z,1598898380.236 [CBIT](ERROR): Communications Fault in component: DAT
2020-08-31T18:26:20.598Z,1598898380.598 [NAL9602](INFO): Powering down
2020-08-31T18:26:20.599Z,1598898380.599 [DAT](INFO): Powering down
2020-08-31T18:26:20.653Z,1598898380.653 [CBIT](INFO): Critical error at 20200831T182620
2020-08-31T18:26:21.433Z,1598898381.433 [CBIT](INFO): Clearing failed state for component DAT
2020-08-31T18:26:21.433Z,1598898381.433 [DAT] No Fault, FailCount= 4
2020-08-31T18:26:22.382Z,1598898382.382 [AMEcho](INFO): Powering down
2020-08-31T18:26:23.832Z,1598898383.832 [DAT](INFO): Powered 24V power converter LCB with command: ! echo 1 > /dev/loadB2
2020-08-31T18:26:23.832Z,1598898383.832 [DAT](INFO): Powering up
2020-08-31T18:26:23.832Z,1598898383.832 [DAT](DEBUG): Initializing DAT.
2020-08-31T18:26:23.906Z,1598898383.906 [CommandLine](IMPORTANT): got command ! echo 1 > /dev/loadB2
2020-08-31T18:26:28.302Z,1598898388.302 [DataOverHttps](INFO): Sending 186 bytes from file Logs/20200831T165910/Express0026.lzma
2020-08-31T18:26:29.304Z,1598898389.304 [DataOverHttps](INFO): Moved sent file to Logs/20200831T165910/Express0026.lzma.bak
2020-08-31T18:26:29.304Z,1598898389.304 [DataOverHttps](INFO): SBD MOMSN=12625896
2020-08-31T18:26:36.208Z,1598898396.208 [DAT](INFO): commRate: 800
2020-08-31T18:26:36.208Z,1598898396.208 [DAT](INFO): commRate: 800
2020-08-31T18:26:36.644Z,1598898396.644 [DAT](INFO): entering command mode
2020-08-31T18:26:36.983Z,1598898396.983 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:26:37.379Z,1598898397.379 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:26:37.816Z,1598898397.816 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:26:38.187Z,1598898398.187 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:26:38.591Z,1598898398.591 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:26:39.007Z,1598898399.007 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:26:39.408Z,1598898399.408 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:26:39.790Z,1598898399.790 [Depth_Keller](ERROR): Pressure reading out of range: 1650.297119 decibar
2020-08-31T18:26:39.792Z,1598898399.792 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:26:40.195Z,1598898400.195 [Depth_Keller](INFO): A/D timeout, 1 tries over 126 ms

2020-08-31T18:26:40.195Z,1598898400.195 [Depth_Keller] Data Fault, FailCount= 1
2020-08-31T18:26:40.195Z,1598898400.195 [Depth_Keller](ERROR): Data Fault
2020-08-31T18:26:40.196Z,1598898400.196 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:26:40.350Z,1598898400.350 [CBIT](ERROR): Data Fault in component: Depth_Keller
2020-08-31T18:26:40.350Z,1598898400.350 [CBIT](INFO): Clearing failed state for component Depth_Keller
2020-08-31T18:26:40.350Z,1598898400.350 [Depth_Keller] No Fault, FailCount= 1
2020-08-31T18:26:40.606Z,1598898400.606 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:26:41.015Z,1598898401.015 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:26:41.409Z,1598898401.409 [AHRS_M2](FAULT): Failed to acquire valid data within timeout.
2020-08-31T18:26:41.409Z,1598898401.409 [AHRS_M2] Data Fault, FailCount= 1
2020-08-31T18:26:41.409Z,1598898401.409 [AHRS_M2](ERROR): Data Fault
2020-08-31T18:26:41.424Z,1598898401.424 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:26:41.591Z,1598898401.591 [CBIT](ERROR): Data Fault in component: AHRS_M2
2020-08-31T18:26:41.809Z,1598898401.809 [AHRS_M2](INFO): Powering down
2020-08-31T18:26:41.891Z,1598898401.891 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:26:42.227Z,1598898402.227 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:26:42.627Z,1598898402.627 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:26:42.683Z,1598898402.683 [CBIT](INFO): Clearing failed state for component AHRS_M2
2020-08-31T18:26:42.683Z,1598898402.683 [AHRS_M2] No Fault, FailCount= 1
2020-08-31T18:26:43.013Z,1598898403.013 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2020-08-31T18:26:43.128Z,1598898403.128 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:26:43.464Z,1598898403.464 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:26:43.863Z,1598898403.863 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:26:44.321Z,1598898404.321 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:26:44.663Z,1598898404.663 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:26:45.075Z,1598898405.075 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:26:45.487Z,1598898405.487 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:26:45.895Z,1598898405.895 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:26:46.295Z,1598898406.295 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:26:46.788Z,1598898406.788 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:26:47.095Z,1598898407.095 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:26:47.505Z,1598898407.505 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:26:47.908Z,1598898407.908 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:26:48.315Z,1598898408.315 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:26:48.746Z,1598898408.746 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:26:49.131Z,1598898409.131 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:26:49.519Z,1598898409.519 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:26:49.916Z,1598898409.916 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:26:50.331Z,1598898410.331 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:26:50.531Z,1598898410.531 [CBIT](CRITICAL): run-time exception #7
2020-08-31T18:26:50.531Z,1598898410.531 [CBIT](CRITICAL): Bad address: 0x4041E008
2020-08-31T18:26:50.532Z,1598898410.532 [CBIT](CRITICAL): Backtrace: 
./bin/LRAUV(_ZN7PCaller20DefaultSignalHandlerEiP7siginfoPv+0x20) [0x17e158]
./bin/LRAUV(_ZN7PCaller10PThreadRunEPv+0xc8) [0x17dca4]

2020-08-31T18:26:50.532Z,1598898410.532 [CBIT] Software Fault, FailCount= 1
2020-08-31T18:26:50.532Z,1598898410.532 [CBIT](ERROR): Software Fault
2020-08-31T18:26:50.542Z,1598898410.542 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2020-08-31T18:26:50.542Z,1598898410.542 [SyncHandler](INFO): Protected caller Thread ID is 1417
2020-08-31T18:26:50.996Z,1598898410.996 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error
2020-08-31T18:26:51.005Z,1598898411.005 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:26:51.060Z,1598898411.060 [CBIT](DEBUG): Uninitialize CBIT Component.
2020-08-31T18:26:51.060Z,1598898411.060 [CBIT](DEBUG): Powering off loads.
2020-08-31T18:26:51.101Z,1598898411.101 [CBIT](DEBUG): Disabling WDT.
2020-08-31T18:26:51.113Z,1598898411.113 [CBIT](DEBUG): Opening all GF detection circuits.
2020-08-31T18:26:51.239Z,1598898411.239 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:26:51.620Z,1598898411.620 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:26:51.997Z,1598898411.997 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:26:52.005Z,1598898412.005 [DAT](FAULT): failed to enter command mode
2020-08-31T18:26:52.421Z,1598898412.421 [DAT](INFO): entering command mode
2020-08-31T18:26:52.808Z,1598898412.808 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:26:53.347Z,1598898413.347 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2020-08-31T18:26:53.815Z,1598898413.815 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2020-08-31T18:26:53.951Z,1598898413.951 [Depth_Keller](ERROR): Pressure reading out of range: 1650.297119 decibar
2020-08-31T18:26:53.953Z,1598898413.953 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:26:54.411Z,1598898414.411 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:26:54.820Z,1598898414.820 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:26:55.132Z,1598898415.132 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:26:55.453Z,1598898415.453 [ElevatorServo](ERROR): getPosition uart error serial timeout
2020-08-31T18:26:55.454Z,1598898415.454 [ElevatorServo](FAULT): Elevator uart error - getPosition.serial timeout
2020-08-31T18:26:55.454Z,1598898415.454 [ElevatorServo] Communications Fault, FailCount= 1
2020-08-31T18:26:55.454Z,1598898415.454 [ElevatorServo](ERROR): Communications Fault
2020-08-31T18:26:55.620Z,1598898415.620 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:26:55.664Z,1598898415.664 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2020-08-31T18:26:55.664Z,1598898415.664 [ElevatorServo](INFO): Powering down
2020-08-31T18:26:55.943Z,1598898415.943 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:26:56.431Z,1598898416.431 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:26:56.480Z,1598898416.480 [ElevatorServo](DEBUG): Initializing EZServoServo.
2020-08-31T18:26:56.480Z,1598898416.480 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2020-08-31T18:26:56.747Z,1598898416.747 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:26:57.159Z,1598898417.159 [RDI_Pathfinder](ERROR): No DVL communication! Re-initializing
2020-08-31T18:26:57.159Z,1598898417.159 [RDI_Pathfinder] Communications Fault, FailCount= 1
2020-08-31T18:26:57.159Z,1598898417.159 [RDI_Pathfinder](ERROR): Communications Fault
2020-08-31T18:26:57.160Z,1598898417.160 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:26:57.560Z,1598898417.560 [RDI_Pathfinder](INFO): Powering down
2020-08-31T18:26:57.561Z,1598898417.561 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:26:57.562Z,1598898417.562 [AMEcho](INFO): Powering up
2020-08-31T18:26:57.963Z,1598898417.963 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:26:58.467Z,1598898418.467 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:26:58.890Z,1598898418.890 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:26:59.269Z,1598898419.269 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:26:59.651Z,1598898419.651 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:27:00.067Z,1598898420.067 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:27:00.373Z,1598898420.373 [AHRS_M2](FAULT): Failed to acquire valid data within timeout.
2020-08-31T18:27:00.373Z,1598898420.373 [AHRS_M2] Data Fault, FailCount= 1
2020-08-31T18:27:00.373Z,1598898420.373 [AHRS_M2](ERROR): Data Fault
2020-08-31T18:27:00.463Z,1598898420.463 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:27:00.790Z,1598898420.790 [AHRS_M2](INFO): Powering down
2020-08-31T18:27:00.875Z,1598898420.875 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:27:01.176Z,1598898421.176 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:27:01.711Z,1598898421.711 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:27:02.010Z,1598898422.010 [Depth_Keller](ERROR): Pressure reading out of range: 1650.297119 decibar
2020-08-31T18:27:02.011Z,1598898422.011 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:27:02.523Z,1598898422.523 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:27:02.817Z,1598898422.817 [Depth_Keller](ERROR): Pressure reading out of range: 1650.297119 decibar
2020-08-31T18:27:02.822Z,1598898422.822 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:27:03.207Z,1598898423.207 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:27:03.703Z,1598898423.703 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:27:04.016Z,1598898424.016 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:27:04.507Z,1598898424.507 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:27:04.923Z,1598898424.923 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:27:05.331Z,1598898425.331 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:27:05.747Z,1598898425.747 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:27:06.050Z,1598898426.050 [Depth_Keller](ERROR): Pressure reading out of range: 1650.297119 decibar
2020-08-31T18:27:06.051Z,1598898426.051 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:27:06.587Z,1598898426.587 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:27:06.967Z,1598898426.967 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:27:07.371Z,1598898427.371 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:27:07.787Z,1598898427.787 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:27:07.787Z,1598898427.787 [DAT](FAULT): failed to enter command mode
2020-08-31T18:27:08.191Z,1598898428.191 [DAT](INFO): entering command mode
2020-08-31T18:27:08.583Z,1598898428.583 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:27:08.999Z,1598898428.999 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:27:09.391Z,1598898429.391 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:27:09.794Z,1598898429.794 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:27:10.199Z,1598898430.199 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:27:10.627Z,1598898430.627 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:27:11.006Z,1598898431.006 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:27:11.008Z,1598898431.008 [AMEcho](ERROR): No EchoSounder communication! Re-initializing
2020-08-31T18:27:11.008Z,1598898431.008 [AMEcho] Communications Fault, FailCount= 1
2020-08-31T18:27:11.008Z,1598898431.008 [AMEcho](ERROR): Communications Fault
2020-08-31T18:27:11.423Z,1598898431.423 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:27:11.424Z,1598898431.424 [AMEcho](INFO): Powering down
2020-08-31T18:27:11.827Z,1598898431.827 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:27:12.218Z,1598898432.218 [Depth_Keller](ERROR): Pressure reading out of range: 1650.297119 decibar
2020-08-31T18:27:12.218Z,1598898432.218 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:27:12.623Z,1598898432.623 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:27:13.027Z,1598898433.027 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:27:13.431Z,1598898433.431 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:27:13.847Z,1598898433.847 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:27:14.274Z,1598898434.274 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:27:14.643Z,1598898434.643 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:27:15.059Z,1598898435.059 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:27:15.451Z,1598898435.451 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:27:15.855Z,1598898435.855 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:27:16.258Z,1598898436.258 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:27:16.663Z,1598898436.663 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:27:17.066Z,1598898437.066 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:27:17.471Z,1598898437.471 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:27:17.887Z,1598898437.887 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:27:18.278Z,1598898438.279 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:27:18.694Z,1598898438.694 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:27:19.087Z,1598898439.087 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:27:19.502Z,1598898439.502 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:27:19.899Z,1598898439.899 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:27:20.299Z,1598898440.299 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:27:20.702Z,1598898440.702 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:27:21.119Z,1598898441.119 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:27:21.523Z,1598898441.523 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:27:21.914Z,1598898441.914 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:27:22.319Z,1598898442.319 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:27:22.542Z,1598898442.542 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2020-08-31T18:27:22.735Z,1598898442.735 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:27:23.139Z,1598898443.139 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:27:23.547Z,1598898443.547 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T18:27:23.547Z,1598898443.547 [DAT](FAULT): failed to enter command mode
2020-08-31T18:27:23.947Z,1598898443.947 [DAT](FAULT): failed to initialize, no bytes available on serial interface
2020-08-31T18:27:23.947Z,1598898443.947 [DAT] Communications Fault, FailCount= 5
2020-08-31T18:27:23.947Z,1598898443.947 [DAT](ERROR): Communications Fault
2020-08-31T18:27:24.338Z,1598898444.338 [DAT](INFO): Powering down
2020-08-31T18:27:29.570Z,1598898449.570 [DataOverHttps](INFO): setting unavailable, lastComms_.elapsed()=60.266281
2020-08-31T18:27:51.421Z,1598898471.421 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2020-08-31T18:27:51.436Z,1598898471.436 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2020-08-31T18:28:09.191Z,1598898489.191 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2
2020-08-31T18:28:09.191Z,1598898489.191 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-08-31T18:28:16.102Z,1598898496.102 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2020-08-31T18:28:16.197Z,1598898496.197 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2020-08-31T18:28:29.028Z,1598898509.028 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2020-08-31T18:28:29.787Z,1598898509.787 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2020-08-31T18:28:32.870Z,1598898512.870 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2020-08-31T18:28:42.329Z,1598898522.329 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2020-08-31T18:28:55.643Z,1598898535.643 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2020-08-31T18:29:08.025Z,1598898548.025 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2020-08-31T18:29:08.180Z,1598898548.180 [BPC1](ERROR): BPC1B buffer size (D84 bytes) exceeded the max device response limit.
2020-08-31T18:29:08.180Z,1598898548.180 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2020-08-31T18:29:21.144Z,1598898561.144 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2020-08-31T18:29:32.419Z,1598898572.419 [BPC1](ERROR): BPC1A buffer size (D06 bytes) exceeded the max device response limit.
2020-08-31T18:29:32.419Z,1598898572.419 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2020-08-31T18:29:33.262Z,1598898573.262 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2020-08-31T18:29:43.174Z,1598898583.174 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2020-08-31T18:29:44.596Z,1598898584.596 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2020-08-31T18:29:45.384Z,1598898585.384 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2020-08-31T18:30:07.200Z,1598898607.200 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2020-08-31T18:30:08.406Z,1598898608.406 [BPC1](ERROR): BPC1B failed to parse battery data