2019-04-10T00:55:37.832Z,1554857737.832 [Supervisor](DEBUG): Initializing supervisor.
2019-04-10T00:55:37.835Z,1554857737.835 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2019-04-10T00:55:37.836Z,1554857737.836 [SyncHandler](INFO): Protected caller Thread ID is 620
2019-04-10T00:55:37.837Z,1554857737.837 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2019-04-10T00:55:37.838Z,1554857737.838 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2019-04-10T00:55:37.838Z,1554857737.838 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 621
2019-04-10T00:55:37.842Z,1554857737.842 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2019-04-10T00:55:37.855Z,1554857737.855 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2019-04-10T00:55:37.856Z,1554857737.856 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2019-04-10T00:55:37.856Z,1554857737.856 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 622
2019-04-10T00:55:37.857Z,1554857737.857 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2019-04-10T00:55:37.858Z,1554857737.858 [logger ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2019-04-10T00:55:37.858Z,1554857737.858 [logger ThreadHandler](INFO): Protected caller Thread ID is 623
2019-04-10T00:55:37.860Z,1554857737.860 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2019-04-10T00:55:37.861Z,1554857737.861 [Supervisor](INFO): Looking for Config files in directory: Config/
2019-04-10T00:55:37.863Z,1554857737.863 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2019-04-10T00:55:37.959Z,1554857737.959 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2019-04-10T00:55:37.959Z,1554857737.959 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2019-04-10T00:55:38.172Z,1554857738.172 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2019-04-10T00:55:38.172Z,1554857738.172 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2019-04-10T00:55:38.314Z,1554857738.314 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2019-04-10T00:55:38.314Z,1554857738.314 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2019-04-10T00:55:38.805Z,1554857738.805 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2019-04-10T00:55:38.805Z,1554857738.805 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2019-04-10T00:55:39.276Z,1554857739.276 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2019-04-10T00:55:39.277Z,1554857739.277 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2019-04-10T00:55:39.773Z,1554857739.773 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2019-04-10T00:55:39.774Z,1554857739.774 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2019-04-10T00:55:40.100Z,1554857740.100 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2019-04-10T00:55:40.101Z,1554857740.101 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2019-04-10T00:55:40.916Z,1554857740.916 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2019-04-10T00:55:40.916Z,1554857740.916 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2019-04-10T00:55:41.334Z,1554857741.334 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2019-04-10T00:55:41.335Z,1554857741.335 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2019-04-10T00:55:41.491Z,1554857741.491 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2019-04-10T00:55:41.491Z,1554857741.491 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2019-04-10T00:55:41.599Z,1554857741.599 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2019-04-10T00:55:41.599Z,1554857741.599 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2019-04-10T00:55:41.680Z,1554857741.680 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2019-04-10T00:55:41.783Z,1554857741.783 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample
2019-04-10T00:55:41.784Z,1554857741.784 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2019-04-10T00:55:41.993Z,1554857741.993 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2019-04-10T00:55:41.994Z,1554857741.994 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2019-04-10T00:55:42.211Z,1554857742.211 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2019-04-10T00:55:42.213Z,1554857742.213 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-makai/
2019-04-10T00:55:42.214Z,1554857742.214 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/secure.cfg
2019-04-10T00:55:42.297Z,1554857742.297 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Battery.cfg
2019-04-10T00:55:42.536Z,1554857742.536 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2019-04-10T00:55:42.537Z,1554857742.537 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Navigation.cfg
2019-04-10T00:55:42.634Z,1554857742.634 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Sensor.cfg
2019-04-10T00:55:42.817Z,1554857742.817 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/vehicle.cfg
2019-04-10T00:55:43.044Z,1554857743.044 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Simulator.cfg
2019-04-10T00:55:43.129Z,1554857743.129 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Servo.cfg
2019-04-10T00:55:43.229Z,1554857743.229 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Control.cfg
2019-04-10T00:55:43.323Z,1554857743.323 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Science.cfg
2019-04-10T00:55:43.483Z,1554857743.483 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/logger.cfg
2019-04-10T00:55:43.591Z,1554857743.591 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/BIT.cfg
2019-04-10T00:55:43.691Z,1554857743.691 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-makai/root/
2019-04-10T00:55:43.692Z,1554857743.692 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg
2019-04-10T00:55:43.696Z,1554857743.696 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2019-04-10T00:55:43.797Z,1554857743.797 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2019-04-10T00:55:43.798Z,1554857743.798 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2019-04-10T00:55:43.926Z,1554857743.926 [BuoyancyServo] Loaded
2019-04-10T00:55:43.926Z,1554857743.926 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2019-04-10T00:55:43.942Z,1554857743.942 [ElevatorServo] Loaded
2019-04-10T00:55:43.943Z,1554857743.943 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2019-04-10T00:55:43.959Z,1554857743.959 [MassServo] Loaded
2019-04-10T00:55:43.959Z,1554857743.959 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2019-04-10T00:55:43.975Z,1554857743.975 [RudderServo] Loaded
2019-04-10T00:55:43.975Z,1554857743.975 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2019-04-10T00:55:43.991Z,1554857743.991 [ThrusterServo] Loaded
2019-04-10T00:55:43.991Z,1554857743.991 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread.
2019-04-10T00:55:43.991Z,1554857743.991 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2019-04-10T00:55:43.992Z,1554857743.992 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2019-04-10T00:55:44.131Z,1554857744.131 [SBIT](DEBUG): Construct Startup Built In Test.
2019-04-10T00:55:44.162Z,1554857744.162 [SBIT] Loaded
2019-04-10T00:55:44.162Z,1554857744.162 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2019-04-10T00:55:44.163Z,1554857744.163 [IBIT](DEBUG): Construct Initiated Built In Test.
2019-04-10T00:55:44.193Z,1554857744.193 [IBIT] Loaded
2019-04-10T00:55:44.193Z,1554857744.193 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2019-04-10T00:55:44.196Z,1554857744.196 [CBIT](DEBUG): Construct Continuous Built In Test.
2019-04-10T00:55:44.606Z,1554857744.606 [CBIT] Loaded
2019-04-10T00:55:44.607Z,1554857744.607 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2019-04-10T00:55:44.607Z,1554857744.607 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2019-04-10T00:55:44.608Z,1554857744.608 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2019-04-10T00:55:44.795Z,1554857744.795 [Aanderaa_O2] Loaded
2019-04-10T00:55:44.795Z,1554857744.795 [ComponentRegistry](DEBUG): SyncComponent "Aanderaa_O2" handled in the control thread.
2019-04-10T00:55:44.806Z,1554857744.806 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_density
2019-04-10T00:55:44.811Z,1554857744.811 [CTD_Seabird](INFO): created writer for : sea_water_density
2019-04-10T00:55:44.813Z,1554857744.813 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): depth
2019-04-10T00:55:44.818Z,1554857744.818 [CTD_Seabird](INFO): created writer for : depth
2019-04-10T00:55:44.819Z,1554857744.819 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_pressure
2019-04-10T00:55:44.824Z,1554857744.824 [CTD_Seabird](INFO): created writer for : sea_water_pressure
2019-04-10T00:55:44.825Z,1554857744.825 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_salinity
2019-04-10T00:55:44.830Z,1554857744.830 [CTD_Seabird](INFO): created writer for : sea_water_salinity
2019-04-10T00:55:44.831Z,1554857744.831 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_temperature
2019-04-10T00:55:44.836Z,1554857744.836 [CTD_Seabird](INFO): created writer for : sea_water_temperature
2019-04-10T00:55:44.837Z,1554857744.837 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_electrical_conductivity
2019-04-10T00:55:44.843Z,1554857744.843 [CTD_Seabird](INFO): created writer for : sea_water_electrical_conductivity
2019-04-10T00:55:44.844Z,1554857744.844 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): speed_of_sound_in_sea_water
2019-04-10T00:55:44.849Z,1554857744.849 [CTD_Seabird](INFO): created writer for : speed_of_sound_in_sea_water
2019-04-10T00:55:44.877Z,1554857744.877 [CTD_Seabird] Loaded
2019-04-10T00:55:44.878Z,1554857744.878 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread.
2019-04-10T00:55:44.879Z,1554857744.879 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 406654E0
2019-04-10T00:55:44.879Z,1554857744.879 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 702
2019-04-10T00:55:44.906Z,1554857744.906 [ESPComponent] Loaded
2019-04-10T00:55:44.907Z,1554857744.907 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread.
2019-04-10T00:55:44.922Z,1554857744.922 [PAR_Licor] Loaded
2019-04-10T00:55:44.922Z,1554857744.922 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2019-04-10T00:55:44.973Z,1554857744.973 [WetLabsBB2FL] Loaded
2019-04-10T00:55:44.974Z,1554857744.974 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2019-04-10T00:55:44.975Z,1554857744.975 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 406954E0
2019-04-10T00:55:44.975Z,1554857744.975 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 703
2019-04-10T00:55:44.976Z,1554857744.976 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2019-04-10T00:55:44.977Z,1554857744.977 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2019-04-10T00:55:45.018Z,1554857745.018 [DepthRateCalculator] Loaded
2019-04-10T00:55:45.018Z,1554857745.018 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2019-04-10T00:55:45.024Z,1554857745.024 [PitchRateCalculator] Loaded
2019-04-10T00:55:45.025Z,1554857745.025 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2019-04-10T00:55:45.042Z,1554857745.042 [SpeedCalculator] Loaded
2019-04-10T00:55:45.042Z,1554857745.042 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2019-04-10T00:55:45.065Z,1554857745.065 [TempGradientCalculator] Loaded
2019-04-10T00:55:45.065Z,1554857745.065 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread.
2019-04-10T00:55:45.072Z,1554857745.072 [YawRateCalculator] Loaded
2019-04-10T00:55:45.072Z,1554857745.072 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2019-04-10T00:55:45.107Z,1554857745.107 [ElevatorOffsetCalculator] Loaded
2019-04-10T00:55:45.108Z,1554857745.108 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2019-04-10T00:55:45.108Z,1554857745.108 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2019-04-10T00:55:45.109Z,1554857745.109 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2019-04-10T00:55:45.136Z,1554857745.136 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2019-04-10T00:55:45.137Z,1554857745.137 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2019-04-10T00:55:45.244Z,1554857745.244 [DeadReckonUsingMultipleVelocitySources] Loaded
2019-04-10T00:55:45.244Z,1554857745.244 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2019-04-10T00:55:45.308Z,1554857745.308 [DeadReckonUsingSpeedCalculator] Loaded
2019-04-10T00:55:45.309Z,1554857745.309 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread.
2019-04-10T00:55:45.372Z,1554857745.372 [DeadReckonWithRespectToSeafloor] Loaded
2019-04-10T00:55:45.372Z,1554857745.372 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonWithRespectToSeafloor" handled in the control thread.
2019-04-10T00:55:45.395Z,1554857745.395 [NavChart] Loaded
2019-04-10T00:55:45.395Z,1554857745.395 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2019-04-10T00:55:45.399Z,1554857745.399 [UniversalFixResidualReporter] Loaded
2019-04-10T00:55:45.400Z,1554857745.400 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2019-04-10T00:55:45.400Z,1554857745.400 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2019-04-10T00:55:45.401Z,1554857745.401 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2019-04-10T00:55:45.720Z,1554857745.720 [AcousticModem_Benthos_ATM900] Loaded
2019-04-10T00:55:45.721Z,1554857745.721 [ComponentRegistry](DEBUG): SyncComponent "AcousticModem_Benthos_ATM900" handled in the control thread.
2019-04-10T00:55:45.793Z,1554857745.793 [DataOverHttps] Loaded
2019-04-10T00:55:45.793Z,1554857745.793 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2019-04-10T00:55:45.794Z,1554857745.794 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 409714E0
2019-04-10T00:55:45.795Z,1554857745.795 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 704
2019-04-10T00:55:45.809Z,1554857745.809 [Depth_Keller] Loaded
2019-04-10T00:55:45.809Z,1554857745.809 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2019-04-10T00:55:45.906Z,1554857745.906 [NAL9602] Loaded
2019-04-10T00:55:45.906Z,1554857745.906 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2019-04-10T00:55:45.911Z,1554857745.911 [Onboard] Loaded
2019-04-10T00:55:45.912Z,1554857745.912 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread.
2019-04-10T00:55:45.915Z,1554857745.915 [Radio_Surface] Loaded
2019-04-10T00:55:45.916Z,1554857745.916 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2019-04-10T00:55:45.917Z,1554857745.917 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 409A14E0
2019-04-10T00:55:45.917Z,1554857745.917 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 705
2019-04-10T00:55:48.077Z,1554857748.077 [BPC1] Loaded
2019-04-10T00:55:48.078Z,1554857748.078 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2019-04-10T00:55:48.110Z,1554857748.110 [BR_Ping1D](CRITICAL): No configuration setting for: BR_Ping1D.minrange
2019-04-10T00:55:48.112Z,1554857748.112 [BR_Ping1D](CRITICAL): No configuration setting for: BR_Ping1D.maxrange
2019-04-10T00:55:48.114Z,1554857748.114 [BR_Ping1D](CRITICAL): No configuration setting for: BR_Ping1D.soundspeed
2019-04-10T00:55:48.116Z,1554857748.116 [BR_Ping1D](CRITICAL): No configuration setting for: BR_Ping1D.automode
2019-04-10T00:55:48.119Z,1554857748.119 [BR_Ping1D](CRITICAL): No configuration setting for: BR_Ping1D.gainindex
2019-04-10T00:55:48.121Z,1554857748.121 [BR_Ping1D](CRITICAL): No configuration setting for: BR_Ping1D.minconfidence
2019-04-10T00:55:48.123Z,1554857748.123 [BR_Ping1D](CRITICAL): No configuration setting for: BR_Ping1D.pingenable
2019-04-10T00:55:48.125Z,1554857748.125 [BR_Ping1D] Loaded
2019-04-10T00:55:48.126Z,1554857748.126 [ComponentRegistry](DEBUG): SyncComponent "BR_Ping1D" handled in the control thread.
2019-04-10T00:55:48.126Z,1554857748.126 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2019-04-10T00:55:48.127Z,1554857748.127 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2019-04-10T00:55:48.192Z,1554857748.192 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2019-04-10T00:55:48.192Z,1554857748.192 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2019-04-10T00:55:48.260Z,1554857748.260 [VerticalControl](DEBUG): Construct VerticalControl.
2019-04-10T00:55:48.351Z,1554857748.351 [VerticalControl] Loaded
2019-04-10T00:55:48.351Z,1554857748.351 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2019-04-10T00:55:48.352Z,1554857748.352 [HorizontalControl](DEBUG): Construct HorizontalControl.
2019-04-10T00:55:48.414Z,1554857748.414 [HorizontalControl] Loaded
2019-04-10T00:55:48.414Z,1554857748.414 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2019-04-10T00:55:48.415Z,1554857748.415 [SpeedControl](DEBUG): Construct SpeedControl.
2019-04-10T00:55:48.416Z,1554857748.416 [SpeedControl] Loaded
2019-04-10T00:55:48.417Z,1554857748.417 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2019-04-10T00:55:48.418Z,1554857748.418 [LoopControl](DEBUG): Construct LoopControl.
2019-04-10T00:55:48.418Z,1554857748.418 [LoopControl] Loaded
2019-04-10T00:55:48.418Z,1554857748.418 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2019-04-10T00:55:48.419Z,1554857748.419 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2019-04-10T00:55:48.420Z,1554857748.420 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2019-04-10T00:55:48.433Z,1554857748.433 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2019-04-10T00:55:48.434Z,1554857748.434 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2019-04-10T00:55:48.718Z,1554857748.718 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2019-04-10T00:55:48.722Z,1554857748.722 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2019-04-10T00:55:48.723Z,1554857748.723 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2019-04-10T00:55:48.730Z,1554857748.730 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2019-04-10T00:55:48.731Z,1554857748.731 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40ACE4E0
2019-04-10T00:55:48.731Z,1554857748.731 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 706
2019-04-10T00:55:48.736Z,1554857748.736 [Supervisor](INFO): Main Thread ID is 9999
2019-04-10T00:55:48.736Z,1554857748.736 [Supervisor](DEBUG): Running supervisor.
2019-04-10T00:55:48.737Z,1554857748.737 [CommandLine ThreadHandler](INFO): Handler Thread ID is 707
2019-04-10T00:55:48.740Z,1554857748.740 [controlThread ThreadHandler](INFO): Handler Thread ID is 708
2019-04-10T00:55:48.740Z,1554857748.740 [controlThread](DEBUG): Initializing ControlThread
2019-04-10T00:55:48.742Z,1554857748.742 [SBIT](INFO): Initialize SBIT Component.
2019-04-10T00:55:48.742Z,1554857748.742 [SBIT](IMPORTANT): git: 2019-03-18-31-ge98d5dc
2019-04-10T00:55:48.742Z,1554857748.742 [SBIT](INFO): git hash: e98d5dc50cbc39e402f19b9946ff4dc0776c8725
2019-04-10T00:55:48.743Z,1554857748.743 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2019-04-10T00:55:48.744Z,1554857748.744 [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-10T00:55:48.745Z,1554857748.745 [SBIT](INFO): Beginning SBIT in 24.000000 seconds.
2019-04-10T00:55:48.746Z,1554857748.746 [IBIT](INFO): Initialize IBIT Component.
2019-04-10T00:55:48.747Z,1554857748.747 [CBIT](DEBUG): Initialize CBIT Component.
2019-04-10T00:55:48.748Z,1554857748.748 [logger ThreadHandler](INFO): Handler Thread ID is 709
2019-04-10T00:55:48.758Z,1554857748.758 [CBIT](DEBUG): Initialized mux pins.
2019-04-10T00:55:48.758Z,1554857748.758 [CBIT](DEBUG): Initializing the watchdog timer.
2019-04-10T00:55:48.766Z,1554857748.766 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 710
2019-04-10T00:55:48.767Z,1554857748.767 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2019-04-10T00:55:48.771Z,1554857748.771 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20
2019-04-10T00:55:48.772Z,1554857748.772 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 712
2019-04-10T00:55:48.773Z,1554857748.773 [WetLabsBB2FL](INFO): Powering down
2019-04-10T00:55:48.782Z,1554857748.782 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2019-04-10T00:55:48.782Z,1554857748.782 [CBIT](DEBUG): Initializing heartbeat.
2019-04-10T00:55:48.802Z,1554857748.802 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 713
2019-04-10T00:55:48.803Z,1554857748.803 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2019-04-10T00:55:48.811Z,1554857748.811 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 714
2019-04-10T00:55:48.830Z,1554857748.830 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 715
2019-04-10T00:55:48.833Z,1554857748.833 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2019-04-10T00:55:48.834Z,1554857748.834 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2019-04-10T00:55:48.834Z,1554857748.834 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2019-04-10T00:55:48.834Z,1554857748.834 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2019-04-10T00:55:48.834Z,1554857748.834 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2019-04-10T00:55:48.834Z,1554857748.834 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2019-04-10T00:55:48.835Z,1554857748.835 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000
2019-04-10T00:55:48.835Z,1554857748.835 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000
2019-04-10T00:55:48.835Z,1554857748.835 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2019-04-10T00:55:48.835Z,1554857748.835 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2019-04-10T00:55:48.835Z,1554857748.835 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000
2019-04-10T00:55:48.836Z,1554857748.836 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000
2019-04-10T00:55:48.836Z,1554857748.836 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000
2019-04-10T00:55:48.836Z,1554857748.836 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000
2019-04-10T00:55:48.836Z,1554857748.836 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000
2019-04-10T00:55:48.836Z,1554857748.836 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000
2019-04-10T00:55:48.854Z,1554857748.854 [CBIT](DEBUG): Deactivating GF circuits.
2019-04-10T00:55:48.854Z,1554857748.854 [CBIT](DEBUG): Deactivating emergency mode.
2019-04-10T00:55:48.890Z,1554857748.890 [CBIT](DEBUG): Backplane powered.
2019-04-10T00:55:48.894Z,1554857748.894 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2019-04-10T00:55:48.895Z,1554857748.895 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2019-04-10T00:55:48.895Z,1554857748.895 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2019-04-10T00:55:48.895Z,1554857748.895 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator.
2019-04-10T00:55:48.896Z,1554857748.896 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2019-04-10T00:55:48.896Z,1554857748.896 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2019-04-10T00:55:48.897Z,1554857748.897 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2019-04-10T00:55:48.898Z,1554857748.898 [NavChart](DEBUG): Initialize NavChart Navigation.
2019-04-10T00:55:48.899Z,1554857748.899 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2019-04-10T00:55:48.903Z,1554857748.903 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2019-04-10T00:55:48.905Z,1554857748.905 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2019-04-10T00:55:48.906Z,1554857748.906 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2019-04-10T00:55:48.906Z,1554857748.906 [LoopControl](DEBUG): Initialize LoopControlComponent.
2019-04-10T00:55:48.907Z,1554857748.907 [MissionManager](INFO): Loading Mission: Missions/Startup.xml
2019-04-10T00:55:48.929Z,1554857748.929 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2019-04-10T00:55:48.965Z,1554857748.965 [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-10T00:55:48.974Z,1554857748.974 [MissionManager](INFO): Loading Mission: Missions/Default.xml
2019-04-10T00:55:49.042Z,1554857749.042 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2019-04-10T00:55:49.043Z,1554857749.043 [Default:A.Wait](DEBUG): Construct Wait.
2019-04-10T00:55:49.060Z,1554857749.060 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2019-04-10T00:55:49.083Z,1554857749.083 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2019-04-10T00:55:49.085Z,1554857749.085 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2019-04-10T00:55:49.115Z,1554857749.115 [Default:E.Execute](DEBUG): Construct Execute.
2019-04-10T00:55:49.138Z,1554857749.138 [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-10T00:55:49.143Z,1554857749.143 [controlThread](DEBUG): Component order: CycleStarter,Aanderaa_O2,ESPComponent,PAR_Licor,AcousticModem_Benthos_ATM900,Depth_Keller,NAL9602,Onboard,BPC1,BR_Ping1D,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-10T00:55:49.163Z,1554857749.163 [ESPComponent](INFO): powering down ESP
2019-04-10T00:55:49.214Z,1554857749.214 [Radio_Surface](INFO): Powering up
2019-04-10T00:55:49.602Z,1554857749.602 [PAR_Licor](INFO): A/D timeout, 10 tries over 140 ms

2019-04-10T00:55:49.602Z,1554857749.602 [PAR_Licor] Data Fault, FailCount= 1
2019-04-10T00:55:49.603Z,1554857749.603 [PAR_Licor](ERROR): Data Fault
2019-04-10T00:55:49.603Z,1554857749.603 [AcousticModem_Benthos_ATM900](INFO): Powering up
2019-04-10T00:55:49.603Z,1554857749.603 [AcousticModem_Benthos_ATM900](DEBUG): Initializing AcousticModem_Benthos_ATM900.
2019-04-10T00:55:49.832Z,1554857749.832 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2019-04-10T00:55:49.838Z,1554857749.838 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2019-04-10T00:55:49.840Z,1554857749.840 [ElevatorServo](DEBUG): Initializing EZServoServo.
2019-04-10T00:55:49.846Z,1554857749.846 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2019-04-10T00:55:49.847Z,1554857749.847 [MassServo](DEBUG): Initializing EZServoServo.
2019-04-10T00:55:49.854Z,1554857749.854 [MassServo](DEBUG): Initializing MassServo.
2019-04-10T00:55:49.855Z,1554857749.855 [RudderServo](DEBUG): Initializing EZServoServo.
2019-04-10T00:55:49.862Z,1554857749.862 [RudderServo](DEBUG): Initializing RudderServo.
2019-04-10T00:55:49.863Z,1554857749.863 [ThrusterServo](DEBUG): Initializing EZServoServo.
2019-04-10T00:55:49.870Z,1554857749.870 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2019-04-10T00:55:49.873Z,1554857749.873 [CommandLine](FAULT): Scheduling is paused
2019-04-10T00:55:49.873Z,1554857749.873 [CBIT](INFO): Critical error at 20190410T005548
2019-04-10T00:55:49.873Z,1554857749.873 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals
2019-04-10T00:55:49.878Z,1554857749.878 [CBIT](ERROR): Data Fault in component: PAR_Licor
2019-04-10T00:55:49.878Z,1554857749.878 [CBIT](INFO): Clearing failed state for component PAR_Licor
2019-04-10T00:55:49.878Z,1554857749.878 [PAR_Licor] No Fault, FailCount= 1
2019-04-10T00:55:50.426Z,1554857750.426 [PAR_Licor](INFO): A/D timeout, 8 tries over 139 ms

2019-04-10T00:55:50.427Z,1554857750.427 [PAR_Licor] Data Fault, FailCount= 2
2019-04-10T00:55:50.427Z,1554857750.427 [PAR_Licor](ERROR): Data Fault
2019-04-10T00:55:50.462Z,1554857750.462 [BR_Ping1D](INFO): startup: 0
2019-04-10T00:55:50.462Z,1554857750.462 [BR_Ping1D](INFO): UART setting parameters ...
2019-04-10T00:55:50.474Z,1554857750.474 [BR_Ping1D](INFO): 42520200EC030000F4017A02
2019-04-10T00:55:50.474Z,1554857750.474 [BR_Ping1D](INFO): XXX autoMode1: 

2019-04-10T00:55:50.475Z,1554857750.475 [BR_Ping1D](INFO): XXX autoMode2: 
2019-04-10T00:55:50.475Z,1554857750.475 [BR_Ping1D](INFO): XXX autoMode3: 1
2019-04-10T00:55:50.475Z,1554857750.475 [BR_Ping1D](INFO): 42520100EB030000840100
2019-04-10T00:55:50.475Z,1554857750.475 [BR_Ping1D](INFO): 42520400EA03000060E31600DE02
2019-04-10T00:55:50.475Z,1554857750.475 [BR_Ping1D](INFO): 42520100EE030000870116
2019-04-10T00:55:50.842Z,1554857750.842 [RudderServo](ERROR): Rudder initialization uart error serial timeout
2019-04-10T00:55:50.842Z,1554857750.842 [RudderServo](FAULT): Rudder failed to initialize
2019-04-10T00:55:50.842Z,1554857750.842 [RudderServo] Communications Fault, FailCount= 1
2019-04-10T00:55:50.842Z,1554857750.842 [RudderServo](ERROR): Communications Fault
2019-04-10T00:55:50.953Z,1554857750.953 [CBIT](ERROR): Communications Fault in component: RudderServo
2019-04-10T00:55:50.954Z,1554857750.954 [CBIT](ERROR): Data Fault in component: PAR_Licor
2019-04-10T00:55:50.954Z,1554857750.954 [CBIT](INFO): Clearing failed state for component PAR_Licor
2019-04-10T00:55:50.954Z,1554857750.954 [PAR_Licor] No Fault, FailCount= 2
2019-04-10T00:55:50.993Z,1554857750.993 [BR_Ping1D](INFO): Starting
2019-04-10T00:55:50.993Z,1554857750.993 [BR_Ping1D](INFO): readConfig
2019-04-10T00:55:50.994Z,1554857750.994 [BR_Ping1D](INFO): startup: 1
2019-04-10T00:55:50.994Z,1554857750.994 [BR_Ping1D](INFO): UART requesting status
2019-04-10T00:55:50.994Z,1554857750.994 [BR_Ping1D](INFO): 42520000BA0400005201
2019-04-10T00:55:51.002Z,1554857751.002 [BR_Ping1D](INFO): 42520000BF0400005701
2019-04-10T00:55:51.010Z,1554857751.010 [BR_Ping1D](INFO): 42520000B30400004B01
2019-04-10T00:55:51.163Z,1554857751.163 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2019-04-10T00:55:51.163Z,1554857751.163 [RudderServo](INFO): Powering down
2019-04-10T00:55:51.385Z,1554857751.385 [BR_Ping1D](INFO): Starting
2019-04-10T00:55:51.385Z,1554857751.385 [BR_Ping1D](INFO): readConfig
2019-04-10T00:55:51.386Z,1554857751.386 [BR_Ping1D](INFO): startup: 2
2019-04-10T00:55:51.386Z,1554857751.386 [BR_Ping1D](INFO): UART waiting for response
2019-04-10T00:55:51.386Z,1554857751.386 [BR_Ping1D](INFO): elapsed 0.9240
2019-04-10T00:55:51.386Z,1554857751.386 [BR_Ping1D](INFO): timeout 5.0000
2019-04-10T00:55:51.386Z,1554857751.386 [BR_Ping1D](INFO): No UART data
2019-04-10T00:55:51.387Z,1554857751.387 [BR_Ping1D](INFO): received UART packets: 0
2019-04-10T00:55:51.387Z,1554857751.387 [BR_Ping1D](INFO): not all values verified yet
2019-04-10T00:55:51.914Z,1554857751.914 [PAR_Licor](INFO): A/D timeout, 9 tries over 146 ms

2019-04-10T00:55:51.914Z,1554857751.914 [PAR_Licor] Data Fault, FailCount= 1
2019-04-10T00:55:51.914Z,1554857751.914 [PAR_Licor](ERROR): Data Fault
2019-04-10T00:55:51.950Z,1554857751.950 [BR_Ping1D](INFO): Starting
2019-04-10T00:55:51.950Z,1554857751.950 [BR_Ping1D](INFO): readConfig
2019-04-10T00:55:51.950Z,1554857751.950 [BR_Ping1D](INFO): startup: 2
2019-04-10T00:55:51.950Z,1554857751.950 [BR_Ping1D](INFO): UART waiting for response
2019-04-10T00:55:51.951Z,1554857751.951 [BR_Ping1D](INFO): elapsed 1.4886
2019-04-10T00:55:51.951Z,1554857751.951 [BR_Ping1D](INFO): timeout 5.0000
2019-04-10T00:55:51.951Z,1554857751.951 [BR_Ping1D](INFO): No UART data
2019-04-10T00:55:51.951Z,1554857751.951 [BR_Ping1D](INFO): received UART packets: 0
2019-04-10T00:55:51.951Z,1554857751.951 [BR_Ping1D](INFO): not all values verified yet
2019-04-10T00:55:51.979Z,1554857751.979 [RudderServo](DEBUG): Initializing EZServoServo.
2019-04-10T00:55:52.099Z,1554857752.099 [RudderServo](DEBUG): Initializing RudderServo.
2019-04-10T00:55:52.103Z,1554857752.103 [CBIT](INFO): Clearing failed state for component RudderServo
2019-04-10T00:55:52.103Z,1554857752.103 [RudderServo] No Fault, FailCount= 1
2019-04-10T00:55:52.103Z,1554857752.103 [CBIT](ERROR): Data Fault in component: PAR_Licor
2019-04-10T00:55:52.104Z,1554857752.104 [CBIT](INFO): Clearing failed state for component PAR_Licor
2019-04-10T00:55:52.104Z,1554857752.104 [PAR_Licor] No Fault, FailCount= 1
2019-04-10T00:55:52.190Z,1554857752.190 [BR_Ping1D](INFO): Starting
2019-04-10T00:55:52.190Z,1554857752.190 [BR_Ping1D](INFO): readConfig
2019-04-10T00:55:52.190Z,1554857752.190 [BR_Ping1D](INFO): startup: 2
2019-04-10T00:55:52.190Z,1554857752.190 [BR_Ping1D](INFO): UART waiting for response
2019-04-10T00:55:52.191Z,1554857752.191 [BR_Ping1D](INFO): elapsed 1.7286
2019-04-10T00:55:52.191Z,1554857752.191 [BR_Ping1D](INFO): timeout 5.0000
2019-04-10T00:55:52.191Z,1554857752.191 [BR_Ping1D](INFO): No UART data
2019-04-10T00:55:52.191Z,1554857752.191 [BR_Ping1D](INFO): received UART packets: 0
2019-04-10T00:55:52.191Z,1554857752.191 [BR_Ping1D](INFO): not all values verified yet
2019-04-10T00:55:52.714Z,1554857752.714 [PAR_Licor](INFO): A/D timeout, 8 tries over 138 ms

2019-04-10T00:55:52.714Z,1554857752.714 [PAR_Licor] Data Fault, FailCount= 2
2019-04-10T00:55:52.714Z,1554857752.714 [PAR_Licor](ERROR): Data Fault
2019-04-10T00:55:52.750Z,1554857752.750 [BR_Ping1D](INFO): Starting
2019-04-10T00:55:52.750Z,1554857752.750 [BR_Ping1D](INFO): readConfig
2019-04-10T00:55:52.750Z,1554857752.750 [BR_Ping1D](INFO): startup: 2
2019-04-10T00:55:52.750Z,1554857752.750 [BR_Ping1D](INFO): UART waiting for response
2019-04-10T00:55:52.751Z,1554857752.751 [BR_Ping1D](INFO): elapsed 2.2887
2019-04-10T00:55:52.751Z,1554857752.751 [BR_Ping1D](INFO): timeout 5.0000
2019-04-10T00:55:52.751Z,1554857752.751 [BR_Ping1D](INFO): No UART data
2019-04-10T00:55:52.751Z,1554857752.751 [BR_Ping1D](INFO): received UART packets: 0
2019-04-10T00:55:52.751Z,1554857752.751 [BR_Ping1D](INFO): not all values verified yet
2019-04-10T00:55:52.934Z,1554857752.934 [CBIT](ERROR): Data Fault in component: PAR_Licor
2019-04-10T00:55:52.934Z,1554857752.934 [CBIT](INFO): Clearing failed state for component PAR_Licor
2019-04-10T00:55:52.934Z,1554857752.934 [PAR_Licor] No Fault, FailCount= 2
2019-04-10T00:55:53.002Z,1554857753.002 [BR_Ping1D](INFO): Starting
2019-04-10T00:55:53.002Z,1554857753.002 [BR_Ping1D](INFO): readConfig
2019-04-10T00:55:53.002Z,1554857753.002 [BR_Ping1D](INFO): startup: 2
2019-04-10T00:55:53.002Z,1554857753.002 [BR_Ping1D](INFO): UART waiting for response
2019-04-10T00:55:53.002Z,1554857753.002 [BR_Ping1D](INFO): elapsed 2.5404
2019-04-10T00:55:53.003Z,1554857753.003 [BR_Ping1D](INFO): timeout 5.0000
2019-04-10T00:55:53.003Z,1554857753.003 [BR_Ping1D](INFO): No UART data
2019-04-10T00:55:53.003Z,1554857753.003 [BR_Ping1D](INFO): received UART packets: 0
2019-04-10T00:55:53.003Z,1554857753.003 [BR_Ping1D](INFO): not all values verified yet
2019-04-10T00:55:53.518Z,1554857753.518 [PAR_Licor](INFO): A/D timeout, 8 tries over 134 ms

2019-04-10T00:55:53.518Z,1554857753.518 [PAR_Licor] Data Fault, FailCount= 3
2019-04-10T00:55:53.518Z,1554857753.518 [PAR_Licor](ERROR): Data Fault
2019-04-10T00:55:53.567Z,1554857753.567 [BR_Ping1D](INFO): Starting
2019-04-10T00:55:53.567Z,1554857753.567 [BR_Ping1D](INFO): readConfig
2019-04-10T00:55:53.567Z,1554857753.567 [BR_Ping1D](INFO): startup: 2
2019-04-10T00:55:53.567Z,1554857753.567 [BR_Ping1D](INFO): UART waiting for response
2019-04-10T00:55:53.567Z,1554857753.567 [BR_Ping1D](INFO): elapsed 3.1053
2019-04-10T00:55:53.567Z,1554857753.567 [BR_Ping1D](INFO): timeout 5.0000
2019-04-10T00:55:53.568Z,1554857753.568 [BR_Ping1D](INFO): No UART data
2019-04-10T00:55:53.568Z,1554857753.568 [BR_Ping1D](INFO): received UART packets: 0
2019-04-10T00:55:53.568Z,1554857753.568 [BR_Ping1D](INFO): not all values verified yet
2019-04-10T00:55:53.846Z,1554857753.846 [CBIT](ERROR): Data Fault in component: PAR_Licor
2019-04-10T00:55:53.847Z,1554857753.847 [CBIT](CRITICAL): Data Fault in component: PAR_Licor
2019-04-10T00:55:53.896Z,1554857753.896 [BR_Ping1D](INFO): Starting
2019-04-10T00:55:53.896Z,1554857753.896 [BR_Ping1D](INFO): readConfig
2019-04-10T00:55:53.896Z,1554857753.896 [BR_Ping1D](INFO): startup: 2
2019-04-10T00:55:53.896Z,1554857753.896 [BR_Ping1D](INFO): UART waiting for response
2019-04-10T00:55:53.897Z,1554857753.897 [BR_Ping1D](INFO): elapsed 3.4346
2019-04-10T00:55:53.897Z,1554857753.897 [BR_Ping1D](INFO): timeout 5.0000
2019-04-10T00:55:53.897Z,1554857753.897 [BR_Ping1D](INFO): No UART data
2019-04-10T00:55:53.897Z,1554857753.897 [BR_Ping1D](INFO): received UART packets: 0
2019-04-10T00:55:53.897Z,1554857753.897 [BR_Ping1D](INFO): not all values verified yet
2019-04-10T00:55:53.984Z,1554857753.984 [CBIT](INFO): Critical error at 20190410T005553
2019-04-10T00:55:54.274Z,1554857754.274 [BR_Ping1D](INFO): Starting
2019-04-10T00:55:54.274Z,1554857754.274 [BR_Ping1D](INFO): readConfig
2019-04-10T00:55:54.274Z,1554857754.274 [BR_Ping1D](INFO): startup: 2
2019-04-10T00:55:54.274Z,1554857754.274 [BR_Ping1D](INFO): UART waiting for response
2019-04-10T00:55:54.274Z,1554857754.274 [BR_Ping1D](INFO): elapsed 3.8124
2019-04-10T00:55:54.275Z,1554857754.275 [BR_Ping1D](INFO): timeout 5.0000
2019-04-10T00:55:54.275Z,1554857754.275 [BR_Ping1D](INFO): No UART data
2019-04-10T00:55:54.275Z,1554857754.275 [BR_Ping1D](INFO): received UART packets: 0
2019-04-10T00:55:54.275Z,1554857754.275 [BR_Ping1D](INFO): not all values verified yet
2019-04-10T00:55:54.677Z,1554857754.677 [BR_Ping1D](INFO): Starting
2019-04-10T00:55:54.677Z,1554857754.677 [BR_Ping1D](INFO): readConfig
2019-04-10T00:55:54.677Z,1554857754.677 [BR_Ping1D](INFO): startup: 2
2019-04-10T00:55:54.678Z,1554857754.678 [BR_Ping1D](INFO): UART waiting for response
2019-04-10T00:55:54.678Z,1554857754.678 [BR_Ping1D](INFO): elapsed 4.2158
2019-04-10T00:55:54.678Z,1554857754.678 [BR_Ping1D](INFO): timeout 5.0000
2019-04-10T00:55:54.678Z,1554857754.678 [BR_Ping1D](INFO): No UART data
2019-04-10T00:55:54.678Z,1554857754.678 [BR_Ping1D](INFO): received UART packets: 0
2019-04-10T00:55:54.679Z,1554857754.679 [BR_Ping1D](INFO): not all values verified yet
2019-04-10T00:55:55.082Z,1554857755.082 [BR_Ping1D](INFO): Starting
2019-04-10T00:55:55.082Z,1554857755.082 [BR_Ping1D](INFO): readConfig
2019-04-10T00:55:55.082Z,1554857755.082 [BR_Ping1D](INFO): startup: 2
2019-04-10T00:55:55.082Z,1554857755.082 [BR_Ping1D](INFO): UART waiting for response
2019-04-10T00:55:55.082Z,1554857755.082 [BR_Ping1D](INFO): elapsed 4.6205
2019-04-10T00:55:55.083Z,1554857755.083 [BR_Ping1D](INFO): timeout 5.0000
2019-04-10T00:55:55.083Z,1554857755.083 [BR_Ping1D](INFO): No UART data
2019-04-10T00:55:55.083Z,1554857755.083 [BR_Ping1D](INFO): received UART packets: 0
2019-04-10T00:55:55.083Z,1554857755.083 [BR_Ping1D](INFO): not all values verified yet
2019-04-10T00:55:55.485Z,1554857755.485 [BR_Ping1D](INFO): Starting
2019-04-10T00:55:55.485Z,1554857755.485 [BR_Ping1D](INFO): readConfig
2019-04-10T00:55:55.486Z,1554857755.486 [BR_Ping1D](INFO): startup: 2
2019-04-10T00:55:55.486Z,1554857755.486 [BR_Ping1D](INFO): UART waiting for response
2019-04-10T00:55:55.486Z,1554857755.486 [BR_Ping1D](INFO): elapsed 5.0241
2019-04-10T00:55:55.486Z,1554857755.486 [BR_Ping1D](INFO): timeout 5.0000
2019-04-10T00:55:55.486Z,1554857755.486 [BR_Ping1D](FAULT): Failed to set parameters in time during initialization.
2019-04-10T00:55:55.486Z,1554857755.486 [BR_Ping1D] Data Fault, FailCount= 1
2019-04-10T00:55:55.486Z,1554857755.486 [BR_Ping1D](ERROR): Data Fault
2019-04-10T00:55:55.858Z,1554857755.858 [CBIT](ERROR): Data Fault in component: BR_Ping1D
2019-04-10T00:55:55.895Z,1554857755.895 [BR_Ping1D](INFO): Stop
2019-04-10T00:55:55.896Z,1554857755.896 [BR_Ping1D](INFO): uninitialize
2019-04-10T00:55:55.896Z,1554857755.896 [BR_Ping1D](INFO): Powering down
2019-04-10T00:55:56.293Z,1554857756.293 [BR_Ping1D](INFO): Stopping
2019-04-10T00:55:56.697Z,1554857756.697 [BR_Ping1D](INFO): Stopping
2019-04-10T00:55:57.101Z,1554857757.101 [BR_Ping1D](INFO): Stopped
2019-04-10T00:55:57.151Z,1554857757.151 [CBIT](INFO): Clearing failed state for component BR_Ping1D
2019-04-10T00:55:57.151Z,1554857757.151 [BR_Ping1D] No Fault, FailCount= 1
2019-04-10T00:55:57.506Z,1554857757.506 [BR_Ping1D](INFO): Start
2019-04-10T00:55:57.909Z,1554857757.909 [BR_Ping1D](INFO): Starting
2019-04-10T00:55:58.314Z,1554857758.314 [BR_Ping1D](INFO): Starting
2019-04-10T00:55:58.314Z,1554857758.314 [BR_Ping1D](INFO): readConfig
2019-04-10T00:55:58.314Z,1554857758.314 [BR_Ping1D](INFO): startup: 0
2019-04-10T00:55:58.314Z,1554857758.314 [BR_Ping1D](INFO): UART setting parameters ...
2019-04-10T00:55:58.326Z,1554857758.326 [BR_Ping1D](INFO): 42520200EC030000F4017A02
2019-04-10T00:55:58.326Z,1554857758.326 [BR_Ping1D](INFO): XXX autoMode1: 

2019-04-10T00:55:58.327Z,1554857758.327 [BR_Ping1D](INFO): XXX autoMode2: 
2019-04-10T00:55:58.327Z,1554857758.327 [BR_Ping1D](INFO): XXX autoMode3: 1
2019-04-10T00:55:58.327Z,1554857758.327 [BR_Ping1D](INFO): 42520100EB030000840100
2019-04-10T00:55:58.327Z,1554857758.327 [BR_Ping1D](INFO): 42520400EA03000060E31600DE02
2019-04-10T00:55:58.327Z,1554857758.327 [BR_Ping1D](INFO): 42520100EE030000870116
2019-04-10T00:55:58.717Z,1554857758.717 [BR_Ping1D](INFO): Starting
2019-04-10T00:55:58.862Z,1554857758.862 [CBIT](CRITICAL): Environmental Failure. Press:14.887811 PSI. Humidity:37%. Temp:25 C. ABORTING MISSION
2019-04-10T00:55:59.121Z,1554857759.121 [BR_Ping1D](INFO): Starting
2019-04-10T00:55:59.122Z,1554857759.122 [BR_Ping1D](INFO): readConfig
2019-04-10T00:55:59.122Z,1554857759.122 [BR_Ping1D](INFO): startup: 1
2019-04-10T00:55:59.122Z,1554857759.122 [BR_Ping1D](INFO): UART requesting status
2019-04-10T00:55:59.122Z,1554857759.122 [BR_Ping1D](INFO): 42520000BA0400005201
2019-04-10T00:55:59.130Z,1554857759.130 [BR_Ping1D](INFO): 42520000BF0400005701
2019-04-10T00:55:59.138Z,1554857759.138 [BR_Ping1D](INFO): 42520000B30400004B01
2019-04-10T00:55:59.170Z,1554857759.170 [CBIT](INFO): Critical error at 20190410T005558
2019-04-10T00:55:59.506Z,1554857759.506 [Aanderaa_O2](FAULT): Failed to initialize within timeout.
2019-04-10T00:55:59.506Z,1554857759.506 [Aanderaa_O2] Communications Fault, FailCount= 1
2019-04-10T00:55:59.506Z,1554857759.506 [Aanderaa_O2](ERROR): Communications Fault
2019-04-10T00:55:59.525Z,1554857759.525 [BR_Ping1D](INFO): Starting
2019-04-10T00:55:59.525Z,1554857759.525 [BR_Ping1D](INFO): readConfig
2019-04-10T00:55:59.526Z,1554857759.526 [BR_Ping1D](INFO): startup: 2
2019-04-10T00:55:59.526Z,1554857759.526 [BR_Ping1D](INFO): UART waiting for response
2019-04-10T00:55:59.526Z,1554857759.526 [BR_Ping1D](INFO): elapsed 1.2117
2019-04-10T00:55:59.526Z,1554857759.526 [BR_Ping1D](INFO): timeout 5.0000
2019-04-10T00:55:59.526Z,1554857759.526 [BR_Ping1D](INFO): No UART data
2019-04-10T00:55:59.527Z,1554857759.527 [BR_Ping1D](INFO): received UART packets: 0
2019-04-10T00:55:59.527Z,1554857759.527 [BR_Ping1D](INFO): not all values verified yet
2019-04-10T00:55:59.555Z,1554857759.555 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2019-04-10T00:56:00.030Z,1554857760.030 [Aanderaa_O2](INFO): Powering down
2019-04-10T00:56:00.128Z,1554857760.128 [BR_Ping1D](INFO): Starting
2019-04-10T00:56:00.128Z,1554857760.128 [BR_Ping1D](INFO): readConfig
2019-04-10T00:56:00.128Z,1554857760.128 [BR_Ping1D](INFO): startup: 2
2019-04-10T00:56:00.128Z,1554857760.128 [BR_Ping1D](INFO): UART waiting for response
2019-04-10T00:56:00.129Z,1554857760.129 [BR_Ping1D](INFO): elapsed 1.8142
2019-04-10T00:56:00.129Z,1554857760.129 [BR_Ping1D](INFO): timeout 5.0000
2019-04-10T00:56:00.129Z,1554857760.129 [BR_Ping1D](INFO): No UART data
2019-04-10T00:56:00.129Z,1554857760.129 [BR_Ping1D](INFO): received UART packets: 0
2019-04-10T00:56:00.129Z,1554857760.129 [BR_Ping1D](INFO): not all values verified yet
2019-04-10T00:56:00.332Z,1554857760.332 [BR_Ping1D](INFO): Starting
2019-04-10T00:56:00.332Z,1554857760.332 [BR_Ping1D](INFO): readConfig
2019-04-10T00:56:00.333Z,1554857760.333 [BR_Ping1D](INFO): startup: 2
2019-04-10T00:56:00.333Z,1554857760.333 [BR_Ping1D](INFO): UART waiting for response
2019-04-10T00:56:00.333Z,1554857760.333 [BR_Ping1D](INFO): elapsed 2.0187
2019-04-10T00:56:00.333Z,1554857760.333 [BR_Ping1D](INFO): timeout 5.0000
2019-04-10T00:56:00.333Z,1554857760.333 [BR_Ping1D](INFO): No UART data
2019-04-10T00:56:00.334Z,1554857760.334 [BR_Ping1D](INFO): received UART packets: 0
2019-04-10T00:56:00.334Z,1554857760.334 [BR_Ping1D](INFO): not all values verified yet
2019-04-10T00:56:00.738Z,1554857760.738 [BR_Ping1D](INFO): Starting
2019-04-10T00:56:00.738Z,1554857760.738 [BR_Ping1D](INFO): readConfig
2019-04-10T00:56:00.738Z,1554857760.738 [BR_Ping1D](INFO): startup: 2
2019-04-10T00:56:00.738Z,1554857760.738 [BR_Ping1D](INFO): UART waiting for response
2019-04-10T00:56:00.738Z,1554857760.738 [BR_Ping1D](INFO): elapsed 2.4241
2019-04-10T00:56:00.739Z,1554857760.739 [BR_Ping1D](INFO): timeout 5.0000
2019-04-10T00:56:00.739Z,1554857760.739 [BR_Ping1D](INFO): No UART data
2019-04-10T00:56:00.739Z,1554857760.739 [BR_Ping1D](INFO): received UART packets: 0
2019-04-10T00:56:00.739Z,1554857760.739 [BR_Ping1D](INFO): not all values verified yet
2019-04-10T00:56:00.755Z,1554857760.755 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2019-04-10T00:56:00.755Z,1554857760.755 [Aanderaa_O2] No Fault, FailCount= 1
2019-04-10T00:56:01.150Z,1554857761.150 [BR_Ping1D](INFO): Starting
2019-04-10T00:56:01.150Z,1554857761.150 [BR_Ping1D](INFO): readConfig
2019-04-10T00:56:01.150Z,1554857761.150 [BR_Ping1D](INFO): startup: 2
2019-04-10T00:56:01.150Z,1554857761.150 [BR_Ping1D](INFO): UART waiting for response
2019-04-10T00:56:01.151Z,1554857761.151 [BR_Ping1D](INFO): elapsed 2.8364
2019-04-10T00:56:01.151Z,1554857761.151 [BR_Ping1D](INFO): timeout 5.0000
2019-04-10T00:56:01.151Z,1554857761.151 [BR_Ping1D](INFO): No UART data
2019-04-10T00:56:01.151Z,1554857761.151 [BR_Ping1D](INFO): received UART packets: 0
2019-04-10T00:56:01.151Z,1554857761.151 [BR_Ping1D](INFO): not all values verified yet
2019-04-10T00:56:01.558Z,1554857761.558 [BR_Ping1D](INFO): Starting
2019-04-10T00:56:01.558Z,1554857761.558 [BR_Ping1D](INFO): readConfig
2019-04-10T00:56:01.558Z,1554857761.558 [BR_Ping1D](INFO): startup: 2
2019-04-10T00:56:01.558Z,1554857761.558 [BR_Ping1D](INFO): UART waiting for response
2019-04-10T00:56:01.558Z,1554857761.558 [BR_Ping1D](INFO): elapsed 3.2441
2019-04-10T00:56:01.559Z,1554857761.559 [BR_Ping1D](INFO): timeout 5.0000
2019-04-10T00:56:01.559Z,1554857761.559 [BR_Ping1D](INFO): No UART data
2019-04-10T00:56:01.559Z,1554857761.559 [BR_Ping1D](INFO): received UART packets: 0
2019-04-10T00:56:01.559Z,1554857761.559 [BR_Ping1D](INFO): not all values verified yet
2019-04-10T00:56:01.822Z,1554857761.822 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2019-04-10T00:56:01.822Z,1554857761.822 [CTD_Seabird] Communications Fault, FailCount= 1
2019-04-10T00:56:01.822Z,1554857761.822 [CTD_Seabird](ERROR): Communications Fault
2019-04-10T00:56:01.949Z,1554857761.949 [BR_Ping1D](INFO): Starting
2019-04-10T00:56:01.949Z,1554857761.949 [BR_Ping1D](INFO): readConfig
2019-04-10T00:56:01.950Z,1554857761.950 [BR_Ping1D](INFO): startup: 2
2019-04-10T00:56:01.950Z,1554857761.950 [BR_Ping1D](INFO): UART waiting for response
2019-04-10T00:56:01.950Z,1554857761.950 [BR_Ping1D](INFO): elapsed 3.6357
2019-04-10T00:56:01.950Z,1554857761.950 [BR_Ping1D](INFO): timeout 5.0000
2019-04-10T00:56:01.950Z,1554857761.950 [BR_Ping1D](INFO): No UART data
2019-04-10T00:56:01.951Z,1554857761.951 [BR_Ping1D](INFO): received UART packets: 0
2019-04-10T00:56:01.951Z,1554857761.951 [BR_Ping1D](INFO): not all values verified yet
2019-04-10T00:56:02.034Z,1554857762.034 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2019-04-10T00:56:02.226Z,1554857762.226 [CTD_Seabird](INFO): Powering down
2019-04-10T00:56:02.366Z,1554857762.366 [BR_Ping1D](INFO): Starting
2019-04-10T00:56:02.366Z,1554857762.366 [BR_Ping1D](INFO): readConfig
2019-04-10T00:56:02.366Z,1554857762.366 [BR_Ping1D](INFO): startup: 2
2019-04-10T00:56:02.366Z,1554857762.366 [BR_Ping1D](INFO): UART waiting for response
2019-04-10T00:56:02.367Z,1554857762.367 [BR_Ping1D](INFO): elapsed 4.0522
2019-04-10T00:56:02.367Z,1554857762.367 [BR_Ping1D](INFO): timeout 5.0000
2019-04-10T00:56:02.367Z,1554857762.367 [BR_Ping1D](INFO): No UART data
2019-04-10T00:56:02.367Z,1554857762.367 [BR_Ping1D](INFO): received UART packets: 0
2019-04-10T00:56:02.367Z,1554857762.367 [BR_Ping1D](INFO): not all values verified yet
2019-04-10T00:56:02.757Z,1554857762.757 [BR_Ping1D](INFO): Starting
2019-04-10T00:56:02.758Z,1554857762.758 [BR_Ping1D](INFO): readConfig
2019-04-10T00:56:02.758Z,1554857762.758 [BR_Ping1D](INFO): startup: 2
2019-04-10T00:56:02.758Z,1554857762.758 [BR_Ping1D](INFO): UART waiting for response
2019-04-10T00:56:02.758Z,1554857762.758 [BR_Ping1D](INFO): elapsed 4.4439
2019-04-10T00:56:02.758Z,1554857762.758 [BR_Ping1D](INFO): timeout 5.0000
2019-04-10T00:56:02.759Z,1554857762.759 [BR_Ping1D](INFO): No UART data
2019-04-10T00:56:02.759Z,1554857762.759 [BR_Ping1D](INFO): received UART packets: 0
2019-04-10T00:56:02.759Z,1554857762.759 [BR_Ping1D](INFO): not all values verified yet
2019-04-10T00:56:03.162Z,1554857763.162 [BR_Ping1D](INFO): Starting
2019-04-10T00:56:03.162Z,1554857763.162 [BR_Ping1D](INFO): readConfig
2019-04-10T00:56:03.162Z,1554857763.162 [BR_Ping1D](INFO): startup: 2
2019-04-10T00:56:03.163Z,1554857763.163 [BR_Ping1D](INFO): UART waiting for response
2019-04-10T00:56:03.163Z,1554857763.163 [BR_Ping1D](INFO): elapsed 4.8485
2019-04-10T00:56:03.163Z,1554857763.163 [BR_Ping1D](INFO): timeout 5.0000
2019-04-10T00:56:03.163Z,1554857763.163 [BR_Ping1D](INFO): No UART data
2019-04-10T00:56:03.163Z,1554857763.163 [BR_Ping1D](INFO): received UART packets: 0
2019-04-10T00:56:03.163Z,1554857763.163 [BR_Ping1D](INFO): not all values verified yet
2019-04-10T00:56:03.566Z,1554857763.566 [BR_Ping1D](INFO): Starting
2019-04-10T00:56:03.566Z,1554857763.566 [BR_Ping1D](INFO): readConfig
2019-04-10T00:56:03.566Z,1554857763.566 [BR_Ping1D](INFO): startup: 2
2019-04-10T00:56:03.566Z,1554857763.566 [BR_Ping1D](INFO): UART waiting for response
2019-04-10T00:56:03.567Z,1554857763.567 [BR_Ping1D](INFO): elapsed 5.2523
2019-04-10T00:56:03.567Z,1554857763.567 [BR_Ping1D](INFO): timeout 5.0000
2019-04-10T00:56:03.567Z,1554857763.567 [BR_Ping1D](FAULT): Failed to set parameters in time during initialization.
2019-04-10T00:56:03.567Z,1554857763.567 [BR_Ping1D] Data Fault, FailCount= 2
2019-04-10T00:56:03.567Z,1554857763.567 [BR_Ping1D](ERROR): Data Fault
2019-04-10T00:56:03.583Z,1554857763.583 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2019-04-10T00:56:03.583Z,1554857763.583 [CTD_Seabird] No Fault, FailCount= 1
2019-04-10T00:56:03.583Z,1554857763.583 [CBIT](ERROR): Data Fault in component: BR_Ping1D
2019-04-10T00:56:03.602Z,1554857763.602 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2019-04-10T00:56:03.604Z,1554857763.604 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20
2019-04-10T00:56:03.970Z,1554857763.970 [BR_Ping1D](INFO): Stop
2019-04-10T00:56:03.970Z,1554857763.970 [BR_Ping1D](INFO): uninitialize
2019-04-10T00:56:03.970Z,1554857763.970 [BR_Ping1D](INFO): Powering down
2019-04-10T00:56:04.373Z,1554857764.373 [BR_Ping1D](INFO): Stopping
2019-04-10T00:56:04.789Z,1554857764.789 [BR_Ping1D](INFO): Stopping
2019-04-10T00:56:05.181Z,1554857765.181 [BR_Ping1D](INFO): Stopped
2019-04-10T00:56:05.215Z,1554857765.215 [CBIT](INFO): Clearing failed state for component BR_Ping1D
2019-04-10T00:56:05.215Z,1554857765.215 [BR_Ping1D] No Fault, FailCount= 2
2019-04-10T00:56:05.586Z,1554857765.586 [BR_Ping1D](INFO): Start
2019-04-10T00:56:05.989Z,1554857765.989 [BR_Ping1D](INFO): Starting
2019-04-10T00:56:06.394Z,1554857766.394 [BR_Ping1D](INFO): Starting
2019-04-10T00:56:06.394Z,1554857766.394 [BR_Ping1D](INFO): readConfig
2019-04-10T00:56:06.394Z,1554857766.394 [BR_Ping1D](INFO): startup: 0
2019-04-10T00:56:06.394Z,1554857766.394 [BR_Ping1D](INFO): UART setting parameters ...
2019-04-10T00:56:06.406Z,1554857766.406 [BR_Ping1D](INFO): 42520200EC030000F4017A02
2019-04-10T00:56:06.406Z,1554857766.406 [BR_Ping1D](INFO): XXX autoMode1: 

2019-04-10T00:56:06.406Z,1554857766.406 [BR_Ping1D](INFO): XXX autoMode2: 
2019-04-10T00:56:06.406Z,1554857766.406 [BR_Ping1D](INFO): XXX autoMode3: 1
2019-04-10T00:56:06.407Z,1554857766.407 [BR_Ping1D](INFO): 42520100EB030000840100
2019-04-10T00:56:06.407Z,1554857766.407 [BR_Ping1D](INFO): 42520400EA03000060E31600DE02
2019-04-10T00:56:06.407Z,1554857766.407 [BR_Ping1D](INFO): 42520100EE030000870116
2019-04-10T00:56:06.797Z,1554857766.797 [BR_Ping1D](INFO): Starting
2019-04-10T00:56:07.201Z,1554857767.201 [BR_Ping1D](INFO): Starting
2019-04-10T00:56:07.201Z,1554857767.201 [BR_Ping1D](INFO): readConfig
2019-04-10T00:56:07.202Z,1554857767.202 [BR_Ping1D](INFO): startup: 1
2019-04-10T00:56:07.202Z,1554857767.202 [BR_Ping1D](INFO): UART requesting status
2019-04-10T00:56:07.202Z,1554857767.202 [BR_Ping1D](INFO): 42520000BA0400005201
2019-04-10T00:56:07.210Z,1554857767.210 [BR_Ping1D](INFO): 42520000BF0400005701
2019-04-10T00:56:07.218Z,1554857767.218 [BR_Ping1D](INFO): 42520000B30400004B01
2019-04-10T00:56:07.605Z,1554857767.605 [BR_Ping1D](INFO): Starting
2019-04-10T00:56:07.605Z,1554857767.605 [BR_Ping1D](INFO): readConfig
2019-04-10T00:56:07.606Z,1554857767.606 [BR_Ping1D](INFO): startup: 2
2019-04-10T00:56:07.606Z,1554857767.606 [BR_Ping1D](INFO): UART waiting for response
2019-04-10T00:56:07.606Z,1554857767.606 [BR_Ping1D](INFO): elapsed 1.2114
2019-04-10T00:56:07.606Z,1554857767.606 [BR_Ping1D](INFO): timeout 5.0000
2019-04-10T00:56:07.607Z,1554857767.606 [BR_Ping1D](INFO): No UART data
2019-04-10T00:56:07.607Z,1554857767.607 [BR_Ping1D](INFO): received UART packets: 0
2019-04-10T00:56:07.607Z,1554857767.607 [BR_Ping1D](INFO): not all values verified yet
2019-04-10T00:56:08.010Z,1554857768.010 [BR_Ping1D](INFO): Starting
2019-04-10T00:56:08.010Z,1554857768.010 [BR_Ping1D](INFO): readConfig
2019-04-10T00:56:08.010Z,1554857768.010 [BR_Ping1D](INFO): startup: 2
2019-04-10T00:56:08.010Z,1554857768.010 [BR_Ping1D](INFO): UART waiting for response
2019-04-10T00:56:08.010Z,1554857768.010 [BR_Ping1D](INFO): elapsed 1.6157
2019-04-10T00:56:08.011Z,1554857768.011 [BR_Ping1D](INFO): timeout 5.0000
2019-04-10T00:56:08.011Z,1554857768.011 [BR_Ping1D](INFO): No UART data
2019-04-10T00:56:08.011Z,1554857768.011 [BR_Ping1D](INFO): received UART packets: 0
2019-04-10T00:56:08.011Z,1554857768.011 [BR_Ping1D](INFO): not all values verified yet
2019-04-10T00:56:08.418Z,1554857768.418 [BR_Ping1D](INFO): Starting
2019-04-10T00:56:08.418Z,1554857768.418 [BR_Ping1D](INFO): readConfig
2019-04-10T00:56:08.419Z,1554857768.419 [BR_Ping1D](INFO): startup: 2
2019-04-10T00:56:08.419Z,1554857768.419 [BR_Ping1D](INFO): UART waiting for response
2019-04-10T00:56:08.419Z,1554857768.419 [BR_Ping1D](INFO): elapsed 2.0244
2019-04-10T00:56:08.419Z,1554857768.419 [BR_Ping1D](INFO): timeout 5.0000
2019-04-10T00:56:08.419Z,1554857768.419 [BR_Ping1D](INFO): No UART data
2019-04-10T00:56:08.420Z,1554857768.420 [BR_Ping1D](INFO): received UART packets: 0
2019-04-10T00:56:08.420Z,1554857768.420 [BR_Ping1D](INFO): not all values verified yet
2019-04-10T00:56:08.818Z,1554857768.818 [BR_Ping1D](INFO): Starting
2019-04-10T00:56:08.818Z,1554857768.818 [BR_Ping1D](INFO): readConfig
2019-04-10T00:56:08.818Z,1554857768.818 [BR_Ping1D](INFO): startup: 2
2019-04-10T00:56:08.818Z,1554857768.818 [BR_Ping1D](INFO): UART waiting for response
2019-04-10T00:56:08.819Z,1554857768.819 [BR_Ping1D](INFO): elapsed 2.4239
2019-04-10T00:56:08.819Z,1554857768.819 [BR_Ping1D](INFO): timeout 5.0000
2019-04-10T00:56:08.819Z,1554857768.819 [BR_Ping1D](INFO): No UART data
2019-04-10T00:56:08.819Z,1554857768.819 [BR_Ping1D](INFO): received UART packets: 0
2019-04-10T00:56:08.819Z,1554857768.819 [BR_Ping1D](INFO): not all values verified yet
2019-04-10T00:56:09.222Z,1554857769.222 [BR_Ping1D](INFO): Starting
2019-04-10T00:56:09.222Z,1554857769.222 [BR_Ping1D](INFO): readConfig
2019-04-10T00:56:09.223Z,1554857769.223 [BR_Ping1D](INFO): startup: 2
2019-04-10T00:56:09.223Z,1554857769.223 [BR_Ping1D](INFO): UART waiting for response
2019-04-10T00:56:09.223Z,1554857769.223 [BR_Ping1D](INFO): elapsed 2.8284
2019-04-10T00:56:09.223Z,1554857769.223 [BR_Ping1D](INFO): timeout 5.0000
2019-04-10T00:56:09.223Z,1554857769.223 [BR_Ping1D](INFO): No UART data
2019-04-10T00:56:09.224Z,1554857769.224 [BR_Ping1D](INFO): received UART packets: 0
2019-04-10T00:56:09.224Z,1554857769.224 [BR_Ping1D](INFO): not all values verified yet
2019-04-10T00:56:09.626Z,1554857769.626 [BR_Ping1D](INFO): Starting
2019-04-10T00:56:09.627Z,1554857769.627 [BR_Ping1D](INFO): readConfig
2019-04-10T00:56:09.627Z,1554857769.627 [BR_Ping1D](INFO): startup: 2
2019-04-10T00:56:09.627Z,1554857769.627 [BR_Ping1D](INFO): UART waiting for response
2019-04-10T00:56:09.627Z,1554857769.627 [BR_Ping1D](INFO): elapsed 3.2325
2019-04-10T00:56:09.627Z,1554857769.627 [BR_Ping1D](INFO): timeout 5.0000
2019-04-10T00:56:09.628Z,1554857769.628 [BR_Ping1D](INFO): No UART data
2019-04-10T00:56:09.628Z,1554857769.628 [BR_Ping1D](INFO): received UART packets: 0
2019-04-10T00:56:09.628Z,1554857769.628 [BR_Ping1D](INFO): not all values verified yet
2019-04-10T00:56:10.011Z,1554857770.011 [AcousticModem_Benthos_ATM900](FAULT): failed to initialize, no bytes available on serial interface
2019-04-10T00:56:10.011Z,1554857770.011 [AcousticModem_Benthos_ATM900] Communications Fault, FailCount= 1
2019-04-10T00:56:10.011Z,1554857770.011 [AcousticModem_Benthos_ATM900](ERROR): Communications Fault
2019-04-10T00:56:10.029Z,1554857770.029 [BR_Ping1D](INFO): Starting
2019-04-10T00:56:10.029Z,1554857770.029 [BR_Ping1D](INFO): readConfig
2019-04-10T00:56:10.030Z,1554857770.030 [BR_Ping1D](INFO): startup: 2
2019-04-10T00:56:10.030Z,1554857770.030 [BR_Ping1D](INFO): UART waiting for response
2019-04-10T00:56:10.030Z,1554857770.030 [BR_Ping1D](INFO): elapsed 3.6354
2019-04-10T00:56:10.030Z,1554857770.030 [BR_Ping1D](INFO): timeout 5.0000
2019-04-10T00:56:10.030Z,1554857770.030 [BR_Ping1D](INFO): No UART data
2019-04-10T00:56:10.031Z,1554857770.031 [BR_Ping1D](INFO): received UART packets: 0
2019-04-10T00:56:10.031Z,1554857770.031 [BR_Ping1D](INFO): not all values verified yet
2019-04-10T00:56:10.047Z,1554857770.047 [CBIT](ERROR): Communications Fault in component: AcousticModem_Benthos_ATM900
2019-04-10T00:56:10.415Z,1554857770.415 [AcousticModem_Benthos_ATM900](INFO): Powering down
2019-04-10T00:56:10.574Z,1554857770.574 [BR_Ping1D](INFO): Starting
2019-04-10T00:56:10.574Z,1554857770.574 [BR_Ping1D](INFO): readConfig
2019-04-10T00:56:10.574Z,1554857770.574 [BR_Ping1D](INFO): startup: 2
2019-04-10T00:56:10.574Z,1554857770.574 [BR_Ping1D](INFO): UART waiting for response
2019-04-10T00:56:10.575Z,1554857770.575 [BR_Ping1D](INFO): elapsed 4.1799
2019-04-10T00:56:10.575Z,1554857770.575 [BR_Ping1D](INFO): timeout 5.0000
2019-04-10T00:56:10.575Z,1554857770.575 [BR_Ping1D](INFO): No UART data
2019-04-10T00:56:10.575Z,1554857770.575 [BR_Ping1D](INFO): received UART packets: 0
2019-04-10T00:56:10.575Z,1554857770.575 [BR_Ping1D](INFO): not all values verified yet
2019-04-10T00:56:10.838Z,1554857770.838 [BR_Ping1D](INFO): Starting
2019-04-10T00:56:10.838Z,1554857770.838 [BR_Ping1D](INFO): readConfig
2019-04-10T00:56:10.839Z,1554857770.839 [BR_Ping1D](INFO): startup: 2
2019-04-10T00:56:10.839Z,1554857770.839 [BR_Ping1D](INFO): UART waiting for response
2019-04-10T00:56:10.839Z,1554857770.839 [BR_Ping1D](INFO): elapsed 4.4444
2019-04-10T00:56:10.839Z,1554857770.839 [BR_Ping1D](INFO): timeout 5.0000
2019-04-10T00:56:10.839Z,1554857770.839 [BR_Ping1D](INFO): No UART data
2019-04-10T00:56:10.840Z,1554857770.840 [BR_Ping1D](INFO): received UART packets: 0
2019-04-10T00:56:10.840Z,1554857770.840 [BR_Ping1D](INFO): not all values verified yet
2019-04-10T00:56:11.222Z,1554857771.222 [Aanderaa_O2](FAULT): Failed to initialize within timeout.
2019-04-10T00:56:11.222Z,1554857771.222 [Aanderaa_O2] Communications Fault, FailCount= 2
2019-04-10T00:56:11.222Z,1554857771.222 [Aanderaa_O2](ERROR): Communications Fault
2019-04-10T00:56:11.241Z,1554857771.241 [BR_Ping1D](INFO): Starting
2019-04-10T00:56:11.242Z,1554857771.242 [BR_Ping1D](INFO): readConfig
2019-04-10T00:56:11.242Z,1554857771.242 [BR_Ping1D](INFO): startup: 2
2019-04-10T00:56:11.242Z,1554857771.242 [BR_Ping1D](INFO): UART waiting for response
2019-04-10T00:56:11.242Z,1554857771.242 [BR_Ping1D](INFO): elapsed 4.8476
2019-04-10T00:56:11.242Z,1554857771.242 [BR_Ping1D](INFO): timeout 5.0000
2019-04-10T00:56:11.243Z,1554857771.243 [BR_Ping1D](INFO): No UART data
2019-04-10T00:56:11.243Z,1554857771.243 [BR_Ping1D](INFO): received UART packets: 0
2019-04-10T00:56:11.243Z,1554857771.243 [BR_Ping1D](INFO): not all values verified yet
2019-04-10T00:56:11.271Z,1554857771.271 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2019-04-10T00:56:11.271Z,1554857771.271 [CBIT](INFO): Clearing failed state for component AcousticModem_Benthos_ATM900
2019-04-10T00:56:11.271Z,1554857771.271 [AcousticModem_Benthos_ATM900] No Fault, FailCount= 1
2019-04-10T00:56:11.746Z,1554857771.746 [Aanderaa_O2](INFO): Powering down
2019-04-10T00:56:11.765Z,1554857771.765 [BR_Ping1D](INFO): Starting
2019-04-10T00:56:11.766Z,1554857771.766 [BR_Ping1D](INFO): readConfig
2019-04-10T00:56:11.766Z,1554857771.766 [BR_Ping1D](INFO): startup: 2
2019-04-10T00:56:11.766Z,1554857771.766 [BR_Ping1D](INFO): UART waiting for response
2019-04-10T00:56:11.766Z,1554857771.766 [BR_Ping1D](INFO): elapsed 5.3716
2019-04-10T00:56:11.766Z,1554857771.766 [BR_Ping1D](INFO): timeout 5.0000
2019-04-10T00:56:11.767Z,1554857771.767 [BR_Ping1D](FAULT): Failed to set parameters in time during initialization.
2019-04-10T00:56:11.767Z,1554857771.767 [BR_Ping1D] Data Fault, FailCount= 3
2019-04-10T00:56:11.767Z,1554857771.767 [BR_Ping1D](ERROR): Data Fault
2019-04-10T00:56:11.795Z,1554857771.795 [CBIT](ERROR): Data Fault in component: BR_Ping1D
2019-04-10T00:56:12.049Z,1554857772.049 [BR_Ping1D](INFO): Stop
2019-04-10T00:56:12.050Z,1554857772.050 [BR_Ping1D](INFO): uninitialize
2019-04-10T00:56:12.050Z,1554857772.050 [BR_Ping1D](INFO): Powering down
2019-04-10T00:56:12.455Z,1554857772.455 [BR_Ping1D](INFO): Stopping
2019-04-10T00:56:12.483Z,1554857772.483 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2019-04-10T00:56:12.483Z,1554857772.483 [Aanderaa_O2] No Fault, FailCount= 2
2019-04-10T00:56:12.869Z,1554857772.869 [BR_Ping1D](INFO): Stopping
2019-04-10T00:56:13.276Z,1554857773.276 [BR_Ping1D](INFO): Stopped
2019-04-10T00:56:13.288Z,1554857773.288 [SBIT](IMPORTANT): Beginning Startup BIT
2019-04-10T00:56:13.292Z,1554857773.292 [CBIT](INFO): Clearing failed state for component BR_Ping1D
2019-04-10T00:56:13.292Z,1554857773.292 [BR_Ping1D] No Fault, FailCount= 3
2019-04-10T00:56:13.293Z,1554857773.293 [CBIT](IMPORTANT): Beginning ground fault scan
2019-04-10T00:56:13.647Z,1554857773.647 [AcousticModem_Benthos_ATM900](INFO): Powering up
2019-04-10T00:56:13.647Z,1554857773.647 [AcousticModem_Benthos_ATM900](DEBUG): Initializing AcousticModem_Benthos_ATM900.
2019-04-10T00:56:13.682Z,1554857773.682 [BR_Ping1D](INFO): Start
2019-04-10T00:56:14.069Z,1554857774.069 [BR_Ping1D](INFO): Starting
2019-04-10T00:56:14.474Z,1554857774.474 [BR_Ping1D](INFO): Starting
2019-04-10T00:56:14.474Z,1554857774.474 [BR_Ping1D](INFO): readConfig
2019-04-10T00:56:14.474Z,1554857774.474 [BR_Ping1D](INFO): startup: 0
2019-04-10T00:56:14.474Z,1554857774.474 [BR_Ping1D](INFO): UART setting parameters ...
2019-04-10T00:56:14.486Z,1554857774.486 [BR_Ping1D](INFO): 42520200EC030000F4017A02
2019-04-10T00:56:14.487Z,1554857774.487 [BR_Ping1D](INFO): XXX autoMode1: 

2019-04-10T00:56:14.487Z,1554857774.487 [BR_Ping1D](INFO): XXX autoMode2: 
2019-04-10T00:56:14.487Z,1554857774.487 [BR_Ping1D](INFO): XXX autoMode3: 1
2019-04-10T00:56:14.487Z,1554857774.487 [BR_Ping1D](INFO): 42520100EB030000840100
2019-04-10T00:56:14.487Z,1554857774.487 [BR_Ping1D](INFO): 42520400EA03000060E31600DE02
2019-04-10T00:56:14.488Z,1554857774.488 [BR_Ping1D](INFO): 42520100EE030000870116
2019-04-10T00:56:14.877Z,1554857774.877 [BR_Ping1D](INFO): Starting
2019-04-10T00:56:15.281Z,1554857775.281 [BR_Ping1D](INFO): Starting
2019-04-10T00:56:15.282Z,1554857775.282 [BR_Ping1D](INFO): readConfig
2019-04-10T00:56:15.282Z,1554857775.282 [BR_Ping1D](INFO): startup: 1
2019-04-10T00:56:15.282Z,1554857775.282 [BR_Ping1D](INFO): UART requesting status
2019-04-10T00:56:15.282Z,1554857775.282 [BR_Ping1D](INFO): 42520000BA0400005201
2019-04-10T00:56:15.290Z,1554857775.290 [BR_Ping1D](INFO): 42520000BF0400005701
2019-04-10T00:56:15.298Z,1554857775.298 [BR_Ping1D](INFO): 42520000B30400004B01
2019-04-10T00:56:15.694Z,1554857775.694 [BR_Ping1D](INFO): Starting
2019-04-10T00:56:15.694Z,1554857775.694 [BR_Ping1D](INFO): readConfig
2019-04-10T00:56:15.694Z,1554857775.694 [BR_Ping1D](INFO): startup: 2
2019-04-10T00:56:15.694Z,1554857775.694 [BR_Ping1D](INFO): UART waiting for response
2019-04-10T00:56:15.694Z,1554857775.694 [BR_Ping1D](INFO): elapsed 1.2199
2019-04-10T00:56:15.695Z,1554857775.695 [BR_Ping1D](INFO): timeout 5.0000
2019-04-10T00:56:15.695Z,1554857775.695 [BR_Ping1D](INFO): No UART data
2019-04-10T00:56:15.695Z,1554857775.695 [BR_Ping1D](INFO): received UART packets: 0
2019-04-10T00:56:15.695Z,1554857775.695 [BR_Ping1D](INFO): not all values verified yet
2019-04-10T00:56:16.276Z,1554857776.276 [NAL9602](INFO): Powering up NAL9602
2019-04-10T00:56:16.292Z,1554857776.292 [BR_Ping1D](INFO): Starting
2019-04-10T00:56:16.292Z,1554857776.292 [BR_Ping1D](INFO): readConfig
2019-04-10T00:56:16.292Z,1554857776.292 [BR_Ping1D](INFO): startup: 2
2019-04-10T00:56:16.292Z,1554857776.292 [BR_Ping1D](INFO): UART waiting for response
2019-04-10T00:56:16.292Z,1554857776.292 [BR_Ping1D](INFO): elapsed 1.8179
2019-04-10T00:56:16.293Z,1554857776.293 [BR_Ping1D](INFO): timeout 5.0000
2019-04-10T00:56:16.293Z,1554857776.293 [BR_Ping1D](INFO): No UART data
2019-04-10T00:56:16.293Z,1554857776.293 [BR_Ping1D](INFO): received UART packets: 0
2019-04-10T00:56:16.293Z,1554857776.293 [BR_Ping1D](INFO): not all values verified yet
2019-04-10T00:56:16.658Z,1554857776.658 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2019-04-10T00:56:16.658Z,1554857776.658 [CTD_Seabird] Communications Fault, FailCount= 2
2019-04-10T00:56:16.658Z,1554857776.658 [CTD_Seabird](ERROR): Communications Fault
2019-04-10T00:56:16.682Z,1554857776.682 [BR_Ping1D](INFO): Starting
2019-04-10T00:56:16.683Z,1554857776.683 [BR_Ping1D](INFO): readConfig
2019-04-10T00:56:16.683Z,1554857776.683 [BR_Ping1D](INFO): startup: 2
2019-04-10T00:56:16.683Z,1554857776.683 [BR_Ping1D](INFO): UART waiting for response
2019-04-10T00:56:16.683Z,1554857776.683 [BR_Ping1D](INFO): elapsed 2.2087
2019-04-10T00:56:16.683Z,1554857776.683 [BR_Ping1D](INFO): timeout 5.0000
2019-04-10T00:56:16.684Z,1554857776.684 [BR_Ping1D](INFO): No UART data
2019-04-10T00:56:16.684Z,1554857776.684 [BR_Ping1D](INFO): received UART packets: 0
2019-04-10T00:56:16.684Z,1554857776.684 [BR_Ping1D](INFO): not all values verified yet
2019-04-10T00:56:16.827Z,1554857776.827 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2019-04-10T00:56:17.062Z,1554857777.062 [CTD_Seabird](INFO): Powering down
2019-04-10T00:56:17.087Z,1554857777.087 [BR_Ping1D](INFO): Starting
2019-04-10T00:56:17.087Z,1554857777.087 [BR_Ping1D](INFO): readConfig
2019-04-10T00:56:17.087Z,1554857777.087 [BR_Ping1D](INFO): startup: 2
2019-04-10T00:56:17.087Z,1554857777.087 [BR_Ping1D](INFO): UART waiting for response
2019-04-10T00:56:17.088Z,1554857777.088 [BR_Ping1D](INFO): elapsed 2.6133
2019-04-10T00:56:17.088Z,1554857777.088 [BR_Ping1D](INFO): timeout 5.0000
2019-04-10T00:56:17.088Z,1554857777.088 [BR_Ping1D](INFO): No UART data
2019-04-10T00:56:17.088Z,1554857777.088 [BR_Ping1D](INFO): received UART packets: 0
2019-04-10T00:56:17.088Z,1554857777.088 [BR_Ping1D](INFO): not all values verified yet
2019-04-10T00:56:17.481Z,1554857777.481 [BR_Ping1D](INFO): Starting
2019-04-10T00:56:17.481Z,1554857777.481 [BR_Ping1D](INFO): readConfig
2019-04-10T00:56:17.482Z,1554857777.482 [BR_Ping1D](INFO): startup: 2
2019-04-10T00:56:17.482Z,1554857777.482 [BR_Ping1D](INFO): UART waiting for response
2019-04-10T00:56:17.482Z,1554857777.482 [BR_Ping1D](INFO): elapsed 3.0076
2019-04-10T00:56:17.482Z,1554857777.482 [BR_Ping1D](INFO): timeout 5.0000
2019-04-10T00:56:17.482Z,1554857777.482 [BR_Ping1D](INFO): No UART data
2019-04-10T00:56:17.483Z,1554857777.483 [BR_Ping1D](INFO): received UART packets: 0
2019-04-10T00:56:17.483Z,1554857777.483 [BR_Ping1D](INFO): not all values verified yet
2019-04-10T00:56:17.886Z,1554857777.886 [BR_Ping1D](INFO): Starting
2019-04-10T00:56:17.886Z,1554857777.886 [BR_Ping1D](INFO): readConfig
2019-04-10T00:56:17.886Z,1554857777.886 [BR_Ping1D](INFO): startup: 2
2019-04-10T00:56:17.887Z,1554857777.887 [BR_Ping1D](INFO): UART waiting for response
2019-04-10T00:56:17.887Z,1554857777.887 [BR_Ping1D](INFO): elapsed 3.4124
2019-04-10T00:56:17.887Z,1554857777.887 [BR_Ping1D](INFO): timeout 5.0000
2019-04-10T00:56:17.887Z,1554857777.887 [BR_Ping1D](INFO): No UART data
2019-04-10T00:56:17.887Z,1554857777.887 [BR_Ping1D](INFO): received UART packets: 0
2019-04-10T00:56:17.887Z,1554857777.887 [BR_Ping1D](INFO): not all values verified yet
2019-04-10T00:56:18.003Z,1554857778.003 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2019-04-10T00:56:18.003Z,1554857778.003 [CTD_Seabird] No Fault, FailCount= 2
2019-04-10T00:56:18.289Z,1554857778.289 [BR_Ping1D](INFO): Starting
2019-04-10T00:56:18.289Z,1554857778.289 [BR_Ping1D](INFO): readConfig
2019-04-10T00:56:18.290Z,1554857778.290 [BR_Ping1D](INFO): startup: 2
2019-04-10T00:56:18.290Z,1554857778.290 [BR_Ping1D](INFO): UART waiting for response
2019-04-10T00:56:18.290Z,1554857778.290 [BR_Ping1D](INFO): elapsed 3.8155
2019-04-10T00:56:18.290Z,1554857778.290 [BR_Ping1D](INFO): timeout 5.0000
2019-04-10T00:56:18.290Z,1554857778.290 [BR_Ping1D](INFO): No UART data
2019-04-10T00:56:18.291Z,1554857778.291 [BR_Ping1D](INFO): received UART packets: 0
2019-04-10T00:56:18.291Z,1554857778.291 [BR_Ping1D](INFO): not all values verified yet
2019-04-10T00:56:18.406Z,1554857778.406 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2019-04-10T00:56:18.408Z,1554857778.408 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20
2019-04-10T00:56:18.695Z,1554857778.695 [BR_Ping1D](INFO): Starting
2019-04-10T00:56:18.695Z,1554857778.695 [BR_Ping1D](INFO): readConfig
2019-04-10T00:56:18.695Z,1554857778.695 [BR_Ping1D](INFO): startup: 2
2019-04-10T00:56:18.695Z,1554857778.695 [BR_Ping1D](INFO): UART waiting for response
2019-04-10T00:56:18.696Z,1554857778.696 [BR_Ping1D](INFO): elapsed 4.2212
2019-04-10T00:56:18.696Z,1554857778.696 [BR_Ping1D](INFO): timeout 5.0000
2019-04-10T00:56:18.696Z,1554857778.696 [BR_Ping1D](INFO): No UART data
2019-04-10T00:56:18.696Z,1554857778.696 [BR_Ping1D](INFO): received UART packets: 0
2019-04-10T00:56:18.696Z,1554857778.696 [BR_Ping1D](INFO): not all values verified yet
2019-04-10T00:56:19.100Z,1554857779.100 [BR_Ping1D](INFO): Starting
2019-04-10T00:56:19.100Z,1554857779.100 [BR_Ping1D](INFO): readConfig
2019-04-10T00:56:19.100Z,1554857779.100 [BR_Ping1D](INFO): startup: 2
2019-04-10T00:56:19.100Z,1554857779.100 [BR_Ping1D](INFO): UART waiting for response
2019-04-10T00:56:19.100Z,1554857779.100 [BR_Ping1D](INFO): elapsed 4.6258
2019-04-10T00:56:19.100Z,1554857779.100 [BR_Ping1D](INFO): timeout 5.0000
2019-04-10T00:56:19.101Z,1554857779.101 [BR_Ping1D](INFO): No UART data
2019-04-10T00:56:19.101Z,1554857779.101 [BR_Ping1D](INFO): received UART packets: 0
2019-04-10T00:56:19.101Z,1554857779.101 [BR_Ping1D](INFO): not all values verified yet
2019-04-10T00:56:19.502Z,1554857779.502 [BR_Ping1D](INFO): Starting
2019-04-10T00:56:19.502Z,1554857779.502 [BR_Ping1D](INFO): readConfig
2019-04-10T00:56:19.502Z,1554857779.502 [BR_Ping1D](INFO): startup: 2
2019-04-10T00:56:19.503Z,1554857779.503 [BR_Ping1D](INFO): UART waiting for response
2019-04-10T00:56:19.503Z,1554857779.503 [BR_Ping1D](INFO): elapsed 5.0283
2019-04-10T00:56:19.503Z,1554857779.503 [BR_Ping1D](INFO): timeout 5.0000
2019-04-10T00:56:19.503Z,1554857779.503 [BR_Ping1D](FAULT): Failed to set parameters in time during initialization.
2019-04-10T00:56:19.503Z,1554857779.503 [BR_Ping1D] Data Fault, FailCount= 4
2019-04-10T00:56:19.503Z,1554857779.503 [BR_Ping1D](ERROR): Data Fault
2019-04-10T00:56:19.599Z,1554857779.599 [CBIT](ERROR): Data Fault in component: BR_Ping1D
2019-04-10T00:56:19.902Z,1554857779.902 [BR_Ping1D](INFO): Stop
2019-04-10T00:56:19.902Z,1554857779.902 [BR_Ping1D](INFO): uninitialize
2019-04-10T00:56:19.903Z,1554857779.903 [BR_Ping1D](INFO): Powering down
2019-04-10T00:56:20.307Z,1554857780.307 [BR_Ping1D](INFO): Stopping
2019-04-10T00:56:20.713Z,1554857780.713 [BR_Ping1D](INFO): Stopping
2019-04-10T00:56:21.117Z,1554857781.117 [BR_Ping1D](INFO): Stopped
2019-04-10T00:56:21.203Z,1554857781.203 [CBIT](INFO): Clearing failed state for component BR_Ping1D
2019-04-10T00:56:21.203Z,1554857781.203 [BR_Ping1D] No Fault, FailCount= 4
2019-04-10T00:56:21.521Z,1554857781.521 [BR_Ping1D](INFO): Start
2019-04-10T00:56:21.927Z,1554857781.927 [BR_Ping1D](INFO): Starting
2019-04-10T00:56:22.332Z,1554857782.332 [BR_Ping1D](INFO): Starting
2019-04-10T00:56:22.332Z,1554857782.332 [BR_Ping1D](INFO): readConfig
2019-04-10T00:56:22.332Z,1554857782.332 [BR_Ping1D](INFO): startup: 0
2019-04-10T00:56:22.332Z,1554857782.332 [BR_Ping1D](INFO): UART setting parameters ...
2019-04-10T00:56:22.346Z,1554857782.346 [BR_Ping1D](INFO): 42520200EC030000F4017A02
2019-04-10T00:56:22.346Z,1554857782.346 [BR_Ping1D](INFO): XXX autoMode1: 

2019-04-10T00:56:22.346Z,1554857782.346 [BR_Ping1D](INFO): XXX autoMode2: 
2019-04-10T00:56:22.346Z,1554857782.346 [BR_Ping1D](INFO): XXX autoMode3: 1
2019-04-10T00:56:22.347Z,1554857782.347 [BR_Ping1D](INFO): 42520100EB030000840100
2019-04-10T00:56:22.347Z,1554857782.347 [BR_Ping1D](INFO): 42520400EA03000060E31600DE02
2019-04-10T00:56:22.347Z,1554857782.347 [BR_Ping1D](INFO): 42520100EE030000870116
2019-04-10T00:56:22.733Z,1554857782.733 [BR_Ping1D](INFO): Starting
2019-04-10T00:56:23.118Z,1554857783.118 [Aanderaa_O2](FAULT): Failed to initialize within timeout.
2019-04-10T00:56:23.118Z,1554857783.118 [Aanderaa_O2] Communications Fault, FailCount= 3
2019-04-10T00:56:23.118Z,1554857783.118 [Aanderaa_O2](ERROR): Communications Fault
2019-04-10T00:56:23.137Z,1554857783.137 [BR_Ping1D](INFO): Starting
2019-04-10T00:56:23.137Z,1554857783.137 [BR_Ping1D](INFO): readConfig
2019-04-10T00:56:23.138Z,1554857783.138 [BR_Ping1D](INFO): startup: 1
2019-04-10T00:56:23.138Z,1554857783.138 [BR_Ping1D](INFO): UART requesting status
2019-04-10T00:56:23.138Z,1554857783.138 [BR_Ping1D](INFO): 42520000BA0400005201
2019-04-10T00:56:23.146Z,1554857783.146 [BR_Ping1D](INFO): 42520000BF0400005701
2019-04-10T00:56:23.154Z,1554857783.154 [BR_Ping1D](INFO): 42520000B30400004B01
2019-04-10T00:56:23.235Z,1554857783.235 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2019-04-10T00:56:23.235Z,1554857783.235 [CBIT](FAULT): Communications Fault in component: Aanderaa_O2
2019-04-10T00:56:23.642Z,1554857783.642 [Aanderaa_O2](INFO): Powering down
2019-04-10T00:56:23.662Z,1554857783.662 [BR_Ping1D](INFO): Starting
2019-04-10T00:56:23.662Z,1554857783.662 [BR_Ping1D](INFO): readConfig
2019-04-10T00:56:23.662Z,1554857783.662 [BR_Ping1D](INFO): startup: 2
2019-04-10T00:56:23.662Z,1554857783.662 [BR_Ping1D](INFO): UART waiting for response
2019-04-10T00:56:23.663Z,1554857783.663 [BR_Ping1D](INFO): elapsed 1.3304
2019-04-10T00:56:23.663Z,1554857783.663 [BR_Ping1D](INFO): timeout 5.0000
2019-04-10T00:56:23.663Z,1554857783.663 [BR_Ping1D](INFO): No UART data
2019-04-10T00:56:23.663Z,1554857783.663 [BR_Ping1D](INFO): received UART packets: 0
2019-04-10T00:56:23.663Z,1554857783.663 [BR_Ping1D](INFO): not all values verified yet
2019-04-10T00:56:23.945Z,1554857783.945 [BR_Ping1D](INFO): Starting
2019-04-10T00:56:23.945Z,1554857783.945 [BR_Ping1D](INFO): readConfig
2019-04-10T00:56:23.945Z,1554857783.945 [BR_Ping1D](INFO): startup: 2
2019-04-10T00:56:23.946Z,1554857783.946 [BR_Ping1D](INFO): UART waiting for response
2019-04-10T00:56:23.946Z,1554857783.946 [BR_Ping1D](INFO): elapsed 1.6135
2019-04-10T00:56:23.946Z,1554857783.946 [BR_Ping1D](INFO): timeout 5.0000
2019-04-10T00:56:23.946Z,1554857783.946 [BR_Ping1D](INFO): No UART data
2019-04-10T00:56:23.946Z,1554857783.946 [BR_Ping1D](INFO): received UART packets: 0
2019-04-10T00:56:23.947Z,1554857783.947 [BR_Ping1D](INFO): not all values verified yet
2019-04-10T00:56:24.019Z,1554857784.019 [CBIT](IMPORTANT): Ground fault detected
mA:
CHAN A0 (Batt): -0.006714
CHAN A1 (24V): -0.127484
CHAN A2 (12V): -0.005143
CHAN A3 (5V): -0.002272
CHAN B0 (3.3V): -0.000646
CHAN B1 (3.15aV): -0.000873
CHAN B2 (3.15bV): -0.000799
CHAN B3 (GND): -0.000047
OPEN: -0.000651
Full Scale Calc: 4.765 mA, -1.589 mA
2019-04-10T00:56:24.349Z,1554857784.349 [BR_Ping1D](INFO): Starting
2019-04-10T00:56:24.350Z,1554857784.350 [BR_Ping1D](INFO): readConfig
2019-04-10T00:56:24.350Z,1554857784.350 [BR_Ping1D](INFO): startup: 2
2019-04-10T00:56:24.350Z,1554857784.350 [BR_Ping1D](INFO): UART waiting for response
2019-04-10T00:56:24.350Z,1554857784.350 [BR_Ping1D](INFO): elapsed 2.0180
2019-04-10T00:56:24.350Z,1554857784.350 [BR_Ping1D](INFO): timeout 5.0000
2019-04-10T00:56:24.351Z,1554857784.351 [BR_Ping1D](INFO): No UART data
2019-04-10T00:56:24.351Z,1554857784.351 [BR_Ping1D](INFO): received UART packets: 0
2019-04-10T00:56:24.351Z,1554857784.351 [BR_Ping1D](INFO): not all values verified yet
2019-04-10T00:56:24.753Z,1554857784.753 [BR_Ping1D](INFO): Starting
2019-04-10T00:56:24.753Z,1554857784.753 [BR_Ping1D](INFO): readConfig
2019-04-10T00:56:24.753Z,1554857784.753 [BR_Ping1D](INFO): startup: 2
2019-04-10T00:56:24.754Z,1554857784.754 [BR_Ping1D](INFO): UART waiting for response
2019-04-10T00:56:24.754Z,1554857784.754 [BR_Ping1D](INFO): elapsed 2.4216
2019-04-10T00:56:24.754Z,1554857784.754 [BR_Ping1D](INFO): timeout 5.0000
2019-04-10T00:56:24.754Z,1554857784.754 [BR_Ping1D](INFO): No UART data
2019-04-10T00:56:24.754Z,1554857784.754 [BR_Ping1D](INFO): received UART packets: 0
2019-04-10T00:56:24.755Z,1554857784.755 [BR_Ping1D](INFO): not all values verified yet
2019-04-10T00:56:25.157Z,1554857785.157 [BR_Ping1D](INFO): Starting
2019-04-10T00:56:25.157Z,1554857785.157 [BR_Ping1D](INFO): readConfig
2019-04-10T00:56:25.158Z,1554857785.158 [BR_Ping1D](INFO): startup: 2
2019-04-10T00:56:25.158Z,1554857785.158 [BR_Ping1D](INFO): UART waiting for response
2019-04-10T00:56:25.158Z,1554857785.158 [BR_Ping1D](INFO): elapsed 2.8259
2019-04-10T00:56:25.158Z,1554857785.158 [BR_Ping1D](INFO): timeout 5.0000
2019-04-10T00:56:25.159Z,1554857785.159 [BR_Ping1D](INFO): No UART data
2019-04-10T00:56:25.159Z,1554857785.159 [BR_Ping1D](INFO): received UART packets: 0
2019-04-10T00:56:25.159Z,1554857785.159 [BR_Ping1D](INFO): not all values verified yet
2019-04-10T00:56:25.562Z,1554857785.562 [BR_Ping1D](INFO): Starting
2019-04-10T00:56:25.562Z,1554857785.562 [BR_Ping1D](INFO): readConfig
2019-04-10T00:56:25.563Z,1554857785.563 [BR_Ping1D](INFO): startup: 2
2019-04-10T00:56:25.563Z,1554857785.563 [BR_Ping1D](INFO): UART waiting for response
2019-04-10T00:56:25.563Z,1554857785.563 [BR_Ping1D](INFO): elapsed 3.2308
2019-04-10T00:56:25.563Z,1554857785.563 [BR_Ping1D](INFO): timeout 5.0000
2019-04-10T00:56:25.563Z,1554857785.563 [BR_Ping1D](INFO): No UART data
2019-04-10T00:56:25.564Z,1554857785.564 [BR_Ping1D](INFO): received UART packets: 0
2019-04-10T00:56:25.564Z,1554857785.564 [BR_Ping1D](INFO): not all values verified yet
2019-04-10T00:56:25.969Z,1554857785.969 [BR_Ping1D](INFO): Starting
2019-04-10T00:56:25.969Z,1554857785.969 [BR_Ping1D](INFO): readConfig
2019-04-10T00:56:25.969Z,1554857785.969 [BR_Ping1D](INFO): startup: 2
2019-04-10T00:56:25.969Z,1554857785.969 [BR_Ping1D](INFO): UART waiting for response
2019-04-10T00:56:25.969Z,1554857785.969 [BR_Ping1D](INFO): elapsed 3.6372
2019-04-10T00:56:25.970Z,1554857785.970 [BR_Ping1D](INFO): timeout 5.0000
2019-04-10T00:56:25.971Z,1554857785.971 [BR_Ping1D](INFO): No UART data
2019-04-10T00:56:25.971Z,1554857785.971 [BR_Ping1D](INFO): received UART packets: 0
2019-04-10T00:56:25.971Z,1554857785.971 [BR_Ping1D](INFO): not all values verified yet
2019-04-10T00:56:26.369Z,1554857786.369 [BR_Ping1D](INFO): Starting
2019-04-10T00:56:26.369Z,1554857786.369 [BR_Ping1D](INFO): readConfig
2019-04-10T00:56:26.370Z,1554857786.370 [BR_Ping1D](INFO): startup: 2
2019-04-10T00:56:26.370Z,1554857786.370 [BR_Ping1D](INFO): UART waiting for response
2019-04-10T00:56:26.370Z,1554857786.370 [BR_Ping1D](INFO): elapsed 4.0378
2019-04-10T00:56:26.370Z,1554857786.370 [BR_Ping1D](INFO): timeout 5.0000
2019-04-10T00:56:26.370Z,1554857786.370 [BR_Ping1D](INFO): No UART data
2019-04-10T00:56:26.371Z,1554857786.371 [BR_Ping1D](INFO): received UART packets: 0
2019-04-10T00:56:26.371Z,1554857786.371 [BR_Ping1D](INFO): not all values verified yet
2019-04-10T00:56:26.785Z,1554857786.785 [BR_Ping1D](INFO): Starting
2019-04-10T00:56:26.785Z,1554857786.785 [BR_Ping1D](INFO): readConfig
2019-04-10T00:56:26.785Z,1554857786.785 [BR_Ping1D](INFO): startup: 2
2019-04-10T00:56:26.785Z,1554857786.785 [BR_Ping1D](INFO): UART waiting for response
2019-04-10T00:56:26.785Z,1554857786.785 [BR_Ping1D](INFO): elapsed 4.4531
2019-04-10T00:56:26.786Z,1554857786.786 [BR_Ping1D](INFO): timeout 5.0000
2019-04-10T00:56:26.786Z,1554857786.786 [BR_Ping1D](INFO): No UART data
2019-04-10T00:56:26.786Z,1554857786.786 [BR_Ping1D](INFO): received UART packets: 0
2019-04-10T00:56:26.786Z,1554857786.786 [BR_Ping1D](INFO): not all values verified yet
2019-04-10T00:56:27.163Z,1554857787.163 [NAL9602](INFO): NAL9602 initialized
2019-04-10T00:56:27.178Z,1554857787.178 [BR_Ping1D](INFO): Starting
2019-04-10T00:56:27.178Z,1554857787.178 [BR_Ping1D](INFO): readConfig
2019-04-10T00:56:27.178Z,1554857787.178 [BR_Ping1D](INFO): startup: 2
2019-04-10T00:56:27.178Z,1554857787.178 [BR_Ping1D](INFO): UART waiting for response
2019-04-10T00:56:27.178Z,1554857787.178 [BR_Ping1D](INFO): elapsed 4.8461
2019-04-10T00:56:27.179Z,1554857787.179 [BR_Ping1D](INFO): timeout 5.0000
2019-04-10T00:56:27.179Z,1554857787.179 [BR_Ping1D](INFO): No UART data
2019-04-10T00:56:27.179Z,1554857787.179 [BR_Ping1D](INFO): received UART packets: 0
2019-04-10T00:56:27.179Z,1554857787.179 [BR_Ping1D](INFO): not all values verified yet
2019-04-10T00:56:27.592Z,1554857787.592 [BR_Ping1D](INFO): Starting
2019-04-10T00:56:27.592Z,1554857787.592 [BR_Ping1D](INFO): readConfig
2019-04-10T00:56:27.592Z,1554857787.592 [BR_Ping1D](INFO): startup: 2
2019-04-10T00:56:27.592Z,1554857787.592 [BR_Ping1D](INFO): UART waiting for response
2019-04-10T00:56:27.592Z,1554857787.592 [BR_Ping1D](INFO): elapsed 5.2600
2019-04-10T00:56:27.592Z,1554857787.592 [BR_Ping1D](INFO): timeout 5.0000
2019-04-10T00:56:27.593Z,1554857787.593 [BR_Ping1D](FAULT): Failed to set parameters in time during initialization.
2019-04-10T00:56:27.593Z,1554857787.593 [BR_Ping1D] Data Fault, FailCount= 5
2019-04-10T00:56:27.593Z,1554857787.593 [BR_Ping1D](ERROR): Data Fault
2019-04-10T00:56:27.655Z,1554857787.655 [CBIT](ERROR): Data Fault in component: BR_Ping1D
2019-04-10T00:56:27.655Z,1554857787.655 [CBIT](CRITICAL): Data Fault in component: BR_Ping1D
2019-04-10T00:56:27.982Z,1554857787.982 [NAL9602](DEBUG): Fix Requested
2019-04-10T00:56:27.997Z,1554857787.997 [BR_Ping1D](INFO): Stop
2019-04-10T00:56:27.998Z,1554857787.998 [BR_Ping1D](INFO): uninitialize
2019-04-10T00:56:27.998Z,1554857787.998 [BR_Ping1D](INFO): Powering down
2019-04-10T00:56:28.099Z,1554857788.099 [CBIT](INFO): Critical error at 20190410T005627
2019-04-10T00:56:28.405Z,1554857788.405 [BR_Ping1D](INFO): Stopping
2019-04-10T00:56:28.813Z,1554857788.813 [BR_Ping1D](INFO): Stopping
2019-04-10T00:56:29.291Z,1554857789.291 [BR_Ping1D](INFO): Stopped
2019-04-10T00:56:31.458Z,1554857791.458 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2019-04-10T00:56:31.458Z,1554857791.458 [CTD_Seabird] Communications Fault, FailCount= 3
2019-04-10T00:56:31.458Z,1554857791.458 [CTD_Seabird](ERROR): Communications Fault
2019-04-10T00:56:31.831Z,1554857791.831 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2019-04-10T00:56:31.831Z,1554857791.831 [CBIT](FAULT): Communications Fault in component: CTD_Seabird
2019-04-10T00:56:31.862Z,1554857791.862 [CTD_Seabird](INFO): Powering down
2019-04-10T00:56:33.711Z,1554857793.711 [AcousticModem_Benthos_ATM900](FAULT): failed to initialize, no bytes available on serial interface
2019-04-10T00:56:33.711Z,1554857793.711 [AcousticModem_Benthos_ATM900] Communications Fault, FailCount= 2
2019-04-10T00:56:33.711Z,1554857793.711 [AcousticModem_Benthos_ATM900](ERROR): Communications Fault
2019-04-10T00:56:33.927Z,1554857793.927 [CBIT](ERROR): Communications Fault in component: AcousticModem_Benthos_ATM900
2019-04-10T00:56:34.114Z,1554857794.114 [AcousticModem_Benthos_ATM900](INFO): Powering down
2019-04-10T00:56:35.023Z,1554857795.023 [CBIT](INFO): Clearing failed state for component AcousticModem_Benthos_ATM900
2019-04-10T00:56:35.024Z,1554857795.024 [AcousticModem_Benthos_ATM900] No Fault, FailCount= 2
2019-04-10T00:56:37.371Z,1554857797.371 [AcousticModem_Benthos_ATM900](INFO): Powering up
2019-04-10T00:56:37.371Z,1554857797.371 [AcousticModem_Benthos_ATM900](DEBUG): Initializing AcousticModem_Benthos_ATM900.
2019-04-10T00:56:56.906Z,1554857816.906 [BPC1](ERROR): BPC1B: No match for serial number 018D in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file).
2019-04-10T00:56:57.285Z,1554857817.285 [BPC1](ERROR): BPC1A: No match for serial number 04CC in BPC1A's battery stick inventory (sticks 1-32 in onboard configuration file).
2019-04-10T00:56:57.301Z,1554857817.301 [BPC1](FAULT): Failed to parse data from all battery packs.
2019-04-10T00:56:57.301Z,1554857817.301 [BPC1] Data Fault, FailCount= 1
2019-04-10T00:56:57.301Z,1554857817.301 [BPC1](ERROR): Data Fault
2019-04-10T00:56:57.422Z,1554857817.422 [CBIT](ERROR): Data Fault in component: BPC1
2019-04-10T00:56:57.654Z,1554857817.654 [AcousticModem_Benthos_ATM900](FAULT): failed to initialize, no bytes available on serial interface
2019-04-10T00:56:57.655Z,1554857817.655 [AcousticModem_Benthos_ATM900] Communications Fault, FailCount= 3
2019-04-10T00:56:57.655Z,1554857817.655 [AcousticModem_Benthos_ATM900](ERROR): Communications Fault
2019-04-10T00:56:57.799Z,1554857817.799 [CBIT](ERROR): Communications Fault in component: AcousticModem_Benthos_ATM900
2019-04-10T00:56:58.059Z,1554857818.059 [AcousticModem_Benthos_ATM900](INFO): Powering down
2019-04-10T00:56:58.939Z,1554857818.939 [CBIT](INFO): Clearing failed state for component AcousticModem_Benthos_ATM900
2019-04-10T00:56:58.939Z,1554857818.939 [AcousticModem_Benthos_ATM900] No Fault, FailCount= 3
2019-04-10T00:57:01.290Z,1554857821.290 [AcousticModem_Benthos_ATM900](INFO): Powering up
2019-04-10T00:57:01.291Z,1554857821.291 [AcousticModem_Benthos_ATM900](DEBUG): Initializing AcousticModem_Benthos_ATM900.
2019-04-10T00:57:06.983Z,1554857826.983 [SBIT](IMPORTANT): SBIT PASSED
2019-04-10T00:57:07.063Z,1554857827.063 [CommandLine](IMPORTANT): got command configSet list
2019-04-10T00:57:07.063Z,1554857827.063 [CommandLine](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2019-04-10T00:57:07.064Z,1554857827.064 [CommandLine](IMPORTANT): DropWeight.loadAtStartup=0 bool;

2019-04-10T00:57:07.064Z,1554857827.064 [CommandLine](IMPORTANT): Rowe_600LCM.loadAtStartup=0 bool;

2019-04-10T00:57:07.395Z,1554857827.395 [MissionManager](IMPORTANT): Started mission Startup
2019-04-10T00:57:07.395Z,1554857827.395 [Startup] Running Loop=1
2019-04-10T00:57:07.395Z,1554857827.395 [Startup](DEBUG): Aggregate::initialize Startup
2019-04-10T00:57:07.395Z,1554857827.395 [Startup:A.GoToSurface] Running Loop=1
2019-04-10T00:57:07.395Z,1554857827.395 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2019-04-10T00:57:07.396Z,1554857827.396 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2019-04-10T00:57:07.397Z,1554857827.397 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2019-04-10T00:57:07.397Z,1554857827.397 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2019-04-10T00:57:07.397Z,1554857827.397 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2019-04-10T00:57:07.398Z,1554857827.398 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2019-04-10T00:57:07.399Z,1554857827.399 [Startup:StartupSatComms] Running Loop=1
2019-04-10T00:57:07.399Z,1554857827.399 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2019-04-10T00:57:07.399Z,1554857827.399 [Startup:StartupSatComms:A] Running Loop=1
2019-04-10T00:57:07.795Z,1554857827.795 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2019-04-10T00:57:21.491Z,1554857841.491 [AcousticModem_Benthos_ATM900](FAULT): failed to initialize, no bytes available on serial interface
2019-04-10T00:57:21.491Z,1554857841.491 [AcousticModem_Benthos_ATM900] Communications Fault, FailCount= 4
2019-04-10T00:57:21.491Z,1554857841.491 [AcousticModem_Benthos_ATM900](ERROR): Communications Fault
2019-04-10T00:57:21.528Z,1554857841.528 [CBIT](ERROR): Communications Fault in component: AcousticModem_Benthos_ATM900
2019-04-10T00:57:21.894Z,1554857841.894 [AcousticModem_Benthos_ATM900](INFO): Powering down
2019-04-10T00:57:22.740Z,1554857842.740 [CBIT](INFO): Clearing failed state for component AcousticModem_Benthos_ATM900
2019-04-10T00:57:22.740Z,1554857842.740 [AcousticModem_Benthos_ATM900] No Fault, FailCount= 4
2019-04-10T00:57:25.126Z,1554857845.126 [AcousticModem_Benthos_ATM900](INFO): Powering up
2019-04-10T00:57:25.127Z,1554857845.127 [AcousticModem_Benthos_ATM900](DEBUG): Initializing AcousticModem_Benthos_ATM900.
2019-04-10T00:57:45.327Z,1554857865.327 [AcousticModem_Benthos_ATM900](FAULT): failed to initialize, no bytes available on serial interface
2019-04-10T00:57:45.327Z,1554857865.327 [AcousticModem_Benthos_ATM900] Communications Fault, FailCount= 5
2019-04-10T00:57:45.327Z,1554857865.327 [AcousticModem_Benthos_ATM900](ERROR): Communications Fault
2019-04-10T00:57:45.394Z,1554857865.394 [CBIT](ERROR): Communications Fault in component: AcousticModem_Benthos_ATM900
2019-04-10T00:57:45.730Z,1554857865.730 [AcousticModem_Benthos_ATM900](INFO): Powering down
2019-04-10T00:57:46.576Z,1554857866.576 [CBIT](INFO): Clearing failed state for component AcousticModem_Benthos_ATM900
2019-04-10T00:57:46.576Z,1554857866.576 [AcousticModem_Benthos_ATM900] No Fault, FailCount= 5
2019-04-10T00:57:48.963Z,1554857868.963 [AcousticModem_Benthos_ATM900](INFO): Powering up
2019-04-10T00:57:48.963Z,1554857868.963 [AcousticModem_Benthos_ATM900](DEBUG): Initializing AcousticModem_Benthos_ATM900.
2019-04-10T00:57:49.013Z,1554857869.013 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-04-10T00:57:49.013Z,1554857869.013 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2019-04-10T00:57:49.013Z,1554857869.013 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-04-10T00:57:49.015Z,1554857869.015 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-04-10T00:57:49.015Z,1554857869.015 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 1
2019-04-10T00:57:49.015Z,1554857869.015 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2019-04-10T00:57:49.016Z,1554857869.016 [DeadReckonWithRespectToSeafloor](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-04-10T00:57:49.016Z,1554857869.016 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1
2019-04-10T00:57:49.016Z,1554857869.016 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2019-04-10T00:57:49.027Z,1554857869.027 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-04-10T00:57:49.028Z,1554857869.028 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2019-04-10T00:57:49.028Z,1554857869.028 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2019-04-10T00:57:49.409Z,1554857869.409 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-04-10T00:57:49.409Z,1554857869.409 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2019-04-10T00:57:49.410Z,1554857869.410 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2019-04-10T00:57:49.410Z,1554857869.410 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 1
2019-04-10T00:57:49.410Z,1554857869.410 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2019-04-10T00:57:49.410Z,1554857869.410 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1
2019-04-10T00:57:49.809Z,1554857869.809 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2019-04-10T00:58:07.575Z,1554857887.575 [Startup:StartupSatComms:A](INFO): Timed out from 2019-04-10T00:57:07.4Z
2019-04-10T00:58:07.575Z,1554857887.575 [Startup:StartupSatComms:A] Stopped
2019-04-10T00:58:07.575Z,1554857887.575 [Startup:StartupSatComms:B] Running Loop=1
2019-04-10T00:58:07.979Z,1554857887.979 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2019-04-10T00:58:09.162Z,1554857889.162 [AcousticModem_Benthos_ATM900](FAULT): failed to initialize, no bytes available on serial interface
2019-04-10T00:58:09.163Z,1554857889.163 [AcousticModem_Benthos_ATM900] Communications Fault, FailCount= 6
2019-04-10T00:58:09.163Z,1554857889.163 [AcousticModem_Benthos_ATM900](ERROR): Communications Fault
2019-04-10T00:58:09.214Z,1554857889.214 [CBIT](ERROR): Communications Fault in component: AcousticModem_Benthos_ATM900
2019-04-10T00:58:09.567Z,1554857889.567 [AcousticModem_Benthos_ATM900](INFO): Powering down
2019-04-10T00:58:10.422Z,1554857890.422 [CBIT](INFO): Clearing failed state for component AcousticModem_Benthos_ATM900
2019-04-10T00:58:10.422Z,1554857890.422 [AcousticModem_Benthos_ATM900] No Fault, FailCount= 6
2019-04-10T00:58:12.798Z,1554857892.798 [AcousticModem_Benthos_ATM900](INFO): Powering up
2019-04-10T00:58:12.799Z,1554857892.799 [AcousticModem_Benthos_ATM900](DEBUG): Initializing AcousticModem_Benthos_ATM900.
2019-04-10T00:58:31.392Z,1554857911.392 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004884
2019-04-10T00:58:31.515Z,1554857911.515 [CommandLine](IMPORTANT): got command restart application
2019-04-10T00:58:32.526Z,1554857912.526 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2019-04-10T00:58:32.526Z,1554857912.526 [CommandLine ThreadHandler](INFO): Thread cancelled.
2019-04-10T00:58:32.566Z,1554857912.566 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup.  Bye!
2019-04-10T00:58:32.566Z,1554857912.566 [CommandLine ThreadHandler](INFO): Thread cancelled.
2019-04-10T00:58:32.567Z,1554857912.567 [CommandLine](INFO): Join timeout helper Thread ID is 799
2019-04-10T00:58:32.567Z,1554857912.567 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2019-04-10T00:58:32.567Z,1554857912.567 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2019-04-10T00:58:32.568Z,1554857912.568 [NavChartDb](INFO): Join timeout helper Thread ID is 800
2019-04-10T00:58:32.770Z,1554857912.770 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2019-04-10T00:58:32.770Z,1554857912.770 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2019-04-10T00:58:32.774Z,1554857912.774 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2019-04-10T00:58:32.774Z,1554857912.774 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2019-04-10T00:58:32.774Z,1554857912.774 [Radio_Surface](INFO): Join timeout helper Thread ID is 801
2019-04-10T00:58:32.866Z,1554857912.866 [Radio_Surface](INFO): Powering down
2019-04-10T00:58:32.867Z,1554857912.867 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2019-04-10T00:58:32.867Z,1554857912.867 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2019-04-10T00:58:32.874Z,1554857912.874 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler
2019-04-10T00:58:32.874Z,1554857912.874 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2019-04-10T00:58:32.874Z,1554857912.874 [DataOverHttps](INFO): Join timeout helper Thread ID is 802
2019-04-10T00:58:32.998Z,1554857912.998 [AcousticModem_Benthos_ATM900](FAULT): failed to initialize, no bytes available on serial interface
2019-04-10T00:58:32.998Z,1554857912.998 [AcousticModem_Benthos_ATM900] Communications Fault, FailCount= 7
2019-04-10T00:58:32.999Z,1554857912.999 [AcousticModem_Benthos_ATM900](ERROR): Communications Fault
2019-04-10T00:58:33.002Z,1554857913.002 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread.
2019-04-10T00:58:33.003Z,1554857913.003 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2019-04-10T00:58:33.015Z,1554857913.015 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2019-04-10T00:58:33.015Z,1554857913.015 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2019-04-10T00:58:33.016Z,1554857913.016 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 803
2019-04-10T00:58:33.040Z,1554857913.040 [CBIT](ERROR): Communications Fault in component: AcousticModem_Benthos_ATM900
2019-04-10T00:58:33.154Z,1554857913.154 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread.
2019-04-10T00:58:33.155Z,1554857913.155 [WetLabsBB2FL](INFO): Powering down
2019-04-10T00:58:33.156Z,1554857913.156 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2019-04-10T00:58:33.175Z,1554857913.175 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler
2019-04-10T00:58:33.175Z,1554857913.175 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2019-04-10T00:58:33.175Z,1554857913.175 [CTD_Seabird](INFO): Join timeout helper Thread ID is 804
2019-04-10T00:58:33.194Z,1554857913.194 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread.
2019-04-10T00:58:33.194Z,1554857913.194 [CTD_Seabird](INFO): Powering down
2019-04-10T00:58:33.206Z,1554857913.206 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2019-04-10T00:58:33.215Z,1554857913.215 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2019-04-10T00:58:33.215Z,1554857913.215 [logger ThreadHandler](INFO): Thread cancelled.
2019-04-10T00:58:33.215Z,1554857913.215 [logger](INFO): Join timeout helper Thread ID is 806
2019-04-10T00:58:33.266Z,1554857913.266 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2019-04-10T00:58:33.266Z,1554857913.266 [logger ThreadHandler](INFO): Thread cancelled.
2019-04-10T00:58:33.275Z,1554857913.275 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2019-04-10T00:58:33.275Z,1554857913.275 [CommandLine ThreadHandler](INFO): Thread cancelled.
2019-04-10T00:58:33.275Z,1554857913.275 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2019-04-10T00:58:33.275Z,1554857913.275 [controlThread ThreadHandler](INFO): Thread cancelled.
2019-04-10T00:58:33.275Z,1554857913.275 [controlThread](INFO): Join timeout helper Thread ID is 807
2019-04-10T00:58:33.398Z,1554857913.398 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2019-04-10T00:58:33.398Z,1554857913.398 [controlThread](DEBUG): Uninitializing ControlThread
2019-04-10T00:58:33.399Z,1554857913.399 [Aanderaa_O2](INFO): Powering down
2019-04-10T00:58:33.401Z,1554857913.401 [AcousticModem_Benthos_ATM900](INFO): Powering down
2019-04-10T00:58:33.518Z,1554857913.518 [NAL9602](INFO): Powering down
2019-04-10T00:58:33.520Z,1554857913.520 [BR_Ping1D](INFO): uninitialize
2019-04-10T00:58:33.520Z,1554857913.520 [BR_Ping1D](INFO): Powering down
2019-04-10T00:58:33.521Z,1554857913.521 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2019-04-10T00:58:33.522Z,1554857913.522 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2019-04-10T00:58:33.523Z,1554857913.523 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2019-04-10T00:58:33.523Z,1554857913.523 [MissionManager](INFO): Uninitializing Mission Default
2019-04-10T00:58:33.526Z,1554857913.526 [MissionManager](INFO): Uninitializing Mission Startup
2019-04-10T00:58:33.526Z,1554857913.526 [Startup] Stopped
2019-04-10T00:58:33.526Z,1554857913.526 [Startup](DEBUG): Aggregate::uninitialize Startup
2019-04-10T00:58:33.526Z,1554857913.526 [Startup:A.GoToSurface] Stopped
2019-04-10T00:58:33.526Z,1554857913.526 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2019-04-10T00:58:33.526Z,1554857913.526 [Startup:StartupSatComms] Stopped
2019-04-10T00:58:33.526Z,1554857913.526 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2019-04-10T00:58:33.526Z,1554857913.526 [Startup:StartupSatComms:B] Stopped
2019-04-10T00:58:33.528Z,1554857913.528 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2019-04-10T00:58:33.528Z,1554857913.528 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2019-04-10T00:58:33.528Z,1554857913.528 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2019-04-10T00:58:33.529Z,1554857913.529 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2019-04-10T00:58:33.529Z,1554857913.529 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2019-04-10T00:58:33.529Z,1554857913.529 [BuoyancyServo](INFO): Powering down
2019-04-10T00:58:33.542Z,1554857913.542 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2019-04-10T00:58:33.542Z,1554857913.542 [ElevatorServo](INFO): Powering down
2019-04-10T00:58:33.543Z,1554857913.543 [MassServo](DEBUG): Uninitialize Mass Servo.
2019-04-10T00:58:33.543Z,1554857913.543 [MassServo](INFO): Powering down
2019-04-10T00:58:33.544Z,1554857913.544 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2019-04-10T00:58:33.544Z,1554857913.544 [RudderServo](INFO): Powering down
2019-04-10T00:58:33.545Z,1554857913.545 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2019-04-10T00:58:33.545Z,1554857913.545 [ThrusterServo](INFO): Powering down
2019-04-10T00:58:33.546Z,1554857913.546 [SBIT](DEBUG): Uninitialize SBIT Component.
2019-04-10T00:58:33.546Z,1554857913.546 [IBIT](DEBUG): Uninitialize IBIT Component.
2019-04-10T00:58:33.546Z,1554857913.546 [CBIT](DEBUG): Uninitialize CBIT Component.
2019-04-10T00:58:33.546Z,1554857913.546 [CBIT](DEBUG): Powering off loads.
2019-04-10T00:58:33.558Z,1554857913.558 [CBIT](DEBUG): Disabling WDT.
2019-04-10T00:58:33.570Z,1554857913.570 [CBIT](DEBUG): Opening all GF detection circuits.
2019-04-10T00:58:33.571Z,1554857913.571 [controlThread ThreadHandler](INFO): Thread cancelled.
2019-04-10T00:58:33.602Z,1554857913.602 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2019-04-10T00:58:33.607Z,1554857913.607 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2019-04-10T00:58:33.678Z,1554857913.678 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2019-04-10T00:58:33.683Z,1554857913.683 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2019-04-10T00:58:33.735Z,1554857913.735 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2019-04-10T00:58:33.795Z,1554857913.795 [logger ThreadHandler](INFO): Thread cancelled.