2019-05-07T23:21:06.201Z,1557271266.201 [Supervisor](DEBUG): Initializing supervisor.
2019-05-07T23:21:06.204Z,1557271266.204 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2019-05-07T23:21:06.204Z,1557271266.204 [SyncHandler](INFO): Protected caller Thread ID is 806
2019-05-07T23:21:06.205Z,1557271266.205 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2019-05-07T23:21:06.206Z,1557271266.206 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2019-05-07T23:21:06.206Z,1557271266.206 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 807
2019-05-07T23:21:06.209Z,1557271266.209 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2019-05-07T23:21:06.221Z,1557271266.221 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2019-05-07T23:21:06.222Z,1557271266.222 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2019-05-07T23:21:06.222Z,1557271266.222 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 808
2019-05-07T23:21:06.223Z,1557271266.223 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2019-05-07T23:21:06.224Z,1557271266.224 [logger ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2019-05-07T23:21:06.224Z,1557271266.224 [logger ThreadHandler](INFO): Protected caller Thread ID is 809
2019-05-07T23:21:06.226Z,1557271266.226 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2019-05-07T23:21:06.227Z,1557271266.227 [Supervisor](INFO): Looking for Config files in directory: Config/
2019-05-07T23:21:06.231Z,1557271266.231 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2019-05-07T23:21:06.326Z,1557271266.326 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2019-05-07T23:21:06.327Z,1557271266.327 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2019-05-07T23:21:06.528Z,1557271266.528 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2019-05-07T23:21:06.528Z,1557271266.528 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2019-05-07T23:21:06.665Z,1557271266.665 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2019-05-07T23:21:06.667Z,1557271266.667 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2019-05-07T23:21:07.160Z,1557271267.160 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2019-05-07T23:21:07.160Z,1557271267.160 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2019-05-07T23:21:07.618Z,1557271267.618 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2019-05-07T23:21:07.619Z,1557271267.619 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2019-05-07T23:21:08.090Z,1557271268.090 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2019-05-07T23:21:08.090Z,1557271268.090 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2019-05-07T23:21:08.395Z,1557271268.395 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2019-05-07T23:21:08.396Z,1557271268.396 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2019-05-07T23:21:08.728Z,1557271268.728 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2019-05-07T23:21:08.728Z,1557271268.728 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2019-05-07T23:21:09.129Z,1557271269.129 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2019-05-07T23:21:09.131Z,1557271269.131 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2019-05-07T23:21:09.283Z,1557271269.283 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2019-05-07T23:21:09.283Z,1557271269.283 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2019-05-07T23:21:09.388Z,1557271269.388 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2019-05-07T23:21:09.389Z,1557271269.389 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2019-05-07T23:21:09.470Z,1557271269.470 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2019-05-07T23:21:09.577Z,1557271269.577 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample
2019-05-07T23:21:09.940Z,1557271269.940 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2019-05-07T23:21:10.342Z,1557271270.342 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2019-05-07T23:21:10.344Z,1557271270.344 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2019-05-07T23:21:10.552Z,1557271270.552 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2019-05-07T23:21:10.554Z,1557271270.554 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-makai/
2019-05-07T23:21:10.558Z,1557271270.558 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/secure.cfg
2019-05-07T23:21:10.641Z,1557271270.641 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Battery.cfg
2019-05-07T23:21:10.872Z,1557271270.872 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2019-05-07T23:21:10.872Z,1557271270.872 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Navigation.cfg
2019-05-07T23:21:10.967Z,1557271270.967 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Sensor.cfg
2019-05-07T23:21:11.128Z,1557271271.128 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/vehicle.cfg
2019-05-07T23:21:11.336Z,1557271271.336 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Simulator.cfg
2019-05-07T23:21:11.422Z,1557271271.422 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Servo.cfg
2019-05-07T23:21:11.520Z,1557271271.520 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Control.cfg
2019-05-07T23:21:11.613Z,1557271271.613 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Science.cfg
2019-05-07T23:21:11.763Z,1557271271.763 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/logger.cfg
2019-05-07T23:21:11.868Z,1557271271.868 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/BIT.cfg
2019-05-07T23:21:11.965Z,1557271271.965 [Supervisor](FAULT): Ignoring configuration overrides from Data/persisted.cfg
2019-05-07T23:21:11.969Z,1557271271.969 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2019-05-07T23:21:12.094Z,1557271272.094 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2019-05-07T23:21:12.095Z,1557271272.095 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2019-05-07T23:21:12.243Z,1557271272.243 [BuoyancyServo] Loaded
2019-05-07T23:21:12.243Z,1557271272.243 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2019-05-07T23:21:12.258Z,1557271272.258 [ElevatorServo] Loaded
2019-05-07T23:21:12.258Z,1557271272.258 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2019-05-07T23:21:12.273Z,1557271272.273 [MassServo] Loaded
2019-05-07T23:21:12.273Z,1557271272.273 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2019-05-07T23:21:12.288Z,1557271272.288 [RudderServo] Loaded
2019-05-07T23:21:12.288Z,1557271272.288 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2019-05-07T23:21:12.302Z,1557271272.302 [ThrusterServo] Loaded
2019-05-07T23:21:12.303Z,1557271272.303 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread.
2019-05-07T23:21:12.303Z,1557271272.303 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2019-05-07T23:21:12.305Z,1557271272.305 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2019-05-07T23:21:12.461Z,1557271272.461 [SBIT](DEBUG): Construct Startup Built In Test.
2019-05-07T23:21:12.490Z,1557271272.490 [SBIT] Loaded
2019-05-07T23:21:12.490Z,1557271272.490 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2019-05-07T23:21:12.491Z,1557271272.491 [IBIT](DEBUG): Construct Initiated Built In Test.
2019-05-07T23:21:12.518Z,1557271272.518 [IBIT] Loaded
2019-05-07T23:21:12.518Z,1557271272.518 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2019-05-07T23:21:12.522Z,1557271272.522 [CBIT](DEBUG): Construct Continuous Built In Test.
2019-05-07T23:21:12.906Z,1557271272.906 [CBIT] Loaded
2019-05-07T23:21:12.907Z,1557271272.907 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2019-05-07T23:21:12.907Z,1557271272.907 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2019-05-07T23:21:12.908Z,1557271272.908 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2019-05-07T23:21:13.210Z,1557271273.210 [Aanderaa_O2] Loaded
2019-05-07T23:21:13.211Z,1557271273.211 [ComponentRegistry](DEBUG): SyncComponent "Aanderaa_O2" handled in the control thread.
2019-05-07T23:21:13.220Z,1557271273.220 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_density
2019-05-07T23:21:13.225Z,1557271273.225 [CTD_Seabird](INFO): created writer for : sea_water_density
2019-05-07T23:21:13.227Z,1557271273.227 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): depth
2019-05-07T23:21:13.232Z,1557271273.232 [CTD_Seabird](INFO): created writer for : depth
2019-05-07T23:21:13.232Z,1557271273.232 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_pressure
2019-05-07T23:21:13.237Z,1557271273.237 [CTD_Seabird](INFO): created writer for : sea_water_pressure
2019-05-07T23:21:13.238Z,1557271273.238 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_salinity
2019-05-07T23:21:13.243Z,1557271273.243 [CTD_Seabird](INFO): created writer for : sea_water_salinity
2019-05-07T23:21:13.244Z,1557271273.244 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_temperature
2019-05-07T23:21:13.249Z,1557271273.249 [CTD_Seabird](INFO): created writer for : sea_water_temperature
2019-05-07T23:21:13.250Z,1557271273.250 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_electrical_conductivity
2019-05-07T23:21:13.255Z,1557271273.255 [CTD_Seabird](INFO): created writer for : sea_water_electrical_conductivity
2019-05-07T23:21:13.255Z,1557271273.255 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): speed_of_sound_in_sea_water
2019-05-07T23:21:13.260Z,1557271273.260 [CTD_Seabird](INFO): created writer for : speed_of_sound_in_sea_water
2019-05-07T23:21:13.286Z,1557271273.286 [CTD_Seabird] Loaded
2019-05-07T23:21:13.287Z,1557271273.287 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread.
2019-05-07T23:21:13.288Z,1557271273.288 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 4065E4E0
2019-05-07T23:21:13.288Z,1557271273.288 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 888
2019-05-07T23:21:13.313Z,1557271273.313 [ESPComponent] Loaded
2019-05-07T23:21:13.314Z,1557271273.314 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread.
2019-05-07T23:21:13.328Z,1557271273.328 [PAR_Licor] Loaded
2019-05-07T23:21:13.328Z,1557271273.328 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2019-05-07T23:21:13.375Z,1557271273.375 [WetLabsBB2FL] Loaded
2019-05-07T23:21:13.375Z,1557271273.375 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2019-05-07T23:21:13.376Z,1557271273.376 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 4068E4E0
2019-05-07T23:21:13.377Z,1557271273.377 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 889
2019-05-07T23:21:13.378Z,1557271273.378 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2019-05-07T23:21:13.378Z,1557271273.378 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2019-05-07T23:21:13.432Z,1557271273.432 [DepthRateCalculator] Loaded
2019-05-07T23:21:13.432Z,1557271273.432 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2019-05-07T23:21:13.438Z,1557271273.438 [PitchRateCalculator] Loaded
2019-05-07T23:21:13.438Z,1557271273.438 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2019-05-07T23:21:13.454Z,1557271273.454 [SpeedCalculator] Loaded
2019-05-07T23:21:13.455Z,1557271273.455 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2019-05-07T23:21:13.475Z,1557271273.475 [TempGradientCalculator] Loaded
2019-05-07T23:21:13.476Z,1557271273.476 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread.
2019-05-07T23:21:13.481Z,1557271273.481 [YawRateCalculator] Loaded
2019-05-07T23:21:13.482Z,1557271273.482 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2019-05-07T23:21:13.514Z,1557271273.514 [ElevatorOffsetCalculator] Loaded
2019-05-07T23:21:13.515Z,1557271273.515 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2019-05-07T23:21:13.515Z,1557271273.515 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2019-05-07T23:21:13.516Z,1557271273.516 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2019-05-07T23:21:13.556Z,1557271273.556 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2019-05-07T23:21:13.557Z,1557271273.557 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2019-05-07T23:21:13.675Z,1557271273.675 [DeadReckonUsingMultipleVelocitySources] Loaded
2019-05-07T23:21:13.675Z,1557271273.675 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2019-05-07T23:21:13.735Z,1557271273.735 [DeadReckonUsingSpeedCalculator] Loaded
2019-05-07T23:21:13.735Z,1557271273.735 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread.
2019-05-07T23:21:13.793Z,1557271273.793 [DeadReckonWithRespectToSeafloor] Loaded
2019-05-07T23:21:13.794Z,1557271273.794 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonWithRespectToSeafloor" handled in the control thread.
2019-05-07T23:21:13.814Z,1557271273.814 [NavChart] Loaded
2019-05-07T23:21:13.814Z,1557271273.814 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2019-05-07T23:21:13.818Z,1557271273.818 [UniversalFixResidualReporter] Loaded
2019-05-07T23:21:13.818Z,1557271273.818 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2019-05-07T23:21:13.819Z,1557271273.819 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2019-05-07T23:21:13.819Z,1557271273.819 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2019-05-07T23:21:14.354Z,1557271274.354 [AcousticModem_Benthos_ATM900] Loaded
2019-05-07T23:21:14.354Z,1557271274.354 [ComponentRegistry](DEBUG): SyncComponent "AcousticModem_Benthos_ATM900" handled in the control thread.
2019-05-07T23:21:14.503Z,1557271274.503 [DataOverHttps] Loaded
2019-05-07T23:21:14.503Z,1557271274.503 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2019-05-07T23:21:14.504Z,1557271274.504 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 4096E4E0
2019-05-07T23:21:14.505Z,1557271274.505 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 890
2019-05-07T23:21:14.518Z,1557271274.518 [Depth_Keller] Loaded
2019-05-07T23:21:14.519Z,1557271274.519 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2019-05-07T23:21:14.524Z,1557271274.524 [DropWeight] Loaded
2019-05-07T23:21:14.524Z,1557271274.524 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2019-05-07T23:21:14.614Z,1557271274.614 [NAL9602] Loaded
2019-05-07T23:21:14.614Z,1557271274.614 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2019-05-07T23:21:14.619Z,1557271274.619 [Onboard] Loaded
2019-05-07T23:21:14.620Z,1557271274.620 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread.
2019-05-07T23:21:14.623Z,1557271274.623 [Radio_Surface] Loaded
2019-05-07T23:21:14.623Z,1557271274.623 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2019-05-07T23:21:14.624Z,1557271274.624 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 4099E4E0
2019-05-07T23:21:14.625Z,1557271274.625 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 891
2019-05-07T23:21:14.777Z,1557271274.777 [PNI_TCM] Loaded
2019-05-07T23:21:14.778Z,1557271274.778 [ComponentRegistry](DEBUG): SyncComponent "PNI_TCM" handled in the control thread.
2019-05-07T23:21:14.952Z,1557271274.952 [Rowe_600] Loaded
2019-05-07T23:21:14.953Z,1557271274.953 [ComponentRegistry](DEBUG): Component "Rowe_600" handled in its own thread.
2019-05-07T23:21:14.954Z,1557271274.954 [Rowe_600 ThreadHandler](DEBUG): Created PCaller Thread at 409CE4E0
2019-05-07T23:21:14.954Z,1557271274.954 [Rowe_600 ThreadHandler](INFO): Protected caller Thread ID is 892
2019-05-07T23:21:16.741Z,1557271276.741 [BPC1] Loaded
2019-05-07T23:21:16.741Z,1557271276.741 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2019-05-07T23:21:16.742Z,1557271276.742 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2019-05-07T23:21:16.742Z,1557271276.742 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2019-05-07T23:21:16.854Z,1557271276.854 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2019-05-07T23:21:16.854Z,1557271276.854 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2019-05-07T23:21:16.941Z,1557271276.941 [VerticalControl](DEBUG): Construct VerticalControl.
2019-05-07T23:21:17.024Z,1557271277.024 [VerticalControl] Loaded
2019-05-07T23:21:17.024Z,1557271277.024 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2019-05-07T23:21:17.025Z,1557271277.025 [HorizontalControl](DEBUG): Construct HorizontalControl.
2019-05-07T23:21:17.082Z,1557271277.082 [HorizontalControl] Loaded
2019-05-07T23:21:17.082Z,1557271277.082 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2019-05-07T23:21:17.083Z,1557271277.083 [SpeedControl](DEBUG): Construct SpeedControl.
2019-05-07T23:21:17.085Z,1557271277.085 [SpeedControl] Loaded
2019-05-07T23:21:17.085Z,1557271277.085 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2019-05-07T23:21:17.086Z,1557271277.086 [LoopControl](DEBUG): Construct LoopControl.
2019-05-07T23:21:17.086Z,1557271277.086 [LoopControl] Loaded
2019-05-07T23:21:17.087Z,1557271277.087 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2019-05-07T23:21:17.087Z,1557271277.087 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2019-05-07T23:21:17.088Z,1557271277.088 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2019-05-07T23:21:17.112Z,1557271277.112 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2019-05-07T23:21:17.113Z,1557271277.113 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2019-05-07T23:21:17.427Z,1557271277.427 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2019-05-07T23:21:17.431Z,1557271277.431 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2019-05-07T23:21:17.431Z,1557271277.431 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2019-05-07T23:21:17.438Z,1557271277.438 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2019-05-07T23:21:17.439Z,1557271277.439 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40B014E0
2019-05-07T23:21:17.440Z,1557271277.440 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 894
2019-05-07T23:21:17.444Z,1557271277.444 [Supervisor](INFO): Main Thread ID is 802
2019-05-07T23:21:17.444Z,1557271277.444 [Supervisor](DEBUG): Running supervisor.
2019-05-07T23:21:17.445Z,1557271277.445 [CommandLine ThreadHandler](INFO): Handler Thread ID is 895
2019-05-07T23:21:17.447Z,1557271277.447 [controlThread ThreadHandler](INFO): Handler Thread ID is 896
2019-05-07T23:21:17.448Z,1557271277.448 [controlThread](DEBUG): Initializing ControlThread
2019-05-07T23:21:17.450Z,1557271277.450 [SBIT](INFO): Initialize SBIT Component.
2019-05-07T23:21:17.450Z,1557271277.450 [SBIT](IMPORTANT): git: 2019-04-10-2-gf3e4ef2
2019-05-07T23:21:17.450Z,1557271277.450 [SBIT](INFO): git hash: f3e4ef2c5f3aa5e841d57d486bee5a5f25629231
2019-05-07T23:21:17.451Z,1557271277.451 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2019-05-07T23:21:17.452Z,1557271277.452 [SBIT](INFO): Kernel Reporting Different Version From Configuration.
Kernel Expected: #2 PREEMPT Thu Jan 11 20:13:48 PST 2018
Kernel Reported: #1 PREEMPT Thu Feb 21 11:17:40 PST 2019
2019-05-07T23:21:17.453Z,1557271277.453 [SBIT](INFO): Beginning SBIT in 24.000000 seconds.
2019-05-07T23:21:17.454Z,1557271277.454 [IBIT](INFO): Initialize IBIT Component.
2019-05-07T23:21:17.454Z,1557271277.454 [CBIT](DEBUG): Initialize CBIT Component.
2019-05-07T23:21:17.455Z,1557271277.455 [logger ThreadHandler](INFO): Handler Thread ID is 897
2019-05-07T23:21:17.469Z,1557271277.469 [CBIT](DEBUG): Initialized mux pins.
2019-05-07T23:21:17.469Z,1557271277.469 [CBIT](FAULT): LAST RESTART WAS UNINTENTIONAL.
2019-05-07T23:21:17.469Z,1557271277.469 [CBIT](DEBUG): Initializing the watchdog timer.
2019-05-07T23:21:17.481Z,1557271277.481 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 898
2019-05-07T23:21:17.482Z,1557271277.482 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2019-05-07T23:21:17.485Z,1557271277.485 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20
2019-05-07T23:21:17.487Z,1557271277.487 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 900
2019-05-07T23:21:17.488Z,1557271277.488 [WetLabsBB2FL](INFO): Powering down
2019-05-07T23:21:17.493Z,1557271277.493 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2019-05-07T23:21:17.493Z,1557271277.493 [CBIT](DEBUG): Initializing heartbeat.
2019-05-07T23:21:17.517Z,1557271277.517 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 901
2019-05-07T23:21:17.518Z,1557271277.518 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2019-05-07T23:21:17.529Z,1557271277.529 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 902
2019-05-07T23:21:17.541Z,1557271277.541 [Rowe_600 ThreadHandler](INFO): Handler Thread ID is 903
2019-05-07T23:21:17.553Z,1557271277.553 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 904
2019-05-07T23:21:17.563Z,1557271277.563 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2019-05-07T23:21:17.563Z,1557271277.563 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2019-05-07T23:21:17.563Z,1557271277.563 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2019-05-07T23:21:17.563Z,1557271277.563 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2019-05-07T23:21:17.563Z,1557271277.563 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2019-05-07T23:21:17.564Z,1557271277.564 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2019-05-07T23:21:17.564Z,1557271277.564 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000
2019-05-07T23:21:17.564Z,1557271277.564 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000
2019-05-07T23:21:17.564Z,1557271277.564 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2019-05-07T23:21:17.564Z,1557271277.564 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2019-05-07T23:21:17.565Z,1557271277.565 [CBIT](DEBUG): Deactivating GF circuits.
2019-05-07T23:21:17.565Z,1557271277.565 [CBIT](DEBUG): Deactivating emergency mode.
2019-05-07T23:21:17.565Z,1557271277.565 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000
2019-05-07T23:21:17.565Z,1557271277.565 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000
2019-05-07T23:21:17.566Z,1557271277.566 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000
2019-05-07T23:21:17.566Z,1557271277.566 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000
2019-05-07T23:21:17.566Z,1557271277.566 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000
2019-05-07T23:21:17.566Z,1557271277.566 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000
2019-05-07T23:21:17.601Z,1557271277.601 [CBIT](DEBUG): Backplane powered.
2019-05-07T23:21:17.605Z,1557271277.605 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2019-05-07T23:21:17.606Z,1557271277.606 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2019-05-07T23:21:17.606Z,1557271277.606 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2019-05-07T23:21:17.606Z,1557271277.606 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator.
2019-05-07T23:21:17.607Z,1557271277.607 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2019-05-07T23:21:17.607Z,1557271277.607 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2019-05-07T23:21:17.608Z,1557271277.608 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2019-05-07T23:21:17.609Z,1557271277.609 [NavChart](DEBUG): Initialize NavChart Navigation.
2019-05-07T23:21:17.610Z,1557271277.610 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2019-05-07T23:21:17.616Z,1557271277.616 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2019-05-07T23:21:17.622Z,1557271277.622 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2019-05-07T23:21:17.622Z,1557271277.622 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2019-05-07T23:21:17.623Z,1557271277.623 [LoopControl](DEBUG): Initialize LoopControlComponent.
2019-05-07T23:21:17.624Z,1557271277.624 [MissionManager](INFO): Loading Mission: Missions/Startup.xml
2019-05-07T23:21:17.651Z,1557271277.651 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2019-05-07T23:21:17.671Z,1557271277.671 [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-05-07T23:21:17.672Z,1557271277.672 [MissionManager](INFO): Loading Mission: Missions/Default.xml
2019-05-07T23:21:17.757Z,1557271277.757 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2019-05-07T23:21:17.758Z,1557271277.758 [Default:A.Wait](DEBUG): Construct Wait.
2019-05-07T23:21:17.760Z,1557271277.760 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2019-05-07T23:21:17.796Z,1557271277.796 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2019-05-07T23:21:17.798Z,1557271277.798 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2019-05-07T23:21:17.817Z,1557271277.817 [Rowe_600](INFO): Powering down
2019-05-07T23:21:17.836Z,1557271277.836 [Default:E.Execute](DEBUG): Construct Execute.
2019-05-07T23:21:17.839Z,1557271277.839 [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-05-07T23:21:17.856Z,1557271277.856 [controlThread](DEBUG): Component order: CycleStarter,Aanderaa_O2,ESPComponent,PAR_Licor,AcousticModem_Benthos_ATM900,Depth_Keller,DropWeight,NAL9602,Onboard,PNI_TCM,BPC1,PAR_Licor,Depth_Keller,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-05-07T23:21:17.898Z,1557271277.898 [ESPComponent](INFO): powering down ESP
2019-05-07T23:21:17.933Z,1557271277.933 [Radio_Surface](INFO): Powering up
2019-05-07T23:21:18.077Z,1557271278.077 [Rowe_600](INFO): Data requested. STOPPED ==> START
2019-05-07T23:21:18.077Z,1557271278.077 [Rowe_600](INFO): Initializing
2019-05-07T23:21:18.117Z,1557271278.117 [Rowe_600](INFO): Powering up
2019-05-07T23:21:18.202Z,1557271278.202 [AcousticModem_Benthos_ATM900](INFO): Powering up
2019-05-07T23:21:18.202Z,1557271278.202 [AcousticModem_Benthos_ATM900](DEBUG): Initializing AcousticModem_Benthos_ATM900.
2019-05-07T23:21:18.226Z,1557271278.226 [Depth_Keller](ERROR): Pressure reading out of range: 1895.684326 decibar
2019-05-07T23:21:18.293Z,1557271278.293 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-05-07T23:21:18.391Z,1557271278.391 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2019-05-07T23:21:18.397Z,1557271278.397 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2019-05-07T23:21:18.399Z,1557271278.399 [ElevatorServo](DEBUG): Initializing EZServoServo.
2019-05-07T23:21:18.405Z,1557271278.405 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2019-05-07T23:21:18.406Z,1557271278.406 [MassServo](DEBUG): Initializing EZServoServo.
2019-05-07T23:21:18.413Z,1557271278.413 [MassServo](DEBUG): Initializing MassServo.
2019-05-07T23:21:18.414Z,1557271278.414 [RudderServo](DEBUG): Initializing EZServoServo.
2019-05-07T23:21:18.421Z,1557271278.421 [RudderServo](DEBUG): Initializing RudderServo.
2019-05-07T23:21:18.422Z,1557271278.422 [ThrusterServo](DEBUG): Initializing EZServoServo.
2019-05-07T23:21:18.429Z,1557271278.429 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2019-05-07T23:21:18.535Z,1557271278.535 [DropWeight](CRITICAL): DROP WEIGHT MISSING.

2019-05-07T23:21:18.535Z,1557271278.535 [DropWeight] Hardware Fault, FailCount= 1
2019-05-07T23:21:18.535Z,1557271278.535 [DropWeight](ERROR): Hardware Fault
2019-05-07T23:21:18.579Z,1557271278.579 [CommandLine](FAULT): Scheduling is paused
2019-05-07T23:21:18.580Z,1557271278.580 [CBIT](INFO): Critical error at 20190507T232118
2019-05-07T23:21:18.580Z,1557271278.580 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals
2019-05-07T23:21:18.583Z,1557271278.583 [CBIT](ERROR): Hardware Fault in component: DropWeight
2019-05-07T23:21:18.583Z,1557271278.583 [CBIT](CRITICAL): Hardware Fault in component: DropWeight
2019-05-07T23:21:18.904Z,1557271278.904 [CBIT](INFO): Critical error at 20190507T232118
2019-05-07T23:21:25.340Z,1557271285.340 [PNI_TCM](FAULT): Failed to set parameters during initialization.
2019-05-07T23:21:25.340Z,1557271285.340 [PNI_TCM] Data Fault, FailCount= 1
2019-05-07T23:21:25.340Z,1557271285.340 [PNI_TCM](ERROR): Data Fault
2019-05-07T23:21:25.406Z,1557271285.406 [CBIT](ERROR): Data Fault in component: PNI_TCM
2019-05-07T23:21:25.744Z,1557271285.744 [PNI_TCM](INFO): Powering down
2019-05-07T23:21:27.165Z,1557271287.165 [CBIT](INFO): Clearing failed state for component PNI_TCM
2019-05-07T23:21:27.166Z,1557271287.166 [PNI_TCM] No Fault, FailCount= 1
2019-05-07T23:21:27.806Z,1557271287.806 [CBIT](CRITICAL): Environmental Failure. Press:14.793281 PSI. Humidity:36%. Temp:26 C. ABORTING MISSION
2019-05-07T23:21:28.149Z,1557271288.149 [Aanderaa_O2](FAULT): Failed to initialize within timeout.
2019-05-07T23:21:28.149Z,1557271288.149 [Aanderaa_O2] Communications Fault, FailCount= 1
2019-05-07T23:21:28.149Z,1557271288.149 [Aanderaa_O2](ERROR): Communications Fault
2019-05-07T23:21:28.232Z,1557271288.232 [CBIT](INFO): Critical error at 20190507T232127
2019-05-07T23:21:28.242Z,1557271288.242 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2019-05-07T23:21:28.669Z,1557271288.669 [Aanderaa_O2](INFO): Powering down
2019-05-07T23:21:29.429Z,1557271289.429 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2019-05-07T23:21:29.430Z,1557271289.430 [Aanderaa_O2] No Fault, FailCount= 1
2019-05-07T23:21:30.533Z,1557271290.533 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2019-05-07T23:21:30.533Z,1557271290.533 [CTD_Seabird] Communications Fault, FailCount= 1
2019-05-07T23:21:30.533Z,1557271290.533 [CTD_Seabird](ERROR): Communications Fault
2019-05-07T23:21:30.626Z,1557271290.626 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2019-05-07T23:21:30.937Z,1557271290.937 [CTD_Seabird](INFO): Powering down
2019-05-07T23:21:32.247Z,1557271292.247 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2019-05-07T23:21:32.247Z,1557271292.247 [CTD_Seabird] No Fault, FailCount= 1
2019-05-07T23:21:32.365Z,1557271292.365 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2019-05-07T23:21:32.366Z,1557271292.366 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20
2019-05-07T23:21:34.641Z,1557271294.641 [PNI_TCM](FAULT): Failed to set parameters during initialization.
2019-05-07T23:21:34.641Z,1557271294.641 [PNI_TCM] Data Fault, FailCount= 2
2019-05-07T23:21:34.641Z,1557271294.641 [PNI_TCM](ERROR): Data Fault
2019-05-07T23:21:34.676Z,1557271294.676 [CBIT](ERROR): Data Fault in component: PNI_TCM
2019-05-07T23:21:35.038Z,1557271295.038 [PNI_TCM](INFO): Powering down
2019-05-07T23:21:36.302Z,1557271296.302 [CBIT](INFO): Clearing failed state for component PNI_TCM
2019-05-07T23:21:36.302Z,1557271296.302 [PNI_TCM] No Fault, FailCount= 2
2019-05-07T23:21:38.249Z,1557271298.249 [AcousticModem_Benthos_ATM900](FAULT): failed to initialize, no bytes available on serial interface
2019-05-07T23:21:38.250Z,1557271298.250 [AcousticModem_Benthos_ATM900] Communications Fault, FailCount= 1
2019-05-07T23:21:38.250Z,1557271298.250 [AcousticModem_Benthos_ATM900](ERROR): Communications Fault
2019-05-07T23:21:38.319Z,1557271298.319 [CBIT](ERROR): Communications Fault in component: AcousticModem_Benthos_ATM900
2019-05-07T23:21:38.653Z,1557271298.653 [AcousticModem_Benthos_ATM900](INFO): Powering down
2019-05-07T23:21:39.058Z,1557271299.058 [AcousticModem_Benthos_ATM900](FAULT): LCB fault:  Hardware Overcurrent Shutdown. Current Limiter Activated.
2019-05-07T23:21:39.058Z,1557271299.058 [AcousticModem_Benthos_ATM900] Hardware Fault, FailCount= 1
2019-05-07T23:21:39.058Z,1557271299.058 [AcousticModem_Benthos_ATM900](ERROR): Hardware Fault
2019-05-07T23:21:39.519Z,1557271299.519 [CBIT](INFO): Clearing failed state for component AcousticModem_Benthos_ATM900
2019-05-07T23:21:39.519Z,1557271299.519 [AcousticModem_Benthos_ATM900] No Fault, FailCount= 1
2019-05-07T23:21:39.861Z,1557271299.861 [Aanderaa_O2](FAULT): Failed to initialize within timeout.
2019-05-07T23:21:39.862Z,1557271299.862 [Aanderaa_O2] Communications Fault, FailCount= 2
2019-05-07T23:21:39.862Z,1557271299.862 [Aanderaa_O2](ERROR): Communications Fault
2019-05-07T23:21:39.922Z,1557271299.922 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2019-05-07T23:21:40.385Z,1557271300.385 [Aanderaa_O2](INFO): Powering down
2019-05-07T23:21:41.131Z,1557271301.131 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2019-05-07T23:21:41.131Z,1557271301.131 [Aanderaa_O2] No Fault, FailCount= 2
2019-05-07T23:21:41.898Z,1557271301.898 [AcousticModem_Benthos_ATM900](INFO): Powering up
2019-05-07T23:21:41.898Z,1557271301.898 [AcousticModem_Benthos_ATM900](DEBUG): Initializing AcousticModem_Benthos_ATM900.
2019-05-07T23:21:41.975Z,1557271301.975 [SBIT](IMPORTANT): Beginning Startup BIT
2019-05-07T23:21:41.992Z,1557271301.992 [CBIT](IMPORTANT): Beginning ground fault scan
2019-05-07T23:21:43.924Z,1557271303.924 [PNI_TCM](FAULT): Failed to set parameters during initialization.
2019-05-07T23:21:43.924Z,1557271303.924 [PNI_TCM] Data Fault, FailCount= 3
2019-05-07T23:21:43.924Z,1557271303.924 [PNI_TCM](ERROR): Data Fault
2019-05-07T23:21:44.390Z,1557271304.390 [CBIT](ERROR): Data Fault in component: PNI_TCM
2019-05-07T23:21:44.439Z,1557271304.439 [PNI_TCM](INFO): Powering down
2019-05-07T23:21:44.806Z,1557271304.806 [NAL9602](INFO): Powering up NAL9602
2019-05-07T23:21:45.417Z,1557271305.417 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2019-05-07T23:21:45.417Z,1557271305.417 [CTD_Seabird] Communications Fault, FailCount= 2
2019-05-07T23:21:45.417Z,1557271305.417 [CTD_Seabird](ERROR): Communications Fault
2019-05-07T23:21:45.821Z,1557271305.821 [CTD_Seabird](INFO): Powering down
2019-05-07T23:21:45.838Z,1557271305.838 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2019-05-07T23:21:45.839Z,1557271305.839 [CBIT](INFO): Clearing failed state for component PNI_TCM
2019-05-07T23:21:45.839Z,1557271305.839 [PNI_TCM] No Fault, FailCount= 3
2019-05-07T23:21:47.054Z,1557271307.054 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2019-05-07T23:21:47.054Z,1557271307.054 [CTD_Seabird] No Fault, FailCount= 2
2019-05-07T23:21:47.169Z,1557271307.169 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2019-05-07T23:21:47.177Z,1557271307.177 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20
2019-05-07T23:21:51.665Z,1557271311.665 [Aanderaa_O2](FAULT): Failed to initialize within timeout.
2019-05-07T23:21:51.665Z,1557271311.665 [Aanderaa_O2] Communications Fault, FailCount= 3
2019-05-07T23:21:51.666Z,1557271311.666 [Aanderaa_O2](ERROR): Communications Fault
2019-05-07T23:21:51.778Z,1557271311.778 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2019-05-07T23:21:51.779Z,1557271311.779 [CBIT](FAULT): Communications Fault in component: Aanderaa_O2
2019-05-07T23:21:52.189Z,1557271312.189 [Aanderaa_O2](INFO): Powering down
2019-05-07T23:21:52.984Z,1557271312.984 [CBIT](IMPORTANT): Ground fault detected
mA:
CHAN A0 (Batt): -0.006966
CHAN A1 (24V): -0.110434
CHAN A2 (12V): -0.005375
CHAN A3 (5V): -0.001601
CHAN B0 (3.3V): -0.001649
CHAN B1 (3.15aV): -0.000941
CHAN B2 (3.15bV): -0.001602
CHAN B3 (GND): 0.000174
OPEN: 0.006144
Full Scale Calc: 4.765 mA, -1.589 mA
2019-05-07T23:21:53.308Z,1557271313.308 [PNI_TCM](FAULT): Failed to set parameters during initialization.
2019-05-07T23:21:53.309Z,1557271313.309 [PNI_TCM] Data Fault, FailCount= 4
2019-05-07T23:21:53.309Z,1557271313.309 [PNI_TCM](ERROR): Data Fault
2019-05-07T23:21:53.382Z,1557271313.382 [CBIT](ERROR): Data Fault in component: PNI_TCM
2019-05-07T23:21:53.711Z,1557271313.711 [PNI_TCM](INFO): Powering down
2019-05-07T23:21:55.062Z,1557271315.062 [CBIT](INFO): Clearing failed state for component PNI_TCM
2019-05-07T23:21:55.062Z,1557271315.062 [PNI_TCM] No Fault, FailCount= 4
2019-05-07T23:21:55.710Z,1557271315.710 [NAL9602](INFO): NAL9602 initialized
2019-05-07T23:21:56.541Z,1557271316.541 [NAL9602](DEBUG): Fix Requested
2019-05-07T23:22:00.229Z,1557271320.229 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2019-05-07T23:22:00.229Z,1557271320.229 [CTD_Seabird] Communications Fault, FailCount= 3
2019-05-07T23:22:00.229Z,1557271320.229 [CTD_Seabird](ERROR): Communications Fault
2019-05-07T23:22:00.454Z,1557271320.454 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2019-05-07T23:22:00.455Z,1557271320.455 [CBIT](FAULT): Communications Fault in component: CTD_Seabird
2019-05-07T23:22:00.633Z,1557271320.633 [CTD_Seabird](INFO): Powering down
2019-05-07T23:22:01.930Z,1557271321.930 [AcousticModem_Benthos_ATM900](FAULT): failed to initialize, no bytes available on serial interface
2019-05-07T23:22:01.930Z,1557271321.930 [AcousticModem_Benthos_ATM900] Communications Fault, FailCount= 2
2019-05-07T23:22:01.930Z,1557271321.930 [AcousticModem_Benthos_ATM900](ERROR): Communications Fault
2019-05-07T23:22:02.054Z,1557271322.054 [CBIT](ERROR): Communications Fault in component: AcousticModem_Benthos_ATM900
2019-05-07T23:22:02.325Z,1557271322.325 [AcousticModem_Benthos_ATM900](INFO): Powering down
2019-05-07T23:22:02.730Z,1557271322.730 [AcousticModem_Benthos_ATM900](FAULT): LCB fault:  Hardware Overcurrent Shutdown. Current Limiter Activated.
2019-05-07T23:22:02.730Z,1557271322.730 [AcousticModem_Benthos_ATM900] Hardware Fault, FailCount= 2
2019-05-07T23:22:02.730Z,1557271322.730 [AcousticModem_Benthos_ATM900](ERROR): Hardware Fault
2019-05-07T23:22:02.753Z,1557271322.753 [PNI_TCM](FAULT): Failed to set parameters during initialization.
2019-05-07T23:22:02.754Z,1557271322.754 [PNI_TCM] Data Fault, FailCount= 5
2019-05-07T23:22:02.754Z,1557271322.754 [PNI_TCM](ERROR): Data Fault
2019-05-07T23:22:02.973Z,1557271322.973 [CBIT](ERROR): Data Fault in component: PNI_TCM
2019-05-07T23:22:02.974Z,1557271322.974 [CBIT](CRITICAL): Data Fault in component: PNI_TCM
2019-05-07T23:22:03.153Z,1557271323.153 [PNI_TCM](INFO): Powering down
2019-05-07T23:22:03.292Z,1557271323.292 [CBIT](INFO): Critical error at 20190507T232202
2019-05-07T23:22:03.295Z,1557271323.295 [CBIT](INFO): Clearing failed state for component AcousticModem_Benthos_ATM900
2019-05-07T23:22:03.295Z,1557271323.295 [AcousticModem_Benthos_ATM900] No Fault, FailCount= 2
2019-05-07T23:22:05.558Z,1557271325.558 [AcousticModem_Benthos_ATM900](INFO): Powering up
2019-05-07T23:22:05.558Z,1557271325.558 [AcousticModem_Benthos_ATM900](DEBUG): Initializing AcousticModem_Benthos_ATM900.
2019-05-07T23:22:25.834Z,1557271345.834 [AcousticModem_Benthos_ATM900](FAULT): failed to initialize, no bytes available on serial interface
2019-05-07T23:22:25.834Z,1557271345.834 [AcousticModem_Benthos_ATM900] Communications Fault, FailCount= 3
2019-05-07T23:22:25.834Z,1557271345.834 [AcousticModem_Benthos_ATM900](ERROR): Communications Fault
2019-05-07T23:22:25.865Z,1557271345.865 [BPC1](ERROR): BPC1A: No match for serial number 04CC in BPC1A's battery stick inventory (sticks 1-32 in onboard configuration file).
2019-05-07T23:22:25.866Z,1557271345.866 [BPC1](ERROR): BPC1B: No match for serial number 018D in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file).
2019-05-07T23:22:25.866Z,1557271345.866 [BPC1](FAULT): Failed to parse data from all battery packs.
2019-05-07T23:22:25.866Z,1557271345.866 [BPC1] Data Fault, FailCount= 1
2019-05-07T23:22:25.866Z,1557271345.866 [BPC1](ERROR): Data Fault
2019-05-07T23:22:26.018Z,1557271346.018 [CBIT](ERROR): Communications Fault in component: AcousticModem_Benthos_ATM900
2019-05-07T23:22:26.019Z,1557271346.019 [CBIT](ERROR): Data Fault in component: BPC1
2019-05-07T23:22:26.238Z,1557271346.238 [AcousticModem_Benthos_ATM900](INFO): Powering down
2019-05-07T23:22:27.350Z,1557271347.350 [CBIT](INFO): Clearing failed state for component AcousticModem_Benthos_ATM900
2019-05-07T23:22:27.350Z,1557271347.350 [AcousticModem_Benthos_ATM900] No Fault, FailCount= 3
2019-05-07T23:22:29.469Z,1557271349.469 [AcousticModem_Benthos_ATM900](INFO): Powering up
2019-05-07T23:22:29.470Z,1557271349.470 [AcousticModem_Benthos_ATM900](DEBUG): Initializing AcousticModem_Benthos_ATM900.
2019-05-07T23:22:35.574Z,1557271355.574 [SBIT](IMPORTANT): SBIT PASSED
2019-05-07T23:22:35.630Z,1557271355.630 [CommandLine](IMPORTANT): got command configSet list
2019-05-07T23:22:35.631Z,1557271355.631 [CommandLine](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2019-05-07T23:22:35.633Z,1557271355.633 [CommandLine](IMPORTANT): DropWeight.loadAtStartup=0 bool;

2019-05-07T23:22:35.633Z,1557271355.633 [CommandLine](IMPORTANT): PAR_Licor.adcCal=8.765e-06 microampere_per_count;

2019-05-07T23:22:35.633Z,1557271355.633 [CommandLine](IMPORTANT): PAR_Licor.darkCount=0 count;

2019-05-07T23:22:35.633Z,1557271355.633 [CommandLine](IMPORTANT): PAR_Licor.multiplier=190.3 micromole_per_second_per_square_meter_per_microampere;

2019-05-07T23:22:35.633Z,1557271355.633 [CommandLine](IMPORTANT): Rowe_600LCM.loadAtStartup=0 bool;

2019-05-07T23:22:35.974Z,1557271355.974 [MissionManager](IMPORTANT): Started mission Startup
2019-05-07T23:22:35.974Z,1557271355.974 [Startup] Running Loop=1
2019-05-07T23:22:35.974Z,1557271355.974 [Startup](DEBUG): Aggregate::initialize Startup
2019-05-07T23:22:35.975Z,1557271355.975 [Startup:A.GoToSurface] Running Loop=1
2019-05-07T23:22:35.975Z,1557271355.975 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2019-05-07T23:22:35.975Z,1557271355.975 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2019-05-07T23:22:35.976Z,1557271355.976 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2019-05-07T23:22:35.976Z,1557271355.976 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2019-05-07T23:22:35.976Z,1557271355.976 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2019-05-07T23:22:35.977Z,1557271355.977 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2019-05-07T23:22:35.978Z,1557271355.978 [Startup:StartupSatComms] Running Loop=1
2019-05-07T23:22:35.978Z,1557271355.978 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2019-05-07T23:22:35.978Z,1557271355.978 [Startup:StartupSatComms:A] Running Loop=1
2019-05-07T23:22:36.387Z,1557271356.387 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2019-05-07T23:22:49.670Z,1557271369.670 [AcousticModem_Benthos_ATM900](FAULT): failed to initialize, no bytes available on serial interface
2019-05-07T23:22:49.670Z,1557271369.670 [AcousticModem_Benthos_ATM900] Communications Fault, FailCount= 4
2019-05-07T23:22:49.670Z,1557271369.670 [AcousticModem_Benthos_ATM900](ERROR): Communications Fault
2019-05-07T23:22:49.736Z,1557271369.736 [CBIT](ERROR): Communications Fault in component: AcousticModem_Benthos_ATM900
2019-05-07T23:22:50.070Z,1557271370.070 [AcousticModem_Benthos_ATM900](INFO): Powering down
2019-05-07T23:22:50.932Z,1557271370.932 [CBIT](INFO): Clearing failed state for component AcousticModem_Benthos_ATM900
2019-05-07T23:22:50.932Z,1557271370.932 [AcousticModem_Benthos_ATM900] No Fault, FailCount= 4
2019-05-07T23:22:53.306Z,1557271373.306 [AcousticModem_Benthos_ATM900](INFO): Powering up
2019-05-07T23:22:53.306Z,1557271373.306 [AcousticModem_Benthos_ATM900](DEBUG): Initializing AcousticModem_Benthos_ATM900.
2019-05-07T23:23:13.498Z,1557271393.498 [AcousticModem_Benthos_ATM900](FAULT): failed to initialize, no bytes available on serial interface
2019-05-07T23:23:13.498Z,1557271393.498 [AcousticModem_Benthos_ATM900] Communications Fault, FailCount= 5
2019-05-07T23:23:13.498Z,1557271393.498 [AcousticModem_Benthos_ATM900](ERROR): Communications Fault
2019-05-07T23:23:13.554Z,1557271393.554 [CBIT](ERROR): Communications Fault in component: AcousticModem_Benthos_ATM900
2019-05-07T23:23:13.906Z,1557271393.906 [AcousticModem_Benthos_ATM900](INFO): Powering down
2019-05-07T23:23:14.754Z,1557271394.754 [CBIT](INFO): Clearing failed state for component AcousticModem_Benthos_ATM900
2019-05-07T23:23:14.754Z,1557271394.754 [AcousticModem_Benthos_ATM900] No Fault, FailCount= 5
2019-05-07T23:23:17.141Z,1557271397.141 [AcousticModem_Benthos_ATM900](INFO): Powering up
2019-05-07T23:23:17.142Z,1557271397.142 [AcousticModem_Benthos_ATM900](DEBUG): Initializing AcousticModem_Benthos_ATM900.
2019-05-07T23:23:17.992Z,1557271397.992 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-05-07T23:23:17.992Z,1557271397.992 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2019-05-07T23:23:17.992Z,1557271397.992 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-05-07T23:23:17.994Z,1557271397.994 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-05-07T23:23:17.994Z,1557271397.994 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 1
2019-05-07T23:23:17.994Z,1557271397.994 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2019-05-07T23:23:17.995Z,1557271397.995 [DeadReckonWithRespectToSeafloor](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-05-07T23:23:17.996Z,1557271397.996 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1
2019-05-07T23:23:17.996Z,1557271397.996 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2019-05-07T23:23:18.042Z,1557271398.042 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-05-07T23:23:18.043Z,1557271398.043 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2019-05-07T23:23:18.043Z,1557271398.043 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2019-05-07T23:23:18.401Z,1557271398.401 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-05-07T23:23:18.401Z,1557271398.401 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2019-05-07T23:23:18.402Z,1557271398.402 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2019-05-07T23:23:18.402Z,1557271398.402 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 1
2019-05-07T23:23:18.402Z,1557271398.402 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2019-05-07T23:23:18.402Z,1557271398.402 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1
2019-05-07T23:23:18.788Z,1557271398.788 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2019-05-07T23:23:36.155Z,1557271416.155 [Startup:StartupSatComms:A](INFO): Timed out from 2019-05-07T23:22:35.0Z
2019-05-07T23:23:36.155Z,1557271416.155 [Startup:StartupSatComms:A] Stopped
2019-05-07T23:23:36.155Z,1557271416.155 [Startup:StartupSatComms:B] Running Loop=1
2019-05-07T23:23:36.563Z,1557271416.563 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2019-05-07T23:23:37.342Z,1557271417.342 [AcousticModem_Benthos_ATM900](FAULT): failed to initialize, no bytes available on serial interface
2019-05-07T23:23:37.342Z,1557271417.342 [AcousticModem_Benthos_ATM900] Communications Fault, FailCount= 6
2019-05-07T23:23:37.342Z,1557271417.342 [AcousticModem_Benthos_ATM900](ERROR): Communications Fault
2019-05-07T23:23:37.398Z,1557271417.398 [CBIT](ERROR): Communications Fault in component: AcousticModem_Benthos_ATM900
2019-05-07T23:23:37.751Z,1557271417.751 [AcousticModem_Benthos_ATM900](INFO): Powering down
2019-05-07T23:23:38.598Z,1557271418.598 [CBIT](INFO): Clearing failed state for component AcousticModem_Benthos_ATM900
2019-05-07T23:23:38.598Z,1557271418.598 [AcousticModem_Benthos_ATM900] No Fault, FailCount= 6
2019-05-07T23:23:40.977Z,1557271420.977 [AcousticModem_Benthos_ATM900](INFO): Powering up
2019-05-07T23:23:40.978Z,1557271420.978 [AcousticModem_Benthos_ATM900](DEBUG): Initializing AcousticModem_Benthos_ATM900.
2019-05-07T23:23:45.754Z,1557271425.754 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004574
2019-05-07T23:23:55.572Z,1557271435.572 [DataOverHttps](INFO): Sending 18 bytes from file Logs/20190507T230342/Courier0004.lzma
2019-05-07T23:23:56.378Z,1557271436.378 [DataOverHttps](INFO): Moved sent file to Logs/20190507T230342/Courier0004.lzma.bak
2019-05-07T23:23:56.379Z,1557271436.379 [DataOverHttps](INFO): SBD MOMSN=10961000
2019-05-07T23:24:01.183Z,1557271441.183 [AcousticModem_Benthos_ATM900](FAULT): failed to initialize, no bytes available on serial interface
2019-05-07T23:24:01.183Z,1557271441.183 [AcousticModem_Benthos_ATM900] Communications Fault, FailCount= 7
2019-05-07T23:24:01.183Z,1557271441.183 [AcousticModem_Benthos_ATM900](ERROR): Communications Fault
2019-05-07T23:24:01.232Z,1557271441.232 [CBIT](ERROR): Communications Fault in component: AcousticModem_Benthos_ATM900
2019-05-07T23:24:01.578Z,1557271441.578 [AcousticModem_Benthos_ATM900](INFO): Powering down
2019-05-07T23:24:02.453Z,1557271442.453 [CBIT](INFO): Clearing failed state for component AcousticModem_Benthos_ATM900
2019-05-07T23:24:02.453Z,1557271442.453 [AcousticModem_Benthos_ATM900] No Fault, FailCount= 7
2019-05-07T23:24:04.810Z,1557271444.810 [AcousticModem_Benthos_ATM900](INFO): Powering up
2019-05-07T23:24:04.810Z,1557271444.810 [AcousticModem_Benthos_ATM900](DEBUG): Initializing AcousticModem_Benthos_ATM900.
2019-05-07T23:24:10.201Z,1557271450.201 [DataOverHttps](INFO): Sending 232 bytes from file Logs/20190507T232106/Courier0000.lzma
2019-05-07T23:24:11.006Z,1557271451.006 [DataOverHttps](INFO): Moved sent file to Logs/20190507T232106/Courier0000.lzma.bak
2019-05-07T23:24:11.007Z,1557271451.007 [DataOverHttps](INFO): SBD MOMSN=10961005
2019-05-07T23:24:21.809Z,1557271461.809 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2019-05-07T23:24:21.809Z,1557271461.809 [Aanderaa_O2] No Fault, FailCount= 3
2019-05-07T23:24:25.010Z,1557271465.010 [AcousticModem_Benthos_ATM900](FAULT): failed to initialize, no bytes available on serial interface
2019-05-07T23:24:25.010Z,1557271465.010 [AcousticModem_Benthos_ATM900] Communications Fault, FailCount= 8
2019-05-07T23:24:25.010Z,1557271465.010 [AcousticModem_Benthos_ATM900](ERROR): Communications Fault
2019-05-07T23:24:25.070Z,1557271465.070 [CBIT](ERROR): Communications Fault in component: AcousticModem_Benthos_ATM900
2019-05-07T23:24:25.070Z,1557271465.070 [CBIT](FAULT): Communications Fault in component: AcousticModem_Benthos_ATM900
2019-05-07T23:24:25.421Z,1557271465.421 [AcousticModem_Benthos_ATM900](INFO): Powering down
2019-05-07T23:24:26.129Z,1557271466.129 [DataOverHttps](INFO): Sending 2237 bytes from file Logs/20190507T230342/Express0001.lzma
2019-05-07T23:24:26.930Z,1557271466.930 [DataOverHttps](INFO): Moved sent file to Logs/20190507T230342/Express0001.lzma.bak
2019-05-07T23:24:26.930Z,1557271466.930 [DataOverHttps](INFO): SBD MOMSN=10961012
2019-05-07T23:24:30.336Z,1557271470.336 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2019-05-07T23:24:30.336Z,1557271470.336 [CTD_Seabird] No Fault, FailCount= 3
2019-05-07T23:24:30.669Z,1557271470.669 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2019-05-07T23:24:30.670Z,1557271470.670 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20
2019-05-07T23:24:32.277Z,1557271472.277 [Aanderaa_O2](FAULT): Failed to initialize within timeout.
2019-05-07T23:24:32.277Z,1557271472.277 [Aanderaa_O2] Communications Fault, FailCount= 1
2019-05-07T23:24:32.277Z,1557271472.277 [Aanderaa_O2](ERROR): Communications Fault
2019-05-07T23:24:32.327Z,1557271472.327 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2019-05-07T23:24:32.797Z,1557271472.797 [Aanderaa_O2](INFO): Powering down
2019-05-07T23:24:33.538Z,1557271473.538 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2019-05-07T23:24:33.538Z,1557271473.538 [Aanderaa_O2] No Fault, FailCount= 1
2019-05-07T23:24:36.367Z,1557271476.367 [Startup:StartupSatComms:B](INFO): Timed out from 2019-05-07T23:23:36.2Z
2019-05-07T23:24:36.367Z,1557271476.367 [Startup:StartupSatComms:B] Stopped
2019-05-07T23:24:36.367Z,1557271476.367 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2019-05-07T23:24:36.367Z,1557271476.367 [Startup:StartupSatComms] Stopped
2019-05-07T23:24:36.367Z,1557271476.367 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2019-05-07T23:24:36.368Z,1557271476.368 [Startup](INFO): Completed Startup
2019-05-07T23:24:36.368Z,1557271476.368 [MissionManager](INFO): Startup is completed.
2019-05-07T23:24:36.368Z,1557271476.368 [MissionManager](INFO): Uninitializing Mission Startup
2019-05-07T23:24:36.368Z,1557271476.368 [Startup] Stopped
2019-05-07T23:24:36.369Z,1557271476.369 [Startup](DEBUG): Aggregate::uninitialize Startup
2019-05-07T23:24:36.369Z,1557271476.369 [Startup:A.GoToSurface] Stopped
2019-05-07T23:24:36.369Z,1557271476.369 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2019-05-07T23:24:36.806Z,1557271476.806 [MissionManager](IMPORTANT): Started mission Default
2019-05-07T23:24:36.806Z,1557271476.806 [Default] Running Loop=1
2019-05-07T23:24:36.806Z,1557271476.806 [Default](DEBUG): Aggregate::initialize Default
2019-05-07T23:24:36.806Z,1557271476.806 [Default:B.GoToSurface] Running Loop=1
2019-05-07T23:24:36.807Z,1557271476.807 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2019-05-07T23:24:36.807Z,1557271476.807 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2019-05-07T23:24:36.807Z,1557271476.807 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2019-05-07T23:24:36.807Z,1557271476.807 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2019-05-07T23:24:36.808Z,1557271476.808 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2019-05-07T23:24:36.808Z,1557271476.808 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2019-05-07T23:24:36.808Z,1557271476.808 [Default:A.Wait] Running Loop=1
2019-05-07T23:24:36.808Z,1557271476.808 [Default:A.Wait](DEBUG): Initialize Wait Component.
2019-05-07T23:24:42.172Z,1557271482.172 [DataOverHttps](INFO): Sending 18 bytes from file Logs/20190507T230342/Express0005.lzma
2019-05-07T23:24:42.978Z,1557271482.978 [DataOverHttps](INFO): Moved sent file to Logs/20190507T230342/Express0005.lzma.bak
2019-05-07T23:24:42.978Z,1557271482.978 [DataOverHttps](INFO): SBD MOMSN=10961145
2019-05-07T23:24:43.725Z,1557271483.725 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2019-05-07T23:24:43.725Z,1557271483.725 [CTD_Seabird] Communications Fault, FailCount= 1
2019-05-07T23:24:43.725Z,1557271483.725 [CTD_Seabird](ERROR): Communications Fault
2019-05-07T23:24:43.993Z,1557271483.993 [Aanderaa_O2](FAULT): Failed to initialize within timeout.
2019-05-07T23:24:43.993Z,1557271483.993 [Aanderaa_O2] Communications Fault, FailCount= 2
2019-05-07T23:24:43.993Z,1557271483.993 [Aanderaa_O2](ERROR): Communications Fault
2019-05-07T23:24:44.054Z,1557271484.054 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2019-05-07T23:24:44.055Z,1557271484.055 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2019-05-07T23:24:44.129Z,1557271484.129 [CTD_Seabird](INFO): Powering down
2019-05-07T23:24:44.517Z,1557271484.517 [Aanderaa_O2](INFO): Powering down
2019-05-07T23:24:45.240Z,1557271485.240 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2019-05-07T23:24:45.240Z,1557271485.240 [Aanderaa_O2] No Fault, FailCount= 2
2019-05-07T23:24:45.240Z,1557271485.240 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2019-05-07T23:24:45.240Z,1557271485.240 [CTD_Seabird] No Fault, FailCount= 1
2019-05-07T23:24:45.473Z,1557271485.473 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2019-05-07T23:24:45.475Z,1557271485.475 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20
2019-05-07T23:24:50.087Z,1557271490.087 [Default:A.Wait](INFO): Done Waiting.
2019-05-07T23:24:50.087Z,1557271490.087 [Default:A.Wait] Stopped
2019-05-07T23:24:50.087Z,1557271490.087 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2019-05-07T23:24:50.481Z,1557271490.481 [Default:CheckIn] Running Loop=1
2019-05-07T23:24:50.481Z,1557271490.481 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2019-05-07T23:24:50.481Z,1557271490.481 [Default:CheckIn:Read_GPS] Running Loop=1
2019-05-07T23:24:50.896Z,1557271490.896 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2019-05-07T23:24:55.709Z,1557271495.709 [Aanderaa_O2](FAULT): Failed to initialize within timeout.
2019-05-07T23:24:55.709Z,1557271495.709 [Aanderaa_O2] Communications Fault, FailCount= 3
2019-05-07T23:24:55.709Z,1557271495.709 [Aanderaa_O2](ERROR): Communications Fault
2019-05-07T23:24:55.748Z,1557271495.748 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2019-05-07T23:24:55.749Z,1557271495.749 [CBIT](FAULT): Communications Fault in component: Aanderaa_O2
2019-05-07T23:24:56.233Z,1557271496.233 [Aanderaa_O2](INFO): Powering down
2019-05-07T23:24:58.525Z,1557271498.525 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2019-05-07T23:24:58.525Z,1557271498.525 [CTD_Seabird] Communications Fault, FailCount= 2
2019-05-07T23:24:58.525Z,1557271498.525 [CTD_Seabird](ERROR): Communications Fault
2019-05-07T23:24:58.576Z,1557271498.576 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2019-05-07T23:24:58.929Z,1557271498.929 [CTD_Seabird](INFO): Powering down
2019-05-07T23:25:00.195Z,1557271500.195 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2019-05-07T23:25:00.195Z,1557271500.195 [CTD_Seabird] No Fault, FailCount= 2
2019-05-07T23:25:00.273Z,1557271500.273 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2019-05-07T23:25:00.274Z,1557271500.274 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20
2019-05-07T23:25:13.325Z,1557271513.325 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2019-05-07T23:25:13.325Z,1557271513.325 [CTD_Seabird] Communications Fault, FailCount= 3
2019-05-07T23:25:13.325Z,1557271513.325 [CTD_Seabird](ERROR): Communications Fault
2019-05-07T23:25:13.540Z,1557271513.540 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2019-05-07T23:25:13.540Z,1557271513.540 [CBIT](FAULT): Communications Fault in component: CTD_Seabird
2019-05-07T23:25:13.729Z,1557271513.729 [CTD_Seabird](INFO): Powering down
2019-05-07T23:25:19.183Z,1557271519.183 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-05-07T23:25:19.183Z,1557271519.183 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2
2019-05-07T23:25:19.183Z,1557271519.183 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-05-07T23:25:19.184Z,1557271519.184 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-05-07T23:25:19.184Z,1557271519.184 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 2
2019-05-07T23:25:19.184Z,1557271519.184 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2019-05-07T23:25:19.186Z,1557271519.186 [DeadReckonWithRespectToSeafloor](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-05-07T23:25:19.186Z,1557271519.186 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 2
2019-05-07T23:25:19.186Z,1557271519.186 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2019-05-07T23:25:19.196Z,1557271519.196 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-05-07T23:25:19.197Z,1557271519.197 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2019-05-07T23:25:19.197Z,1557271519.197 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2019-05-07T23:25:19.594Z,1557271519.594 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-05-07T23:25:19.594Z,1557271519.594 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2
2019-05-07T23:25:19.595Z,1557271519.595 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2019-05-07T23:25:19.595Z,1557271519.595 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 2
2019-05-07T23:25:19.595Z,1557271519.595 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2019-05-07T23:25:19.595Z,1557271519.595 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 2
2019-05-07T23:25:19.984Z,1557271519.984 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2019-05-07T23:26:58.955Z,1557271618.955 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2019-05-07T23:26:59.777Z,1557271619.777 [NAL9602](DEBUG): Fix Requested
2019-05-07T23:27:02.601Z,1557271622.601 [NAL9602](DEBUG): Fix Requested
2019-05-07T23:27:03.044Z,1557271623.044 [CBIT](INFO): Clearing failed state for component PNI_TCM
2019-05-07T23:27:03.044Z,1557271623.044 [PNI_TCM] No Fault, FailCount= 5
2019-05-07T23:27:05.433Z,1557271625.433 [NAL9602](DEBUG): Fix Requested
2019-05-07T23:27:08.261Z,1557271628.261 [NAL9602](DEBUG): Fix Requested
2019-05-07T23:27:10.688Z,1557271630.688 [PNI_TCM](FAULT): Failed to set parameters during initialization.
2019-05-07T23:27:10.688Z,1557271630.688 [PNI_TCM] Data Fault, FailCount= 1
2019-05-07T23:27:10.688Z,1557271630.688 [PNI_TCM](ERROR): Data Fault
2019-05-07T23:27:10.704Z,1557271630.704 [CBIT](ERROR): Data Fault in component: PNI_TCM
2019-05-07T23:27:11.096Z,1557271631.096 [PNI_TCM](INFO): Powering down
2019-05-07T23:27:11.489Z,1557271631.489 [NAL9602](DEBUG): Fix Requested
2019-05-07T23:27:12.330Z,1557271632.330 [CBIT](INFO): Clearing failed state for component PNI_TCM
2019-05-07T23:27:12.330Z,1557271632.330 [PNI_TCM] No Fault, FailCount= 1
2019-05-07T23:27:14.321Z,1557271634.321 [NAL9602](DEBUG): Fix Requested
2019-05-07T23:27:17.562Z,1557271637.562 [NAL9602](DEBUG): Fix Requested
2019-05-07T23:27:19.998Z,1557271639.998 [PNI_TCM](FAULT): Failed to set parameters during initialization.
2019-05-07T23:27:19.998Z,1557271639.998 [PNI_TCM] Data Fault, FailCount= 2
2019-05-07T23:27:19.998Z,1557271639.998 [PNI_TCM](ERROR): Data Fault
2019-05-07T23:27:20.003Z,1557271640.003 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-05-07T23:27:20.003Z,1557271640.003 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3
2019-05-07T23:27:20.003Z,1557271640.003 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-05-07T23:27:20.004Z,1557271640.004 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-05-07T23:27:20.005Z,1557271640.005 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 3
2019-05-07T23:27:20.005Z,1557271640.005 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2019-05-07T23:27:20.006Z,1557271640.006 [DeadReckonWithRespectToSeafloor](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-05-07T23:27:20.006Z,1557271640.006 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 3
2019-05-07T23:27:20.006Z,1557271640.006 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2019-05-07T23:27:20.017Z,1557271640.017 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-05-07T23:27:20.018Z,1557271640.018 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2019-05-07T23:27:20.018Z,1557271640.018 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2019-05-07T23:27:20.018Z,1557271640.018 [CBIT](ERROR): Data Fault in component: PNI_TCM
2019-05-07T23:27:20.377Z,1557271640.377 [NAL9602](DEBUG): Fix Requested
2019-05-07T23:27:20.391Z,1557271640.391 [PNI_TCM](INFO): Powering down
2019-05-07T23:27:20.507Z,1557271640.507 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-05-07T23:27:20.507Z,1557271640.507 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3
2019-05-07T23:27:20.508Z,1557271640.508 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2019-05-07T23:27:20.508Z,1557271640.508 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 3
2019-05-07T23:27:20.508Z,1557271640.508 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2019-05-07T23:27:20.508Z,1557271640.508 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 3
2019-05-07T23:27:20.803Z,1557271640.803 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2019-05-07T23:27:21.610Z,1557271641.610 [CBIT](INFO): Clearing failed state for component PNI_TCM
2019-05-07T23:27:21.610Z,1557271641.610 [PNI_TCM] No Fault, FailCount= 2
2019-05-07T23:27:23.613Z,1557271643.613 [NAL9602](DEBUG): Fix Requested
2019-05-07T23:27:26.052Z,1557271646.052 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2019-05-07T23:27:26.052Z,1557271646.052 [Aanderaa_O2] No Fault, FailCount= 3
2019-05-07T23:27:26.437Z,1557271646.437 [NAL9602](DEBUG): Fix Requested
2019-05-07T23:27:29.269Z,1557271649.269 [NAL9602](DEBUG): Fix Requested
2019-05-07T23:27:29.283Z,1557271649.283 [PNI_TCM](FAULT): Failed to set parameters during initialization.
2019-05-07T23:27:29.283Z,1557271649.283 [PNI_TCM] Data Fault, FailCount= 3
2019-05-07T23:27:29.283Z,1557271649.283 [PNI_TCM](ERROR): Data Fault
2019-05-07T23:27:29.299Z,1557271649.299 [CBIT](ERROR): Data Fault in component: PNI_TCM
2019-05-07T23:27:29.690Z,1557271649.690 [PNI_TCM](INFO): Powering down
2019-05-07T23:27:30.897Z,1557271650.897 [CBIT](INFO): Clearing failed state for component PNI_TCM
2019-05-07T23:27:30.898Z,1557271650.898 [PNI_TCM] No Fault, FailCount= 3
2019-05-07T23:27:32.497Z,1557271652.497 [NAL9602](DEBUG): Fix Requested
2019-05-07T23:27:35.329Z,1557271655.329 [NAL9602](DEBUG): Fix Requested
2019-05-07T23:27:36.517Z,1557271656.517 [Aanderaa_O2](FAULT): Failed to initialize within timeout.
2019-05-07T23:27:36.517Z,1557271656.517 [Aanderaa_O2] Communications Fault, FailCount= 1
2019-05-07T23:27:36.517Z,1557271656.517 [Aanderaa_O2](ERROR): Communications Fault
2019-05-07T23:27:36.566Z,1557271656.566 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2019-05-07T23:27:37.041Z,1557271657.041 [Aanderaa_O2](INFO): Powering down
2019-05-07T23:27:37.782Z,1557271657.782 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2019-05-07T23:27:37.783Z,1557271657.783 [Aanderaa_O2] No Fault, FailCount= 1
2019-05-07T23:27:38.573Z,1557271658.573 [NAL9602](DEBUG): Fix Requested
2019-05-07T23:27:38.588Z,1557271658.588 [PNI_TCM](FAULT): Failed to set parameters during initialization.
2019-05-07T23:27:38.588Z,1557271658.588 [PNI_TCM] Data Fault, FailCount= 4
2019-05-07T23:27:38.588Z,1557271658.588 [PNI_TCM](ERROR): Data Fault
2019-05-07T23:27:38.632Z,1557271658.632 [CBIT](ERROR): Data Fault in component: PNI_TCM
2019-05-07T23:27:38.979Z,1557271658.979 [PNI_TCM](INFO): Powering down
2019-05-07T23:27:40.198Z,1557271660.198 [CBIT](INFO): Clearing failed state for component PNI_TCM
2019-05-07T23:27:40.198Z,1557271660.198 [PNI_TCM] No Fault, FailCount= 4
2019-05-07T23:27:41.389Z,1557271661.389 [NAL9602](DEBUG): Fix Requested
2019-05-07T23:27:43.431Z,1557271663.431 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2019-05-07T23:27:43.431Z,1557271663.431 [CTD_Seabird] No Fault, FailCount= 3
2019-05-07T23:27:43.769Z,1557271663.769 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2019-05-07T23:27:43.770Z,1557271663.770 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20
2019-05-07T23:27:44.621Z,1557271664.621 [NAL9602](DEBUG): Fix Requested
2019-05-07T23:27:47.445Z,1557271667.445 [NAL9602](DEBUG): Fix Requested
2019-05-07T23:27:47.871Z,1557271667.871 [PNI_TCM](FAULT): Failed to set parameters during initialization.
2019-05-07T23:27:47.872Z,1557271667.872 [PNI_TCM] Data Fault, FailCount= 5
2019-05-07T23:27:47.872Z,1557271667.872 [PNI_TCM](ERROR): Data Fault
2019-05-07T23:27:47.920Z,1557271667.920 [CBIT](ERROR): Data Fault in component: PNI_TCM
2019-05-07T23:27:47.920Z,1557271667.920 [CBIT](CRITICAL): Data Fault in component: PNI_TCM
2019-05-07T23:27:48.233Z,1557271668.233 [Aanderaa_O2](FAULT): Failed to initialize within timeout.
2019-05-07T23:27:48.233Z,1557271668.233 [Aanderaa_O2] Communications Fault, FailCount= 2
2019-05-07T23:27:48.233Z,1557271668.233 [Aanderaa_O2](ERROR): Communications Fault
2019-05-07T23:27:48.267Z,1557271668.267 [PNI_TCM](INFO): Powering down
2019-05-07T23:27:48.389Z,1557271668.389 [CBIT](INFO): Critical error at 20190507T232747
2019-05-07T23:27:48.392Z,1557271668.392 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2019-05-07T23:27:48.757Z,1557271668.757 [Aanderaa_O2](INFO): Powering down
2019-05-07T23:27:49.499Z,1557271669.499 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2019-05-07T23:27:49.499Z,1557271669.499 [Aanderaa_O2] No Fault, FailCount= 2
2019-05-07T23:27:50.681Z,1557271670.681 [NAL9602](DEBUG): Fix Requested
2019-05-07T23:27:53.502Z,1557271673.502 [NAL9602](DEBUG): Fix Requested
2019-05-07T23:27:56.337Z,1557271676.337 [NAL9602](DEBUG): Fix Requested
2019-05-07T23:27:56.821Z,1557271676.821 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2019-05-07T23:27:56.821Z,1557271676.821 [CTD_Seabird] Communications Fault, FailCount= 1
2019-05-07T23:27:56.821Z,1557271676.821 [CTD_Seabird](ERROR): Communications Fault
2019-05-07T23:27:57.170Z,1557271677.170 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2019-05-07T23:27:57.225Z,1557271677.225 [CTD_Seabird](INFO): Powering down
2019-05-07T23:27:58.364Z,1557271678.364 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2019-05-07T23:27:58.365Z,1557271678.365 [CTD_Seabird] No Fault, FailCount= 1
2019-05-07T23:27:58.569Z,1557271678.569 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2019-05-07T23:27:58.570Z,1557271678.570 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20
2019-05-07T23:27:59.561Z,1557271679.561 [NAL9602](DEBUG): Fix Requested
2019-05-07T23:27:59.951Z,1557271679.951 [Aanderaa_O2](FAULT): Failed to initialize within timeout.
2019-05-07T23:27:59.951Z,1557271679.951 [Aanderaa_O2] Communications Fault, FailCount= 3
2019-05-07T23:27:59.951Z,1557271679.951 [Aanderaa_O2](ERROR): Communications Fault
2019-05-07T23:28:00.007Z,1557271680.007 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2019-05-07T23:28:00.008Z,1557271680.008 [CBIT](FAULT): Communications Fault in component: Aanderaa_O2
2019-05-07T23:28:00.473Z,1557271680.473 [Aanderaa_O2](INFO): Powering down
2019-05-07T23:28:02.397Z,1557271682.397 [NAL9602](DEBUG): Fix Requested
2019-05-07T23:28:05.621Z,1557271685.621 [NAL9602](DEBUG): Fix Requested
2019-05-07T23:28:08.457Z,1557271688.457 [NAL9602](DEBUG): Fix Requested
2019-05-07T23:28:11.621Z,1557271691.621 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2019-05-07T23:28:11.621Z,1557271691.621 [CTD_Seabird] Communications Fault, FailCount= 2
2019-05-07T23:28:11.621Z,1557271691.621 [CTD_Seabird](ERROR): Communications Fault
2019-05-07T23:28:11.689Z,1557271691.689 [NAL9602](DEBUG): Fix Requested
2019-05-07T23:28:11.743Z,1557271691.743 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2019-05-07T23:28:12.025Z,1557271692.025 [CTD_Seabird](INFO): Powering down
2019-05-07T23:28:13.328Z,1557271693.328 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2019-05-07T23:28:13.328Z,1557271693.328 [CTD_Seabird] No Fault, FailCount= 2
2019-05-07T23:28:13.369Z,1557271693.369 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2019-05-07T23:28:13.370Z,1557271693.370 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20
2019-05-07T23:28:14.517Z,1557271694.517 [NAL9602](DEBUG): Fix Requested
2019-05-07T23:28:17.337Z,1557271697.337 [NAL9602](DEBUG): Fix Requested
2019-05-07T23:28:20.577Z,1557271700.577 [NAL9602](DEBUG): Fix Requested
2019-05-07T23:28:23.401Z,1557271703.401 [NAL9602](DEBUG): Fix Requested
2019-05-07T23:28:26.422Z,1557271706.422 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2019-05-07T23:28:26.422Z,1557271706.422 [CTD_Seabird] Communications Fault, FailCount= 3
2019-05-07T23:28:26.422Z,1557271706.422 [CTD_Seabird](ERROR): Communications Fault
2019-05-07T23:28:26.633Z,1557271706.633 [NAL9602](DEBUG): Fix Requested
2019-05-07T23:28:26.668Z,1557271706.668 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2019-05-07T23:28:26.668Z,1557271706.668 [CBIT](FAULT): Communications Fault in component: CTD_Seabird
2019-05-07T23:28:26.825Z,1557271706.825 [CTD_Seabird](INFO): Powering down
2019-05-07T23:28:29.461Z,1557271709.461 [NAL9602](DEBUG): Fix Requested
2019-05-07T23:28:32.697Z,1557271712.697 [NAL9602](DEBUG): Fix Requested
2019-05-07T23:28:35.525Z,1557271715.525 [NAL9602](DEBUG): Fix Requested
2019-05-07T23:28:38.753Z,1557271718.753 [NAL9602](DEBUG): Fix Requested
2019-05-07T23:28:41.585Z,1557271721.585 [NAL9602](DEBUG): Fix Requested
2019-05-07T23:28:44.405Z,1557271724.405 [NAL9602](DEBUG): Fix Requested
2019-05-07T23:28:47.641Z,1557271727.641 [NAL9602](DEBUG): Fix Requested
2019-05-07T23:28:50.469Z,1557271730.469 [NAL9602](DEBUG): Fix Requested
2019-05-07T23:28:53.701Z,1557271733.701 [NAL9602](DEBUG): Fix Requested
2019-05-07T23:28:56.529Z,1557271736.529 [NAL9602](DEBUG): Fix Requested
2019-05-07T23:28:59.761Z,1557271739.761 [NAL9602](DEBUG): Fix Requested
2019-05-07T23:29:02.589Z,1557271742.589 [NAL9602](DEBUG): Fix Requested
2019-05-07T23:29:05.417Z,1557271745.417 [NAL9602](DEBUG): Fix Requested
2019-05-07T23:29:08.653Z,1557271748.653 [NAL9602](DEBUG): Fix Requested
2019-05-07T23:29:11.501Z,1557271751.501 [NAL9602](DEBUG): Fix Requested
2019-05-07T23:29:14.709Z,1557271754.709 [NAL9602](DEBUG): Fix Requested
2019-05-07T23:29:17.541Z,1557271757.541 [NAL9602](DEBUG): Fix Requested
2019-05-07T23:29:20.769Z,1557271760.769 [NAL9602](DEBUG): Fix Requested
2019-05-07T23:29:21.238Z,1557271761.238 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-05-07T23:29:21.238Z,1557271761.238 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4
2019-05-07T23:29:21.238Z,1557271761.238 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-05-07T23:29:21.239Z,1557271761.239 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-05-07T23:29:21.239Z,1557271761.239 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 4
2019-05-07T23:29:21.239Z,1557271761.239 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2019-05-07T23:29:21.253Z,1557271761.253 [DeadReckonWithRespectToSeafloor](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-05-07T23:29:21.253Z,1557271761.253 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 4
2019-05-07T23:29:21.253Z,1557271761.253 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2019-05-07T23:29:21.288Z,1557271761.288 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-05-07T23:29:21.288Z,1557271761.288 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2019-05-07T23:29:21.288Z,1557271761.288 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2019-05-07T23:29:21.630Z,1557271761.630 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-05-07T23:29:21.630Z,1557271761.630 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4
2019-05-07T23:29:21.630Z,1557271761.630 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2019-05-07T23:29:21.631Z,1557271761.631 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 4
2019-05-07T23:29:21.631Z,1557271761.631 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2019-05-07T23:29:21.631Z,1557271761.631 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 4
2019-05-07T23:29:22.000Z,1557271762.000 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2019-05-07T23:29:23.618Z,1557271763.618 [NAL9602](DEBUG): Fix Requested
2019-05-07T23:29:25.251Z,1557271765.251 [CBIT](INFO): Clearing failed state for component AcousticModem_Benthos_ATM900
2019-05-07T23:29:25.251Z,1557271765.251 [AcousticModem_Benthos_ATM900] No Fault, FailCount= 8
2019-05-07T23:29:25.601Z,1557271765.601 [AcousticModem_Benthos_ATM900](INFO): Powering up
2019-05-07T23:29:25.602Z,1557271765.602 [AcousticModem_Benthos_ATM900](DEBUG): Initializing AcousticModem_Benthos_ATM900.
2019-05-07T23:29:26.425Z,1557271766.425 [NAL9602](DEBUG): Fix Requested
2019-05-07T23:29:28.445Z,1557271768.445 [NAL9602](DEBUG): Fix Requested
2019-05-07T23:29:31.681Z,1557271771.681 [NAL9602](DEBUG): Fix Requested
2019-05-07T23:29:34.521Z,1557271774.521 [NAL9602](DEBUG): Fix Requested
2019-05-07T23:29:37.737Z,1557271777.737 [NAL9602](DEBUG): Fix Requested
2019-05-07T23:29:40.582Z,1557271780.582 [NAL9602](DEBUG): Fix Requested
2019-05-07T23:29:43.801Z,1557271783.801 [NAL9602](DEBUG): Fix Requested
2019-05-07T23:29:45.802Z,1557271785.802 [AcousticModem_Benthos_ATM900](FAULT): failed to initialize, no bytes available on serial interface
2019-05-07T23:29:45.802Z,1557271785.802 [AcousticModem_Benthos_ATM900] Communications Fault, FailCount= 1
2019-05-07T23:29:45.802Z,1557271785.802 [AcousticModem_Benthos_ATM900](ERROR): Communications Fault
2019-05-07T23:29:45.913Z,1557271785.913 [CBIT](ERROR): Communications Fault in component: AcousticModem_Benthos_ATM900
2019-05-07T23:29:46.205Z,1557271786.205 [AcousticModem_Benthos_ATM900](INFO): Powering down
2019-05-07T23:29:46.625Z,1557271786.625 [NAL9602](DEBUG): Fix Requested
2019-05-07T23:29:47.081Z,1557271787.081 [CBIT](INFO): Clearing failed state for component AcousticModem_Benthos_ATM900
2019-05-07T23:29:47.081Z,1557271787.081 [AcousticModem_Benthos_ATM900] No Fault, FailCount= 1
2019-05-07T23:29:49.441Z,1557271789.441 [AcousticModem_Benthos_ATM900](INFO): Powering up
2019-05-07T23:29:49.442Z,1557271789.442 [AcousticModem_Benthos_ATM900](DEBUG): Initializing AcousticModem_Benthos_ATM900.
2019-05-07T23:29:49.857Z,1557271789.857 [NAL9602](DEBUG): Fix Requested
2019-05-07T23:29:50.696Z,1557271790.696 [Default:CheckIn:Read_GPS](INFO): Timed out from 2019-05-07T23:24:50.5Z
2019-05-07T23:29:50.696Z,1557271790.696 [Default:CheckIn:Read_GPS] Stopped
2019-05-07T23:29:50.696Z,1557271790.696 [Default:CheckIn:Read_Iridium] Running Loop=1
2019-05-07T23:29:51.100Z,1557271791.100 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications
2019-05-07T23:29:52.709Z,1557271792.709 [NAL9602](DEBUG): Fix Requested
2019-05-07T23:29:55.529Z,1557271795.529 [NAL9602](DEBUG): Fix Requested
2019-05-07T23:29:58.761Z,1557271798.761 [NAL9602](DEBUG): Fix Requested
2019-05-07T23:30:00.958Z,1557271800.958 [DataOverHttps](INFO): Sending 69 bytes from file Logs/20190507T232106/Courier0004.lzma
2019-05-07T23:30:01.585Z,1557271801.585 [NAL9602](DEBUG): Fix Requested
2019-05-07T23:30:01.766Z,1557271801.766 [DataOverHttps](INFO): Moved sent file to Logs/20190507T232106/Courier0004.lzma.bak
2019-05-07T23:30:01.767Z,1557271801.767 [DataOverHttps](INFO): SBD MOMSN=10961158
2019-05-07T23:30:04.833Z,1557271804.833 [NAL9602](DEBUG): Fix Requested
2019-05-07T23:30:07.653Z,1557271807.653 [NAL9602](DEBUG): Fix Requested
2019-05-07T23:30:09.658Z,1557271809.658 [AcousticModem_Benthos_ATM900](FAULT): failed to initialize, no bytes available on serial interface
2019-05-07T23:30:09.658Z,1557271809.658 [AcousticModem_Benthos_ATM900] Communications Fault, FailCount= 2
2019-05-07T23:30:09.658Z,1557271809.658 [AcousticModem_Benthos_ATM900](ERROR): Communications Fault
2019-05-07T23:30:09.708Z,1557271809.708 [CBIT](ERROR): Communications Fault in component: AcousticModem_Benthos_ATM900
2019-05-07T23:30:10.054Z,1557271810.054 [AcousticModem_Benthos_ATM900](INFO): Powering down
2019-05-07T23:30:10.889Z,1557271810.889 [NAL9602](DEBUG): Fix Requested
2019-05-07T23:30:10.955Z,1557271810.955 [CBIT](INFO): Clearing failed state for component AcousticModem_Benthos_ATM900
2019-05-07T23:30:10.955Z,1557271810.955 [AcousticModem_Benthos_ATM900] No Fault, FailCount= 2
2019-05-07T23:30:13.294Z,1557271813.294 [AcousticModem_Benthos_ATM900](INFO): Powering up
2019-05-07T23:30:13.294Z,1557271813.294 [AcousticModem_Benthos_ATM900](DEBUG): Initializing AcousticModem_Benthos_ATM900.
2019-05-07T23:30:13.705Z,1557271813.705 [NAL9602](DEBUG): Fix Requested
2019-05-07T23:30:16.533Z,1557271816.533 [NAL9602](DEBUG): Fix Requested
2019-05-07T23:30:18.553Z,1557271818.553 [NAL9602](DEBUG): Fix Requested
2019-05-07T23:30:21.801Z,1557271821.801 [NAL9602](DEBUG): Fix Requested
2019-05-07T23:30:24.649Z,1557271824.649 [NAL9602](DEBUG): Fix Requested
2019-05-07T23:30:26.195Z,1557271826.195 [DataOverHttps](INFO): Sending 1284 bytes from file Logs/20190507T232106/Express0001.lzma
2019-05-07T23:30:26.994Z,1557271826.994 [DataOverHttps](INFO): Moved sent file to Logs/20190507T232106/Express0001.lzma.bak
2019-05-07T23:30:26.994Z,1557271826.994 [DataOverHttps](INFO): SBD MOMSN=10961165
2019-05-07T23:30:27.845Z,1557271827.845 [NAL9602](DEBUG): Fix Requested
2019-05-07T23:30:30.296Z,1557271830.296 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2019-05-07T23:30:30.296Z,1557271830.296 [Aanderaa_O2] No Fault, FailCount= 3
2019-05-07T23:30:30.673Z,1557271830.673 [NAL9602](DEBUG): Fix Requested
2019-05-07T23:30:33.489Z,1557271833.489 [AcousticModem_Benthos_ATM900](FAULT): failed to initialize, no bytes available on serial interface
2019-05-07T23:30:33.490Z,1557271833.490 [AcousticModem_Benthos_ATM900] Communications Fault, FailCount= 3
2019-05-07T23:30:33.490Z,1557271833.490 [AcousticModem_Benthos_ATM900](ERROR): Communications Fault
2019-05-07T23:30:33.570Z,1557271833.570 [CBIT](ERROR): Communications Fault in component: AcousticModem_Benthos_ATM900
2019-05-07T23:30:33.889Z,1557271833.889 [AcousticModem_Benthos_ATM900](INFO): Powering down
2019-05-07T23:30:34.029Z,1557271834.029 [NAL9602](DEBUG): Fix Requested
2019-05-07T23:30:34.767Z,1557271834.767 [CBIT](INFO): Clearing failed state for component AcousticModem_Benthos_ATM900
2019-05-07T23:30:34.767Z,1557271834.767 [AcousticModem_Benthos_ATM900] No Fault, FailCount= 3
2019-05-07T23:30:36.737Z,1557271836.737 [NAL9602](DEBUG): Fix Requested
2019-05-07T23:30:37.124Z,1557271837.124 [AcousticModem_Benthos_ATM900](INFO): Powering up
2019-05-07T23:30:37.125Z,1557271837.125 [AcousticModem_Benthos_ATM900](DEBUG): Initializing AcousticModem_Benthos_ATM900.
2019-05-07T23:30:39.561Z,1557271839.561 [NAL9602](DEBUG): Fix Requested
2019-05-07T23:30:40.753Z,1557271840.753 [Aanderaa_O2](FAULT): Failed to initialize within timeout.
2019-05-07T23:30:40.753Z,1557271840.753 [Aanderaa_O2] Communications Fault, FailCount= 1
2019-05-07T23:30:40.753Z,1557271840.753 [Aanderaa_O2](ERROR): Communications Fault
2019-05-07T23:30:40.874Z,1557271840.874 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2019-05-07T23:30:41.285Z,1557271841.285 [Aanderaa_O2](INFO): Powering down
2019-05-07T23:30:42.130Z,1557271842.130 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2019-05-07T23:30:42.130Z,1557271842.130 [Aanderaa_O2] No Fault, FailCount= 1
2019-05-07T23:30:42.805Z,1557271842.805 [NAL9602](DEBUG): Fix Requested
2019-05-07T23:30:45.641Z,1557271845.641 [NAL9602](DEBUG): Fix Requested
2019-05-07T23:30:48.861Z,1557271848.861 [NAL9602](DEBUG): Fix Requested
2019-05-07T23:30:51.678Z,1557271851.678 [AcousticModem_Benthos_ATM900](DEBUG): 
2019-05-07T23:30:51.693Z,1557271851.693 [NAL9602](DEBUG): Fix Requested
2019-05-07T23:30:52.441Z,1557271852.441 [DataOverHttps](INFO): Sending 594 bytes from file Logs/20190507T232106/Express0005.lzma
2019-05-07T23:30:52.481Z,1557271852.481 [Aanderaa_O2](FAULT): Failed to initialize within timeout.
2019-05-07T23:30:52.481Z,1557271852.481 [Aanderaa_O2] Communications Fault, FailCount= 2
2019-05-07T23:30:52.481Z,1557271852.481 [Aanderaa_O2](ERROR): Communications Fault
2019-05-07T23:30:52.623Z,1557271852.623 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2019-05-07T23:30:53.005Z,1557271853.005 [Aanderaa_O2](INFO): Powering down
2019-05-07T23:30:53.009Z,1557271853.009 [AcousticModem_Benthos_ATM900](DEBUG): Teledyne Benthos DAT-900 Series
2019-05-07T23:30:53.010Z,1557271853.010 [AcousticModem_Benthos_ATM900](DEBUG): MF Frequency Band
2019-05-07T23:30:53.011Z,1557271853.011 [AcousticModem_Benthos_ATM900](DEBUG): Directional Acoustic Transponder version 8.12.21
2019-05-07T23:30:53.247Z,1557271853.247 [DataOverHttps](INFO): Moved sent file to Logs/20190507T232106/Express0005.lzma.bak
2019-05-07T23:30:53.247Z,1557271853.247 [DataOverHttps](INFO): SBD MOMSN=10961208
2019-05-07T23:30:53.702Z,1557271853.702 [AcousticModem_Benthos_ATM900](DEBUG): Jan 12 2000 14:10:06 
2019-05-07T23:30:53.703Z,1557271853.703 [AcousticModem_Benthos_ATM900](DEBUG): Features enabled [Bearing]
2019-05-07T23:30:53.704Z,1557271853.704 [AcousticModem_Benthos_ATM900](DEBUG): WARNING: diag.rom image not found; POST not performed
2019-05-07T23:30:53.795Z,1557271853.795 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2019-05-07T23:30:53.795Z,1557271853.795 [Aanderaa_O2] No Fault, FailCount= 2
2019-05-07T23:30:54.530Z,1557271854.530 [AcousticModem_Benthos_ATM900](INFO): entering command mode
2019-05-07T23:30:54.910Z,1557271854.910 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2019-05-07T23:30:54.925Z,1557271854.925 [NAL9602](DEBUG): Fix Requested
2019-05-07T23:30:55.318Z,1557271855.318 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2019-05-07T23:30:55.318Z,1557271855.318 [AcousticModem_Benthos_ATM900](DEBUG): read user prompt 1: user:1>
2019-05-07T23:30:55.318Z,1557271855.318 [AcousticModem_Benthos_ATM900](INFO): command mode acknowledged
2019-05-07T23:30:55.732Z,1557271855.732 [AcousticModem_Benthos_ATM900](INFO): setting local address to 3
2019-05-07T23:30:56.126Z,1557271856.126 [AcousticModem_Benthos_ATM900](DEBUG): checking for local address setting acknowledgment
2019-05-07T23:30:56.126Z,1557271856.126 [AcousticModem_Benthos_ATM900](INFO): set local address to 3
2019-05-07T23:30:56.527Z,1557271856.527 [AcousticModem_Benthos_ATM900](DEBUG): read user prompt 2: user:2>
2019-05-07T23:30:56.612Z,1557271856.612 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2019-05-07T23:30:56.612Z,1557271856.612 [CTD_Seabird] No Fault, FailCount= 3
2019-05-07T23:30:56.862Z,1557271856.862 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2019-05-07T23:30:56.869Z,1557271856.869 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20
2019-05-07T23:30:57.735Z,1557271857.735 [CommandLine](IMPORTANT): got command quit
2019-05-07T23:30:57.761Z,1557271857.761 [NAL9602](DEBUG): Fix Requested
2019-05-07T23:30:58.741Z,1557271858.741 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2019-05-07T23:30:58.741Z,1557271858.741 [CommandLine ThreadHandler](INFO): Thread cancelled.
2019-05-07T23:30:58.749Z,1557271858.749 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup.  Bye!
2019-05-07T23:30:58.749Z,1557271858.749 [CommandLine ThreadHandler](INFO): Thread cancelled.
2019-05-07T23:30:58.750Z,1557271858.750 [CommandLine](INFO): Join timeout helper Thread ID is 1434
2019-05-07T23:30:58.753Z,1557271858.753 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2019-05-07T23:30:58.753Z,1557271858.753 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2019-05-07T23:30:58.755Z,1557271858.755 [NavChartDb](INFO): Join timeout helper Thread ID is 1435
2019-05-07T23:30:59.121Z,1557271859.121 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2019-05-07T23:30:59.122Z,1557271859.122 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2019-05-07T23:30:59.122Z,1557271859.122 [ComponentRegistry](INFO): Shutting down Rowe_600 ThreadHandler
2019-05-07T23:30:59.122Z,1557271859.122 [Rowe_600 ThreadHandler](INFO): Thread cancelled.
2019-05-07T23:30:59.123Z,1557271859.123 [Rowe_600](INFO): Join timeout helper Thread ID is 1436
2019-05-07T23:30:59.313Z,1557271859.313 [Rowe_600 ThreadHandler](INFO): Uninitializing protected caller thread.
2019-05-07T23:30:59.313Z,1557271859.313 [Rowe_600](INFO): Powering down
2019-05-07T23:30:59.389Z,1557271859.389 [Rowe_600 ThreadHandler](INFO): Thread cancelled.
2019-05-07T23:30:59.473Z,1557271859.473 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2019-05-07T23:30:59.473Z,1557271859.473 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2019-05-07T23:30:59.474Z,1557271859.474 [Radio_Surface](INFO): Join timeout helper Thread ID is 1437
2019-05-07T23:30:59.693Z,1557271859.693 [Radio_Surface](INFO): Powering down
2019-05-07T23:30:59.694Z,1557271859.694 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2019-05-07T23:30:59.694Z,1557271859.694 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2019-05-07T23:30:59.705Z,1557271859.705 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler
2019-05-07T23:30:59.705Z,1557271859.705 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2019-05-07T23:30:59.706Z,1557271859.706 [DataOverHttps](INFO): Join timeout helper Thread ID is 1438
2019-05-07T23:30:59.909Z,1557271859.909 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread.
2019-05-07T23:30:59.910Z,1557271859.910 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2019-05-07T23:30:59.926Z,1557271859.926 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2019-05-07T23:30:59.926Z,1557271859.926 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2019-05-07T23:30:59.927Z,1557271859.927 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 1439
2019-05-07T23:31:00.306Z,1557271860.306 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread.
2019-05-07T23:31:00.306Z,1557271860.306 [WetLabsBB2FL](INFO): Powering down
2019-05-07T23:31:00.306Z,1557271860.306 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2019-05-07T23:31:00.310Z,1557271860.310 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler
2019-05-07T23:31:00.310Z,1557271860.310 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2019-05-07T23:31:00.310Z,1557271860.310 [CTD_Seabird](INFO): Join timeout helper Thread ID is 1440
2019-05-07T23:31:00.581Z,1557271860.581 [NAL9602](DEBUG): Fix Requested
2019-05-07T23:31:00.877Z,1557271860.877 [CTD_Seabird](INFO): Powering down
2019-05-07T23:31:01.009Z,1557271861.009 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread.
2019-05-07T23:31:01.009Z,1557271861.009 [CTD_Seabird](INFO): Powering down
2019-05-07T23:31:01.021Z,1557271861.021 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2019-05-07T23:31:01.038Z,1557271861.038 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2019-05-07T23:31:01.038Z,1557271861.038 [logger ThreadHandler](INFO): Thread cancelled.
2019-05-07T23:31:01.038Z,1557271861.038 [logger](INFO): Join timeout helper Thread ID is 1441
2019-05-07T23:31:01.045Z,1557271861.045 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2019-05-07T23:31:01.045Z,1557271861.045 [logger ThreadHandler](INFO): Thread cancelled.
2019-05-07T23:31:01.066Z,1557271861.066 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2019-05-07T23:31:01.066Z,1557271861.066 [CommandLine ThreadHandler](INFO): Thread cancelled.
2019-05-07T23:31:01.066Z,1557271861.066 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2019-05-07T23:31:01.066Z,1557271861.066 [controlThread ThreadHandler](INFO): Thread cancelled.
2019-05-07T23:31:01.066Z,1557271861.066 [controlThread](INFO): Join timeout helper Thread ID is 1442
2019-05-07T23:31:01.067Z,1557271861.067 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2019-05-07T23:31:01.067Z,1557271861.067 [controlThread](DEBUG): Uninitializing ControlThread
2019-05-07T23:31:01.185Z,1557271861.185 [Aanderaa_O2](INFO): Powering down
2019-05-07T23:31:01.187Z,1557271861.187 [AcousticModem_Benthos_ATM900](INFO): Powering down
2019-05-07T23:31:01.308Z,1557271861.308 [NAL9602](INFO): Powering down
2019-05-07T23:31:01.313Z,1557271861.313 [PNI_TCM](INFO): Powering down
2019-05-07T23:31:01.315Z,1557271861.315 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2019-05-07T23:31:01.316Z,1557271861.316 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2019-05-07T23:31:01.316Z,1557271861.316 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2019-05-07T23:31:01.317Z,1557271861.317 [MissionManager](INFO): Uninitializing Mission Default
2019-05-07T23:31:01.317Z,1557271861.317 [Default] Stopped
2019-05-07T23:31:01.317Z,1557271861.317 [Default](DEBUG): Aggregate::uninitialize Default
2019-05-07T23:31:01.317Z,1557271861.317 [Default:B.GoToSurface] Stopped
2019-05-07T23:31:01.317Z,1557271861.317 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2019-05-07T23:31:01.317Z,1557271861.317 [Default:CheckIn] Stopped
2019-05-07T23:31:01.318Z,1557271861.318 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2019-05-07T23:31:01.318Z,1557271861.318 [Default:CheckIn:Read_Iridium] Stopped
2019-05-07T23:31:01.320Z,1557271861.320 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2019-05-07T23:31:01.320Z,1557271861.320 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2019-05-07T23:31:01.325Z,1557271861.325 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2019-05-07T23:31:01.329Z,1557271861.329 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2019-05-07T23:31:01.329Z,1557271861.329 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2019-05-07T23:31:01.337Z,1557271861.337 [BuoyancyServo](INFO): Powering down
2019-05-07T23:31:01.349Z,1557271861.349 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2019-05-07T23:31:01.349Z,1557271861.349 [ElevatorServo](INFO): Powering down
2019-05-07T23:31:01.350Z,1557271861.350 [MassServo](DEBUG): Uninitialize Mass Servo.
2019-05-07T23:31:01.350Z,1557271861.350 [MassServo](INFO): Powering down
2019-05-07T23:31:01.351Z,1557271861.351 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2019-05-07T23:31:01.351Z,1557271861.351 [RudderServo](INFO): Powering down
2019-05-07T23:31:01.352Z,1557271861.352 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2019-05-07T23:31:01.352Z,1557271861.352 [ThrusterServo](INFO): Powering down
2019-05-07T23:31:01.353Z,1557271861.353 [SBIT](DEBUG): Uninitialize SBIT Component.
2019-05-07T23:31:01.353Z,1557271861.353 [IBIT](DEBUG): Uninitialize IBIT Component.
2019-05-07T23:31:01.354Z,1557271861.354 [CBIT](DEBUG): Uninitialize CBIT Component.
2019-05-07T23:31:01.354Z,1557271861.354 [CBIT](DEBUG): Powering off loads.
2019-05-07T23:31:01.365Z,1557271861.365 [CBIT](DEBUG): Disabling WDT.
2019-05-07T23:31:01.377Z,1557271861.377 [CBIT](DEBUG): Opening all GF detection circuits.
2019-05-07T23:31:01.378Z,1557271861.378 [controlThread ThreadHandler](INFO): Thread cancelled.
2019-05-07T23:31:01.428Z,1557271861.428 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2019-05-07T23:31:01.450Z,1557271861.450 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2019-05-07T23:31:01.683Z,1557271861.683 [Rowe_600 ThreadHandler](INFO): Thread cancelled.
2019-05-07T23:31:01.706Z,1557271861.706 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2019-05-07T23:31:01.711Z,1557271861.711 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2019-05-07T23:31:01.916Z,1557271861.916 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2019-05-07T23:31:02.177Z,1557271862.177 [logger ThreadHandler](INFO): Thread cancelled.