2019-04-01T18:12:30.489Z,1554142350.489 [Supervisor](DEBUG): Initializing supervisor.
2019-04-01T18:12:30.492Z,1554142350.492 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2019-04-01T18:12:30.493Z,1554142350.493 [SyncHandler](INFO): Protected caller Thread ID is 1820
2019-04-01T18:12:30.494Z,1554142350.494 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2019-04-01T18:12:30.495Z,1554142350.495 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2019-04-01T18:12:30.495Z,1554142350.495 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 1821
2019-04-01T18:12:30.498Z,1554142350.498 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2019-04-01T18:12:30.509Z,1554142350.509 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2019-04-01T18:12:30.510Z,1554142350.510 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2019-04-01T18:12:30.511Z,1554142350.511 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 1822
2019-04-01T18:12:30.512Z,1554142350.512 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2019-04-01T18:12:30.513Z,1554142350.513 [logger ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2019-04-01T18:12:30.513Z,1554142350.513 [logger ThreadHandler](INFO): Protected caller Thread ID is 1823
2019-04-01T18:12:30.515Z,1554142350.515 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2019-04-01T18:12:30.515Z,1554142350.515 [Supervisor](INFO): Looking for Config files in directory: Config/
2019-04-01T18:12:30.517Z,1554142350.517 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2019-04-01T18:12:30.612Z,1554142350.612 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2019-04-01T18:12:30.613Z,1554142350.613 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2019-04-01T18:12:30.813Z,1554142350.813 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2019-04-01T18:12:30.814Z,1554142350.814 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2019-04-01T18:12:30.951Z,1554142350.951 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2019-04-01T18:12:30.952Z,1554142350.952 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2019-04-01T18:12:31.408Z,1554142351.408 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2019-04-01T18:12:31.408Z,1554142351.408 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2019-04-01T18:12:31.849Z,1554142351.849 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2019-04-01T18:12:31.849Z,1554142351.849 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2019-04-01T18:12:32.315Z,1554142352.315 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2019-04-01T18:12:32.316Z,1554142352.316 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2019-04-01T18:12:32.622Z,1554142352.622 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2019-04-01T18:12:32.622Z,1554142352.622 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2019-04-01T18:12:32.954Z,1554142352.954 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2019-04-01T18:12:32.955Z,1554142352.955 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2019-04-01T18:12:33.346Z,1554142353.346 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2019-04-01T18:12:33.347Z,1554142353.347 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2019-04-01T18:12:33.495Z,1554142353.495 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2019-04-01T18:12:33.496Z,1554142353.496 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2019-04-01T18:12:33.601Z,1554142353.601 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2019-04-01T18:12:33.602Z,1554142353.602 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2019-04-01T18:12:33.682Z,1554142353.682 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2019-04-01T18:12:33.783Z,1554142353.783 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample
2019-04-01T18:12:33.784Z,1554142353.784 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2019-04-01T18:12:33.980Z,1554142353.980 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2019-04-01T18:12:33.981Z,1554142353.981 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2019-04-01T18:12:34.187Z,1554142354.187 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2019-04-01T18:12:34.189Z,1554142354.189 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-makai/
2019-04-01T18:12:34.190Z,1554142354.190 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/secure.cfg
2019-04-01T18:12:34.272Z,1554142354.272 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Battery.cfg
2019-04-01T18:12:34.501Z,1554142354.501 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2019-04-01T18:12:34.501Z,1554142354.501 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Navigation.cfg
2019-04-01T18:12:34.597Z,1554142354.597 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Sensor.cfg
2019-04-01T18:12:34.764Z,1554142354.764 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/vehicle.cfg
2019-04-01T18:12:34.977Z,1554142354.977 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Simulator.cfg
2019-04-01T18:12:35.062Z,1554142355.062 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Servo.cfg
2019-04-01T18:12:35.159Z,1554142355.159 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Control.cfg
2019-04-01T18:12:35.252Z,1554142355.252 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Science.cfg
2019-04-01T18:12:35.435Z,1554142355.435 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/logger.cfg
2019-04-01T18:12:35.820Z,1554142355.820 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/BIT.cfg
2019-04-01T18:12:36.092Z,1554142356.092 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-makai/root/
2019-04-01T18:12:36.092Z,1554142356.092 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg
2019-04-01T18:12:36.096Z,1554142356.096 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2019-04-01T18:12:36.391Z,1554142356.391 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2019-04-01T18:12:36.391Z,1554142356.391 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2019-04-01T18:12:36.617Z,1554142356.617 [BuoyancyServo] Loaded
2019-04-01T18:12:36.618Z,1554142356.618 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2019-04-01T18:12:36.646Z,1554142356.646 [ElevatorServo] Loaded
2019-04-01T18:12:36.646Z,1554142356.646 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2019-04-01T18:12:36.663Z,1554142356.663 [MassServo] Loaded
2019-04-01T18:12:36.663Z,1554142356.663 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2019-04-01T18:12:36.679Z,1554142356.679 [RudderServo] Loaded
2019-04-01T18:12:36.679Z,1554142356.679 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2019-04-01T18:12:36.694Z,1554142356.694 [ThrusterServo] Loaded
2019-04-01T18:12:36.694Z,1554142356.694 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread.
2019-04-01T18:12:36.694Z,1554142356.694 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2019-04-01T18:12:36.695Z,1554142356.695 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2019-04-01T18:12:36.829Z,1554142356.829 [SBIT](DEBUG): Construct Startup Built In Test.
2019-04-01T18:12:36.857Z,1554142356.857 [SBIT] Loaded
2019-04-01T18:12:36.857Z,1554142356.857 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2019-04-01T18:12:36.858Z,1554142356.858 [IBIT](DEBUG): Construct Initiated Built In Test.
2019-04-01T18:12:36.886Z,1554142356.886 [IBIT] Loaded
2019-04-01T18:12:36.886Z,1554142356.886 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2019-04-01T18:12:36.889Z,1554142356.889 [CBIT](DEBUG): Construct Continuous Built In Test.
2019-04-01T18:12:37.274Z,1554142357.274 [CBIT] Loaded
2019-04-01T18:12:37.274Z,1554142357.274 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2019-04-01T18:12:37.274Z,1554142357.274 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2019-04-01T18:12:37.275Z,1554142357.275 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2019-04-01T18:12:37.456Z,1554142357.456 [Aanderaa_O2] Loaded
2019-04-01T18:12:37.456Z,1554142357.456 [ComponentRegistry](DEBUG): SyncComponent "Aanderaa_O2" handled in the control thread.
2019-04-01T18:12:37.466Z,1554142357.466 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_density
2019-04-01T18:12:37.471Z,1554142357.471 [CTD_Seabird](INFO): created writer for : sea_water_density
2019-04-01T18:12:37.473Z,1554142357.473 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): depth
2019-04-01T18:12:37.478Z,1554142357.478 [CTD_Seabird](INFO): created writer for : depth
2019-04-01T18:12:37.478Z,1554142357.478 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_pressure
2019-04-01T18:12:37.483Z,1554142357.483 [CTD_Seabird](INFO): created writer for : sea_water_pressure
2019-04-01T18:12:37.484Z,1554142357.484 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_salinity
2019-04-01T18:12:37.489Z,1554142357.489 [CTD_Seabird](INFO): created writer for : sea_water_salinity
2019-04-01T18:12:37.490Z,1554142357.490 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_temperature
2019-04-01T18:12:37.495Z,1554142357.495 [CTD_Seabird](INFO): created writer for : sea_water_temperature
2019-04-01T18:12:37.496Z,1554142357.496 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_electrical_conductivity
2019-04-01T18:12:37.501Z,1554142357.501 [CTD_Seabird](INFO): created writer for : sea_water_electrical_conductivity
2019-04-01T18:12:37.502Z,1554142357.502 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): speed_of_sound_in_sea_water
2019-04-01T18:12:37.507Z,1554142357.507 [CTD_Seabird](INFO): created writer for : speed_of_sound_in_sea_water
2019-04-01T18:12:37.533Z,1554142357.533 [CTD_Seabird] Loaded
2019-04-01T18:12:37.533Z,1554142357.533 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread.
2019-04-01T18:12:37.534Z,1554142357.534 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 406654E0
2019-04-01T18:12:37.535Z,1554142357.535 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 1902
2019-04-01T18:12:37.560Z,1554142357.560 [ESPComponent] Loaded
2019-04-01T18:12:37.561Z,1554142357.561 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread.
2019-04-01T18:12:37.574Z,1554142357.574 [PAR_Licor] Loaded
2019-04-01T18:12:37.575Z,1554142357.575 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2019-04-01T18:12:37.622Z,1554142357.622 [WetLabsBB2FL] Loaded
2019-04-01T18:12:37.623Z,1554142357.623 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2019-04-01T18:12:37.624Z,1554142357.624 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 406954E0
2019-04-01T18:12:37.624Z,1554142357.624 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 1903
2019-04-01T18:12:37.625Z,1554142357.625 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2019-04-01T18:12:37.625Z,1554142357.625 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2019-04-01T18:12:37.665Z,1554142357.665 [DepthRateCalculator] Loaded
2019-04-01T18:12:37.666Z,1554142357.666 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2019-04-01T18:12:37.671Z,1554142357.671 [PitchRateCalculator] Loaded
2019-04-01T18:12:37.672Z,1554142357.672 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2019-04-01T18:12:37.687Z,1554142357.687 [SpeedCalculator] Loaded
2019-04-01T18:12:37.687Z,1554142357.687 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2019-04-01T18:12:37.709Z,1554142357.709 [TempGradientCalculator] Loaded
2019-04-01T18:12:37.709Z,1554142357.709 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread.
2019-04-01T18:12:37.715Z,1554142357.715 [YawRateCalculator] Loaded
2019-04-01T18:12:37.715Z,1554142357.715 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2019-04-01T18:12:37.748Z,1554142357.748 [ElevatorOffsetCalculator] Loaded
2019-04-01T18:12:37.748Z,1554142357.748 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2019-04-01T18:12:37.749Z,1554142357.749 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2019-04-01T18:12:37.749Z,1554142357.749 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2019-04-01T18:12:37.775Z,1554142357.775 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2019-04-01T18:12:37.776Z,1554142357.776 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2019-04-01T18:12:37.878Z,1554142357.878 [DeadReckonUsingMultipleVelocitySources] Loaded
2019-04-01T18:12:37.878Z,1554142357.878 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2019-04-01T18:12:37.937Z,1554142357.937 [DeadReckonUsingSpeedCalculator] Loaded
2019-04-01T18:12:37.938Z,1554142357.938 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread.
2019-04-01T18:12:37.997Z,1554142357.997 [DeadReckonWithRespectToSeafloor] Loaded
2019-04-01T18:12:37.997Z,1554142357.997 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonWithRespectToSeafloor" handled in the control thread.
2019-04-01T18:12:38.018Z,1554142358.018 [NavChart] Loaded
2019-04-01T18:12:38.018Z,1554142358.018 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2019-04-01T18:12:38.022Z,1554142358.022 [UniversalFixResidualReporter] Loaded
2019-04-01T18:12:38.023Z,1554142358.023 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2019-04-01T18:12:38.023Z,1554142358.023 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2019-04-01T18:12:38.023Z,1554142358.023 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2019-04-01T18:12:38.318Z,1554142358.318 [AcousticModem_Benthos_ATM900] Loaded
2019-04-01T18:12:38.318Z,1554142358.318 [ComponentRegistry](DEBUG): SyncComponent "AcousticModem_Benthos_ATM900" handled in the control thread.
2019-04-01T18:12:38.396Z,1554142358.396 [DataOverHttps] Loaded
2019-04-01T18:12:38.396Z,1554142358.396 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2019-04-01T18:12:38.397Z,1554142358.397 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 4096C4E0
2019-04-01T18:12:38.398Z,1554142358.398 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 1904
2019-04-01T18:12:38.411Z,1554142358.411 [Depth_Keller] Loaded
2019-04-01T18:12:38.411Z,1554142358.411 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2019-04-01T18:12:38.502Z,1554142358.502 [NAL9602] Loaded
2019-04-01T18:12:38.502Z,1554142358.502 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2019-04-01T18:12:38.507Z,1554142358.507 [Onboard] Loaded
2019-04-01T18:12:38.507Z,1554142358.507 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread.
2019-04-01T18:12:38.510Z,1554142358.510 [Radio_Surface] Loaded
2019-04-01T18:12:38.511Z,1554142358.511 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2019-04-01T18:12:38.512Z,1554142358.512 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 4099C4E0
2019-04-01T18:12:38.512Z,1554142358.512 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 1905
2019-04-01T18:12:39.794Z,1554142359.794 [BPC1] Loaded
2019-04-01T18:12:39.794Z,1554142359.794 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2019-04-01T18:12:39.795Z,1554142359.795 [BR_Ping](CRITICAL): No configuration setting for: BR_Ping.simulateHardware
2019-04-01T18:12:39.804Z,1554142359.804 [BR_Ping] Loaded
2019-04-01T18:12:39.804Z,1554142359.804 [ComponentRegistry](DEBUG): SyncComponent "BR_Ping" handled in the control thread.
2019-04-01T18:12:39.804Z,1554142359.804 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2019-04-01T18:12:39.805Z,1554142359.805 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2019-04-01T18:12:39.867Z,1554142359.867 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2019-04-01T18:12:39.868Z,1554142359.868 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2019-04-01T18:12:39.936Z,1554142359.936 [VerticalControl](DEBUG): Construct VerticalControl.
2019-04-01T18:12:40.019Z,1554142360.019 [VerticalControl] Loaded
2019-04-01T18:12:40.019Z,1554142360.019 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2019-04-01T18:12:40.020Z,1554142360.020 [HorizontalControl](DEBUG): Construct HorizontalControl.
2019-04-01T18:12:40.077Z,1554142360.077 [HorizontalControl] Loaded
2019-04-01T18:12:40.077Z,1554142360.077 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2019-04-01T18:12:40.078Z,1554142360.078 [SpeedControl](DEBUG): Construct SpeedControl.
2019-04-01T18:12:40.080Z,1554142360.080 [SpeedControl] Loaded
2019-04-01T18:12:40.080Z,1554142360.080 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2019-04-01T18:12:40.081Z,1554142360.081 [LoopControl](DEBUG): Construct LoopControl.
2019-04-01T18:12:40.081Z,1554142360.081 [LoopControl] Loaded
2019-04-01T18:12:40.082Z,1554142360.082 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2019-04-01T18:12:40.082Z,1554142360.082 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2019-04-01T18:12:40.083Z,1554142360.083 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2019-04-01T18:12:40.095Z,1554142360.095 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2019-04-01T18:12:40.096Z,1554142360.096 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2019-04-01T18:12:40.368Z,1554142360.368 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2019-04-01T18:12:40.372Z,1554142360.372 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2019-04-01T18:12:40.373Z,1554142360.373 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2019-04-01T18:12:40.379Z,1554142360.379 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2019-04-01T18:12:40.380Z,1554142360.380 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40AC94E0
2019-04-01T18:12:40.381Z,1554142360.381 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 1906
2019-04-01T18:12:40.385Z,1554142360.385 [Supervisor](INFO): Main Thread ID is 803
2019-04-01T18:12:40.385Z,1554142360.385 [Supervisor](DEBUG): Running supervisor.
2019-04-01T18:12:40.386Z,1554142360.386 [CommandLine ThreadHandler](INFO): Handler Thread ID is 1907
2019-04-01T18:12:40.388Z,1554142360.388 [controlThread ThreadHandler](INFO): Handler Thread ID is 1908
2019-04-01T18:12:40.389Z,1554142360.389 [controlThread](DEBUG): Initializing ControlThread
2019-04-01T18:12:40.391Z,1554142360.391 [SBIT](INFO): Initialize SBIT Component.
2019-04-01T18:12:40.391Z,1554142360.391 [SBIT](IMPORTANT): git: 2019-03-18-25-g41eb097
2019-04-01T18:12:40.391Z,1554142360.391 [SBIT](INFO): git hash: 41eb097d057d44a6b31f942ace2973a2253fba2e
2019-04-01T18:12:40.392Z,1554142360.392 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2019-04-01T18:12:40.393Z,1554142360.393 [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-04-01T18:12:40.394Z,1554142360.394 [SBIT](INFO): Beginning SBIT in 24.000000 seconds.
2019-04-01T18:12:40.394Z,1554142360.394 [IBIT](INFO): Initialize IBIT Component.
2019-04-01T18:12:40.395Z,1554142360.395 [CBIT](DEBUG): Initialize CBIT Component.
2019-04-01T18:12:40.396Z,1554142360.396 [logger ThreadHandler](INFO): Handler Thread ID is 1909
2019-04-01T18:12:40.409Z,1554142360.409 [CBIT](DEBUG): Initialized mux pins.
2019-04-01T18:12:40.409Z,1554142360.409 [CBIT](DEBUG): Initializing the watchdog timer.
2019-04-01T18:12:40.417Z,1554142360.417 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 1910
2019-04-01T18:12:40.418Z,1554142360.418 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2019-04-01T18:12:40.421Z,1554142360.421 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20
2019-04-01T18:12:40.422Z,1554142360.422 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 1912
2019-04-01T18:12:40.424Z,1554142360.424 [WetLabsBB2FL](INFO): Powering down
2019-04-01T18:12:40.433Z,1554142360.433 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2019-04-01T18:12:40.433Z,1554142360.433 [CBIT](DEBUG): Initializing heartbeat.
2019-04-01T18:12:40.453Z,1554142360.453 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 1913
2019-04-01T18:12:40.454Z,1554142360.454 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2019-04-01T18:12:40.465Z,1554142360.465 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 1914
2019-04-01T18:12:40.481Z,1554142360.481 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 1915
2019-04-01T18:12:40.484Z,1554142360.484 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2019-04-01T18:12:40.484Z,1554142360.484 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2019-04-01T18:12:40.484Z,1554142360.484 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2019-04-01T18:12:40.485Z,1554142360.485 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2019-04-01T18:12:40.486Z,1554142360.486 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2019-04-01T18:12:40.486Z,1554142360.486 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2019-04-01T18:12:40.486Z,1554142360.486 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000
2019-04-01T18:12:40.486Z,1554142360.486 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000
2019-04-01T18:12:40.487Z,1554142360.487 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2019-04-01T18:12:40.487Z,1554142360.487 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2019-04-01T18:12:40.487Z,1554142360.487 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000
2019-04-01T18:12:40.487Z,1554142360.487 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000
2019-04-01T18:12:40.487Z,1554142360.487 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000
2019-04-01T18:12:40.487Z,1554142360.487 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000
2019-04-01T18:12:40.488Z,1554142360.488 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000
2019-04-01T18:12:40.488Z,1554142360.488 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000
2019-04-01T18:12:40.505Z,1554142360.505 [CBIT](DEBUG): Deactivating GF circuits.
2019-04-01T18:12:40.505Z,1554142360.505 [CBIT](DEBUG): Deactivating emergency mode.
2019-04-01T18:12:40.541Z,1554142360.541 [CBIT](DEBUG): Backplane powered.
2019-04-01T18:12:40.545Z,1554142360.545 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2019-04-01T18:12:40.545Z,1554142360.545 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2019-04-01T18:12:40.546Z,1554142360.546 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2019-04-01T18:12:40.546Z,1554142360.546 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator.
2019-04-01T18:12:40.547Z,1554142360.547 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2019-04-01T18:12:40.547Z,1554142360.547 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2019-04-01T18:12:40.548Z,1554142360.548 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2019-04-01T18:12:40.549Z,1554142360.549 [NavChart](DEBUG): Initialize NavChart Navigation.
2019-04-01T18:12:40.550Z,1554142360.550 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2019-04-01T18:12:40.555Z,1554142360.555 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2019-04-01T18:12:40.557Z,1554142360.557 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2019-04-01T18:12:40.558Z,1554142360.558 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2019-04-01T18:12:40.558Z,1554142360.558 [LoopControl](DEBUG): Initialize LoopControlComponent.
2019-04-01T18:12:40.561Z,1554142360.561 [MissionManager](INFO): Loading Mission: Missions/Startup.xml
2019-04-01T18:12:40.596Z,1554142360.596 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2019-04-01T18:12:40.631Z,1554142360.631 [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-04-01T18:12:40.632Z,1554142360.632 [MissionManager](INFO): Loading Mission: Missions/Default.xml
2019-04-01T18:12:40.698Z,1554142360.698 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2019-04-01T18:12:40.699Z,1554142360.699 [Default:A.Wait](DEBUG): Construct Wait.
2019-04-01T18:12:40.714Z,1554142360.714 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2019-04-01T18:12:40.777Z,1554142360.777 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2019-04-01T18:12:40.779Z,1554142360.779 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2019-04-01T18:12:40.785Z,1554142360.785 [Default:E.Execute](DEBUG): Construct Execute.
2019-04-01T18:12:40.788Z,1554142360.788 [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-04-01T18:12:40.809Z,1554142360.809 [controlThread](DEBUG): Component order: CycleStarter,Aanderaa_O2,ESPComponent,PAR_Licor,AcousticModem_Benthos_ATM900,Depth_Keller,NAL9602,Onboard,BPC1,BR_Ping,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-04-01T18:12:40.825Z,1554142360.825 [ESPComponent](INFO): powering down ESP
2019-04-01T18:12:40.869Z,1554142360.869 [Radio_Surface](INFO): Powering up
2019-04-01T18:12:41.262Z,1554142361.262 [PAR_Licor](INFO): A/D timeout, 9 tries over 135 ms

2019-04-01T18:12:41.262Z,1554142361.262 [PAR_Licor] Data Fault, FailCount= 1
2019-04-01T18:12:41.262Z,1554142361.262 [PAR_Licor](ERROR): Data Fault
2019-04-01T18:12:41.263Z,1554142361.263 [AcousticModem_Benthos_ATM900](INFO): Powering up
2019-04-01T18:12:41.263Z,1554142361.263 [AcousticModem_Benthos_ATM900](DEBUG): Initializing AcousticModem_Benthos_ATM900.
2019-04-01T18:12:41.483Z,1554142361.483 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2019-04-01T18:12:41.489Z,1554142361.489 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2019-04-01T18:12:41.490Z,1554142361.490 [ElevatorServo](DEBUG): Initializing EZServoServo.
2019-04-01T18:12:41.497Z,1554142361.497 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2019-04-01T18:12:41.498Z,1554142361.498 [MassServo](DEBUG): Initializing EZServoServo.
2019-04-01T18:12:41.505Z,1554142361.505 [MassServo](DEBUG): Initializing MassServo.
2019-04-01T18:12:41.506Z,1554142361.506 [RudderServo](DEBUG): Initializing EZServoServo.
2019-04-01T18:12:41.513Z,1554142361.513 [RudderServo](DEBUG): Initializing RudderServo.
2019-04-01T18:12:41.514Z,1554142361.514 [ThrusterServo](DEBUG): Initializing EZServoServo.
2019-04-01T18:12:41.521Z,1554142361.521 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2019-04-01T18:12:41.523Z,1554142361.523 [CommandLine](FAULT): Scheduling is paused
2019-04-01T18:12:41.524Z,1554142361.524 [CBIT](INFO): Critical error at 20190401T181239
2019-04-01T18:12:41.524Z,1554142361.524 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals
2019-04-01T18:12:41.525Z,1554142361.525 [CBIT](FAULT): Main Battery Failure. Count: 1
2019-04-01T18:12:41.529Z,1554142361.529 [CBIT](ERROR): Data Fault in component: PAR_Licor
2019-04-01T18:12:41.529Z,1554142361.529 [CBIT](INFO): Clearing failed state for component PAR_Licor
2019-04-01T18:12:41.529Z,1554142361.529 [PAR_Licor] No Fault, FailCount= 1
2019-04-01T18:12:42.089Z,1554142362.089 [PAR_Licor](INFO): A/D timeout, 7 tries over 139 ms

2019-04-01T18:12:42.089Z,1554142362.089 [PAR_Licor] Data Fault, FailCount= 2
2019-04-01T18:12:42.089Z,1554142362.089 [PAR_Licor](ERROR): Data Fault
2019-04-01T18:12:42.137Z,1554142362.137 [BR_Ping](CRITICAL): SIGSEGV: address not mapped to object
2019-04-01T18:12:42.137Z,1554142362.137 [BR_Ping](CRITICAL): Bad address: 0x0
2019-04-01T18:12:42.138Z,1554142362.138 [BR_Ping](CRITICAL): Backtrace: 
./bin/LRAUV(_ZN7PCaller20DefaultSignalHandlerEiP7siginfoPv+0x20) [0x1790e4]
./bin/LRAUV(_ZN9Component7executeEv+0x31c) [0xd6b8c]
./bin/LRAUV(_ZN7PCaller10PThreadRunEPv+0xbc) [0x178c80]

2019-04-01T18:12:42.138Z,1554142362.138 [BR_Ping] Software Fault, FailCount= 1
2019-04-01T18:12:42.138Z,1554142362.138 [BR_Ping](ERROR): Software Fault
2019-04-01T18:12:42.153Z,1554142362.153 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2019-04-01T18:12:42.153Z,1554142362.153 [SyncHandler](INFO): Protected caller Thread ID is 1925
2019-04-01T18:12:42.482Z,1554142362.482 [CBIT](INFO): Critical error at 20190401T181242
2019-04-01T18:12:42.485Z,1554142362.485 [CBIT](ERROR): Data Fault in component: PAR_Licor
2019-04-01T18:12:42.485Z,1554142362.485 [CBIT](INFO): Clearing failed state for component PAR_Licor
2019-04-01T18:12:42.485Z,1554142362.485 [PAR_Licor] No Fault, FailCount= 2
2019-04-01T18:12:42.486Z,1554142362.486 [CBIT](ERROR): Software Fault in component: BR_Ping
2019-04-01T18:12:42.528Z,1554142362.528 [BR_Ping](INFO): Powering down
2019-04-01T18:12:43.437Z,1554142363.437 [PAR_Licor](INFO): A/D timeout, 8 tries over 138 ms

2019-04-01T18:12:43.437Z,1554142363.437 [PAR_Licor] Data Fault, FailCount= 1
2019-04-01T18:12:43.437Z,1554142363.437 [PAR_Licor](ERROR): Data Fault
2019-04-01T18:12:43.489Z,1554142363.489 [CBIT](ERROR): Data Fault in component: PAR_Licor
2019-04-01T18:12:43.489Z,1554142363.489 [CBIT](INFO): Clearing failed state for component PAR_Licor
2019-04-01T18:12:43.489Z,1554142363.489 [PAR_Licor] No Fault, FailCount= 1
2019-04-01T18:12:43.808Z,1554142363.808 [CBIT](INFO): Clearing failed state for component BR_Ping
2019-04-01T18:12:43.808Z,1554142363.808 [BR_Ping] No Fault, FailCount= 1
2019-04-01T18:12:44.245Z,1554142364.245 [PAR_Licor](INFO): A/D timeout, 8 tries over 138 ms

2019-04-01T18:12:44.245Z,1554142364.245 [PAR_Licor] Data Fault, FailCount= 2
2019-04-01T18:12:44.245Z,1554142364.245 [PAR_Licor](ERROR): Data Fault
2019-04-01T18:12:44.641Z,1554142364.641 [MassServo](FAULT): Mass shifter EEPROM initialization uart error serial timeout
2019-04-01T18:12:44.641Z,1554142364.641 [MassServo] Communications Fault, FailCount= 1
2019-04-01T18:12:44.641Z,1554142364.641 [MassServo](ERROR): Communications Fault
2019-04-01T18:12:44.645Z,1554142364.645 [CBIT](ERROR): Communications Fault in component: MassServo
2019-04-01T18:12:44.645Z,1554142364.645 [CBIT](ERROR): Data Fault in component: PAR_Licor
2019-04-01T18:12:44.646Z,1554142364.646 [CBIT](INFO): Clearing failed state for component PAR_Licor
2019-04-01T18:12:44.646Z,1554142364.646 [PAR_Licor] No Fault, FailCount= 2
2019-04-01T18:12:44.745Z,1554142364.745 [MassServo](DEBUG): Uninitialize Mass Servo.
2019-04-01T18:12:44.745Z,1554142364.745 [MassServo](INFO): Powering down
2019-04-01T18:12:45.090Z,1554142365.090 [BR_Ping](CRITICAL): SIGSEGV: address not mapped to object
2019-04-01T18:12:45.090Z,1554142365.090 [BR_Ping](CRITICAL): Bad address: 0x0
2019-04-01T18:12:45.091Z,1554142365.091 [BR_Ping](CRITICAL): Backtrace: 
./bin/LRAUV(_ZN7PCaller20DefaultSignalHandlerEiP7siginfoPv+0x20) [0x1790e4]
./bin/LRAUV(_ZN9Component7executeEv+0x31c) [0xd6b8c]
./bin/LRAUV(_ZN7PCaller10PThreadRunEPv+0xbc) [0x178c80]

2019-04-01T18:12:45.091Z,1554142365.091 [BR_Ping] Software Fault, FailCount= 2
2019-04-01T18:12:45.091Z,1554142365.091 [BR_Ping](ERROR): Software Fault
2019-04-01T18:12:45.101Z,1554142365.101 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2019-04-01T18:12:45.101Z,1554142365.101 [SyncHandler](INFO): Protected caller Thread ID is 1927
2019-04-01T18:12:45.474Z,1554142365.474 [CBIT](INFO): Critical error at 20190401T181245
2019-04-01T18:12:45.477Z,1554142365.477 [CBIT](ERROR): Software Fault in component: BR_Ping
2019-04-01T18:12:45.632Z,1554142365.632 [PAR_Licor](INFO): A/D timeout, 8 tries over 148 ms

2019-04-01T18:12:45.641Z,1554142365.641 [PAR_Licor] Data Fault, FailCount= 1
2019-04-01T18:12:45.641Z,1554142365.641 [PAR_Licor](ERROR): Data Fault
2019-04-01T18:12:45.663Z,1554142365.663 [BR_Ping](INFO): Powering down
2019-04-01T18:12:45.764Z,1554142365.764 [MassServo](DEBUG): Initializing EZServoServo.
2019-04-01T18:12:45.882Z,1554142365.882 [MassServo](DEBUG): Initializing MassServo.
2019-04-01T18:12:45.884Z,1554142365.884 [CBIT](FAULT): Main Battery Failure. Count: 11
2019-04-01T18:12:45.886Z,1554142365.886 [CBIT](INFO): Clearing failed state for component MassServo
2019-04-01T18:12:45.886Z,1554142365.886 [MassServo] No Fault, FailCount= 1
2019-04-01T18:12:45.887Z,1554142365.887 [CBIT](ERROR): Data Fault in component: PAR_Licor
2019-04-01T18:12:45.887Z,1554142365.887 [CBIT](INFO): Clearing failed state for component PAR_Licor
2019-04-01T18:12:45.887Z,1554142365.887 [PAR_Licor] No Fault, FailCount= 1
2019-04-01T18:12:46.437Z,1554142366.437 [PAR_Licor](INFO): A/D timeout, 9 tries over 142 ms

2019-04-01T18:12:46.437Z,1554142366.437 [PAR_Licor] Data Fault, FailCount= 2
2019-04-01T18:12:46.437Z,1554142366.437 [PAR_Licor](ERROR): Data Fault
2019-04-01T18:12:46.509Z,1554142366.509 [CBIT](ERROR): Data Fault in component: PAR_Licor
2019-04-01T18:12:46.510Z,1554142366.510 [CBIT](INFO): Clearing failed state for component PAR_Licor
2019-04-01T18:12:46.510Z,1554142366.510 [PAR_Licor] No Fault, FailCount= 2
2019-04-01T18:12:46.805Z,1554142366.805 [CBIT](INFO): Clearing failed state for component BR_Ping
2019-04-01T18:12:46.805Z,1554142366.805 [BR_Ping] No Fault, FailCount= 2
2019-04-01T18:12:47.253Z,1554142367.253 [PAR_Licor](INFO): A/D timeout, 9 tries over 150 ms

2019-04-01T18:12:47.253Z,1554142367.253 [PAR_Licor] Data Fault, FailCount= 3
2019-04-01T18:12:47.253Z,1554142367.253 [PAR_Licor](ERROR): Data Fault
2019-04-01T18:12:47.537Z,1554142367.537 [CBIT](ERROR): Data Fault in component: PAR_Licor
2019-04-01T18:12:47.538Z,1554142367.538 [CBIT](CRITICAL): Data Fault in component: PAR_Licor
2019-04-01T18:12:47.587Z,1554142367.587 [CBIT](INFO): Critical error at 20190401T181247
2019-04-01T18:12:47.977Z,1554142367.977 [BR_Ping](CRITICAL): SIGSEGV: address not mapped to object
2019-04-01T18:12:47.977Z,1554142367.977 [BR_Ping](CRITICAL): Bad address: 0x0
2019-04-01T18:12:47.978Z,1554142367.978 [BR_Ping](CRITICAL): Backtrace: 
./bin/LRAUV(_ZN7PCaller20DefaultSignalHandlerEiP7siginfoPv+0x20) [0x1790e4]
./bin/LRAUV(_ZN9Component7executeEv+0x31c) [0xd6b8c]
./bin/LRAUV(_ZN7PCaller10PThreadRunEPv+0xbc) [0x178c80]

2019-04-01T18:12:47.978Z,1554142367.978 [BR_Ping] Software Fault, FailCount= 3
2019-04-01T18:12:47.978Z,1554142367.978 [BR_Ping](ERROR): Software Fault
2019-04-01T18:12:47.989Z,1554142367.989 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2019-04-01T18:12:47.989Z,1554142367.989 [SyncHandler](INFO): Protected caller Thread ID is 1930
2019-04-01T18:12:48.309Z,1554142368.309 [MassServo](FAULT): Mass shifter EEPROM initialization uart error serial timeout
2019-04-01T18:12:48.309Z,1554142368.309 [MassServo] Communications Fault, FailCount= 2
2019-04-01T18:12:48.309Z,1554142368.309 [MassServo](ERROR): Communications Fault
2019-04-01T18:12:48.311Z,1554142368.311 [CBIT](INFO): Critical error at 20190401T181247
2019-04-01T18:12:48.313Z,1554142368.313 [CBIT](ERROR): Communications Fault in component: MassServo
2019-04-01T18:12:48.314Z,1554142368.314 [CBIT](ERROR): Software Fault in component: BR_Ping
2019-04-01T18:12:48.365Z,1554142368.365 [BR_Ping](INFO): Powering down
2019-04-01T18:12:48.452Z,1554142368.452 [MassServo](DEBUG): Uninitialize Mass Servo.
2019-04-01T18:12:48.452Z,1554142368.452 [MassServo](INFO): Powering down
2019-04-01T18:12:49.205Z,1554142369.205 [MassServo](DEBUG): Initializing EZServoServo.
2019-04-01T18:12:49.326Z,1554142369.326 [MassServo](DEBUG): Initializing MassServo.
2019-04-01T18:12:49.330Z,1554142369.330 [CBIT](INFO): Clearing failed state for component MassServo
2019-04-01T18:12:49.330Z,1554142369.330 [MassServo] No Fault, FailCount= 2
2019-04-01T18:12:49.591Z,1554142369.591 [CBIT](FAULT): Main Battery Failure. Count: 21
2019-04-01T18:12:49.594Z,1554142369.594 [CBIT](INFO): Clearing failed state for component BR_Ping
2019-04-01T18:12:49.594Z,1554142369.594 [BR_Ping] No Fault, FailCount= 3
2019-04-01T18:12:50.428Z,1554142370.428 [CBIT](CRITICAL): Environmental Failure. Press:14.739250 PSI. Humidity:36%. Temp:26 C. ABORTING MISSION
2019-04-01T18:12:50.806Z,1554142370.806 [BR_Ping](CRITICAL): SIGSEGV: address not mapped to object
2019-04-01T18:12:50.806Z,1554142370.806 [BR_Ping](CRITICAL): Bad address: 0x0
2019-04-01T18:12:50.806Z,1554142370.806 [BR_Ping](CRITICAL): Backtrace: 
./bin/LRAUV(_ZN7PCaller20DefaultSignalHandlerEiP7siginfoPv+0x20) [0x1790e4]
./bin/LRAUV(_ZN9Component7executeEv+0x31c) [0xd6b8c]
./bin/LRAUV(_ZN7PCaller10PThreadRunEPv+0xbc) [0x178c80]

2019-04-01T18:12:50.806Z,1554142370.806 [BR_Ping] Software Fault, FailCount= 4
2019-04-01T18:12:50.806Z,1554142370.806 [BR_Ping](ERROR): Software Fault
2019-04-01T18:12:50.821Z,1554142370.821 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2019-04-01T18:12:50.821Z,1554142370.821 [SyncHandler](INFO): Protected caller Thread ID is 1933
2019-04-01T18:12:50.834Z,1554142370.834 [CBIT](INFO): Critical error at 20190401T181250
2019-04-01T18:12:50.837Z,1554142370.837 [CBIT](ERROR): Software Fault in component: BR_Ping
2019-04-01T18:12:51.177Z,1554142371.177 [Aanderaa_O2](FAULT): Failed to initialize within timeout.
2019-04-01T18:12:51.177Z,1554142371.177 [Aanderaa_O2] Communications Fault, FailCount= 1
2019-04-01T18:12:51.177Z,1554142371.177 [Aanderaa_O2](ERROR): Communications Fault
2019-04-01T18:12:51.194Z,1554142371.194 [BR_Ping](INFO): Powering down
2019-04-01T18:12:51.284Z,1554142371.284 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2019-04-01T18:12:51.701Z,1554142371.701 [Aanderaa_O2](INFO): Powering down
2019-04-01T18:12:52.105Z,1554142372.105 [MassServo](FAULT): Mass shifter EEPROM initialization uart error serial timeout
2019-04-01T18:12:52.105Z,1554142372.105 [MassServo] Communications Fault, FailCount= 3
2019-04-01T18:12:52.105Z,1554142372.105 [MassServo](ERROR): Communications Fault
2019-04-01T18:12:52.109Z,1554142372.109 [CBIT](ERROR): Communications Fault in component: MassServo
2019-04-01T18:12:52.170Z,1554142372.170 [MassServo](DEBUG): Uninitialize Mass Servo.
2019-04-01T18:12:52.170Z,1554142372.170 [MassServo](INFO): Powering down
2019-04-01T18:12:52.186Z,1554142372.186 [CBIT](INFO): Clearing failed state for component BR_Ping
2019-04-01T18:12:52.187Z,1554142372.187 [BR_Ping] No Fault, FailCount= 4
2019-04-01T18:12:52.596Z,1554142372.596 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2019-04-01T18:12:52.596Z,1554142372.596 [Aanderaa_O2] No Fault, FailCount= 1
2019-04-01T18:12:52.970Z,1554142372.970 [MassServo](DEBUG): Initializing EZServoServo.
2019-04-01T18:12:53.090Z,1554142373.090 [MassServo](DEBUG): Initializing MassServo.
2019-04-01T18:12:53.094Z,1554142373.094 [CBIT](INFO): Clearing failed state for component MassServo
2019-04-01T18:12:53.094Z,1554142373.094 [MassServo] No Fault, FailCount= 3
2019-04-01T18:12:53.369Z,1554142373.369 [BR_Ping](CRITICAL): SIGSEGV: address not mapped to object
2019-04-01T18:12:53.370Z,1554142373.370 [BR_Ping](CRITICAL): Bad address: 0x0
2019-04-01T18:12:53.370Z,1554142373.370 [BR_Ping](CRITICAL): Backtrace: 
./bin/LRAUV(_ZN7PCaller20DefaultSignalHandlerEiP7siginfoPv+0x20) [0x1790e4]
./bin/LRAUV(_ZN9Component7executeEv+0x31c) [0xd6b8c]
./bin/LRAUV(_ZN7PCaller10PThreadRunEPv+0xbc) [0x178c80]

2019-04-01T18:12:53.370Z,1554142373.370 [BR_Ping] Software Fault, FailCount= 5
2019-04-01T18:12:53.370Z,1554142373.370 [BR_Ping](ERROR): Software Fault
2019-04-01T18:12:53.377Z,1554142373.377 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2019-04-01T18:12:53.377Z,1554142373.377 [SyncHandler](INFO): Protected caller Thread ID is 1937
2019-04-01T18:12:53.394Z,1554142373.394 [CBIT](INFO): Critical error at 20190401T181253
2019-04-01T18:12:53.406Z,1554142373.406 [CBIT](ERROR): Software Fault in component: BR_Ping
2019-04-01T18:12:53.406Z,1554142373.406 [CBIT](CRITICAL): Software Fault in component: BR_Ping
2019-04-01T18:12:53.469Z,1554142373.469 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2019-04-01T18:12:53.469Z,1554142373.469 [CTD_Seabird] Communications Fault, FailCount= 1
2019-04-01T18:12:53.469Z,1554142373.469 [CTD_Seabird](ERROR): Communications Fault
2019-04-01T18:12:53.748Z,1554142373.748 [BR_Ping](INFO): Powering down
2019-04-01T18:12:53.840Z,1554142373.840 [CBIT](INFO): Critical error at 20190401T181253
2019-04-01T18:12:53.840Z,1554142373.840 [CBIT](FAULT): Main Battery Failure. Count: 31
2019-04-01T18:12:53.851Z,1554142373.851 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2019-04-01T18:12:53.873Z,1554142373.873 [CTD_Seabird](INFO): Powering down
2019-04-01T18:12:54.977Z,1554142374.977 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2019-04-01T18:12:54.977Z,1554142374.977 [CTD_Seabird] No Fault, FailCount= 1
2019-04-01T18:12:55.245Z,1554142375.245 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2019-04-01T18:12:55.246Z,1554142375.246 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20
2019-04-01T18:12:55.685Z,1554142375.685 [MassServo](FAULT): Mass shifter EEPROM initialization uart error serial timeout
2019-04-01T18:12:55.685Z,1554142375.685 [MassServo] Communications Fault, FailCount= 4
2019-04-01T18:12:55.685Z,1554142375.685 [MassServo](ERROR): Communications Fault
2019-04-01T18:12:55.689Z,1554142375.689 [CBIT](ERROR): Communications Fault in component: MassServo
2019-04-01T18:12:55.778Z,1554142375.778 [MassServo](DEBUG): Uninitialize Mass Servo.
2019-04-01T18:12:55.778Z,1554142375.778 [MassServo](INFO): Powering down
2019-04-01T18:12:56.614Z,1554142376.614 [MassServo](DEBUG): Initializing EZServoServo.
2019-04-01T18:12:56.734Z,1554142376.734 [MassServo](DEBUG): Initializing MassServo.
2019-04-01T18:12:56.738Z,1554142376.738 [CBIT](INFO): Clearing failed state for component MassServo
2019-04-01T18:12:56.738Z,1554142376.738 [MassServo] No Fault, FailCount= 4
2019-04-01T18:12:57.838Z,1554142377.838 [CBIT](FAULT): Main Battery Failure. Count: 41
2019-04-01T18:12:59.337Z,1554142379.337 [MassServo](FAULT): Mass shifter EEPROM initialization uart error serial timeout
2019-04-01T18:12:59.337Z,1554142379.337 [MassServo] Communications Fault, FailCount= 5
2019-04-01T18:12:59.337Z,1554142379.337 [MassServo](ERROR): Communications Fault
2019-04-01T18:12:59.341Z,1554142379.341 [CBIT](ERROR): Communications Fault in component: MassServo
2019-04-01T18:12:59.341Z,1554142379.341 [CBIT](CRITICAL): Communications Fault in component: MassServo
2019-04-01T18:12:59.418Z,1554142379.418 [MassServo](DEBUG): Uninitialize Mass Servo.
2019-04-01T18:12:59.418Z,1554142379.418 [MassServo](INFO): Powering down
2019-04-01T18:12:59.420Z,1554142379.420 [CBIT](INFO): Critical error at 20190401T181259
2019-04-01T18:13:00.226Z,1554142380.226 [MassServo](DEBUG): Initializing EZServoServo.
2019-04-01T18:13:00.346Z,1554142380.346 [MassServo](DEBUG): Initializing MassServo.
2019-04-01T18:13:01.406Z,1554142381.406 [AcousticModem_Benthos_ATM900](FAULT): failed to initialize, no bytes available on serial interface
2019-04-01T18:13:01.406Z,1554142381.406 [AcousticModem_Benthos_ATM900] Communications Fault, FailCount= 1
2019-04-01T18:13:01.406Z,1554142381.406 [AcousticModem_Benthos_ATM900](ERROR): Communications Fault
2019-04-01T18:13:01.478Z,1554142381.478 [CBIT](ERROR): Communications Fault in component: AcousticModem_Benthos_ATM900
2019-04-01T18:13:01.809Z,1554142381.809 [AcousticModem_Benthos_ATM900](INFO): Powering down
2019-04-01T18:13:01.987Z,1554142381.987 [CBIT](FAULT): Main Battery Failure. Count: 51
2019-04-01T18:13:02.649Z,1554142382.649 [CBIT](INFO): Clearing failed state for component AcousticModem_Benthos_ATM900
2019-04-01T18:13:02.649Z,1554142382.649 [AcousticModem_Benthos_ATM900] No Fault, FailCount= 1
2019-04-01T18:13:03.021Z,1554142383.021 [Aanderaa_O2](FAULT): Failed to initialize within timeout.
2019-04-01T18:13:03.021Z,1554142383.021 [Aanderaa_O2] Communications Fault, FailCount= 2
2019-04-01T18:13:03.021Z,1554142383.021 [Aanderaa_O2](ERROR): Communications Fault
2019-04-01T18:13:03.057Z,1554142383.057 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2019-04-01T18:13:03.545Z,1554142383.545 [Aanderaa_O2](INFO): Powering down
2019-04-01T18:13:04.286Z,1554142384.286 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2019-04-01T18:13:04.286Z,1554142384.286 [Aanderaa_O2] No Fault, FailCount= 2
2019-04-01T18:13:05.053Z,1554142385.053 [AcousticModem_Benthos_ATM900](INFO): Powering up
2019-04-01T18:13:05.053Z,1554142385.053 [AcousticModem_Benthos_ATM900](DEBUG): Initializing AcousticModem_Benthos_ATM900.
2019-04-01T18:13:05.126Z,1554142385.126 [SBIT](IMPORTANT): Beginning Startup BIT
2019-04-01T18:13:05.132Z,1554142385.132 [CBIT](IMPORTANT): Beginning ground fault scan
2019-04-01T18:13:05.908Z,1554142385.908 [CBIT](FAULT): Main Battery Failure. Count: 61
2019-04-01T18:13:08.297Z,1554142388.297 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2019-04-01T18:13:08.297Z,1554142388.297 [CTD_Seabird] Communications Fault, FailCount= 2
2019-04-01T18:13:08.297Z,1554142388.297 [CTD_Seabird](ERROR): Communications Fault
2019-04-01T18:13:08.406Z,1554142388.406 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2019-04-01T18:13:08.682Z,1554142388.682 [NAL9602](INFO): Powering up NAL9602
2019-04-01T18:13:08.701Z,1554142388.701 [CTD_Seabird](INFO): Powering down
2019-04-01T18:13:10.039Z,1554142390.039 [CBIT](FAULT): Main Battery Failure. Count: 71
2019-04-01T18:13:10.042Z,1554142390.042 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2019-04-01T18:13:10.042Z,1554142390.042 [CTD_Seabird] No Fault, FailCount= 2
2019-04-01T18:13:10.045Z,1554142390.045 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2019-04-01T18:13:10.046Z,1554142390.046 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20
2019-04-01T18:13:13.964Z,1554142393.964 [CBIT](FAULT): Main Battery Failure. Count: 81
2019-04-01T18:13:14.737Z,1554142394.737 [Aanderaa_O2](FAULT): Failed to initialize within timeout.
2019-04-01T18:13:14.737Z,1554142394.737 [Aanderaa_O2] Communications Fault, FailCount= 3
2019-04-01T18:13:14.737Z,1554142394.737 [Aanderaa_O2](ERROR): Communications Fault
2019-04-01T18:13:14.798Z,1554142394.798 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2019-04-01T18:13:14.799Z,1554142394.799 [CBIT](FAULT): Communications Fault in component: Aanderaa_O2
2019-04-01T18:13:15.261Z,1554142395.261 [Aanderaa_O2](INFO): Powering down
2019-04-01T18:13:15.986Z,1554142395.986 [CBIT](IMPORTANT): Ground fault detected
mA:
CHAN A0 (Batt): -0.006857
CHAN A1 (24V): -0.127915
CHAN A2 (12V): -0.005158
CHAN A3 (5V): -0.002245
CHAN B0 (3.3V): -0.001251
CHAN B1 (3.15aV): -0.001275
CHAN B2 (3.15bV): -0.000794
CHAN B3 (GND): 0.000258
OPEN: -0.001238
Full Scale Calc: 4.765 mA, -1.589 mA
2019-04-01T18:13:18.002Z,1554142398.002 [CBIT](FAULT): Main Battery Failure. Count: 91
2019-04-01T18:13:18.427Z,1554142398.427 [SBIT](ERROR): Could not read massPosReader_.
2019-04-01T18:13:19.590Z,1554142399.590 [NAL9602](INFO): NAL9602 initialized
2019-04-01T18:13:20.409Z,1554142400.409 [NAL9602](DEBUG): Fix Requested
2019-04-01T18:13:22.091Z,1554142402.091 [CBIT](FAULT): Main Battery Failure. Count: 101
2019-04-01T18:13:23.097Z,1554142403.097 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2019-04-01T18:13:23.097Z,1554142403.097 [CTD_Seabird] Communications Fault, FailCount= 3
2019-04-01T18:13:23.097Z,1554142403.097 [CTD_Seabird](ERROR): Communications Fault
2019-04-01T18:13:23.322Z,1554142403.322 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2019-04-01T18:13:23.322Z,1554142403.322 [CBIT](FAULT): Communications Fault in component: CTD_Seabird
2019-04-01T18:13:23.501Z,1554142403.501 [CTD_Seabird](INFO): Powering down
2019-04-01T18:13:25.241Z,1554142405.241 [AcousticModem_Benthos_ATM900](FAULT): failed to initialize, no bytes available on serial interface
2019-04-01T18:13:25.241Z,1554142405.241 [AcousticModem_Benthos_ATM900] Communications Fault, FailCount= 2
2019-04-01T18:13:25.241Z,1554142405.241 [AcousticModem_Benthos_ATM900](ERROR): Communications Fault
2019-04-01T18:13:25.330Z,1554142405.330 [CBIT](ERROR): Communications Fault in component: AcousticModem_Benthos_ATM900
2019-04-01T18:13:25.645Z,1554142405.645 [AcousticModem_Benthos_ATM900](INFO): Powering down
2019-04-01T18:13:26.323Z,1554142406.323 [CBIT](FAULT): Main Battery Failure. Count: 111
2019-04-01T18:13:26.490Z,1554142406.490 [CBIT](INFO): Clearing failed state for component AcousticModem_Benthos_ATM900
2019-04-01T18:13:26.491Z,1554142406.491 [AcousticModem_Benthos_ATM900] No Fault, FailCount= 2
2019-04-01T18:13:28.877Z,1554142408.877 [AcousticModem_Benthos_ATM900](INFO): Powering up
2019-04-01T18:13:28.877Z,1554142408.877 [AcousticModem_Benthos_ATM900](DEBUG): Initializing AcousticModem_Benthos_ATM900.
2019-04-01T18:13:30.123Z,1554142410.123 [CBIT](FAULT): Main Battery Failure. Count: 121
2019-04-01T18:13:34.178Z,1554142414.178 [CBIT](FAULT): Main Battery Failure. Count: 131
2019-04-01T18:13:38.203Z,1554142418.203 [CBIT](FAULT): Main Battery Failure. Count: 141
2019-04-01T18:13:42.243Z,1554142422.243 [CBIT](FAULT): Main Battery Failure. Count: 151
2019-04-01T18:13:45.085Z,1554142425.085 [SBIT](ERROR): Could not read massPosReader_.
2019-04-01T18:13:45.085Z,1554142425.085 [SBIT](FAULT): Control surface position failure.
2019-04-01T18:13:46.286Z,1554142426.286 [CBIT](FAULT): Main Battery Failure. Count: 161
2019-04-01T18:13:49.077Z,1554142429.077 [AcousticModem_Benthos_ATM900](FAULT): failed to initialize, no bytes available on serial interface
2019-04-01T18:13:49.077Z,1554142429.077 [AcousticModem_Benthos_ATM900] Communications Fault, FailCount= 3
2019-04-01T18:13:49.078Z,1554142429.078 [AcousticModem_Benthos_ATM900](ERROR): Communications Fault
2019-04-01T18:13:49.202Z,1554142429.202 [CBIT](ERROR): Communications Fault in component: AcousticModem_Benthos_ATM900
2019-04-01T18:13:49.481Z,1554142429.481 [AcousticModem_Benthos_ATM900](INFO): Powering down
2019-04-01T18:13:50.579Z,1554142430.579 [CBIT](FAULT): Main Battery Failure. Count: 171
2019-04-01T18:13:50.582Z,1554142430.582 [CBIT](INFO): Clearing failed state for component AcousticModem_Benthos_ATM900
2019-04-01T18:13:50.582Z,1554142430.582 [AcousticModem_Benthos_ATM900] No Fault, FailCount= 3
2019-04-01T18:13:52.713Z,1554142432.713 [AcousticModem_Benthos_ATM900](INFO): Powering up
2019-04-01T18:13:52.713Z,1554142432.713 [AcousticModem_Benthos_ATM900](DEBUG): Initializing AcousticModem_Benthos_ATM900.
2019-04-01T18:13:54.378Z,1554142434.378 [CBIT](FAULT): Main Battery Failure. Count: 181
2019-04-01T18:13:58.404Z,1554142438.404 [CBIT](FAULT): Main Battery Failure. Count: 191
2019-04-01T18:13:58.806Z,1554142438.806 [SBIT](ERROR): Could not read massPosReader_.
2019-04-01T18:13:58.806Z,1554142438.806 [SBIT](FAULT): Control surface position failure.
2019-04-01T18:13:59.212Z,1554142439.212 [SBIT](CRITICAL): SBIT FAILED
2019-04-01T18:13:59.228Z,1554142439.228 [CBIT](INFO): Critical error at 20190401T181359
2019-04-01T18:13:59.294Z,1554142439.294 [CommandLine](IMPORTANT): got command configSet list
2019-04-01T18:13:59.294Z,1554142439.294 [CommandLine](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2019-04-01T18:13:59.295Z,1554142439.295 [CommandLine](IMPORTANT): DropWeight.loadAtStartup=0 bool;

2019-04-01T18:13:59.295Z,1554142439.295 [CommandLine](IMPORTANT): Rowe_600LCM.loadAtStartup=0 bool;

2019-04-01T18:13:59.626Z,1554142439.626 [MissionManager](IMPORTANT): Started mission Startup
2019-04-01T18:13:59.626Z,1554142439.626 [Startup] Running Loop=1
2019-04-01T18:13:59.626Z,1554142439.626 [Startup](DEBUG): Aggregate::initialize Startup
2019-04-01T18:13:59.627Z,1554142439.627 [Startup:A.GoToSurface] Running Loop=1
2019-04-01T18:13:59.627Z,1554142439.627 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2019-04-01T18:13:59.627Z,1554142439.627 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2019-04-01T18:13:59.628Z,1554142439.628 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2019-04-01T18:13:59.628Z,1554142439.628 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2019-04-01T18:13:59.629Z,1554142439.629 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2019-04-01T18:13:59.629Z,1554142439.629 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2019-04-01T18:13:59.630Z,1554142439.630 [Startup:StartupSatComms] Running Loop=1
2019-04-01T18:13:59.631Z,1554142439.631 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2019-04-01T18:13:59.631Z,1554142439.631 [Startup:StartupSatComms:A] Running Loop=1
2019-04-01T18:14:00.026Z,1554142440.026 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2019-04-01T18:14:02.446Z,1554142442.446 [CBIT](FAULT): Main Battery Failure. Count: 201
2019-04-01T18:14:06.477Z,1554142446.477 [CBIT](FAULT): Main Battery Failure. Count: 211
2019-04-01T18:14:10.540Z,1554142450.540 [CBIT](FAULT): Main Battery Failure. Count: 221
2019-04-01T18:14:12.913Z,1554142452.913 [AcousticModem_Benthos_ATM900](FAULT): failed to initialize, no bytes available on serial interface
2019-04-01T18:14:12.913Z,1554142452.913 [AcousticModem_Benthos_ATM900] Communications Fault, FailCount= 4
2019-04-01T18:14:12.913Z,1554142452.913 [AcousticModem_Benthos_ATM900](ERROR): Communications Fault
2019-04-01T18:14:12.960Z,1554142452.960 [CBIT](ERROR): Communications Fault in component: AcousticModem_Benthos_ATM900
2019-04-01T18:14:13.317Z,1554142453.317 [AcousticModem_Benthos_ATM900](INFO): Powering down
2019-04-01T18:14:14.163Z,1554142454.163 [CBIT](INFO): Clearing failed state for component AcousticModem_Benthos_ATM900
2019-04-01T18:14:14.163Z,1554142454.163 [AcousticModem_Benthos_ATM900] No Fault, FailCount= 4
2019-04-01T18:14:14.557Z,1554142454.557 [CBIT](FAULT): Main Battery Failure. Count: 231
2019-04-01T18:14:16.549Z,1554142456.549 [AcousticModem_Benthos_ATM900](INFO): Powering up
2019-04-01T18:14:16.549Z,1554142456.549 [AcousticModem_Benthos_ATM900](DEBUG): Initializing AcousticModem_Benthos_ATM900.
2019-04-01T18:14:18.605Z,1554142458.605 [CBIT](FAULT): Main Battery Failure. Count: 241
2019-04-01T18:14:22.648Z,1554142462.648 [CBIT](FAULT): Main Battery Failure. Count: 251
2019-04-01T18:14:26.696Z,1554142466.696 [CBIT](FAULT): Main Battery Failure. Count: 261
2019-04-01T18:14:30.725Z,1554142470.725 [CBIT](FAULT): Main Battery Failure. Count: 271
2019-04-01T18:14:34.764Z,1554142474.764 [CBIT](FAULT): Main Battery Failure. Count: 281
2019-04-01T18:14:36.749Z,1554142476.749 [AcousticModem_Benthos_ATM900](FAULT): failed to initialize, no bytes available on serial interface
2019-04-01T18:14:36.749Z,1554142476.749 [AcousticModem_Benthos_ATM900] Communications Fault, FailCount= 5
2019-04-01T18:14:36.749Z,1554142476.749 [AcousticModem_Benthos_ATM900](ERROR): Communications Fault
2019-04-01T18:14:36.820Z,1554142476.820 [CBIT](ERROR): Communications Fault in component: AcousticModem_Benthos_ATM900
2019-04-01T18:14:37.153Z,1554142477.153 [AcousticModem_Benthos_ATM900](INFO): Powering down
2019-04-01T18:14:37.998Z,1554142477.998 [CBIT](INFO): Clearing failed state for component AcousticModem_Benthos_ATM900
2019-04-01T18:14:37.998Z,1554142477.998 [AcousticModem_Benthos_ATM900] No Fault, FailCount= 5
2019-04-01T18:14:38.798Z,1554142478.798 [CBIT](FAULT): Main Battery Failure. Count: 291
2019-04-01T18:14:40.385Z,1554142480.385 [AcousticModem_Benthos_ATM900](INFO): Powering up
2019-04-01T18:14:40.385Z,1554142480.385 [AcousticModem_Benthos_ATM900](DEBUG): Initializing AcousticModem_Benthos_ATM900.
2019-04-01T18:14:40.816Z,1554142480.816 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-04-01T18:14:40.817Z,1554142480.817 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2019-04-01T18:14:40.817Z,1554142480.817 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-04-01T18:14:40.818Z,1554142480.818 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-04-01T18:14:40.818Z,1554142480.818 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 1
2019-04-01T18:14:40.818Z,1554142480.818 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2019-04-01T18:14:40.820Z,1554142480.820 [DeadReckonWithRespectToSeafloor](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-04-01T18:14:40.820Z,1554142480.820 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1
2019-04-01T18:14:40.820Z,1554142480.820 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2019-04-01T18:14:40.865Z,1554142480.865 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-04-01T18:14:40.865Z,1554142480.865 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2019-04-01T18:14:40.865Z,1554142480.865 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2019-04-01T18:14:41.226Z,1554142481.226 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-04-01T18:14:41.226Z,1554142481.226 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2019-04-01T18:14:41.227Z,1554142481.227 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2019-04-01T18:14:41.227Z,1554142481.227 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 1
2019-04-01T18:14:41.227Z,1554142481.227 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2019-04-01T18:14:41.227Z,1554142481.227 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1
2019-04-01T18:14:41.635Z,1554142481.635 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2019-04-01T18:14:42.855Z,1554142482.855 [CBIT](FAULT): Main Battery Failure. Count: 301
2019-04-01T18:14:46.898Z,1554142486.898 [CBIT](FAULT): Main Battery Failure. Count: 311
2019-04-01T18:14:50.935Z,1554142490.935 [CBIT](FAULT): Main Battery Failure. Count: 321
2019-04-01T18:14:54.964Z,1554142494.964 [CBIT](FAULT): Main Battery Failure. Count: 331
2019-04-01T18:14:59.004Z,1554142499.004 [CBIT](FAULT): Main Battery Failure. Count: 341
2019-04-01T18:14:59.806Z,1554142499.806 [Startup:StartupSatComms:A](INFO): Timed out from 2019-04-01T18:13:59.6Z
2019-04-01T18:14:59.806Z,1554142499.806 [Startup:StartupSatComms:A] Stopped
2019-04-01T18:14:59.806Z,1554142499.806 [Startup:StartupSatComms:B] Running Loop=1
2019-04-01T18:15:00.211Z,1554142500.211 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2019-04-01T18:15:00.585Z,1554142500.585 [AcousticModem_Benthos_ATM900](FAULT): failed to initialize, no bytes available on serial interface
2019-04-01T18:15:00.585Z,1554142500.585 [AcousticModem_Benthos_ATM900] Communications Fault, FailCount= 6
2019-04-01T18:15:00.585Z,1554142500.585 [AcousticModem_Benthos_ATM900](ERROR): Communications Fault
2019-04-01T18:15:00.643Z,1554142500.643 [CBIT](ERROR): Communications Fault in component: AcousticModem_Benthos_ATM900
2019-04-01T18:15:00.989Z,1554142500.989 [AcousticModem_Benthos_ATM900](INFO): Powering down
2019-04-01T18:15:01.835Z,1554142501.835 [CBIT](INFO): Clearing failed state for component AcousticModem_Benthos_ATM900
2019-04-01T18:15:01.835Z,1554142501.835 [AcousticModem_Benthos_ATM900] No Fault, FailCount= 6
2019-04-01T18:15:03.054Z,1554142503.054 [CBIT](FAULT): Main Battery Failure. Count: 351
2019-04-01T18:15:04.221Z,1554142504.221 [AcousticModem_Benthos_ATM900](INFO): Powering up
2019-04-01T18:15:04.221Z,1554142504.221 [AcousticModem_Benthos_ATM900](DEBUG): Initializing AcousticModem_Benthos_ATM900.
2019-04-01T18:15:07.084Z,1554142507.084 [CBIT](FAULT): Main Battery Failure. Count: 361
2019-04-01T18:15:11.127Z,1554142511.127 [CBIT](FAULT): Main Battery Failure. Count: 371
2019-04-01T18:15:15.164Z,1554142515.164 [CBIT](FAULT): Main Battery Failure. Count: 381
2019-04-01T18:15:19.210Z,1554142519.210 [CBIT](FAULT): Main Battery Failure. Count: 391
2019-04-01T18:15:19.839Z,1554142519.839 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004896
2019-04-01T18:15:23.252Z,1554142523.252 [CBIT](FAULT): Main Battery Failure. Count: 401
2019-04-01T18:15:24.421Z,1554142524.421 [AcousticModem_Benthos_ATM900](FAULT): failed to initialize, no bytes available on serial interface
2019-04-01T18:15:24.421Z,1554142524.421 [AcousticModem_Benthos_ATM900] Communications Fault, FailCount= 7
2019-04-01T18:15:24.421Z,1554142524.421 [AcousticModem_Benthos_ATM900](ERROR): Communications Fault
2019-04-01T18:15:24.491Z,1554142524.491 [CBIT](ERROR): Communications Fault in component: AcousticModem_Benthos_ATM900
2019-04-01T18:15:24.825Z,1554142524.825 [AcousticModem_Benthos_ATM900](INFO): Powering down
2019-04-01T18:15:24.913Z,1554142524.913 [DataOverHttps](INFO): Sending 327 bytes from file Logs/20190401T180438/Courier0004.lzma
2019-04-01T18:15:25.670Z,1554142525.670 [CBIT](INFO): Clearing failed state for component AcousticModem_Benthos_ATM900
2019-04-01T18:15:25.670Z,1554142525.670 [AcousticModem_Benthos_ATM900] No Fault, FailCount= 7
2019-04-01T18:15:25.718Z,1554142525.718 [DataOverHttps](INFO): Moved sent file to Logs/20190401T180438/Courier0004.lzma.bak
2019-04-01T18:15:25.718Z,1554142525.718 [DataOverHttps](INFO): SBD MOMSN=10316767
2019-04-01T18:15:27.278Z,1554142527.278 [CBIT](FAULT): Main Battery Failure. Count: 411
2019-04-01T18:15:28.057Z,1554142528.057 [AcousticModem_Benthos_ATM900](INFO): Powering up
2019-04-01T18:15:28.057Z,1554142528.057 [AcousticModem_Benthos_ATM900](DEBUG): Initializing AcousticModem_Benthos_ATM900.
2019-04-01T18:15:31.325Z,1554142531.325 [CBIT](FAULT): Main Battery Failure. Count: 421
2019-04-01T18:15:35.398Z,1554142535.398 [CBIT](FAULT): Main Battery Failure. Count: 431
2019-04-01T18:15:37.889Z,1554142537.889 [DataOverHttps](INFO): Sending 531 bytes from file Logs/20190401T181230/Courier0000.lzma
2019-04-01T18:15:38.694Z,1554142538.694 [DataOverHttps](INFO): Moved sent file to Logs/20190401T181230/Courier0000.lzma.bak
2019-04-01T18:15:38.694Z,1554142538.694 [DataOverHttps](INFO): SBD MOMSN=10316789
2019-04-01T18:15:39.411Z,1554142539.411 [CBIT](FAULT): Main Battery Failure. Count: 441
2019-04-01T18:15:43.453Z,1554142543.453 [CBIT](FAULT): Main Battery Failure. Count: 451
2019-04-01T18:15:45.075Z,1554142545.075 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2019-04-01T18:15:45.075Z,1554142545.075 [Aanderaa_O2] No Fault, FailCount= 3
2019-04-01T18:15:47.496Z,1554142547.496 [CBIT](FAULT): Main Battery Failure. Count: 461
2019-04-01T18:15:48.257Z,1554142548.257 [AcousticModem_Benthos_ATM900](FAULT): failed to initialize, no bytes available on serial interface
2019-04-01T18:15:48.257Z,1554142548.257 [AcousticModem_Benthos_ATM900] Communications Fault, FailCount= 8
2019-04-01T18:15:48.257Z,1554142548.257 [AcousticModem_Benthos_ATM900](ERROR): Communications Fault
2019-04-01T18:15:48.323Z,1554142548.323 [CBIT](ERROR): Communications Fault in component: AcousticModem_Benthos_ATM900
2019-04-01T18:15:48.323Z,1554142548.323 [CBIT](FAULT): Communications Fault in component: AcousticModem_Benthos_ATM900
2019-04-01T18:15:48.661Z,1554142548.661 [AcousticModem_Benthos_ATM900](INFO): Powering down
2019-04-01T18:15:50.911Z,1554142550.911 [DataOverHttps](INFO): Sending 1356 bytes from file Logs/20190401T180135/Express0001.lzma
2019-04-01T18:15:51.528Z,1554142551.528 [CBIT](FAULT): Main Battery Failure. Count: 471
2019-04-01T18:15:51.710Z,1554142551.710 [DataOverHttps](INFO): Moved sent file to Logs/20190401T180135/Express0001.lzma.bak
2019-04-01T18:15:51.710Z,1554142551.710 [DataOverHttps](INFO): SBD MOMSN=10316813
2019-04-01T18:15:53.154Z,1554142553.154 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2019-04-01T18:15:53.154Z,1554142553.154 [CTD_Seabird] No Fault, FailCount= 3
2019-04-01T18:15:53.517Z,1554142553.517 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2019-04-01T18:15:53.519Z,1554142553.519 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20
2019-04-01T18:15:55.529Z,1554142555.529 [Aanderaa_O2](FAULT): Failed to initialize within timeout.
2019-04-01T18:15:55.529Z,1554142555.529 [Aanderaa_O2] Communications Fault, FailCount= 1
2019-04-01T18:15:55.529Z,1554142555.529 [Aanderaa_O2](ERROR): Communications Fault
2019-04-01T18:15:55.584Z,1554142555.584 [CBIT](FAULT): Main Battery Failure. Count: 481
2019-04-01T18:15:55.586Z,1554142555.586 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2019-04-01T18:15:56.053Z,1554142556.053 [Aanderaa_O2](INFO): Powering down
2019-04-01T18:15:56.780Z,1554142556.780 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2019-04-01T18:15:56.780Z,1554142556.780 [Aanderaa_O2] No Fault, FailCount= 1
2019-04-01T18:15:59.620Z,1554142559.620 [CBIT](FAULT): Main Battery Failure. Count: 491
2019-04-01T18:16:00.002Z,1554142560.002 [Startup:StartupSatComms:B](INFO): Timed out from 2019-04-01T18:14:59.8Z
2019-04-01T18:16:00.002Z,1554142560.002 [Startup:StartupSatComms:B] Stopped
2019-04-01T18:16:00.003Z,1554142560.003 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2019-04-01T18:16:00.003Z,1554142560.003 [Startup:StartupSatComms] Stopped
2019-04-01T18:16:00.003Z,1554142560.003 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2019-04-01T18:16:00.004Z,1554142560.004 [Startup](INFO): Completed Startup
2019-04-01T18:16:00.004Z,1554142560.004 [MissionManager](INFO): Startup is completed.
2019-04-01T18:16:00.004Z,1554142560.004 [MissionManager](INFO): Uninitializing Mission Startup
2019-04-01T18:16:00.004Z,1554142560.004 [Startup] Stopped
2019-04-01T18:16:00.004Z,1554142560.004 [Startup](DEBUG): Aggregate::uninitialize Startup
2019-04-01T18:16:00.004Z,1554142560.004 [Startup:A.GoToSurface] Stopped
2019-04-01T18:16:00.004Z,1554142560.004 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2019-04-01T18:16:00.425Z,1554142560.425 [MissionManager](IMPORTANT): Started mission Default
2019-04-01T18:16:00.426Z,1554142560.426 [Default] Running Loop=1
2019-04-01T18:16:00.426Z,1554142560.426 [Default](DEBUG): Aggregate::initialize Default
2019-04-01T18:16:00.426Z,1554142560.426 [Default:B.GoToSurface] Running Loop=1
2019-04-01T18:16:00.426Z,1554142560.426 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2019-04-01T18:16:00.426Z,1554142560.426 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2019-04-01T18:16:00.426Z,1554142560.426 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2019-04-01T18:16:00.427Z,1554142560.427 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2019-04-01T18:16:00.427Z,1554142560.427 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2019-04-01T18:16:00.427Z,1554142560.427 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2019-04-01T18:16:00.428Z,1554142560.428 [Default:A.Wait] Running Loop=1
2019-04-01T18:16:00.428Z,1554142560.428 [Default:A.Wait](DEBUG): Initialize Wait Component.
2019-04-01T18:16:02.692Z,1554142562.692 [DataOverHttps](INFO): Sending 220 bytes from file Logs/20190401T180135/Express0005.lzma
2019-04-01T18:16:03.498Z,1554142563.498 [DataOverHttps](INFO): Moved sent file to Logs/20190401T180135/Express0005.lzma.bak
2019-04-01T18:16:03.498Z,1554142563.498 [DataOverHttps](INFO): SBD MOMSN=10316886
2019-04-01T18:16:03.637Z,1554142563.637 [CBIT](FAULT): Main Battery Failure. Count: 501
2019-04-01T18:16:06.569Z,1554142566.569 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2019-04-01T18:16:06.569Z,1554142566.569 [CTD_Seabird] Communications Fault, FailCount= 1
2019-04-01T18:16:06.569Z,1554142566.569 [CTD_Seabird](ERROR): Communications Fault
2019-04-01T18:16:06.947Z,1554142566.947 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2019-04-01T18:16:06.981Z,1554142566.981 [CTD_Seabird](INFO): Powering down
2019-04-01T18:16:07.249Z,1554142567.249 [Aanderaa_O2](FAULT): Failed to initialize within timeout.
2019-04-01T18:16:07.249Z,1554142567.249 [Aanderaa_O2] Communications Fault, FailCount= 2
2019-04-01T18:16:07.249Z,1554142567.249 [Aanderaa_O2](ERROR): Communications Fault
2019-04-01T18:16:07.343Z,1554142567.343 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2019-04-01T18:16:07.797Z,1554142567.797 [Aanderaa_O2](INFO): Powering down
2019-04-01T18:16:07.856Z,1554142567.856 [CBIT](FAULT): Main Battery Failure. Count: 511
2019-04-01T18:16:08.111Z,1554142568.111 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2019-04-01T18:16:08.111Z,1554142568.111 [CTD_Seabird] No Fault, FailCount= 1
2019-04-01T18:16:08.325Z,1554142568.325 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2019-04-01T18:16:08.326Z,1554142568.326 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20
2019-04-01T18:16:08.503Z,1554142568.503 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2019-04-01T18:16:08.503Z,1554142568.503 [Aanderaa_O2] No Fault, FailCount= 2
2019-04-01T18:16:11.748Z,1554142571.748 [CBIT](FAULT): Main Battery Failure. Count: 521
2019-04-01T18:16:13.744Z,1554142573.744 [Default:A.Wait](INFO): Done Waiting.
2019-04-01T18:16:13.744Z,1554142573.744 [Default:A.Wait] Stopped
2019-04-01T18:16:13.744Z,1554142573.744 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2019-04-01T18:16:14.158Z,1554142574.158 [Default:CheckIn] Running Loop=1
2019-04-01T18:16:14.158Z,1554142574.158 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2019-04-01T18:16:14.158Z,1554142574.158 [Default:CheckIn:Read_GPS] Running Loop=1
2019-04-01T18:16:14.564Z,1554142574.564 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2019-04-01T18:16:15.775Z,1554142575.775 [CBIT](FAULT): Main Battery Failure. Count: 531
2019-04-01T18:16:18.973Z,1554142578.973 [Aanderaa_O2](FAULT): Failed to initialize within timeout.
2019-04-01T18:16:18.973Z,1554142578.973 [Aanderaa_O2] Communications Fault, FailCount= 3
2019-04-01T18:16:18.973Z,1554142578.973 [Aanderaa_O2](ERROR): Communications Fault
2019-04-01T18:16:19.011Z,1554142579.011 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2019-04-01T18:16:19.011Z,1554142579.011 [CBIT](FAULT): Communications Fault in component: Aanderaa_O2
2019-04-01T18:16:19.497Z,1554142579.497 [Aanderaa_O2](INFO): Powering down
2019-04-01T18:16:19.820Z,1554142579.820 [CBIT](FAULT): Main Battery Failure. Count: 541
2019-04-01T18:16:21.377Z,1554142581.377 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2019-04-01T18:16:21.377Z,1554142581.377 [CTD_Seabird] Communications Fault, FailCount= 2
2019-04-01T18:16:21.377Z,1554142581.377 [CTD_Seabird](ERROR): Communications Fault
2019-04-01T18:16:21.445Z,1554142581.445 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2019-04-01T18:16:21.781Z,1554142581.781 [CTD_Seabird](INFO): Powering down
2019-04-01T18:16:22.326Z,1554142582.326 [CommandLine](IMPORTANT): got command restart application
2019-04-01T18:16:23.054Z,1554142583.054 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2019-04-01T18:16:23.054Z,1554142583.054 [CTD_Seabird] No Fault, FailCount= 2
2019-04-01T18:16:23.125Z,1554142583.125 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2019-04-01T18:16:23.126Z,1554142583.126 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20
2019-04-01T18:16:23.333Z,1554142583.333 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2019-04-01T18:16:23.333Z,1554142583.333 [CommandLine ThreadHandler](INFO): Thread cancelled.
2019-04-01T18:16:23.457Z,1554142583.457 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup.  Bye!
2019-04-01T18:16:23.457Z,1554142583.457 [CommandLine ThreadHandler](INFO): Thread cancelled.
2019-04-01T18:16:23.458Z,1554142583.458 [CommandLine](INFO): Join timeout helper Thread ID is 1969
2019-04-01T18:16:23.465Z,1554142583.465 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2019-04-01T18:16:23.465Z,1554142583.465 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2019-04-01T18:16:23.466Z,1554142583.466 [NavChartDb](INFO): Join timeout helper Thread ID is 1970
2019-04-01T18:16:23.629Z,1554142583.629 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2019-04-01T18:16:23.629Z,1554142583.629 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2019-04-01T18:16:23.645Z,1554142583.645 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2019-04-01T18:16:23.645Z,1554142583.645 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2019-04-01T18:16:23.645Z,1554142583.645 [Radio_Surface](INFO): Join timeout helper Thread ID is 1971
2019-04-01T18:16:23.860Z,1554142583.860 [CBIT](FAULT): Main Battery Failure. Count: 551
2019-04-01T18:16:23.961Z,1554142583.961 [Radio_Surface](INFO): Powering down
2019-04-01T18:16:23.962Z,1554142583.962 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2019-04-01T18:16:23.962Z,1554142583.962 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2019-04-01T18:16:23.973Z,1554142583.973 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler
2019-04-01T18:16:23.973Z,1554142583.973 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2019-04-01T18:16:23.973Z,1554142583.973 [DataOverHttps](INFO): Join timeout helper Thread ID is 1972
2019-04-01T18:16:24.185Z,1554142584.185 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread.
2019-04-01T18:16:24.185Z,1554142584.185 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2019-04-01T18:16:24.197Z,1554142584.197 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2019-04-01T18:16:24.197Z,1554142584.197 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2019-04-01T18:16:24.197Z,1554142584.197 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 1973
2019-04-01T18:16:24.281Z,1554142584.281 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread.
2019-04-01T18:16:24.281Z,1554142584.281 [WetLabsBB2FL](INFO): Powering down
2019-04-01T18:16:24.282Z,1554142584.282 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2019-04-01T18:16:24.298Z,1554142584.298 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler
2019-04-01T18:16:24.298Z,1554142584.298 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2019-04-01T18:16:24.298Z,1554142584.298 [CTD_Seabird](INFO): Join timeout helper Thread ID is 1974
2019-04-01T18:16:25.133Z,1554142585.133 [CTD_Seabird](INFO): Powering down
2019-04-01T18:16:25.265Z,1554142585.265 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread.
2019-04-01T18:16:25.265Z,1554142585.265 [CTD_Seabird](INFO): Powering down
2019-04-01T18:16:25.277Z,1554142585.277 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2019-04-01T18:16:25.285Z,1554142585.285 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2019-04-01T18:16:25.285Z,1554142585.285 [logger ThreadHandler](INFO): Thread cancelled.
2019-04-01T18:16:25.286Z,1554142585.286 [logger](INFO): Join timeout helper Thread ID is 1975
2019-04-01T18:16:25.317Z,1554142585.317 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2019-04-01T18:16:25.317Z,1554142585.317 [logger ThreadHandler](INFO): Thread cancelled.
2019-04-01T18:16:25.325Z,1554142585.325 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2019-04-01T18:16:25.325Z,1554142585.325 [CommandLine ThreadHandler](INFO): Thread cancelled.
2019-04-01T18:16:25.326Z,1554142585.326 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2019-04-01T18:16:25.326Z,1554142585.326 [controlThread ThreadHandler](INFO): Thread cancelled.
2019-04-01T18:16:25.326Z,1554142585.326 [controlThread](INFO): Join timeout helper Thread ID is 1976
2019-04-01T18:16:25.433Z,1554142585.433 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2019-04-01T18:16:25.433Z,1554142585.433 [controlThread](DEBUG): Uninitializing ControlThread
2019-04-01T18:16:25.433Z,1554142585.433 [Aanderaa_O2](INFO): Powering down
2019-04-01T18:16:25.435Z,1554142585.435 [AcousticModem_Benthos_ATM900](INFO): Powering down
2019-04-01T18:16:25.436Z,1554142585.436 [NAL9602](INFO): Powering down
2019-04-01T18:16:25.438Z,1554142585.438 [BR_Ping](INFO): Powering down
2019-04-01T18:16:25.439Z,1554142585.439 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2019-04-01T18:16:25.440Z,1554142585.440 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2019-04-01T18:16:25.440Z,1554142585.440 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2019-04-01T18:16:25.441Z,1554142585.441 [MissionManager](INFO): Uninitializing Mission Default
2019-04-01T18:16:25.441Z,1554142585.441 [Default] Stopped
2019-04-01T18:16:25.441Z,1554142585.441 [Default](DEBUG): Aggregate::uninitialize Default
2019-04-01T18:16:25.441Z,1554142585.441 [Default:B.GoToSurface] Stopped
2019-04-01T18:16:25.441Z,1554142585.441 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2019-04-01T18:16:25.441Z,1554142585.441 [Default:CheckIn] Stopped
2019-04-01T18:16:25.441Z,1554142585.441 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2019-04-01T18:16:25.441Z,1554142585.441 [Default:CheckIn:Read_GPS] Stopped
2019-04-01T18:16:25.444Z,1554142585.444 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2019-04-01T18:16:25.444Z,1554142585.444 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2019-04-01T18:16:25.444Z,1554142585.444 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2019-04-01T18:16:25.444Z,1554142585.444 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2019-04-01T18:16:25.445Z,1554142585.445 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2019-04-01T18:16:25.445Z,1554142585.445 [BuoyancyServo](INFO): Powering down
2019-04-01T18:16:25.457Z,1554142585.457 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2019-04-01T18:16:25.457Z,1554142585.457 [ElevatorServo](INFO): Powering down
2019-04-01T18:16:25.458Z,1554142585.458 [MassServo](DEBUG): Uninitialize Mass Servo.
2019-04-01T18:16:25.458Z,1554142585.458 [MassServo](INFO): Powering down
2019-04-01T18:16:25.458Z,1554142585.458 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2019-04-01T18:16:25.458Z,1554142585.458 [RudderServo](INFO): Powering down
2019-04-01T18:16:25.459Z,1554142585.459 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2019-04-01T18:16:25.459Z,1554142585.459 [ThrusterServo](INFO): Powering down
2019-04-01T18:16:25.460Z,1554142585.460 [SBIT](DEBUG): Uninitialize SBIT Component.
2019-04-01T18:16:25.460Z,1554142585.460 [IBIT](DEBUG): Uninitialize IBIT Component.
2019-04-01T18:16:25.460Z,1554142585.460 [CBIT](DEBUG): Uninitialize CBIT Component.
2019-04-01T18:16:25.461Z,1554142585.461 [CBIT](DEBUG): Powering off loads.
2019-04-01T18:16:25.473Z,1554142585.473 [CBIT](DEBUG): Disabling WDT.
2019-04-01T18:16:25.485Z,1554142585.485 [CBIT](DEBUG): Opening all GF detection circuits.
2019-04-01T18:16:25.485Z,1554142585.485 [controlThread ThreadHandler](INFO): Thread cancelled.
2019-04-01T18:16:25.648Z,1554142585.648 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2019-04-01T18:16:25.653Z,1554142585.653 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2019-04-01T18:16:25.719Z,1554142585.719 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2019-04-01T18:16:25.724Z,1554142585.724 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2019-04-01T18:16:25.770Z,1554142585.770 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2019-04-01T18:16:25.827Z,1554142585.827 [logger ThreadHandler](INFO): Thread cancelled.