2020-01-10T19:21:19.372Z,1578684079.372 [Supervisor](DEBUG): Initializing supervisor.
2020-01-10T19:21:19.375Z,1578684079.375 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2020-01-10T19:21:19.376Z,1578684079.376 [SyncHandler](INFO): Protected caller Thread ID is 9029
2020-01-10T19:21:19.376Z,1578684079.376 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2020-01-10T19:21:19.377Z,1578684079.377 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2020-01-10T19:21:19.377Z,1578684079.377 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 9030
2020-01-10T19:21:19.380Z,1578684079.380 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2020-01-10T19:21:19.392Z,1578684079.392 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2020-01-10T19:21:19.393Z,1578684079.393 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2020-01-10T19:21:19.393Z,1578684079.393 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 9031
2020-01-10T19:21:19.394Z,1578684079.394 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2020-01-10T19:21:19.395Z,1578684079.395 [logger ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2020-01-10T19:21:19.395Z,1578684079.395 [logger ThreadHandler](INFO): Protected caller Thread ID is 9032
2020-01-10T19:21:19.397Z,1578684079.397 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2020-01-10T19:21:19.398Z,1578684079.398 [Supervisor](INFO): Looking for Config files in directory: Config/
2020-01-10T19:21:19.399Z,1578684079.399 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2020-01-10T19:21:19.816Z,1578684079.816 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2020-01-10T19:21:19.816Z,1578684079.816 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2020-01-10T19:21:19.911Z,1578684079.911 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample
2020-01-10T19:21:19.911Z,1578684079.911 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2020-01-10T19:21:20.222Z,1578684080.222 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2020-01-10T19:21:20.222Z,1578684080.222 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2020-01-10T19:21:20.356Z,1578684080.356 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2020-01-10T19:21:20.356Z,1578684080.356 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2020-01-10T19:21:20.538Z,1578684080.538 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2020-01-10T19:21:20.539Z,1578684080.539 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2020-01-10T19:21:20.972Z,1578684080.972 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2020-01-10T19:21:20.973Z,1578684080.973 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2020-01-10T19:21:21.173Z,1578684081.173 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2020-01-10T19:21:21.174Z,1578684081.174 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2020-01-10T19:21:21.313Z,1578684081.313 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2020-01-10T19:21:21.314Z,1578684081.314 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2020-01-10T19:21:21.493Z,1578684081.493 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2020-01-10T19:21:21.494Z,1578684081.494 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2020-01-10T19:21:21.586Z,1578684081.586 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2020-01-10T19:21:21.587Z,1578684081.587 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2020-01-10T19:21:21.876Z,1578684081.876 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2020-01-10T19:21:21.877Z,1578684081.877 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2020-01-10T19:21:21.955Z,1578684081.955 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2020-01-10T19:21:22.055Z,1578684082.055 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2020-01-10T19:21:22.055Z,1578684082.055 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2020-01-10T19:21:22.675Z,1578684082.675 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2020-01-10T19:21:22.676Z,1578684082.676 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2020-01-10T19:21:23.075Z,1578684083.075 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2020-01-10T19:21:23.077Z,1578684083.077 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-whoidhs/
2020-01-10T19:21:23.078Z,1578684083.078 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/vehicle.cfg
2020-01-10T19:21:23.275Z,1578684083.275 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Control.cfg
2020-01-10T19:21:23.370Z,1578684083.370 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/BIT.cfg
2020-01-10T19:21:23.464Z,1578684083.464 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Battery.cfg
2020-01-10T19:21:23.688Z,1578684083.688 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2020-01-10T19:21:23.689Z,1578684083.689 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Simulator.cfg
2020-01-10T19:21:23.771Z,1578684083.771 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Navigation.cfg
2020-01-10T19:21:23.860Z,1578684083.860 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/logger.cfg
2020-01-10T19:21:23.954Z,1578684083.954 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/secure.cfg
2020-01-10T19:21:24.034Z,1578684084.034 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Servo.cfg
2020-01-10T19:21:24.152Z,1578684084.152 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Sensor.cfg
2020-01-10T19:21:24.556Z,1578684084.556 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Science.cfg
2020-01-10T19:21:24.766Z,1578684084.766 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-whoidhs/root/
2020-01-10T19:21:24.766Z,1578684084.766 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg
2020-01-10T19:21:24.787Z,1578684084.787 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2020-01-10T19:21:25.341Z,1578684085.341 [AHRS_M2](DEBUG): LcmSlateWriter::add(): platform_orientation
2020-01-10T19:21:25.347Z,1578684085.347 [AHRS_M2](INFO): created writer for : platform_orientation
2020-01-10T19:21:25.348Z,1578684085.348 [AHRS_M2](DEBUG): LcmSlateWriter::add(): platform_magnetic_orientation
2020-01-10T19:21:25.354Z,1578684085.354 [AHRS_M2](INFO): created writer for : platform_magnetic_orientation
2020-01-10T19:21:25.354Z,1578684085.354 [AHRS_M2](DEBUG): LcmSlateWriter::add(): platform_pitch_angle
2020-01-10T19:21:25.360Z,1578684085.360 [AHRS_M2](INFO): created writer for : platform_pitch_angle
2020-01-10T19:21:25.360Z,1578684085.360 [AHRS_M2](DEBUG): LcmSlateWriter::add(): platform_roll_angle
2020-01-10T19:21:25.366Z,1578684085.366 [AHRS_M2](INFO): created writer for : platform_roll_angle
2020-01-10T19:21:25.437Z,1578684085.437 [AHRS_M2] Loaded
2020-01-10T19:21:25.437Z,1578684085.437 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread.
2020-01-10T19:21:25.516Z,1578684085.516 [DataOverHttps] Loaded
2020-01-10T19:21:25.516Z,1578684085.516 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2020-01-10T19:21:25.517Z,1578684085.517 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 4076F4E0
2020-01-10T19:21:25.517Z,1578684085.517 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 9111
2020-01-10T19:21:25.542Z,1578684085.542 [DDM] Loaded
2020-01-10T19:21:25.542Z,1578684085.542 [ComponentRegistry](DEBUG): SyncComponent "DDM" handled in the control thread.
2020-01-10T19:21:25.555Z,1578684085.555 [Depth_Keller] Loaded
2020-01-10T19:21:25.555Z,1578684085.555 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2020-01-10T19:21:25.560Z,1578684085.560 [DropWeight] Loaded
2020-01-10T19:21:25.561Z,1578684085.561 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2020-01-10T19:21:25.622Z,1578684085.622 [DUSBL_Hydroid] Loaded
2020-01-10T19:21:25.623Z,1578684085.623 [ComponentRegistry](DEBUG): SyncComponent "DUSBL_Hydroid" handled in the control thread.
2020-01-10T19:21:25.669Z,1578684085.669 [Micromodem] Loaded
2020-01-10T19:21:25.669Z,1578684085.669 [ComponentRegistry](DEBUG): SyncComponent "Micromodem" handled in the control thread.
2020-01-10T19:21:25.766Z,1578684085.766 [NAL9602] Loaded
2020-01-10T19:21:25.766Z,1578684085.766 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2020-01-10T19:21:25.804Z,1578684085.804 [Onboard](ERROR): Can't open SysFS node file: /sys/class/power_supply/ds2782-0/voltage_now
2020-01-10T19:21:25.804Z,1578684085.804 [Onboard](ERROR): Can't open SysFS node file: /sys/class/power_supply/ds2782-0/current_now
2020-01-10T19:21:25.805Z,1578684085.805 [Onboard](ERROR): Can't open SysFS node file: /sys/class/power_supply/ds2782-0/charge_now
2020-01-10T19:21:25.805Z,1578684085.805 [Onboard](ERROR): Can't open SysFS node file: /sys/class/power_supply/ds2782-0/charge_full
2020-01-10T19:21:25.806Z,1578684085.806 [Onboard](ERROR): Can't open SysFS node file: /sys/class/power_supply/ds2782-1/voltage_now
2020-01-10T19:21:25.806Z,1578684085.806 [Onboard](ERROR): Can't open SysFS node file: /sys/class/power_supply/ds2782-1/current_now
2020-01-10T19:21:25.807Z,1578684085.807 [Onboard](ERROR): Can't open SysFS node file: /sys/class/power_supply/ds2782-1/charge_now
2020-01-10T19:21:25.807Z,1578684085.807 [Onboard](ERROR): Can't open SysFS node file: /sys/class/power_supply/ds2782-1/charge_full
2020-01-10T19:21:25.807Z,1578684085.807 [Onboard] Loaded
2020-01-10T19:21:25.808Z,1578684085.808 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread.
2020-01-10T19:21:25.814Z,1578684085.814 [PowerOnly] Loaded
2020-01-10T19:21:25.814Z,1578684085.814 [ComponentRegistry](DEBUG): SyncComponent "PowerOnly" handled in the control thread.
2020-01-10T19:21:25.820Z,1578684085.820 [Radio_Surface] Loaded
2020-01-10T19:21:25.821Z,1578684085.821 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2020-01-10T19:21:25.822Z,1578684085.822 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 4079F4E0
2020-01-10T19:21:25.822Z,1578684085.822 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 9112
2020-01-10T19:21:25.866Z,1578684085.866 [RDI_Pathfinder] Loaded
2020-01-10T19:21:25.866Z,1578684085.866 [ComponentRegistry](DEBUG): SyncComponent "RDI_Pathfinder" handled in the control thread.
2020-01-10T19:21:27.372Z,1578684087.372 [BPC1] Loaded
2020-01-10T19:21:27.372Z,1578684087.372 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2020-01-10T19:21:27.372Z,1578684087.372 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2020-01-10T19:21:27.373Z,1578684087.373 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2020-01-10T19:21:27.386Z,1578684087.386 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2020-01-10T19:21:27.387Z,1578684087.387 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2020-01-10T19:21:27.490Z,1578684087.490 [DeadReckonUsingMultipleVelocitySources] Loaded
2020-01-10T19:21:27.490Z,1578684087.490 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2020-01-10T19:21:27.511Z,1578684087.511 [NavChart] Loaded
2020-01-10T19:21:27.511Z,1578684087.511 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2020-01-10T19:21:27.515Z,1578684087.515 [UniversalFixResidualReporter] Loaded
2020-01-10T19:21:27.515Z,1578684087.515 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2020-01-10T19:21:27.516Z,1578684087.516 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2020-01-10T19:21:27.516Z,1578684087.516 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2020-01-10T19:21:27.623Z,1578684087.623 [BuoyancyServo] Loaded
2020-01-10T19:21:27.623Z,1578684087.623 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2020-01-10T19:21:27.638Z,1578684087.638 [ElevatorServo] Loaded
2020-01-10T19:21:27.638Z,1578684087.638 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2020-01-10T19:21:27.653Z,1578684087.653 [MassServo] Loaded
2020-01-10T19:21:27.653Z,1578684087.653 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2020-01-10T19:21:27.668Z,1578684087.668 [RudderServo] Loaded
2020-01-10T19:21:27.668Z,1578684087.668 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2020-01-10T19:21:27.683Z,1578684087.683 [ThrusterServo] Loaded
2020-01-10T19:21:27.683Z,1578684087.683 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread.
2020-01-10T19:21:27.684Z,1578684087.684 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2020-01-10T19:21:27.684Z,1578684087.684 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2020-01-10T19:21:27.939Z,1578684087.939 [CTD_NeilBrown] Loaded
2020-01-10T19:21:27.940Z,1578684087.940 [ComponentRegistry](DEBUG): Component "CTD_NeilBrown" handled in its own thread.
2020-01-10T19:21:27.941Z,1578684087.941 [CTD_NeilBrown ThreadHandler](DEBUG): Created PCaller Thread at 408F34E0
2020-01-10T19:21:27.941Z,1578684087.941 [CTD_NeilBrown ThreadHandler](INFO): Protected caller Thread ID is 9113
2020-01-10T19:21:27.955Z,1578684087.955 [PAR_Licor] Loaded
2020-01-10T19:21:27.956Z,1578684087.956 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2020-01-10T19:21:27.999Z,1578684087.999 [WetLabsSeaOWL_UV_A] Loaded
2020-01-10T19:21:27.999Z,1578684087.999 [ComponentRegistry](DEBUG): Component "WetLabsSeaOWL_UV_A" handled in its own thread.
2020-01-10T19:21:28.000Z,1578684088.000 [WetLabsSeaOWL_UV_A ThreadHandler](DEBUG): Created PCaller Thread at 409234E0
2020-01-10T19:21:28.001Z,1578684088.001 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Protected caller Thread ID is 9114
2020-01-10T19:21:28.001Z,1578684088.001 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2020-01-10T19:21:28.002Z,1578684088.002 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2020-01-10T19:21:28.307Z,1578684088.307 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2020-01-10T19:21:28.307Z,1578684088.307 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2020-01-10T19:21:28.347Z,1578684088.347 [DepthRateCalculator] Loaded
2020-01-10T19:21:28.347Z,1578684088.347 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2020-01-10T19:21:28.353Z,1578684088.353 [PitchRateCalculator] Loaded
2020-01-10T19:21:28.353Z,1578684088.353 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2020-01-10T19:21:28.365Z,1578684088.365 [SpeedCalculator] Loaded
2020-01-10T19:21:28.366Z,1578684088.366 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2020-01-10T19:21:28.386Z,1578684088.386 [TempGradientCalculator] Loaded
2020-01-10T19:21:28.387Z,1578684088.387 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread.
2020-01-10T19:21:28.392Z,1578684088.392 [YawRateCalculator] Loaded
2020-01-10T19:21:28.392Z,1578684088.392 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2020-01-10T19:21:28.432Z,1578684088.432 [ElevatorOffsetCalculator] Loaded
2020-01-10T19:21:28.433Z,1578684088.433 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2020-01-10T19:21:28.433Z,1578684088.433 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2020-01-10T19:21:28.434Z,1578684088.434 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2020-01-10T19:21:28.567Z,1578684088.567 [SBIT](DEBUG): Construct Startup Built In Test.
2020-01-10T19:21:28.589Z,1578684088.589 [SBIT] Loaded
2020-01-10T19:21:28.589Z,1578684088.589 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2020-01-10T19:21:28.590Z,1578684088.590 [IBIT](DEBUG): Construct Initiated Built In Test.
2020-01-10T19:21:28.602Z,1578684088.602 [IBIT] Loaded
2020-01-10T19:21:28.602Z,1578684088.602 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2020-01-10T19:21:28.606Z,1578684088.606 [CBIT](DEBUG): Construct Continuous Built In Test.
2020-01-10T19:21:28.743Z,1578684088.743 [CBIT] Loaded
2020-01-10T19:21:28.744Z,1578684088.744 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2020-01-10T19:21:28.744Z,1578684088.744 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2020-01-10T19:21:28.745Z,1578684088.745 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2020-01-10T19:21:28.827Z,1578684088.827 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2020-01-10T19:21:28.827Z,1578684088.827 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2020-01-10T19:21:28.922Z,1578684088.922 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2020-01-10T19:21:28.922Z,1578684088.922 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2020-01-10T19:21:28.970Z,1578684088.970 [VerticalControl](DEBUG): Construct VerticalControl.
2020-01-10T19:21:29.052Z,1578684089.052 [VerticalControl] Loaded
2020-01-10T19:21:29.052Z,1578684089.052 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2020-01-10T19:21:29.053Z,1578684089.053 [HorizontalControl](DEBUG): Construct HorizontalControl.
2020-01-10T19:21:29.124Z,1578684089.124 [HorizontalControl] Loaded
2020-01-10T19:21:29.124Z,1578684089.124 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2020-01-10T19:21:29.125Z,1578684089.125 [SpeedControl](DEBUG): Construct SpeedControl.
2020-01-10T19:21:29.126Z,1578684089.126 [SpeedControl] Loaded
2020-01-10T19:21:29.127Z,1578684089.127 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2020-01-10T19:21:29.127Z,1578684089.127 [LoopControl](DEBUG): Construct LoopControl.
2020-01-10T19:21:29.128Z,1578684089.128 [LoopControl] Loaded
2020-01-10T19:21:29.128Z,1578684089.128 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2020-01-10T19:21:29.128Z,1578684089.128 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2020-01-10T19:21:29.129Z,1578684089.129 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2020-01-10T19:21:29.161Z,1578684089.161 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2020-01-10T19:21:29.176Z,1578684089.176 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2020-01-10T19:21:29.177Z,1578684089.177 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2020-01-10T19:21:29.188Z,1578684089.188 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2020-01-10T19:21:29.189Z,1578684089.189 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40B024E0
2020-01-10T19:21:29.190Z,1578684089.190 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 9115
2020-01-10T19:21:29.194Z,1578684089.194 [Supervisor](INFO): Main Thread ID is 9028
2020-01-10T19:21:29.194Z,1578684089.194 [Supervisor](DEBUG): Running supervisor.
2020-01-10T19:21:29.195Z,1578684089.195 [CommandLine ThreadHandler](INFO): Handler Thread ID is 9116
2020-01-10T19:21:29.197Z,1578684089.197 [controlThread ThreadHandler](INFO): Handler Thread ID is 9117
2020-01-10T19:21:29.198Z,1578684089.198 [controlThread](DEBUG): Initializing ControlThread
2020-01-10T19:21:29.205Z,1578684089.205 [NavChart](DEBUG): Initialize NavChart Navigation.
2020-01-10T19:21:29.205Z,1578684089.205 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2020-01-10T19:21:29.209Z,1578684089.209 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2020-01-10T19:21:29.210Z,1578684089.210 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2020-01-10T19:21:29.210Z,1578684089.210 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2020-01-10T19:21:29.211Z,1578684089.211 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator.
2020-01-10T19:21:29.211Z,1578684089.211 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2020-01-10T19:21:29.211Z,1578684089.211 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2020-01-10T19:21:29.212Z,1578684089.212 [SBIT](INFO): Initialize SBIT Component.
2020-01-10T19:21:29.213Z,1578684089.213 [SBIT](IMPORTANT): git: 2019-12-03-17-g4812c94
2020-01-10T19:21:29.213Z,1578684089.213 [SBIT](INFO): git hash: 4812c9429720da7730f61311b178b42396aebb36
2020-01-10T19:21:29.213Z,1578684089.213 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2020-01-10T19:21:29.215Z,1578684089.215 [SBIT](INFO): Kernel Reporting Different Version From Configuration.
Kernel Expected: #2 PREEMPT Thu Jan 11 20:13:48 PST 2018
Kernel Reported: #2 PREEMPT Wed May 15 08:34:03 PDT 2019
2020-01-10T19:21:29.216Z,1578684089.216 [SBIT](INFO): Beginning SBIT in 39.000000 seconds.
2020-01-10T19:21:29.216Z,1578684089.216 [IBIT](INFO): Initialize IBIT Component.
2020-01-10T19:21:29.217Z,1578684089.217 [CBIT](DEBUG): Initialize CBIT Component.
2020-01-10T19:21:29.218Z,1578684089.218 [logger ThreadHandler](INFO): Handler Thread ID is 9118
2020-01-10T19:21:29.229Z,1578684089.229 [CBIT](DEBUG): Initialized mux pins.
2020-01-10T19:21:29.229Z,1578684089.229 [CBIT](DEBUG): Initializing the watchdog timer.
2020-01-10T19:21:29.237Z,1578684089.237 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 9119
2020-01-10T19:21:29.238Z,1578684089.238 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2020-01-10T19:21:29.249Z,1578684089.249 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 9120
2020-01-10T19:21:29.253Z,1578684089.253 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2020-01-10T19:21:29.253Z,1578684089.253 [CBIT](DEBUG): Initializing heartbeat.
2020-01-10T19:21:29.261Z,1578684089.261 [CTD_NeilBrown ThreadHandler](INFO): Handler Thread ID is 9121
2020-01-10T19:21:29.262Z,1578684089.262 [CTD_NeilBrown](INFO): Powering down
2020-01-10T19:21:29.289Z,1578684089.289 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Handler Thread ID is 9122
2020-01-10T19:21:29.290Z,1578684089.290 [WetLabsSeaOWL_UV_A](INFO): Powering down
2020-01-10T19:21:29.317Z,1578684089.317 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 9123
2020-01-10T19:21:29.320Z,1578684089.320 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2020-01-10T19:21:29.321Z,1578684089.321 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2020-01-10T19:21:29.321Z,1578684089.321 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2020-01-10T19:21:29.321Z,1578684089.321 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2020-01-10T19:21:29.321Z,1578684089.321 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2020-01-10T19:21:29.321Z,1578684089.321 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2020-01-10T19:21:29.322Z,1578684089.322 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000
2020-01-10T19:21:29.322Z,1578684089.322 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000
2020-01-10T19:21:29.322Z,1578684089.322 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2020-01-10T19:21:29.322Z,1578684089.322 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2020-01-10T19:21:29.322Z,1578684089.322 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000
2020-01-10T19:21:29.323Z,1578684089.323 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000
2020-01-10T19:21:29.323Z,1578684089.323 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000
2020-01-10T19:21:29.323Z,1578684089.323 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000
2020-01-10T19:21:29.323Z,1578684089.323 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000
2020-01-10T19:21:29.323Z,1578684089.323 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000
2020-01-10T19:21:29.325Z,1578684089.325 [CBIT](DEBUG): Deactivating GF circuits.
2020-01-10T19:21:29.325Z,1578684089.325 [CBIT](DEBUG): Deactivating emergency mode.
2020-01-10T19:21:29.361Z,1578684089.361 [CBIT](DEBUG): Backplane powered.
2020-01-10T19:21:29.361Z,1578684089.361 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2020-01-10T19:21:29.363Z,1578684089.363 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2020-01-10T19:21:29.363Z,1578684089.363 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2020-01-10T19:21:29.364Z,1578684089.364 [LoopControl](DEBUG): Initialize LoopControlComponent.
2020-01-10T19:21:29.365Z,1578684089.365 [MissionManager](INFO): Loading Mission: Missions/Startup.xml
2020-01-10T19:21:29.375Z,1578684089.375 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2020-01-10T19:21:29.393Z,1578684089.393 [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>


2020-01-10T19:21:29.394Z,1578684089.394 [MissionManager](INFO): Loading Mission: Missions/Default.xml
2020-01-10T19:21:29.468Z,1578684089.468 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2020-01-10T19:21:29.469Z,1578684089.469 [Default:A.Wait](DEBUG): Construct Wait.
2020-01-10T19:21:29.471Z,1578684089.471 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2020-01-10T19:21:29.515Z,1578684089.515 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2020-01-10T19:21:29.517Z,1578684089.517 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2020-01-10T19:21:29.540Z,1578684089.540 [Default:E.Execute](DEBUG): Construct Execute.
2020-01-10T19:21:29.544Z,1578684089.544 [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>


2020-01-10T19:21:29.549Z,1578684089.549 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,DDM,Depth_Keller,DropWeight,DUSBL_Hydroid,Micromodem,NAL9602,Onboard,PowerOnly,RDI_Pathfinder,BPC1,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter,
2020-01-10T19:21:29.573Z,1578684089.573 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2020-01-10T19:21:29.617Z,1578684089.617 [DDM](INFO): Powering up
2020-01-10T19:21:29.617Z,1578684089.617 [DDM](DEBUG): Initializing DDM.
2020-01-10T19:21:29.643Z,1578684089.643 [DUSBL_Hydroid](INFO): Powering up
2020-01-10T19:21:29.643Z,1578684089.643 [DUSBL_Hydroid](DEBUG): Initializing DUSBL_Hydroid.
2020-01-10T19:21:29.653Z,1578684089.653 [Radio_Surface](INFO): Powering up
2020-01-10T19:21:29.822Z,1578684089.822 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2020-01-10T19:21:29.829Z,1578684089.829 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2020-01-10T19:21:29.830Z,1578684089.830 [ElevatorServo](DEBUG): Initializing EZServoServo.
2020-01-10T19:21:29.837Z,1578684089.837 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2020-01-10T19:21:29.838Z,1578684089.838 [MassServo](DEBUG): Initializing EZServoServo.
2020-01-10T19:21:29.849Z,1578684089.849 [MassServo](DEBUG): Initializing MassServo.
2020-01-10T19:21:29.850Z,1578684089.850 [RudderServo](DEBUG): Initializing EZServoServo.
2020-01-10T19:21:29.861Z,1578684089.861 [RudderServo](DEBUG): Initializing RudderServo.
2020-01-10T19:21:29.862Z,1578684089.862 [ThrusterServo](DEBUG): Initializing EZServoServo.
2020-01-10T19:21:29.869Z,1578684089.869 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2020-01-10T19:21:29.974Z,1578684089.974 [DropWeight](CRITICAL): DROP WEIGHT MISSING.

2020-01-10T19:21:29.974Z,1578684089.974 [DropWeight] Hardware Fault, FailCount= 1
2020-01-10T19:21:29.974Z,1578684089.974 [DropWeight](ERROR): Hardware Fault
2020-01-10T19:21:29.976Z,1578684089.976 [Micromodem](INFO): Powering up
2020-01-10T19:21:29.976Z,1578684089.976 [Micromodem](DEBUG): Initializing Micromodem.
2020-01-10T19:21:30.040Z,1578684090.040 [CommandLine](FAULT): Scheduling is paused
2020-01-10T19:21:30.040Z,1578684090.040 [CBIT](INFO): Critical error at 20200110T192129
2020-01-10T19:21:30.041Z,1578684090.041 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals
2020-01-10T19:21:30.043Z,1578684090.043 [CBIT](ERROR): Hardware Fault in component: DropWeight
2020-01-10T19:21:30.043Z,1578684090.043 [CBIT](CRITICAL): Hardware Fault in component: DropWeight
2020-01-10T19:21:30.729Z,1578684090.729 [RudderServo](ERROR): Rudder initialization uart error serial timeout
2020-01-10T19:21:30.729Z,1578684090.729 [RudderServo](FAULT): Rudder failed to initialize
2020-01-10T19:21:30.729Z,1578684090.729 [RudderServo] Communications Fault, FailCount= 1
2020-01-10T19:21:30.729Z,1578684090.729 [RudderServo](ERROR): Communications Fault
2020-01-10T19:21:30.838Z,1578684090.838 [CBIT](INFO): Critical error at 20200110T192130
2020-01-10T19:21:30.841Z,1578684090.841 [CBIT](ERROR): Communications Fault in component: RudderServo
2020-01-10T19:21:31.018Z,1578684091.018 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2020-01-10T19:21:31.018Z,1578684091.018 [RudderServo](INFO): Powering down
2020-01-10T19:21:31.739Z,1578684091.739 [RudderServo](DEBUG): Initializing EZServoServo.
2020-01-10T19:21:31.858Z,1578684091.858 [RudderServo](DEBUG): Initializing RudderServo.
2020-01-10T19:21:31.862Z,1578684091.862 [CBIT](INFO): Clearing failed state for component RudderServo
2020-01-10T19:21:31.862Z,1578684091.862 [RudderServo] No Fault, FailCount= 1
2020-01-10T19:21:34.929Z,1578684094.929 [Micromodem](INFO): Nmea out: $CCCFG,ALL,0*33

2020-01-10T19:21:35.336Z,1578684095.336 [Micromodem](INFO): Nmea in: $CATMG,2020-01-10T19:21:34.834711Z,RTC,RTC*54

2020-01-10T19:21:35.336Z,1578684095.336 [Micromodem](ERROR): CFG response from modem unexpected: $CATMG,2020-01-10T19:21:34.834711Z,RTC,RTC*54

2020-01-10T19:21:35.735Z,1578684095.735 [Micromodem](INFO): Nmea in: $CACFG,ALL,0*31

2020-01-10T19:21:35.735Z,1578684095.735 [Micromodem](INFO): Nmea out: $CCCFG,SRC,1*31

2020-01-10T19:21:36.143Z,1578684096.143 [Micromodem](INFO): Nmea in: $CACFG,SRC,1*33

2020-01-10T19:21:36.143Z,1578684096.143 [Micromodem](INFO): Nmea out: $CCCFG,nav.dt.txtrig_gpio4,1*64

2020-01-10T19:21:36.547Z,1578684096.547 [Micromodem](INFO): Nmea in: $CACFG,nav.dt.txtrig_gpio4,1*66

2020-01-10T19:21:36.547Z,1578684096.547 [Micromodem](INFO): Nmea out: $CCCFG,pwramp.txlevel,0*2F

2020-01-10T19:21:36.951Z,1578684096.951 [Micromodem](INFO): Nmea in: $CACFG,pwramp.txlevel,0*2D

2020-01-10T19:21:36.951Z,1578684096.951 [Micromodem](INFO): Nmea out: $CCCFG,DTO,30*1E

2020-01-10T19:21:37.359Z,1578684097.359 [Micromodem](INFO): Nmea in: $CACFG,DTO,30*1C

2020-01-10T19:21:37.359Z,1578684097.359 [Micromodem](INFO): Nmea out: $CCCFG,FC0,10000*46

2020-01-10T19:21:37.755Z,1578684097.755 [Micromodem](INFO): Nmea in: $CACFG,FC0,10000*44

2020-01-10T19:21:37.755Z,1578684097.755 [Micromodem](INFO): Nmea out: $CCCFG,BW0,4000*63

2020-01-10T19:21:38.171Z,1578684098.171 [Micromodem](INFO): Nmea in: $CACFG,BW0,4000*61

2020-01-10T19:21:38.171Z,1578684098.171 [Micromodem](INFO): Nmea out: $CCCFG,BND,0*3A

2020-01-10T19:21:38.543Z,1578684098.543 [Micromodem](INFO): Nmea in: $CACFG,BND,0*38

2020-01-10T19:21:38.544Z,1578684098.544 [Micromodem](INFO): Nmea out: $CCCLK,2020,01,10,19,21,39*45

2020-01-10T19:21:38.962Z,1578684098.962 [Micromodem](INFO): Nmea in: $CACLK,2020,1,10,19,21,39*77

2020-01-10T19:21:39.347Z,1578684099.347 [Micromodem](INFO): Nmea in: $CATMS,0,2020-01-10T19:21:40Z*79

2020-01-10T19:21:39.349Z,1578684099.349 [Micromodem](INFO): Nmea in: $CATMG,2020-01-10T19:21:40.026026Z,USER_CMD,RTC*1E

2020-01-10T19:21:40.155Z,1578684100.155 [DDM](INFO): Dynamic Docking Module:G
2020-01-10T19:21:43.001Z,1578684103.001 [RDI_Pathfinder](ERROR): Failed to parse:Pathfinder
2020-01-10T19:21:44.914Z,1578684104.914 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004631
2020-01-10T19:21:47.838Z,1578684107.838 [DUSBL_Hydroid](INFO): DUSBL Version:O
2020-01-10T19:21:55.903Z,1578684115.903 [NAL9602](INFO): Powering up NAL9602
2020-01-10T19:22:06.822Z,1578684126.822 [NAL9602](INFO): NAL9602 initialized
2020-01-10T19:22:08.968Z,1578684128.968 [SBIT](IMPORTANT): Beginning Startup BIT
2020-01-10T19:22:08.985Z,1578684128.985 [CBIT](IMPORTANT): Beginning ground fault scan
2020-01-10T19:22:20.506Z,1578684140.506 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): -0.012357
CHAN A1 (24V): -0.028685
CHAN A2 (12V): -0.007147
CHAN A3 (5V): -0.002307
CHAN B0 (3.3V): 0.000322
CHAN B1 (3.15aV): -0.000235
CHAN B2 (3.15bV): 0.000098
CHAN B3 (GND): 0.002422
OPEN: 0.005315
Full Scale Calc: 4.765 mA, -1.589 mA
2020-01-10T19:22:54.187Z,1578684174.187 [RDI_Pathfinder](ERROR): only read 3 of 4 data items
2020-01-10T19:22:54.187Z,1578684174.187 [RDI_Pathfinder](ERROR): Failed to parse:
:RA,  0.00,   0.00,   0.00,   0.00
2020-01-10T19:23:02.711Z,1578684182.711 [SBIT](IMPORTANT): SBIT PASSED
2020-01-10T19:23:02.732Z,1578684182.732 [CommandLine](IMPORTANT): got command configSet list
2020-01-10T19:23:02.749Z,1578684182.749 [CommandLine](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2020-01-10T19:23:02.750Z,1578684182.750 [CommandLine](IMPORTANT): DDM.loadAtStartup=1 bool;

2020-01-10T19:23:02.750Z,1578684182.750 [CommandLine](IMPORTANT): DDM.verbosity=3 count;

2020-01-10T19:23:02.751Z,1578684182.751 [CommandLine](IMPORTANT): DUSBL_Hydroid.detectionThreshold=75 count;

2020-01-10T19:23:02.751Z,1578684182.751 [CommandLine](IMPORTANT): DUSBL_Hydroid.transmitLockout=40 millisecond;

2020-01-10T19:23:02.751Z,1578684182.751 [CommandLine](IMPORTANT): Express linearApproximation DDM.DDMMode 1.000000 count;

2020-01-10T19:23:02.751Z,1578684182.751 [CommandLine](IMPORTANT): Express all DDM.cablePresent;

2020-01-10T19:23:02.751Z,1578684182.751 [CommandLine](IMPORTANT): Express linearApproximation DDM.latchState 1.000000 count;

2020-01-10T19:23:02.751Z,1578684182.751 [CommandLine](IMPORTANT): Express linearApproximation DDM.whiskerState 1.000000 count;

2020-01-10T19:23:02.751Z,1578684182.751 [CommandLine](IMPORTANT): Express linearApproximation DUSBL_Hydroid.acoustic_contact_range 1.000000 meter;

2020-01-10T19:23:02.751Z,1578684182.751 [CommandLine](IMPORTANT): Express linearApproximation DUSBL_Hydroid.xAngle 2.000000 degree;

2020-01-10T19:23:02.751Z,1578684182.751 [CommandLine](IMPORTANT): Express linearApproximation RDI_Pathfinder.height_above_sea_floor 2.000000 meter;

2020-01-10T19:23:02.752Z,1578684182.752 [CommandLine](IMPORTANT): Express linearApproximation platform_orientation 5.000000 degree;

2020-01-10T19:23:02.752Z,1578684182.752 [CommandLine](IMPORTANT): Express linearApproximation platform_x_velocity_wrt_ground 0.100000 meter_per_second;

2020-01-10T19:23:02.752Z,1578684182.752 [CommandLine](IMPORTANT): Express linearApproximation platform_y_velocity_wrt_ground 0.100000 meter_per_second;

2020-01-10T19:23:02.752Z,1578684182.752 [CommandLine](IMPORTANT): HorizontalControl.kiHeading=0.002 reciprocal_second;

2020-01-10T19:23:02.752Z,1578684182.752 [CommandLine](IMPORTANT): HorizontalControl.kpHeading=0.8 none;

2020-01-10T19:23:02.752Z,1578684182.752 [CommandLine](IMPORTANT): HorizontalControl.rudDeadband=0.05 degree;

2020-01-10T19:23:02.752Z,1578684182.752 [CommandLine](IMPORTANT): Micromodem.destinationAddress=12 enum;

2020-01-10T19:23:02.752Z,1578684182.752 [CommandLine](IMPORTANT): Micromodem.surfaceThreshold=0 meter;

2020-01-10T19:23:02.752Z,1578684182.752 [CommandLine](IMPORTANT): PowerOnly.sampleTime=90 second;

2020-01-10T19:23:02.755Z,1578684182.755 [CommandLine](IMPORTANT): RudderServo.deviationAngle=0.0001 degree;

2020-01-10T19:23:02.755Z,1578684182.755 [CommandLine](IMPORTANT): VerticalControl.buoyancyNeutral=105 cubic_centimeter;

2020-01-10T19:23:02.755Z,1578684182.755 [CommandLine](IMPORTANT): VerticalControl.massDefault=-5 millimeter;

2020-01-10T19:23:03.274Z,1578684183.274 [MissionManager](IMPORTANT): Started mission Startup
2020-01-10T19:23:03.274Z,1578684183.274 [Startup] Running Loop=1
2020-01-10T19:23:03.274Z,1578684183.274 [Startup](DEBUG): Aggregate::initialize Startup
2020-01-10T19:23:03.274Z,1578684183.274 [Startup:A.GoToSurface] Running Loop=1
2020-01-10T19:23:03.274Z,1578684183.274 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2020-01-10T19:23:03.275Z,1578684183.275 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2020-01-10T19:23:03.275Z,1578684183.275 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2020-01-10T19:23:03.276Z,1578684183.276 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2020-01-10T19:23:03.276Z,1578684183.276 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2020-01-10T19:23:03.281Z,1578684183.281 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2020-01-10T19:23:03.282Z,1578684183.282 [Startup:StartupSatComms] Running Loop=1
2020-01-10T19:23:03.282Z,1578684183.282 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2020-01-10T19:23:03.282Z,1578684183.282 [Startup:StartupSatComms:A] Running Loop=1
2020-01-10T19:23:03.515Z,1578684183.515 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2020-01-10T19:23:10.728Z,1578684190.728 [Micromodem](INFO): Nmea in: $CACYC,1,12,1,1,0,2*6B

2020-01-10T19:23:10.728Z,1578684190.728 [Micromodem](INFO): Have incoming data
2020-01-10T19:23:10.735Z,1578684190.735 [Micromodem](INFO): Nmea in: $CARXD,12,1,0,1,858A1AB878DB70DBE89704525FDC95B5C5FE9F4147C09B083E4A8CE30F9EA23DB7C2EC1A3F0C8416B2D6BA469C63028C955B1EDAD054116D0BA2C541AD2A74E9*5A

2020-01-10T19:23:10.735Z,1578684190.735 [Micromodem](INFO): Frame:1
2020-01-10T19:23:10.736Z,1578684190.736 [Micromodem](INFO): Frame Size:-18
2020-01-10T19:23:10.736Z,1578684190.736 [Micromodem](INFO): Data End:-2
2020-01-10T19:23:10.736Z,1578684190.736 [Micromodem](INFO): Data At:16
2020-01-10T19:23:11.160Z,1578684191.160 [Micromodem](INFO): Nmea in: $CARXD,12,1,0,2,4EEE1310BA042F91D0BD31A76379D458F2E8C122*52

2020-01-10T19:23:11.165Z,1578684191.165 [Micromodem](INFO): Frame:2
2020-01-10T19:23:11.166Z,1578684191.166 [Micromodem](INFO): Frame Size:41
2020-01-10T19:23:11.166Z,1578684191.166 [Micromodem](INFO): Data End:57
2020-01-10T19:23:11.166Z,1578684191.166 [Micromodem](INFO): Data At:16
2020-01-10T19:23:11.166Z,1578684191.166 [Micromodem](INFO): Deserialize. FrameCount:2
2020-01-10T19:23:11.166Z,1578684191.166 [Micromodem](INFO): Outer loop. Size:-18
2020-01-10T19:23:11.167Z,1578684191.167 [Micromodem](INFO): Outer loop. Size:41
2020-01-10T19:23:11.168Z,1578684191.168 [Micromodem](CRITICAL): CRC Error 0x22C1E8F2 != computed 0x-4B65D0F9
2020-01-10T19:23:11.190Z,1578684191.190 [Micromodem](CRITICAL): Failed to parse uplink message:4EEE1310BA042F91D0BD31A76379D458F2E8C122
2020-01-10T19:23:11.198Z,1578684191.198 [Micromodem](INFO): Nmea in: $CACST,6,0,20200110192308.412704,06,1728,32,0131,0150,59,02,02,00,03,1,012,001,0,3,2,0,150,17.1,8.00,00,-5.00,-01,-0.02,34,10000,4000*78

2020-01-10T19:23:11.295Z,1578684191.295 [CBIT](INFO): Critical error at 20200110T192311
2020-01-10T19:23:53.192Z,1578684233.192 [RDI_Pathfinder](ERROR): Failed to parse:
:RA,  0.00,   0.00,   0.00,   0.00,   0.00
2020-01-10T19:23:54.811Z,1578684234.811 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error
2020-01-10T19:23:54.811Z,1578684234.811 [RDI_Pathfinder](ERROR): Failed to parse:
:TS,20011012364609,35.0, -0.1,   0.0,10
2020-01-10T19:24:03.301Z,1578684243.301 [Startup:StartupSatComms:A](INFO): Timed out from 2020-01-10T19:23:03.3Z
2020-01-10T19:24:03.301Z,1578684243.301 [Startup:StartupSatComms:A] Stopped
2020-01-10T19:24:03.301Z,1578684243.301 [Startup:StartupSatComms:B] Running Loop=1
2020-01-10T19:24:03.703Z,1578684243.703 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2020-01-10T19:24:04.922Z,1578684244.922 [Micromodem](INFO): Outgoing frame #1, 64 bytes: 83C5185E000001005D000004002E0100000000000000151D80030C5669BF31555EAE1409A708CE2489EC102F971AAFC35C3D87A14EFD88D7E667BF45C1E3A334
2020-01-10T19:24:04.922Z,1578684244.922 [Micromodem](INFO): Outgoing frame #2, 64 bytes: DEFFB679D5E2290A79E7E5E85268E06DD92C544DC901C9387913BE8884586314DBA5B5065109D2F2129A254ED0C97EF4D0CB8AA285DE4E98C7DDE9DEA0DE3090
2020-01-10T19:24:04.923Z,1578684244.923 [Micromodem](INFO): Outgoing frame #3, 64 bytes: 814E3EE6FF6A00E732458E8FC9A4D036E2DFAC39DA6B904B7912AD0BD22F24747AA4E0AD66F078E31C34B24E7F5DE85DC2359C37E12C8E91890FC368EE7E15AB
2020-01-10T19:24:04.923Z,1578684244.923 [Micromodem](INFO): Nmea out: $CCCYC,0,1,12,1,0,3*69

2020-01-10T19:24:05.151Z,1578684245.151 [Micromodem](INFO): Nmea in: $CACYC,0,1,12,1,0,3*6B

2020-01-10T19:24:05.509Z,1578684245.509 [Micromodem](INFO): Nmea in: $CADRQ,192405,1,12,0,64,1*7F

2020-01-10T19:24:05.510Z,1578684245.510 [Micromodem](INFO): Nmea out: $CCTXD,1,12,1,83C5185E000001005D000004002E0100000000000000151D80030C5669BF31555EAE1409A708CE2489EC102F971AAFC35C3D87A14EFD88D7E667BF45C1E3A334*4B

2020-01-10T19:24:05.915Z,1578684245.915 [Micromodem](INFO): Nmea in: $CATXD,1,12,1,64*4B

2020-01-10T19:24:06.307Z,1578684246.307 [Micromodem](INFO): Nmea in: $CADRQ,192406,1,12,0,64,2*7F

2020-01-10T19:24:06.307Z,1578684246.307 [Micromodem](INFO): Nmea out: $CCTXD,1,12,1,DEFFB679D5E2290A79E7E5E85268E06DD92C544DC901C9387913BE8884586314DBA5B5065109D2F2129A254ED0C97EF4D0CB8AA285DE4E98C7DDE9DEA0DE3090*31

2020-01-10T19:24:06.715Z,1578684246.715 [Micromodem](INFO): Nmea in: $CATXD,1,12,1,64*4B

2020-01-10T19:24:07.133Z,1578684247.133 [Micromodem](INFO): Nmea in: $CADRQ,192407,1,12,0,64,3*7F

2020-01-10T19:24:07.134Z,1578684247.134 [Micromodem](INFO): Nmea out: $CCTXD,1,12,1,814E3EE6FF6A00E732458E8FC9A4D036E2DFAC39DA6B904B7912AD0BD22F24747AA4E0AD66F078E31C34B24E7F5DE85DC2359C37E12C8E91890FC368EE7E15AB*41

2020-01-10T19:24:07.519Z,1578684247.519 [Micromodem](INFO): Nmea in: $CATXD,1,12,1,64*4B

2020-01-10T19:24:07.932Z,1578684247.932 [Micromodem](INFO): Nmea in: $CATXP,192*48

2020-01-10T19:24:11.575Z,1578684251.575 [Micromodem](INFO): Nmea in: $CATXF,192*5E

2020-01-10T19:24:11.968Z,1578684251.968 [Micromodem](INFO): Nmea in: $CAXST,6,20200110,192408.224561,3,0,200,4000,10000,1,1,12,1,3,3,3,192*7A

2020-01-10T19:24:12.093Z,1578684252.093 [DataOverHttps](INFO): Sending 235 bytes from file Logs/20200110T184211/Courier0000.lzma
2020-01-10T19:24:13.179Z,1578684253.179 [Micromodem](INFO): Nmea in: $CAACK,12,1,1,1*79

2020-01-10T19:24:13.579Z,1578684253.579 [Micromodem](INFO): Nmea in: $CAACK,12,1,2,1*7A

2020-01-10T19:24:13.983Z,1578684253.983 [Micromodem](INFO): Nmea in: $CAACK,12,1,3,1*7B

2020-01-10T19:24:13.984Z,1578684253.984 [Micromodem](INFO): Sent 184 bytes from file Logs/20200110T184211/Courier0000.lzma.parts
2020-01-10T19:24:13.984Z,1578684253.984 [Micromodem](INFO): Packets left to send: 1
2020-01-10T19:24:14.098Z,1578684254.098 [DataOverHttps](INFO): Moved sent file to Logs/20200110T184211/Courier0000.lzma.bak
2020-01-10T19:24:14.099Z,1578684254.099 [DataOverHttps](INFO): SBD MOMSN=12190500
2020-01-10T19:24:14.397Z,1578684254.397 [Micromodem](INFO): Nmea in: $CACST,6,0,20200110192412.776710,06,562,27,0107,0150,89,02,02,00,04,1,012,001,0,4,1,0,150,1.7,6.00,14,-3.00,-01,-0.04,48,10000,4000*73

2020-01-10T19:24:14.945Z,1578684254.945 [Micromodem](INFO): Outgoing frame #1, 64 bytes: 1BC6185E000001005D000004002E0100000000000000151D80030C5669BF31555EAE1409A708CE2489EC102F971AAFC35C3D87A14EFD88D7E667BF45C1E3A334
2020-01-10T19:24:14.946Z,1578684254.946 [Micromodem](INFO): Outgoing frame #2, 64 bytes: DDEBD598F6565BB0449D3EA2F81C0BFF8CE56E35EC67A93FD334E3874162704AA07756C3EBC431663649181551938923D578DCB507DCEE904D9B4CD1EE47095A
2020-01-10T19:24:14.946Z,1578684254.946 [Micromodem](INFO): Outgoing frame #3, 64 bytes: 4536BAA60F440F9127DC5B3261C4B3903D348EAED2B6ECFA3CC216EA0E042E9BBBFBF55EE5576DB9CBCC5244236A38F0F3151A17A39C7E100207154061A1AAB6
2020-01-10T19:24:14.947Z,1578684254.947 [Micromodem](INFO): Nmea out: $CCCYC,0,1,12,1,0,3*69

2020-01-10T19:24:15.859Z,1578684255.859 [Micromodem](INFO): Nmea in: $CACYC,0,1,12,1,0,3*6B

2020-01-10T19:24:16.270Z,1578684256.270 [Micromodem](INFO): Nmea in: $CADRQ,192415,1,12,0,64,1*7E

2020-01-10T19:24:16.271Z,1578684256.271 [Micromodem](INFO): Nmea out: $CCTXD,1,12,1,1BC6185E000001005D000004002E0100000000000000151D80030C5669BF31555EAE1409A708CE2489EC102F971AAFC35C3D87A14EFD88D7E667BF45C1E3A334*30

2020-01-10T19:24:16.667Z,1578684256.667 [Micromodem](INFO): Nmea in: $CATXD,1,12,1,64*4B

2020-01-10T19:24:17.081Z,1578684257.081 [Micromodem](INFO): Nmea in: $CADRQ,192417,1,12,0,64,2*7F

2020-01-10T19:24:17.081Z,1578684257.081 [Micromodem](INFO): Nmea out: $CCTXD,1,12,1,DDEBD598F6565BB0449D3EA2F81C0BFF8CE56E35EC67A93FD334E3874162704AA07756C3EBC431663649181551938923D578DCB507DCEE904D9B4CD1EE47095A*49

2020-01-10T19:24:17.475Z,1578684257.475 [Micromodem](INFO): Nmea in: $CATXD,1,12,1,64*4B

2020-01-10T19:24:17.879Z,1578684257.879 [Micromodem](INFO): Nmea in: $CADRQ,192418,1,12,0,64,3*71

2020-01-10T19:24:17.879Z,1578684257.879 [Micromodem](INFO): Nmea out: $CCTXD,1,12,1,4536BAA60F440F9127DC5B3261C4B3903D348EAED2B6ECFA3CC216EA0E042E9BBBFBF55EE5576DB9CBCC5244236A38F0F3151A17A39C7E100207154061A1AAB6*31

2020-01-10T19:24:18.297Z,1578684258.297 [Micromodem](INFO): Nmea in: $CATXD,1,12,1,64*4B

2020-01-10T19:24:18.686Z,1578684258.686 [Micromodem](INFO): Nmea in: $CATXP,192*48

2020-01-10T19:24:22.323Z,1578684262.323 [Micromodem](INFO): Nmea in: $CATXF,192*5E

2020-01-10T19:24:22.728Z,1578684262.728 [Micromodem](INFO): Nmea in: $CAXST,6,20200110,192418.970492,3,0,200,4000,10000,1,1,12,1,3,3,3,192*7C

2020-01-10T19:24:23.544Z,1578684263.544 [Micromodem](INFO): Nmea in: $CAACK,12,1,1,1*79

2020-01-10T19:24:23.948Z,1578684263.948 [Micromodem](INFO): Nmea in: $CAACK,12,1,2,1*7A

2020-01-10T19:24:24.343Z,1578684264.343 [Micromodem](INFO): Nmea in: $CAACK,12,1,3,1*7B

2020-01-10T19:24:24.344Z,1578684264.344 [Micromodem](INFO): Sent 184 bytes from file Logs/20200110T184443/Courier0000.lzma.parts
2020-01-10T19:24:24.344Z,1578684264.344 [Micromodem](INFO): Packets left to send: 1
2020-01-10T19:24:24.757Z,1578684264.757 [Micromodem](INFO): Nmea in: $CACST,6,0,20200110192423.522348,06,211,23,0131,0150,29,02,02,00,02,1,012,001,0,4,1,0,150,5.2,7.00,16,-4.00,-01,-0.04,37,10000,4000*78

2020-01-10T19:24:25.311Z,1578684265.311 [Micromodem](INFO): Outgoing frame #1, 55 bytes: 1BC6185E000000008F2A3733F26834B3183EA0DE1F320119A53CC0FCF7C89F6943E06426210B824E79B90F7121E69ACEE90CDE22EB9216
2020-01-10T19:24:25.311Z,1578684265.311 [Micromodem](INFO): Nmea out: $CCCYC,0,1,12,1,0,1*6B

2020-01-10T19:24:26.243Z,1578684266.243 [Micromodem](INFO): Nmea in: $CACYC,0,1,12,1,0,1*69

2020-01-10T19:24:26.651Z,1578684266.651 [Micromodem](INFO): Nmea in: $CADRQ,192426,1,12,0,64,1*7E

2020-01-10T19:24:26.651Z,1578684266.651 [Micromodem](INFO): Nmea out: $CCTXD,1,12,1,1BC6185E000000008F2A3733F26834B3183EA0DE1F320119A53CC0FCF7C89F6943E06426210B824E79B90F7121E69ACEE90CDE22EB9216*39

2020-01-10T19:24:27.051Z,1578684267.051 [Micromodem](INFO): Nmea in: $CATXD,1,12,1,55*49

2020-01-10T19:24:27.454Z,1578684267.454 [Micromodem](INFO): Nmea in: $CATXP,55*72

2020-01-10T19:24:28.666Z,1578684268.666 [Micromodem](INFO): Nmea in: $CATXF,55*64

2020-01-10T19:24:29.071Z,1578684269.071 [Micromodem](INFO): Nmea in: $CAXST,6,20200110,192427.707207,3,0,200,4000,10000,1,1,12,1,1,1,3,55*4E

2020-01-10T19:24:29.534Z,1578684269.534 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2020-01-10T19:24:29.534Z,1578684269.534 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-01-10T19:24:29.552Z,1578684269.552 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-01-10T19:24:29.911Z,1578684269.911 [Micromodem](INFO): Nmea in: $CAACK,12,1,1,1*79

2020-01-10T19:24:29.912Z,1578684269.912 [Micromodem](INFO): Sent 47 bytes from file Logs/20200110T184443/Courier0000.lzma.parts
2020-01-10T19:24:29.912Z,1578684269.912 [Micromodem](INFO): Packets left to send: 0
2020-01-10T19:24:30.090Z,1578684270.090 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-01-10T19:24:30.090Z,1578684270.090 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2020-01-10T19:24:30.290Z,1578684270.290 [Micromodem](INFO): Nmea in: $CACST,6,0,20200110192429.719078,06,750,28,0130,0150,89,02,02,00,03,1,012,001,0,4,1,0,150,21.9,8.00,19,-5.00,-01,-0.05,30,10000,4000*43

2020-01-10T19:24:31.385Z,1578684271.385 [Micromodem](INFO): Outgoing frame #1, 64 bytes: 65C7185E000001005D00000400210200000000000000151D80030C5669BF31555EAE1409A708CE2489EC102F971AAFC35C3D87A14EFD88D7E667BF45C1E3A334
2020-01-10T19:24:31.385Z,1578684271.385 [Micromodem](INFO): Outgoing frame #2, 64 bytes: DD86C1F30BD920BD1002ED7DE5F0A34039F6130B595103D462D2DB2E852823627655FC90F1AD879BF7D4A4A65053B0D98E0000369C9F9FEBD9071AA765EF29DE
2020-01-10T19:24:31.386Z,1578684271.386 [Micromodem](INFO): Outgoing frame #3, 64 bytes: 214847F825E0E5544217F6017449B9534A28C5C580D81FC646165A120D5CAA190626911B873B889C032D29DEAAA67B91E229ED2396171BE192BE2807A97A5E7E
2020-01-10T19:24:31.386Z,1578684271.386 [Micromodem](INFO): Nmea out: $CCCYC,0,1,12,1,0,3*69

2020-01-10T19:24:31.935Z,1578684271.935 [DataOverHttps](INFO): Sending 262 bytes from file Logs/20200110T185013/Courier0000.lzma
2020-01-10T19:24:32.359Z,1578684272.359 [Micromodem](INFO): Nmea in: $CACYC,0,1,12,1,0,3*6B

2020-01-10T19:24:32.763Z,1578684272.763 [Micromodem](INFO): Nmea in: $CADRQ,192432,1,12,0,64,1*7B

2020-01-10T19:24:32.763Z,1578684272.763 [Micromodem](INFO): Nmea out: $CCTXD,1,12,1,65C7185E000001005D00000400210200000000000000151D80030C5669BF31555EAE1409A708CE2489EC102F971AAFC35C3D87A14EFD88D7E667BF45C1E3A334*36

2020-01-10T19:24:33.038Z,1578684273.038 [DataOverHttps](INFO): Moved sent file to Logs/20200110T185013/Courier0000.lzma.bak
2020-01-10T19:24:33.038Z,1578684273.038 [DataOverHttps](INFO): SBD MOMSN=12190508
2020-01-10T19:24:33.171Z,1578684273.171 [Micromodem](INFO): Nmea in: $CATXD,1,12,1,64*4B

2020-01-10T19:24:33.575Z,1578684273.575 [Micromodem](INFO): Nmea in: $CADRQ,192433,1,12,0,64,2*79

2020-01-10T19:24:33.575Z,1578684273.575 [Micromodem](INFO): Nmea out: $CCTXD,1,12,1,DD86C1F30BD920BD1002ED7DE5F0A34039F6130B595103D462D2DB2E852823627655FC90F1AD879BF7D4A4A65053B0D98E0000369C9F9FEBD9071AA765EF29DE*4F

2020-01-10T19:24:33.975Z,1578684273.975 [Micromodem](INFO): Nmea in: $CATXD,1,12,1,64*4B

2020-01-10T19:24:34.391Z,1578684274.391 [Micromodem](INFO): Nmea in: $CADRQ,192434,1,12,0,64,3*7F

2020-01-10T19:24:34.392Z,1578684274.392 [Micromodem](INFO): Nmea out: $CCTXD,1,12,1,214847F825E0E5544217F6017449B9534A28C5C580D81FC646165A120D5CAA190626911B873B889C032D29DEAAA67B91E229ED2396171BE192BE2807A97A5E7E*3E

2020-01-10T19:24:34.814Z,1578684274.814 [Micromodem](INFO): Nmea in: $CATXD,1,12,1,64*4B

2020-01-10T19:24:35.191Z,1578684275.191 [Micromodem](INFO): Nmea in: $CATXP,192*48

2020-01-10T19:24:38.830Z,1578684278.830 [Micromodem](INFO): Nmea in: $CATXF,192*5E

2020-01-10T19:24:39.228Z,1578684279.228 [Micromodem](INFO): Nmea in: $CAXST,6,20200110,192435.476072,3,0,200,4000,10000,1,1,12,1,3,3,3,192*72

2020-01-10T19:24:40.040Z,1578684280.040 [Micromodem](INFO): Nmea in: $CAACK,12,1,1,1*79

2020-01-10T19:24:40.445Z,1578684280.445 [Micromodem](INFO): Nmea in: $CAACK,12,1,2,1*7A

2020-01-10T19:24:40.839Z,1578684280.839 [Micromodem](INFO): Nmea in: $CAACK,12,1,3,1*7B

2020-01-10T19:24:40.840Z,1578684280.840 [Micromodem](INFO): Sent 184 bytes from file Logs/20200110T185013/Courier0000.lzma.parts
2020-01-10T19:24:40.840Z,1578684280.840 [Micromodem](INFO): Packets left to send: 1
2020-01-10T19:24:41.250Z,1578684281.250 [Micromodem](INFO): Nmea in: $CACST,6,0,20200110192440.028231,06,207,23,0100,0150,89,02,02,00,03,1,012,001,0,4,1,0,150,24.4,7.00,17,-4.00,-01,-0.03,27,10000,4000*41

2020-01-10T19:24:41.766Z,1578684281.766 [Micromodem](INFO): Outgoing frame #1, 64 bytes: 0BCA185E000001005D000004002E0100000000000000151D80030C5669BF31555EAE1409A708CE2489EC102F971AAFC35C3D87A14EFD88D7E667BF45C1E3A334
2020-01-10T19:24:41.766Z,1578684281.766 [Micromodem](INFO): Outgoing frame #2, 64 bytes: DEB284076F155F38175D72528141FCD31168F3FCB2C4BD3BAF2BAC3F3A4F4F207408D30883F3FF14CFB2D7C55BFC2BAD695E5BA5DD66AD48120345F3BD27D251
2020-01-10T19:24:41.767Z,1578684281.767 [Micromodem](INFO): Outgoing frame #3, 64 bytes: EB308B4AA8DD6B01A9910DCC90D0D8C0AD3D8DA84482D6F26AC4BEAB3D6CAB6C835696E7C3DF65ED2F458D5B1A7E2E690B01FAE62136B5C22709CE6F0EF91A27
2020-01-10T19:24:41.767Z,1578684281.767 [Micromodem](INFO): Nmea out: $CCCYC,0,1,12,1,0,3*69

2020-01-10T19:24:42.695Z,1578684282.695 [Micromodem](INFO): Nmea in: $CACYC,0,1,12,1,0,3*6B

2020-01-10T19:24:43.099Z,1578684283.099 [Micromodem](INFO): Nmea in: $CADRQ,192442,1,12,0,64,1*7C

2020-01-10T19:24:43.099Z,1578684283.099 [Micromodem](INFO): Nmea out: $CCTXD,1,12,1,0BCA185E000001005D000004002E0100000000000000151D80030C5669BF31555EAE1409A708CE2489EC102F971AAFC35C3D87A14EFD88D7E667BF45C1E3A334*46

2020-01-10T19:24:43.499Z,1578684283.499 [Micromodem](INFO): Nmea in: $CATXD,1,12,1,64*4B

2020-01-10T19:24:43.911Z,1578684283.911 [Micromodem](INFO): Nmea in: $CADRQ,192444,1,12,0,64,2*79

2020-01-10T19:24:43.912Z,1578684283.912 [Micromodem](INFO): Nmea out: $CCTXD,1,12,1,DEB284076F155F38175D72528141FCD31168F3FCB2C4BD3BAF2BAC3F3A4F4F207408D30883F3FF14CFB2D7C55BFC2BAD695E5BA5DD66AD48120345F3BD27D251*40

2020-01-10T19:24:44.313Z,1578684284.313 [Micromodem](INFO): Nmea in: $CATXD,1,12,1,64*4B

2020-01-10T19:24:44.707Z,1578684284.707 [Micromodem](INFO): Nmea in: $CADRQ,192444,1,12,0,64,3*78

2020-01-10T19:24:44.707Z,1578684284.707 [Micromodem](INFO): Nmea out: $CCTXD,1,12,1,EB308B4AA8DD6B01A9910DCC90D0D8C0AD3D8DA84482D6F26AC4BEAB3D6CAB6C835696E7C3DF65ED2F458D5B1A7E2E690B01FAE62136B5C22709CE6F0EF91A27*32

2020-01-10T19:24:45.115Z,1578684285.115 [Micromodem](INFO): Nmea in: $CATXD,1,12,1,64*4B

2020-01-10T19:24:45.521Z,1578684285.521 [Micromodem](INFO): Nmea in: $CATXP,192*48

2020-01-10T19:24:49.151Z,1578684289.151 [Micromodem](INFO): Nmea in: $CATXF,192*5E

2020-01-10T19:24:49.560Z,1578684289.560 [Micromodem](INFO): Nmea in: $CAXST,6,20200110,192445.796143,3,0,200,4000,10000,1,1,12,1,3,3,3,192*7B

2020-01-10T19:24:50.372Z,1578684290.372 [Micromodem](INFO): Nmea in: $CAACK,12,1,1,1*79

2020-01-10T19:24:50.541Z,1578684290.541 [DataOverHttps](INFO): Sending 233 bytes from file Logs/20200110T190131/Courier0000.lzma
2020-01-10T19:24:50.767Z,1578684290.767 [Micromodem](INFO): Nmea in: $CAACK,12,1,2,1*7A

2020-01-10T19:24:51.179Z,1578684291.179 [Micromodem](INFO): Nmea in: $CAACK,12,1,3,1*7B

2020-01-10T19:24:51.180Z,1578684291.180 [Micromodem](INFO): Sent 184 bytes from file Logs/20200110T190131/Courier0000.lzma.parts
2020-01-10T19:24:51.180Z,1578684291.180 [Micromodem](INFO): Packets left to send: 1
2020-01-10T19:24:51.582Z,1578684291.582 [Micromodem](INFO): Nmea in: $CACST,6,0,20200110192450.348143,06,228,23,0118,0150,29,01,01,00,03,1,012,001,0,4,1,0,150,26.6,6.00,14,-3.00,-01,-0.04,18,10000,4000*43

2020-01-10T19:24:52.123Z,1578684292.123 [Micromodem](INFO): Outgoing frame #1, 57 bytes: 0BCA185E00000000B825BE7D5AE7E06D20698545710F7454A7CA6C626F50F71F7D6C690976BFB6B459322AA1F06FE9C4ABA89F72236D352DFE
2020-01-10T19:24:52.124Z,1578684292.124 [Micromodem](INFO): Nmea out: $CCCYC,0,1,12,1,0,1*6B

2020-01-10T19:24:52.546Z,1578684292.546 [DataOverHttps](INFO): Moved sent file to Logs/20200110T190131/Courier0000.lzma.bak
2020-01-10T19:24:52.546Z,1578684292.546 [DataOverHttps](INFO): SBD MOMSN=12190522
2020-01-10T19:24:53.043Z,1578684293.043 [Micromodem](INFO): Nmea in: $CACYC,0,1,12,1,0,1*69

2020-01-10T19:24:53.447Z,1578684293.447 [Micromodem](INFO): Nmea in: $CADRQ,192453,1,12,0,64,1*7C

2020-01-10T19:24:53.448Z,1578684293.448 [Micromodem](INFO): Nmea out: $CCTXD,1,12,1,0BCA185E00000000B825BE7D5AE7E06D20698545710F7454A7CA6C626F50F71F7D6C690976BFB6B459322AA1F06FE9C4ABA89F72236D352DFE*4B

2020-01-10T19:24:53.853Z,1578684293.853 [Micromodem](INFO): Nmea in: $CATXD,1,12,1,57*4B

2020-01-10T19:24:54.251Z,1578684294.251 [Micromodem](INFO): Nmea in: $CATXP,57*70

2020-01-10T19:24:55.471Z,1578684295.471 [Micromodem](INFO): Nmea in: $CATXF,57*66

2020-01-10T19:24:55.876Z,1578684295.876 [Micromodem](INFO): Nmea in: $CAXST,6,20200110,192454.502786,3,0,200,4000,10000,1,1,12,1,1,1,3,57*43

2020-01-10T19:24:56.675Z,1578684296.675 [Micromodem](INFO): Nmea in: $CAACK,12,1,1,1*79

2020-01-10T19:24:56.675Z,1578684296.675 [Micromodem](INFO): Sent 49 bytes from file Logs/20200110T190131/Courier0000.lzma.parts
2020-01-10T19:24:56.676Z,1578684296.676 [Micromodem](INFO): Packets left to send: 0
2020-01-10T19:24:57.086Z,1578684297.086 [Micromodem](INFO): Nmea in: $CACST,6,0,20200110192456.514108,06,204,23,0115,0150,29,02,02,00,04,1,012,001,0,4,1,0,150,11.2,7.00,16,-4.00,-01,-0.03,33,10000,4000*4B

2020-01-10T19:24:58.144Z,1578684298.144 [Micromodem](INFO): Outgoing frame #1, 64 bytes: 8DCA185E000001005D00000400000100000000000000151D80030C5669BF31555EAE1409A708CE2489EC102F971AAFC35C3D87A14EFD88D7E667BF45C1E3A334
2020-01-10T19:24:58.144Z,1578684298.144 [Micromodem](INFO): Outgoing frame #2, 64 bytes: DE2526C873EDA5E23E647E5B7D4222B03F9AB92DA0826C4684D506BE59DA52CC50123EFF3D48EF727AB8DFC7251D5B3F57386DB46E15312DED82BD3B068FC6CC
2020-01-10T19:24:58.145Z,1578684298.145 [Micromodem](INFO): Outgoing frame #3, 64 bytes: BE9323714333D7016E170594280EE877CF56AB11005C4BED4875FCA950B1491D1909F617590F53045A27568B12A685958867489590C7FFF42DEBB72359B80715
2020-01-10T19:24:58.145Z,1578684298.145 [Micromodem](INFO): Nmea out: $CCCYC,0,1,12,1,0,3*69

2020-01-10T19:24:59.087Z,1578684299.087 [Micromodem](INFO): Nmea in: $CACYC,0,1,12,1,0,3*6B

2020-01-10T19:24:59.491Z,1578684299.491 [Micromodem](INFO): Nmea in: $CADRQ,192459,1,12,0,64,1*76

2020-01-10T19:24:59.491Z,1578684299.491 [Micromodem](INFO): Nmea out: $CCTXD,1,12,1,8DCA185E000001005D00000400000100000000000000151D80030C5669BF31555EAE1409A708CE2489EC102F971AAFC35C3D87A14EFD88D7E667BF45C1E3A334*3F

2020-01-10T19:24:59.899Z,1578684299.899 [Micromodem](INFO): Nmea in: $CATXD,1,12,1,64*4B

2020-01-10T19:25:00.303Z,1578684300.303 [Micromodem](INFO): Nmea in: $CADRQ,192500,1,12,0,64,2*78

2020-01-10T19:25:00.303Z,1578684300.303 [Micromodem](INFO): Nmea out: $CCTXD,1,12,1,DE2526C873EDA5E23E647E5B7D4222B03F9AB92DA0826C4684D506BE59DA52CC50123EFF3D48EF727AB8DFC7251D5B3F57386DB46E15312DED82BD3B068FC6CC*44

2020-01-10T19:25:00.713Z,1578684300.713 [Micromodem](INFO): Nmea in: $CATXD,1,12,1,64*4B

2020-01-10T19:25:01.112Z,1578684301.112 [Micromodem](INFO): Nmea in: $CADRQ,192501,1,12,0,64,3*78

2020-01-10T19:25:01.112Z,1578684301.112 [Micromodem](INFO): Nmea out: $CCTXD,1,12,1,BE9323714333D7016E170594280EE877CF56AB11005C4BED4875FCA950B1491D1909F617590F53045A27568B12A685958867489590C7FFF42DEBB72359B80715*3E

2020-01-10T19:25:01.511Z,1578684301.511 [Micromodem](INFO): Nmea in: $CATXD,1,12,1,64*4B

2020-01-10T19:25:01.916Z,1578684301.916 [Micromodem](INFO): Nmea in: $CATXP,192*48

2020-01-10T19:25:03.636Z,1578684303.636 [Startup:StartupSatComms:B](INFO): Timed out from 2020-01-10T19:24:03.3Z
2020-01-10T19:25:03.636Z,1578684303.636 [Startup:StartupSatComms:B] Stopped
2020-01-10T19:25:03.636Z,1578684303.636 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2020-01-10T19:25:03.636Z,1578684303.636 [Startup:StartupSatComms] Stopped
2020-01-10T19:25:03.636Z,1578684303.636 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2020-01-10T19:25:03.637Z,1578684303.637 [Startup](INFO): Completed Startup
2020-01-10T19:25:03.637Z,1578684303.637 [MissionManager](INFO): Startup is completed.
2020-01-10T19:25:03.637Z,1578684303.637 [MissionManager](INFO): Uninitializing Mission Startup
2020-01-10T19:25:03.638Z,1578684303.638 [Startup] Stopped
2020-01-10T19:25:03.638Z,1578684303.638 [Startup](DEBUG): Aggregate::uninitialize Startup
2020-01-10T19:25:03.638Z,1578684303.638 [Startup:A.GoToSurface] Stopped
2020-01-10T19:25:03.638Z,1578684303.638 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2020-01-10T19:25:04.005Z,1578684304.005 [MissionManager](IMPORTANT): Started mission Default
2020-01-10T19:25:04.006Z,1578684304.006 [Default] Running Loop=1
2020-01-10T19:25:04.006Z,1578684304.006 [Default](DEBUG): Aggregate::initialize Default
2020-01-10T19:25:04.006Z,1578684304.006 [Default:B.GoToSurface] Running Loop=1
2020-01-10T19:25:04.006Z,1578684304.006 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2020-01-10T19:25:04.006Z,1578684304.006 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2020-01-10T19:25:04.007Z,1578684304.007 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2020-01-10T19:25:04.007Z,1578684304.007 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2020-01-10T19:25:04.007Z,1578684304.007 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2020-01-10T19:25:04.008Z,1578684304.008 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2020-01-10T19:25:04.008Z,1578684304.008 [Default:A.Wait] Running Loop=1
2020-01-10T19:25:04.008Z,1578684304.008 [Default:A.Wait](DEBUG): Initialize Wait Component.
2020-01-10T19:25:05.557Z,1578684305.557 [Micromodem](INFO): Nmea in: $CATXF,192*5E

2020-01-10T19:25:05.559Z,1578684305.559 [Micromodem](INFO): Nmea in: $CAXST,6,20200110,192502.200383,3,0,200,4000,10000,1,1,12,1,3,3,3,192*7D

2020-01-10T19:25:06.776Z,1578684306.776 [Micromodem](INFO): Nmea in: $CAACK,12,1,1,1*79

2020-01-10T19:25:06.792Z,1578684306.792 [Micromodem](INFO): Nmea in: $CAACK,12,1,2,1*7A

2020-01-10T19:25:06.857Z,1578684306.857 [RDI_Pathfinder](ERROR): only read 3 of 4 data items
2020-01-10T19:25:06.857Z,1578684306.857 [RDI_Pathfinder](ERROR): Failed to parse:
:RA,  0.00,   0.00,   0.00,   8,V
2020-01-10T19:25:07.167Z,1578684307.167 [Micromodem](INFO): Nmea in: $CAACK,12,1,3,1*7B

2020-01-10T19:25:07.171Z,1578684307.171 [Micromodem](INFO): Nmea in: $CACST,6,0,20200110192506.752157,06,218,23,0126,0150,59,02,02,00,04,1,012,001,0,4,1,0,150,13.9,6.00,16,-3.00,-01,-0.04,35,2AREV,192507,AUV,2.0.32731*13

2020-01-10T19:25:07.171Z,1578684307.171 [Micromodem](ERROR): Response from modem failed NMEA checksum: $CACST,6,0,20200110192506.752157,06,218,23,0126,0150,59,02,02,00,04,1,012,001,0,4,1,0,150,13.9,6.00,16,-3.00,-01,-0.04,35,2AREV,192507,AUV,2.0.32731*13
 expected 3A
2020-01-10T19:25:10.681Z,1578684310.681 [DataOverHttps](INFO): Sending 211 bytes from file Logs/20200110T190341/Courier0000.lzma
2020-01-10T19:25:12.686Z,1578684312.686 [DataOverHttps](INFO): Moved sent file to Logs/20200110T190341/Courier0000.lzma.bak
2020-01-10T19:25:12.686Z,1578684312.686 [DataOverHttps](INFO): SBD MOMSN=12190540
2020-01-10T19:25:17.406Z,1578684317.406 [Default:A.Wait](INFO): Done Waiting.
2020-01-10T19:25:17.406Z,1578684317.406 [Default:A.Wait] Stopped
2020-01-10T19:25:17.406Z,1578684317.406 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2020-01-10T19:25:17.726Z,1578684317.726 [Default:CheckIn] Running Loop=1
2020-01-10T19:25:17.726Z,1578684317.726 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2020-01-10T19:25:17.726Z,1578684317.726 [Default:CheckIn:Read_GPS] Running Loop=1
2020-01-10T19:25:18.115Z,1578684318.115 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2020-01-10T19:25:22.414Z,1578684322.414 [Micromodem](INFO): Nmea in: $CACYC,1,12,1,1,0,2*6B

2020-01-10T19:25:22.415Z,1578684322.415 [Micromodem](INFO): Have incoming data
2020-01-10T19:25:22.420Z,1578684322.420 [Micromodem](INFO): Nmea in: $CARXD,12,1,0,1,858A1AB878DB70DBE89704525FDC95B5C5FE9F4147C09B083E4A8CE30F9EA23DB7C2EC1A3F0C8416B2D6BA469C63028C955B1EDAD054116D0BA2C541AD2A74E9*5A

2020-01-10T19:25:22.421Z,1578684322.421 [Micromodem](INFO): Frame:1
2020-01-10T19:25:22.422Z,1578684322.422 [Micromodem](INFO): Frame Size:129
2020-01-10T19:25:22.422Z,1578684322.422 [Micromodem](INFO): Data End:145
2020-01-10T19:25:22.422Z,1578684322.422 [Micromodem](INFO): Data At:16
2020-01-10T19:25:22.841Z,1578684322.841 [Micromodem](INFO): Nmea in: $CARXD,12,1,0,2,4EEE1310BA042F91D0BD31A76379D458F2E8C122*52

2020-01-10T19:25:22.841Z,1578684322.841 [Micromodem](INFO): Frame:2
2020-01-10T19:25:22.841Z,1578684322.841 [Micromodem](INFO): Frame Size:41
2020-01-10T19:25:22.842Z,1578684322.842 [Micromodem](INFO): Data End:57
2020-01-10T19:25:22.842Z,1578684322.842 [Micromodem](INFO): Data At:16
2020-01-10T19:25:22.842Z,1578684322.842 [Micromodem](INFO): Deserialize. FrameCount:2
2020-01-10T19:25:22.842Z,1578684322.842 [Micromodem](INFO): Outer loop. Size:129
2020-01-10T19:25:22.842Z,1578684322.842 [Micromodem](INFO): Outer loop. Size:41
2020-01-10T19:25:22.843Z,1578684322.843 [Micromodem](INFO): Received command:failc;stop;configSet list;get platform_orientation degree;stop;failc
2020-01-10T19:25:23.483Z,1578684323.483 [CommandLine](IMPORTANT): got command failComponent
2020-01-10T19:25:23.483Z,1578684323.483 [CommandLine](IMPORTANT): Failed components:
2020-01-10T19:25:23.483Z,1578684323.483 [CommandLine](IMPORTANT): DropWeight: Hardware Fault
2020-01-10T19:25:23.484Z,1578684323.484 [CommandLine](IMPORTANT): got command stop
2020-01-10T19:25:23.484Z,1578684323.484 [CommandLine](IMPORTANT): Scheduling is paused
2020-01-10T19:25:23.484Z,1578684323.484 [CommandLine](IMPORTANT): got command configSet list
2020-01-10T19:25:23.485Z,1578684323.485 [CommandLine](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2020-01-10T19:25:23.485Z,1578684323.485 [CommandLine](IMPORTANT): DDM.loadAtStartup=1 bool;

2020-01-10T19:25:23.486Z,1578684323.486 [CommandLine](IMPORTANT): DDM.verbosity=3 count;

2020-01-10T19:25:23.486Z,1578684323.486 [CommandLine](IMPORTANT): DUSBL_Hydroid.detectionThreshold=75 count;

2020-01-10T19:25:23.486Z,1578684323.486 [CommandLine](IMPORTANT): DUSBL_Hydroid.transmitLockout=40 millisecond;

2020-01-10T19:25:23.486Z,1578684323.486 [CommandLine](IMPORTANT): Express linearApproximation DDM.DDMMode 1.000000 count;

2020-01-10T19:25:23.486Z,1578684323.486 [CommandLine](IMPORTANT): Express all DDM.cablePresent;

2020-01-10T19:25:23.486Z,1578684323.486 [CommandLine](IMPORTANT): Express linearApproximation DDM.latchState 1.000000 count;

2020-01-10T19:25:23.486Z,1578684323.486 [CommandLine](IMPORTANT): Express linearApproximation DDM.whiskerState 1.000000 count;

2020-01-10T19:25:23.486Z,1578684323.486 [CommandLine](IMPORTANT): Express linearApproximation DUSBL_Hydroid.acoustic_contact_range 1.000000 meter;

2020-01-10T19:25:23.487Z,1578684323.487 [CommandLine](IMPORTANT): Express linearApproximation DUSBL_Hydroid.xAngle 2.000000 degree;

2020-01-10T19:25:23.487Z,1578684323.487 [CommandLine](IMPORTANT): Express linearApproximation RDI_Pathfinder.height_above_sea_floor 2.000000 meter;

2020-01-10T19:25:23.487Z,1578684323.487 [CommandLine](IMPORTANT): Express linearApproximation platform_orientation 5.000000 degree;

2020-01-10T19:25:23.487Z,1578684323.487 [CommandLine](IMPORTANT): Express linearApproximation platform_x_velocity_wrt_ground 0.100000 meter_per_second;

2020-01-10T19:25:23.487Z,1578684323.487 [CommandLine](IMPORTANT): Express linearApproximation platform_y_velocity_wrt_ground 0.100000 meter_per_second;

2020-01-10T19:25:23.487Z,1578684323.487 [CommandLine](IMPORTANT): HorizontalControl.kiHeading=0.002 reciprocal_second;

2020-01-10T19:25:23.487Z,1578684323.487 [CommandLine](IMPORTANT): HorizontalControl.kpHeading=0.8 none;

2020-01-10T19:25:23.487Z,1578684323.487 [CommandLine](IMPORTANT): HorizontalControl.rudDeadband=0.05 degree;

2020-01-10T19:25:23.487Z,1578684323.487 [CommandLine](IMPORTANT): Micromodem.destinationAddress=12 enum;

2020-01-10T19:25:23.488Z,1578684323.488 [CommandLine](IMPORTANT): Micromodem.surfaceThreshold=0 meter;

2020-01-10T19:25:23.488Z,1578684323.488 [CommandLine](IMPORTANT): PowerOnly.sampleTime=90 second;

2020-01-10T19:25:23.488Z,1578684323.488 [CommandLine](IMPORTANT): RudderServo.deviationAngle=0.0001 degree;

2020-01-10T19:25:23.488Z,1578684323.488 [CommandLine](IMPORTANT): VerticalControl.buoyancyNeutral=105 cubic_centimeter;

2020-01-10T19:25:23.488Z,1578684323.488 [CommandLine](IMPORTANT): VerticalControl.massDefault=-5 millimeter;

2020-01-10T19:25:23.489Z,1578684323.489 [CommandLine](IMPORTANT): got command get platform_orientation degree
2020-01-10T19:25:23.489Z,1578684323.489 [CommandLine](IMPORTANT): platform_orientation 72.422552 arcdeg
2020-01-10T19:25:23.489Z,1578684323.489 [CommandLine](IMPORTANT): got command stop
2020-01-10T19:25:23.490Z,1578684323.490 [CommandLine](IMPORTANT): got command failComponent
2020-01-10T19:25:23.490Z,1578684323.490 [CommandLine](IMPORTANT): Failed components:
2020-01-10T19:25:23.490Z,1578684323.490 [CommandLine](IMPORTANT): DropWeight: Hardware Fault
2020-01-10T19:25:23.514Z,1578684323.514 [Micromodem](INFO): Nmea in: $CACST,6,0,20200110192520.256929,06,1807,32,0160,0150,59,02,02,00,04,1,012,001,0,3,2,0,150,27.0,7.00,00,-4.00,-01,-0.02,23,10000,4000*78

2020-01-10T19:27:09.856Z,1578684429.856 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2020-01-10T19:27:31.835Z,1578684451.835 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2
2020-01-10T19:27:31.835Z,1578684451.835 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-01-10T19:27:31.885Z,1578684451.885 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-01-10T19:27:32.258Z,1578684452.258 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-01-10T19:27:32.258Z,1578684452.258 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2
2020-01-10T19:28:51.712Z,1578684531.712 [BPC1](INFO): Calculating totals. Valid battery stick count: 56. Valid reserve battery stick count: 6.
2020-01-10T19:28:51.715Z,1578684531.715 [BPC1](INFO): Received data from all battery sticks.
2020-01-10T19:30:17.782Z,1578684617.782 [Default:CheckIn:Read_GPS](INFO): Timed out from 2020-01-10T19:25:17.7Z
2020-01-10T19:30:17.782Z,1578684617.782 [Default:CheckIn:Read_GPS] Stopped
2020-01-10T19:30:17.782Z,1578684617.782 [Default:CheckIn:Read_Iridium] Running Loop=1
2020-01-10T19:30:18.176Z,1578684618.176 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications
2020-01-10T19:30:18.544Z,1578684618.544 [Micromodem](INFO): Sent 184 bytes from file Logs/20200110T190341/Courier0000.lzma.parts
2020-01-10T19:30:18.544Z,1578684618.544 [Micromodem](INFO): Packets left to send: 1
2020-01-10T19:30:19.572Z,1578684619.572 [Micromodem](INFO): Outgoing frame #1, 64 bytes: D7CA185E000001005D00000400360100000000000000151D80030C5669BF31555EAE1409A708CE2489EC102F971AAFC35C3D87A14EFD88D7E667BF45C1E3A334
2020-01-10T19:30:19.572Z,1578684619.572 [Micromodem](INFO): Outgoing frame #2, 64 bytes: DED6921FBE4C70010BE8D940969E8BF8D69B2A8FDDA0978FF79CDFBCDF55CB16CC5FF348AAEDB41483CC9F1E63FF9BE3CEEC91FFE427CB86D941C7E1D55C2B90
2020-01-10T19:30:19.573Z,1578684619.573 [Micromodem](INFO): Outgoing frame #3, 64 bytes: A05BB7B40AE8607545BAA406D2FFDB045F5C315EFE55C04BDE07DCD2507A541667D2039794562FF2BC5F7BA0015A368B9867F356F6340BAA40789CF82C49CC32
2020-01-10T19:30:19.573Z,1578684619.573 [Micromodem](INFO): Nmea out: $CCCYC,0,1,12,1,0,3*69

2020-01-10T19:30:19.739Z,1578684619.739 [Micromodem](INFO): Nmea in: $CACYC,0,1,12,1,0,3*6B

2020-01-10T19:30:20.091Z,1578684620.091 [Micromodem](INFO): Nmea in: $CADRQ,193020,1,12,0,64,1*7D

2020-01-10T19:30:20.091Z,1578684620.091 [Micromodem](INFO): Nmea out: $CCTXD,1,12,1,D7CA185E000001005D00000400360100000000000000151D80030C5669BF31555EAE1409A708CE2489EC102F971AAFC35C3D87A14EFD88D7E667BF45C1E3A334*35

2020-01-10T19:30:20.503Z,1578684620.503 [Micromodem](INFO): Nmea in: $CATXD,1,12,1,64*4B

2020-01-10T19:30:20.895Z,1578684620.895 [Micromodem](INFO): Nmea in: $CADRQ,193021,1,12,0,64,2*7F

2020-01-10T19:30:20.895Z,1578684620.895 [Micromodem](INFO): Nmea out: $CCTXD,1,12,1,DED6921FBE4C70010BE8D940969E8BF8D69B2A8FDDA0978FF79CDFBCDF55CB16CC5FF348AAEDB41483CC9F1E63FF9BE3CEEC91FFE427CB86D941C7E1D55C2B90*3F

2020-01-10T19:30:21.303Z,1578684621.303 [Micromodem](INFO): Nmea in: $CATXD,1,12,1,64*4B

2020-01-10T19:30:21.703Z,1578684621.703 [Micromodem](INFO): Nmea in: $CADRQ,193021,1,12,0,64,3*7E

2020-01-10T19:30:21.703Z,1578684621.703 [Micromodem](INFO): Nmea out: $CCTXD,1,12,1,A05BB7B40AE8607545BAA406D2FFDB045F5C315EFE55C04BDE07DCD2507A541667D2039794562FF2BC5F7BA0015A368B9867F356F6340BAA40789CF82C49CC32*39

2020-01-10T19:30:22.108Z,1578684622.108 [Micromodem](INFO): Nmea in: $CATXD,1,12,1,64*4B

2020-01-10T19:30:22.523Z,1578684622.523 [Micromodem](INFO): Nmea in: $CATXP,192*48

2020-01-10T19:30:25.317Z,1578684625.317 [DataOverHttps](INFO): Sending 256 bytes from file Logs/20200110T190455/Courier0000.lzma
2020-01-10T19:30:26.147Z,1578684626.147 [Micromodem](INFO): Nmea in: $CATXF,192*5E

2020-01-10T19:30:26.552Z,1578684626.552 [Micromodem](INFO): Nmea in: $CAXST,6,20200110,193022.790096,3,0,200,4000,10000,1,1,12,1,3,3,3,192*70

2020-01-10T19:30:27.323Z,1578684627.323 [DataOverHttps](INFO): Moved sent file to Logs/20200110T190455/Courier0000.lzma.bak
2020-01-10T19:30:27.324Z,1578684627.324 [DataOverHttps](INFO): SBD MOMSN=12190568
2020-01-10T19:30:27.763Z,1578684627.763 [Micromodem](INFO): Nmea in: $CAACK,12,1,1,1*79

2020-01-10T19:30:28.167Z,1578684628.167 [Micromodem](INFO): Nmea in: $CAACK,12,1,2,1*7A

2020-01-10T19:30:28.575Z,1578684628.575 [Micromodem](INFO): Nmea in: $CAACK,12,1,3,1*7B

2020-01-10T19:30:28.576Z,1578684628.576 [Micromodem](INFO): Sent 184 bytes from file Logs/20200110T190455/Courier0000.lzma.parts
2020-01-10T19:30:28.576Z,1578684628.576 [Micromodem](INFO): Packets left to send: 1
2020-01-10T19:30:28.992Z,1578684628.992 [Micromodem](INFO): Nmea in: $CACST,6,0,20200110193027.345140,06,645,28,0107,0150,89,02,02,00,03,1,012,001,0,4,1,0,150,25.6,6.00,15,-3.00,-01,-0.04,28,10000,4000*49

2020-01-10T19:30:29.527Z,1578684629.527 [Micromodem](INFO): Outgoing frame #1, 64 bytes: AFCE185E000001005D00000400360100000000000000151D80030C5669BF31555EAE1409A708CE2489EC102F971AAFC35C3D87A14EFD88D7E667BF45C1E3A334
2020-01-10T19:30:29.528Z,1578684629.528 [Micromodem](INFO): Outgoing frame #2, 64 bytes: DED9D0B62ED5F420D3A27DFA47486326EEF6A8CBC3663CA42CC4D709534F8EA16E9B228F7F9E7E5AAABB63C67AF87A2E6E772FDFC642E2AE32B4E39AB099FC70
2020-01-10T19:30:29.528Z,1578684629.528 [Micromodem](INFO): Outgoing frame #3, 64 bytes: BE8D9A4CA9213C40DB1008DCBB920A7901F8CCF7D14FF3EA6D0841CD250276515DF692F6349D13F509FF4260D249E815BAB3B2ADB1B9F05813776E21A0637C7B
2020-01-10T19:30:29.529Z,1578684629.529 [Micromodem](INFO): Nmea out: $CCCYC,0,1,12,1,0,3*69

2020-01-10T19:30:30.463Z,1578684630.463 [Micromodem](INFO): Nmea in: $CACYC,0,1,12,1,0,3*6B

2020-01-10T19:30:30.863Z,1578684630.863 [Micromodem](INFO): Nmea in: $CADRQ,193030,1,12,0,64,1*7C

2020-01-10T19:30:30.863Z,1578684630.863 [Micromodem](INFO): Nmea out: $CCTXD,1,12,1,AFCE185E000001005D00000400360100000000000000151D80030C5669BF31555EAE1409A708CE2489EC102F971AAFC35C3D87A14EFD88D7E667BF45C1E3A334*45

2020-01-10T19:30:31.267Z,1578684631.267 [Micromodem](INFO): Nmea in: $CATXD,1,12,1,64*4B

2020-01-10T19:30:31.671Z,1578684631.671 [Micromodem](INFO): Nmea in: $CADRQ,193031,1,12,0,64,2*7E

2020-01-10T19:30:31.671Z,1578684631.671 [Micromodem](INFO): Nmea out: $CCTXD,1,12,1,DED9D0B62ED5F420D3A27DFA47486326EEF6A8CBC3663CA42CC4D709534F8EA16E9B228F7F9E7E5AAABB63C67AF87A2E6E772FDFC642E2AE32B4E39AB099FC70*4F

2020-01-10T19:30:32.074Z,1578684632.074 [Micromodem](INFO): Nmea in: $CATXD,1,12,1,64*4B

2020-01-10T19:30:32.479Z,1578684632.479 [Micromodem](INFO): Nmea in: $CADRQ,193032,1,12,0,64,3*7C

2020-01-10T19:30:32.479Z,1578684632.479 [Micromodem](INFO): Nmea out: $CCTXD,1,12,1,BE8D9A4CA9213C40DB1008DCBB920A7901F8CCF7D14FF3EA6D0841CD250276515DF692F6349D13F509FF4260D249E815BAB3B2ADB1B9F05813776E21A0637C7B*45

2020-01-10T19:30:32.887Z,1578684632.887 [Micromodem](INFO): Nmea in: $CATXD,1,12,1,64*4B

2020-01-10T19:30:32.956Z,1578684632.956 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3
2020-01-10T19:30:32.956Z,1578684632.956 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-01-10T19:30:32.982Z,1578684632.982 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-01-10T19:30:33.286Z,1578684633.286 [Micromodem](INFO): Nmea in: $CATXP,192*48

2020-01-10T19:30:33.343Z,1578684633.343 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-01-10T19:30:33.343Z,1578684633.343 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3
2020-01-10T19:30:36.923Z,1578684636.923 [Micromodem](INFO): Nmea in: $CATXF,192*5E

2020-01-10T19:30:37.328Z,1578684637.328 [Micromodem](INFO): Nmea in: $CAXST,6,20200110,193033.565689,3,0,200,4000,10000,1,1,12,1,3,3,3,192*70

2020-01-10T19:30:38.140Z,1578684638.140 [Micromodem](INFO): Nmea in: $CAACK,12,1,1,1*79

2020-01-10T19:30:38.539Z,1578684638.539 [Micromodem](INFO): Nmea in: $CAACK,12,1,2,1*7A

2020-01-10T19:30:38.947Z,1578684638.947 [Micromodem](INFO): Nmea in: $CAACK,12,1,3,1*7B

2020-01-10T19:30:38.948Z,1578684638.948 [Micromodem](INFO): Sent 184 bytes from file Logs/20200110T192119/Courier0000.lzma.parts
2020-01-10T19:30:38.948Z,1578684638.948 [Micromodem](INFO): Packets left to send: 1
2020-01-10T19:30:39.354Z,1578684639.354 [Micromodem](INFO): Nmea in: $CACST,6,0,20200110193038.121229,06,191,22,0110,0150,89,02,02,00,03,1,012,001,0,4,1,0,150,14.4,5.00,14,-2.00,-01,-0.04,37,10000,4000*44

2020-01-10T19:30:39.888Z,1578684639.888 [Micromodem](INFO): Outgoing frame #1, 64 bytes: AFCE185E00000000EBA91A48C2FB3F6DC98981D6DBF8BDA05301B8EBF841A5AFEB41CAA8ADC90493BE7F61B6F6F812E9903C21D1D15EE82741624FAC4223839D
2020-01-10T19:30:39.888Z,1578684639.888 [Micromodem](INFO): Outgoing frame #2, 18 bytes: 29FCDB65A8A9B135044696990403758E6474
2020-01-10T19:30:39.889Z,1578684639.889 [Micromodem](INFO): Nmea out: $CCCYC,0,1,12,1,0,2*68

2020-01-10T19:30:40.819Z,1578684640.819 [Micromodem](INFO): Nmea in: $CACYC,0,1,12,1,0,2*6A

2020-01-10T19:30:41.215Z,1578684641.215 [Micromodem](INFO): Nmea in: $CADRQ,193040,1,12,0,64,1*7B

2020-01-10T19:30:41.215Z,1578684641.215 [Micromodem](INFO): Nmea out: $CCTXD,1,12,1,AFCE185E00000000EBA91A48C2FB3F6DC98981D6DBF8BDA05301B8EBF841A5AFEB41CAA8ADC90493BE7F61B6F6F812E9903C21D1D15EE82741624FAC4223839D*31

2020-01-10T19:30:41.619Z,1578684641.619 [Micromodem](INFO): Nmea in: $CATXD,1,12,1,64*4B

2020-01-10T19:30:42.031Z,1578684642.031 [Micromodem](INFO): Nmea in: $CADRQ,193042,1,12,0,64,2*7A

2020-01-10T19:30:42.031Z,1578684642.031 [Micromodem](INFO): Nmea out: $CCTXD,1,12,1,29FCDB65A8A9B135044696990403758E6474*44

2020-01-10T19:30:42.435Z,1578684642.435 [Micromodem](INFO): Nmea in: $CATXD,1,12,1,18*40

2020-01-10T19:30:42.834Z,1578684642.834 [Micromodem](INFO): Nmea in: $CATXP,82*78

2020-01-10T19:30:45.258Z,1578684645.258 [Micromodem](INFO): Nmea in: $CATXF,82*6E

2020-01-10T19:30:45.267Z,1578684645.267 [DataOverHttps](INFO): Sending 258 bytes from file Logs/20200110T192119/Courier0000.lzma
2020-01-10T19:30:45.660Z,1578684645.660 [Micromodem](INFO): Nmea in: $CAXST,6,20200110,193043.057825,3,0,200,4000,10000,1,1,12,1,2,2,3,82*4B

2020-01-10T19:30:46.467Z,1578684646.467 [Micromodem](INFO): Nmea in: $CAACK,12,1,1,1*79

2020-01-10T19:30:46.875Z,1578684646.875 [Micromodem](INFO): Nmea in: $CAACK,12,1,2,1*7A

2020-01-10T19:30:46.875Z,1578684646.875 [Micromodem](INFO): Sent 74 bytes from file Logs/20200110T192119/Courier0000.lzma.parts
2020-01-10T19:30:46.875Z,1578684646.875 [Micromodem](INFO): Packets left to send: 0
2020-01-10T19:30:47.310Z,1578684647.310 [Micromodem](INFO): Nmea in: $CACST,6,0,20200110193046.291687,06,492,26,0095,0150,59,02,02,00,02,1,012,001,0,4,1,0,150,27.4,6.00,17,-3.00,-01,-0.08,23,10000,4000*4F

2020-01-10T19:30:48.276Z,1578684648.276 [DataOverHttps](FAULT): Server acknowledged file Logs/20200110T192119/Courier0000.lzma, notLogs/20200110T192119/Courier0004.lzma
2020-01-10T19:30:48.276Z,1578684648.276 [DataOverHttps](INFO): SBD MOMSN=12190575
2020-01-10T19:30:48.362Z,1578684648.362 [Micromodem](INFO): Outgoing frame #1, 64 bytes: AFCE185E040001005D00000400540100000000000000151D80030C5669BF3148E2FA22188B6A3173E5573572661C0BCBDFFAB423BD32D9A51E8904B0A920CE9A
2020-01-10T19:30:48.363Z,1578684648.363 [Micromodem](INFO): Outgoing frame #2, 64 bytes: EF9F66414C9B9FD6761AD008C3E3DC4FCA2E4E25B6359B14B772C42BBF445E54CD5F36943A3BDD9E89309E9017DB79DD009A333A47CF42F3BE4E4AD4301D597F
2020-01-10T19:30:48.363Z,1578684648.363 [Micromodem](INFO): Outgoing frame #3, 64 bytes: FFA3EC7FA24353C087A3A1B3BD161F92F69707865251F3B93C9772C25CD67B52231335EF84B8E92D5FFA309E6B04FFDD8912C3CD130320C3740AB72F1A5DC1B7
2020-01-10T19:30:48.364Z,1578684648.364 [Micromodem](INFO): Nmea out: $CCCYC,0,1,12,1,0,3*69

2020-01-10T19:30:49.283Z,1578684649.283 [Micromodem](INFO): Nmea in: $CACYC,0,1,12,1,0,3*6B

2020-01-10T19:30:49.687Z,1578684649.687 [Micromodem](INFO): Nmea in: $CADRQ,193049,1,12,0,64,1*72

2020-01-10T19:30:49.687Z,1578684649.687 [Micromodem](INFO): Nmea out: $CCTXD,1,12,1,AFCE185E040001005D00000400540100000000000000151D80030C5669BF3148E2FA22188B6A3173E5573572661C0BCBDFFAB423BD32D9A51E8904B0A920CE9A*35

2020-01-10T19:30:50.087Z,1578684650.087 [Micromodem](INFO): Nmea in: $CATXD,1,12,1,64*4B

2020-01-10T19:30:50.503Z,1578684650.503 [Micromodem](INFO): Nmea in: $CADRQ,193050,1,12,0,64,2*79

2020-01-10T19:30:50.503Z,1578684650.503 [Micromodem](INFO): Nmea out: $CCTXD,1,12,1,EF9F66414C9B9FD6761AD008C3E3DC4FCA2E4E25B6359B14B772C42BBF445E54CD5F36943A3BDD9E89309E9017DB79DD009A333A47CF42F3BE4E4AD4301D597F*3D

2020-01-10T19:30:50.895Z,1578684650.895 [Micromodem](INFO): Nmea in: $CATXD,1,12,1,64*4B

2020-01-10T19:30:51.296Z,1578684651.296 [Micromodem](INFO): Nmea in: $CADRQ,193051,1,12,0,64,3*79

2020-01-10T19:30:51.296Z,1578684651.296 [Micromodem](INFO): Nmea out: $CCTXD,1,12,1,FFA3EC7FA24353C087A3A1B3BD161F92F69707865251F3B93C9772C25CD67B52231335EF84B8E92D5FFA309E6B04FFDD8912C3CD130320C3740AB72F1A5DC1B7*3A

2020-01-10T19:30:51.719Z,1578684651.719 [Micromodem](INFO): Nmea in: $CATXD,1,12,1,64*4B

2020-01-10T19:30:52.108Z,1578684652.108 [Micromodem](INFO): Nmea in: $CATXP,192*48

2020-01-10T19:30:55.749Z,1578684655.749 [Micromodem](INFO): Nmea in: $CATXF,192*5E

2020-01-10T19:30:56.152Z,1578684656.152 [Micromodem](INFO): Nmea in: $CAXST,6,20200110,193052.381933,3,0,200,4000,10000,1,1,12,1,3,3,3,192*75

2020-01-10T19:30:56.981Z,1578684656.981 [Micromodem](INFO): Nmea in: $CAACK,12,1,1,1*79

2020-01-10T19:30:57.359Z,1578684657.359 [Micromodem](INFO): Nmea in: $CAACK,12,1,2,1*7A

2020-01-10T19:30:57.763Z,1578684657.763 [Micromodem](INFO): Nmea in: $CAACK,12,1,3,1*7B

2020-01-10T19:30:57.764Z,1578684657.764 [Micromodem](INFO): Sent 184 bytes from file Logs/20200110T192119/Courier0004.lzma.parts
2020-01-10T19:30:57.765Z,1578684657.765 [Micromodem](INFO): Packets left to send: 1
2020-01-10T19:30:58.182Z,1578684658.182 [Micromodem](INFO): Nmea in: $CACST,6,0,20200110193056.937260,06,172,22,0097,0150,59,02,02,00,02,1,012,001,0,4,1,0,150,24.2,6.00,13,-3.00,-01,-0.04,24,10000,4000*43

2020-01-10T19:30:58.745Z,1578684658.745 [Micromodem](INFO): Using rate 1 for 13 bytes.
2020-01-10T19:30:58.745Z,1578684658.745 [Micromodem](INFO): Outgoing frame #1, 13 bytes: AFCE185E04000000DB56793E00
2020-01-10T19:30:58.746Z,1578684658.746 [Micromodem](INFO): Nmea out: $CCCYC,0,1,12,1,0,1*6B

2020-01-10T19:30:59.639Z,1578684659.639 [Micromodem](INFO): Nmea in: $CACYC,0,1,12,1,0,1*69

2020-01-10T19:31:00.049Z,1578684660.049 [Micromodem](INFO): Nmea in: $CADRQ,193059,1,12,0,64,1*73

2020-01-10T19:31:00.050Z,1578684660.050 [Micromodem](ERROR): Received CADRQ with bad size: 64 expected <= 32
2020-01-10T19:31:01.060Z,1578684661.060 [Micromodem](INFO): Using rate 0 for 13 bytes.
2020-01-10T19:31:01.061Z,1578684661.061 [Micromodem](INFO): Outgoing frame #1, 13 bytes: AFCE185E04000000DB56793E00
2020-01-10T19:31:01.061Z,1578684661.061 [Micromodem](INFO): Nmea out: $CCCYC,0,1,12,1,0,1*6B

2020-01-10T19:31:01.280Z,1578684661.280 [Micromodem](INFO): Nmea in: $CACYC,0,1,12,1,0,1*69

2020-01-10T19:31:01.655Z,1578684661.655 [Micromodem](INFO): Nmea in: $CADRQ,193102,1,12,0,64,1*7C

2020-01-10T19:31:01.655Z,1578684661.655 [Micromodem](ERROR): Received CADRQ with bad size: 64 expected <= 32
2020-01-10T19:31:02.757Z,1578684662.757 [Micromodem](INFO): Using rate 0 for 13 bytes.
2020-01-10T19:31:02.758Z,1578684662.758 [Micromodem](INFO): Outgoing frame #1, 13 bytes: AFCE185E04000000DB56793E00
2020-01-10T19:31:02.758Z,1578684662.758 [Micromodem](INFO): Nmea out: $CCCYC,0,1,12,1,0,1*6B

2020-01-10T19:31:02.991Z,1578684662.991 [Micromodem](INFO): Nmea in: $CACYC,0,1,12,1,0,1*69

2020-01-10T19:31:03.355Z,1578684663.355 [Micromodem](INFO): Nmea in: $CADRQ,193103,1,12,0,64,1*7D

2020-01-10T19:31:03.355Z,1578684663.355 [Micromodem](ERROR): Received CADRQ with bad size: 64 expected <= 32
2020-01-10T19:31:04.533Z,1578684664.533 [Micromodem](INFO): Using rate 0 for 13 bytes.
2020-01-10T19:31:04.534Z,1578684664.534 [Micromodem](INFO): Outgoing frame #1, 13 bytes: AFCE185E04000000DB56793E00
2020-01-10T19:31:04.534Z,1578684664.534 [Micromodem](INFO): Nmea out: $CCCYC,0,1,12,1,0,1*6B

2020-01-10T19:31:04.755Z,1578684664.755 [Micromodem](INFO): Nmea in: $CACYC,0,1,12,1,0,1*69

2020-01-10T19:31:05.127Z,1578684665.127 [Micromodem](INFO): Nmea in: $CADRQ,193105,1,12,0,64,1*7B

2020-01-10T19:31:05.127Z,1578684665.127 [Micromodem](ERROR): Received CADRQ with bad size: 64 expected <= 32
2020-01-10T19:31:05.889Z,1578684665.889 [Micromodem](INFO): Using rate 0 for 13 bytes.
2020-01-10T19:31:05.890Z,1578684665.890 [Micromodem](INFO): Outgoing frame #1, 13 bytes: AFCE185E04000000DB56793E00
2020-01-10T19:31:05.890Z,1578684665.890 [Micromodem](INFO): Nmea out: $CCCYC,0,1,12,1,0,1*6B

2020-01-10T19:31:06.063Z,1578684666.063 [Micromodem](INFO): Nmea in: $CACYC,0,1,12,1,0,1*69

2020-01-10T19:31:06.407Z,1578684666.407 [Micromodem](INFO): Nmea in: $CADRQ,193106,1,12,0,64,1*78

2020-01-10T19:31:06.407Z,1578684666.407 [Micromodem](ERROR): Received CADRQ with bad size: 64 expected <= 32
2020-01-10T19:31:06.517Z,1578684666.517 [DataOverHttps](INFO): Sending 189 bytes from file Logs/20200110T192119/Courier0004.lzma
2020-01-10T19:31:06.994Z,1578684666.994 [Micromodem](INFO): Using rate 0 for 13 bytes.
2020-01-10T19:31:06.994Z,1578684666.994 [Micromodem](INFO): Outgoing frame #1, 13 bytes: AFCE185E04000000DB56793E00
2020-01-10T19:31:06.995Z,1578684666.995 [Micromodem](INFO): Nmea out: $CCCYC,0,1,12,1,0,1*6B

2020-01-10T19:31:07.151Z,1578684667.151 [Micromodem](INFO): Nmea in: $CACYC,0,1,12,1,0,1*69

2020-01-10T19:31:07.511Z,1578684667.511 [Micromodem](INFO): Nmea in: $CADRQ,193107,1,12,0,64,1*79

2020-01-10T19:31:07.511Z,1578684667.511 [Micromodem](ERROR): Received CADRQ with bad size: 64 expected <= 32
2020-01-10T19:31:08.086Z,1578684668.086 [Micromodem](INFO): Using rate 0 for 13 bytes.
2020-01-10T19:31:08.087Z,1578684668.087 [Micromodem](INFO): Outgoing frame #1, 13 bytes: AFCE185E04000000DB56793E00
2020-01-10T19:31:08.087Z,1578684668.087 [Micromodem](INFO): Nmea out: $CCCYC,0,1,12,1,0,1*6B

2020-01-10T19:31:08.259Z,1578684668.259 [Micromodem](INFO): Nmea in: $CACYC,0,1,12,1,0,1*69

2020-01-10T19:31:08.522Z,1578684668.522 [DataOverHttps](INFO): Moved sent file to Logs/20200110T192119/Courier0004.lzma.bak
2020-01-10T19:31:08.523Z,1578684668.523 [DataOverHttps](INFO): SBD MOMSN=12190582
2020-01-10T19:31:08.616Z,1578684668.616 [Micromodem](INFO): Nmea in: $CADRQ,193109,1,12,0,64,1*77

2020-01-10T19:31:08.616Z,1578684668.616 [Micromodem](ERROR): Received CADRQ with bad size: 64 expected <= 32
2020-01-10T19:31:09.259Z,1578684669.259 [Default:CheckIn:Read_Iridium] Stopped
2020-01-10T19:31:09.259Z,1578684669.259 [Default:CheckIn:C.Wait] Running Loop=1
2020-01-10T19:31:09.259Z,1578684669.259 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2020-01-10T19:31:12.166Z,1578684672.166 [RDI_Pathfinder](ERROR): Failed to parse:
:B,-32768,-32768,V
2020-01-10T19:31:38.367Z,1578684698.367 [Micromodem](INFO): Nmea in: $CAERR,193139,DATA_TIMEOUT,1*4E

2020-01-10T19:31:58.185Z,1578684718.185 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error
2020-01-10T19:31:58.185Z,1578684718.185 [RDI_Pathfinder](ERROR): Failed to parse:
:TS,20011012444909,35.0, -0.1,   0.0,10
2020-01-10T19:32:09.075Z,1578684729.075 [NAL9602](FAULT): GPS failed to acquire within timeout.
2020-01-10T19:32:09.075Z,1578684729.075 [NAL9602] Data Fault, FailCount= 1
2020-01-10T19:32:09.075Z,1578684729.075 [NAL9602](ERROR): Data Fault
2020-01-10T19:32:09.136Z,1578684729.136 [CBIT](ERROR): Data Fault in component: NAL9602
2020-01-10T19:32:09.479Z,1578684729.479 [NAL9602](INFO): Powering down
2020-01-10T19:32:10.331Z,1578684730.331 [CBIT](INFO): Clearing failed state for component NAL9602
2020-01-10T19:32:10.331Z,1578684730.331 [NAL9602] No Fault, FailCount= 1
2020-01-10T19:32:39.785Z,1578684759.785 [NAL9602](INFO): Powering up NAL9602
2020-01-10T19:32:50.687Z,1578684770.687 [NAL9602](INFO): NAL9602 initialized
2020-01-10T19:32:58.998Z,1578684778.998 [CommandLine](IMPORTANT): got command restart application
2020-01-10T19:33:00.002Z,1578684780.002 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2020-01-10T19:33:00.003Z,1578684780.003 [CommandLine ThreadHandler](INFO): Thread cancelled.
2020-01-10T19:33:00.025Z,1578684780.025 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup.  Bye!
2020-01-10T19:33:00.026Z,1578684780.026 [CommandLine ThreadHandler](INFO): Thread cancelled.
2020-01-10T19:33:00.026Z,1578684780.026 [CommandLine](INFO): Join timeout helper Thread ID is 9169
2020-01-10T19:33:00.027Z,1578684780.027 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2020-01-10T19:33:00.027Z,1578684780.027 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2020-01-10T19:33:00.028Z,1578684780.028 [NavChartDb](INFO): Join timeout helper Thread ID is 9170
2020-01-10T19:33:00.297Z,1578684780.297 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2020-01-10T19:33:00.297Z,1578684780.297 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2020-01-10T19:33:00.305Z,1578684780.305 [ComponentRegistry](INFO): Shutting down WetLabsSeaOWL_UV_A ThreadHandler
2020-01-10T19:33:00.305Z,1578684780.305 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Thread cancelled.
2020-01-10T19:33:00.305Z,1578684780.305 [WetLabsSeaOWL_UV_A](INFO): Join timeout helper Thread ID is 9171
2020-01-10T19:33:00.705Z,1578684780.705 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Uninitializing protected caller thread.
2020-01-10T19:33:00.705Z,1578684780.705 [WetLabsSeaOWL_UV_A](INFO): Powering down
2020-01-10T19:33:00.706Z,1578684780.706 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Thread cancelled.
2020-01-10T19:33:00.713Z,1578684780.713 [ComponentRegistry](INFO): Shutting down CTD_NeilBrown ThreadHandler
2020-01-10T19:33:00.713Z,1578684780.713 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled.
2020-01-10T19:33:00.713Z,1578684780.713 [CTD_NeilBrown](INFO): Join timeout helper Thread ID is 9172
2020-01-10T19:33:00.829Z,1578684780.829 [CTD_NeilBrown ThreadHandler](INFO): Uninitializing protected caller thread.
2020-01-10T19:33:00.829Z,1578684780.829 [CTD_NeilBrown](INFO): Powering down
2020-01-10T19:33:00.841Z,1578684780.841 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled.
2020-01-10T19:33:00.853Z,1578684780.853 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2020-01-10T19:33:00.853Z,1578684780.853 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2020-01-10T19:33:00.853Z,1578684780.853 [Radio_Surface](INFO): Join timeout helper Thread ID is 9173
2020-01-10T19:33:00.977Z,1578684780.977 [Radio_Surface](INFO): Powering down
2020-01-10T19:33:00.978Z,1578684780.978 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2020-01-10T19:33:00.978Z,1578684780.978 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2020-01-10T19:33:00.982Z,1578684780.982 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler
2020-01-10T19:33:00.982Z,1578684780.982 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2020-01-10T19:33:00.982Z,1578684780.982 [DataOverHttps](INFO): Join timeout helper Thread ID is 9174
2020-01-10T19:33:02.152Z,1578684782.152 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread.
2020-01-10T19:33:02.160Z,1578684782.160 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2020-01-10T19:33:02.178Z,1578684782.178 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2020-01-10T19:33:02.178Z,1578684782.178 [logger ThreadHandler](INFO): Thread cancelled.
2020-01-10T19:33:02.178Z,1578684782.178 [logger](INFO): Join timeout helper Thread ID is 9175
2020-01-10T19:33:02.197Z,1578684782.197 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2020-01-10T19:33:02.197Z,1578684782.197 [logger ThreadHandler](INFO): Thread cancelled.
2020-01-10T19:33:02.217Z,1578684782.217 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2020-01-10T19:33:02.218Z,1578684782.218 [CommandLine ThreadHandler](INFO): Thread cancelled.
2020-01-10T19:33:02.218Z,1578684782.218 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2020-01-10T19:33:02.218Z,1578684782.218 [controlThread ThreadHandler](INFO): Thread cancelled.
2020-01-10T19:33:02.218Z,1578684782.218 [controlThread](INFO): Join timeout helper Thread ID is 9176
2020-01-10T19:33:02.385Z,1578684782.385 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2020-01-10T19:33:02.385Z,1578684782.385 [controlThread](DEBUG): Uninitializing ControlThread
2020-01-10T19:33:02.386Z,1578684782.386 [AHRS_M2](INFO): Powering down
2020-01-10T19:33:02.457Z,1578684782.457 [DDM](INFO): Powering down
2020-01-10T19:33:02.549Z,1578684782.549 [DUSBL_Hydroid](INFO): Powering down
2020-01-10T19:33:02.641Z,1578684782.641 [Micromodem](INFO): Powering down
2020-01-10T19:33:02.737Z,1578684782.737 [NAL9602](INFO): Powering down
2020-01-10T19:33:02.809Z,1578684782.809 [RDI_Pathfinder](INFO): Powering down
2020-01-10T19:33:02.810Z,1578684782.810 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2020-01-10T19:33:02.811Z,1578684782.811 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2020-01-10T19:33:02.812Z,1578684782.812 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2020-01-10T19:33:02.812Z,1578684782.812 [MissionManager](INFO): Uninitializing Mission Default
2020-01-10T19:33:02.812Z,1578684782.812 [Default] Stopped
2020-01-10T19:33:02.812Z,1578684782.812 [Default](DEBUG): Aggregate::uninitialize Default
2020-01-10T19:33:02.812Z,1578684782.812 [Default:B.GoToSurface] Stopped
2020-01-10T19:33:02.813Z,1578684782.813 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2020-01-10T19:33:02.813Z,1578684782.813 [Default:CheckIn] Stopped
2020-01-10T19:33:02.813Z,1578684782.813 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2020-01-10T19:33:02.813Z,1578684782.813 [Default:CheckIn:C.Wait] Stopped
2020-01-10T19:33:02.813Z,1578684782.813 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2020-01-10T19:33:02.815Z,1578684782.815 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2020-01-10T19:33:02.816Z,1578684782.816 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2020-01-10T19:33:02.816Z,1578684782.816 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2020-01-10T19:33:02.816Z,1578684782.816 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2020-01-10T19:33:02.817Z,1578684782.817 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2020-01-10T19:33:02.817Z,1578684782.817 [BuoyancyServo](INFO): Powering down
2020-01-10T19:33:02.829Z,1578684782.829 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2020-01-10T19:33:02.829Z,1578684782.829 [ElevatorServo](INFO): Powering down
2020-01-10T19:33:02.830Z,1578684782.830 [MassServo](DEBUG): Uninitialize Mass Servo.
2020-01-10T19:33:02.830Z,1578684782.830 [MassServo](INFO): Powering down
2020-01-10T19:33:02.831Z,1578684782.831 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2020-01-10T19:33:02.831Z,1578684782.831 [RudderServo](INFO): Powering down
2020-01-10T19:33:02.831Z,1578684782.831 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2020-01-10T19:33:02.831Z,1578684782.831 [ThrusterServo](INFO): Powering down
2020-01-10T19:33:02.832Z,1578684782.832 [SBIT](DEBUG): Uninitialize SBIT Component.
2020-01-10T19:33:02.833Z,1578684782.833 [IBIT](DEBUG): Uninitialize IBIT Component.
2020-01-10T19:33:02.833Z,1578684782.833 [CBIT](DEBUG): Uninitialize CBIT Component.
2020-01-10T19:33:02.833Z,1578684782.833 [CBIT](DEBUG): Powering off loads.
2020-01-10T19:33:02.845Z,1578684782.845 [CBIT](DEBUG): Disabling WDT.
2020-01-10T19:33:02.857Z,1578684782.857 [CBIT](DEBUG): Opening all GF detection circuits.
2020-01-10T19:33:02.858Z,1578684782.858 [controlThread ThreadHandler](INFO): Thread cancelled.
2020-01-10T19:33:02.917Z,1578684782.917 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2020-01-10T19:33:02.927Z,1578684782.927 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2020-01-10T19:33:02.974Z,1578684782.974 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Thread cancelled.
2020-01-10T19:33:02.977Z,1578684782.977 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled.
2020-01-10T19:33:03.036Z,1578684783.036 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2020-01-10T19:33:03.096Z,1578684783.096 [logger ThreadHandler](INFO): Thread cancelled.