2019-02-07T23:49:12.625Z,1549583352.625 [Supervisor](DEBUG): Initializing supervisor.
2019-02-07T23:49:12.628Z,1549583352.628 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2019-02-07T23:49:12.629Z,1549583352.629 [SyncHandler](INFO): Protected caller Thread ID is 8226
2019-02-07T23:49:12.629Z,1549583352.629 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2019-02-07T23:49:12.630Z,1549583352.630 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2019-02-07T23:49:12.631Z,1549583352.631 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 8227
2019-02-07T23:49:12.634Z,1549583352.634 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2019-02-07T23:49:12.662Z,1549583352.662 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2019-02-07T23:49:12.663Z,1549583352.663 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2019-02-07T23:49:12.663Z,1549583352.663 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 8228
2019-02-07T23:49:12.666Z,1549583352.666 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2019-02-07T23:49:12.667Z,1549583352.667 [logger ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2019-02-07T23:49:12.667Z,1549583352.667 [logger ThreadHandler](INFO): Protected caller Thread ID is 8229
2019-02-07T23:49:12.669Z,1549583352.669 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2019-02-07T23:49:12.670Z,1549583352.670 [Supervisor](INFO): Looking for Config files in directory: Config/
2019-02-07T23:49:12.675Z,1549583352.675 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2019-02-07T23:49:13.108Z,1549583353.108 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2019-02-07T23:49:13.109Z,1549583353.109 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2019-02-07T23:49:13.545Z,1549583353.545 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2019-02-07T23:49:13.545Z,1549583353.545 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2019-02-07T23:49:13.863Z,1549583353.863 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2019-02-07T23:49:13.864Z,1549583353.864 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2019-02-07T23:49:14.052Z,1549583354.052 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2019-02-07T23:49:14.053Z,1549583354.053 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2019-02-07T23:49:14.489Z,1549583354.489 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2019-02-07T23:49:14.489Z,1549583354.489 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2019-02-07T23:49:14.956Z,1549583354.956 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2019-02-07T23:49:14.957Z,1549583354.957 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2019-02-07T23:49:15.058Z,1549583355.058 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2019-02-07T23:49:15.059Z,1549583355.059 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2019-02-07T23:49:15.248Z,1549583355.248 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2019-02-07T23:49:15.248Z,1549583355.248 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2019-02-07T23:49:15.389Z,1549583355.389 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2019-02-07T23:49:15.390Z,1549583355.390 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2019-02-07T23:49:15.469Z,1549583355.469 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2019-02-07T23:49:15.674Z,1549583355.674 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2019-02-07T23:49:15.675Z,1549583355.675 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2019-02-07T23:49:15.775Z,1549583355.775 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample
2019-02-07T23:49:15.776Z,1549583355.776 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2019-02-07T23:49:15.870Z,1549583355.870 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2019-02-07T23:49:15.871Z,1549583355.871 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2019-02-07T23:49:16.026Z,1549583356.026 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2019-02-07T23:49:16.026Z,1549583356.026 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2019-02-07T23:49:16.338Z,1549583356.338 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2019-02-07T23:49:16.340Z,1549583356.340 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-whoidhs/
2019-02-07T23:49:16.341Z,1549583356.341 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Science.cfg
2019-02-07T23:49:16.473Z,1549583356.473 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Battery.cfg
2019-02-07T23:49:16.700Z,1549583356.700 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2019-02-07T23:49:16.701Z,1549583356.701 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Sensor.cfg
2019-02-07T23:49:16.864Z,1549583356.864 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Control.cfg
2019-02-07T23:49:16.962Z,1549583356.962 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/BIT.cfg
2019-02-07T23:49:17.059Z,1549583357.059 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/vehicle.cfg
2019-02-07T23:49:17.249Z,1549583357.249 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Simulator.cfg
2019-02-07T23:49:17.332Z,1549583357.332 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/logger.cfg
2019-02-07T23:49:17.428Z,1549583357.428 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Navigation.cfg
2019-02-07T23:49:17.519Z,1549583357.519 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/secure.cfg
2019-02-07T23:49:17.600Z,1549583357.600 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Servo.cfg
2019-02-07T23:49:17.713Z,1549583357.713 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-whoidhs/root/
2019-02-07T23:49:17.713Z,1549583357.713 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg
2019-02-07T23:49:17.718Z,1549583357.718 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2019-02-07T23:49:18.041Z,1549583358.041 [SBIT](DEBUG): Construct Startup Built In Test.
2019-02-07T23:49:18.070Z,1549583358.070 [SBIT] Loaded
2019-02-07T23:49:18.071Z,1549583358.071 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2019-02-07T23:49:18.071Z,1549583358.071 [IBIT](DEBUG): Construct Initiated Built In Test.
2019-02-07T23:49:18.099Z,1549583358.099 [IBIT] Loaded
2019-02-07T23:49:18.099Z,1549583358.099 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2019-02-07T23:49:18.103Z,1549583358.103 [CBIT](DEBUG): Construct Continuous Built In Test.
2019-02-07T23:49:18.586Z,1549583358.586 [CBIT] Loaded
2019-02-07T23:49:18.586Z,1549583358.586 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2019-02-07T23:49:18.586Z,1549583358.586 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2019-02-07T23:49:18.587Z,1549583358.587 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2019-02-07T23:49:18.711Z,1549583358.711 [BuoyancyServo] Loaded
2019-02-07T23:49:18.712Z,1549583358.712 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2019-02-07T23:49:18.726Z,1549583358.726 [ElevatorServo] Loaded
2019-02-07T23:49:18.726Z,1549583358.726 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2019-02-07T23:49:18.740Z,1549583358.740 [MassServo] Loaded
2019-02-07T23:49:18.740Z,1549583358.740 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2019-02-07T23:49:18.756Z,1549583358.756 [RudderServo] Loaded
2019-02-07T23:49:18.756Z,1549583358.756 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2019-02-07T23:49:18.770Z,1549583358.770 [ThrusterServo] Loaded
2019-02-07T23:49:18.770Z,1549583358.770 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread.
2019-02-07T23:49:18.770Z,1549583358.770 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2019-02-07T23:49:18.771Z,1549583358.771 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2019-02-07T23:49:18.874Z,1549583358.874 [DeadReckonUsingMultipleVelocitySources] Loaded
2019-02-07T23:49:18.874Z,1549583358.874 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2019-02-07T23:49:18.932Z,1549583358.932 [DeadReckonUsingSpeedCalculator] Loaded
2019-02-07T23:49:18.933Z,1549583358.933 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread.
2019-02-07T23:49:18.990Z,1549583358.990 [DeadReckonWithRespectToSeafloor] Loaded
2019-02-07T23:49:18.991Z,1549583358.991 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonWithRespectToSeafloor" handled in the control thread.
2019-02-07T23:49:19.007Z,1549583359.007 [NavChart] Loaded
2019-02-07T23:49:19.007Z,1549583359.007 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2019-02-07T23:49:19.011Z,1549583359.011 [UniversalFixResidualReporter] Loaded
2019-02-07T23:49:19.011Z,1549583359.011 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2019-02-07T23:49:19.011Z,1549583359.011 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2019-02-07T23:49:19.012Z,1549583359.012 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2019-02-07T23:49:19.026Z,1549583359.026 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2019-02-07T23:49:19.026Z,1549583359.026 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2019-02-07T23:49:19.257Z,1549583359.257 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2019-02-07T23:49:19.258Z,1549583359.258 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2019-02-07T23:49:19.589Z,1549583359.589 [AHRS_M2] Loaded
2019-02-07T23:49:19.589Z,1549583359.589 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread.
2019-02-07T23:49:19.656Z,1549583359.656 [DataOverHttps] Loaded
2019-02-07T23:49:19.656Z,1549583359.656 [ComponentRegistry](DEBUG): SyncComponent "DataOverHttps" handled in the control thread.
2019-02-07T23:49:19.669Z,1549583359.669 [Depth_Keller] Loaded
2019-02-07T23:49:19.669Z,1549583359.669 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2019-02-07T23:49:19.674Z,1549583359.674 [DropWeight] Loaded
2019-02-07T23:49:19.674Z,1549583359.674 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2019-02-07T23:49:19.725Z,1549583359.725 [DUSBL_Hydroid] Loaded
2019-02-07T23:49:19.725Z,1549583359.725 [ComponentRegistry](DEBUG): SyncComponent "DUSBL_Hydroid" handled in the control thread.
2019-02-07T23:49:19.814Z,1549583359.814 [NAL9602] Loaded
2019-02-07T23:49:19.814Z,1549583359.814 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2019-02-07T23:49:19.819Z,1549583359.819 [Onboard] Loaded
2019-02-07T23:49:19.819Z,1549583359.819 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread.
2019-02-07T23:49:19.826Z,1549583359.826 [Radio_Surface] Loaded
2019-02-07T23:49:19.826Z,1549583359.826 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2019-02-07T23:49:19.827Z,1549583359.827 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 408494E0
2019-02-07T23:49:19.828Z,1549583359.828 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 8308
2019-02-07T23:49:19.856Z,1549583359.856 [RDI_Pathfinder] Loaded
2019-02-07T23:49:19.856Z,1549583359.856 [ComponentRegistry](DEBUG): SyncComponent "RDI_Pathfinder" handled in the control thread.
2019-02-07T23:49:19.877Z,1549583359.877 [RDI_PathfinderUp] Loaded
2019-02-07T23:49:19.878Z,1549583359.878 [ComponentRegistry](DEBUG): SyncComponent "RDI_PathfinderUp" handled in the control thread.
2019-02-07T23:49:22.094Z,1549583362.094 [BPC1] Loaded
2019-02-07T23:49:22.094Z,1549583362.094 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2019-02-07T23:49:22.094Z,1549583362.094 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2019-02-07T23:49:22.095Z,1549583362.095 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2019-02-07T23:49:22.163Z,1549583362.163 [VerticalControl](DEBUG): Construct VerticalControl.
2019-02-07T23:49:22.249Z,1549583362.249 [VerticalControl] Loaded
2019-02-07T23:49:22.249Z,1549583362.249 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2019-02-07T23:49:22.250Z,1549583362.250 [HorizontalControl](DEBUG): Construct HorizontalControl.
2019-02-07T23:49:22.307Z,1549583362.307 [HorizontalControl] Loaded
2019-02-07T23:49:22.307Z,1549583362.307 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2019-02-07T23:49:22.308Z,1549583362.308 [SpeedControl](DEBUG): Construct SpeedControl.
2019-02-07T23:49:22.310Z,1549583362.310 [SpeedControl] Loaded
2019-02-07T23:49:22.310Z,1549583362.310 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2019-02-07T23:49:22.311Z,1549583362.311 [LoopControl](DEBUG): Construct LoopControl.
2019-02-07T23:49:22.311Z,1549583362.311 [LoopControl] Loaded
2019-02-07T23:49:22.311Z,1549583362.311 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2019-02-07T23:49:22.312Z,1549583362.312 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2019-02-07T23:49:22.312Z,1549583362.312 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2019-02-07T23:49:22.410Z,1549583362.410 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2019-02-07T23:49:22.411Z,1549583362.411 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2019-02-07T23:49:22.592Z,1549583362.592 [Aanderaa_O2] Loaded
2019-02-07T23:49:22.593Z,1549583362.593 [ComponentRegistry](DEBUG): SyncComponent "Aanderaa_O2" handled in the control thread.
2019-02-07T23:49:22.676Z,1549583362.676 [CTD_NeilBrown] Loaded
2019-02-07T23:49:22.676Z,1549583362.676 [ComponentRegistry](DEBUG): Component "CTD_NeilBrown" handled in its own thread.
2019-02-07T23:49:22.677Z,1549583362.677 [CTD_NeilBrown ThreadHandler](DEBUG): Created PCaller Thread at 4095A4E0
2019-02-07T23:49:22.678Z,1549583362.678 [CTD_NeilBrown ThreadHandler](INFO): Protected caller Thread ID is 8309
2019-02-07T23:49:22.723Z,1549583362.723 [WetLabsSeaOWL_UV_A] Loaded
2019-02-07T23:49:22.723Z,1549583362.723 [ComponentRegistry](DEBUG): Component "WetLabsSeaOWL_UV_A" handled in its own thread.
2019-02-07T23:49:22.724Z,1549583362.724 [WetLabsSeaOWL_UV_A ThreadHandler](DEBUG): Created PCaller Thread at 4098A4E0
2019-02-07T23:49:22.724Z,1549583362.724 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Protected caller Thread ID is 8310
2019-02-07T23:49:22.725Z,1549583362.725 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2019-02-07T23:49:22.725Z,1549583362.725 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2019-02-07T23:49:22.889Z,1549583362.889 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2019-02-07T23:49:22.889Z,1549583362.889 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2019-02-07T23:49:22.929Z,1549583362.929 [DepthRateCalculator] Loaded
2019-02-07T23:49:22.929Z,1549583362.929 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2019-02-07T23:49:22.934Z,1549583362.934 [PitchRateCalculator] Loaded
2019-02-07T23:49:22.935Z,1549583362.935 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2019-02-07T23:49:22.946Z,1549583362.946 [SpeedCalculator] Loaded
2019-02-07T23:49:22.947Z,1549583362.947 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2019-02-07T23:49:22.968Z,1549583362.968 [TempGradientCalculator] Loaded
2019-02-07T23:49:22.968Z,1549583362.968 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread.
2019-02-07T23:49:22.973Z,1549583362.973 [YawRateCalculator] Loaded
2019-02-07T23:49:22.973Z,1549583362.973 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2019-02-07T23:49:23.002Z,1549583363.002 [ElevatorOffsetCalculator] Loaded
2019-02-07T23:49:23.003Z,1549583363.003 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2019-02-07T23:49:23.003Z,1549583363.003 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2019-02-07T23:49:23.004Z,1549583363.004 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2019-02-07T23:49:23.030Z,1549583363.030 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2019-02-07T23:49:23.034Z,1549583363.034 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2019-02-07T23:49:23.035Z,1549583363.035 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2019-02-07T23:49:23.041Z,1549583363.041 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2019-02-07T23:49:23.042Z,1549583363.042 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40A464E0
2019-02-07T23:49:23.043Z,1549583363.043 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 8311
2019-02-07T23:49:23.047Z,1549583363.047 [Supervisor](INFO): Main Thread ID is 8078
2019-02-07T23:49:23.047Z,1549583363.047 [Supervisor](DEBUG): Running supervisor.
2019-02-07T23:49:23.048Z,1549583363.048 [CommandLine ThreadHandler](INFO): Handler Thread ID is 8312
2019-02-07T23:49:23.051Z,1549583363.051 [controlThread ThreadHandler](INFO): Handler Thread ID is 8313
2019-02-07T23:49:23.051Z,1549583363.051 [controlThread](DEBUG): Initializing ControlThread
2019-02-07T23:49:23.052Z,1549583363.052 [SBIT](INFO): Initialize SBIT Component.
2019-02-07T23:49:23.052Z,1549583363.052 [SBIT](IMPORTANT): git: 2019-01-14A-54-g0d094c9
2019-02-07T23:49:23.053Z,1549583363.053 [SBIT](INFO): git hash: 0d094c9fe207dedbc4f0c5a93b42d412b4ef2ca6
2019-02-07T23:49:23.053Z,1549583363.053 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2019-02-07T23:49:23.053Z,1549583363.053 [SBIT](IMPORTANT): Kernel Version:#2 PREEMPT Thu Jan 11 20:13:48 PST 2018
2019-02-07T23:49:23.054Z,1549583363.054 [SBIT](INFO): Beginning SBIT in 28.000000 seconds.
2019-02-07T23:49:23.055Z,1549583363.055 [IBIT](INFO): Initialize IBIT Component.
2019-02-07T23:49:23.056Z,1549583363.056 [CBIT](DEBUG): Initialize CBIT Component.
2019-02-07T23:49:23.056Z,1549583363.056 [logger ThreadHandler](INFO): Handler Thread ID is 8314
2019-02-07T23:49:23.070Z,1549583363.070 [CBIT](DEBUG): Initialized mux pins.
2019-02-07T23:49:23.070Z,1549583363.070 [CBIT](DEBUG): Initializing the watchdog timer.
2019-02-07T23:49:23.082Z,1549583363.082 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 8315
2019-02-07T23:49:23.088Z,1549583363.088 [Radio_Surface](INFO): Powering up
2019-02-07T23:49:23.094Z,1549583363.094 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2019-02-07T23:49:23.094Z,1549583363.094 [CBIT](DEBUG): Initializing heartbeat.
2019-02-07T23:49:23.095Z,1549583363.095 [CTD_NeilBrown ThreadHandler](INFO): Handler Thread ID is 8316
2019-02-07T23:49:23.096Z,1549583363.096 [CTD_NeilBrown](INFO): Powering down
2019-02-07T23:49:23.130Z,1549583363.130 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Handler Thread ID is 8317
2019-02-07T23:49:23.131Z,1549583363.131 [WetLabsSeaOWL_UV_A](INFO): Powering down
2019-02-07T23:49:23.162Z,1549583363.162 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 8318
2019-02-07T23:49:23.165Z,1549583363.165 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2019-02-07T23:49:23.166Z,1549583363.166 [CBIT](DEBUG): Deactivating GF circuits.
2019-02-07T23:49:23.166Z,1549583363.166 [CBIT](DEBUG): Deactivating emergency mode.
2019-02-07T23:49:23.166Z,1549583363.166 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2019-02-07T23:49:23.166Z,1549583363.166 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2019-02-07T23:49:23.166Z,1549583363.166 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2019-02-07T23:49:23.167Z,1549583363.167 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2019-02-07T23:49:23.167Z,1549583363.167 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2019-02-07T23:49:23.167Z,1549583363.167 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000
2019-02-07T23:49:23.167Z,1549583363.167 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000
2019-02-07T23:49:23.167Z,1549583363.167 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2019-02-07T23:49:23.168Z,1549583363.168 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2019-02-07T23:49:23.168Z,1549583363.168 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000
2019-02-07T23:49:23.168Z,1549583363.168 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000
2019-02-07T23:49:23.168Z,1549583363.168 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000
2019-02-07T23:49:23.168Z,1549583363.168 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000
2019-02-07T23:49:23.169Z,1549583363.169 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000
2019-02-07T23:49:23.169Z,1549583363.169 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000
2019-02-07T23:49:23.203Z,1549583363.203 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2019-02-07T23:49:23.204Z,1549583363.204 [NavChart](DEBUG): Initialize NavChart Navigation.
2019-02-07T23:49:23.204Z,1549583363.204 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2019-02-07T23:49:23.209Z,1549583363.209 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2019-02-07T23:49:23.211Z,1549583363.211 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2019-02-07T23:49:23.211Z,1549583363.211 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2019-02-07T23:49:23.212Z,1549583363.212 [LoopControl](DEBUG): Initialize LoopControlComponent.
2019-02-07T23:49:23.212Z,1549583363.212 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2019-02-07T23:49:23.213Z,1549583363.213 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2019-02-07T23:49:23.213Z,1549583363.213 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2019-02-07T23:49:23.214Z,1549583363.214 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator.
2019-02-07T23:49:23.214Z,1549583363.214 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2019-02-07T23:49:23.215Z,1549583363.215 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2019-02-07T23:49:23.216Z,1549583363.216 [MissionManager](INFO): Loading Mission: Missions/Startup.xml
2019-02-07T23:49:23.239Z,1549583363.239 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2019-02-07T23:49:23.271Z,1549583363.271 [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-07T23:49:23.272Z,1549583363.272 [MissionManager](INFO): Loading Mission: Missions/Default.xml
2019-02-07T23:49:23.352Z,1549583363.352 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2019-02-07T23:49:23.354Z,1549583363.354 [Default:A.Wait](DEBUG): Construct Wait.
2019-02-07T23:49:23.355Z,1549583363.355 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2019-02-07T23:49:23.404Z,1549583363.404 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2019-02-07T23:49:23.427Z,1549583363.427 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2019-02-07T23:49:23.432Z,1549583363.432 [Default:E.Execute](DEBUG): Construct Execute.
2019-02-07T23:49:23.452Z,1549583363.452 [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-07T23:49:23.462Z,1549583363.462 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,DataOverHttps,Depth_Keller,DropWeight,DUSBL_Hydroid,NAL9602,Onboard,RDI_Pathfinder,RDI_PathfinderUp,BPC1,Aanderaa_O2,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-02-07T23:49:23.474Z,1549583363.474 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2019-02-07T23:49:23.521Z,1549583363.521 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2019-02-07T23:49:23.545Z,1549583363.545 [Depth_Keller](ERROR): Pressure reading out of range: 1913.424561 decibar
2019-02-07T23:49:23.586Z,1549583363.586 [DUSBL_Hydroid](INFO): Start
2019-02-07T23:49:23.586Z,1549583363.586 [DUSBL_Hydroid](INFO): Powering up
2019-02-07T23:49:23.586Z,1549583363.586 [DUSBL_Hydroid](DEBUG): Initializing DUSBL_Hydroid.
2019-02-07T23:49:23.755Z,1549583363.755 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-02-07T23:49:23.978Z,1549583363.978 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2019-02-07T23:49:23.986Z,1549583363.986 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2019-02-07T23:49:24.008Z,1549583364.008 [ElevatorServo](DEBUG): Initializing EZServoServo.
2019-02-07T23:49:24.014Z,1549583364.014 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2019-02-07T23:49:24.020Z,1549583364.020 [MassServo](DEBUG): Initializing EZServoServo.
2019-02-07T23:49:24.026Z,1549583364.026 [MassServo](DEBUG): Initializing MassServo.
2019-02-07T23:49:24.032Z,1549583364.032 [RudderServo](DEBUG): Initializing EZServoServo.
2019-02-07T23:49:24.038Z,1549583364.038 [RudderServo](DEBUG): Initializing RudderServo.
2019-02-07T23:49:24.060Z,1549583364.060 [ThrusterServo](DEBUG): Initializing EZServoServo.
2019-02-07T23:49:24.066Z,1549583364.066 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2019-02-07T23:49:24.199Z,1549583364.199 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:49:24.290Z,1549583364.290 [RDI_PathfinderUp](INFO): Powering down
2019-02-07T23:49:24.359Z,1549583364.359 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-02-07T23:49:24.539Z,1549583364.539 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:49:24.558Z,1549583364.558 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-02-07T23:49:24.910Z,1549583364.910 [BuoyancyServo](ERROR): Buoyancy initialization uart error serial timeout
2019-02-07T23:49:24.910Z,1549583364.910 [BuoyancyServo](FAULT): Buoyancy failed to initialize
2019-02-07T23:49:24.910Z,1549583364.910 [BuoyancyServo] Communications Fault, FailCount= 1
2019-02-07T23:49:24.910Z,1549583364.910 [BuoyancyServo](ERROR): Communications Fault
2019-02-07T23:49:25.114Z,1549583365.114 [CBIT](ERROR): Communications Fault in component: BuoyancyServo
2019-02-07T23:49:25.124Z,1549583365.124 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:49:25.527Z,1549583365.527 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:49:25.931Z,1549583365.931 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:49:26.327Z,1549583366.327 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:49:26.795Z,1549583366.795 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:49:26.930Z,1549583366.930 [Aanderaa_O2](INFO): Powering down
2019-02-07T23:49:27.151Z,1549583367.151 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:49:27.212Z,1549583367.212 [CBIT](INFO): Clearing failed state for component BuoyancyServo
2019-02-07T23:49:27.212Z,1549583367.212 [BuoyancyServo] No Fault, FailCount= 1
2019-02-07T23:49:27.551Z,1549583367.551 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:49:27.580Z,1549583367.580 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2019-02-07T23:49:27.699Z,1549583367.699 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2019-02-07T23:49:28.019Z,1549583368.019 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:49:28.443Z,1549583368.443 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:49:28.843Z,1549583368.843 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:49:29.256Z,1549583369.256 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:49:29.655Z,1549583369.655 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:49:30.055Z,1549583370.055 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:49:30.455Z,1549583370.455 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:49:30.855Z,1549583370.855 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:49:31.255Z,1549583371.255 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:49:31.644Z,1549583371.644 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:49:32.056Z,1549583372.056 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:49:32.431Z,1549583372.431 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:49:32.831Z,1549583372.831 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:49:33.224Z,1549583373.224 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:49:33.631Z,1549583373.631 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:49:34.044Z,1549583374.044 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:49:34.423Z,1549583374.423 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:49:34.823Z,1549583374.823 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:49:35.234Z,1549583375.234 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:49:35.623Z,1549583375.623 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:49:36.046Z,1549583376.046 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:49:36.423Z,1549583376.423 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:49:36.839Z,1549583376.839 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:49:36.856Z,1549583376.856 [RDI_Pathfinder](ERROR): Failed to parse:Pathfinder
2019-02-07T23:49:37.223Z,1549583377.223 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:49:37.634Z,1549583377.634 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:49:38.023Z,1549583378.023 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:49:38.433Z,1549583378.433 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:49:38.843Z,1549583378.843 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:49:39.224Z,1549583379.224 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:49:39.635Z,1549583379.635 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:49:40.023Z,1549583380.023 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:49:40.435Z,1549583380.435 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:49:40.836Z,1549583380.836 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:49:41.229Z,1549583381.229 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:49:41.627Z,1549583381.627 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:49:42.027Z,1549583382.027 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:49:42.427Z,1549583382.427 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:49:42.843Z,1549583382.843 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:49:43.231Z,1549583383.231 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:49:43.625Z,1549583383.625 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:49:43.626Z,1549583383.626 [DUSBL_Hydroid](FAULT): failed to initialize; deviceResponse_ loaded: , available: !U1,V,O
!U1,V,O
!U1,V,O
!U1,V,O
!U1,V,O
!U1,V,O
!U1,V,O
!U1,V,O
!U1,V,O
!U1,V,O
!U1,V,O
!U1,V,O
«ZÒQf?°h!
2019-02-07T23:49:43.626Z,1549583383.626 [DUSBL_Hydroid] Communications Fault, FailCount= 1
2019-02-07T23:49:43.626Z,1549583383.626 [DUSBL_Hydroid](ERROR): Communications Fault
2019-02-07T23:49:43.704Z,1549583383.704 [CBIT](ERROR): Communications Fault in component: DUSBL_Hydroid
2019-02-07T23:49:44.025Z,1549583384.025 [DUSBL_Hydroid](INFO): Stop
2019-02-07T23:49:44.025Z,1549583384.025 [DUSBL_Hydroid](INFO): uninitialize
2019-02-07T23:49:44.025Z,1549583384.025 [DUSBL_Hydroid](INFO): Powering down
2019-02-07T23:49:44.425Z,1549583384.425 [DUSBL_Hydroid](INFO): Stopping
2019-02-07T23:49:44.835Z,1549583384.835 [DUSBL_Hydroid](INFO): Stopped
2019-02-07T23:49:44.929Z,1549583384.929 [CBIT](INFO): Clearing failed state for component DUSBL_Hydroid
2019-02-07T23:49:44.929Z,1549583384.929 [DUSBL_Hydroid] No Fault, FailCount= 1
2019-02-07T23:49:45.231Z,1549583385.231 [DUSBL_Hydroid](INFO): Start
2019-02-07T23:49:45.627Z,1549583385.627 [DUSBL_Hydroid](INFO): Start
2019-02-07T23:49:46.027Z,1549583386.027 [DUSBL_Hydroid](INFO): Start
2019-02-07T23:49:46.427Z,1549583386.427 [DUSBL_Hydroid](INFO): Start
2019-02-07T23:49:46.827Z,1549583386.827 [DUSBL_Hydroid](INFO): Start
2019-02-07T23:49:47.227Z,1549583387.227 [DUSBL_Hydroid](INFO): Start
2019-02-07T23:49:47.227Z,1549583387.227 [DUSBL_Hydroid](INFO): Powering up
2019-02-07T23:49:47.227Z,1549583387.227 [DUSBL_Hydroid](DEBUG): Initializing DUSBL_Hydroid.
2019-02-07T23:49:47.627Z,1549583387.627 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:49:48.027Z,1549583388.027 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:49:48.427Z,1549583388.427 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:49:48.827Z,1549583388.827 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:49:49.227Z,1549583389.227 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:49:49.627Z,1549583389.627 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:49:50.028Z,1549583390.028 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:49:50.029Z,1549583390.029 [NAL9602](INFO): Powering up NAL9602
2019-02-07T23:49:50.427Z,1549583390.427 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:49:50.827Z,1549583390.827 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:49:51.236Z,1549583391.236 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:49:51.623Z,1549583391.623 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:49:51.669Z,1549583391.669 [SBIT](IMPORTANT): Beginning Startup BIT
2019-02-07T23:49:51.673Z,1549583391.673 [CBIT](IMPORTANT): Beginning ground fault scan
2019-02-07T23:49:52.023Z,1549583392.023 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:49:52.423Z,1549583392.423 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:49:52.827Z,1549583392.827 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:49:53.231Z,1549583393.231 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:49:53.627Z,1549583393.627 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:49:54.151Z,1549583394.151 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:49:54.551Z,1549583394.551 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:49:54.951Z,1549583394.951 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:49:55.351Z,1549583395.351 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:49:55.751Z,1549583395.751 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:49:56.151Z,1549583396.151 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:49:56.551Z,1549583396.551 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:49:56.968Z,1549583396.968 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:49:57.351Z,1549583397.351 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:49:57.752Z,1549583397.752 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:49:58.159Z,1549583398.159 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:49:58.551Z,1549583398.551 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:49:58.951Z,1549583398.951 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:49:59.351Z,1549583399.351 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:49:59.751Z,1549583399.751 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:50:00.151Z,1549583400.151 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:50:00.568Z,1549583400.568 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:50:00.951Z,1549583400.951 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:50:00.952Z,1549583400.952 [NAL9602](INFO): NAL9602 initialized
2019-02-07T23:50:01.351Z,1549583401.351 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:50:01.759Z,1549583401.759 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:50:01.774Z,1549583401.774 [NAL9602](DEBUG): Fix Requested
2019-02-07T23:50:02.155Z,1549583402.155 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:50:02.551Z,1549583402.551 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:50:02.715Z,1549583402.715 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): -0.004539
CHAN A1 (24V): -0.025198
CHAN A2 (12V): -0.006620
CHAN A3 (5V): -0.003102
CHAN B0 (3.3V): -0.000289
CHAN B1 (3.15aV): -0.000181
CHAN B2 (3.15bV): 0.000069
CHAN B3 (GND): 0.000659
OPEN: 0.009419
Full Scale Calc: 4.765 mA, -1.589 mA
2019-02-07T23:50:02.968Z,1549583402.968 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:50:03.360Z,1549583403.360 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:50:03.751Z,1549583403.751 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:50:04.151Z,1549583404.151 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:50:04.559Z,1549583404.559 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:50:04.957Z,1549583404.957 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:50:05.367Z,1549583405.367 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:50:05.751Z,1549583405.751 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:50:06.151Z,1549583406.151 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:50:06.559Z,1549583406.559 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:50:06.951Z,1549583406.951 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:50:07.603Z,1549583407.603 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:50:07.604Z,1549583407.604 [DUSBL_Hydroid](FAULT): failed to initialize; deviceResponse_ loaded: , available: !U1,V,O
!U1,V,O
!U1,V,O
!U1,V,O
!U1,V,O
!U1,V,O
!U1,V,O
!U1,V,O
!U1,V,O
!U1,V,O
!U1,V,O
!U1,V,O
?«Ì”Öß?°h!
2019-02-07T23:50:07.604Z,1549583407.604 [DUSBL_Hydroid] Communications Fault, FailCount= 2
2019-02-07T23:50:07.604Z,1549583407.604 [DUSBL_Hydroid](ERROR): Communications Fault
2019-02-07T23:50:07.803Z,1549583407.803 [CBIT](ERROR): Communications Fault in component: DUSBL_Hydroid
2019-02-07T23:50:08.000Z,1549583408.000 [DUSBL_Hydroid](INFO): Stop
2019-02-07T23:50:08.000Z,1549583408.000 [DUSBL_Hydroid](INFO): uninitialize
2019-02-07T23:50:08.000Z,1549583408.000 [DUSBL_Hydroid](INFO): Powering down
2019-02-07T23:50:08.395Z,1549583408.395 [DUSBL_Hydroid](INFO): Stopping
2019-02-07T23:50:08.794Z,1549583408.794 [DUSBL_Hydroid](INFO): Stopped
2019-02-07T23:50:08.991Z,1549583408.991 [CBIT](INFO): Clearing failed state for component DUSBL_Hydroid
2019-02-07T23:50:08.992Z,1549583408.992 [DUSBL_Hydroid] No Fault, FailCount= 2
2019-02-07T23:50:09.208Z,1549583409.208 [DUSBL_Hydroid](INFO): Start
2019-02-07T23:50:09.608Z,1549583409.608 [DUSBL_Hydroid](INFO): Start
2019-02-07T23:50:10.005Z,1549583410.005 [DUSBL_Hydroid](INFO): Start
2019-02-07T23:50:10.404Z,1549583410.404 [DUSBL_Hydroid](INFO): Start
2019-02-07T23:50:10.810Z,1549583410.810 [DUSBL_Hydroid](INFO): Start
2019-02-07T23:50:11.191Z,1549583411.191 [DUSBL_Hydroid](INFO): Start
2019-02-07T23:50:11.191Z,1549583411.191 [DUSBL_Hydroid](INFO): Powering up
2019-02-07T23:50:11.192Z,1549583411.192 [DUSBL_Hydroid](DEBUG): Initializing DUSBL_Hydroid.
2019-02-07T23:50:11.591Z,1549583411.591 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:50:12.000Z,1549583412.000 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:50:12.385Z,1549583412.385 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:50:12.790Z,1549583412.790 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:50:13.185Z,1549583413.185 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:50:13.595Z,1549583413.595 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:50:13.995Z,1549583413.995 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:50:14.395Z,1549583414.395 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:50:14.794Z,1549583414.794 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:50:15.195Z,1549583415.195 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:50:15.591Z,1549583415.591 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:50:15.987Z,1549583415.987 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:50:16.387Z,1549583416.387 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:50:16.815Z,1549583416.815 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:50:17.187Z,1549583417.187 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:50:17.612Z,1549583417.612 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:50:17.987Z,1549583417.987 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:50:18.387Z,1549583418.387 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:50:18.826Z,1549583418.826 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:50:19.201Z,1549583419.201 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:50:19.587Z,1549583419.587 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:50:19.983Z,1549583419.983 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:50:20.383Z,1549583420.383 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:50:20.831Z,1549583420.831 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:50:21.183Z,1549583421.183 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:50:21.583Z,1549583421.583 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:50:21.983Z,1549583421.983 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:50:22.383Z,1549583422.383 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:50:22.790Z,1549583422.790 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:50:23.187Z,1549583423.187 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:50:23.583Z,1549583423.583 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:50:23.983Z,1549583423.983 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:50:24.383Z,1549583424.383 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:50:24.794Z,1549583424.794 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:50:25.183Z,1549583425.183 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:50:25.587Z,1549583425.587 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:50:25.983Z,1549583425.983 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:50:26.383Z,1549583426.383 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:50:26.786Z,1549583426.786 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:50:27.187Z,1549583427.187 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:50:27.596Z,1549583427.596 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:50:27.983Z,1549583427.983 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:50:28.387Z,1549583428.387 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:50:28.786Z,1549583428.786 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:50:29.183Z,1549583429.183 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:50:29.587Z,1549583429.587 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:50:29.983Z,1549583429.983 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:50:30.380Z,1549583430.380 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:50:30.795Z,1549583430.795 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:50:31.183Z,1549583431.183 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:50:31.583Z,1549583431.583 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:50:31.584Z,1549583431.584 [DUSBL_Hydroid](FAULT): failed to initialize; deviceResponse_ loaded: , available: !U1,V,O
!U1,V,O
!U1,V,O
!U1,V,O
!U1,V,O
!U1,V,O
!U1,V,O
!U1,V,O
!U1,V,O
!U1,V,O
!U1,V,O
!U1,V,O
!U1,V,O
fLÁgÓ
?°h!
2019-02-07T23:50:31.584Z,1549583431.584 [DUSBL_Hydroid] Communications Fault, FailCount= 3
2019-02-07T23:50:31.584Z,1549583431.584 [DUSBL_Hydroid](ERROR): Communications Fault
2019-02-07T23:50:31.670Z,1549583431.670 [CBIT](ERROR): Communications Fault in component: DUSBL_Hydroid
2019-02-07T23:50:31.996Z,1549583431.996 [DUSBL_Hydroid](INFO): Stop
2019-02-07T23:50:31.996Z,1549583431.996 [DUSBL_Hydroid](INFO): uninitialize
2019-02-07T23:50:31.996Z,1549583431.996 [DUSBL_Hydroid](INFO): Powering down
2019-02-07T23:50:32.391Z,1549583432.391 [DUSBL_Hydroid](INFO): Stopping
2019-02-07T23:50:32.785Z,1549583432.785 [DUSBL_Hydroid](INFO): Stopped
2019-02-07T23:50:32.891Z,1549583432.891 [CBIT](INFO): Clearing failed state for component DUSBL_Hydroid
2019-02-07T23:50:32.891Z,1549583432.891 [DUSBL_Hydroid] No Fault, FailCount= 3
2019-02-07T23:50:33.191Z,1549583433.191 [DUSBL_Hydroid](INFO): Start
2019-02-07T23:50:33.583Z,1549583433.583 [DUSBL_Hydroid](INFO): Start
2019-02-07T23:50:33.987Z,1549583433.987 [DUSBL_Hydroid](INFO): Start
2019-02-07T23:50:34.495Z,1549583434.495 [DUSBL_Hydroid](INFO): Start
2019-02-07T23:50:34.895Z,1549583434.895 [DUSBL_Hydroid](INFO): Start
2019-02-07T23:50:35.296Z,1549583435.296 [DUSBL_Hydroid](INFO): Start
2019-02-07T23:50:35.296Z,1549583435.296 [DUSBL_Hydroid](INFO): Powering up
2019-02-07T23:50:35.296Z,1549583435.296 [DUSBL_Hydroid](DEBUG): Initializing DUSBL_Hydroid.
2019-02-07T23:50:35.705Z,1549583435.705 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:50:36.099Z,1549583436.099 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:50:36.499Z,1549583436.499 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:50:36.895Z,1549583436.895 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:50:37.299Z,1549583437.299 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:50:37.699Z,1549583437.699 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:50:38.099Z,1549583438.099 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:50:38.499Z,1549583438.499 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:50:38.895Z,1549583438.895 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:50:39.303Z,1549583439.303 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:50:39.695Z,1549583439.695 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:50:40.099Z,1549583440.099 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:50:40.495Z,1549583440.495 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:50:40.895Z,1549583440.895 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:50:41.299Z,1549583441.299 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:50:41.695Z,1549583441.695 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:50:42.103Z,1549583442.103 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:50:42.495Z,1549583442.495 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:50:42.895Z,1549583442.895 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:50:43.299Z,1549583443.299 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:50:43.695Z,1549583443.695 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:50:44.099Z,1549583444.099 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:50:44.495Z,1549583444.495 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:50:44.896Z,1549583444.896 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:50:45.295Z,1549583445.295 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:50:45.695Z,1549583445.695 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:50:45.779Z,1549583445.779 [SBIT](IMPORTANT): SBIT PASSED
2019-02-07T23:50:45.830Z,1549583445.830 [CommandLine](IMPORTANT): got command configSet list
2019-02-07T23:50:45.830Z,1549583445.830 [CommandLine](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2019-02-07T23:50:45.831Z,1549583445.831 [CommandLine](IMPORTANT): AHRS_M2.readMagnetics=1 bool;

2019-02-07T23:50:45.831Z,1549583445.831 [CommandLine](IMPORTANT): NAL9602.requestGGA=1 bool;

2019-02-07T23:50:46.095Z,1549583446.095 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:50:46.167Z,1549583446.167 [MissionManager](IMPORTANT): Started mission Startup
2019-02-07T23:50:46.167Z,1549583446.167 [Startup] Running Loop=1
2019-02-07T23:50:46.167Z,1549583446.167 [Startup](DEBUG): Aggregate::initialize Startup
2019-02-07T23:50:46.167Z,1549583446.167 [Startup:A.GoToSurface] Running Loop=1
2019-02-07T23:50:46.168Z,1549583446.168 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2019-02-07T23:50:46.168Z,1549583446.168 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2019-02-07T23:50:46.169Z,1549583446.169 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2019-02-07T23:50:46.169Z,1549583446.169 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2019-02-07T23:50:46.169Z,1549583446.169 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2019-02-07T23:50:46.170Z,1549583446.170 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2019-02-07T23:50:46.184Z,1549583446.184 [Startup:StartupSatComms] Running Loop=1
2019-02-07T23:50:46.185Z,1549583446.185 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2019-02-07T23:50:46.185Z,1549583446.185 [Startup:StartupSatComms:A] Running Loop=1
2019-02-07T23:50:46.495Z,1549583446.495 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:50:46.535Z,1549583446.535 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2019-02-07T23:50:46.895Z,1549583446.895 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:50:47.299Z,1549583447.299 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:50:47.699Z,1549583447.699 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:50:48.111Z,1549583448.111 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:50:48.499Z,1549583448.499 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:50:48.899Z,1549583448.899 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:50:49.299Z,1549583449.299 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:50:49.695Z,1549583449.695 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:50:50.095Z,1549583450.095 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:50:50.495Z,1549583450.495 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:50:50.899Z,1549583450.899 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:50:51.299Z,1549583451.299 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:50:51.695Z,1549583451.695 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:50:52.107Z,1549583452.107 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:50:52.509Z,1549583452.509 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:50:52.899Z,1549583452.899 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:50:53.296Z,1549583453.296 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:50:53.695Z,1549583453.695 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:50:54.095Z,1549583454.095 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:50:54.496Z,1549583454.496 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:50:54.896Z,1549583454.896 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:50:55.303Z,1549583455.303 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:50:55.304Z,1549583455.304 [DUSBL_Hydroid](FAULT): failed to initialize; deviceResponse_ loaded: , available: !U1,V,O
!U1,V,O
!U1,V,O
!U1,V,O
!U1,V,O
!U1,V,O
!U1,V,O
!U1,V,O
!U1,V,O
!U1,V,O
!U1,V,O
!U1,V,O
ÒûÆמY?°h!
2019-02-07T23:50:55.304Z,1549583455.304 [DUSBL_Hydroid] Communications Fault, FailCount= 4
2019-02-07T23:50:55.304Z,1549583455.304 [DUSBL_Hydroid](ERROR): Communications Fault
2019-02-07T23:50:55.405Z,1549583455.405 [CBIT](ERROR): Communications Fault in component: DUSBL_Hydroid
2019-02-07T23:50:55.695Z,1549583455.695 [DUSBL_Hydroid](INFO): Stop
2019-02-07T23:50:55.695Z,1549583455.695 [DUSBL_Hydroid](INFO): uninitialize
2019-02-07T23:50:55.695Z,1549583455.695 [DUSBL_Hydroid](INFO): Powering down
2019-02-07T23:50:56.103Z,1549583456.103 [DUSBL_Hydroid](INFO): Stopping
2019-02-07T23:50:56.508Z,1549583456.508 [DUSBL_Hydroid](INFO): Stopped
2019-02-07T23:50:56.547Z,1549583456.547 [CBIT](INFO): Clearing failed state for component DUSBL_Hydroid
2019-02-07T23:50:56.547Z,1549583456.547 [DUSBL_Hydroid] No Fault, FailCount= 4
2019-02-07T23:50:56.895Z,1549583456.895 [DUSBL_Hydroid](INFO): Start
2019-02-07T23:50:57.295Z,1549583457.295 [DUSBL_Hydroid](INFO): Start
2019-02-07T23:50:57.695Z,1549583457.695 [DUSBL_Hydroid](INFO): Start
2019-02-07T23:50:58.095Z,1549583458.095 [DUSBL_Hydroid](INFO): Start
2019-02-07T23:50:58.499Z,1549583458.499 [DUSBL_Hydroid](INFO): Start
2019-02-07T23:50:58.895Z,1549583458.895 [DUSBL_Hydroid](INFO): Start
2019-02-07T23:50:58.895Z,1549583458.895 [DUSBL_Hydroid](INFO): Powering up
2019-02-07T23:50:58.896Z,1549583458.896 [DUSBL_Hydroid](DEBUG): Initializing DUSBL_Hydroid.
2019-02-07T23:50:59.295Z,1549583459.295 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:50:59.695Z,1549583459.695 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:51:00.099Z,1549583460.099 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:51:00.495Z,1549583460.495 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:51:00.895Z,1549583460.895 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:51:01.307Z,1549583461.307 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:51:01.695Z,1549583461.695 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:51:02.095Z,1549583462.095 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:51:02.495Z,1549583462.495 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:51:02.895Z,1549583462.895 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:51:03.295Z,1549583463.295 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:51:03.699Z,1549583463.699 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:51:04.096Z,1549583464.096 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:51:04.495Z,1549583464.495 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:51:04.895Z,1549583464.895 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:51:05.295Z,1549583465.295 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:51:05.695Z,1549583465.695 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:51:06.095Z,1549583466.095 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:51:06.495Z,1549583466.495 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:51:06.903Z,1549583466.903 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:51:07.299Z,1549583467.299 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:51:07.695Z,1549583467.695 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:51:08.103Z,1549583468.103 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:51:08.495Z,1549583468.495 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:51:08.903Z,1549583468.903 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:51:09.295Z,1549583469.295 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:51:09.695Z,1549583469.695 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:51:10.095Z,1549583470.095 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:51:10.495Z,1549583470.495 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:51:10.899Z,1549583470.899 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:51:11.295Z,1549583471.295 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:51:11.699Z,1549583471.699 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:51:12.095Z,1549583472.095 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:51:12.505Z,1549583472.505 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:51:12.903Z,1549583472.903 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:51:13.296Z,1549583473.296 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:51:13.695Z,1549583473.695 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:51:14.095Z,1549583474.095 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:51:14.499Z,1549583474.499 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:51:14.895Z,1549583474.895 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:51:15.295Z,1549583475.295 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:51:15.699Z,1549583475.699 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:51:16.099Z,1549583476.099 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:51:16.495Z,1549583476.495 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:51:16.899Z,1549583476.899 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:51:17.295Z,1549583477.295 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:51:17.695Z,1549583477.695 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:51:18.103Z,1549583478.103 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:51:18.495Z,1549583478.495 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:51:18.903Z,1549583478.903 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:51:18.904Z,1549583478.904 [DUSBL_Hydroid](FAULT): failed to initialize; deviceResponse_ loaded: , available: !U1,V,O
!U1,V,O
!U1,V,O
!U1,V,O
!U1,V,O
!U1,V,O
!U1,V,O
!U1,V,O
!U1,V,O
!U1,V,O
!U1,V,O
!U1,V,O
«ZÒQf?°h!
2019-02-07T23:51:18.904Z,1549583478.904 [DUSBL_Hydroid] Communications Fault, FailCount= 5
2019-02-07T23:51:18.904Z,1549583478.904 [DUSBL_Hydroid](ERROR): Communications Fault
2019-02-07T23:51:19.004Z,1549583479.004 [CBIT](ERROR): Communications Fault in component: DUSBL_Hydroid
2019-02-07T23:51:19.295Z,1549583479.295 [DUSBL_Hydroid](INFO): Stop
2019-02-07T23:51:19.295Z,1549583479.295 [DUSBL_Hydroid](INFO): uninitialize
2019-02-07T23:51:19.295Z,1549583479.295 [DUSBL_Hydroid](INFO): Powering down
2019-02-07T23:51:19.699Z,1549583479.699 [DUSBL_Hydroid](INFO): Stopping
2019-02-07T23:51:20.095Z,1549583480.095 [DUSBL_Hydroid](INFO): Stopped
2019-02-07T23:51:20.189Z,1549583480.189 [CBIT](INFO): Clearing failed state for component DUSBL_Hydroid
2019-02-07T23:51:20.189Z,1549583480.189 [DUSBL_Hydroid] No Fault, FailCount= 5
2019-02-07T23:51:20.495Z,1549583480.495 [DUSBL_Hydroid](INFO): Start
2019-02-07T23:51:20.895Z,1549583480.895 [DUSBL_Hydroid](INFO): Start
2019-02-07T23:51:21.295Z,1549583481.295 [DUSBL_Hydroid](INFO): Start
2019-02-07T23:51:21.695Z,1549583481.695 [DUSBL_Hydroid](INFO): Start
2019-02-07T23:51:22.095Z,1549583482.095 [DUSBL_Hydroid](INFO): Start
2019-02-07T23:51:22.496Z,1549583482.496 [DUSBL_Hydroid](INFO): Start
2019-02-07T23:51:22.496Z,1549583482.496 [DUSBL_Hydroid](INFO): Powering up
2019-02-07T23:51:22.496Z,1549583482.496 [DUSBL_Hydroid](DEBUG): Initializing DUSBL_Hydroid.
2019-02-07T23:51:22.895Z,1549583482.895 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:51:23.295Z,1549583483.295 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:51:23.699Z,1549583483.699 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:51:24.103Z,1549583484.103 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:51:24.504Z,1549583484.504 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:51:24.899Z,1549583484.899 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:51:25.295Z,1549583485.295 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:51:25.695Z,1549583485.695 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:51:26.095Z,1549583486.095 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:51:26.495Z,1549583486.495 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:51:26.895Z,1549583486.895 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:51:27.295Z,1549583487.295 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:51:27.699Z,1549583487.699 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:51:28.095Z,1549583488.095 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:51:28.495Z,1549583488.495 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:51:28.899Z,1549583488.899 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:51:29.305Z,1549583489.305 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:51:29.695Z,1549583489.695 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:51:30.103Z,1549583490.103 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:51:30.495Z,1549583490.495 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:51:30.895Z,1549583490.895 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:51:31.299Z,1549583491.299 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:51:31.696Z,1549583491.696 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:51:32.095Z,1549583492.095 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:51:32.496Z,1549583492.496 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:51:32.895Z,1549583492.895 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:51:33.299Z,1549583493.299 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:51:33.695Z,1549583493.695 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:51:34.095Z,1549583494.095 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:51:34.507Z,1549583494.507 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:51:34.895Z,1549583494.895 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:51:35.295Z,1549583495.295 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:51:35.695Z,1549583495.695 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:51:36.095Z,1549583496.095 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:51:36.495Z,1549583496.495 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:51:36.895Z,1549583496.895 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:51:37.295Z,1549583497.295 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:51:37.699Z,1549583497.699 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:51:38.099Z,1549583498.099 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:51:38.495Z,1549583498.495 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:51:38.895Z,1549583498.895 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:51:39.299Z,1549583499.299 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:51:39.691Z,1549583499.691 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:51:40.099Z,1549583500.099 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:51:40.495Z,1549583500.495 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:51:40.896Z,1549583500.896 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:51:41.299Z,1549583501.299 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:51:41.707Z,1549583501.707 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:51:42.099Z,1549583502.099 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:51:42.495Z,1549583502.495 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:51:42.895Z,1549583502.895 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:51:42.896Z,1549583502.896 [DUSBL_Hydroid](FAULT): failed to initialize; deviceResponse_ loaded: , available: !U1,V,O
!U1,V,O
!U1,V,O
!U1,V,O
!U1,V,O
!U1,V,O
!U1,V,O
!U1,V,O
!U1,V,O
!U1,V,O
!U1,V,O
!U1,V,O
!U1,V,O
fLÁgÓ
?°h!
2019-02-07T23:51:42.896Z,1549583502.896 [DUSBL_Hydroid] Communications Fault, FailCount= 6
2019-02-07T23:51:42.896Z,1549583502.896 [DUSBL_Hydroid](ERROR): Communications Fault
2019-02-07T23:51:43.011Z,1549583503.011 [CBIT](ERROR): Communications Fault in component: DUSBL_Hydroid
2019-02-07T23:51:43.300Z,1549583503.300 [DUSBL_Hydroid](INFO): Stop
2019-02-07T23:51:43.300Z,1549583503.300 [DUSBL_Hydroid](INFO): uninitialize
2019-02-07T23:51:43.300Z,1549583503.300 [DUSBL_Hydroid](INFO): Powering down
2019-02-07T23:51:43.699Z,1549583503.699 [DUSBL_Hydroid](INFO): Stopping
2019-02-07T23:51:44.092Z,1549583504.092 [DUSBL_Hydroid](INFO): Stopped
2019-02-07T23:51:44.201Z,1549583504.201 [CBIT](INFO): Clearing failed state for component DUSBL_Hydroid
2019-02-07T23:51:44.201Z,1549583504.201 [DUSBL_Hydroid] No Fault, FailCount= 6
2019-02-07T23:51:44.511Z,1549583504.511 [DUSBL_Hydroid](INFO): Start
2019-02-07T23:51:47.677Z,1549583507.677 [DUSBL_Hydroid](INFO): Start
2019-02-07T23:51:47.677Z,1549583507.677 [DUSBL_Hydroid](INFO): Powering up
2019-02-07T23:51:47.677Z,1549583507.677 [DUSBL_Hydroid](DEBUG): Initializing DUSBL_Hydroid.
2019-02-07T23:51:47.820Z,1549583507.820 [Startup:StartupSatComms:A](INFO): Timed out from 2019-02-07T23:50:46.2Z
2019-02-07T23:51:47.820Z,1549583507.820 [Startup:StartupSatComms:A] Stopped
2019-02-07T23:51:47.820Z,1549583507.820 [Startup:StartupSatComms:B] Running Loop=1
2019-02-07T23:51:47.893Z,1549583507.893 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:51:47.961Z,1549583507.961 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2019-02-07T23:51:48.271Z,1549583508.271 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:51:48.668Z,1549583508.668 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004974
2019-02-07T23:51:48.671Z,1549583508.671 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:51:49.079Z,1549583509.079 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:51:49.460Z,1549583509.460 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:51:54.280Z,1549583514.280 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:51:54.487Z,1549583514.487 [DataOverHttps](INFO): Sending 25 bytes from file Logs/20190207T234159/Courier0007.lzma
2019-02-07T23:51:54.503Z,1549583514.503 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:51:54.836Z,1549583514.836 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:51:55.230Z,1549583515.230 [DataOverHttps](INFO): Moved sent file to Logs/20190207T234159/Courier0007.lzma.bak
2019-02-07T23:51:55.230Z,1549583515.230 [DataOverHttps](INFO): SBD MOMSN=9641253
2019-02-07T23:51:55.236Z,1549583515.236 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:51:55.635Z,1549583515.635 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:51:56.031Z,1549583516.031 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:52:00.408Z,1549583520.408 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:52:00.655Z,1549583520.655 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:52:01.007Z,1549583521.007 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:52:01.430Z,1549583521.430 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:52:01.833Z,1549583521.833 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:52:02.204Z,1549583522.204 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:52:05.522Z,1549583525.522 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:52:05.651Z,1549583525.651 [DataOverHttps](INFO): Sending 100 bytes from file Logs/20190207T234159/Express0008.lzma
2019-02-07T23:52:05.680Z,1549583525.680 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:52:06.044Z,1549583526.044 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:52:06.427Z,1549583526.427 [DataOverHttps](INFO): Moved sent file to Logs/20190207T234159/Express0008.lzma.bak
2019-02-07T23:52:06.427Z,1549583526.427 [DataOverHttps](INFO): SBD MOMSN=9641255
2019-02-07T23:52:06.460Z,1549583526.460 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:52:06.843Z,1549583526.843 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:52:07.235Z,1549583527.235 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:52:10.515Z,1549583530.515 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:52:10.516Z,1549583530.516 [DUSBL_Hydroid](FAULT): failed to initialize; deviceResponse_ loaded: , available: 
2019-02-07T23:52:10.516Z,1549583530.516 [DUSBL_Hydroid] Communications Fault, FailCount= 7
2019-02-07T23:52:10.516Z,1549583530.516 [DUSBL_Hydroid](ERROR): Communications Fault
2019-02-07T23:52:10.653Z,1549583530.653 [CBIT](ERROR): Communications Fault in component: DUSBL_Hydroid
2019-02-07T23:52:10.708Z,1549583530.708 [DUSBL_Hydroid](INFO): Stop
2019-02-07T23:52:10.708Z,1549583530.708 [DUSBL_Hydroid](INFO): uninitialize
2019-02-07T23:52:10.708Z,1549583530.708 [DUSBL_Hydroid](INFO): Powering down
2019-02-07T23:52:11.084Z,1549583531.084 [DUSBL_Hydroid](INFO): Stopping
2019-02-07T23:52:11.484Z,1549583531.484 [DUSBL_Hydroid](INFO): Stopped
2019-02-07T23:52:11.557Z,1549583531.557 [CBIT](INFO): Clearing failed state for component DUSBL_Hydroid
2019-02-07T23:52:11.557Z,1549583531.557 [DUSBL_Hydroid] No Fault, FailCount= 7
2019-02-07T23:52:11.871Z,1549583531.871 [DUSBL_Hydroid](INFO): Start
2019-02-07T23:52:12.275Z,1549583532.275 [DUSBL_Hydroid](INFO): Start
2019-02-07T23:52:15.637Z,1549583535.637 [DUSBL_Hydroid](INFO): Start
2019-02-07T23:52:15.637Z,1549583535.637 [DUSBL_Hydroid](INFO): Powering up
2019-02-07T23:52:15.637Z,1549583535.637 [DUSBL_Hydroid](DEBUG): Initializing DUSBL_Hydroid.
2019-02-07T23:52:15.652Z,1549583535.652 [NAL9602](INFO): SBD MO Status=0, MOMSN=2136, MT Status=0, MTMSN=0
2019-02-07T23:52:15.652Z,1549583535.652 [NAL9602](INFO): No messages in MT queue
2019-02-07T23:52:15.881Z,1549583535.881 [DataOverHttps](INFO): Sending 856 bytes from file Logs/20190207T234912/Express0001.lzma
2019-02-07T23:52:15.927Z,1549583535.927 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:52:16.287Z,1549583536.287 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:52:16.310Z,1549583536.310 [NAL9602](DEBUG): Fix Requested
2019-02-07T23:52:16.675Z,1549583536.675 [DataOverHttps](INFO): Moved sent file to Logs/20190207T234912/Express0001.lzma.bak
2019-02-07T23:52:16.675Z,1549583536.675 [DataOverHttps](INFO): SBD MOMSN=9641258
2019-02-07T23:52:16.683Z,1549583536.683 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:52:17.090Z,1549583537.090 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:52:17.142Z,1549583537.142 [Startup:StartupSatComms:B] Stopped
2019-02-07T23:52:17.142Z,1549583537.142 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2019-02-07T23:52:17.142Z,1549583537.142 [Startup:StartupSatComms] Stopped
2019-02-07T23:52:17.142Z,1549583537.142 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2019-02-07T23:52:17.143Z,1549583537.143 [Startup](INFO): Completed Startup
2019-02-07T23:52:17.143Z,1549583537.143 [MissionManager](INFO): Startup is completed.
2019-02-07T23:52:17.143Z,1549583537.143 [MissionManager](INFO): Uninitializing Mission Startup
2019-02-07T23:52:17.143Z,1549583537.143 [Startup] Stopped
2019-02-07T23:52:17.144Z,1549583537.144 [Startup](DEBUG): Aggregate::uninitialize Startup
2019-02-07T23:52:17.144Z,1549583537.144 [Startup:A.GoToSurface] Stopped
2019-02-07T23:52:17.144Z,1549583537.144 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2019-02-07T23:52:17.483Z,1549583537.483 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:52:17.518Z,1549583537.518 [MissionManager](IMPORTANT): Started mission Default
2019-02-07T23:52:17.518Z,1549583537.518 [Default] Running Loop=1
2019-02-07T23:52:17.518Z,1549583537.518 [Default](DEBUG): Aggregate::initialize Default
2019-02-07T23:52:17.518Z,1549583537.518 [Default:B.GoToSurface] Running Loop=1
2019-02-07T23:52:17.518Z,1549583537.518 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2019-02-07T23:52:17.519Z,1549583537.519 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2019-02-07T23:52:17.519Z,1549583537.519 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2019-02-07T23:52:17.519Z,1549583537.519 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2019-02-07T23:52:17.520Z,1549583537.520 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2019-02-07T23:52:17.520Z,1549583537.520 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2019-02-07T23:52:17.520Z,1549583537.520 [Default:A.Wait] Running Loop=1
2019-02-07T23:52:17.520Z,1549583537.520 [Default:A.Wait](DEBUG): Initialize Wait Component.
2019-02-07T23:52:20.715Z,1549583540.715 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:52:20.903Z,1549583540.903 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:52:21.263Z,1549583541.263 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:52:21.278Z,1549583541.278 [NAL9602](DEBUG): Fix Requested
2019-02-07T23:52:21.669Z,1549583541.669 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:52:21.672Z,1549583541.672 [NAL9602](DEBUG): Parsing GGA sentence: $GPGGA,235133.00,,,,,1,3,2.48,,,,,,*6F
2019-02-07T23:52:21.672Z,1549583541.672 [NAL9602](ERROR): Invalid hemisphere value reported: 44
2019-02-07T23:52:21.673Z,1549583541.673 [NAL9602](ERROR): Invalid hemisphere value reported: 44
2019-02-07T23:52:22.059Z,1549583542.059 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:52:22.096Z,1549583542.096 [RDI_Pathfinder](ERROR): Failed to parse:
:HM,G,D,0e8d,0ffe,  0.000, 0.000, 0.000
2019-02-07T23:52:22.459Z,1549583542.459 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:52:22.855Z,1549583542.855 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:52:23.268Z,1549583543.268 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:52:23.314Z,1549583543.314 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2019-02-07T23:52:23.314Z,1549583543.314 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-02-07T23:52:23.315Z,1549583543.315 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 1
2019-02-07T23:52:23.316Z,1549583543.316 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2019-02-07T23:52:23.317Z,1549583543.317 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1
2019-02-07T23:52:23.317Z,1549583543.317 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2019-02-07T23:52:23.349Z,1549583543.349 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-02-07T23:52:23.349Z,1549583543.349 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2019-02-07T23:52:23.349Z,1549583543.349 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2019-02-07T23:52:23.660Z,1549583543.660 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:52:23.829Z,1549583543.829 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-02-07T23:52:23.829Z,1549583543.829 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2019-02-07T23:52:23.834Z,1549583543.834 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2019-02-07T23:52:23.834Z,1549583543.834 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 1
2019-02-07T23:52:23.835Z,1549583543.835 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2019-02-07T23:52:23.835Z,1549583543.835 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1
2019-02-07T23:52:24.056Z,1549583544.056 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:52:24.082Z,1549583544.082 [NAL9602](DEBUG): Fix Requested
2019-02-07T23:52:24.154Z,1549583544.154 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2019-02-07T23:52:24.455Z,1549583544.455 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:52:24.457Z,1549583544.457 [NAL9602](DEBUG): Parsing GGA sentence: $GPGGA,235136.00,,,,,1,3,2.48,,,,,,*6A
2019-02-07T23:52:24.458Z,1549583544.458 [NAL9602](ERROR): Invalid hemisphere value reported: 44
2019-02-07T23:52:24.458Z,1549583544.458 [NAL9602](ERROR): Invalid hemisphere value reported: 44
2019-02-07T23:52:24.863Z,1549583544.863 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:52:25.255Z,1549583545.255 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:52:25.655Z,1549583545.655 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:52:26.059Z,1549583546.059 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:52:26.455Z,1549583546.455 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:52:26.863Z,1549583546.863 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:52:26.878Z,1549583546.878 [NAL9602](DEBUG): Fix Requested
2019-02-07T23:52:27.264Z,1549583547.264 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:52:27.266Z,1549583547.266 [NAL9602](DEBUG): Parsing GGA sentence: $GPGGA,235138.00,,,,,1,3,2.48,,,,,,*64
2019-02-07T23:52:27.266Z,1549583547.266 [NAL9602](ERROR): Invalid hemisphere value reported: 44
2019-02-07T23:52:27.266Z,1549583547.266 [NAL9602](ERROR): Invalid hemisphere value reported: 44
2019-02-07T23:52:27.665Z,1549583547.665 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:52:28.059Z,1549583548.059 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:52:28.459Z,1549583548.459 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:52:28.855Z,1549583548.855 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:52:29.255Z,1549583549.255 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:52:29.655Z,1549583549.655 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:52:30.055Z,1549583550.055 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:52:30.070Z,1549583550.070 [NAL9602](DEBUG): Fix Requested
2019-02-07T23:52:30.455Z,1549583550.455 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:52:30.457Z,1549583550.457 [NAL9602](DEBUG): Parsing GGA sentence: $GPGGA,235142.00,,,,,1,3,2.48,,,,,,*69
2019-02-07T23:52:30.458Z,1549583550.458 [NAL9602](ERROR): Invalid hemisphere value reported: 44
2019-02-07T23:52:30.458Z,1549583550.458 [NAL9602](ERROR): Invalid hemisphere value reported: 44
2019-02-07T23:52:30.859Z,1549583550.859 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:52:30.944Z,1549583550.944 [Default:A.Wait](INFO): Done Waiting.
2019-02-07T23:52:30.944Z,1549583550.944 [Default:A.Wait] Stopped
2019-02-07T23:52:30.944Z,1549583550.944 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2019-02-07T23:52:31.255Z,1549583551.255 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:52:31.321Z,1549583551.321 [Default:CheckIn] Running Loop=1
2019-02-07T23:52:31.322Z,1549583551.322 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2019-02-07T23:52:31.322Z,1549583551.322 [Default:CheckIn:Read_GPS] Running Loop=1
2019-02-07T23:52:31.656Z,1549583551.656 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:52:31.726Z,1549583551.726 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2019-02-07T23:52:32.059Z,1549583552.059 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:52:32.459Z,1549583552.459 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:52:32.859Z,1549583552.859 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:52:33.259Z,1549583553.259 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:52:33.276Z,1549583553.276 [NAL9602](DEBUG): Fix Requested
2019-02-07T23:52:33.655Z,1549583553.655 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:52:33.659Z,1549583553.659 [NAL9602](DEBUG): Parsing GGA sentence: $GPGGA,235145.00,,,,,1,3,2.48,,,,,,*6E
2019-02-07T23:52:33.659Z,1549583553.659 [NAL9602](ERROR): Invalid hemisphere value reported: 44
2019-02-07T23:52:33.659Z,1549583553.659 [NAL9602](ERROR): Invalid hemisphere value reported: 44
2019-02-07T23:52:34.055Z,1549583554.055 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:52:34.455Z,1549583554.455 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:52:34.859Z,1549583554.859 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:52:35.259Z,1549583555.259 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:52:35.659Z,1549583555.659 [DUSBL_Hydroid](INFO): Starting
2019-02-07T23:52:35.660Z,1549583555.660 [DUSBL_Hydroid](FAULT): failed to initialize; deviceResponse_ loaded: , available: 
2019-02-07T23:52:35.660Z,1549583555.660 [DUSBL_Hydroid] Communications Fault, FailCount= 8
2019-02-07T23:52:35.660Z,1549583555.660 [DUSBL_Hydroid](ERROR): Communications Fault
2019-02-07T23:52:35.726Z,1549583555.726 [CBIT](ERROR): Communications Fault in component: DUSBL_Hydroid
2019-02-07T23:52:35.727Z,1549583555.727 [CBIT](CRITICAL): Communications Fault in component: DUSBL_Hydroid
2019-02-07T23:52:36.055Z,1549583556.055 [DUSBL_Hydroid](INFO): Stop
2019-02-07T23:52:36.055Z,1549583556.055 [DUSBL_Hydroid](INFO): uninitialize
2019-02-07T23:52:36.055Z,1549583556.055 [DUSBL_Hydroid](INFO): Powering down
2019-02-07T23:52:36.070Z,1549583556.070 [NAL9602](DEBUG): Fix Requested
2019-02-07T23:52:36.154Z,1549583556.154 [CommandLine](FAULT): Scheduling is paused
2019-02-07T23:52:36.154Z,1549583556.154 [CBIT](INFO): Critical error at 20190207T235235
2019-02-07T23:52:36.155Z,1549583556.155 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals
2019-02-07T23:52:36.455Z,1549583556.455 [DUSBL_Hydroid](INFO): Stopping
2019-02-07T23:52:36.457Z,1549583556.457 [NAL9602](DEBUG): Parsing GGA sentence: $GPGGA,235148.00,,,,,1,3,2.48,,,,,,*63
2019-02-07T23:52:36.457Z,1549583556.457 [NAL9602](ERROR): Invalid hemisphere value reported: 44
2019-02-07T23:52:36.458Z,1549583556.458 [NAL9602](ERROR): Invalid hemisphere value reported: 44
2019-02-07T23:52:36.859Z,1549583556.859 [DUSBL_Hydroid](INFO): Stopped
2019-02-07T23:52:39.274Z,1549583559.274 [NAL9602](DEBUG): Fix Requested
2019-02-07T23:52:39.657Z,1549583559.657 [NAL9602](DEBUG): Parsing GGA sentence: $GPGGA,235151.00,,,,,1,3,2.48,,,,,,*6B
2019-02-07T23:52:39.657Z,1549583559.657 [NAL9602](ERROR): Invalid hemisphere value reported: 44
2019-02-07T23:52:39.658Z,1549583559.658 [NAL9602](ERROR): Invalid hemisphere value reported: 44
2019-02-07T23:52:42.070Z,1549583562.070 [NAL9602](DEBUG): Fix Requested
2019-02-07T23:52:42.457Z,1549583562.457 [NAL9602](DEBUG): Parsing GGA sentence: $GPGGA,235154.00,,,,,1,3,2.47,,,,,,*61
2019-02-07T23:52:42.458Z,1549583562.458 [NAL9602](ERROR): Invalid hemisphere value reported: 44
2019-02-07T23:52:42.458Z,1549583562.458 [NAL9602](ERROR): Invalid hemisphere value reported: 44
2019-02-07T23:52:45.271Z,1549583565.271 [NAL9602](DEBUG): Fix Requested
2019-02-07T23:52:45.676Z,1549583565.676 [NAL9602](DEBUG): Parsing GGA sentence: $GPGGA,235157.00,,,,,1,3,2.47,,,,,,*62
2019-02-07T23:52:45.676Z,1549583565.676 [NAL9602](ERROR): Invalid hemisphere value reported: 44
2019-02-07T23:52:45.676Z,1549583565.676 [NAL9602](ERROR): Invalid hemisphere value reported: 44
2019-02-07T23:52:48.070Z,1549583568.070 [NAL9602](DEBUG): Fix Requested
2019-02-07T23:52:48.457Z,1549583568.457 [NAL9602](DEBUG): Parsing GGA sentence: $GPGGA,235200.00,,,,,1,3,2.47,,,,,,*63
2019-02-07T23:52:48.457Z,1549583568.457 [NAL9602](ERROR): Invalid hemisphere value reported: 44
2019-02-07T23:52:48.457Z,1549583568.457 [NAL9602](ERROR): Invalid hemisphere value reported: 44
2019-02-07T23:52:51.270Z,1549583571.270 [NAL9602](DEBUG): Fix Requested
2019-02-07T23:52:51.665Z,1549583571.665 [NAL9602](DEBUG): Parsing GGA sentence: $GPGGA,235203.00,,,,,1,3,2.47,,,,,,*60
2019-02-07T23:52:51.666Z,1549583571.666 [NAL9602](ERROR): Invalid hemisphere value reported: 44
2019-02-07T23:52:51.666Z,1549583571.666 [NAL9602](ERROR): Invalid hemisphere value reported: 44
2019-02-07T23:52:56.638Z,1549583576.638 [NAL9602](DEBUG): Fix Requested
2019-02-07T23:52:57.025Z,1549583577.025 [NAL9602](DEBUG): Parsing GGA sentence: $GPGGA,235208.00,,,,,1,3,2.47,,,,,,*6B
2019-02-07T23:52:57.025Z,1549583577.025 [NAL9602](ERROR): Invalid hemisphere value reported: 44
2019-02-07T23:52:57.034Z,1549583577.034 [NAL9602](ERROR): Invalid hemisphere value reported: 44
2019-02-07T23:52:59.038Z,1549583579.038 [NAL9602](DEBUG): Fix Requested
2019-02-07T23:52:59.433Z,1549583579.433 [NAL9602](DEBUG): Parsing GGA sentence: $GPGGA,235211.00,,,,,1,3,2.47,,,,,,*63
2019-02-07T23:52:59.433Z,1549583579.433 [NAL9602](ERROR): Invalid hemisphere value reported: 44
2019-02-07T23:52:59.433Z,1549583579.433 [NAL9602](ERROR): Invalid hemisphere value reported: 44
2019-02-07T23:53:02.234Z,1549583582.234 [NAL9602](DEBUG): Fix Requested
2019-02-07T23:53:05.042Z,1549583585.042 [NAL9602](DEBUG): Fix Requested
2019-02-07T23:53:08.234Z,1549583588.234 [NAL9602](DEBUG): Fix Requested
2019-02-07T23:53:08.621Z,1549583588.621 [NAL9602](DEBUG): Parsing GGA sentence: $GPGGA,235220.00,,,,,1,3,2.46,,,,,,*60
2019-02-07T23:53:08.621Z,1549583588.621 [NAL9602](ERROR): Invalid hemisphere value reported: 44
2019-02-07T23:53:08.621Z,1549583588.621 [NAL9602](ERROR): Invalid hemisphere value reported: 44
2019-02-07T23:53:11.042Z,1549583591.042 [NAL9602](DEBUG): Fix Requested
2019-02-07T23:53:11.430Z,1549583591.430 [NAL9602](DEBUG): Parsing GGA sentence: $GPGGA,235223.00,,,,,1,3,2.46,,,,,,*63
2019-02-07T23:53:11.430Z,1549583591.430 [NAL9602](ERROR): Invalid hemisphere value reported: 44
2019-02-07T23:53:11.430Z,1549583591.430 [NAL9602](ERROR): Invalid hemisphere value reported: 44
2019-02-07T23:53:14.250Z,1549583594.250 [NAL9602](DEBUG): Fix Requested
2019-02-07T23:53:14.625Z,1549583594.625 [NAL9602](DEBUG): Parsing GGA sentence: $GPGGA,235226.00,,,,,1,3,2.46,,,,,,*66
2019-02-07T23:53:14.625Z,1549583594.625 [NAL9602](ERROR): Invalid hemisphere value reported: 44
2019-02-07T23:53:14.625Z,1549583594.625 [NAL9602](ERROR): Invalid hemisphere value reported: 44
2019-02-07T23:53:17.042Z,1549583597.042 [NAL9602](DEBUG): Fix Requested
2019-02-07T23:53:17.416Z,1549583597.416 [NAL9602](DEBUG): Parsing GGA sentence: $GPGGA,235229.00,,,,,1,3,2.46,,,,,,*69
2019-02-07T23:53:17.417Z,1549583597.417 [NAL9602](ERROR): Invalid hemisphere value reported: 44
2019-02-07T23:53:17.417Z,1549583597.417 [NAL9602](ERROR): Invalid hemisphere value reported: 44
2019-02-07T23:53:20.238Z,1549583600.238 [NAL9602](DEBUG): Fix Requested
2019-02-07T23:53:20.625Z,1549583600.625 [NAL9602](DEBUG): Parsing GGA sentence: $GPGGA,235232.00,3648.16690,N,12147.28626,W,1,5,1.88,2.9,M,-30.7,M,,*57
2019-02-07T23:53:20.628Z,1549583600.628 [NAL9602](INFO): GPS fix at 20190207T235232: (36.802782, -121.788104)
2019-02-07T23:53:20.669Z,1549583600.669 [Default:CheckIn:Read_GPS] Stopped
2019-02-07T23:53:20.669Z,1549583600.669 [Default:CheckIn:Read_Iridium] Running Loop=1
2019-02-07T23:53:21.099Z,1549583601.099 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications
2019-02-07T23:53:27.246Z,1549583607.246 [DataOverHttps](INFO): Sending 277 bytes from file Logs/20190207T234912/Courier0004.lzma
2019-02-07T23:53:27.996Z,1549583607.996 [DataOverHttps](INFO): Moved sent file to Logs/20190207T234912/Courier0004.lzma.bak
2019-02-07T23:53:27.996Z,1549583607.996 [DataOverHttps](INFO): SBD MOMSN=9641281
2019-02-07T23:53:37.965Z,1549583617.965 [DataOverHttps](INFO): Sending 292 bytes from file Logs/20190207T234912/Express0005.lzma
2019-02-07T23:53:38.732Z,1549583618.732 [DataOverHttps](INFO): Moved sent file to Logs/20190207T234912/Express0005.lzma.bak
2019-02-07T23:53:38.732Z,1549583618.732 [DataOverHttps](INFO): SBD MOMSN=9641286
2019-02-07T23:53:39.198Z,1549583619.198 [Default:CheckIn:Read_Iridium] Stopped
2019-02-07T23:53:39.198Z,1549583619.198 [Default:CheckIn:C.Wait] Running Loop=1
2019-02-07T23:53:39.198Z,1549583619.198 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2019-02-07T23:53:55.916Z,1549583635.916 [CommandLine](IMPORTANT): got command restart application
2019-02-07T23:53:56.925Z,1549583636.925 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2019-02-07T23:53:56.925Z,1549583636.925 [CommandLine ThreadHandler](INFO): Thread cancelled.
2019-02-07T23:53:57.038Z,1549583637.038 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup.  Bye!
2019-02-07T23:53:57.038Z,1549583637.038 [CommandLine ThreadHandler](INFO): Thread cancelled.
2019-02-07T23:53:57.039Z,1549583637.039 [CommandLine](INFO): Join timeout helper Thread ID is 8363
2019-02-07T23:53:57.039Z,1549583637.039 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2019-02-07T23:53:57.039Z,1549583637.039 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2019-02-07T23:53:57.040Z,1549583637.040 [NavChartDb](INFO): Join timeout helper Thread ID is 8364
2019-02-07T23:53:57.222Z,1549583637.222 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2019-02-07T23:53:57.222Z,1549583637.222 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2019-02-07T23:53:57.226Z,1549583637.226 [ComponentRegistry](INFO): Shutting down WetLabsSeaOWL_UV_A ThreadHandler
2019-02-07T23:53:57.226Z,1549583637.226 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Thread cancelled.
2019-02-07T23:53:57.226Z,1549583637.226 [WetLabsSeaOWL_UV_A](INFO): Join timeout helper Thread ID is 8365
2019-02-07T23:53:57.503Z,1549583637.503 [NAL9602](INFO): Powering down
2019-02-07T23:53:57.622Z,1549583637.622 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Uninitializing protected caller thread.
2019-02-07T23:53:57.622Z,1549583637.622 [WetLabsSeaOWL_UV_A](INFO): Powering down
2019-02-07T23:53:57.623Z,1549583637.623 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Thread cancelled.
2019-02-07T23:53:57.642Z,1549583637.642 [ComponentRegistry](INFO): Shutting down CTD_NeilBrown ThreadHandler
2019-02-07T23:53:57.642Z,1549583637.642 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled.
2019-02-07T23:53:57.642Z,1549583637.642 [CTD_NeilBrown](INFO): Join timeout helper Thread ID is 8366
2019-02-07T23:53:57.703Z,1549583637.703 [CTD_NeilBrown ThreadHandler](INFO): Uninitializing protected caller thread.
2019-02-07T23:53:57.703Z,1549583637.703 [CTD_NeilBrown](INFO): Powering down
2019-02-07T23:53:57.718Z,1549583637.718 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled.
2019-02-07T23:53:57.726Z,1549583637.726 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2019-02-07T23:53:57.726Z,1549583637.726 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2019-02-07T23:53:57.726Z,1549583637.726 [Radio_Surface](INFO): Join timeout helper Thread ID is 8367
2019-02-07T23:53:58.018Z,1549583638.018 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2019-02-07T23:53:58.018Z,1549583638.018 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2019-02-07T23:53:58.035Z,1549583638.035 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2019-02-07T23:53:58.035Z,1549583638.035 [logger ThreadHandler](INFO): Thread cancelled.
2019-02-07T23:53:58.035Z,1549583638.035 [logger](INFO): Join timeout helper Thread ID is 8368
2019-02-07T23:53:58.062Z,1549583638.062 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2019-02-07T23:53:58.062Z,1549583638.062 [logger ThreadHandler](INFO): Thread cancelled.
2019-02-07T23:53:58.074Z,1549583638.074 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2019-02-07T23:53:58.075Z,1549583638.075 [CommandLine ThreadHandler](INFO): Thread cancelled.
2019-02-07T23:53:58.075Z,1549583638.075 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2019-02-07T23:53:58.075Z,1549583638.075 [controlThread ThreadHandler](INFO): Thread cancelled.
2019-02-07T23:53:58.075Z,1549583638.075 [controlThread](INFO): Join timeout helper Thread ID is 8369
2019-02-07T23:53:58.278Z,1549583638.278 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2019-02-07T23:53:58.278Z,1549583638.278 [controlThread](DEBUG): Uninitializing ControlThread
2019-02-07T23:53:58.279Z,1549583638.279 [AHRS_M2](INFO): Powering down
2019-02-07T23:53:58.351Z,1549583638.351 [DUSBL_Hydroid](INFO): uninitialize
2019-02-07T23:53:58.351Z,1549583638.351 [DUSBL_Hydroid](INFO): Powering down
2019-02-07T23:53:58.352Z,1549583638.352 [NAL9602](INFO): Powering down
2019-02-07T23:53:58.422Z,1549583638.422 [RDI_Pathfinder](INFO): Powering down
2019-02-07T23:53:58.423Z,1549583638.423 [RDI_PathfinderUp](INFO): Powering down
2019-02-07T23:53:58.424Z,1549583638.424 [Aanderaa_O2](INFO): Powering down
2019-02-07T23:53:58.425Z,1549583638.425 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2019-02-07T23:53:58.426Z,1549583638.426 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2019-02-07T23:53:58.427Z,1549583638.427 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2019-02-07T23:53:58.428Z,1549583638.428 [MissionManager](INFO): Uninitializing Mission Default
2019-02-07T23:53:58.428Z,1549583638.428 [Default] Stopped
2019-02-07T23:53:58.428Z,1549583638.428 [Default](DEBUG): Aggregate::uninitialize Default
2019-02-07T23:53:58.428Z,1549583638.428 [Default:B.GoToSurface] Stopped
2019-02-07T23:53:58.428Z,1549583638.428 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2019-02-07T23:53:58.428Z,1549583638.428 [Default:CheckIn] Stopped
2019-02-07T23:53:58.428Z,1549583638.428 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2019-02-07T23:53:58.428Z,1549583638.428 [Default:CheckIn:C.Wait] Stopped
2019-02-07T23:53:58.428Z,1549583638.428 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2019-02-07T23:53:58.431Z,1549583638.431 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2019-02-07T23:53:58.431Z,1549583638.431 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2019-02-07T23:53:58.432Z,1549583638.432 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2019-02-07T23:53:58.432Z,1549583638.432 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2019-02-07T23:53:58.432Z,1549583638.432 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2019-02-07T23:53:58.432Z,1549583638.432 [BuoyancyServo](INFO): Powering down
2019-02-07T23:53:58.446Z,1549583638.446 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2019-02-07T23:53:58.446Z,1549583638.446 [ElevatorServo](INFO): Powering down
2019-02-07T23:53:58.447Z,1549583638.447 [MassServo](DEBUG): Uninitialize Mass Servo.
2019-02-07T23:53:58.447Z,1549583638.447 [MassServo](INFO): Powering down
2019-02-07T23:53:58.448Z,1549583638.448 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2019-02-07T23:53:58.448Z,1549583638.448 [RudderServo](INFO): Powering down
2019-02-07T23:53:58.449Z,1549583638.449 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2019-02-07T23:53:58.449Z,1549583638.449 [ThrusterServo](INFO): Powering down
2019-02-07T23:53:58.449Z,1549583638.449 [SBIT](DEBUG): Uninitialize SBIT Component.
2019-02-07T23:53:58.450Z,1549583638.450 [IBIT](DEBUG): Uninitialize IBIT Component.
2019-02-07T23:53:58.450Z,1549583638.450 [CBIT](DEBUG): Uninitialize CBIT Component.
2019-02-07T23:53:58.450Z,1549583638.450 [CBIT](DEBUG): Powering off loads.
2019-02-07T23:53:58.462Z,1549583638.462 [CBIT](DEBUG): Disabling WDT.
2019-02-07T23:53:58.474Z,1549583638.474 [CBIT](DEBUG): Opening all GF detection circuits.
2019-02-07T23:53:58.475Z,1549583638.475 [controlThread ThreadHandler](INFO): Thread cancelled.
2019-02-07T23:53:58.583Z,1549583638.583 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2019-02-07T23:53:58.629Z,1549583638.629 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Thread cancelled.
2019-02-07T23:53:58.632Z,1549583638.632 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled.
2019-02-07T23:53:58.653Z,1549583638.653 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2019-02-07T23:53:58.722Z,1549583638.722 [logger ThreadHandler](INFO): Thread cancelled.