2019-02-21T23:11:17.376Z,1550790677.376 [Supervisor](DEBUG): Initializing supervisor.
2019-02-21T23:11:17.391Z,1550790677.391 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2019-02-21T23:11:17.392Z,1550790677.392 [SyncHandler](INFO): Protected caller Thread ID is 1510
2019-02-21T23:11:17.392Z,1550790677.392 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2019-02-21T23:11:17.407Z,1550790677.407 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2019-02-21T23:11:17.408Z,1550790677.408 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 1511
2019-02-21T23:11:17.410Z,1550790677.410 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2019-02-21T23:11:17.457Z,1550790677.457 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2019-02-21T23:11:17.478Z,1550790677.478 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2019-02-21T23:11:17.478Z,1550790677.478 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 1512
2019-02-21T23:11:17.479Z,1550790677.479 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2019-02-21T23:11:17.491Z,1550790677.491 [logger ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2019-02-21T23:11:17.492Z,1550790677.492 [logger ThreadHandler](INFO): Protected caller Thread ID is 1513
2019-02-21T23:11:17.494Z,1550790677.494 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2019-02-21T23:11:17.494Z,1550790677.494 [Supervisor](INFO): Looking for Config files in directory: Config/
2019-02-21T23:11:17.496Z,1550790677.496 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2019-02-21T23:11:17.919Z,1550790677.919 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2019-02-21T23:11:17.920Z,1550790677.920 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2019-02-21T23:11:18.086Z,1550790678.086 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2019-02-21T23:11:19.090Z,1550790679.090 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2019-02-21T23:11:19.091Z,1550790679.091 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2019-02-21T23:11:19.835Z,1550790679.835 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2019-02-21T23:11:19.836Z,1550790679.836 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2019-02-21T23:11:20.035Z,1550790680.035 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2019-02-21T23:11:20.036Z,1550790680.036 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2019-02-21T23:11:21.067Z,1550790681.067 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2019-02-21T23:11:21.068Z,1550790681.068 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2019-02-21T23:11:21.642Z,1550790681.642 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2019-02-21T23:11:21.643Z,1550790681.643 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2019-02-21T23:11:22.664Z,1550790682.664 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2019-02-21T23:11:22.665Z,1550790682.665 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2019-02-21T23:11:22.864Z,1550790682.864 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2019-02-21T23:11:22.865Z,1550790682.865 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2019-02-21T23:11:23.052Z,1550790683.052 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample
2019-02-21T23:11:23.052Z,1550790683.052 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2019-02-21T23:11:24.342Z,1550790684.342 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2019-02-21T23:11:24.343Z,1550790684.343 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2019-02-21T23:11:25.409Z,1550790685.409 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2019-02-21T23:11:25.410Z,1550790685.410 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2019-02-21T23:11:25.937Z,1550790685.937 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2019-02-21T23:11:25.938Z,1550790685.938 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2019-02-21T23:11:26.341Z,1550790686.341 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2019-02-21T23:11:26.341Z,1550790686.341 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2019-02-21T23:11:26.770Z,1550790686.770 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2019-02-21T23:11:26.772Z,1550790686.772 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-daphne/
2019-02-21T23:11:26.773Z,1550790686.773 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Navigation.cfg
2019-02-21T23:11:26.975Z,1550790686.975 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Simulator.cfg
2019-02-21T23:11:27.115Z,1550790687.115 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Control.cfg
2019-02-21T23:11:27.349Z,1550790687.349 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/secure.cfg
2019-02-21T23:11:27.524Z,1550790687.524 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Servo.cfg
2019-02-21T23:11:27.724Z,1550790687.724 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/BIT.cfg
2019-02-21T23:11:27.896Z,1550790687.896 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/vehicle.cfg
2019-02-21T23:11:28.373Z,1550790688.373 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/workSite.cfg
2019-02-21T23:11:28.509Z,1550790688.509 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Sensor.cfg
2019-02-21T23:11:28.773Z,1550790688.773 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Science.cfg
2019-02-21T23:11:29.059Z,1550790689.059 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/logger.cfg
2019-02-21T23:11:29.350Z,1550790689.350 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Battery.cfg
2019-02-21T23:11:30.078Z,1550790690.078 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2019-02-21T23:11:30.079Z,1550790690.079 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg
2019-02-21T23:11:30.081Z,1550790690.081 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2019-02-21T23:11:30.191Z,1550790690.191 [VerticalControl](DEBUG): Construct VerticalControl.
2019-02-21T23:11:30.516Z,1550790690.516 [VerticalControl] Loaded
2019-02-21T23:11:30.516Z,1550790690.516 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2019-02-21T23:11:30.517Z,1550790690.517 [HorizontalControl](DEBUG): Construct HorizontalControl.
2019-02-21T23:11:30.714Z,1550790690.714 [HorizontalControl] Loaded
2019-02-21T23:11:30.714Z,1550790690.714 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2019-02-21T23:11:30.743Z,1550790690.743 [SpeedControl](DEBUG): Construct SpeedControl.
2019-02-21T23:11:30.765Z,1550790690.765 [SpeedControl] Loaded
2019-02-21T23:11:30.765Z,1550790690.765 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2019-02-21T23:11:30.766Z,1550790690.766 [LoopControl](DEBUG): Construct LoopControl.
2019-02-21T23:11:30.781Z,1550790690.781 [LoopControl] Loaded
2019-02-21T23:11:30.782Z,1550790690.782 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2019-02-21T23:11:30.782Z,1550790690.782 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2019-02-21T23:11:30.783Z,1550790690.783 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2019-02-21T23:11:30.828Z,1550790690.828 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2019-02-21T23:11:30.828Z,1550790690.828 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2019-02-21T23:11:31.063Z,1550790691.063 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2019-02-21T23:11:31.084Z,1550790691.084 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2019-02-21T23:11:31.345Z,1550790691.345 [BuoyancyServo] Loaded
2019-02-21T23:11:31.346Z,1550790691.346 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2019-02-21T23:11:31.381Z,1550790691.381 [ElevatorServo] Loaded
2019-02-21T23:11:31.382Z,1550790691.382 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2019-02-21T23:11:31.408Z,1550790691.408 [MassServo] Loaded
2019-02-21T23:11:31.408Z,1550790691.408 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2019-02-21T23:11:31.442Z,1550790691.442 [RudderServo] Loaded
2019-02-21T23:11:31.443Z,1550790691.443 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2019-02-21T23:11:31.479Z,1550790691.479 [ThrusterServo] Loaded
2019-02-21T23:11:31.480Z,1550790691.480 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread.
2019-02-21T23:11:31.480Z,1550790691.480 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2019-02-21T23:11:31.481Z,1550790691.481 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2019-02-21T23:11:31.724Z,1550790691.724 [DeadReckonUsingMultipleVelocitySources] Loaded
2019-02-21T23:11:31.724Z,1550790691.724 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2019-02-21T23:11:31.909Z,1550790691.909 [DeadReckonUsingSpeedCalculator] Loaded
2019-02-21T23:11:31.909Z,1550790691.909 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread.
2019-02-21T23:11:32.081Z,1550790692.081 [DeadReckonWithRespectToSeafloor] Loaded
2019-02-21T23:11:32.082Z,1550790692.082 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonWithRespectToSeafloor" handled in the control thread.
2019-02-21T23:11:32.121Z,1550790692.121 [NavChart] Loaded
2019-02-21T23:11:32.122Z,1550790692.122 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2019-02-21T23:11:32.144Z,1550790692.144 [UniversalFixResidualReporter] Loaded
2019-02-21T23:11:32.144Z,1550790692.144 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2019-02-21T23:11:32.145Z,1550790692.145 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2019-02-21T23:11:32.145Z,1550790692.145 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2019-02-21T23:11:32.256Z,1550790692.256 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2019-02-21T23:11:32.256Z,1550790692.256 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2019-02-21T23:11:32.999Z,1550790692.999 [DataOverHttps] Loaded
2019-02-21T23:11:32.000Z,1550790693.000 [ComponentRegistry](DEBUG): SyncComponent "DataOverHttps" handled in the control thread.
2019-02-21T23:11:33.033Z,1550790693.033 [Depth_Keller] Loaded
2019-02-21T23:11:33.034Z,1550790693.034 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2019-02-21T23:11:33.039Z,1550790693.039 [DropWeight] Loaded
2019-02-21T23:11:33.075Z,1550790693.075 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2019-02-21T23:11:33.467Z,1550790693.467 [NAL9602] Loaded
2019-02-21T23:11:33.468Z,1550790693.468 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2019-02-21T23:11:33.490Z,1550790693.490 [Onboard] Loaded
2019-02-21T23:11:33.491Z,1550790693.491 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread.
2019-02-21T23:11:33.498Z,1550790693.498 [Radio_Surface] Loaded
2019-02-21T23:11:33.498Z,1550790693.498 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2019-02-21T23:11:33.499Z,1550790693.499 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 408624E0
2019-02-21T23:11:33.499Z,1550790693.499 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 1683
2019-02-21T23:11:33.635Z,1550790693.635 [PNI_TCM] Loaded
2019-02-21T23:11:33.635Z,1550790693.635 [ComponentRegistry](DEBUG): SyncComponent "PNI_TCM" handled in the control thread.
2019-02-21T23:11:33.830Z,1550790693.830 [Rowe_600LCM] Loaded
2019-02-21T23:11:33.831Z,1550790693.831 [ComponentRegistry](DEBUG): Component "Rowe_600LCM" handled in its own thread.
2019-02-21T23:11:33.851Z,1550790693.851 [Rowe_600LCM ThreadHandler](DEBUG): Created PCaller Thread at 408924E0
2019-02-21T23:11:33.852Z,1550790693.852 [Rowe_600LCM ThreadHandler](INFO): Protected caller Thread ID is 1688
2019-02-21T23:11:33.852Z,1550790693.852 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2019-02-21T23:11:33.853Z,1550790693.853 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2019-02-21T23:11:33.953Z,1550790693.953 [DepthRateCalculator] Loaded
2019-02-21T23:11:33.953Z,1550790693.953 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2019-02-21T23:11:33.959Z,1550790693.959 [PitchRateCalculator] Loaded
2019-02-21T23:11:33.973Z,1550790693.973 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2019-02-21T23:11:34.008Z,1550790694.008 [SpeedCalculator] Loaded
2019-02-21T23:11:34.008Z,1550790694.008 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2019-02-21T23:11:34.058Z,1550790694.058 [TempGradientCalculator] Loaded
2019-02-21T23:11:34.059Z,1550790694.059 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread.
2019-02-21T23:11:34.064Z,1550790694.064 [YawRateCalculator] Loaded
2019-02-21T23:11:34.064Z,1550790694.064 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2019-02-21T23:11:34.176Z,1550790694.176 [ElevatorOffsetCalculator] Loaded
2019-02-21T23:11:34.176Z,1550790694.176 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2019-02-21T23:11:34.177Z,1550790694.177 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2019-02-21T23:11:34.177Z,1550790694.177 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2019-02-21T23:11:34.744Z,1550790694.744 [Aanderaa_O2] Loaded
2019-02-21T23:11:34.744Z,1550790694.744 [ComponentRegistry](DEBUG): SyncComponent "Aanderaa_O2" handled in the control thread.
2019-02-21T23:11:34.917Z,1550790694.917 [CTD_NeilBrown] Loaded
2019-02-21T23:11:34.917Z,1550790694.917 [ComponentRegistry](DEBUG): Component "CTD_NeilBrown" handled in its own thread.
2019-02-21T23:11:34.918Z,1550790694.918 [CTD_NeilBrown ThreadHandler](DEBUG): Created PCaller Thread at 4095C4E0
2019-02-21T23:11:34.919Z,1550790694.919 [CTD_NeilBrown ThreadHandler](INFO): Protected caller Thread ID is 1693
2019-02-21T23:11:34.928Z,1550790694.928 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_density
2019-02-21T23:11:34.933Z,1550790694.933 [CTD_Seabird](INFO): created writer for : sea_water_density
2019-02-21T23:11:34.959Z,1550790694.959 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): depth
2019-02-21T23:11:34.964Z,1550790694.964 [CTD_Seabird](INFO): created writer for : depth
2019-02-21T23:11:34.965Z,1550790694.965 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_pressure
2019-02-21T23:11:34.970Z,1550790694.970 [CTD_Seabird](INFO): created writer for : sea_water_pressure
2019-02-21T23:11:34.971Z,1550790694.971 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_salinity
2019-02-21T23:11:34.996Z,1550790694.996 [CTD_Seabird](INFO): created writer for : sea_water_salinity
2019-02-21T23:11:34.996Z,1550790694.996 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_temperature
2019-02-21T23:11:35.010Z,1550790695.010 [CTD_Seabird](INFO): created writer for : sea_water_temperature
2019-02-21T23:11:35.011Z,1550790695.011 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_electrical_conductivity
2019-02-21T23:11:35.017Z,1550790695.017 [CTD_Seabird](INFO): created writer for : sea_water_electrical_conductivity
2019-02-21T23:11:35.017Z,1550790695.017 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): speed_of_sound_in_sea_water
2019-02-21T23:11:35.030Z,1550790695.030 [CTD_Seabird](INFO): created writer for : speed_of_sound_in_sea_water
2019-02-21T23:11:35.143Z,1550790695.143 [CTD_Seabird] Loaded
2019-02-21T23:11:35.144Z,1550790695.144 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread.
2019-02-21T23:11:35.159Z,1550790695.159 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 4098C4E0
2019-02-21T23:11:35.160Z,1550790695.160 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 1698
2019-02-21T23:11:35.190Z,1550790695.190 [PAR_Licor] Loaded
2019-02-21T23:11:35.190Z,1550790695.190 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2019-02-21T23:11:35.333Z,1550790695.333 [WetLabsBB2FL] Loaded
2019-02-21T23:11:35.333Z,1550790695.333 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2019-02-21T23:11:35.353Z,1550790695.353 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 409BC4E0
2019-02-21T23:11:35.353Z,1550790695.353 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 1699
2019-02-21T23:11:35.354Z,1550790695.354 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2019-02-21T23:11:35.355Z,1550790695.355 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2019-02-21T23:11:35.417Z,1550790695.417 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2019-02-21T23:11:35.417Z,1550790695.417 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2019-02-21T23:11:36.145Z,1550790696.145 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2019-02-21T23:11:36.145Z,1550790696.145 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2019-02-21T23:11:36.484Z,1550790696.484 [SBIT](DEBUG): Construct Startup Built In Test.
2019-02-21T23:11:36.536Z,1550790696.536 [SBIT] Loaded
2019-02-21T23:11:36.536Z,1550790696.536 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2019-02-21T23:11:36.537Z,1550790696.537 [IBIT](DEBUG): Construct Initiated Built In Test.
2019-02-21T23:11:36.582Z,1550790696.582 [IBIT] Loaded
2019-02-21T23:11:36.582Z,1550790696.582 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2019-02-21T23:11:36.594Z,1550790696.594 [CBIT](DEBUG): Construct Continuous Built In Test.
2019-02-21T23:11:37.622Z,1550790697.622 [CBIT] Loaded
2019-02-21T23:11:37.622Z,1550790697.622 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2019-02-21T23:11:37.622Z,1550790697.622 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2019-02-21T23:11:37.626Z,1550790697.626 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2019-02-21T23:11:37.630Z,1550790697.630 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2019-02-21T23:11:37.636Z,1550790697.636 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2019-02-21T23:11:37.638Z,1550790697.638 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40AA64E0
2019-02-21T23:11:37.638Z,1550790697.638 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 1712
2019-02-21T23:11:37.642Z,1550790697.642 [Supervisor](INFO): Main Thread ID is 1505
2019-02-21T23:11:37.643Z,1550790697.643 [Supervisor](DEBUG): Running supervisor.
2019-02-21T23:11:37.643Z,1550790697.643 [CommandLine ThreadHandler](INFO): Handler Thread ID is 1713
2019-02-21T23:11:37.645Z,1550790697.645 [controlThread ThreadHandler](INFO): Handler Thread ID is 1714
2019-02-21T23:11:37.646Z,1550790697.646 [controlThread](DEBUG): Initializing ControlThread
2019-02-21T23:11:37.647Z,1550790697.647 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2019-02-21T23:11:37.672Z,1550790697.672 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2019-02-21T23:11:37.673Z,1550790697.673 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2019-02-21T23:11:37.673Z,1550790697.673 [LoopControl](DEBUG): Initialize LoopControlComponent.
2019-02-21T23:11:37.675Z,1550790697.675 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2019-02-21T23:11:37.688Z,1550790697.688 [NavChart](DEBUG): Initialize NavChart Navigation.
2019-02-21T23:11:37.689Z,1550790697.689 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2019-02-21T23:11:37.693Z,1550790697.693 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2019-02-21T23:11:37.694Z,1550790697.694 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2019-02-21T23:11:37.694Z,1550790697.694 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2019-02-21T23:11:37.694Z,1550790697.694 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator.
2019-02-21T23:11:37.695Z,1550790697.695 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2019-02-21T23:11:37.699Z,1550790697.699 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2019-02-21T23:11:37.708Z,1550790697.708 [SBIT](INFO): Initialize SBIT Component.
2019-02-21T23:11:37.708Z,1550790697.708 [SBIT](IMPORTANT): git: 2019-01-14A-50-g9cfb34a
2019-02-21T23:11:37.708Z,1550790697.708 [SBIT](INFO): git hash: 9cfb34a5380b67c155f39980646156fa9a5482a4
2019-02-21T23:11:37.709Z,1550790697.709 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2019-02-21T23:11:37.710Z,1550790697.710 [SBIT](INFO): Kernel Reporting Different Version From Configuration.
Kernel Expected: #2 PREEMPT Thu Jan 11 20:13:48 PST 2018
Kernel Reported: #1 PREEMPT Tue Dec 18 21:19:28 PST 2018
2019-02-21T23:11:37.716Z,1550790697.716 [logger ThreadHandler](INFO): Handler Thread ID is 1717
2019-02-21T23:11:37.711Z,1550790697.711 [SBIT](INFO): Beginning SBIT in 23.000000 seconds.
2019-02-21T23:11:37.739Z,1550790697.739 [IBIT](INFO): Initialize IBIT Component.
2019-02-21T23:11:37.740Z,1550790697.740 [CBIT](DEBUG): Initialize CBIT Component.
2019-02-21T23:11:37.751Z,1550790697.751 [CBIT](DEBUG): Initialized mux pins.
2019-02-21T23:11:37.751Z,1550790697.751 [CBIT](DEBUG): Initializing the watchdog timer.
2019-02-21T23:11:37.762Z,1550790697.762 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 1719
2019-02-21T23:11:37.768Z,1550790697.768 [Radio_Surface](INFO): Powering up
2019-02-21T23:11:37.779Z,1550790697.779 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2019-02-21T23:11:37.779Z,1550790697.779 [CBIT](DEBUG): Initializing heartbeat.
2019-02-21T23:11:37.785Z,1550790697.785 [Rowe_600LCM ThreadHandler](INFO): Handler Thread ID is 1721
2019-02-21T23:11:37.785Z,1550790697.785 [Rowe_600LCM](INFO): Initializing
2019-02-21T23:11:37.794Z,1550790697.794 [Rowe_600LCM](INFO): Powering up
2019-02-21T23:11:37.817Z,1550790697.817 [CTD_NeilBrown ThreadHandler](INFO): Handler Thread ID is 1722
2019-02-21T23:11:37.818Z,1550790697.818 [CTD_NeilBrown](INFO): Powering down
2019-02-21T23:11:37.844Z,1550790697.844 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 1723
2019-02-21T23:11:37.844Z,1550790697.844 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2019-02-21T23:11:37.851Z,1550790697.851 [CBIT](DEBUG): Deactivating GF circuits.
2019-02-21T23:11:37.851Z,1550790697.851 [CBIT](DEBUG): Deactivating emergency mode.
2019-02-21T23:11:37.852Z,1550790697.852 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 1725
2019-02-21T23:11:37.853Z,1550790697.853 [WetLabsBB2FL](INFO): Powering down
2019-02-21T23:11:37.871Z,1550790697.871 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20
2019-02-21T23:11:37.888Z,1550790697.888 [MissionManager](INFO): Loading Mission: Missions/Startup.xml
2019-02-21T23:11:37.899Z,1550790697.899 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2019-02-21T23:11:37.942Z,1550790697.942 [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-02-21T23:11:37.952Z,1550790697.952 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 1726
2019-02-21T23:11:37.962Z,1550790697.962 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2019-02-21T23:11:37.962Z,1550790697.962 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2019-02-21T23:11:37.963Z,1550790697.963 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2019-02-21T23:11:37.963Z,1550790697.963 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2019-02-21T23:11:37.963Z,1550790697.963 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2019-02-21T23:11:37.963Z,1550790697.963 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2019-02-21T23:11:37.963Z,1550790697.963 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000
2019-02-21T23:11:37.964Z,1550790697.964 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000
2019-02-21T23:11:37.964Z,1550790697.964 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2019-02-21T23:11:37.964Z,1550790697.964 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2019-02-21T23:11:37.964Z,1550790697.964 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000
2019-02-21T23:11:37.964Z,1550790697.964 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000
2019-02-21T23:11:37.965Z,1550790697.965 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000
2019-02-21T23:11:37.965Z,1550790697.965 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000
2019-02-21T23:11:37.965Z,1550790697.965 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000
2019-02-21T23:11:37.965Z,1550790697.965 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000
2019-02-21T23:11:37.983Z,1550790697.983 [MissionManager](INFO): Loading Mission: Missions/Default.xml
2019-02-21T23:11:38.157Z,1550790698.157 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2019-02-21T23:11:38.158Z,1550790698.158 [Default:A.Wait](DEBUG): Construct Wait.
2019-02-21T23:11:38.188Z,1550790698.188 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2019-02-21T23:11:38.264Z,1550790698.264 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2019-02-21T23:11:38.267Z,1550790698.267 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2019-02-21T23:11:38.316Z,1550790698.316 [Default:E.Execute](DEBUG): Construct Execute.
2019-02-21T23:11:38.336Z,1550790698.336 [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-02-21T23:11:38.341Z,1550790698.341 [controlThread](DEBUG): Component order: CycleStarter,DataOverHttps,Depth_Keller,DropWeight,NAL9602,Onboard,PNI_TCM,Aanderaa_O2,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,DeadReckonUsingSpeedCalculator,DeadReckonWithRespectToSeafloor,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter,
2019-02-21T23:11:38.361Z,1550790698.361 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2019-02-21T23:11:38.409Z,1550790698.409 [Depth_Keller](ERROR): Pressure reading out of range: 1831.023193 decibar
2019-02-21T23:11:38.779Z,1550790698.779 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-02-21T23:11:39.296Z,1550790699.296 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2019-02-21T23:11:39.335Z,1550790699.335 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2019-02-21T23:11:39.355Z,1550790699.355 [ElevatorServo](DEBUG): Initializing EZServoServo.
2019-02-21T23:11:39.380Z,1550790699.380 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2019-02-21T23:11:39.398Z,1550790699.398 [MassServo](DEBUG): Initializing EZServoServo.
2019-02-21T23:11:39.415Z,1550790699.415 [MassServo](DEBUG): Initializing MassServo.
2019-02-21T23:11:39.462Z,1550790699.462 [RudderServo](DEBUG): Initializing EZServoServo.
2019-02-21T23:11:39.471Z,1550790699.471 [RudderServo](DEBUG): Initializing RudderServo.
2019-02-21T23:11:39.525Z,1550790699.525 [ThrusterServo](DEBUG): Initializing EZServoServo.
2019-02-21T23:11:39.539Z,1550790699.539 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2019-02-21T23:11:39.989Z,1550790699.989 [DropWeight](CRITICAL): DROP WEIGHT MISSING.

2019-02-21T23:11:39.990Z,1550790699.990 [DropWeight] Hardware Fault, FailCount= 1
2019-02-21T23:11:39.990Z,1550790699.990 [DropWeight](ERROR): Hardware Fault
2019-02-21T23:11:40.493Z,1550790700.493 [CommandLine](FAULT): Scheduling is paused
2019-02-21T23:11:40.493Z,1550790700.493 [CBIT](INFO): Critical error at 20190221T231139
2019-02-21T23:11:40.493Z,1550790700.493 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals
2019-02-21T23:11:40.496Z,1550790700.496 [CBIT](ERROR): Hardware Fault in component: DropWeight
2019-02-21T23:11:40.497Z,1550790700.497 [CBIT](CRITICAL): Hardware Fault in component: DropWeight
2019-02-21T23:11:40.608Z,1550790700.608 [CBIT](INFO): Critical error at 20190221T231140
2019-02-21T23:11:42.466Z,1550790702.466 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of Rowe LCM interface
2019-02-21T23:11:42.693Z,1550790702.693 [Rowe_600LCM](INFO): Started Rowe LCM interface with command:nohup ./lrauv-framework/onboard/bin/roweadcp -ldir /mnt/mmc/LRAUV/Logs/latest/ -dev /dev/ttyB4 -b 9600 >& /dev/null &
2019-02-21T23:11:47.748Z,1550790707.748 [PNI_TCM](FAULT): Failed to acquire valid data within timeout.
2019-02-21T23:11:47.748Z,1550790707.748 [PNI_TCM] Data Fault, FailCount= 1
2019-02-21T23:11:47.748Z,1550790707.748 [PNI_TCM](ERROR): Data Fault
2019-02-21T23:11:47.869Z,1550790707.869 [CBIT](CRITICAL): Environmental Failure. Press:14.540762 PSI. Humidity:19%. Temp:24 C. ABORTING MISSION
2019-02-21T23:11:47.870Z,1550790707.870 [CBIT](ERROR): Data Fault in component: PNI_TCM
2019-02-21T23:11:48.154Z,1550790708.154 [PNI_TCM](INFO): Powering down
2019-02-21T23:11:48.291Z,1550790708.291 [CBIT](INFO): Critical error at 20190221T231147
2019-02-21T23:11:48.924Z,1550790708.924 [Aanderaa_O2](FAULT): Failed to initialize within timeout.
2019-02-21T23:11:48.924Z,1550790708.924 [Aanderaa_O2] Communications Fault, FailCount= 1
2019-02-21T23:11:48.924Z,1550790708.924 [Aanderaa_O2](ERROR): Communications Fault
2019-02-21T23:11:49.022Z,1550790709.022 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2019-02-21T23:11:49.325Z,1550790709.325 [Aanderaa_O2](INFO): Powering down
2019-02-21T23:11:49.482Z,1550790709.482 [CBIT](INFO): Clearing failed state for component PNI_TCM
2019-02-21T23:11:49.482Z,1550790709.482 [PNI_TCM] No Fault, FailCount= 1
2019-02-21T23:11:50.223Z,1550790710.223 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2019-02-21T23:11:50.223Z,1550790710.223 [Aanderaa_O2] No Fault, FailCount= 1
2019-02-21T23:11:51.923Z,1550790711.923 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2019-02-21T23:11:51.923Z,1550790711.923 [CTD_Seabird] Communications Fault, FailCount= 1
2019-02-21T23:11:51.923Z,1550790711.923 [CTD_Seabird](ERROR): Communications Fault
2019-02-21T23:11:51.987Z,1550790711.987 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2019-02-21T23:11:52.328Z,1550790712.328 [CTD_Seabird](INFO): Powering down
2019-02-21T23:11:53.456Z,1550790713.456 [PAR_Licor](INFO): A/D timeout, 7 tries over 127 ms

2019-02-21T23:11:53.456Z,1550790713.456 [PAR_Licor] Data Fault, FailCount= 1
2019-02-21T23:11:53.456Z,1550790713.456 [PAR_Licor](ERROR): Data Fault
2019-02-21T23:11:53.551Z,1550790713.551 [CBIT](ERROR): Data Fault in component: PAR_Licor
2019-02-21T23:11:53.551Z,1550790713.551 [CBIT](INFO): Clearing failed state for component PAR_Licor
2019-02-21T23:11:53.551Z,1550790713.551 [PAR_Licor] No Fault, FailCount= 1
2019-02-21T23:11:54.267Z,1550790714.267 [PAR_Licor](INFO): A/D timeout, 5 tries over 138 ms

2019-02-21T23:11:54.267Z,1550790714.267 [PAR_Licor] Data Fault, FailCount= 2
2019-02-21T23:11:54.268Z,1550790714.268 [PAR_Licor](ERROR): Data Fault
2019-02-21T23:11:54.363Z,1550790714.363 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2019-02-21T23:11:54.363Z,1550790714.363 [CTD_Seabird] No Fault, FailCount= 1
2019-02-21T23:11:54.364Z,1550790714.364 [CBIT](ERROR): Data Fault in component: PAR_Licor
2019-02-21T23:11:54.364Z,1550790714.364 [CBIT](INFO): Clearing failed state for component PAR_Licor
2019-02-21T23:11:54.364Z,1550790714.364 [PAR_Licor] No Fault, FailCount= 2
2019-02-21T23:11:55.055Z,1550790715.055 [PAR_Licor](INFO): A/D timeout, 16 tries over 127 ms

2019-02-21T23:11:55.056Z,1550790715.056 [PAR_Licor] Data Fault, FailCount= 3
2019-02-21T23:11:55.056Z,1550790715.056 [PAR_Licor](ERROR): Data Fault
2019-02-21T23:11:55.168Z,1550790715.168 [CBIT](ERROR): Data Fault in component: PAR_Licor
2019-02-21T23:11:55.168Z,1550790715.168 [CBIT](CRITICAL): Data Fault in component: PAR_Licor
2019-02-21T23:11:55.239Z,1550790715.239 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2019-02-21T23:11:55.240Z,1550790715.240 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20
2019-02-21T23:11:55.596Z,1550790715.596 [CBIT](INFO): Critical error at 20190221T231155
2019-02-21T23:11:56.928Z,1550790716.928 [PNI_TCM](FAULT): Failed to set parameters during initialization.
2019-02-21T23:11:56.929Z,1550790716.929 [PNI_TCM] Data Fault, FailCount= 2
2019-02-21T23:11:56.929Z,1550790716.929 [PNI_TCM](ERROR): Data Fault
2019-02-21T23:11:57.015Z,1550790717.015 [CBIT](ERROR): Data Fault in component: PNI_TCM
2019-02-21T23:11:57.323Z,1550790717.323 [PNI_TCM](INFO): Powering down
2019-02-21T23:11:58.651Z,1550790718.651 [CBIT](INFO): Clearing failed state for component PNI_TCM
2019-02-21T23:11:58.651Z,1550790718.651 [PNI_TCM] No Fault, FailCount= 2
2019-02-21T23:12:00.936Z,1550790720.936 [Aanderaa_O2](FAULT): Failed to initialize within timeout.
2019-02-21T23:12:00.936Z,1550790720.936 [Aanderaa_O2] Communications Fault, FailCount= 2
2019-02-21T23:12:00.936Z,1550790720.936 [Aanderaa_O2](ERROR): Communications Fault
2019-02-21T23:12:01.004Z,1550790721.004 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2019-02-21T23:12:01.327Z,1550790721.327 [Aanderaa_O2](INFO): Powering down
2019-02-21T23:12:01.394Z,1550790721.394 [SBIT](IMPORTANT): Beginning Startup BIT
2019-02-21T23:12:01.433Z,1550790721.433 [CBIT](IMPORTANT): Beginning ground fault scan
2019-02-21T23:12:02.171Z,1550790722.171 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2019-02-21T23:12:02.171Z,1550790722.171 [Aanderaa_O2] No Fault, FailCount= 2
2019-02-21T23:12:03.526Z,1550790723.526 [NAL9602](INFO): Powering up NAL9602
2019-02-21T23:12:05.940Z,1550790725.940 [PNI_TCM](FAULT): Failed to set parameters during initialization.
2019-02-21T23:12:05.940Z,1550790725.940 [PNI_TCM] Data Fault, FailCount= 3
2019-02-21T23:12:05.940Z,1550790725.940 [PNI_TCM](ERROR): Data Fault
2019-02-21T23:12:06.035Z,1550790726.035 [CBIT](ERROR): Data Fault in component: PNI_TCM
2019-02-21T23:12:06.341Z,1550790726.341 [PNI_TCM](INFO): Powering down
2019-02-21T23:12:07.617Z,1550790727.617 [CBIT](INFO): Clearing failed state for component PNI_TCM
2019-02-21T23:12:07.617Z,1550790727.617 [PNI_TCM] No Fault, FailCount= 3
2019-02-21T23:12:09.279Z,1550790729.279 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2019-02-21T23:12:09.279Z,1550790729.279 [CTD_Seabird] Communications Fault, FailCount= 2
2019-02-21T23:12:09.279Z,1550790729.279 [CTD_Seabird](ERROR): Communications Fault
2019-02-21T23:12:09.618Z,1550790729.618 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2019-02-21T23:12:09.683Z,1550790729.683 [CTD_Seabird](INFO): Powering down
2019-02-21T23:12:11.648Z,1550790731.648 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2019-02-21T23:12:11.648Z,1550790731.648 [CTD_Seabird] No Fault, FailCount= 2
2019-02-21T23:12:12.511Z,1550790732.511 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2019-02-21T23:12:12.512Z,1550790732.512 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20
2019-02-21T23:12:12.745Z,1550790732.745 [Aanderaa_O2](FAULT): Failed to initialize within timeout.
2019-02-21T23:12:12.745Z,1550790732.745 [Aanderaa_O2] Communications Fault, FailCount= 3
2019-02-21T23:12:12.745Z,1550790732.745 [Aanderaa_O2](ERROR): Communications Fault
2019-02-21T23:12:12.878Z,1550790732.878 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2019-02-21T23:12:12.878Z,1550790732.878 [CBIT](FAULT): Communications Fault in component: Aanderaa_O2
2019-02-21T23:12:12.939Z,1550790732.939 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): -0.002140
CHAN A1 (24V): -0.006549
CHAN A2 (12V): -0.001986
CHAN A3 (5V): -0.001409
CHAN B0 (3.3V): 0.000048
CHAN B1 (3.15aV): -0.000089
CHAN B2 (3.15bV): -0.000073
CHAN B3 (GND): 0.000365
OPEN: -0.000576
Full Scale Calc: 4.765 mA, -1.589 mA
2019-02-21T23:12:13.141Z,1550790733.141 [Aanderaa_O2](INFO): Powering down
2019-02-21T23:12:15.140Z,1550790735.140 [PNI_TCM](FAULT): Failed to set parameters during initialization.
2019-02-21T23:12:15.140Z,1550790735.140 [PNI_TCM] Data Fault, FailCount= 4
2019-02-21T23:12:15.140Z,1550790735.140 [PNI_TCM](ERROR): Data Fault
2019-02-21T23:12:15.203Z,1550790735.203 [CBIT](ERROR): Data Fault in component: PNI_TCM
2019-02-21T23:12:15.559Z,1550790735.559 [PNI_TCM](INFO): Powering down
2019-02-21T23:12:17.293Z,1550790737.293 [CBIT](INFO): Clearing failed state for component PNI_TCM
2019-02-21T23:12:17.293Z,1550790737.293 [PNI_TCM] No Fault, FailCount= 4
2019-02-21T23:12:24.261Z,1550790744.261 [NAL9602](ERROR): NAL9602 initialization error.
2019-02-21T23:12:24.261Z,1550790744.261 [NAL9602] Communications Fault, FailCount= 1
2019-02-21T23:12:24.261Z,1550790744.261 [NAL9602](ERROR): Communications Fault
2019-02-21T23:12:24.345Z,1550790744.345 [CBIT](ERROR): Communications Fault in component: NAL9602
2019-02-21T23:12:24.660Z,1550790744.660 [NAL9602](INFO): Powering down
2019-02-21T23:12:24.677Z,1550790744.677 [PNI_TCM](FAULT): Failed to set parameters during initialization.
2019-02-21T23:12:24.677Z,1550790744.677 [PNI_TCM] Data Fault, FailCount= 5
2019-02-21T23:12:24.677Z,1550790744.677 [PNI_TCM](ERROR): Data Fault
2019-02-21T23:12:24.786Z,1550790744.786 [CBIT](ERROR): Data Fault in component: PNI_TCM
2019-02-21T23:12:24.786Z,1550790744.786 [CBIT](CRITICAL): Data Fault in component: PNI_TCM
2019-02-21T23:12:25.075Z,1550790745.075 [PNI_TCM](INFO): Powering down
2019-02-21T23:12:25.172Z,1550790745.172 [CBIT](INFO): Critical error at 20190221T231224
2019-02-21T23:12:25.574Z,1550790745.574 [CBIT](INFO): Clearing failed state for component NAL9602
2019-02-21T23:12:25.574Z,1550790745.574 [NAL9602] No Fault, FailCount= 1
2019-02-21T23:12:26.571Z,1550790746.571 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2019-02-21T23:12:26.571Z,1550790746.571 [CTD_Seabird] Communications Fault, FailCount= 3
2019-02-21T23:12:26.571Z,1550790746.571 [CTD_Seabird](ERROR): Communications Fault
2019-02-21T23:12:26.739Z,1550790746.739 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2019-02-21T23:12:26.740Z,1550790746.740 [CBIT](FAULT): Communications Fault in component: CTD_Seabird
2019-02-21T23:12:26.975Z,1550790746.975 [CTD_Seabird](INFO): Powering down
2019-02-21T23:12:56.061Z,1550790776.061 [NAL9602](INFO): Powering up NAL9602
2019-02-21T23:12:56.985Z,1550790776.985 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004954
2019-02-21T23:13:10.054Z,1550790790.054 [SBIT](IMPORTANT): SBIT PASSED
2019-02-21T23:13:10.216Z,1550790790.216 [CommandLine](IMPORTANT): got command configSet list
2019-02-21T23:13:10.216Z,1550790790.216 [CommandLine](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2019-02-21T23:13:10.216Z,1550790790.216 [CommandLine](IMPORTANT): No configSet variables persisted
2019-02-21T23:13:10.414Z,1550790790.414 [MissionManager](IMPORTANT): Started mission Startup
2019-02-21T23:13:10.414Z,1550790790.414 [Startup] Running Loop=1
2019-02-21T23:13:10.414Z,1550790790.414 [Startup](DEBUG): Aggregate::initialize Startup
2019-02-21T23:13:10.414Z,1550790790.414 [Startup:A.GoToSurface] Running Loop=1
2019-02-21T23:13:10.414Z,1550790790.414 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2019-02-21T23:13:10.435Z,1550790790.435 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2019-02-21T23:13:10.436Z,1550790790.436 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2019-02-21T23:13:10.436Z,1550790790.436 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2019-02-21T23:13:10.436Z,1550790790.436 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2019-02-21T23:13:10.437Z,1550790790.437 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2019-02-21T23:13:10.487Z,1550790790.487 [Startup:StartupSatComms] Running Loop=1
2019-02-21T23:13:10.488Z,1550790790.488 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2019-02-21T23:13:10.488Z,1550790790.488 [Startup:StartupSatComms:A] Running Loop=1
2019-02-21T23:13:10.730Z,1550790790.730 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2019-02-21T23:13:17.105Z,1550790797.105 [NAL9602](ERROR): NAL9602 initialization error.
2019-02-21T23:13:17.105Z,1550790797.105 [NAL9602] Communications Fault, FailCount= 2
2019-02-21T23:13:17.105Z,1550790797.105 [NAL9602](ERROR): Communications Fault
2019-02-21T23:13:17.175Z,1550790797.175 [CBIT](ERROR): Communications Fault in component: NAL9602
2019-02-21T23:13:17.505Z,1550790797.505 [NAL9602](INFO): Powering down
2019-02-21T23:13:18.357Z,1550790798.357 [CBIT](INFO): Clearing failed state for component NAL9602
2019-02-21T23:13:18.358Z,1550790798.358 [NAL9602] No Fault, FailCount= 2
2019-02-21T23:13:37.928Z,1550790817.928 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-02-21T23:13:37.929Z,1550790817.929 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2019-02-21T23:13:37.929Z,1550790817.929 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-02-21T23:13:37.932Z,1550790817.932 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-02-21T23:13:37.932Z,1550790817.932 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 1
2019-02-21T23:13:37.932Z,1550790817.932 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2019-02-21T23:13:37.933Z,1550790817.933 [DeadReckonWithRespectToSeafloor](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-02-21T23:13:37.933Z,1550790817.933 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1
2019-02-21T23:13:37.934Z,1550790817.934 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2019-02-21T23:13:37.994Z,1550790817.994 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-02-21T23:13:37.994Z,1550790817.994 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2019-02-21T23:13:37.994Z,1550790817.994 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2019-02-21T23:13:38.379Z,1550790818.379 [Rowe_600LCM](FAULT): Did not receive valid device response within the specified allowable sample time.
2019-02-21T23:13:38.379Z,1550790818.379 [Rowe_600LCM] Communications Fault, FailCount= 1
2019-02-21T23:13:38.379Z,1550790818.379 [Rowe_600LCM](ERROR): Communications Fault
2019-02-21T23:13:38.405Z,1550790818.405 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-02-21T23:13:38.405Z,1550790818.405 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2019-02-21T23:13:38.405Z,1550790818.405 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2019-02-21T23:13:38.405Z,1550790818.405 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 1
2019-02-21T23:13:38.406Z,1550790818.406 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2019-02-21T23:13:38.406Z,1550790818.406 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1
2019-02-21T23:13:38.406Z,1550790818.406 [CBIT](ERROR): Communications Fault in component: Rowe_600LCM
2019-02-21T23:13:38.741Z,1550790818.741 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2019-02-21T23:13:38.783Z,1550790818.783 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of roweadcp LCM interface
2019-02-21T23:13:39.249Z,1550790819.249 [Rowe_600LCM](INFO): Powering down
2019-02-21T23:13:54.254Z,1550790834.254 [NAL9602](INFO): Powering up NAL9602
2019-02-21T23:13:54.384Z,1550790834.384 [CBIT](INFO): Clearing failed state for component Rowe_600LCM
2019-02-21T23:13:54.384Z,1550790834.384 [Rowe_600LCM] No Fault, FailCount= 1
2019-02-21T23:13:54.599Z,1550790834.599 [Rowe_600LCM](INFO): Initializing
2019-02-21T23:13:54.600Z,1550790834.600 [Rowe_600LCM](INFO): Powering up
2019-02-21T23:13:59.125Z,1550790839.125 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of Rowe LCM interface
2019-02-21T23:13:59.218Z,1550790839.218 [Rowe_600LCM](INFO): Started Rowe LCM interface with command:nohup ./lrauv-framework/onboard/bin/roweadcp -ldir /mnt/mmc/LRAUV/Logs/latest/ -dev /dev/ttyB4 -b 9600 >& /dev/null &
2019-02-21T23:14:10.862Z,1550790850.862 [Startup:StartupSatComms:A](INFO): Timed out from 2019-02-21T23:13:10.5Z
2019-02-21T23:14:10.862Z,1550790850.862 [Startup:StartupSatComms:A] Stopped
2019-02-21T23:14:10.862Z,1550790850.862 [Startup:StartupSatComms:B] Running Loop=1
2019-02-21T23:14:11.634Z,1550790851.634 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2019-02-21T23:14:19.369Z,1550790859.369 [NAL9602](ERROR): NAL9602 initialization error.
2019-02-21T23:14:19.369Z,1550790859.369 [NAL9602] Communications Fault, FailCount= 3
2019-02-21T23:14:19.370Z,1550790859.370 [NAL9602](ERROR): Communications Fault
2019-02-21T23:14:19.455Z,1550790859.455 [CBIT](ERROR): Communications Fault in component: NAL9602
2019-02-21T23:14:20.228Z,1550790860.228 [DataOverHttps](INFO): Sending 69 bytes from file Logs/20190221T230532/Courier0004.lzma
2019-02-21T23:14:20.232Z,1550790860.232 [NAL9602](INFO): Powering down
2019-02-21T23:14:20.700Z,1550790860.700 [DataOverHttps](INFO): Moved sent file to Logs/20190221T230532/Courier0004.lzma.bak
2019-02-21T23:14:20.700Z,1550790860.700 [DataOverHttps](INFO): SBD MOMSN=10067593
2019-02-21T23:14:20.797Z,1550790860.797 [CBIT](INFO): Clearing failed state for component NAL9602
2019-02-21T23:14:20.797Z,1550790860.797 [NAL9602] No Fault, FailCount= 3
2019-02-21T23:14:33.200Z,1550790873.200 [DataOverHttps](INFO): Sending 245 bytes from file Logs/20190221T231117/Courier0000.lzma
2019-02-21T23:14:33.976Z,1550790873.976 [DataOverHttps](INFO): Moved sent file to Logs/20190221T231117/Courier0000.lzma.bak
2019-02-21T23:14:33.976Z,1550790873.976 [DataOverHttps](INFO): SBD MOMSN=10067596
2019-02-21T23:14:48.909Z,1550790888.909 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2019-02-21T23:14:48.909Z,1550790888.909 [Aanderaa_O2] No Fault, FailCount= 3
2019-02-21T23:14:48.961Z,1550790888.961 [DataOverHttps](INFO): Sending 322 bytes from file Logs/20190221T230532/Express0005.lzma
2019-02-21T23:14:49.716Z,1550790889.716 [DataOverHttps](INFO): Moved sent file to Logs/20190221T230532/Express0005.lzma.bak
2019-02-21T23:14:49.716Z,1550790889.716 [DataOverHttps](INFO): SBD MOMSN=10067604
2019-02-21T23:14:50.445Z,1550790890.445 [NAL9602](INFO): Powering up NAL9602
2019-02-21T23:14:56.820Z,1550790896.820 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2019-02-21T23:14:56.820Z,1550790896.820 [CTD_Seabird] No Fault, FailCount= 3
2019-02-21T23:14:57.233Z,1550790897.233 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2019-02-21T23:14:57.237Z,1550790897.237 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20
2019-02-21T23:15:09.043Z,1550790909.043 [Aanderaa_O2](FAULT): Failed to initialize within timeout.
2019-02-21T23:15:09.043Z,1550790909.043 [Aanderaa_O2] Communications Fault, FailCount= 1
2019-02-21T23:15:09.044Z,1550790909.044 [Aanderaa_O2](ERROR): Communications Fault
2019-02-21T23:15:09.075Z,1550790909.075 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2019-02-21T23:15:09.120Z,1550790909.120 [DataOverHttps](INFO): Sending 1032 bytes from file Logs/20190221T231117/Express0001.lzma
2019-02-21T23:15:09.288Z,1550790909.288 [Aanderaa_O2](INFO): Powering down
2019-02-21T23:15:09.892Z,1550790909.892 [DataOverHttps](INFO): Moved sent file to Logs/20190221T231117/Express0001.lzma.bak
2019-02-21T23:15:09.892Z,1550790909.892 [DataOverHttps](INFO): SBD MOMSN=10067619
2019-02-21T23:15:09.950Z,1550790909.950 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2019-02-21T23:15:09.950Z,1550790909.950 [Aanderaa_O2] No Fault, FailCount= 1
2019-02-21T23:15:10.756Z,1550790910.756 [Startup:StartupSatComms:B] Stopped
2019-02-21T23:15:10.756Z,1550790910.756 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2019-02-21T23:15:10.756Z,1550790910.756 [Startup:StartupSatComms] Stopped
2019-02-21T23:15:10.757Z,1550790910.757 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2019-02-21T23:15:10.757Z,1550790910.757 [Startup](INFO): Completed Startup
2019-02-21T23:15:10.758Z,1550790910.758 [MissionManager](INFO): Startup is completed.
2019-02-21T23:15:10.758Z,1550790910.758 [MissionManager](INFO): Uninitializing Mission Startup
2019-02-21T23:15:10.758Z,1550790910.758 [Startup] Stopped
2019-02-21T23:15:10.758Z,1550790910.758 [Startup](DEBUG): Aggregate::uninitialize Startup
2019-02-21T23:15:10.758Z,1550790910.758 [Startup:A.GoToSurface] Stopped
2019-02-21T23:15:10.758Z,1550790910.758 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2019-02-21T23:15:10.886Z,1550790910.886 [MissionManager](IMPORTANT): Started mission Default
2019-02-21T23:15:10.886Z,1550790910.886 [Default] Running Loop=1
2019-02-21T23:15:10.886Z,1550790910.886 [Default](DEBUG): Aggregate::initialize Default
2019-02-21T23:15:10.886Z,1550790910.886 [Default:B.GoToSurface] Running Loop=1
2019-02-21T23:15:10.886Z,1550790910.886 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2019-02-21T23:15:10.887Z,1550790910.887 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2019-02-21T23:15:10.888Z,1550790910.888 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2019-02-21T23:15:10.888Z,1550790910.888 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2019-02-21T23:15:10.888Z,1550790910.888 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2019-02-21T23:15:10.889Z,1550790910.889 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2019-02-21T23:15:10.889Z,1550790910.889 [Default:A.Wait] Running Loop=1
2019-02-21T23:15:10.889Z,1550790910.889 [Default:A.Wait](DEBUG): Initialize Wait Component.
2019-02-21T23:15:11.335Z,1550790911.335 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2019-02-21T23:15:11.335Z,1550790911.335 [CTD_Seabird] Communications Fault, FailCount= 1
2019-02-21T23:15:11.335Z,1550790911.335 [CTD_Seabird](ERROR): Communications Fault
2019-02-21T23:15:11.739Z,1550790911.739 [CTD_Seabird](INFO): Powering down
2019-02-21T23:15:17.031Z,1550790917.031 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2019-02-21T23:15:17.031Z,1550790917.031 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2019-02-21T23:15:17.043Z,1550790917.043 [CTD_Seabird] No Fault, FailCount= 1
2019-02-21T23:15:17.112Z,1550790917.112 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2019-02-21T23:15:17.114Z,1550790917.114 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20
2019-02-21T23:15:19.456Z,1550790919.456 [NAL9602](ERROR): NAL9602 initialization error.
2019-02-21T23:15:19.457Z,1550790919.457 [NAL9602] Communications Fault, FailCount= 4
2019-02-21T23:15:19.457Z,1550790919.457 [NAL9602](ERROR): Communications Fault
2019-02-21T23:15:19.517Z,1550790919.517 [CBIT](ERROR): Communications Fault in component: NAL9602
2019-02-21T23:15:19.860Z,1550790919.860 [NAL9602](INFO): Powering down
2019-02-21T23:15:20.742Z,1550790920.742 [CBIT](INFO): Clearing failed state for component NAL9602
2019-02-21T23:15:20.742Z,1550790920.742 [NAL9602] No Fault, FailCount= 4
2019-02-21T23:15:21.071Z,1550790921.071 [Aanderaa_O2](FAULT): Failed to initialize within timeout.
2019-02-21T23:15:21.071Z,1550790921.071 [Aanderaa_O2] Communications Fault, FailCount= 2
2019-02-21T23:15:21.071Z,1550790921.071 [Aanderaa_O2](ERROR): Communications Fault
2019-02-21T23:15:21.130Z,1550790921.130 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2019-02-21T23:15:21.591Z,1550790921.591 [Aanderaa_O2](INFO): Powering down
2019-02-21T23:15:22.315Z,1550790922.315 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2019-02-21T23:15:22.315Z,1550790922.315 [Aanderaa_O2] No Fault, FailCount= 2
2019-02-21T23:15:24.282Z,1550790924.282 [Default:A.Wait](INFO): Done Waiting.
2019-02-21T23:15:24.282Z,1550790924.282 [Default:A.Wait] Stopped
2019-02-21T23:15:24.282Z,1550790924.282 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2019-02-21T23:15:24.698Z,1550790924.698 [Default:CheckIn] Running Loop=1
2019-02-21T23:15:24.698Z,1550790924.698 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2019-02-21T23:15:24.698Z,1550790924.698 [Default:CheckIn:Read_GPS] Running Loop=1
2019-02-21T23:15:25.082Z,1550790925.082 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2019-02-21T23:15:31.167Z,1550790931.167 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2019-02-21T23:15:31.167Z,1550790931.167 [CTD_Seabird] Communications Fault, FailCount= 2
2019-02-21T23:15:31.167Z,1550790931.167 [CTD_Seabird](ERROR): Communications Fault
2019-02-21T23:15:31.506Z,1550790931.506 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2019-02-21T23:15:31.571Z,1550790931.571 [CTD_Seabird](INFO): Powering down
2019-02-21T23:15:33.077Z,1550790933.077 [Aanderaa_O2](FAULT): Failed to initialize within timeout.
2019-02-21T23:15:33.077Z,1550790933.077 [Aanderaa_O2] Communications Fault, FailCount= 3
2019-02-21T23:15:33.077Z,1550790933.077 [Aanderaa_O2](ERROR): Communications Fault
2019-02-21T23:15:33.108Z,1550790933.108 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2019-02-21T23:15:33.109Z,1550790933.109 [CBIT](FAULT): Communications Fault in component: Aanderaa_O2
2019-02-21T23:15:33.599Z,1550790933.599 [Aanderaa_O2](INFO): Powering down
2019-02-21T23:15:33.651Z,1550790933.651 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2019-02-21T23:15:33.651Z,1550790933.651 [CTD_Seabird] No Fault, FailCount= 2
2019-02-21T23:15:34.528Z,1550790934.528 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2019-02-21T23:15:34.535Z,1550790934.535 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20
2019-02-21T23:15:39.079Z,1550790939.079 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-02-21T23:15:39.079Z,1550790939.079 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2
2019-02-21T23:15:39.079Z,1550790939.079 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-02-21T23:15:39.092Z,1550790939.092 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-02-21T23:15:39.092Z,1550790939.092 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 2
2019-02-21T23:15:39.092Z,1550790939.092 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2019-02-21T23:15:39.093Z,1550790939.093 [DeadReckonWithRespectToSeafloor](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-02-21T23:15:39.093Z,1550790939.093 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 2
2019-02-21T23:15:39.093Z,1550790939.093 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2019-02-21T23:15:39.134Z,1550790939.134 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-02-21T23:15:39.134Z,1550790939.134 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2019-02-21T23:15:39.134Z,1550790939.134 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2019-02-21T23:15:39.514Z,1550790939.514 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-02-21T23:15:39.514Z,1550790939.514 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2
2019-02-21T23:15:39.515Z,1550790939.515 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2019-02-21T23:15:39.515Z,1550790939.515 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 2
2019-02-21T23:15:39.515Z,1550790939.515 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2019-02-21T23:15:39.515Z,1550790939.515 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 2
2019-02-21T23:15:39.899Z,1550790939.899 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2019-02-21T23:15:48.599Z,1550790948.599 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2019-02-21T23:15:48.599Z,1550790948.599 [CTD_Seabird] Communications Fault, FailCount= 3
2019-02-21T23:15:48.599Z,1550790948.599 [CTD_Seabird](ERROR): Communications Fault
2019-02-21T23:15:48.716Z,1550790948.716 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2019-02-21T23:15:48.716Z,1550790948.716 [CBIT](FAULT): Communications Fault in component: CTD_Seabird
2019-02-21T23:15:49.003Z,1550790949.003 [CTD_Seabird](INFO): Powering down
2019-02-21T23:15:50.256Z,1550790950.256 [NAL9602](INFO): Powering up NAL9602
2019-02-21T23:15:55.047Z,1550790955.047 [Rowe_600LCM](FAULT): Did not receive valid device response within the specified allowable sample time.
2019-02-21T23:15:55.047Z,1550790955.047 [Rowe_600LCM] Communications Fault, FailCount= 2
2019-02-21T23:15:55.047Z,1550790955.047 [Rowe_600LCM](ERROR): Communications Fault
2019-02-21T23:15:55.137Z,1550790955.137 [CBIT](ERROR): Communications Fault in component: Rowe_600LCM
2019-02-21T23:15:55.451Z,1550790955.451 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of roweadcp LCM interface
2019-02-21T23:15:55.658Z,1550790955.658 [Rowe_600LCM](INFO): Powering down
2019-02-21T23:15:57.106Z,1550790957.106 [CBIT](INFO): Clearing failed state for component Rowe_600LCM
2019-02-21T23:15:57.106Z,1550790957.106 [Rowe_600LCM] No Fault, FailCount= 2
2019-02-21T23:15:57.275Z,1550790957.275 [Rowe_600LCM](INFO): Initializing
2019-02-21T23:15:57.276Z,1550790957.276 [Rowe_600LCM](INFO): Powering up
2019-02-21T23:16:01.400Z,1550790961.400 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of Rowe LCM interface
2019-02-21T23:16:01.530Z,1550790961.530 [Rowe_600LCM](INFO): Started Rowe LCM interface with command:nohup ./lrauv-framework/onboard/bin/roweadcp -ldir /mnt/mmc/LRAUV/Logs/latest/ -dev /dev/ttyB4 -b 9600 >& /dev/null &
2019-02-21T23:16:11.456Z,1550790971.456 [NAL9602](ERROR): NAL9602 initialization error.
2019-02-21T23:16:11.457Z,1550790971.457 [NAL9602] Communications Fault, FailCount= 5
2019-02-21T23:16:11.457Z,1550790971.457 [NAL9602](ERROR): Communications Fault
2019-02-21T23:16:11.528Z,1550790971.528 [CBIT](ERROR): Communications Fault in component: NAL9602
2019-02-21T23:16:11.528Z,1550790971.528 [CBIT](CRITICAL): Communications Fault in component: NAL9602
2019-02-21T23:16:14.679Z,1550790974.679 [NAL9602](INFO): Powering down
2019-02-21T23:16:14.711Z,1550790974.711 [CBIT](INFO): Critical error at 20190221T231611
2019-02-21T23:17:18.604Z,1550791038.604 [DataOverHttps](IMPORTANT): SBD MTMSN=20190221T231410
2019-02-21T23:17:25.657Z,1550791045.657 [CBIT](INFO): Clearing failed state for component PNI_TCM
2019-02-21T23:17:25.657Z,1550791045.657 [PNI_TCM] No Fault, FailCount= 5
2019-02-21T23:17:25.719Z,1550791045.719 [DataOverHttps](INFO): Received command:restart hardware
2019-02-21T23:17:25.763Z,1550791045.763 [CommandLine](IMPORTANT): got command restart hardware
2019-02-21T23:17:25.764Z,1550791045.764 [CommandLine](IMPORTANT): restart hardware is deprecated, executing restart system instead
2019-02-21T23:17:32.900Z,1550791052.900 [PNI_TCM](FAULT): Failed to set parameters during initialization.
2019-02-21T23:17:32.901Z,1550791052.901 [PNI_TCM] Data Fault, FailCount= 1
2019-02-21T23:17:32.901Z,1550791052.901 [PNI_TCM](ERROR): Data Fault
2019-02-21T23:17:32.961Z,1550791052.961 [CBIT](ERROR): Data Fault in component: PNI_TCM
2019-02-21T23:17:33.300Z,1550791053.300 [PNI_TCM](INFO): Powering down
2019-02-21T23:17:34.566Z,1550791054.566 [CBIT](INFO): Clearing failed state for component PNI_TCM
2019-02-21T23:17:34.566Z,1550791054.566 [PNI_TCM] No Fault, FailCount= 1
2019-02-21T23:17:40.107Z,1550791060.107 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-02-21T23:17:40.107Z,1550791060.107 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3
2019-02-21T23:17:40.107Z,1550791060.107 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-02-21T23:17:40.109Z,1550791060.109 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-02-21T23:17:40.109Z,1550791060.109 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 3
2019-02-21T23:17:40.109Z,1550791060.109 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2019-02-21T23:17:40.143Z,1550791060.143 [DeadReckonWithRespectToSeafloor](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-02-21T23:17:40.143Z,1550791060.143 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 3
2019-02-21T23:17:40.143Z,1550791060.143 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2019-02-21T23:17:40.173Z,1550791060.173 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-02-21T23:17:40.173Z,1550791060.173 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2019-02-21T23:17:40.174Z,1550791060.174 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2019-02-21T23:17:40.518Z,1550791060.518 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-02-21T23:17:40.518Z,1550791060.518 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3
2019-02-21T23:17:40.558Z,1550791060.558 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2019-02-21T23:17:40.558Z,1550791060.558 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 3
2019-02-21T23:17:40.559Z,1550791060.559 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2019-02-21T23:17:40.559Z,1550791060.559 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 3
2019-02-21T23:17:40.907Z,1550791060.907 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2019-02-21T23:17:42.101Z,1550791062.101 [PNI_TCM](FAULT): Failed to set parameters during initialization.
2019-02-21T23:17:42.101Z,1550791062.101 [PNI_TCM] Data Fault, FailCount= 2
2019-02-21T23:17:42.101Z,1550791062.101 [PNI_TCM](ERROR): Data Fault
2019-02-21T23:17:42.173Z,1550791062.173 [CBIT](ERROR): Data Fault in component: PNI_TCM
2019-02-21T23:17:42.500Z,1550791062.500 [PNI_TCM](INFO): Powering down
2019-02-21T23:17:43.742Z,1550791063.742 [CBIT](INFO): Clearing failed state for component PNI_TCM
2019-02-21T23:17:43.742Z,1550791063.742 [PNI_TCM] No Fault, FailCount= 2
2019-02-21T23:17:51.303Z,1550791071.303 [PNI_TCM](FAULT): Failed to set parameters during initialization.
2019-02-21T23:17:51.304Z,1550791071.304 [PNI_TCM] Data Fault, FailCount= 3
2019-02-21T23:17:51.304Z,1550791071.304 [PNI_TCM](ERROR): Data Fault
2019-02-21T23:17:51.410Z,1550791071.410 [CBIT](ERROR): Data Fault in component: PNI_TCM
2019-02-21T23:17:51.708Z,1550791071.708 [PNI_TCM](INFO): Powering down
2019-02-21T23:17:52.924Z,1550791072.924 [CBIT](INFO): Clearing failed state for component PNI_TCM
2019-02-21T23:17:52.924Z,1550791072.924 [PNI_TCM] No Fault, FailCount= 3
2019-02-21T23:17:57.775Z,1550791077.775 [Rowe_600LCM](FAULT): Did not receive valid device response within the specified allowable sample time.
2019-02-21T23:17:57.775Z,1550791077.775 [Rowe_600LCM] Communications Fault, FailCount= 3
2019-02-21T23:17:57.775Z,1550791077.775 [Rowe_600LCM](ERROR): Communications Fault
2019-02-21T23:17:58.143Z,1550791078.143 [CBIT](ERROR): Communications Fault in component: Rowe_600LCM
2019-02-21T23:17:58.179Z,1550791078.179 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of roweadcp LCM interface
2019-02-21T23:17:58.321Z,1550791078.321 [Rowe_600LCM](INFO): Powering down
2019-02-21T23:17:59.714Z,1550791079.714 [CBIT](INFO): Clearing failed state for component Rowe_600LCM
2019-02-21T23:17:59.714Z,1550791079.714 [Rowe_600LCM] No Fault, FailCount= 3
2019-02-21T23:17:59.935Z,1550791079.935 [Rowe_600LCM](INFO): Initializing
2019-02-21T23:17:59.936Z,1550791079.936 [Rowe_600LCM](INFO): Powering up
2019-02-21T23:18:00.499Z,1550791080.499 [PNI_TCM](FAULT): Failed to set parameters during initialization.
2019-02-21T23:18:00.499Z,1550791080.499 [PNI_TCM] Data Fault, FailCount= 4
2019-02-21T23:18:00.499Z,1550791080.499 [PNI_TCM](ERROR): Data Fault
2019-02-21T23:18:00.553Z,1550791080.553 [CBIT](ERROR): Data Fault in component: PNI_TCM
2019-02-21T23:18:00.899Z,1550791080.899 [PNI_TCM](INFO): Powering down
2019-02-21T23:18:02.121Z,1550791082.121 [CBIT](INFO): Clearing failed state for component PNI_TCM
2019-02-21T23:18:02.121Z,1550791082.121 [PNI_TCM] No Fault, FailCount= 4
2019-02-21T23:18:03.352Z,1550791083.352 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2019-02-21T23:18:03.352Z,1550791083.352 [Aanderaa_O2] No Fault, FailCount= 3
2019-02-21T23:18:04.118Z,1550791084.118 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of Rowe LCM interface
2019-02-21T23:18:04.282Z,1550791084.282 [Rowe_600LCM](INFO): Started Rowe LCM interface with command:nohup ./lrauv-framework/onboard/bin/roweadcp -ldir /mnt/mmc/LRAUV/Logs/latest/ -dev /dev/ttyB4 -b 9600 >& /dev/null &
2019-02-21T23:18:09.706Z,1550791089.706 [PNI_TCM](FAULT): Failed to set parameters during initialization.
2019-02-21T23:18:09.706Z,1550791089.706 [PNI_TCM] Data Fault, FailCount= 5
2019-02-21T23:18:09.706Z,1550791089.706 [PNI_TCM](ERROR): Data Fault
2019-02-21T23:18:09.726Z,1550791089.726 [CBIT](ERROR): Data Fault in component: PNI_TCM
2019-02-21T23:18:09.727Z,1550791089.727 [CBIT](CRITICAL): Data Fault in component: PNI_TCM
2019-02-21T23:18:10.107Z,1550791090.107 [PNI_TCM](INFO): Powering down
2019-02-21T23:18:10.131Z,1550791090.131 [CBIT](INFO): Critical error at 20190221T231809
2019-02-21T23:18:11.724Z,1550791091.724 [CBIT](INFO): Clearing failed state for component NAL9602
2019-02-21T23:18:11.724Z,1550791091.724 [NAL9602] No Fault, FailCount= 5
2019-02-21T23:18:12.084Z,1550791092.084 [NAL9602](INFO): Powering up NAL9602
2019-02-21T23:18:13.707Z,1550791093.707 [Aanderaa_O2](FAULT): Failed to initialize within timeout.
2019-02-21T23:18:13.707Z,1550791093.707 [Aanderaa_O2] Communications Fault, FailCount= 1
2019-02-21T23:18:13.707Z,1550791093.707 [Aanderaa_O2](ERROR): Communications Fault
2019-02-21T23:18:13.765Z,1550791093.765 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2019-02-21T23:18:14.100Z,1550791094.100 [Aanderaa_O2](INFO): Powering down
2019-02-21T23:18:14.933Z,1550791094.933 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2019-02-21T23:18:14.933Z,1550791094.933 [Aanderaa_O2] No Fault, FailCount= 1
2019-02-21T23:18:18.940Z,1550791098.940 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2019-02-21T23:18:18.940Z,1550791098.940 [CTD_Seabird] No Fault, FailCount= 3
2019-02-21T23:18:19.075Z,1550791099.075 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2019-02-21T23:18:19.077Z,1550791099.077 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20
2019-02-21T23:18:28.033Z,1550791108.033 [Aanderaa_O2](FAULT): Failed to initialize within timeout.
2019-02-21T23:18:28.033Z,1550791108.033 [Aanderaa_O2] Communications Fault, FailCount= 2
2019-02-21T23:18:28.033Z,1550791108.033 [Aanderaa_O2](ERROR): Communications Fault
2019-02-21T23:18:28.073Z,1550791108.073 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2019-02-21T23:18:28.158Z,1550791108.158 [Aanderaa_O2](INFO): Powering down
2019-02-21T23:18:28.952Z,1550791108.952 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2019-02-21T23:18:28.952Z,1550791108.952 [Aanderaa_O2] No Fault, FailCount= 2
2019-02-21T23:18:33.149Z,1550791113.149 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2019-02-21T23:18:33.149Z,1550791113.149 [CTD_Seabird] Communications Fault, FailCount= 1
2019-02-21T23:18:33.149Z,1550791113.149 [CTD_Seabird](ERROR): Communications Fault
2019-02-21T23:18:33.377Z,1550791113.377 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2019-02-21T23:18:33.551Z,1550791113.551 [CTD_Seabird](INFO): Powering down
2019-02-21T23:18:35.757Z,1550791115.757 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2019-02-21T23:18:35.757Z,1550791115.757 [CTD_Seabird] No Fault, FailCount= 1
2019-02-21T23:18:36.501Z,1550791116.501 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2019-02-21T23:18:36.504Z,1550791116.504 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20
2019-02-21T23:18:38.489Z,1550791118.489 [NAL9602](ERROR): NAL9602 initialization error.
2019-02-21T23:18:38.489Z,1550791118.489 [NAL9602] Communications Fault, FailCount= 1
2019-02-21T23:18:38.489Z,1550791118.489 [NAL9602](ERROR): Communications Fault
2019-02-21T23:18:38.546Z,1550791118.546 [CBIT](ERROR): Communications Fault in component: NAL9602
2019-02-21T23:18:38.889Z,1550791118.889 [NAL9602](INFO): Powering down
2019-02-21T23:18:39.306Z,1550791119.306 [Aanderaa_O2](FAULT): Failed to initialize within timeout.
2019-02-21T23:18:39.306Z,1550791119.306 [Aanderaa_O2] Communications Fault, FailCount= 3
2019-02-21T23:18:39.306Z,1550791119.306 [Aanderaa_O2](ERROR): Communications Fault
2019-02-21T23:18:39.350Z,1550791119.350 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2019-02-21T23:18:39.351Z,1550791119.351 [CBIT](FAULT): Communications Fault in component: Aanderaa_O2
2019-02-21T23:18:39.701Z,1550791119.701 [Aanderaa_O2](INFO): Powering down
2019-02-21T23:18:39.757Z,1550791119.757 [CBIT](INFO): Clearing failed state for component NAL9602
2019-02-21T23:18:39.757Z,1550791119.757 [NAL9602] No Fault, FailCount= 1
2019-02-21T23:18:50.543Z,1550791130.543 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2019-02-21T23:18:50.543Z,1550791130.543 [CTD_Seabird] Communications Fault, FailCount= 2
2019-02-21T23:18:50.543Z,1550791130.543 [CTD_Seabird](ERROR): Communications Fault
2019-02-21T23:18:50.947Z,1550791130.947 [CTD_Seabird](INFO): Powering down
2019-02-21T23:18:50.957Z,1550791130.957 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2019-02-21T23:18:52.941Z,1550791132.941 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2019-02-21T23:18:52.941Z,1550791132.941 [CTD_Seabird] No Fault, FailCount= 2
2019-02-21T23:18:53.895Z,1550791133.895 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2019-02-21T23:18:53.907Z,1550791133.907 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20
2019-02-21T23:19:07.955Z,1550791147.955 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2019-02-21T23:19:07.955Z,1550791147.955 [CTD_Seabird] Communications Fault, FailCount= 3
2019-02-21T23:19:07.955Z,1550791147.955 [CTD_Seabird](ERROR): Communications Fault
2019-02-21T23:19:08.146Z,1550791148.146 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2019-02-21T23:19:08.147Z,1550791148.147 [CBIT](FAULT): Communications Fault in component: CTD_Seabird
2019-02-21T23:19:08.359Z,1550791148.359 [CTD_Seabird](INFO): Powering down
2019-02-21T23:19:09.292Z,1550791149.292 [NAL9602](INFO): Powering up NAL9602
2019-02-21T23:19:30.368Z,1550791170.368 [NAL9602](ERROR): NAL9602 initialization error.
2019-02-