2019-03-26T15:58:03.897Z,1553615883.897 [Supervisor](DEBUG): Initializing supervisor.
2019-03-26T15:58:03.900Z,1553615883.900 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2019-03-26T15:58:03.901Z,1553615883.901 [SyncHandler](INFO): Protected caller Thread ID is 5535
2019-03-26T15:58:03.901Z,1553615883.901 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2019-03-26T15:58:03.902Z,1553615883.902 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2019-03-26T15:58:03.902Z,1553615883.902 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 5536
2019-03-26T15:58:03.906Z,1553615883.906 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2019-03-26T15:58:03.918Z,1553615883.918 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2019-03-26T15:58:03.919Z,1553615883.919 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2019-03-26T15:58:03.919Z,1553615883.919 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 5537
2019-03-26T15:58:03.920Z,1553615883.920 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2019-03-26T15:58:03.921Z,1553615883.921 [logger ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2019-03-26T15:58:03.921Z,1553615883.921 [logger ThreadHandler](INFO): Protected caller Thread ID is 5538
2019-03-26T15:58:03.923Z,1553615883.923 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2019-03-26T15:58:03.923Z,1553615883.923 [Supervisor](INFO): Looking for Config files in directory: Config/
2019-03-26T15:58:03.925Z,1553615883.925 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2019-03-26T15:58:04.124Z,1553615884.124 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2019-03-26T15:58:04.125Z,1553615884.125 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2019-03-26T15:58:04.206Z,1553615884.206 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2019-03-26T15:58:04.634Z,1553615884.634 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2019-03-26T15:58:04.635Z,1553615884.635 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2019-03-26T15:58:04.959Z,1553615884.959 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2019-03-26T15:58:04.959Z,1553615884.959 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2019-03-26T15:58:05.056Z,1553615885.056 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2019-03-26T15:58:05.056Z,1553615885.056 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2019-03-26T15:58:05.353Z,1553615885.353 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2019-03-26T15:58:05.353Z,1553615885.353 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2019-03-26T15:58:05.548Z,1553615885.548 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2019-03-26T15:58:05.549Z,1553615885.549 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2019-03-26T15:58:05.994Z,1553615885.994 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2019-03-26T15:58:05.995Z,1553615885.995 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2019-03-26T15:58:06.101Z,1553615886.101 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2019-03-26T15:58:06.102Z,1553615886.102 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2019-03-26T15:58:06.202Z,1553615886.202 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample
2019-03-26T15:58:06.203Z,1553615886.203 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2019-03-26T15:58:06.688Z,1553615886.688 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2019-03-26T15:58:06.688Z,1553615886.688 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2019-03-26T15:58:07.077Z,1553615887.077 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2019-03-26T15:58:07.077Z,1553615887.077 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2019-03-26T15:58:07.272Z,1553615887.272 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2019-03-26T15:58:07.273Z,1553615887.273 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2019-03-26T15:58:07.417Z,1553615887.417 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2019-03-26T15:58:07.418Z,1553615887.418 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2019-03-26T15:58:07.569Z,1553615887.569 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2019-03-26T15:58:07.571Z,1553615887.571 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-daphne/
2019-03-26T15:58:07.572Z,1553615887.572 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Navigation.cfg
2019-03-26T15:58:07.663Z,1553615887.663 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Simulator.cfg
2019-03-26T15:58:07.749Z,1553615887.749 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Control.cfg
2019-03-26T15:58:07.851Z,1553615887.851 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/secure.cfg
2019-03-26T15:58:07.934Z,1553615887.934 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Servo.cfg
2019-03-26T15:58:08.030Z,1553615888.030 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/BIT.cfg
2019-03-26T15:58:08.129Z,1553615888.129 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/vehicle.cfg
2019-03-26T15:58:08.333Z,1553615888.333 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/workSite.cfg
2019-03-26T15:58:08.410Z,1553615888.410 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Sensor.cfg
2019-03-26T15:58:08.599Z,1553615888.599 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Science.cfg
2019-03-26T15:58:08.862Z,1553615888.862 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/logger.cfg
2019-03-26T15:58:09.080Z,1553615889.080 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Battery.cfg
2019-03-26T15:58:09.382Z,1553615889.382 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2019-03-26T15:58:09.383Z,1553615889.383 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg
2019-03-26T15:58:09.385Z,1553615889.385 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2019-03-26T15:58:09.470Z,1553615889.470 [VerticalControl](DEBUG): Construct VerticalControl.
2019-03-26T15:58:09.581Z,1553615889.581 [VerticalControl] Loaded
2019-03-26T15:58:09.581Z,1553615889.581 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2019-03-26T15:58:09.582Z,1553615889.582 [HorizontalControl](DEBUG): Construct HorizontalControl.
2019-03-26T15:58:09.648Z,1553615889.648 [HorizontalControl] Loaded
2019-03-26T15:58:09.649Z,1553615889.649 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2019-03-26T15:58:09.649Z,1553615889.649 [SpeedControl](DEBUG): Construct SpeedControl.
2019-03-26T15:58:09.655Z,1553615889.655 [SpeedControl] Loaded
2019-03-26T15:58:09.655Z,1553615889.655 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2019-03-26T15:58:09.656Z,1553615889.656 [LoopControl](DEBUG): Construct LoopControl.
2019-03-26T15:58:09.656Z,1553615889.656 [LoopControl] Loaded
2019-03-26T15:58:09.656Z,1553615889.656 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2019-03-26T15:58:09.657Z,1553615889.657 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2019-03-26T15:58:09.658Z,1553615889.658 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2019-03-26T15:58:09.681Z,1553615889.681 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2019-03-26T15:58:09.681Z,1553615889.681 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2019-03-26T15:58:09.802Z,1553615889.802 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2019-03-26T15:58:09.802Z,1553615889.802 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2019-03-26T15:58:09.918Z,1553615889.918 [BuoyancyServo] Loaded
2019-03-26T15:58:09.918Z,1553615889.918 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2019-03-26T15:58:09.929Z,1553615889.929 [ElevatorServo] Loaded
2019-03-26T15:58:09.929Z,1553615889.929 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2019-03-26T15:58:09.940Z,1553615889.940 [MassServo] Loaded
2019-03-26T15:58:09.940Z,1553615889.940 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2019-03-26T15:58:09.951Z,1553615889.951 [RudderServo] Loaded
2019-03-26T15:58:09.951Z,1553615889.951 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2019-03-26T15:58:09.961Z,1553615889.961 [ThrusterServo] Loaded
2019-03-26T15:58:09.962Z,1553615889.962 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread.
2019-03-26T15:58:09.962Z,1553615889.962 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2019-03-26T15:58:09.963Z,1553615889.963 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2019-03-26T15:58:10.083Z,1553615890.083 [DeadReckonUsingMultipleVelocitySources] Loaded
2019-03-26T15:58:10.083Z,1553615890.083 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2019-03-26T15:58:10.140Z,1553615890.140 [DeadReckonUsingSpeedCalculator] Loaded
2019-03-26T15:58:10.141Z,1553615890.141 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread.
2019-03-26T15:58:10.197Z,1553615890.197 [DeadReckonWithRespectToSeafloor] Loaded
2019-03-26T15:58:10.197Z,1553615890.197 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonWithRespectToSeafloor" handled in the control thread.
2019-03-26T15:58:10.217Z,1553615890.217 [NavChart] Loaded
2019-03-26T15:58:10.217Z,1553615890.217 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2019-03-26T15:58:10.221Z,1553615890.221 [UniversalFixResidualReporter] Loaded
2019-03-26T15:58:10.222Z,1553615890.222 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2019-03-26T15:58:10.222Z,1553615890.222 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2019-03-26T15:58:10.223Z,1553615890.223 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2019-03-26T15:58:10.323Z,1553615890.323 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2019-03-26T15:58:10.324Z,1553615890.324 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2019-03-26T15:58:10.736Z,1553615890.736 [AHRS_M2] Loaded
2019-03-26T15:58:10.737Z,1553615890.737 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread.
2019-03-26T15:58:10.810Z,1553615890.810 [DataOverHttps] Loaded
2019-03-26T15:58:10.810Z,1553615890.810 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2019-03-26T15:58:10.811Z,1553615890.811 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 4086D4E0
2019-03-26T15:58:10.812Z,1553615890.812 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 5621
2019-03-26T15:58:10.825Z,1553615890.825 [Depth_Keller] Loaded
2019-03-26T15:58:10.826Z,1553615890.826 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2019-03-26T15:58:10.830Z,1553615890.830 [DropWeight] Loaded
2019-03-26T15:58:10.831Z,1553615890.831 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2019-03-26T15:58:10.955Z,1553615890.955 [DVL_micro] Loaded
2019-03-26T15:58:10.955Z,1553615890.955 [ComponentRegistry](DEBUG): SyncComponent "DVL_micro" handled in the control thread.
2019-03-26T15:58:11.050Z,1553615891.050 [NAL9602] Loaded
2019-03-26T15:58:11.050Z,1553615891.050 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2019-03-26T15:58:11.066Z,1553615891.066 [Onboard] Loaded
2019-03-26T15:58:11.066Z,1553615891.066 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread.
2019-03-26T15:58:11.069Z,1553615891.069 [Radio_Surface] Loaded
2019-03-26T15:58:11.069Z,1553615891.069 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2019-03-26T15:58:11.070Z,1553615891.070 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 4089D4E0
2019-03-26T15:58:11.071Z,1553615891.071 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 5622
2019-03-26T15:58:13.430Z,1553615893.430 [BPC1] Loaded
2019-03-26T15:58:13.430Z,1553615893.430 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2019-03-26T15:58:13.430Z,1553615893.430 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2019-03-26T15:58:13.431Z,1553615893.431 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2019-03-26T15:58:13.587Z,1553615893.587 [DepthRateCalculator] Loaded
2019-03-26T15:58:13.587Z,1553615893.587 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2019-03-26T15:58:13.593Z,1553615893.593 [PitchRateCalculator] Loaded
2019-03-26T15:58:13.593Z,1553615893.593 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2019-03-26T15:58:13.604Z,1553615893.604 [SpeedCalculator] Loaded
2019-03-26T15:58:13.604Z,1553615893.604 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2019-03-26T15:58:13.626Z,1553615893.626 [TempGradientCalculator] Loaded
2019-03-26T15:58:13.626Z,1553615893.626 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread.
2019-03-26T15:58:13.631Z,1553615893.631 [YawRateCalculator] Loaded
2019-03-26T15:58:13.631Z,1553615893.631 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2019-03-26T15:58:13.660Z,1553615893.660 [ElevatorOffsetCalculator] Loaded
2019-03-26T15:58:13.660Z,1553615893.660 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2019-03-26T15:58:13.661Z,1553615893.661 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2019-03-26T15:58:13.661Z,1553615893.661 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2019-03-26T15:58:14.048Z,1553615894.048 [CTD_NeilBrown] Loaded
2019-03-26T15:58:14.048Z,1553615894.048 [ComponentRegistry](DEBUG): Component "CTD_NeilBrown" handled in its own thread.
2019-03-26T15:58:14.049Z,1553615894.049 [CTD_NeilBrown ThreadHandler](DEBUG): Created PCaller Thread at 4099E4E0
2019-03-26T15:58:14.049Z,1553615894.049 [CTD_NeilBrown ThreadHandler](INFO): Protected caller Thread ID is 5623
2019-03-26T15:58:14.059Z,1553615894.059 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_density
2019-03-26T15:58:14.064Z,1553615894.064 [CTD_Seabird](INFO): created writer for : sea_water_density
2019-03-26T15:58:14.066Z,1553615894.066 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): depth
2019-03-26T15:58:14.071Z,1553615894.071 [CTD_Seabird](INFO): created writer for : depth
2019-03-26T15:58:14.071Z,1553615894.071 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_pressure
2019-03-26T15:58:14.076Z,1553615894.076 [CTD_Seabird](INFO): created writer for : sea_water_pressure
2019-03-26T15:58:14.077Z,1553615894.077 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_salinity
2019-03-26T15:58:14.082Z,1553615894.082 [CTD_Seabird](INFO): created writer for : sea_water_salinity
2019-03-26T15:58:14.082Z,1553615894.082 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_temperature
2019-03-26T15:58:14.087Z,1553615894.087 [CTD_Seabird](INFO): created writer for : sea_water_temperature
2019-03-26T15:58:14.088Z,1553615894.088 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_electrical_conductivity
2019-03-26T15:58:14.093Z,1553615894.093 [CTD_Seabird](INFO): created writer for : sea_water_electrical_conductivity
2019-03-26T15:58:14.093Z,1553615894.093 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): speed_of_sound_in_sea_water
2019-03-26T15:58:14.098Z,1553615894.098 [CTD_Seabird](INFO): created writer for : speed_of_sound_in_sea_water
2019-03-26T15:58:14.124Z,1553615894.124 [CTD_Seabird] Loaded
2019-03-26T15:58:14.125Z,1553615894.125 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread.
2019-03-26T15:58:14.126Z,1553615894.126 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 409CE4E0
2019-03-26T15:58:14.126Z,1553615894.126 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 5624
2019-03-26T15:58:14.151Z,1553615894.151 [ESPComponent] Loaded
2019-03-26T15:58:14.152Z,1553615894.152 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread.
2019-03-26T15:58:14.165Z,1553615894.165 [PAR_Licor] Loaded
2019-03-26T15:58:14.166Z,1553615894.166 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2019-03-26T15:58:14.212Z,1553615894.212 [WetLabsBB2FL] Loaded
2019-03-26T15:58:14.213Z,1553615894.213 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2019-03-26T15:58:14.214Z,1553615894.214 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 409FE4E0
2019-03-26T15:58:14.214Z,1553615894.214 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 5625
2019-03-26T15:58:14.215Z,1553615894.215 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2019-03-26T15:58:14.215Z,1553615894.215 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2019-03-26T15:58:14.255Z,1553615894.255 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2019-03-26T15:58:14.256Z,1553615894.256 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2019-03-26T15:58:14.564Z,1553615894.564 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2019-03-26T15:58:14.564Z,1553615894.564 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2019-03-26T15:58:14.716Z,1553615894.716 [SBIT](DEBUG): Construct Startup Built In Test.
2019-03-26T15:58:14.727Z,1553615894.727 [SBIT] Loaded
2019-03-26T15:58:14.728Z,1553615894.728 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2019-03-26T15:58:14.728Z,1553615894.728 [IBIT](DEBUG): Construct Initiated Built In Test.
2019-03-26T15:58:14.740Z,1553615894.740 [IBIT] Loaded
2019-03-26T15:58:14.740Z,1553615894.740 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2019-03-26T15:58:14.743Z,1553615894.743 [CBIT](DEBUG): Construct Continuous Built In Test.
2019-03-26T15:58:14.880Z,1553615894.880 [CBIT] Loaded
2019-03-26T15:58:14.880Z,1553615894.880 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2019-03-26T15:58:14.880Z,1553615894.880 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2019-03-26T15:58:14.884Z,1553615894.884 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2019-03-26T15:58:14.885Z,1553615894.885 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2019-03-26T15:58:14.892Z,1553615894.892 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2019-03-26T15:58:14.893Z,1553615894.893 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40AF54E0
2019-03-26T15:58:14.893Z,1553615894.893 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 5626
2019-03-26T15:58:14.898Z,1553615894.898 [Supervisor](INFO): Main Thread ID is 5534
2019-03-26T15:58:14.898Z,1553615894.898 [Supervisor](DEBUG): Running supervisor.
2019-03-26T15:58:14.899Z,1553615894.899 [CommandLine ThreadHandler](INFO): Handler Thread ID is 5627
2019-03-26T15:58:14.902Z,1553615894.902 [controlThread ThreadHandler](INFO): Handler Thread ID is 5628
2019-03-26T15:58:14.902Z,1553615894.902 [controlThread](DEBUG): Initializing ControlThread
2019-03-26T15:58:14.903Z,1553615894.903 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2019-03-26T15:58:14.904Z,1553615894.904 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2019-03-26T15:58:14.905Z,1553615894.905 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2019-03-26T15:58:14.906Z,1553615894.906 [LoopControl](DEBUG): Initialize LoopControlComponent.
2019-03-26T15:58:14.907Z,1553615894.907 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2019-03-26T15:58:14.908Z,1553615894.908 [NavChart](DEBUG): Initialize NavChart Navigation.
2019-03-26T15:58:14.909Z,1553615894.909 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2019-03-26T15:58:14.915Z,1553615894.915 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2019-03-26T15:58:14.915Z,1553615894.915 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2019-03-26T15:58:14.916Z,1553615894.916 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2019-03-26T15:58:14.916Z,1553615894.916 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator.
2019-03-26T15:58:14.917Z,1553615894.917 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2019-03-26T15:58:14.917Z,1553615894.917 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2019-03-26T15:58:14.921Z,1553615894.921 [SBIT](INFO): Initialize SBIT Component.
2019-03-26T15:58:14.922Z,1553615894.922 [SBIT](IMPORTANT): git: 2019-03-18-25-g41eb097
2019-03-26T15:58:14.922Z,1553615894.922 [SBIT](INFO): git hash: 41eb097d057d44a6b31f942ace2973a2253fba2e
2019-03-26T15:58:14.922Z,1553615894.922 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2019-03-26T15:58:14.923Z,1553615894.923 [SBIT](INFO): Kernel Reporting Different Version From Configuration.
Kernel Expected: #2 PREEMPT Thu Jan 11 20:13:48 PST 2018
Kernel Reported: #1 PREEMPT Tue Dec 18 21:19:28 PST 2018
2019-03-26T15:58:14.924Z,1553615894.924 [SBIT](INFO): Beginning SBIT in 23.000000 seconds.
2019-03-26T15:58:14.925Z,1553615894.925 [IBIT](INFO): Initialize IBIT Component.
2019-03-26T15:58:14.926Z,1553615894.926 [CBIT](DEBUG): Initialize CBIT Component.
2019-03-26T15:58:14.927Z,1553615894.927 [logger ThreadHandler](INFO): Handler Thread ID is 5629
2019-03-26T15:58:14.937Z,1553615894.937 [CBIT](DEBUG): Initialized mux pins.
2019-03-26T15:58:14.937Z,1553615894.937 [CBIT](DEBUG): Initializing the watchdog timer.
2019-03-26T15:58:14.945Z,1553615894.945 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 5630
2019-03-26T15:58:14.946Z,1553615894.946 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2019-03-26T15:58:14.957Z,1553615894.957 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 5631
2019-03-26T15:58:14.961Z,1553615894.961 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2019-03-26T15:58:14.961Z,1553615894.961 [CBIT](DEBUG): Initializing heartbeat.
2019-03-26T15:58:14.969Z,1553615894.969 [CTD_NeilBrown ThreadHandler](INFO): Handler Thread ID is 5632
2019-03-26T15:58:14.970Z,1553615894.970 [CTD_NeilBrown](INFO): Powering down
2019-03-26T15:58:14.997Z,1553615894.997 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 5633
2019-03-26T15:58:14.998Z,1553615894.998 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2019-03-26T15:58:15.001Z,1553615895.001 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 5635
2019-03-26T15:58:15.003Z,1553615895.003 [WetLabsBB2FL](INFO): Powering down
2019-03-26T15:58:15.021Z,1553615895.021 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20
2019-03-26T15:58:15.033Z,1553615895.033 [CBIT](DEBUG): Deactivating GF circuits.
2019-03-26T15:58:15.033Z,1553615895.033 [CBIT](DEBUG): Deactivating emergency mode.
2019-03-26T15:58:15.034Z,1553615895.034 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 5636
2019-03-26T15:58:15.039Z,1553615895.039 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2019-03-26T15:58:15.039Z,1553615895.039 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2019-03-26T15:58:15.040Z,1553615895.040 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2019-03-26T15:58:15.040Z,1553615895.040 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2019-03-26T15:58:15.040Z,1553615895.040 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2019-03-26T15:58:15.040Z,1553615895.040 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2019-03-26T15:58:15.041Z,1553615895.041 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000
2019-03-26T15:58:15.041Z,1553615895.041 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000
2019-03-26T15:58:15.041Z,1553615895.041 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2019-03-26T15:58:15.041Z,1553615895.041 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2019-03-26T15:58:15.042Z,1553615895.042 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000
2019-03-26T15:58:15.042Z,1553615895.042 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000
2019-03-26T15:58:15.042Z,1553615895.042 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000
2019-03-26T15:58:15.042Z,1553615895.042 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000
2019-03-26T15:58:15.043Z,1553615895.043 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000
2019-03-26T15:58:15.043Z,1553615895.043 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000
2019-03-26T15:58:15.069Z,1553615895.069 [CBIT](DEBUG): Backplane powered.
2019-03-26T15:58:15.070Z,1553615895.070 [MissionManager](INFO): Loading Mission: Missions/Startup.xml
2019-03-26T15:58:15.081Z,1553615895.081 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2019-03-26T15:58:15.092Z,1553615895.092 [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>


2019-03-26T15:58:15.109Z,1553615895.109 [MissionManager](INFO): Loading Mission: Missions/Default.xml
2019-03-26T15:58:15.160Z,1553615895.160 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2019-03-26T15:58:15.181Z,1553615895.181 [Default:A.Wait](DEBUG): Construct Wait.
2019-03-26T15:58:15.182Z,1553615895.182 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2019-03-26T15:58:15.213Z,1553615895.213 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2019-03-26T15:58:15.216Z,1553615895.216 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2019-03-26T15:58:15.237Z,1553615895.237 [Default:E.Execute](DEBUG): Construct Execute.
2019-03-26T15:58:15.257Z,1553615895.257 [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>


2019-03-26T15:58:15.262Z,1553615895.262 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,Depth_Keller,DropWeight,DVL_micro,NAL9602,Onboard,BPC1,ESPComponent,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,DeadReckonUsingSpeedCalculator,DeadReckonWithRespectToSeafloor,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter,
2019-03-26T15:58:15.269Z,1553615895.269 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2019-03-26T15:58:15.323Z,1553615895.323 [DVL_micro](INFO): Initializing
2019-03-26T15:58:15.361Z,1553615895.361 [Radio_Surface](INFO): Powering up
2019-03-26T15:58:15.389Z,1553615895.389 [ESPComponent](INFO): powering down ESP
2019-03-26T15:58:15.851Z,1553615895.851 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2019-03-26T15:58:15.857Z,1553615895.857 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2019-03-26T15:58:15.858Z,1553615895.858 [ElevatorServo](DEBUG): Initializing EZServoServo.
2019-03-26T15:58:15.873Z,1553615895.873 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2019-03-26T15:58:15.874Z,1553615895.874 [MassServo](DEBUG): Initializing EZServoServo.
2019-03-26T15:58:15.885Z,1553615895.885 [MassServo](DEBUG): Initializing MassServo.
2019-03-26T15:58:15.886Z,1553615895.886 [RudderServo](DEBUG): Initializing EZServoServo.
2019-03-26T15:58:15.897Z,1553615895.897 [RudderServo](DEBUG): Initializing RudderServo.
2019-03-26T15:58:15.898Z,1553615895.898 [ThrusterServo](DEBUG): Initializing EZServoServo.
2019-03-26T15:58:15.909Z,1553615895.909 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2019-03-26T15:58:16.086Z,1553615896.086 [DropWeight](CRITICAL): DROP WEIGHT MISSING.

2019-03-26T15:58:16.086Z,1553615896.086 [DropWeight] Hardware Fault, FailCount= 1
2019-03-26T15:58:16.086Z,1553615896.086 [DropWeight](ERROR): Hardware Fault
2019-03-26T15:58:16.172Z,1553615896.172 [CommandLine](FAULT): Scheduling is paused
2019-03-26T15:58:16.173Z,1553615896.173 [CBIT](INFO): Critical error at 20190326T155816
2019-03-26T15:58:16.173Z,1553615896.173 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals
2019-03-26T15:58:16.176Z,1553615896.176 [CBIT](ERROR): Hardware Fault in component: DropWeight
2019-03-26T15:58:16.176Z,1553615896.176 [CBIT](CRITICAL): Hardware Fault in component: DropWeight
2019-03-26T15:58:16.383Z,1553615896.383 [CBIT](INFO): Critical error at 20190326T155816
2019-03-26T15:58:18.965Z,1553615898.965 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T15:58:19.541Z,1553615899.541 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T15:58:19.738Z,1553615899.738 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial buffer full
2019-03-26T15:58:20.893Z,1553615900.893 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T15:58:21.657Z,1553615901.657 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T15:58:22.025Z,1553615902.025 [MassServo](ERROR): isCommunicating uart error serial timeout
2019-03-26T15:58:22.025Z,1553615902.025 [MassServo](FAULT): Invalid EZ Servo response:""
2019-03-26T15:58:22.025Z,1553615902.025 [MassServo] Communications Fault, FailCount= 1
2019-03-26T15:58:22.025Z,1553615902.025 [MassServo](ERROR): Communications Fault
2019-03-26T15:58:22.026Z,1553615902.026 [MassServo](FAULT): Mass Shifter error waiting for homing. Uart error: serial timeout
2019-03-26T15:58:22.026Z,1553615902.026 [MassServo] Hardware Fault, FailCount= 1
2019-03-26T15:58:22.026Z,1553615902.026 [MassServo](ERROR): Hardware Fault
2019-03-26T15:58:22.357Z,1553615902.357 [MassServo](FAULT): Invalid EZ Servo response:"0\r"
2019-03-26T15:58:22.358Z,1553615902.358 [MassServo] Communications Fault, FailCount= 1
2019-03-26T15:58:22.358Z,1553615902.358 [MassServo](ERROR): Communications Fault
2019-03-26T15:58:22.362Z,1553615902.362 [CBIT](ERROR): Communications Fault in component: MassServo
2019-03-26T15:58:22.693Z,1553615902.693 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T15:58:22.969Z,1553615902.969 [MassServo](DEBUG): Uninitialize Mass Servo.
2019-03-26T15:58:22.970Z,1553615902.970 [MassServo](INFO): Powering down
2019-03-26T15:58:23.134Z,1553615903.134 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial buffer full
2019-03-26T15:58:24.133Z,1553615904.133 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T15:58:24.227Z,1553615904.227 [MassServo](DEBUG): Initializing EZServoServo.
2019-03-26T15:58:24.346Z,1553615904.346 [MassServo](DEBUG): Initializing MassServo.
2019-03-26T15:58:24.350Z,1553615904.350 [CBIT](INFO): Clearing failed state for component MassServo
2019-03-26T15:58:24.350Z,1553615904.350 [MassServo] No Fault, FailCount= 1
2019-03-26T15:58:24.469Z,1553615904.469 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T15:58:24.865Z,1553615904.865 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial buffer full
2019-03-26T15:58:24.988Z,1553615904.988 [CBIT](CRITICAL): Environmental Failure. Press:14.759317 PSI. Humidity:34%. Temp:26 C. ABORTING MISSION
2019-03-26T15:58:25.653Z,1553615905.653 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T15:58:25.752Z,1553615905.752 [CBIT](INFO): Critical error at 20190326T155824
2019-03-26T15:58:26.257Z,1553615906.257 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T15:58:26.262Z,1553615906.262 [DVL_micro](ERROR): No DVL communication! Re-initializing
2019-03-26T15:58:26.262Z,1553615906.262 [DVL_micro] Communications Fault, FailCount= 1
2019-03-26T15:58:26.262Z,1553615906.262 [DVL_micro](ERROR): Communications Fault
2019-03-26T15:58:26.318Z,1553615906.318 [CBIT](ERROR): Communications Fault in component: DVL_micro
2019-03-26T15:58:26.473Z,1553615906.473 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T15:58:26.549Z,1553615906.549 [DVL_micro](INFO): uninitialize:Powering down
2019-03-26T15:58:26.841Z,1553615906.841 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T15:58:27.249Z,1553615907.249 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T15:58:27.485Z,1553615907.485 [CBIT](INFO): Clearing failed state for component DVL_micro
2019-03-26T15:58:27.485Z,1553615907.485 [DVL_micro] No Fault, FailCount= 1
2019-03-26T15:58:27.805Z,1553615907.805 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T15:58:27.816Z,1553615907.816 [DVL_micro](INFO): Initializing
2019-03-26T15:58:28.065Z,1553615908.065 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T15:58:28.065Z,1553615908.065 [AHRS_M2](FAULT): Failed to initialize within timeout.
2019-03-26T15:58:28.065Z,1553615908.065 [AHRS_M2] Communications Fault, FailCount= 1
2019-03-26T15:58:28.065Z,1553615908.065 [AHRS_M2](ERROR): Communications Fault
2019-03-26T15:58:28.230Z,1553615908.230 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.021097
2019-03-26T15:58:28.238Z,1553615908.238 [MassServo](ERROR): isCommunicating uart error serial timeout
2019-03-26T15:58:28.239Z,1553615908.239 [MassServo](FAULT): Invalid EZ Servo response:"\377"
2019-03-26T15:58:28.240Z,1553615908.240 [MassServo] Communications Fault, FailCount= 2
2019-03-26T15:58:28.240Z,1553615908.240 [MassServo](ERROR): Communications Fault
2019-03-26T15:58:28.241Z,1553615908.241 [MassServo](FAULT): Mass Shifter error waiting for homing. Uart error: serial timeout
2019-03-26T15:58:28.242Z,1553615908.242 [MassServo] Hardware Fault, FailCount= 2
2019-03-26T15:58:28.242Z,1553615908.242 [MassServo](ERROR): Hardware Fault
2019-03-26T15:58:28.414Z,1553615908.414 [MassServo](FAULT): Invalid EZ Servo response:"`41"
2019-03-26T15:58:28.414Z,1553615908.414 [MassServo] Communications Fault, FailCount= 2
2019-03-26T15:58:28.414Z,1553615908.414 [MassServo](ERROR): Communications Fault
2019-03-26T15:58:28.420Z,1553615908.420 [CBIT](ERROR): Communications Fault in component: MassServo
2019-03-26T15:58:28.421Z,1553615908.421 [CBIT](ERROR): Communications Fault in component: AHRS_M2
2019-03-26T15:58:28.426Z,1553615908.426 [AHRS_M2](INFO): Powering down
2019-03-26T15:58:28.634Z,1553615908.634 [MassServo](DEBUG): Uninitialize Mass Servo.
2019-03-26T15:58:28.634Z,1553615908.634 [MassServo](INFO): Powering down
2019-03-26T15:58:29.302Z,1553615909.302 [MassServo](DEBUG): Initializing EZServoServo.
2019-03-26T15:58:29.422Z,1553615909.422 [MassServo](DEBUG): Initializing MassServo.
2019-03-26T15:58:29.427Z,1553615909.427 [CBIT](INFO): Clearing failed state for component MassServo
2019-03-26T15:58:29.427Z,1553615909.427 [MassServo] No Fault, FailCount= 2
2019-03-26T15:58:29.427Z,1553615909.427 [CBIT](INFO): Clearing failed state for component AHRS_M2
2019-03-26T15:58:29.427Z,1553615909.427 [AHRS_M2] No Fault, FailCount= 1
2019-03-26T15:58:29.637Z,1553615909.637 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2019-03-26T15:58:33.317Z,1553615913.317 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T15:58:33.629Z,1553615913.629 [MassServo](FAULT): Invalid EZ Servo response:""
2019-03-26T15:58:33.629Z,1553615913.629 [MassServo] Communications Fault, FailCount= 3
2019-03-26T15:58:33.629Z,1553615913.629 [MassServo](ERROR): Communications Fault
2019-03-26T15:58:33.629Z,1553615913.629 [MassServo](FAULT): Mass Shifter error waiting for homing. Uart error: no error
2019-03-26T15:58:33.629Z,1553615913.629 [MassServo] Hardware Fault, FailCount= 3
2019-03-26T15:58:33.629Z,1553615913.629 [MassServo](ERROR): Hardware Fault
2019-03-26T15:58:33.666Z,1553615913.666 [MassServo](FAULT): Reading outside of valid range:1106723.000000

2019-03-26T15:58:33.670Z,1553615913.670 [CBIT](ERROR): Hardware Fault in component: MassServo
2019-03-26T15:58:34.101Z,1553615914.101 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T15:58:34.150Z,1553615914.150 [MassServo](DEBUG): Uninitialize Mass Servo.
2019-03-26T15:58:34.151Z,1553615914.151 [MassServo](INFO): Powering down
2019-03-26T15:58:34.297Z,1553615914.297 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T15:58:34.677Z,1553615914.677 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T15:58:34.766Z,1553615914.766 [MassServo](DEBUG): Initializing EZServoServo.
2019-03-26T15:58:34.886Z,1553615914.886 [MassServo](DEBUG): Initializing MassServo.
2019-03-26T15:58:34.890Z,1553615914.890 [CBIT](INFO): Clearing failed state for component MassServo
2019-03-26T15:58:34.890Z,1553615914.890 [MassServo] No Fault, FailCount= 3
2019-03-26T15:58:35.069Z,1553615915.069 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T15:58:35.473Z,1553615915.473 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T15:58:35.877Z,1553615915.877 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T15:58:36.445Z,1553615916.445 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T15:58:36.713Z,1553615916.713 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T15:58:37.089Z,1553615917.089 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T15:58:37.493Z,1553615917.493 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T15:58:38.109Z,1553615918.109 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T15:58:38.118Z,1553615918.118 [DVL_micro](ERROR): No DVL communication! Re-initializing
2019-03-26T15:58:38.118Z,1553615918.118 [DVL_micro] Communications Fault, FailCount= 2
2019-03-26T15:58:38.118Z,1553615918.118 [DVL_micro](ERROR): Communications Fault
2019-03-26T15:58:38.175Z,1553615918.175 [CBIT](ERROR): Communications Fault in component: DVL_micro
2019-03-26T15:58:38.325Z,1553615918.325 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T15:58:38.401Z,1553615918.401 [DVL_micro](INFO): uninitialize:Powering down
2019-03-26T15:58:38.731Z,1553615918.731 [MassServo](FAULT): Invalid EZ Servo response:"\r\n"
2019-03-26T15:58:38.731Z,1553615918.731 [MassServo] Communications Fault, FailCount= 4
2019-03-26T15:58:38.731Z,1553615918.731 [MassServo](ERROR): Communications Fault
2019-03-26T15:58:38.731Z,1553615918.731 [MassServo](FAULT): Mass Shifter error waiting for homing. Uart error: no error
2019-03-26T15:58:38.731Z,1553615918.731 [MassServo] Hardware Fault, FailCount= 4
2019-03-26T15:58:38.732Z,1553615918.732 [MassServo](ERROR): Hardware Fault
2019-03-26T15:58:39.109Z,1553615919.109 [SBIT](IMPORTANT): Beginning Startup BIT
2019-03-26T15:58:39.113Z,1553615919.113 [CBIT](ERROR): Hardware Fault in component: MassServo
2019-03-26T15:58:39.113Z,1553615919.113 [CBIT](IMPORTANT): Beginning ground fault scan
2019-03-26T15:58:39.525Z,1553615919.525 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T15:58:39.658Z,1553615919.658 [ElevatorServo](ERROR): getPosition uart error serial timeout
2019-03-26T15:58:39.659Z,1553615919.659 [ElevatorServo](FAULT): Elevator uart error - getPosition.serial timeout
2019-03-26T15:58:39.659Z,1553615919.659 [ElevatorServo] Communications Fault, FailCount= 1
2019-03-26T15:58:39.659Z,1553615919.659 [ElevatorServo](ERROR): Communications Fault
2019-03-26T15:58:39.661Z,1553615919.661 [MassServo](DEBUG): Uninitialize Mass Servo.
2019-03-26T15:58:39.662Z,1553615919.662 [MassServo](INFO): Powering down
2019-03-26T15:58:39.858Z,1553615919.858 [CBIT](ERROR): Communications Fault in component: ElevatorServo
2019-03-26T15:58:40.333Z,1553615920.333 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T15:58:40.390Z,1553615920.390 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2019-03-26T15:58:40.390Z,1553615920.390 [ElevatorServo](INFO): Powering down
2019-03-26T15:58:40.473Z,1553615920.473 [CBIT](INFO): Clearing failed state for component DVL_micro
2019-03-26T15:58:40.474Z,1553615920.474 [DVL_micro] No Fault, FailCount= 2
2019-03-26T15:58:40.589Z,1553615920.589 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T15:58:40.600Z,1553615920.600 [DVL_micro](INFO): Initializing
2019-03-26T15:58:40.640Z,1553615920.640 [MassServo](DEBUG): Initializing EZServoServo.
2019-03-26T15:58:40.758Z,1553615920.758 [MassServo](DEBUG): Initializing MassServo.
2019-03-26T15:58:40.763Z,1553615920.763 [CBIT](INFO): Clearing failed state for component MassServo
2019-03-26T15:58:40.763Z,1553615920.763 [MassServo] No Fault, FailCount= 4
2019-03-26T15:58:40.981Z,1553615920.981 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T15:58:41.074Z,1553615921.074 [ElevatorServo](DEBUG): Initializing EZServoServo.
2019-03-26T15:58:41.194Z,1553615921.194 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2019-03-26T15:58:41.282Z,1553615921.282 [RudderServo](ERROR): getPosition uart error serial timeout
2019-03-26T15:58:41.283Z,1553615921.283 [RudderServo](FAULT): Rudder uart error - getPosition..serial timeout
2019-03-26T15:58:41.283Z,1553615921.283 [RudderServo] Communications Fault, FailCount= 1
2019-03-26T15:58:41.283Z,1553615921.283 [RudderServo](ERROR): Communications Fault
2019-03-26T15:58:41.293Z,1553615921.293 [CBIT](INFO): Clearing failed state for component ElevatorServo
2019-03-26T15:58:41.293Z,1553615921.293 [ElevatorServo] No Fault, FailCount= 1
2019-03-26T15:58:41.293Z,1553615921.293 [CBIT](ERROR): Communications Fault in component: RudderServo
2019-03-26T15:58:41.601Z,1553615921.601 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T15:58:41.606Z,1553615921.606 [NAL9602](INFO): Powering up NAL9602
2019-03-26T15:58:41.675Z,1553615921.675 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2019-03-26T15:58:41.675Z,1553615921.675 [RudderServo](INFO): Powering down
2019-03-26T15:58:42.101Z,1553615922.101 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T15:58:42.601Z,1553615922.601 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T15:58:42.601Z,1553615922.601 [AHRS_M2](FAULT): Failed to initialize within timeout.
2019-03-26T15:58:42.601Z,1553615922.601 [AHRS_M2] Communications Fault, FailCount= 2
2019-03-26T15:58:42.601Z,1553615922.601 [AHRS_M2](ERROR): Communications Fault
2019-03-26T15:58:42.657Z,1553615922.657 [RudderServo](DEBUG): Initializing EZServoServo.
2019-03-26T15:58:42.778Z,1553615922.778 [RudderServo](DEBUG): Initializing RudderServo.
2019-03-26T15:58:42.782Z,1553615922.782 [CBIT](INFO): Clearing failed state for component RudderServo
2019-03-26T15:58:42.783Z,1553615922.783 [RudderServo] No Fault, FailCount= 1
2019-03-26T15:58:42.783Z,1553615922.783 [CBIT](ERROR): Communications Fault in component: AHRS_M2
2019-03-26T15:58:42.901Z,1553615922.901 [AHRS_M2](INFO): Powering down
2019-03-26T15:59:12.978Z,1553615952.978 [DVL_micro](ERROR): No DVL communication! Re-initializing
2019-03-26T15:59:12.978Z,1553615952.978 [DVL_micro] Communications Fault, FailCount= 3
2019-03-26T15:59:12.978Z,1553615952.978 [DVL_micro](ERROR): Communications Fault
2019-03-26T15:59:13.090Z,1553615953.090 [SBIT](ERROR): Could not read elevatorAngleReader_.
2019-03-26T15:59:13.090Z,1553615953.090 [SBIT](ERROR): Could not read rudderAngleReader_.
2019-03-26T15:59:13.090Z,1553615953.090 [SBIT](ERROR): Could not read massPosReader_.
2019-03-26T15:59:13.094Z,1553615953.094 [CBIT](ERROR): Communications Fault in component: DVL_micro
2019-03-26T15:59:13.206Z,1553615953.206 [AHRS_M2](FAULT): LCB fault: LCB Watchdog Reset. Invalid Command. Hardware Overcurrent Shutdown. Software Overcurrent. Current Limiter Activated.
2019-03-26T15:59:13.206Z,1553615953.206 [AHRS_M2] Hardware Fault, FailCount= 2
2019-03-26T15:59:13.206Z,1553615953.206 [AHRS_M2](ERROR): Hardware Fault
2019-03-26T15:59:13.289Z,1553615953.289 [DVL_micro](INFO): uninitialize:Powering down
2019-03-26T15:59:13.606Z,1553615953.606 [NAL9602](INFO): NAL9602 initialized
2019-03-26T15:59:13.655Z,1553615953.655 [CBIT](INFO): Clearing failed state for component AHRS_M2
2019-03-26T15:59:13.655Z,1553615953.655 [AHRS_M2] No Fault, FailCount= 2
2019-03-26T15:59:14.005Z,1553615954.005 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2019-03-26T15:59:14.357Z,1553615954.357 [ElevatorServo](FAULT): Invalid EZ Servo response:""
2019-03-26T15:59:14.357Z,1553615954.357 [ElevatorServo] Communications Fault, FailCount= 2
2019-03-26T15:59:14.357Z,1553615954.357 [ElevatorServo](ERROR): Communications Fault
2019-03-26T15:59:14.357Z,1553615954.357 [ElevatorServo](ERROR): Elevator reporting null position
2019-03-26T15:59:14.389Z,1553615954.389 [CBIT](ERROR): Communications Fault in component: ElevatorServo
2019-03-26T15:59:14.390Z,1553615954.390 [CBIT](INFO): Clearing failed state for component DVL_micro
2019-03-26T15:59:14.390Z,1553615954.390 [DVL_micro] No Fault, FailCount= 3
2019-03-26T15:59:14.506Z,1553615954.506 [DVL_micro](INFO): Initializing
2019-03-26T15:59:14.533Z,1553615954.533 [NAL9602](DEBUG): Fix Requested
2019-03-26T15:59:14.570Z,1553615954.570 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2019-03-26T15:59:14.571Z,1553615954.571 [ElevatorServo](INFO): Powering down
2019-03-26T15:59:14.853Z,1553615954.853 [MassServo](FAULT): Invalid EZ Servo response:""
2019-03-26T15:59:14.853Z,1553615954.853 [MassServo] Communications Fault, FailCount= 5
2019-03-26T15:59:14.853Z,1553615954.853 [MassServo](ERROR): Communications Fault
2019-03-26T15:59:14.854Z,1553615954.854 [MassServo](FAULT): Mass Shifter error waiting for homing. Uart error: no error
2019-03-26T15:59:14.854Z,1553615954.854 [MassServo] Hardware Fault, FailCount= 5
2019-03-26T15:59:14.854Z,1553615954.854 [MassServo](ERROR): Hardware Fault
2019-03-26T15:59:14.917Z,1553615954.917 [CBIT](ERROR): Hardware Fault in component: MassServo
2019-03-26T15:59:14.918Z,1553615954.918 [CBIT](CRITICAL): Hardware Fault in component: MassServo
2019-03-26T15:59:14.995Z,1553615954.995 [MassServo](DEBUG): Uninitialize Mass Servo.
2019-03-26T15:59:14.995Z,1553615954.995 [MassServo](INFO): Powering down
2019-03-26T15:59:14.999Z,1553615954.999 [CBIT](INFO): Critical error at 20190326T155914
2019-03-26T15:59:15.407Z,1553615955.407 [ElevatorServo](DEBUG): Initializing EZServoServo.
2019-03-26T15:59:15.522Z,1553615955.522 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2019-03-26T15:59:15.745Z,1553615955.745 [RudderServo](FAULT): Invalid EZ Servo response:""
2019-03-26T15:59:15.745Z,1553615955.745 [RudderServo] Communications Fault, FailCount= 2
2019-03-26T15:59:15.745Z,1553615955.745 [RudderServo](ERROR): Communications Fault
2019-03-26T15:59:15.745Z,1553615955.745 [RudderServo](ERROR): Rudder reporting null position
2019-03-26T15:59:15.756Z,1553615955.756 [CBIT](INFO): Clearing failed state for component ElevatorServo
2019-03-26T15:59:15.757Z,1553615955.757 [ElevatorServo] No Fault, FailCount= 2
2019-03-26T15:59:15.757Z,1553615955.757 [CBIT](ERROR): Communications Fault in component: RudderServo
2019-03-26T15:59:15.835Z,1553615955.835 [MassServo](DEBUG): Initializing EZServoServo.
2019-03-26T15:59:15.950Z,1553615955.950 [MassServo](DEBUG): Initializing MassServo.
2019-03-26T15:59:15.950Z,1553615955.950 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2019-03-26T15:59:15.951Z,1553615955.951 [RudderServo](INFO): Powering down
2019-03-26T15:59:16.821Z,1553615956.821 [RudderServo](DEBUG): Initializing EZServoServo.
2019-03-26T15:59:16.942Z,1553615956.942 [RudderServo](DEBUG): Initializing RudderServo.
2019-03-26T15:59:16.947Z,1553615956.947 [CBIT](INFO): Clearing failed state for component RudderServo
2019-03-26T15:59:16.947Z,1553615956.947 [RudderServo] No Fault, FailCount= 2
2019-03-26T15:59:18.261Z,1553615958.261 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T15:59:18.801Z,1553615958.801 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T15:59:19.605Z,1553615959.605 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T15:59:19.905Z,1553615959.905 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T15:59:20.221Z,1553615960.221 [ElevatorServo](FAULT): Invalid EZ Servo response:""
2019-03-26T15:59:20.222Z,1553615960.222 [ElevatorServo] Communications Fault, FailCount= 3
2019-03-26T15:59:20.222Z,1553615960.222 [ElevatorServo](ERROR): Communications Fault
2019-03-26T15:59:20.222Z,1553615960.222 [ElevatorServo](ERROR): Elevator reporting null position
2019-03-26T15:59:20.253Z,1553615960.253 [CBIT](ERROR): Communications Fault in component: ElevatorServo
2019-03-26T15:59:20.253Z,1553615960.253 [CBIT](CRITICAL): Communications Fault in component: ElevatorServo
2019-03-26T15:59:20.258Z,1553615960.258 [CBIT](IMPORTANT): Ground fault detected
mA:
CHAN A0 (Batt): -0.001196
CHAN A1 (24V): -0.133152
CHAN A2 (12V): -0.001773
CHAN A3 (5V): -0.001453
CHAN B0 (3.3V): 0.000328
CHAN B1 (3.15aV): -0.000234
CHAN B2 (3.15bV): 0.000543
CHAN B3 (GND): 0.000190
OPEN: -0.000348
Full Scale Calc: 4.765 mA, -1.589 mA
2019-03-26T15:59:20.773Z,1553615960.773 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T15:59:20.823Z,1553615960.823 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2019-03-26T15:59:20.823Z,1553615960.823 [ElevatorServo](INFO): Powering down
2019-03-26T15:59:20.850Z,1553615960.850 [CBIT](INFO): Critical error at 20190326T155920
2019-03-26T15:59:20.985Z,1553615960.985 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T15:59:21.285Z,1553615961.285 [RudderServo](ERROR): getPosition uart error serial timeout
2019-03-26T15:59:21.285Z,1553615961.285 [RudderServo](FAULT): Rudder uart error - getPosition..serial timeout
2019-03-26T15:59:21.285Z,1553615961.285 [RudderServo] Communications Fault, FailCount= 3
2019-03-26T15:59:21.285Z,1553615961.285 [RudderServo](ERROR): Communications Fault
2019-03-26T15:59:21.301Z,1553615961.301 [CBIT](ERROR): Communications Fault in component: RudderServo
2019-03-26T15:59:21.302Z,1553615961.302 [CBIT](CRITICAL): Communications Fault in component: RudderServo
2019-03-26T15:59:21.681Z,1553615961.681 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T15:59:21.751Z,1553615961.751 [ElevatorServo](DEBUG): Initializing EZServoServo.
2019-03-26T15:59:21.870Z,1553615961.870 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2019-03-26T15:59:21.870Z,1553615961.870 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2019-03-26T15:59:21.870Z,1553615961.870 [RudderServo](INFO): Powering down
2019-03-26T15:59:21.873Z,1553615961.873 [CBIT](INFO): Critical error at 20190326T155921
2019-03-26T15:59:21.989Z,1553615961.989 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T15:59:22.385Z,1553615962.385 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T15:59:22.455Z,1553615962.455 [RudderServo](DEBUG): Initializing EZServoServo.
2019-03-26T15:59:22.578Z,1553615962.578 [RudderServo](DEBUG): Initializing RudderServo.
2019-03-26T15:59:22.789Z,1553615962.789 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T15:59:23.193Z,1553615963.193 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T15:59:23.597Z,1553615963.597 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T15:59:23.989Z,1553615963.989 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T15:59:24.393Z,1553615964.393 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T15:59:24.797Z,1553615964.797 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T15:59:25.201Z,1553615965.201 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T15:59:25.202Z,1553615965.202 [DVL_micro](ERROR): No DVL communication! Re-initializing
2019-03-26T15:59:25.203Z,1553615965.203 [DVL_micro] Communications Fault, FailCount= 4
2019-03-26T15:59:25.203Z,1553615965.203 [DVL_micro](ERROR): Communications Fault
2019-03-26T15:59:25.234Z,1553615965.234 [CBIT](ERROR): Communications Fault in component: DVL_micro
2019-03-26T15:59:25.605Z,1553615965.605 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T15:59:25.685Z,1553615965.685 [DVL_micro](INFO): uninitialize:Powering down
2019-03-26T15:59:26.013Z,1553615966.013 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T15:59:26.421Z,1553615966.421 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T15:59:26.460Z,1553615966.460 [CBIT](INFO): Clearing failed state for component DVL_micro
2019-03-26T15:59:26.461Z,1553615966.461 [DVL_micro] No Fault, FailCount= 4
2019-03-26T15:59:26.825Z,1553615966.825 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T15:59:26.836Z,1553615966.836 [DVL_micro](INFO): Initializing
2019-03-26T15:59:27.222Z,1553615967.222 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T15:59:27.222Z,1553615967.222 [AHRS_M2](FAULT): Failed to initialize within timeout.
2019-03-26T15:59:27.222Z,1553615967.222 [AHRS_M2] Communications Fault, FailCount= 3
2019-03-26T15:59:27.222Z,1553615967.222 [AHRS_M2](ERROR): Communications Fault
2019-03-26T15:59:27.265Z,1553615967.265 [CBIT](ERROR): Communications Fault in component: AHRS_M2
2019-03-26T15:59:27.537Z,1553615967.537 [AHRS_M2](INFO): Powering down
2019-03-26T15:59:57.618Z,1553615997.618 [DVL_micro](ERROR): No DVL communication! Re-initializing
2019-03-26T15:59:57.618Z,1553615997.618 [DVL_micro] Communications Fault, FailCount= 5
2019-03-26T15:59:57.618Z,1553615997.618 [DVL_micro](ERROR): Communications Fault
2019-03-26T15:59:57.660Z,1553615997.660 [SBIT](ERROR): Could not read elevatorAngleReader_.
2019-03-26T15:59:57.661Z,1553615997.661 [SBIT](ERROR): Could not read rudderAngleReader_.
2019-03-26T15:59:57.661Z,1553615997.661 [SBIT](ERROR): Could not read massPosReader_.
2019-03-26T15:59:57.661Z,1553615997.661 [SBIT](FAULT): Control surface position failure.
2019-03-26T15:59:57.665Z,1553615997.665 [CBIT](ERROR): Communications Fault in component: DVL_micro
2019-03-26T15:59:57.665Z,1553615997.665 [CBIT](CRITICAL): Communications Fault in component: DVL_micro
2019-03-26T15:59:57.671Z,1553615997.671 [AHRS_M2](FAULT): LCB fault: LCB Watchdog Reset. Invalid Command. Hardware Overcurrent Shutdown. Software Overcurrent. Current Limiter Activated.
2019-03-26T15:59:57.671Z,1553615997.671 [AHRS_M2] Hardware Fault, FailCount= 3
2019-03-26T15:59:57.671Z,1553615997.671 [AHRS_M2](ERROR): Hardware Fault
2019-03-26T15:59:57.813Z,1553615997.813 [DVL_micro](INFO): uninitialize:Powering down
2019-03-26T15:59:57.857Z,1553615997.857 [CBIT](INFO): Critical error at 20190326T155957
2019-03-26T15:59:58.108Z,1553615998.108 [BPC1](ERROR): BPC1B buffer size (A3B bytes) exceeded the max device response limit.
2019-03-26T15:59:58.108Z,1553615998.108 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2019-03-26T15:59:58.145Z,1553615998.145 [CBIT](INFO): Clearing failed state for component AHRS_M2
2019-03-26T15:59:58.145Z,1553615998.145 [AHRS_M2] No Fault, FailCount= 3
2019-03-26T15:59:58.477Z,1553615998.477 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2019-03-26T15:59:58.515Z,1553615998.515 [BPC1](ERROR): BPC1A buffer size (A3B bytes) exceeded the max device response limit.
2019-03-26T15:59:58.515Z,1553615998.515 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2019-03-26T16:00:01.805Z,1553616001.805 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T16:00:02.201Z,1553616002.201 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T16:00:02.609Z,1553616002.609 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T16:00:03.009Z,1553616003.009 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T16:00:03.429Z,1553616003.429 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T16:00:03.829Z,1553616003.829 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T16:00:04.225Z,1553616004.225 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T16:00:04.633Z,1553616004.633 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T16:00:05.029Z,1553616005.029 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T16:00:05.433Z,1553616005.433 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T16:00:05.837Z,1553616005.837 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T16:00:06.241Z,1553616006.241 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T16:00:06.653Z,1553616006.653 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T16:00:07.061Z,1553616007.061 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T16:00:07.453Z,1553616007.453 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T16:00:07.865Z,1553616007.865 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T16:00:08.261Z,1553616008.261 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T16:00:08.665Z,1553616008.665 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T16:00:09.077Z,1553616009.077 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T16:00:09.473Z,1553616009.473 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T16:00:09.885Z,1553616009.885 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T16:00:10.289Z,1553616010.289 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T16:00:10.685Z,1553616010.685 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T16:00:11.097Z,1553616011.097 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T16:00:11.134Z,1553616011.134 [SBIT](ERROR): Could not read elevatorAngleReader_.
2019-03-26T16:00:11.134Z,1553616011.134 [SBIT](ERROR): Could not read rudderAngleReader_.
2019-03-26T16:00:11.134Z,1553616011.134 [SBIT](ERROR): Could not read massPosReader_.
2019-03-26T16:00:11.134Z,1553616011.134 [SBIT](FAULT): Control surface position failure.
2019-03-26T16:00:11.501Z,1553616011.501 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T16:00:11.501Z,1553616011.501 [AHRS_M2](FAULT): Failed to initialize within timeout.
2019-03-26T16:00:11.501Z,1553616011.501 [AHRS_M2] Communications Fault, FailCount= 4
2019-03-26T16:00:11.501Z,1553616011.501 [AHRS_M2](ERROR): Communications Fault
2019-03-26T16:00:11.537Z,1553616011.537 [SBIT](CRITICAL): SBIT FAILED
2019-03-26T16:00:11.552Z,1553616011.552 [CBIT](INFO): Critical error at 20190326T160011
2019-03-26T16:00:11.555Z,1553616011.555 [CBIT](ERROR): Communications Fault in component: AHRS_M2
2019-03-26T16:00:11.630Z,1553616011.630 [CommandLine](IMPORTANT): got command configSet list
2019-03-26T16:00:11.630Z,1553616011.630 [CommandLine](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2019-03-26T16:00:11.631Z,1553616011.631 [CommandLine](IMPORTANT): No configSet variables persisted
2019-03-26T16:00:11.809Z,1553616011.809 [AHRS_M2](INFO): Powering down
2019-03-26T16:00:42.041Z,1553616042.041 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-03-26T16:00:42.042Z,1553616042.042 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2019-03-26T16:00:42.042Z,1553616042.042 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-03-26T16:00:42.043Z,1553616042.043 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-03-26T16:00:42.043Z,1553616042.043 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 1
2019-03-26T16:00:42.043Z,1553616042.043 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2019-03-26T16:00:42.045Z,1553616042.045 [DeadReckonWithRespectToSeafloor](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-03-26T16:00:42.045Z,1553616042.045 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1
2019-03-26T16:00:42.045Z,1553616042.045 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2019-03-26T16:00:42.046Z,1553616042.046 [MissionManager](IMPORTANT): Started mission Startup
2019-03-26T16:00:42.047Z,1553616042.047 [Startup] Running Loop=1
2019-03-26T16:00:42.047Z,1553616042.047 [Startup](DEBUG): Aggregate::initialize Startup
2019-03-26T16:00:42.047Z,1553616042.047 [Startup:A.GoToSurface] Running Loop=1
2019-03-26T16:00:42.047Z,1553616042.047 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2019-03-26T16:00:42.048Z,1553616042.048 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2019-03-26T16:00:42.048Z,1553616042.048 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2019-03-26T16:00:42.049Z,1553616042.049 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2019-03-26T16:00:42.049Z,1553616042.049 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2019-03-26T16:00:42.049Z,1553616042.049 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2019-03-26T16:00:42.051Z,1553616042.051 [Startup:StartupSatComms] Running Loop=1
2019-03-26T16:00:42.051Z,1553616042.051 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2019-03-26T16:00:42.051Z,1553616042.051 [Startup:StartupSatComms:A] Running Loop=1
2019-03-26T16:00:42.059Z,1553616042.059 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-03-26T16:00:42.060Z,1553616042.060 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2019-03-26T16:00:42.060Z,1553616042.060 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2019-03-26T16:00:42.066Z,1553616042.066 [AHRS_M2](FAULT): LCB fault: LCB Watchdog Reset. Invalid Command. Hardware Overcurrent Shutdown. Software Overcurrent. Current Limiter Activated.
2019-03-26T16:00:42.066Z,1553616042.066 [AHRS_M2] Hardware Fault, FailCount= 4
2019-03-26T16:00:42.066Z,1553616042.066 [AHRS_M2](ERROR): Hardware Fault
2019-03-26T16:00:42.334Z,1553616042.334 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2019-03-26T16:00:42.359Z,1553616042.359 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-03-26T16:00:42.361Z,1553616042.361 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2019-03-26T16:00:42.362Z,1553616042.362 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2019-03-26T16:00:42.362Z,1553616042.362 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 1
2019-03-26T16:00:42.362Z,1553616042.362 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2019-03-26T16:00:42.362Z,1553616042.362 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1
2019-03-26T16:00:42.560Z,1553616042.560 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2019-03-26T16:00:42.569Z,1553616042.569 [CBIT](INFO): Clearing failed state for component AHRS_M2
2019-03-26T16:00:42.569Z,1553616042.569 [AHRS_M2] No Fault, FailCount= 4
2019-03-26T16:00:42.873Z,1553616042.873 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2019-03-26T16:00:46.201Z,1553616046.201 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T16:00:46.597Z,1553616046.597 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T16:00:47.001Z,1553616047.001 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T16:00:47.405Z,1553616047.405 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T16:00:47.809Z,1553616047.809 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T16:00:48.213Z,1553616048.213 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T16:00:48.617Z,1553616048.617 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T16:00:49.021Z,1553616049.021 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T16:00:49.425Z,1553616049.425 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T16:00:49.829Z,1553616049.829 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T16:00:50.233Z,1553616050.233 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T16:00:50.645Z,1553616050.645 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T16:00:51.041Z,1553616051.041 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T16:00:51.453Z,1553616051.453 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T16:00:51.849Z,1553616051.849 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T16:00:52.253Z,1553616052.253 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T16:00:52.657Z,1553616052.657 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T16:00:53.061Z,1553616053.061 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T16:00:53.465Z,1553616053.465 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T16:00:53.869Z,1553616053.869 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T16:00:54.273Z,1553616054.273 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T16:00:54.685Z,1553616054.685 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T16:00:55.082Z,1553616055.082 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T16:00:55.485Z,1553616055.485 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T16:00:55.889Z,1553616055.889 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T16:00:55.889Z,1553616055.889 [AHRS_M2](FAULT): Failed to initialize within timeout.
2019-03-26T16:00:55.889Z,1553616055.889 [AHRS_M2] Communications Fault, FailCount= 5
2019-03-26T16:00:55.889Z,1553616055.889 [AHRS_M2](ERROR): Communications Fault
2019-03-26T16:00:55.948Z,1553616055.948 [CBIT](ERROR): Communications Fault in component: AHRS_M2
2019-03-26T16:00:55.948Z,1553616055.948 [CBIT](CRITICAL): Communications Fault in component: AHRS_M2
2019-03-26T16:00:56.205Z,1553616056.205 [AHRS_M2](INFO): Powering down
2019-03-26T16:01:26.387Z,1553616086.387 [CBIT](INFO): Critical error at 20190326T160055
2019-03-26T16:01:26.421Z,1553616086.421 [AHRS_M2](FAULT): LCB fault: LCB Watchdog Reset. Invalid Command. Hardware Overcurrent Shutdown. Software Overcurrent. Current Limiter Activated.
2019-03-26T16:01:26.421Z,1553616086.421 [AHRS_M2] Hardware Fault, FailCount= 5
2019-03-26T16:01:26.421Z,1553616086.421 [AHRS_M2](ERROR): Hardware Fault
2019-03-26T16:01:42.216Z,1553616102.216 [Startup:StartupSatComms:A](INFO): Timed out from 2019-03-26T16:00:42.1Z
2019-03-26T16:01:42.217Z,1553616102.217 [Startup:StartupSatComms:A] Stopped
2019-03-26T16:01:42.217Z,1553616102.217 [Startup:StartupSatComms:B] Running Loop=1
2019-03-26T16:01:42.615Z,1553616102.615 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2019-03-26T16:01:47.204Z,1553616107.204 [DataOverHttps](INFO): Sending 69 bytes from file Logs/20190325T235747/Courier0016.lzma
2019-03-26T16:01:48.010Z,1553616108.010 [DataOverHttps](INFO): Moved sent file to Logs/20190325T235747/Courier0016.lzma.bak
2019-03-26T16:01:48.011Z,1553616108.011 [DataOverHttps](INFO): SBD MOMSN=10250212
2019-03-26T16:01:58.389Z,1553616118.389 [DataOverHttps](INFO): Sending 323 bytes from file Logs/20190326T155803/Courier0000.lzma
2019-03-26T16:01:59.194Z,1553616119.194 [DataOverHttps](INFO): Moved sent file to Logs/20190326T155803/Courier0000.lzma.bak
2019-03-26T16:01:59.194Z,1553616119.194 [DataOverHttps](INFO): SBD MOMSN=10250215
2019-03-26T16:02:09.548Z,1553616129.548 [DataOverHttps](INFO): Sending 170 bytes from file Logs/20190325T235747/Express0017.lzma
2019-03-26T16:02:10.354Z,1553616130.354 [DataOverHttps](INFO): Moved sent file to Logs/20190325T235747/Express0017.lzma.bak
2019-03-26T16:02:10.354Z,1553616130.354 [DataOverHttps](INFO): SBD MOMSN=10250227
2019-03-26T16:02:20.742Z,1553616140.742 [DataOverHttps](INFO): Sending 1225 bytes from file Logs/20190326T155803/Express0001.lzma
2019-03-26T16:02:21.546Z,1553616141.546 [DataOverHttps](INFO): Moved sent file to Logs/20190326T155803/Express0001.lzma.bak
2019-03-26T16:02:21.546Z,1553616141.546 [DataOverHttps](INFO): SBD MOMSN=10250232
2019-03-26T16:02:22.191Z,1553616142.191 [Startup:StartupSatComms:B] Stopped
2019-03-26T16:02:22.191Z,1553616142.191 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2019-03-26T16:02:22.191Z,1553616142.191 [Startup:StartupSatComms] Stopped
2019-03-26T16:02:22.192Z,1553616142.192 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2019-03-26T16:02:22.192Z,1553616142.192 [Startup](INFO): Completed Startup
2019-03-26T16:02:22.192Z,1553616142.192 [MissionManager](INFO): Startup is completed.
2019-03-26T16:02:22.193Z,1553616142.193 [MissionManager](INFO): Uninitializing Mission Startup
2019-03-26T16:02:22.193Z,1553616142.193 [Startup] Stopped
2019-03-26T16:02:22.193Z,1553616142.193 [Startup](DEBUG): Aggregate::uninitialize Startup
2019-03-26T16:02:22.193Z,1553616142.193 [Startup:A.GoToSurface] Stopped
2019-03-26T16:02:22.193Z,1553616142.193 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2019-03-26T16:02:22.604Z,1553616142.604 [MissionManager](IMPORTANT): Started mission Default
2019-03-26T16:02:22.605Z,1553616142.605 [Default] Running Loop=1
2019-03-26T16:02:22.605Z,1553616142.605 [Default](DEBUG): Aggregate::initialize Default
2019-03-26T16:02:22.605Z,1553616142.605 [Default:B.GoToSurface] Running Loop=1
2019-03-26T16:02:22.605Z,1553616142.605 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2019-03-26T16:02:22.605Z,1553616142.605 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2019-03-26T16:02:22.606Z,1553616142.606 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2019-03-26T16:02:22.606Z,1553616142.606 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2019-03-26T16:02:22.606Z,1553616142.606 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2019-03-26T16:02:22.607Z,1553616142.607 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2019-03-26T16:02:22.607Z,1553616142.607 [Default:A.Wait] Running Loop=1
2019-03-26T16:02:22.607Z,1553616142.607 [Default:A.Wait](DEBUG): Initialize Wait Component.
2019-03-26T16:02:35.932Z,1553616155.932 [Default:A.Wait](INFO): Done Waiting.
2019-03-26T16:02:35.933Z,1553616155.933 [Default:A.Wait] Stopped
2019-03-26T16:02:35.933Z,1553616155.933 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2019-03-26T16:02:36.344Z,1553616156.344 [Default:CheckIn] Running Loop=1
2019-03-26T16:02:36.344Z,1553616156.344 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2019-03-26T16:02:36.345Z,1553616156.345 [Default:CheckIn:Read_GPS] Running Loop=1
2019-03-26T16:02:36.739Z,1553616156.739 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2019-03-26T16:02:42.793Z,1553616162.793 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-03-26T16:02:42.793Z,1553616162.793 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2
2019-03-26T16:02:42.793Z,1553616162.793 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-03-26T16:02:42.795Z,1553616162.795 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-03-26T16:02:42.795Z,1553616162.795 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 2
2019-03-26T16:02:42.795Z,1553616162.795 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2019-03-26T16:02:42.796Z,1553616162.796 [DeadReckonWithRespectToSeafloor](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-03-26T16:02:42.796Z,1553616162.796 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 2
2019-03-26T16:02:42.796Z,1553616162.796 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2019-03-26T16:02:42.806Z,1553616162.806 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-03-26T16:02:42.806Z,1553616162.806 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2019-03-26T16:02:42.807Z,1553616162.807 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2019-03-26T16:02:43.219Z,1553616163.219 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-03-26T16:02:43.219Z,1553616163.219 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2
2019-03-26T16:02:43.219Z,1553616163.219 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2019-03-26T16:02:43.219Z,1553616163.219 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 2
2019-03-26T16:02:43.220Z,1553616163.220 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2019-03-26T16:02:43.220Z,1553616163.220 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 2
2019-03-26T16:02:43.605Z,1553616163.605 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2019-03-26T16:04:14.935Z,1553616254.935 [CBIT](INFO): Clearing failed state for component MassServo
2019-03-26T16:04:14.935Z,1553616254.935 [MassServo] No Fault, FailCount= 5
2019-03-26T16:04:18.518Z,1553616258.518 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2019-03-26T16:04:19.345Z,1553616259.345 [NAL9602](DEBUG): Fix Requested
2019-03-26T16:04:19.825Z,1553616259.825 [MassServo](INFO): Failure count cleared after critical for MassServo
2019-03-26T16:04:22.168Z,1553616262.168 [NAL9602](DEBUG): Fix Requested
2019-03-26T16:04:24.993Z,1553616264.993 [NAL9602](DEBUG): Fix Requested
2019-03-26T16:04:27.013Z,1553616267.013 [NAL9602](DEBUG): Fix Requested
2019-03-26T16:04:30.249Z,1553616270.249 [NAL9602](DEBUG): Fix Requested
2019-03-26T16:04:33.073Z,1553616273.073 [NAL9602](DEBUG): Fix Requested
2019-03-26T16:04:36.305Z,1553616276.305 [NAL9602](DEBUG): Fix Requested
2019-03-26T16:04:39.133Z,1553616279.133 [NAL9602](DEBUG): Fix Requested
2019-03-26T16:04:42.373Z,1553616282.373 [NAL9602](DEBUG): Fix Requested
2019-03-26T16:04:43.997Z,1553616283.997 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-03-26T16:04:43.997Z,1553616283.997 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3
2019-03-26T16:04:43.997Z,1553616283.997 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-03-26T16:04:43.999Z,1553616283.999 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-03-26T16:04:43.999Z,1553616283.999 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 3
2019-03-26T16:04:43.999Z,1553616283.999 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2019-03-26T16:04:44.000Z,1553616284.000 [DeadReckonWithRespectToSeafloor](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-03-26T16:04:44.000Z,1553616284.000 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 3
2019-03-26T16:04:44.000Z,1553616284.000 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2019-03-26T16:04:44.010Z,1553616284.010 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-03-26T16:04:44.010Z,1553616284.010 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2019-03-26T16:04:44.011Z,1553616284.011 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2019-03-26T16:04:44.411Z,1553616284.411 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-03-26T16:04:44.411Z,1553616284.411 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3
2019-03-26T16:04:44.411Z,1553616284.411 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2019-03-26T16:04:44.411Z,1553616284.411 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 3
2019-03-26T16:04:44.412Z,1553616284.412 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2019-03-26T16:04:44.412Z,1553616284.412 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 3
2019-03-26T16:04:44.805Z,1553616284.805 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2019-03-26T16:04:45.193Z,1553616285.193 [NAL9602](DEBUG): Fix Requested
2019-03-26T16:04:48.021Z,1553616288.021 [NAL9602](DEBUG): Fix Requested
2019-03-26T16:04:49.090Z,1553616289.090 [CommandLine](IMPORTANT): got command failComponent
2019-03-26T16:04:49.091Z,1553616289.091 [CommandLine](IMPORTANT): Failed components:
2019-03-26T16:04:49.091Z,1553616289.091 [CommandLine](IMPORTANT): ElevatorServo: Communications Fault
2019-03-26T16:04:49.092Z,1553616289.092 [CommandLine](IMPORTANT): RudderServo: Communications Fault
2019-03-26T16:04:49.092Z,1553616289.092 [CommandLine](IMPORTANT): AHRS_M2: Hardware Fault
2019-03-26T16:04:49.092Z,1553616289.092 [CommandLine](IMPORTANT): DropWeight: Hardware Fault
2019-03-26T16:04:49.092Z,1553616289.092 [CommandLine](IMPORTANT): DVL_micro: Communications Fault
2019-03-26T16:04:50.045Z,1553616290.045 [NAL9602](DEBUG): Fix Requested
2019-03-26T16:04:52.065Z,1553616292.065 [NAL9602](DEBUG): Fix Requested
2019-03-26T16:04:55.293Z,1553616295.293 [NAL9602](DEBUG): Fix Requested
2019-03-26T16:04:58.129Z,1553616298.129 [NAL9602](DEBUG): Fix Requested
2019-03-26T16:05:01.357Z,1553616301.357 [NAL9602](DEBUG): Fix Requested
2019-03-26T16:05:04.185Z,1553616304.185 [NAL9602](DEBUG): Fix Requested
2019-03-26T16:05:07.029Z,1553616307.029 [NAL9602](DEBUG): Fix Requested
2019-03-26T16:05:09.049Z,1553616309.049 [NAL9602](DEBUG): Fix Requested
2019-03-26T16:05:11.069Z,1553616311.069 [NAL9602](DEBUG): Fix Requested
2019-03-26T16:05:13.085Z,1553616313.085 [NAL9602](DEBUG): Fix Requested
2019-03-26T16:05:16.317Z,1553616316.317 [NAL9602](DEBUG): Fix Requested
2019-03-26T16:05:19.145Z,1553616319.145 [NAL9602](DEBUG): Fix Requested
2019-03-26T16:05:22.377Z,1553616322.377 [NAL9602](DEBUG): Fix Requested
2019-03-26T16:05:25.205Z,1553616325.205 [NAL9602](DEBUG): Fix Requested
2019-03-26T16:05:28.441Z,1553616328.441 [NAL9602](DEBUG): Fix Requested
2019-03-26T16:05:31.265Z,1553616331.265 [NAL9602](DEBUG): Fix Requested
2019-03-26T16:05:34.097Z,1553616334.097 [NAL9602](DEBUG): Fix Requested
2019-03-26T16:05:36.113Z,1553616336.113 [NAL9602](DEBUG): Fix Requested
2019-03-26T16:05:38.137Z,1553616338.137 [NAL9602](DEBUG): Fix Requested
2019-03-26T16:05:41.369Z,1553616341.369 [NAL9602](DEBUG): Fix Requested
2019-03-26T16:05:44.193Z,1553616344.193 [NAL9602](DEBUG): Fix Requested
2019-03-26T16:05:45.833Z,1553616345.833 [CommandLine](IMPORTANT): got command load
2019-03-26T16:05:45.834Z,1553616345.834 [CommandLine](FAULT): Incomplete syntax. Try: help load
2019-03-26T16:05:47.433Z,1553616347.433 [NAL9602](DEBUG): Fix Requested
2019-03-26T16:05:47.694Z,1553616347.694 [CommandLine](IMPORTANT): got command load
2019-03-26T16:05:47.695Z,1553616347.695 [CommandLine](FAULT): Incomplete syntax. Try: help load
2019-03-26T16:05:50.257Z,1553616350.257 [NAL9602](DEBUG): Fix Requested
2019-03-26T16:05:53.489Z,1553616353.489 [NAL9602](DEBUG): Fix Requested
2019-03-26T16:05:55.972Z,1553616355.972 [CBIT](INFO): Clearing failed state for component AHRS_M2
2019-03-26T16:05:55.972Z,1553616355.972 [AHRS_M2] No Fault, FailCount= 5
2019-03-26T16:05:56.297Z,1553616356.297 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2019-03-26T16:05:56.329Z,1553616356.329 [NAL9602](DEBUG): Fix Requested
2019-03-26T16:05:59.141Z,1553616359.141 [NAL9602](DEBUG): Fix Requested
2019-03-26T16:05:59.613Z,1553616359.613 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T16:06:00.041Z,1553616360.041 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T16:06:00.430Z,1553616360.430 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T16:06:00.825Z,1553616360.825 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T16:06:01.253Z,1553616361.253 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T16:06:01.633Z,1553616361.633 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T16:06:02.061Z,1553616362.061 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T16:06:02.445Z,1553616362.445 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T16:06:02.461Z,1553616362.461 [NAL9602](DEBUG): Fix Requested
2019-03-26T16:06:02.849Z,1553616362.849 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T16:06:03.253Z,1553616363.253 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T16:06:03.657Z,1553616363.657 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T16:06:04.061Z,1553616364.061 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T16:06:04.477Z,1553616364.477 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T16:06:04.881Z,1553616364.881 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T16:06:05.277Z,1553616365.277 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T16:06:05.297Z,1553616365.297 [NAL9602](DEBUG): Fix Requested
2019-03-26T16:06:05.689Z,1553616365.689 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T16:06:06.093Z,1553616366.093 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T16:06:06.497Z,1553616366.497 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T16:06:06.901Z,1553616366.901 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T16:06:07.294Z,1553616367.294 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T16:06:07.697Z,1553616367.697 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T16:06:08.113Z,1553616368.113 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T16:06:08.137Z,1553616368.137 [NAL9602](DEBUG): Fix Requested
2019-03-26T16:06:08.517Z,1553616368.517 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T16:06:08.913Z,1553616368.913 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T16:06:09.325Z,1553616369.325 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T16:06:09.325Z,1553616369.325 [AHRS_M2](FAULT): Failed to initialize within timeout.
2019-03-26T16:06:09.325Z,1553616369.325 [AHRS_M2] Communications Fault, FailCount= 1
2019-03-26T16:06:09.325Z,1553616369.325 [AHRS_M2](ERROR): Communications Fault
2019-03-26T16:06:09.376Z,1553616369.376 [CBIT](ERROR): Communications Fault in component: AHRS_M2
2019-03-26T16:06:09.629Z,1553616369.629 [AHRS_M2](INFO): Powering down
2019-03-26T16:06:39.771Z,1553616399.771 [AHRS_M2](FAULT): LCB fault: LCB Watchdog Reset. Invalid Command. Hardware Overcurrent Shutdown. Software Overcurrent. Current Limiter Activated.
2019-03-26T16:06:39.771Z,1553616399.771 [AHRS_M2] Hardware Fault, FailCount= 1
2019-03-26T16:06:39.771Z,1553616399.771 [AHRS_M2](ERROR): Hardware Fault
2019-03-26T16:06:39.841Z,1553616399.841 [NAL9602](DEBUG): Fix Requested
2019-03-26T16:06:40.227Z,1553616400.227 [CBIT](INFO): Clearing failed state for component AHRS_M2
2019-03-26T16:06:40.227Z,1553616400.227 [AHRS_M2] No Fault, FailCount= 1
2019-03-26T16:06:40.579Z,1553616400.579 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2019-03-26T16:06:42.213Z,1553616402.213 [NAL9602](DEBUG): Fix Requested
2019-03-26T16:06:44.137Z,1553616404.137 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T16:06:44.313Z,1553616404.313 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T16:06:44.961Z,1553616404.961 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T16:06:44.991Z,1553616404.991 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-03-26T16:06:44.991Z,1553616404.991 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4
2019-03-26T16:06:44.991Z,1553616404.991 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-03-26T16:06:44.993Z,1553616404.993 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-03-26T16:06:44.993Z,1553616404.993 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 4
2019-03-26T16:06:44.993Z,1553616404.993 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2019-03-26T16:06:44.995Z,1553616404.995 [DeadReckonWithRespectToSeafloor](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-03-26T16:06:44.995Z,1553616404.995 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 4
2019-03-26T16:06:44.995Z,1553616404.995 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2019-03-26T16:06:45.057Z,1553616405.057 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-03-26T16:06:45.057Z,1553616405.057 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2019-03-26T16:06:45.057Z,1553616405.057 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2019-03-26T16:06:45.461Z,1553616405.461 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T16:06:45.506Z,1553616405.506 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-03-26T16:06:45.507Z,1553616405.507 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4
2019-03-26T16:06:45.507Z,1553616405.507 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2019-03-26T16:06:45.507Z,1553616405.507 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 4
2019-03-26T16:06:45.508Z,1553616405.508 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2019-03-26T16:06:45.508Z,1553616405.508 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 4
2019-03-26T16:06:45.601Z,1553616405.601 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T16:06:45.617Z,1553616405.617 [NAL9602](DEBUG): Fix Requested
2019-03-26T16:06:45.641Z,1553616405.641 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2019-03-26T16:06:46.001Z,1553616406.001 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T16:06:46.421Z,1553616406.421 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T16:06:46.817Z,1553616406.817 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T16:06:47.209Z,1553616407.209 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T16:06:47.625Z,1553616407.625 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T16:06:48.037Z,1553616408.037 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T16:06:48.429Z,1553616408.429 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T16:06:48.449Z,1553616408.449 [NAL9602](DEBUG): Fix Requested
2019-03-26T16:06:48.833Z,1553616408.833 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T16:06:49.233Z,1553616409.233 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T16:06:49.657Z,1553616409.657 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T16:06:50.057Z,1553616410.057 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T16:06:50.449Z,1553616410.449 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T16:06:50.853Z,1553616410.853 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T16:06:51.253Z,1553616411.253 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T16:06:51.273Z,1553616411.273 [NAL9602](DEBUG): Fix Requested
2019-03-26T16:06:51.681Z,1553616411.681 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T16:06:52.073Z,1553616412.073 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T16:06:52.469Z,1553616412.469 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T16:06:52.873Z,1553616412.873 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T16:06:53.278Z,1553616413.278 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T16:06:53.681Z,1553616413.681 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T16:06:53.681Z,1553616413.681 [AHRS_M2](FAULT): Failed to initialize within timeout.
2019-03-26T16:06:53.681Z,1553616413.681 [AHRS_M2] Communications Fault, FailCount= 2
2019-03-26T16:06:53.681Z,1553616413.681 [AHRS_M2](ERROR): Communications Fault
2019-03-26T16:06:53.743Z,1553616413.743 [CBIT](ERROR): Communications Fault in component: AHRS_M2
2019-03-26T16:06:53.997Z,1553616413.997 [AHRS_M2](INFO): Powering down
2019-03-26T16:07:24.116Z,1553616444.116 [AHRS_M2](FAULT): LCB fault: LCB Watchdog Reset. Invalid Command. Hardware Overcurrent Shutdown. Software Overcurrent. Current Limiter Activated.
2019-03-26T16:07:24.116Z,1553616444.116 [AHRS_M2] Hardware Fault, FailCount= 2
2019-03-26T16:07:24.116Z,1553616444.116 [AHRS_M2](ERROR): Hardware Fault
2019-03-26T16:07:24.211Z,1553616444.211 [NAL9602](DEBUG): Fix Requested
2019-03-26T16:07:24.556Z,1553616444.556 [BPC1](ERROR): BPC1B buffer size (924 bytes) exceeded the max device response limit.
2019-03-26T16:07:24.557Z,1553616444.557 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2019-03-26T16:07:24.580Z,1553616444.580 [CBIT](INFO): Clearing failed state for component AHRS_M2
2019-03-26T16:07:24.580Z,1553616444.580 [AHRS_M2] No Fault, FailCount= 2
2019-03-26T16:07:24.921Z,1553616444.921 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2019-03-26T16:07:26.553Z,1553616446.553 [NAL9602](DEBUG): Fix Requested
2019-03-26T16:07:28.249Z,1553616448.249 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T16:07:28.641Z,1553616448.641 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T16:07:29.061Z,1553616449.061 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T16:07:29.449Z,1553616449.449 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T16:07:29.469Z,1553616449.469 [NAL9602](DEBUG): Fix Requested
2019-03-26T16:07:29.857Z,1553616449.857 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T16:07:30.257Z,1553616450.257 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T16:07:30.677Z,1553616450.677 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T16:07:31.081Z,1553616451.081 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T16:07:31.497Z,1553616451.497 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T16:07:31.889Z,1553616451.889 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T16:07:32.293Z,1553616452.293 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T16:07:32.325Z,1553616452.325 [NAL9602](DEBUG): Fix Requested
2019-03-26T16:07:32.697Z,1553616452.697 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T16:07:33.101Z,1553616453.101 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T16:07:33.497Z,1553616453.497 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T16:07:33.909Z,1553616453.909 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T16:07:34.301Z,1553616454.301 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T16:07:34.709Z,1553616454.709 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T16:07:35.110Z,1553616455.110 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T16:07:35.513Z,1553616455.513 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T16:07:35.535Z,1553616455.535 [NAL9602](DEBUG): Fix Requested
2019-03-26T16:07:35.917Z,1553616455.917 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T16:07:36.333Z,1553616456.333 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T16:07:36.391Z,1553616456.391 [Default:CheckIn:Read_GPS](INFO): Timed out from 2019-03-26T16:02:36.3Z
2019-03-26T16:07:36.391Z,1553616456.391 [Default:CheckIn:Read_GPS] Stopped
2019-03-26T16:07:36.391Z,1553616456.391 [Default:CheckIn:Read_Iridium] Running Loop=1
2019-03-26T16:07:36.737Z,1553616456.737 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T16:07:36.768Z,1553616456.768 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications
2019-03-26T16:07:37.137Z,1553616457.137 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T16:07:37.549Z,1553616457.549 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T16:07:37.949Z,1553616457.949 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-03-26T16:07:37.949Z,1553616457.949 [AHRS_M2](FAULT): Failed to initialize within timeout.
2019-03-26T16:07:37.949Z,1553616457.949 [AHRS_M2] Communications Fault, FailCount= 3
2019-03-26T16:07:37.949Z,1553616457.949 [AHRS_M2](ERROR): Communications Fault
2019-03-26T16:07:38.000Z,1553616458.000 [CBIT](ERROR): Communications Fault in component: AHRS_M2
2019-03-26T16:07:38.253Z,1553616458.253 [AHRS_M2](INFO): Powering down
2019-03-26T16:07:41.344Z,1553616461.344 [DataOverHttps](INFO): Sending 25 bytes from file Logs/20190326T155803/Courier0004.lzma
2019-03-26T16:07:42.150Z,1553616462.150 [DataOverHttps](INFO): Moved sent file to Logs/20190326T155803/Courier0004.lzma.bak
2019-03-26T16:07:42.150Z,1553616462.150 [DataOverHttps](INFO): SBD MOMSN=10250317
2019-03-26T16:07:51.528Z,1553616471.528 [DataOverHttps](INFO): Sending 579 bytes from file Logs/20190326T155803/Express0005.lzma
2019-03-26T16:07:52.330Z,1553616472.330 [DataOverHttps](INFO): Moved sent file to Logs/20190326T155803/Express0005.lzma.bak
2019-03-26T16:07:52.330Z,1553616472.330 [DataOverHttps](INFO): SBD MOMSN=10250319
2019-03-26T16:08:05.227Z,1553616485.227 [CommandLine](IMPORTANT): got command configSet AHRS_M2.loadAtStartup 0.000000 bool persist
2019-03-26T16:08:05.227Z,1553616485.227 [CommandLine](IMPORTANT): configSet AHRS_M2.loadAtStartup requires a restart to take effect.
2019-03-26T16:08:08.345Z,1553616488.345 [NAL9602](DEBUG): Fix Requested
2019-03-26T16:08:08.418Z,1553616488.418 [Default:CheckIn:Read_Iridium] Stopped
2019-03-26T16:08:08.418Z,1553616488.418 [Default:CheckIn:C.Wait] Running Loop=1
2019-03-26T16:08:08.418Z,1553616488.418 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2019-03-26T16:08:08.442Z,1553616488.442 [AHRS_M2](FAULT): LCB fault: LCB Watchdog Reset. Invalid Command. Hardware Overcurrent Shutdown. Software Overcurrent. Current Limiter Activated.
2019-03-26T16:08:08.442Z,1553616488.442 [AHRS_M2] Hardware Fault, FailCount= 3
2019-03-26T16:08:08.442Z,1553616488.442 [AHRS_M2](ERROR): Hardware Fault
2019-03-26T16:08:08.935Z,1553616488.935 [CBIT](INFO): Clearing failed state for component AHRS_M2
2019-03-26T16:08:08.935Z,1553616488.935 [AHRS_M2] No Fault, FailCount= 3
2019-03-26T16:08:09.249Z,1553616489.249 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2019-03-26T16:08:09.534Z,1553616489.534 [CommandLine](IMPORTANT): got command restart application
2019-03-26T16:08:10.481Z,1553616490.481 [NAL9602](DEBUG): Fix Requested
2019-03-26T16:08:10.537Z,1553616490.537 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2019-03-26T16:08:10.537Z,1553616490.537 [CommandLine ThreadHandler](INFO): Thread cancelled.
2019-03-26T16:08:10.725Z,1553616490.725 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup.  Bye!
2019-03-26T16:08:10.725Z,1553616490.725 [CommandLine ThreadHandler](INFO): Thread cancelled.
2019-03-26T16:08:10.726Z,1553616490.726 [CommandLine](INFO): Join timeout helper Thread ID is 5684
2019-03-26T16:08:10.737Z,1553616490.737 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2019-03-26T16:08:10.737Z,1553616490.737 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2019-03-26T16:08:10.737Z,1553616490.737 [NavChartDb](INFO): Join timeout helper Thread ID is 5685
2019-03-26T16:08:11.015Z,1553616491.015 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2019-03-26T16:08:11.015Z,1553616491.015 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2019-03-26T16:08:11.033Z,1553616491.033 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2019-03-26T16:08:11.033Z,1553616491.033 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2019-03-26T16:08:11.033Z,1553616491.033 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 5686
2019-03-26T16:08:11.113Z,1553616491.113 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread.
2019-03-26T16:08:11.113Z,1553616491.113 [WetLabsBB2FL](INFO): Powering down
2019-03-26T16:08:11.114Z,1553616491.114 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2019-03-26T16:08:11.121Z,1553616491.121 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler
2019-03-26T16:08:11.121Z,1553616491.121 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2019-03-26T16:08:11.121Z,1553616491.121 [CTD_Seabird](INFO): Join timeout helper Thread ID is 5687
2019-03-26T16:08:11.485Z,1553616491.485 [CTD_Seabird](INFO): Powering down
2019-03-26T16:08:11.497Z,1553616491.497 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread.
2019-03-26T16:08:11.497Z,1553616491.497 [CTD_Seabird](INFO): Powering down
2019-03-26T16:08:11.509Z,1553616491.509 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2019-03-26T16:08:11.525Z,1553616491.525 [ComponentRegistry](INFO): Shutting down CTD_NeilBrown ThreadHandler
2019-03-26T16:08:11.525Z,1553616491.525 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled.
2019-03-26T16:08:11.525Z,1553616491.525 [CTD_NeilBrown](INFO): Join timeout helper Thread ID is 5688
2019-03-26T16:08:11.625Z,1553616491.625 [CTD_NeilBrown ThreadHandler](INFO): Uninitializing protected caller thread.
2019-03-26T16:08:11.625Z,1553616491.625 [CTD_NeilBrown](INFO): Powering down
2019-03-26T16:08:11.637Z,1553616491.637 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled.
2019-03-26T16:08:11.646Z,1553616491.646 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2019-03-26T16:08:11.646Z,1553616491.646 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2019-03-26T16:08:11.646Z,1553616491.646 [Radio_Surface](INFO): Join timeout helper Thread ID is 5689
2019-03-26T16:08:11.817Z,1553616491.817 [Radio_Surface](INFO): Powering down
2019-03-26T16:08:11.818Z,1553616491.818 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2019-03-26T16:08:11.818Z,1553616491.818 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2019-03-26T16:08:11.838Z,1553616491.838 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler
2019-03-26T16:08:11.838Z,1553616491.838 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2019-03-26T16:08:11.838Z,1553616491.838 [DataOverHttps](INFO): Join timeout helper Thread ID is 5690
2019-03-26T16:08:12.105Z,1553616492.105 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread.
2019-03-26T16:08:12.109Z,1553616492.109 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2019-03-26T16:08:12.111Z,1553616492.111 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2019-03-26T16:08:12.111Z,1553616492.111 [logger ThreadHandler](INFO): Thread cancelled.
2019-03-26T16:08:12.111Z,1553616492.111 [logger](INFO): Join timeout helper Thread ID is 5691
2019-03-26T16:08:12.141Z,1553616492.141 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2019-03-26T16:08:12.141Z,1553616492.141 [logger ThreadHandler](INFO): Thread cancelled.
2019-03-26T16:08:12.154Z,1553616492.154 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2019-03-26T16:08:12.154Z,1553616492.154 [CommandLine ThreadHandler](INFO): Thread cancelled.
2019-03-26T16:08:12.154Z,1553616492.154 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2019-03-26T16:08:12.154Z,1553616492.154 [controlThread ThreadHandler](INFO): Thread cancelled.
2019-03-26T16:08:12.154Z,1553616492.154 [controlThread](INFO): Join timeout helper Thread ID is 5692
2019-03-26T16:08:12.477Z,1553616492.477 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2019-03-26T16:08:12.477Z,1553616492.477 [controlThread](DEBUG): Uninitializing ControlThread
2019-03-26T16:08:12.478Z,1553616492.478 [AHRS_M2](INFO): Powering down
2019-03-26T16:08:12.549Z,1553616492.549 [DVL_micro](INFO): uninitialize:Powering down
2019-03-26T16:08:12.550Z,1553616492.550 [NAL9602](INFO): Powering down
2019-03-26T16:08:12.554Z,1553616492.554 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2019-03-26T16:08:12.555Z,1553616492.555 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2019-03-26T16:08:12.556Z,1553616492.556 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2019-03-26T16:08:12.556Z,1553616492.556 [MissionManager](INFO): Uninitializing Mission Default
2019-03-26T16:08:12.556Z,1553616492.556 [Default] Stopped
2019-03-26T16:08:12.556Z,1553616492.556 [Default](DEBUG): Aggregate::uninitialize Default
2019-03-26T16:08:12.557Z,1553616492.557 [Default:B.GoToSurface] Stopped
2019-03-26T16:08:12.557Z,1553616492.557 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2019-03-26T16:08:12.557Z,1553616492.557 [Default:CheckIn] Stopped
2019-03-26T16:08:12.557Z,1553616492.557 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2019-03-26T16:08:12.557Z,1553616492.557 [Default:CheckIn:C.Wait] Stopped
2019-03-26T16:08:12.557Z,1553616492.557 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2019-03-26T16:08:12.559Z,1553616492.559 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2019-03-26T16:08:12.560Z,1553616492.560 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2019-03-26T16:08:12.560Z,1553616492.560 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2019-03-26T16:08:12.560Z,1553616492.560 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2019-03-26T16:08:12.561Z,1553616492.561 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2019-03-26T16:08:12.561Z,1553616492.561 [BuoyancyServo](INFO): Powering down
2019-03-26T16:08:12.573Z,1553616492.573 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2019-03-26T16:08:12.573Z,1553616492.573 [ElevatorServo](INFO): Powering down
2019-03-26T16:08:12.574Z,1553616492.574 [MassServo](DEBUG): Uninitialize Mass Servo.
2019-03-26T16:08:12.574Z,1553616492.574 [MassServo](INFO): Powering down
2019-03-26T16:08:12.575Z,1553616492.575 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2019-03-26T16:08:12.575Z,1553616492.575 [RudderServo](INFO): Powering down
2019-03-26T16:08:12.576Z,1553616492.576 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2019-03-26T16:08:12.576Z,1553616492.576 [ThrusterServo](INFO): Powering down
2019-03-26T16:08:12.576Z,1553616492.576 [SBIT](DEBUG): Uninitialize SBIT Component.
2019-03-26T16:08:12.577Z,1553616492.577 [IBIT](DEBUG): Uninitialize IBIT Component.
2019-03-26T16:08:12.577Z,1553616492.577 [CBIT](DEBUG): Uninitialize CBIT Component.
2019-03-26T16:08:12.577Z,1553616492.577 [CBIT](DEBUG): Powering off loads.
2019-03-26T16:08:12.589Z,1553616492.589 [CBIT](DEBUG): Disabling WDT.
2019-03-26T16:08:12.601Z,1553616492.601 [CBIT](DEBUG): Opening all GF detection circuits.
2019-03-26T16:08:12.601Z,1553616492.601 [controlThread ThreadHandler](INFO): Thread cancelled.
2019-03-26T16:08:12.923Z,1553616492.923 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2019-03-26T16:08:12.932Z,1553616492.932 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2019-03-26T16:08:12.961Z,1553616492.961 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2019-03-26T16:08:12.965Z,1553616492.965 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2019-03-26T16:08:12.969Z,1553616492.969 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled.
2019-03-26T16:08:13.004Z,1553616493.004 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2019-03-26T16:08:13.060Z,1553616493.060 [logger ThreadHandler](INFO): Thread cancelled.