2020-01-10T18:15:18.736Z,1578680118.736 [Supervisor](DEBUG): Initializing supervisor.
2020-01-10T18:15:18.740Z,1578680118.740 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2020-01-10T18:15:18.740Z,1578680118.740 [SyncHandler](INFO): Protected caller Thread ID is 4655
2020-01-10T18:15:18.741Z,1578680118.741 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2020-01-10T18:15:18.742Z,1578680118.742 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2020-01-10T18:15:18.742Z,1578680118.742 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 4656
2020-01-10T18:15:18.745Z,1578680118.745 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2020-01-10T18:15:18.757Z,1578680118.757 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2020-01-10T18:15:18.758Z,1578680118.758 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2020-01-10T18:15:18.758Z,1578680118.758 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 4657
2020-01-10T18:15:18.759Z,1578680118.759 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2020-01-10T18:15:18.760Z,1578680118.760 [logger ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2020-01-10T18:15:18.760Z,1578680118.760 [logger ThreadHandler](INFO): Protected caller Thread ID is 4658
2020-01-10T18:15:18.762Z,1578680118.762 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2020-01-10T18:15:18.763Z,1578680118.763 [Supervisor](INFO): Looking for Config files in directory: Config/
2020-01-10T18:15:18.764Z,1578680118.764 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2020-01-10T18:15:19.181Z,1578680119.181 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2020-01-10T18:15:19.182Z,1578680119.182 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2020-01-10T18:15:19.276Z,1578680119.276 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample
2020-01-10T18:15:19.276Z,1578680119.276 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2020-01-10T18:15:19.596Z,1578680119.596 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2020-01-10T18:15:19.596Z,1578680119.596 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2020-01-10T18:15:19.779Z,1578680119.779 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2020-01-10T18:15:19.780Z,1578680119.780 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2020-01-10T18:15:19.962Z,1578680119.962 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2020-01-10T18:15:19.963Z,1578680119.963 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2020-01-10T18:15:20.397Z,1578680120.397 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2020-01-10T18:15:20.398Z,1578680120.398 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2020-01-10T18:15:20.599Z,1578680120.599 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2020-01-10T18:15:20.599Z,1578680120.599 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2020-01-10T18:15:20.738Z,1578680120.738 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2020-01-10T18:15:20.739Z,1578680120.739 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2020-01-10T18:15:20.924Z,1578680120.924 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2020-01-10T18:15:20.924Z,1578680120.924 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2020-01-10T18:15:21.017Z,1578680121.017 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2020-01-10T18:15:21.018Z,1578680121.018 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2020-01-10T18:15:21.308Z,1578680121.308 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2020-01-10T18:15:21.308Z,1578680121.308 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2020-01-10T18:15:21.387Z,1578680121.387 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2020-01-10T18:15:21.487Z,1578680121.487 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2020-01-10T18:15:21.487Z,1578680121.487 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2020-01-10T18:15:22.108Z,1578680122.108 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2020-01-10T18:15:22.109Z,1578680122.109 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2020-01-10T18:15:22.508Z,1578680122.508 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2020-01-10T18:15:22.510Z,1578680122.510 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-whoidhs/
2020-01-10T18:15:22.511Z,1578680122.511 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/vehicle.cfg
2020-01-10T18:15:22.708Z,1578680122.708 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Control.cfg
2020-01-10T18:15:22.803Z,1578680122.803 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/BIT.cfg
2020-01-10T18:15:22.898Z,1578680122.898 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Battery.cfg
2020-01-10T18:15:23.123Z,1578680123.123 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2020-01-10T18:15:23.124Z,1578680123.124 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Simulator.cfg
2020-01-10T18:15:23.206Z,1578680123.206 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Navigation.cfg
2020-01-10T18:15:23.296Z,1578680123.296 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/logger.cfg
2020-01-10T18:15:23.389Z,1578680123.389 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/secure.cfg
2020-01-10T18:15:23.469Z,1578680123.469 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Servo.cfg
2020-01-10T18:15:23.573Z,1578680123.573 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Sensor.cfg
2020-01-10T18:15:23.747Z,1578680123.747 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Science.cfg
2020-01-10T18:15:23.873Z,1578680123.873 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-whoidhs/root/
2020-01-10T18:15:23.873Z,1578680123.873 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg
2020-01-10T18:15:23.894Z,1578680123.894 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2020-01-10T18:15:24.200Z,1578680124.200 [AHRS_M2](DEBUG): LcmSlateWriter::add(): platform_orientation
2020-01-10T18:15:24.205Z,1578680124.205 [AHRS_M2](INFO): created writer for : platform_orientation
2020-01-10T18:15:24.207Z,1578680124.207 [AHRS_M2](DEBUG): LcmSlateWriter::add(): platform_magnetic_orientation
2020-01-10T18:15:24.212Z,1578680124.212 [AHRS_M2](INFO): created writer for : platform_magnetic_orientation
2020-01-10T18:15:24.213Z,1578680124.213 [AHRS_M2](DEBUG): LcmSlateWriter::add(): platform_pitch_angle
2020-01-10T18:15:24.218Z,1578680124.218 [AHRS_M2](INFO): created writer for : platform_pitch_angle
2020-01-10T18:15:24.218Z,1578680124.218 [AHRS_M2](DEBUG): LcmSlateWriter::add(): platform_roll_angle
2020-01-10T18:15:24.224Z,1578680124.224 [AHRS_M2](INFO): created writer for : platform_roll_angle
2020-01-10T18:15:24.294Z,1578680124.294 [AHRS_M2] Loaded
2020-01-10T18:15:24.294Z,1578680124.294 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread.
2020-01-10T18:15:24.377Z,1578680124.377 [DataOverHttps] Loaded
2020-01-10T18:15:24.377Z,1578680124.377 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2020-01-10T18:15:24.378Z,1578680124.378 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 407684E0
2020-01-10T18:15:24.379Z,1578680124.379 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 4737
2020-01-10T18:15:24.403Z,1578680124.403 [DDM] Loaded
2020-01-10T18:15:24.403Z,1578680124.403 [ComponentRegistry](DEBUG): SyncComponent "DDM" handled in the control thread.
2020-01-10T18:15:24.416Z,1578680124.416 [Depth_Keller] Loaded
2020-01-10T18:15:24.416Z,1578680124.416 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2020-01-10T18:15:24.421Z,1578680124.421 [DropWeight] Loaded
2020-01-10T18:15:24.421Z,1578680124.421 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2020-01-10T18:15:24.482Z,1578680124.482 [DUSBL_Hydroid] Loaded
2020-01-10T18:15:24.482Z,1578680124.482 [ComponentRegistry](DEBUG): SyncComponent "DUSBL_Hydroid" handled in the control thread.
2020-01-10T18:15:24.528Z,1578680124.528 [Micromodem] Loaded
2020-01-10T18:15:24.528Z,1578680124.528 [ComponentRegistry](DEBUG): SyncComponent "Micromodem" handled in the control thread.
2020-01-10T18:15:24.624Z,1578680124.624 [NAL9602] Loaded
2020-01-10T18:15:24.625Z,1578680124.625 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2020-01-10T18:15:24.662Z,1578680124.662 [Onboard](ERROR): Can't open SysFS node file: /sys/class/power_supply/ds2782-0/voltage_now
2020-01-10T18:15:24.662Z,1578680124.662 [Onboard](ERROR): Can't open SysFS node file: /sys/class/power_supply/ds2782-0/current_now
2020-01-10T18:15:24.663Z,1578680124.663 [Onboard](ERROR): Can't open SysFS node file: /sys/class/power_supply/ds2782-0/charge_now
2020-01-10T18:15:24.663Z,1578680124.663 [Onboard](ERROR): Can't open SysFS node file: /sys/class/power_supply/ds2782-0/charge_full
2020-01-10T18:15:24.664Z,1578680124.664 [Onboard](ERROR): Can't open SysFS node file: /sys/class/power_supply/ds2782-1/voltage_now
2020-01-10T18:15:24.664Z,1578680124.664 [Onboard](ERROR): Can't open SysFS node file: /sys/class/power_supply/ds2782-1/current_now
2020-01-10T18:15:24.665Z,1578680124.665 [Onboard](ERROR): Can't open SysFS node file: /sys/class/power_supply/ds2782-1/charge_now
2020-01-10T18:15:24.665Z,1578680124.665 [Onboard](ERROR): Can't open SysFS node file: /sys/class/power_supply/ds2782-1/charge_full
2020-01-10T18:15:24.666Z,1578680124.666 [Onboard] Loaded
2020-01-10T18:15:24.666Z,1578680124.666 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread.
2020-01-10T18:15:24.672Z,1578680124.672 [PowerOnly] Loaded
2020-01-10T18:15:24.672Z,1578680124.672 [ComponentRegistry](DEBUG): SyncComponent "PowerOnly" handled in the control thread.
2020-01-10T18:15:24.678Z,1578680124.678 [Radio_Surface] Loaded
2020-01-10T18:15:24.679Z,1578680124.679 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2020-01-10T18:15:24.679Z,1578680124.679 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 407984E0
2020-01-10T18:15:24.680Z,1578680124.680 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 4738
2020-01-10T18:15:24.723Z,1578680124.723 [RDI_Pathfinder] Loaded
2020-01-10T18:15:24.723Z,1578680124.723 [ComponentRegistry](DEBUG): SyncComponent "RDI_Pathfinder" handled in the control thread.
2020-01-10T18:15:26.627Z,1578680126.627 [BPC1] Loaded
2020-01-10T18:15:26.627Z,1578680126.627 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2020-01-10T18:15:26.627Z,1578680126.627 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2020-01-10T18:15:26.628Z,1578680126.628 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2020-01-10T18:15:26.641Z,1578680126.641 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2020-01-10T18:15:26.642Z,1578680126.642 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2020-01-10T18:15:26.745Z,1578680126.745 [DeadReckonUsingMultipleVelocitySources] Loaded
2020-01-10T18:15:26.745Z,1578680126.745 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2020-01-10T18:15:26.765Z,1578680126.765 [NavChart] Loaded
2020-01-10T18:15:26.766Z,1578680126.766 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2020-01-10T18:15:26.770Z,1578680126.770 [UniversalFixResidualReporter] Loaded
2020-01-10T18:15:26.770Z,1578680126.770 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2020-01-10T18:15:26.770Z,1578680126.770 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2020-01-10T18:15:26.771Z,1578680126.771 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2020-01-10T18:15:26.877Z,1578680126.877 [BuoyancyServo] Loaded
2020-01-10T18:15:26.877Z,1578680126.877 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2020-01-10T18:15:26.892Z,1578680126.892 [ElevatorServo] Loaded
2020-01-10T18:15:26.892Z,1578680126.892 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2020-01-10T18:15:26.907Z,1578680126.907 [MassServo] Loaded
2020-01-10T18:15:26.907Z,1578680126.907 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2020-01-10T18:15:26.922Z,1578680126.922 [RudderServo] Loaded
2020-01-10T18:15:26.923Z,1578680126.923 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2020-01-10T18:15:26.937Z,1578680126.937 [ThrusterServo] Loaded
2020-01-10T18:15:26.937Z,1578680126.937 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread.
2020-01-10T18:15:26.938Z,1578680126.938 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2020-01-10T18:15:26.938Z,1578680126.938 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2020-01-10T18:15:27.194Z,1578680127.194 [CTD_NeilBrown] Loaded
2020-01-10T18:15:27.194Z,1578680127.194 [ComponentRegistry](DEBUG): Component "CTD_NeilBrown" handled in its own thread.
2020-01-10T18:15:27.195Z,1578680127.195 [CTD_NeilBrown ThreadHandler](DEBUG): Created PCaller Thread at 408EC4E0
2020-01-10T18:15:27.196Z,1578680127.196 [CTD_NeilBrown ThreadHandler](INFO): Protected caller Thread ID is 4739
2020-01-10T18:15:27.210Z,1578680127.210 [PAR_Licor] Loaded
2020-01-10T18:15:27.210Z,1578680127.210 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2020-01-10T18:15:27.253Z,1578680127.253 [WetLabsSeaOWL_UV_A] Loaded
2020-01-10T18:15:27.254Z,1578680127.254 [ComponentRegistry](DEBUG): Component "WetLabsSeaOWL_UV_A" handled in its own thread.
2020-01-10T18:15:27.255Z,1578680127.255 [WetLabsSeaOWL_UV_A ThreadHandler](DEBUG): Created PCaller Thread at 4091C4E0
2020-01-10T18:15:27.255Z,1578680127.255 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Protected caller Thread ID is 4740
2020-01-10T18:15:27.255Z,1578680127.255 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2020-01-10T18:15:27.256Z,1578680127.256 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2020-01-10T18:15:27.563Z,1578680127.563 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2020-01-10T18:15:27.564Z,1578680127.564 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2020-01-10T18:15:27.603Z,1578680127.603 [DepthRateCalculator] Loaded
2020-01-10T18:15:27.604Z,1578680127.604 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2020-01-10T18:15:27.609Z,1578680127.609 [PitchRateCalculator] Loaded
2020-01-10T18:15:27.610Z,1578680127.610 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2020-01-10T18:15:27.622Z,1578680127.622 [SpeedCalculator] Loaded
2020-01-10T18:15:27.622Z,1578680127.622 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2020-01-10T18:15:27.642Z,1578680127.642 [TempGradientCalculator] Loaded
2020-01-10T18:15:27.643Z,1578680127.643 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread.
2020-01-10T18:15:27.648Z,1578680127.648 [YawRateCalculator] Loaded
2020-01-10T18:15:27.649Z,1578680127.649 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2020-01-10T18:15:27.688Z,1578680127.688 [ElevatorOffsetCalculator] Loaded
2020-01-10T18:15:27.688Z,1578680127.688 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2020-01-10T18:15:27.689Z,1578680127.689 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2020-01-10T18:15:27.689Z,1578680127.689 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2020-01-10T18:15:27.824Z,1578680127.824 [SBIT](DEBUG): Construct Startup Built In Test.
2020-01-10T18:15:27.846Z,1578680127.846 [SBIT] Loaded
2020-01-10T18:15:27.846Z,1578680127.846 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2020-01-10T18:15:27.847Z,1578680127.847 [IBIT](DEBUG): Construct Initiated Built In Test.
2020-01-10T18:15:27.860Z,1578680127.860 [IBIT] Loaded
2020-01-10T18:15:27.860Z,1578680127.860 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2020-01-10T18:15:27.863Z,1578680127.863 [CBIT](DEBUG): Construct Continuous Built In Test.
2020-01-10T18:15:28.001Z,1578680128.001 [CBIT] Loaded
2020-01-10T18:15:28.001Z,1578680128.001 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2020-01-10T18:15:28.002Z,1578680128.002 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2020-01-10T18:15:28.002Z,1578680128.002 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2020-01-10T18:15:28.084Z,1578680128.084 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2020-01-10T18:15:28.084Z,1578680128.084 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2020-01-10T18:15:28.182Z,1578680128.181 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2020-01-10T18:15:28.182Z,1578680128.182 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2020-01-10T18:15:28.230Z,1578680128.230 [VerticalControl](DEBUG): Construct VerticalControl.
2020-01-10T18:15:28.312Z,1578680128.312 [VerticalControl] Loaded
2020-01-10T18:15:28.312Z,1578680128.312 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2020-01-10T18:15:28.313Z,1578680128.313 [HorizontalControl](DEBUG): Construct HorizontalControl.
2020-01-10T18:15:28.383Z,1578680128.383 [HorizontalControl] Loaded
2020-01-10T18:15:28.383Z,1578680128.383 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2020-01-10T18:15:28.383Z,1578680128.383 [SpeedControl](DEBUG): Construct SpeedControl.
2020-01-10T18:15:28.385Z,1578680128.385 [SpeedControl] Loaded
2020-01-10T18:15:28.385Z,1578680128.385 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2020-01-10T18:15:28.386Z,1578680128.386 [LoopControl](DEBUG): Construct LoopControl.
2020-01-10T18:15:28.387Z,1578680128.387 [LoopControl] Loaded
2020-01-10T18:15:28.387Z,1578680128.387 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2020-01-10T18:15:28.387Z,1578680128.387 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2020-01-10T18:15:28.388Z,1578680128.388 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2020-01-10T18:15:28.420Z,1578680128.420 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2020-01-10T18:15:28.424Z,1578680128.424 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2020-01-10T18:15:28.424Z,1578680128.424 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2020-01-10T18:15:28.431Z,1578680128.431 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2020-01-10T18:15:28.432Z,1578680128.432 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40AFB4E0
2020-01-10T18:15:28.432Z,1578680128.432 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 4741
2020-01-10T18:15:28.437Z,1578680128.437 [Supervisor](INFO): Main Thread ID is 4530
2020-01-10T18:15:28.437Z,1578680128.437 [Supervisor](DEBUG): Running supervisor.
2020-01-10T18:15:28.438Z,1578680128.438 [CommandLine ThreadHandler](INFO): Handler Thread ID is 4742
2020-01-10T18:15:28.440Z,1578680128.440 [controlThread ThreadHandler](INFO): Handler Thread ID is 4743
2020-01-10T18:15:28.440Z,1578680128.440 [controlThread](DEBUG): Initializing ControlThread
2020-01-10T18:15:28.449Z,1578680128.449 [NavChart](DEBUG): Initialize NavChart Navigation.
2020-01-10T18:15:28.449Z,1578680128.449 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2020-01-10T18:15:28.453Z,1578680128.453 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2020-01-10T18:15:28.453Z,1578680128.453 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2020-01-10T18:15:28.454Z,1578680128.454 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2020-01-10T18:15:28.454Z,1578680128.454 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator.
2020-01-10T18:15:28.454Z,1578680128.454 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2020-01-10T18:15:28.455Z,1578680128.455 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2020-01-10T18:15:28.455Z,1578680128.455 [SBIT](INFO): Initialize SBIT Component.
2020-01-10T18:15:28.456Z,1578680128.456 [SBIT](IMPORTANT): git: 2019-12-03-17-g4812c94
2020-01-10T18:15:28.456Z,1578680128.456 [SBIT](INFO): git hash: 4812c9429720da7730f61311b178b42396aebb36
2020-01-10T18:15:28.456Z,1578680128.456 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2020-01-10T18:15:28.458Z,1578680128.458 [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-10T18:15:28.459Z,1578680128.459 [SBIT](INFO): Beginning SBIT in 39.000000 seconds.
2020-01-10T18:15:28.459Z,1578680128.459 [IBIT](INFO): Initialize IBIT Component.
2020-01-10T18:15:28.460Z,1578680128.460 [CBIT](DEBUG): Initialize CBIT Component.
2020-01-10T18:15:28.461Z,1578680128.461 [logger ThreadHandler](INFO): Handler Thread ID is 4744
2020-01-10T18:15:28.473Z,1578680128.473 [CBIT](DEBUG): Initialized mux pins.
2020-01-10T18:15:28.473Z,1578680128.473 [CBIT](DEBUG): Initializing the watchdog timer.
2020-01-10T18:15:28.481Z,1578680128.481 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 4745
2020-01-10T18:15:28.482Z,1578680128.482 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2020-01-10T18:15:28.493Z,1578680128.493 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 4746
2020-01-10T18:15:28.497Z,1578680128.497 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2020-01-10T18:15:28.497Z,1578680128.497 [CBIT](DEBUG): Initializing heartbeat.
2020-01-10T18:15:28.505Z,1578680128.505 [CTD_NeilBrown ThreadHandler](INFO): Handler Thread ID is 4747
2020-01-10T18:15:28.506Z,1578680128.506 [CTD_NeilBrown](INFO): Powering down
2020-01-10T18:15:28.529Z,1578680128.529 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Handler Thread ID is 4748
2020-01-10T18:15:28.530Z,1578680128.530 [WetLabsSeaOWL_UV_A](INFO): Powering down
2020-01-10T18:15:28.561Z,1578680128.561 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 4749
2020-01-10T18:15:28.564Z,1578680128.564 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2020-01-10T18:15:28.564Z,1578680128.564 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2020-01-10T18:15:28.565Z,1578680128.565 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2020-01-10T18:15:28.565Z,1578680128.565 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2020-01-10T18:15:28.565Z,1578680128.565 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2020-01-10T18:15:28.565Z,1578680128.565 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2020-01-10T18:15:28.565Z,1578680128.565 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000
2020-01-10T18:15:28.566Z,1578680128.566 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000
2020-01-10T18:15:28.566Z,1578680128.566 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2020-01-10T18:15:28.566Z,1578680128.566 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2020-01-10T18:15:28.566Z,1578680128.566 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000
2020-01-10T18:15:28.566Z,1578680128.566 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000
2020-01-10T18:15:28.567Z,1578680128.567 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000
2020-01-10T18:15:28.567Z,1578680128.567 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000
2020-01-10T18:15:28.567Z,1578680128.567 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000
2020-01-10T18:15:28.567Z,1578680128.567 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000
2020-01-10T18:15:28.569Z,1578680128.569 [CBIT](DEBUG): Deactivating GF circuits.
2020-01-10T18:15:28.569Z,1578680128.569 [CBIT](DEBUG): Deactivating emergency mode.
2020-01-10T18:15:28.605Z,1578680128.605 [CBIT](DEBUG): Backplane powered.
2020-01-10T18:15:28.605Z,1578680128.605 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2020-01-10T18:15:28.607Z,1578680128.607 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2020-01-10T18:15:28.607Z,1578680128.607 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2020-01-10T18:15:28.608Z,1578680128.608 [LoopControl](DEBUG): Initialize LoopControlComponent.
2020-01-10T18:15:28.609Z,1578680128.609 [MissionManager](INFO): Loading Mission: Missions/Startup.xml
2020-01-10T18:15:28.619Z,1578680128.619 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2020-01-10T18:15:28.638Z,1578680128.638 [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-10T18:15:28.638Z,1578680128.638 [MissionManager](INFO): Loading Mission: Missions/Default.xml
2020-01-10T18:15:28.712Z,1578680128.712 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2020-01-10T18:15:28.713Z,1578680128.713 [Default:A.Wait](DEBUG): Construct Wait.
2020-01-10T18:15:28.715Z,1578680128.715 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2020-01-10T18:15:28.767Z,1578680128.767 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2020-01-10T18:15:28.769Z,1578680128.769 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2020-01-10T18:15:28.791Z,1578680128.791 [Default:E.Execute](DEBUG): Construct Execute.
2020-01-10T18:15:28.794Z,1578680128.794 [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-10T18:15:28.814Z,1578680128.814 [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-10T18:15:28.819Z,1578680128.819 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2020-01-10T18:15:28.853Z,1578680128.853 [DDM](INFO): Powering up
2020-01-10T18:15:28.853Z,1578680128.853 [DDM](DEBUG): Initializing DDM.
2020-01-10T18:15:28.879Z,1578680128.879 [DUSBL_Hydroid](INFO): Powering up
2020-01-10T18:15:28.879Z,1578680128.879 [DUSBL_Hydroid](DEBUG): Initializing DUSBL_Hydroid.
2020-01-10T18:15:28.897Z,1578680128.897 [Radio_Surface](INFO): Powering up
2020-01-10T18:15:29.071Z,1578680129.071 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2020-01-10T18:15:29.077Z,1578680129.077 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2020-01-10T18:15:29.078Z,1578680129.078 [ElevatorServo](DEBUG): Initializing EZServoServo.
2020-01-10T18:15:29.085Z,1578680129.085 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2020-01-10T18:15:29.086Z,1578680129.086 [MassServo](DEBUG): Initializing EZServoServo.
2020-01-10T18:15:29.093Z,1578680129.093 [MassServo](DEBUG): Initializing MassServo.
2020-01-10T18:15:29.094Z,1578680129.094 [RudderServo](DEBUG): Initializing EZServoServo.
2020-01-10T18:15:29.101Z,1578680129.101 [RudderServo](DEBUG): Initializing RudderServo.
2020-01-10T18:15:29.102Z,1578680129.102 [ThrusterServo](DEBUG): Initializing EZServoServo.
2020-01-10T18:15:29.109Z,1578680129.109 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2020-01-10T18:15:29.238Z,1578680129.238 [DropWeight](CRITICAL): DROP WEIGHT MISSING.

2020-01-10T18:15:29.238Z,1578680129.238 [DropWeight] Hardware Fault, FailCount= 1
2020-01-10T18:15:29.238Z,1578680129.238 [DropWeight](ERROR): Hardware Fault
2020-01-10T18:15:29.240Z,1578680129.240 [Micromodem](INFO): Powering up
2020-01-10T18:15:29.240Z,1578680129.240 [Micromodem](DEBUG): Initializing Micromodem.
2020-01-10T18:15:29.324Z,1578680129.324 [CommandLine](FAULT): Scheduling is paused
2020-01-10T18:15:29.325Z,1578680129.325 [CBIT](INFO): Critical error at 20200110T181529
2020-01-10T18:15:29.325Z,1578680129.325 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals
2020-01-10T18:15:29.327Z,1578680129.327 [CBIT](ERROR): Hardware Fault in component: DropWeight
2020-01-10T18:15:29.328Z,1578680129.328 [CBIT](CRITICAL): Hardware Fault in component: DropWeight
2020-01-10T18:15:30.025Z,1578680130.025 [RudderServo](ERROR): Rudder initialization uart error serial timeout
2020-01-10T18:15:30.025Z,1578680130.025 [RudderServo](FAULT): Rudder failed to initialize
2020-01-10T18:15:30.025Z,1578680130.025 [RudderServo] Communications Fault, FailCount= 1
2020-01-10T18:15:30.025Z,1578680130.025 [RudderServo](ERROR): Communications Fault
2020-01-10T18:15:30.134Z,1578680130.134 [CBIT](INFO): Critical error at 20200110T181529
2020-01-10T18:15:30.137Z,1578680130.137 [CBIT](ERROR): Communications Fault in component: RudderServo
2020-01-10T18:15:30.318Z,1578680130.318 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2020-01-10T18:15:30.318Z,1578680130.318 [RudderServo](INFO): Powering down
2020-01-10T18:15:31.019Z,1578680131.019 [RudderServo](DEBUG): Initializing EZServoServo.
2020-01-10T18:15:31.138Z,1578680131.138 [RudderServo](DEBUG): Initializing RudderServo.
2020-01-10T18:15:31.142Z,1578680131.142 [CBIT](INFO): Clearing failed state for component RudderServo
2020-01-10T18:15:31.142Z,1578680131.142 [RudderServo] No Fault, FailCount= 1
2020-01-10T18:15:34.230Z,1578680134.230 [Micromodem](INFO): Nmea out: $CCCFG,ALL,0*33

2020-01-10T18:15:35.031Z,1578680135.031 [Micromodem](INFO): Nmea in: $CARE,81535,AUV,2.0.32731*10

2020-01-10T18:15:35.032Z,1578680135.032 [Micromodem](ERROR): Response from modem failed NMEA checksum: $CARE,81535,AUV,2.0.32731*10
 expected 77
2020-01-10T18:15:35.032Z,1578680135.032 [Micromodem](INFO): Nmea out: $CCCFG,ALL,0*33

2020-01-10T18:15:35.844Z,1578680135.844 [Micromodem](INFO): Nmea in: $CATMG,2020-01-10T18:15:35.151124Z,RTC,RTC*59

2020-01-10T18:15:35.844Z,1578680135.844 [Micromodem](ERROR): CFG response from modem unexpected: $CATMG,2020-01-10T18:15:35.151124Z,RTC,RTC*59

2020-01-10T18:15:36.247Z,1578680136.247 [Micromodem](INFO): Nmea in: $CACFG,ALL,0*31

2020-01-10T18:15:36.247Z,1578680136.247 [Micromodem](INFO): Nmea out: $CCCFG,SRC,1*31

2020-01-10T18:15:36.651Z,1578680136.651 [Micromodem](INFO): Nmea in: $CACFG,ALL,0*31

2020-01-10T18:15:36.651Z,1578680136.651 [Micromodem](ERROR): CFG response from modem unexpected: $CACFG,ALL,0*31

2020-01-10T18:15:37.039Z,1578680137.039 [Micromodem](INFO): Nmea in: $CACFG,SRC,1*33

2020-01-10T18:15:37.039Z,1578680137.039 [Micromodem](INFO): Nmea out: $CCCFG,nav.dt.txtrig_gpio4,1*64

2020-01-10T18:15:37.471Z,1578680137.471 [Micromodem](INFO): Nmea in: $CACFG,nav.dt.txtrig_gpio4,1*66

2020-01-10T18:15:37.471Z,1578680137.471 [Micromodem](INFO): Nmea out: $CCCFG,pwramp.txlevel,0*2F

2020-01-10T18:15:37.838Z,1578680137.838 [Micromodem](INFO): Nmea in: $CACFG,pwramp.txlevel,0*2D

2020-01-10T18:15:37.838Z,1578680137.838 [Micromodem](INFO): Nmea out: $CCCFG,DTO,30*1E

2020-01-10T18:15:38.251Z,1578680138.251 [Micromodem](INFO): Nmea in: $CACFG,DTO,30*1C

2020-01-10T18:15:38.251Z,1578680138.251 [Micromodem](INFO): Nmea out: $CCCFG,FC0,10000*46

2020-01-10T18:15:38.647Z,1578680138.647 [Micromodem](INFO): Nmea in: $CACFG,FC0,10000*44

2020-01-10T18:15:38.647Z,1578680138.647 [Micromodem](INFO): Nmea out: $CCCFG,BW0,4000*63

2020-01-10T18:15:39.044Z,1578680139.044 [Micromodem](INFO): Nmea in: $CACFG,BW0,4000*61

2020-01-10T18:15:39.044Z,1578680139.044 [Micromodem](INFO): Nmea out: $CCCFG,BND,0*3A

2020-01-10T18:15:39.454Z,1578680139.454 [DDM](INFO): Dynamic Docking Module:!C REMUS Capture Rev 1.1
2020-01-10T18:15:39.567Z,1578680139.567 [Micromodem](INFO): Nmea in: $CACFG,BND,0*38

2020-01-10T18:15:39.568Z,1578680139.568 [Micromodem](INFO): Nmea out: $CCCLK,2020,01,10,18,15,40*4D

2020-01-10T18:15:39.847Z,1578680139.847 [Micromodem](INFO): Nmea in: $CACLK,2020,1,10,18,15,40*7F

2020-01-10T18:15:40.279Z,1578680140.279 [Micromodem](INFO): Nmea in: $CATMS,0,2020-01-10T18:15:41Z*7E

2020-01-10T18:15:40.285Z,1578680140.285 [Micromodem](INFO): Nmea in: $CATMG,2020-01-10T18:15:41.026076Z,USER_CMD,RTC*1C

2020-01-10T18:15:42.300Z,1578680142.300 [RDI_Pathfinder](ERROR): Failed to parse:Pathfinder
2020-01-10T18:15:46.722Z,1578680146.722 [DUSBL_Hydroid](INFO): DUSBL Version:O
2020-01-10T18:15:54.807Z,1578680154.807 [NAL9602](INFO): Powering up NAL9602
2020-01-10T18:16:05.711Z,1578680165.711 [NAL9602](INFO): NAL9602 initialized
2020-01-10T18:16:08.215Z,1578680168.215 [SBIT](IMPORTANT): Beginning Startup BIT
2020-01-10T18:16:08.227Z,1578680168.227 [CBIT](IMPORTANT): Beginning ground fault scan
2020-01-10T18:16:14.308Z,1578680174.308 [Micromodem](INFO): Nmea in: $CACYC,1,12,1,1,0,1*68

2020-01-10T18:16:14.308Z,1578680174.308 [Micromodem](INFO): Have incoming data
2020-01-10T18:16:14.328Z,1578680174.328 [Micromodem](INFO): Nmea in: $CARXD,12,1,0,1,3D90B8D172D0E11A94BB9A0D6EC0434A2AB488F6*51

2020-01-10T18:16:14.329Z,1578680174.329 [Micromodem](INFO): Frame:1
2020-01-10T18:16:14.330Z,1578680174.330 [Micromodem](INFO): Frame Size:-18
2020-01-10T18:16:14.330Z,1578680174.330 [Micromodem](INFO): Data End:-2
2020-01-10T18:16:14.330Z,1578680174.330 [Micromodem](INFO): Data At:16
2020-01-10T18:16:14.331Z,1578680174.331 [Micromodem](INFO): Deserialize. FrameCount:1
2020-01-10T18:16:14.331Z,1578680174.331 [Micromodem](INFO): Outer loop. Size:-18
2020-01-10T18:16:14.331Z,1578680174.331 [Micromodem](INFO): Sending to RXSBD Size:0
2020-01-10T18:16:14.332Z,1578680174.332 [Micromodem](CRITICAL): Packet size is not N*16+4: 0x0
2020-01-10T18:16:14.332Z,1578680174.332 [Micromodem](CRITICAL): Failed to parse uplink message:
2020-01-10T18:16:14.587Z,1578680174.587 [CBIT](INFO): Critical error at 20200110T181614
2020-01-10T18:16:14.710Z,1578680174.710 [Micromodem](INFO): Nmea in: $CACST,6,0,20200110181613.390766,06,1800,32,0141,0150,59,02,02,00,04,1,012,001,0,3,1,0,150,26.4,8.00,00,-5.00,-01,-0.02,24,10000,4000*7C

2020-01-10T18:16:19.301Z,1578680179.301 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): -0.006970
CHAN A1 (24V): -0.029149
CHAN A2 (12V): -0.007332
CHAN A3 (5V): -0.002134
CHAN B0 (3.3V): 0.000211
CHAN B1 (3.15aV): -0.000048
CHAN B2 (3.15bV): -0.000036
CHAN B3 (GND): 0.002347
OPEN: 0.005058
Full Scale Calc: 4.765 mA, -1.589 mA
2020-01-10T18:16:40.671Z,1578680200.671 [Micromodem](INFO): Nmea in: $CACYC,1,12,1,1,0,1*68

2020-01-10T18:16:40.671Z,1578680200.671 [Micromodem](INFO): Have incoming data
2020-01-10T18:16:40.674Z,1578680200.674 [Micromodem](INFO): Nmea in: $CARXD,12,1,0,1,EA49DA6859B6D6FDD7866B1D923D9D8A099CA094*52

2020-01-10T18:16:40.674Z,1578680200.674 [Micromodem](INFO): Frame:1
2020-01-10T18:16:40.675Z,1578680200.675 [Micromodem](INFO): Frame Size:41
2020-01-10T18:16:40.675Z,1578680200.675 [Micromodem](INFO): Data End:57
2020-01-10T18:16:40.675Z,1578680200.675 [Micromodem](INFO): Data At:16
2020-01-10T18:16:40.675Z,1578680200.675 [Micromodem](INFO): Deserialize. FrameCount:1
2020-01-10T18:16:40.675Z,1578680200.675 [Micromodem](INFO): Outer loop. Size:41
2020-01-10T18:16:40.675Z,1578680200.675 [Micromodem](INFO): Inner loop. C:234
2020-01-10T18:16:40.676Z,1578680200.676 [Micromodem](INFO): Inner loop. C:73
2020-01-10T18:16:40.676Z,1578680200.676 [Micromodem](INFO): Inner loop. C:218
2020-01-10T18:16:40.676Z,1578680200.676 [Micromodem](INFO): Inner loop. C:104
2020-01-10T18:16:40.676Z,1578680200.676 [Micromodem](INFO): Inner loop. C:89
2020-01-10T18:16:40.676Z,1578680200.676 [Micromodem](INFO): Inner loop. C:182
2020-01-10T18:16:40.676Z,1578680200.676 [Micromodem](INFO): Inner loop. C:214
2020-01-10T18:16:40.701Z,1578680200.701 [Micromodem](INFO): Inner loop. C:253
2020-01-10T18:16:40.701Z,1578680200.701 [Micromodem](INFO): Inner loop. C:215
2020-01-10T18:16:40.701Z,1578680200.701 [Micromodem](INFO): Inner loop. C:134
2020-01-10T18:16:40.702Z,1578680200.702 [Micromodem](INFO): Inner loop. C:107
2020-01-10T18:16:40.702Z,1578680200.702 [Micromodem](INFO): Inner loop. C:29
2020-01-10T18:16:40.702Z,1578680200.702 [Micromodem](INFO): Inner loop. C:146
2020-01-10T18:16:40.702Z,1578680200.702 [Micromodem](INFO): Inner loop. C:61
2020-01-10T18:16:40.702Z,1578680200.702 [Micromodem](INFO): Inner loop. C:157
2020-01-10T18:16:40.702Z,1578680200.702 [Micromodem](INFO): Inner loop. C:138
2020-01-10T18:16:40.703Z,1578680200.703 [Micromodem](INFO): Inner loop. C:9
2020-01-10T18:16:40.703Z,1578680200.703 [Micromodem](INFO): Inner loop. C:156
2020-01-10T18:16:40.703Z,1578680200.703 [Micromodem](INFO): Inner loop. C:160
2020-01-10T18:16:40.703Z,1578680200.703 [Micromodem](INFO): Inner loop. C:148
2020-01-10T18:16:40.703Z,1578680200.703 [Micromodem](INFO): Sending to RXSBD Size:20
2020-01-10T18:16:40.704Z,1578680200.704 [Micromodem](INFO): Received command:failc
2020-01-10T18:16:40.778Z,1578680200.778 [CommandLine](IMPORTANT): got command failComponent
2020-01-10T18:16:40.778Z,1578680200.778 [CommandLine](IMPORTANT): Failed components:
2020-01-10T18:16:40.778Z,1578680200.778 [CommandLine](IMPORTANT): DropWeight: Hardware Fault
2020-01-10T18:16:41.078Z,1578680201.078 [Micromodem](INFO): Nmea in: $CACST,6,0,20200110181639.418958,06,1733,32,0131,0150,59,02,02,00,04,1,012,001,0,3,1,0,150,27.3,8.00,00,-5.00,-01,-0.02,24,10000,4000*7E

2020-01-10T18:16:52.171Z,1578680212.171 [RDI_Pathfinder](ERROR): only read 3 of 4 data items
2020-01-10T18:16:52.171Z,1578680212.171 [RDI_Pathfinder](ERROR): Failed to parse:
:RA,  0.00,   0.00,   0.00,   0.00
2020-01-10T18:17:01.551Z,1578680221.551 [SBIT](FAULT): Rudder: EXPECTED:0.000000 ACTUAL:0.013197
2020-01-10T18:17:01.551Z,1578680221.551 [SBIT](FAULT): Control surface position failure.
2020-01-10T18:17:01.958Z,1578680221.958 [SBIT](CRITICAL): SBIT FAILED
2020-01-10T18:17:01.978Z,1578680221.978 [CBIT](INFO): Critical error at 20200110T181701
2020-01-10T18:17:02.057Z,1578680222.057 [CommandLine](IMPORTANT): got command configSet list
2020-01-10T18:17:02.057Z,1578680222.057 [CommandLine](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2020-01-10T18:17:02.058Z,1578680222.058 [CommandLine](IMPORTANT): DDM.loadAtStartup=1 bool;

2020-01-10T18:17:02.058Z,1578680222.058 [CommandLine](IMPORTANT): DDM.verbosity=3 count;

2020-01-10T18:17:02.058Z,1578680222.058 [CommandLine](IMPORTANT): DUSBL_Hydroid.detectionThreshold=75 count;

2020-01-10T18:17:02.058Z,1578680222.058 [CommandLine](IMPORTANT): DUSBL_Hydroid.transmitLockout=40 millisecond;

2020-01-10T18:17:02.059Z,1578680222.059 [CommandLine](IMPORTANT): Express linearApproximation DDM.DDMMode 1.000000 count;

2020-01-10T18:17:02.059Z,1578680222.059 [CommandLine](IMPORTANT): Express all DDM.cablePresent;

2020-01-10T18:17:02.059Z,1578680222.059 [CommandLine](IMPORTANT): Express linearApproximation DDM.latchState 1.000000 count;

2020-01-10T18:17:02.059Z,1578680222.059 [CommandLine](IMPORTANT): Express linearApproximation DDM.whiskerState 1.000000 count;

2020-01-10T18:17:02.059Z,1578680222.059 [CommandLine](IMPORTANT): Express linearApproximation DUSBL_Hydroid.acoustic_contact_range 1.000000 meter;

2020-01-10T18:17:02.059Z,1578680222.059 [CommandLine](IMPORTANT): Express linearApproximation DUSBL_Hydroid.xAngle 2.000000 degree;

2020-01-10T18:17:02.059Z,1578680222.059 [CommandLine](IMPORTANT): Express linearApproximation RDI_Pathfinder.height_above_sea_floor 2.000000 meter;

2020-01-10T18:17:02.059Z,1578680222.059 [CommandLine](IMPORTANT): Express linearApproximation platform_orientation 5.000000 degree;

2020-01-10T18:17:02.059Z,1578680222.059 [CommandLine](IMPORTANT): Express linearApproximation platform_x_velocity_wrt_ground 0.100000 meter_per_second;

2020-01-10T18:17:02.060Z,1578680222.060 [CommandLine](IMPORTANT): Express linearApproximation platform_y_velocity_wrt_ground 0.100000 meter_per_second;

2020-01-10T18:17:02.060Z,1578680222.060 [CommandLine](IMPORTANT): HorizontalControl.kiHeading=0.002 reciprocal_second;

2020-01-10T18:17:02.060Z,1578680222.060 [CommandLine](IMPORTANT): HorizontalControl.kpHeading=0.8 none;

2020-01-10T18:17:02.060Z,1578680222.060 [CommandLine](IMPORTANT): HorizontalControl.rudDeadband=0.05 degree;

2020-01-10T18:17:02.060Z,1578680222.060 [CommandLine](IMPORTANT): Micromodem.destinationAddress=12 enum;

2020-01-10T18:17:02.060Z,1578680222.060 [CommandLine](IMPORTANT): Micromodem.surfaceThreshold=0 meter;

2020-01-10T18:17:02.060Z,1578680222.060 [CommandLine](IMPORTANT): PowerOnly.sampleTime=90 second;

2020-01-10T18:17:02.060Z,1578680222.060 [CommandLine](IMPORTANT): RudderServo.deviationAngle=0.0001 degree;

2020-01-10T18:17:02.060Z,1578680222.060 [CommandLine](IMPORTANT): VerticalControl.buoyancyNeutral=105 cubic_centimeter;

2020-01-10T18:17:02.060Z,1578680222.060 [CommandLine](IMPORTANT): VerticalControl.massDefault=-5 millimeter;

2020-01-10T18:17:02.303Z,1578680222.303 [MissionManager](IMPORTANT): Started mission Startup
2020-01-10T18:17:02.303Z,1578680222.303 [Startup] Running Loop=1
2020-01-10T18:17:02.303Z,1578680222.303 [Startup](DEBUG): Aggregate::initialize Startup
2020-01-10T18:17:02.303Z,1578680222.303 [Startup:A.GoToSurface] Running Loop=1
2020-01-10T18:17:02.303Z,1578680222.303 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2020-01-10T18:17:02.304Z,1578680222.304 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2020-01-10T18:17:02.304Z,1578680222.304 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2020-01-10T18:17:02.313Z,1578680222.313 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2020-01-10T18:17:02.313Z,1578680222.313 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2020-01-10T18:17:02.314Z,1578680222.314 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2020-01-10T18:17:02.315Z,1578680222.315 [Startup:StartupSatComms] Running Loop=1
2020-01-10T18:17:02.315Z,1578680222.315 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2020-01-10T18:17:02.315Z,1578680222.315 [Startup:StartupSatComms:A] Running Loop=1
2020-01-10T18:17:02.684Z,1578680222.684 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2020-01-10T18:17:11.931Z,1578680231.931 [Micromodem](INFO): Nmea in: $CACYC,1,12,1,1,0,1*68

2020-01-10T18:17:11.932Z,1578680231.932 [Micromodem](INFO): Have incoming data
2020-01-10T18:17:11.935Z,1578680231.935 [Micromodem](INFO): Nmea in: $CARXD,12,1,0,1,3D90B8D172D0E11A94BB9A0D6EC0434A2AB488F6*51

2020-01-10T18:17:11.935Z,1578680231.935 [Micromodem](INFO): Frame:1
2020-01-10T18:17:11.935Z,1578680231.935 [Micromodem](INFO): Frame Size:41
2020-01-10T18:17:11.935Z,1578680231.935 [Micromodem](INFO): Data End:57
2020-01-10T18:17:11.936Z,1578680231.936 [Micromodem](INFO): Data At:16
2020-01-10T18:17:11.936Z,1578680231.936 [Micromodem](INFO): Deserialize. FrameCount:1
2020-01-10T18:17:11.936Z,1578680231.936 [Micromodem](INFO): Outer loop. Size:41
2020-01-10T18:17:11.936Z,1578680231.936 [Micromodem](INFO): Inner loop. C:61
2020-01-10T18:17:11.936Z,1578680231.936 [Micromodem](INFO): Inner loop. C:144
2020-01-10T18:17:11.936Z,1578680231.936 [Micromodem](INFO): Inner loop. C:184
2020-01-10T18:17:11.937Z,1578680231.937 [Micromodem](INFO): Inner loop. C:209
2020-01-10T18:17:11.937Z,1578680231.937 [Micromodem](INFO): Inner loop. C:114
2020-01-10T18:17:11.937Z,1578680231.937 [Micromodem](INFO): Inner loop. C:208
2020-01-10T18:17:11.937Z,1578680231.937 [Micromodem](INFO): Inner loop. C:225
2020-01-10T18:17:11.937Z,1578680231.937 [Micromodem](INFO): Inner loop. C:26
2020-01-10T18:17:11.938Z,1578680231.938 [Micromodem](INFO): Inner loop. C:148
2020-01-10T18:17:11.938Z,1578680231.938 [Micromodem](INFO): Inner loop. C:187
2020-01-10T18:17:11.938Z,1578680231.938 [Micromodem](INFO): Inner loop. C:154
2020-01-10T18:17:11.938Z,1578680231.938 [Micromodem](INFO): Inner loop. C:13
2020-01-10T18:17:11.938Z,1578680231.938 [Micromodem](INFO): Inner loop. C:110
2020-01-10T18:17:11.938Z,1578680231.938 [Micromodem](INFO): Inner loop. C:192
2020-01-10T18:17:11.939Z,1578680231.939 [Micromodem](INFO): Inner loop. C:67
2020-01-10T18:17:11.939Z,1578680231.939 [Micromodem](INFO): Inner loop. C:74
2020-01-10T18:17:11.939Z,1578680231.939 [Micromodem](INFO): Inner loop. C:42
2020-01-10T18:17:11.939Z,1578680231.939 [Micromodem](INFO): Inner loop. C:180
2020-01-10T18:17:11.939Z,1578680231.939 [Micromodem](INFO): Inner loop. C:136
2020-01-10T18:17:11.939Z,1578680231.939 [Micromodem](INFO): Inner loop. C:246
2020-01-10T18:17:11.940Z,1578680231.940 [Micromodem](INFO): Sending to RXSBD Size:20
2020-01-10T18:17:11.940Z,1578680231.940 [Micromodem](INFO): Received command:stop
2020-01-10T18:17:12.029Z,1578680232.029 [CommandLine](IMPORTANT): got command stop
2020-01-10T18:17:12.030Z,1578680232.030 [CommandLine](IMPORTANT): Scheduling is paused
2020-01-10T18:17:12.338Z,1578680232.338 [Micromodem](INFO): Nmea in: $CACST,6,0,20200110181710.673013,06,1571,31,0119,0150,59,02,02,00,03,1,012,001,0,3,1,0,150,27.1,8.00,00,-5.00,-01,-0.02,24,10000,4000*75

2020-01-10T18:17:43.047Z,1578680263.047 [Micromodem](INFO): Nmea in: $CACYC,1,12,1,1,0,2*6B

2020-01-10T18:17:43.048Z,1578680263.048 [Micromodem](INFO): Have incoming data
2020-01-10T18:17:43.055Z,1578680263.055 [Micromodem](INFO): Nmea in: $CARXD,12,1,0,1,858A1AB878DB70DBE89704525FDC95B5C5FE9F4147C09B083E4A8CE30F9EA23DB7C2EC1A3F0C8416B2D6BA469C63028C955B1EDAD054116D0BA2C541AD2A74E9*5A

2020-01-10T18:17:43.056Z,1578680263.056 [Micromodem](INFO): Frame:1
2020-01-10T18:17:43.056Z,1578680263.056 [Micromodem](INFO): Frame Size:129
2020-01-10T18:17:43.056Z,1578680263.056 [Micromodem](INFO): Data End:145
2020-01-10T18:17:43.056Z,1578680263.056 [Micromodem](INFO): Data At:16
2020-01-10T18:17:43.444Z,1578680263.444 [Micromodem](INFO): Nmea in: $CARXD,12,1,0,2,4EEE1310BA042F91D0BD31A76379D458F2E8C122*52

2020-01-10T18:17:43.445Z,1578680263.445 [Micromodem](INFO): Frame:2
2020-01-10T18:17:43.445Z,1578680263.445 [Micromodem](INFO): Frame Size:41
2020-01-10T18:17:43.445Z,1578680263.445 [Micromodem](INFO): Data End:57
2020-01-10T18:17:43.445Z,1578680263.445 [Micromodem](INFO): Data At:16
2020-01-10T18:17:43.446Z,1578680263.446 [Micromodem](INFO): Deserialize. FrameCount:2
2020-01-10T18:17:43.446Z,1578680263.446 [Micromodem](INFO): Outer loop. Size:129
2020-01-10T18:17:43.446Z,1578680263.446 [Micromodem](INFO): Inner loop. C:133
2020-01-10T18:17:43.446Z,1578680263.446 [Micromodem](INFO): Inner loop. C:138
2020-01-10T18:17:43.446Z,1578680263.446 [Micromodem](INFO): Inner loop. C:26
2020-01-10T18:17:43.446Z,1578680263.446 [Micromodem](INFO): Inner loop. C:184
2020-01-10T18:17:43.447Z,1578680263.447 [Micromodem](INFO): Inner loop. C:120
2020-01-10T18:17:43.447Z,1578680263.447 [Micromodem](INFO): Inner loop. C:219
2020-01-10T18:17:43.447Z,1578680263.447 [Micromodem](INFO): Inner loop. C:112
2020-01-10T18:17:43.447Z,1578680263.447 [Micromodem](INFO): Inner loop. C:219
2020-01-10T18:17:43.447Z,1578680263.447 [Micromodem](INFO): Inner loop. C:232
2020-01-10T18:17:43.448Z,1578680263.448 [Micromodem](INFO): Inner loop. C:151
2020-01-10T18:17:43.448Z,1578680263.448 [Micromodem](INFO): Inner loop. C:4
2020-01-10T18:17:43.448Z,1578680263.448 [Micromodem](INFO): Inner loop. C:82
2020-01-10T18:17:43.448Z,1578680263.448 [Micromodem](INFO): Inner loop. C:95
2020-01-10T18:17:43.448Z,1578680263.448 [Micromodem](INFO): Inner loop. C:220
2020-01-10T18:17:43.448Z,1578680263.448 [Micromodem](INFO): Inner loop. C:149
2020-01-10T18:17:43.457Z,1578680263.457 [Micromodem](INFO): Inner loop. C:181
2020-01-10T18:17:43.457Z,1578680263.457 [Micromodem](INFO): Inner loop. C:197
2020-01-10T18:17:43.457Z,1578680263.457 [Micromodem](INFO): Inner loop. C:254
2020-01-10T18:17:43.458Z,1578680263.458 [Micromodem](INFO): Inner loop. C:159
2020-01-10T18:17:43.458Z,1578680263.458 [Micromodem](INFO): Inner loop. C:65
2020-01-10T18:17:43.458Z,1578680263.458 [Micromodem](INFO): Inner loop. C:71
2020-01-10T18:17:43.458Z,1578680263.458 [Micromodem](INFO): Inner loop. C:192
2020-01-10T18:17:43.458Z,1578680263.458 [Micromodem](INFO): Inner loop. C:155
2020-01-10T18:17:43.458Z,1578680263.458 [Micromodem](INFO): Inner loop. C:8
2020-01-10T18:17:43.459Z,1578680263.459 [Micromodem](INFO): Inner loop. C:62
2020-01-10T18:17:43.459Z,1578680263.459 [Micromodem](INFO): Inner loop. C:74
2020-01-10T18:17:43.459Z,1578680263.459 [Micromodem](INFO): Inner loop. C:140
2020-01-10T18:17:43.459Z,1578680263.459 [Micromodem](INFO): Inner loop. C:227
2020-01-10T18:17:43.459Z,1578680263.459 [Micromodem](INFO): Inner loop. C:15
2020-01-10T18:17:43.459Z,1578680263.459 [Micromodem](INFO): Inner loop. C:158
2020-01-10T18:17:43.460Z,1578680263.460 [Micromodem](INFO): Inner loop. C:162
2020-01-10T18:17:43.460Z,1578680263.460 [Micromodem](INFO): Inner loop. C:61
2020-01-10T18:17:43.460Z,1578680263.460 [Micromodem](INFO): Inner loop. C:183
2020-01-10T18:17:43.460Z,1578680263.460 [Micromodem](INFO): Inner loop. C:194
2020-01-10T18:17:43.460Z,1578680263.460 [Micromodem](INFO): Inner loop. C:236
2020-01-10T18:17:43.460Z,1578680263.460 [Micromodem](INFO): Inner loop. C:26
2020-01-10T18:17:43.477Z,1578680263.477 [Micromodem](INFO): Inner loop. C:63
2020-01-10T18:17:43.477Z,1578680263.477 [Micromodem](INFO): Inner loop. C:12
2020-01-10T18:17:43.477Z,1578680263.477 [Micromodem](INFO): Inner loop. C:132
2020-01-10T18:17:43.478Z,1578680263.478 [Micromodem](INFO): Inner loop. C:22
2020-01-10T18:17:43.478Z,1578680263.478 [Micromodem](INFO): Inner loop. C:178
2020-01-10T18:17:43.478Z,1578680263.478 [Micromodem](INFO): Inner loop. C:214
2020-01-10T18:17:43.478Z,1578680263.478 [Micromodem](INFO): Inner loop. C:186
2020-01-10T18:17:43.478Z,1578680263.478 [Micromodem](INFO): Inner loop. C:70
2020-01-10T18:17:43.478Z,1578680263.478 [Micromodem](INFO): Inner loop. C:156
2020-01-10T18:17:43.479Z,1578680263.479 [Micromodem](INFO): Inner loop. C:99
2020-01-10T18:17:43.479Z,1578680263.479 [Micromodem](INFO): Inner loop. C:2
2020-01-10T18:17:43.479Z,1578680263.479 [Micromodem](INFO): Inner loop. C:140
2020-01-10T18:17:43.479Z,1578680263.479 [Micromodem](INFO): Inner loop. C:149
2020-01-10T18:17:43.479Z,1578680263.479 [Micromodem](INFO): Inner loop. C:91
2020-01-10T18:17:43.479Z,1578680263.479 [Micromodem](INFO): Inner loop. C:30
2020-01-10T18:17:43.480Z,1578680263.480 [Micromodem](INFO): Inner loop. C:218
2020-01-10T18:17:43.480Z,1578680263.480 [Micromodem](INFO): Inner loop. C:208
2020-01-10T18:17:43.480Z,1578680263.480 [Micromodem](INFO): Inner loop. C:84
2020-01-10T18:17:43.480Z,1578680263.480 [Micromodem](INFO): Inner loop. C:17
2020-01-10T18:17:43.480Z,1578680263.480 [Micromodem](INFO): Inner loop. C:109
2020-01-10T18:17:43.480Z,1578680263.480 [Micromodem](INFO): Inner loop. C:11
2020-01-10T18:17:43.489Z,1578680263.489 [Micromodem](INFO): Inner loop. C:162
2020-01-10T18:17:43.489Z,1578680263.489 [Micromodem](INFO): Inner loop. C:197
2020-01-10T18:17:43.489Z,1578680263.489 [Micromodem](INFO): Inner loop. C:65
2020-01-10T18:17:43.490Z,1578680263.490 [Micromodem](INFO): Inner loop. C:173
2020-01-10T18:17:43.490Z,1578680263.490 [Micromodem](INFO): Inner loop. C:42
2020-01-10T18:17:43.490Z,1578680263.490 [Micromodem](INFO): Inner loop. C:116
2020-01-10T18:17:43.490Z,1578680263.490 [Micromodem](INFO): Inner loop. C:233
2020-01-10T18:17:43.490Z,1578680263.490 [Micromodem](INFO): Outer loop. Size:41
2020-01-10T18:17:43.490Z,1578680263.490 [Micromodem](INFO): Inner loop. C:78
2020-01-10T18:17:43.491Z,1578680263.491 [Micromodem](INFO): Inner loop. C:238
2020-01-10T18:17:43.491Z,1578680263.491 [Micromodem](INFO): Inner loop. C:19
2020-01-10T18:17:43.491Z,1578680263.491 [Micromodem](INFO): Inner loop. C:16
2020-01-10T18:17:43.491Z,1578680263.491 [Micromodem](INFO): Inner loop. C:186
2020-01-10T18:17:43.491Z,1578680263.491 [Micromodem](INFO): Inner loop. C:4
2020-01-10T18:17:43.491Z,1578680263.491 [Micromodem](INFO): Inner loop. C:47
2020-01-10T18:17:43.492Z,1578680263.492 [Micromodem](INFO): Inner loop. C:145
2020-01-10T18:17:43.492Z,1578680263.492 [Micromodem](INFO): Inner loop. C:208
2020-01-10T18:17:43.492Z,1578680263.492 [Micromodem](INFO): Inner loop. C:189
2020-01-10T18:17:43.492Z,1578680263.492 [Micromodem](INFO): Inner loop. C:49
2020-01-10T18:17:43.492Z,1578680263.492 [Micromodem](INFO): Inner loop. C:167
2020-01-10T18:17:43.492Z,1578680263.492 [Micromodem](INFO): Inner loop. C:99
2020-01-10T18:17:43.505Z,1578680263.505 [Micromodem](INFO): Inner loop. C:121
2020-01-10T18:17:43.505Z,1578680263.505 [Micromodem](INFO): Inner loop. C:212
2020-01-10T18:17:43.505Z,1578680263.505 [Micromodem](INFO): Inner loop. C:88
2020-01-10T18:17:43.506Z,1578680263.506 [Micromodem](INFO): Inner loop. C:242
2020-01-10T18:17:43.506Z,1578680263.506 [Micromodem](INFO): Inner loop. C:232
2020-01-10T18:17:43.506Z,1578680263.506 [Micromodem](INFO): Inner loop. C:193
2020-01-10T18:17:43.506Z,1578680263.506 [Micromodem](INFO): Inner loop. C:34
2020-01-10T18:17:43.506Z,1578680263.506 [Micromodem](INFO): Sending to RXSBD Size:84
2020-01-10T18:17:43.507Z,1578680263.507 [Micromodem](INFO): Received command:failc;stop;configSet list;get platform_orientation degree;stop;failc
2020-01-10T18:17:46.571Z,1578680266.571 [CommandLine](IMPORTANT): got command failComponent
2020-01-10T18:17:46.571Z,1578680266.571 [CommandLine](IMPORTANT): Failed components:
2020-01-10T18:17:46.571Z,1578680266.571 [CommandLine](IMPORTANT): DropWeight: Hardware Fault
2020-01-10T18:17:46.571Z,1578680266.571 [CommandLine](IMPORTANT): got command stop
2020-01-10T18:17:46.571Z,1578680266.571 [CommandLine](IMPORTANT): got command configSet list
2020-01-10T18:17:46.572Z,1578680266.572 [CommandLine](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2020-01-10T18:17:46.572Z,1578680266.572 [CommandLine](IMPORTANT): DDM.loadAtStartup=1 bool;

2020-01-10T18:17:46.573Z,1578680266.573 [CommandLine](IMPORTANT): DDM.verbosity=3 count;

2020-01-10T18:17:46.573Z,1578680266.573 [CommandLine](IMPORTANT): DUSBL_Hydroid.detectionThreshold=75 count;

2020-01-10T18:17:46.573Z,1578680266.573 [CommandLine](IMPORTANT): DUSBL_Hydroid.transmitLockout=40 millisecond;

2020-01-10T18:17:46.573Z,1578680266.573 [CommandLine](IMPORTANT): Express linearApproximation DDM.DDMMode 1.000000 count;

2020-01-10T18:17:46.573Z,1578680266.573 [CommandLine](IMPORTANT): Express all DDM.cablePresent;

2020-01-10T18:17:46.573Z,1578680266.573 [CommandLine](IMPORTANT): Express linearApproximation DDM.latchState 1.000000 count;

2020-01-10T18:17:46.573Z,1578680266.573 [CommandLine](IMPORTANT): Express linearApproximation DDM.whiskerState 1.000000 count;

2020-01-10T18:17:46.573Z,1578680266.573 [CommandLine](IMPORTANT): Express linearApproximation DUSBL_Hydroid.acoustic_contact_range 1.000000 meter;

2020-01-10T18:17:46.574Z,1578680266.574 [CommandLine](IMPORTANT): Express linearApproximation DUSBL_Hydroid.xAngle 2.000000 degree;

2020-01-10T18:17:46.574Z,1578680266.574 [CommandLine](IMPORTANT): Express linearApproximation RDI_Pathfinder.height_above_sea_floor 2.000000 meter;

2020-01-10T18:17:46.574Z,1578680266.574 [CommandLine](IMPORTANT): Express linearApproximation platform_orientation 5.000000 degree;

2020-01-10T18:17:46.574Z,1578680266.574 [CommandLine](IMPORTANT): Express linearApproximation platform_x_velocity_wrt_ground 0.100000 meter_per_second;

2020-01-10T18:17:46.574Z,1578680266.574 [CommandLine](IMPORTANT): Express linearApproximation platform_y_velocity_wrt_ground 0.100000 meter_per_second;

2020-01-10T18:17:46.574Z,1578680266.574 [CommandLine](IMPORTANT): HorizontalControl.kiHeading=0.002 reciprocal_second;

2020-01-10T18:17:46.574Z,1578680266.574 [CommandLine](IMPORTANT): HorizontalControl.kpHeading=0.8 none;

2020-01-10T18:17:46.574Z,1578680266.574 [CommandLine](IMPORTANT): HorizontalControl.rudDeadband=0.05 degree;

2020-01-10T18:17:46.574Z,1578680266.574 [CommandLine](IMPORTANT): Micromodem.destinationAddress=12 enum;

2020-01-10T18:17:46.575Z,1578680266.575 [CommandLine](IMPORTANT): Micromodem.surfaceThreshold=0 meter;

2020-01-10T18:17:46.575Z,1578680266.575 [CommandLine](IMPORTANT): PowerOnly.sampleTime=90 second;

2020-01-10T18:17:46.575Z,1578680266.575 [CommandLine](IMPORTANT): RudderServo.deviationAngle=0.0001 degree;

2020-01-10T18:17:46.575Z,1578680266.575 [CommandLine](IMPORTANT): VerticalControl.buoyancyNeutral=105 cubic_centimeter;

2020-01-10T18:17:46.575Z,1578680266.575 [CommandLine](IMPORTANT): VerticalControl.massDefault=-5 millimeter;

2020-01-10T18:17:46.576Z,1578680266.576 [CommandLine](IMPORTANT): got command get platform_orientation degree
2020-01-10T18:17:46.576Z,1578680266.576 [CommandLine](IMPORTANT): platform_orientation 72.892100 arcdeg
2020-01-10T18:17:46.576Z,1578680266.576 [CommandLine](IMPORTANT): got command stop
2020-01-10T18:17:46.577Z,1578680266.577 [CommandLine](IMPORTANT): got command failComponent
2020-01-10T18:17:46.577Z,1578680266.577 [CommandLine](IMPORTANT): Failed components:
2020-01-10T18:17:46.577Z,1578680266.577 [CommandLine](IMPORTANT): DropWeight: Hardware Fault
2020-01-10T18:17:46.582Z,1578680266.582 [Micromodem](INFO): Nmea in: $CACST,6,0,20200110181740.690816,06,1503,31,0115,0150,59,02,02,00,04,1,012,001,0,3,2,0,150,26.8,8.00,00,-5.00,-01,-0.02,24,10000,4000*75

2020-01-10T18:17:57.719Z,1578680277.719 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.005016
2020-01-10T18:18:02.534Z,1578680282.534 [Startup:StartupSatComms:A](INFO): Timed out from 2020-01-10T18:17:02.3Z
2020-01-10T18:18:02.534Z,1578680282.534 [Startup:StartupSatComms:A] Stopped
2020-01-10T18:18:02.535Z,1578680282.535 [Startup:StartupSatComms:B] Running Loop=1
2020-01-10T18:18:02.919Z,1578680282.919 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2020-01-10T18:18:04.228Z,1578680284.228 [Micromodem](INFO): Outgoing frame #1, 64 bytes: 60BE185E000001005D000004009D0100000000000000151D80030C5669BF3148E2FA22188B6A388EEB0BC45C9E58EC1F659FAAC29EC6B6829A7CC0606A7B8EA6
2020-01-10T18:18:04.229Z,1578680284.229 [Micromodem](INFO): Outgoing frame #2, 64 bytes: AA422B2385EC73C0FABC6B0C6D70893EB78F88D46452A4A3C7E9D8907F12032C01CF700820374B1C8E5D82357819DDFA5B46F5DFA93FEDD106818297EE367CDD
2020-01-10T18:18:04.229Z,1578680284.229 [Micromodem](INFO): Outgoing frame #3, 64 bytes: 69571810B7495D6CAF9FD6ABB2DA9F801967DEEE5C99E9C5412D90BAC7130D24E64197165DEE7DC1899F1EEE77C1DDEC70C2778818E89A8F049B55819DEC2CBE
2020-01-10T18:18:04.229Z,1578680284.229 [Micromodem](INFO): Nmea out: $CCCYC,0,1,12,1,0,3*69

2020-01-10T18:18:04.791Z,1578680284.791 [Micromodem](INFO): Nmea in: $CACYC,0,1,12,1,0,3*6B

2020-01-10T18:18:05.195Z,1578680285.195 [Micromodem](INFO): Nmea in: $CADRQ,181805,1,12,0,64,1*71

2020-01-10T18:18:05.195Z,1578680285.195 [Micromodem](INFO): Nmea out: $CCTXD,1,12,1,60BE185E000001005D000004009D0100000000000000151D80030C5669BF3148E2FA22188B6A388EEB0BC45C9E58EC1F659FAAC29EC6B6829A7CC0606A7B8EA6*49

2020-01-10T18:18:05.607Z,1578680285.607 [Micromodem](INFO): Nmea in: $CATXD,1,12,1,64*4B

2020-01-10T18:18:06.052Z,1578680286.052 [Micromodem](INFO): Nmea in: $CADRQ,181806,1,12,0,64,2*71

2020-01-10T18:18:06.052Z,1578680286.052 [Micromodem](INFO): Nmea out: $CCTXD,1,12,1,AA422B2385EC73C0FABC6B0C6D70893EB78F88D46452A4A3C7E9D8907F12032C01CF700820374B1C8E5D82357819DDFA5B46F5DFA93FEDD106818297EE367CDD*49

2020-01-10T18:18:06.411Z,1578680286.411 [Micromodem](INFO): Nmea in: $CATXD,1,12,1,64*4B

2020-01-10T18:18:06.807Z,1578680286.807 [Micromodem](INFO): Nmea in: $CADRQ,181807,1,12,0,64,3*71

2020-01-10T18:18:06.807Z,1578680286.807 [Micromodem](INFO): Nmea out: $CCTXD,1,12,1,69571810B7495D6CAF9FD6ABB2DA9F801967DEEE5C99E9C5412D90BAC7130D24E64197165DEE7DC1899F1EEE77C1DDEC70C2778818E89A8F049B55819DEC2CBE*3E

2020-01-10T18:18:07.223Z,1578680287.223 [Micromodem](INFO): Nmea in: $CATXD,1,12,1,64*4B

2020-01-10T18:18:07.623Z,1578680287.623 [Micromodem](INFO): Nmea in: $CATXP,192*48

2020-01-10T18:18:08.020Z,1578680288.020 [NAL9602](INFO): SBD MO Status=2, MOMSN=10155, MT Status=2, MTMSN=0
2020-01-10T18:18:08.020Z,1578680288.020 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2020-01-10T18:18:10.961Z,1578680290.961 [DataOverHttps](INFO): Sending 308 bytes from file Logs/20200110T181144/Courier0000.lzma
2020-01-10T18:18:11.251Z,1578680291.251 [Micromodem](INFO): Nmea in: $CATXF,192*5E

2020-01-10T18:18:11.664Z,1578680291.664 [Micromodem](INFO): Nmea in: $CAXST,6,20200110,181807.905358,3,0,200,4000,10000,1,1,12,1,3,3,3,192*7F

2020-01-10T18:18:12.478Z,1578680292.478 [Micromodem](INFO): Nmea in: $CAACK,12,1,1,1*79

2020-01-10T18:18:12.867Z,1578680292.867 [Micromodem](INFO): Nmea in: $CAACK,12,1,2,1*7A

2020-01-10T18:18:13.213Z,1578680293.213 [DataOverHttps](INFO): Moved sent file to Logs/20200110T181144/Courier0000.lzma.bak
2020-01-10T18:18:13.213Z,1578680293.213 [DataOverHttps](INFO): SBD MOMSN=12190309
2020-01-10T18:18:13.271Z,1578680293.271 [Micromodem](INFO): Nmea in: $CAACK,12,1,3,1*7B

2020-01-10T18:18:13.272Z,1578680293.272 [Micromodem](INFO): Sent 184 bytes from file Logs/20200110T181144/Courier0000.lzma.parts
2020-01-10T18:18:13.272Z,1578680293.272 [Micromodem](INFO): Packets left to send: 1
2020-01-10T18:18:13.685Z,1578680293.685 [Micromodem](INFO): Nmea in: $CACST,6,0,20200110181812.456434,06,641,28,0109,0150,89,02,02,00,03,1,012,001,0,4,1,0,150,25.8,5.00,13,-2.00,-01,-0.03,27,10000,4000*4F

2020-01-10T18:18:15.396Z,1578680295.396 [Micromodem](INFO): Outgoing frame #1, 47 bytes: 60BE185E040000005D00000400140000000000000000151D80030C5669C08C34EE4C7D8E481728CC9980F21D082000
2020-01-10T18:18:15.397Z,1578680295.397 [Micromodem](INFO): Nmea out: $CCCYC,0,1,12,1,0,1*6B

2020-01-10T18:18:16.551Z,1578680296.551 [Micromodem](INFO): Nmea in: $CACYC,0,1,12,1,0,1*69

2020-01-10T18:18:16.947Z,1578680296.947 [Micromodem](INFO): Nmea in: $CADRQ,181816,1,12,0,64,1*73

2020-01-10T18:18:16.947Z,1578680296.947 [Micromodem](INFO): Nmea out: $CCTXD,1,12,1,60BE185E040000005D00000400140000000000000000151D80030C5669C08C34EE4C7D8E481728CC9980F21D082000*37

2020-01-10T18:18:17.351Z,1578680297.351 [Micromodem](INFO): Nmea in: $CATXD,1,12,1,47*4A

2020-01-10T18:18:17.754Z,1578680297.754 [Micromodem](INFO): Nmea in: $CATXP,47*71

2020-01-10T18:18:18.967Z,1578680298.967 [Micromodem](INFO): Nmea in: $CATXF,47*67

2020-01-10T18:18:19.372Z,1578680299.372 [Micromodem](INFO): Nmea in: $CAXST,6,20200110,181817.997960,3,0,200,4000,10000,1,1,12,1,1,1,3,47*4D

2020-01-10T18:18:20.179Z,1578680300.179 [Micromodem](INFO): Nmea in: $CAACK,12,1,1,1*79

2020-01-10T18:18:20.180Z,1578680300.180 [Micromodem](INFO): Sent 39 bytes from file Logs/20200110T181144/Courier0004.lzma.parts
2020-01-10T18:18:20.180Z,1578680300.180 [Micromodem](INFO): Packets left to send: 0
2020-01-10T18:18:20.586Z,1578680300.586 [Micromodem](INFO): Nmea in: $CACST,6,0,20200110181819.998014,06,549,27,0099,0150,89,02,02,00,03,1,012,001,0,4,1,0,150,14.7,7.00,15,-4.00,-01,-0.03,37,10000,4000*4F

2020-01-10T18:18:21.683Z,1578680301.683 [Micromodem](INFO): Outgoing frame #1, 64 bytes: 36BF185E000001005D000004002E0100000000000000151D80030C5669BF31555EAE1409A708CE2489EC102F971AAFC35C3D87A14EFD88D7E667BF45C1E3A334
2020-01-10T18:18:21.683Z,1578680301.683 [Micromodem](INFO): Outgoing frame #2, 64 bytes: DF5CCD6986D27722AC16047A05CB4DEC750D7E1827D955ADD8BEBC7E9CD59055B48A8F61691C351C17E66D77DA000BC932CCF93723219D9083C4749920396B77
2020-01-10T18:18:21.684Z,1578680301.684 [Micromodem](INFO): Outgoing frame #3, 64 bytes: 5E65CAC7C6F90F3230E0449B85B630F13D7827F81D24EA5EFF616BA3849A321ABF9503BAB91BFCED449B93B13C259831BEAF1EF9ED3032F34465FB743B7269A0
2020-01-10T18:18:21.684Z,1578680301.684 [Micromodem](INFO): Nmea out: $CCCYC,0,1,12,1,0,3*69

2020-01-10T18:18:22.671Z,1578680302.671 [Micromodem](INFO): Nmea in: $CACYC,0,1,12,1,0,3*6B

2020-01-10T18:18:23.067Z,1578680303.067 [Micromodem](INFO): Nmea in: $CADRQ,181822,1,12,0,64,1*74

2020-01-10T18:18:23.067Z,1578680303.067 [Micromodem](INFO): Nmea out: $CCTXD,1,12,1,36BF185E000001005D000004002E0100000000000000151D80030C5669BF31555EAE1409A708CE2489EC102F971AAFC35C3D87A14EFD88D7E667BF45C1E3A334*37

2020-01-10T18:18:23.471Z,1578680303.471 [Micromodem](INFO): Nmea in: $CATXD,1,12,1,64*4B

2020-01-10T18:18:23.875Z,1578680303.875 [Micromodem](INFO): Nmea in: $CADRQ,181824,1,12,0,64,2*71

2020-01-10T18:18:23.875Z,1578680303.875 [Micromodem](INFO): Nmea out: $CCTXD,1,12,1,DF5CCD6986D27722AC16047A05CB4DEC750D7E1827D955ADD8BEBC7E9CD59055B48A8F61691C351C17E66D77DA000BC932CCF93723219D9083C4749920396B77*4A

2020-01-10T18:18:24.279Z,1578680304.279 [Micromodem](INFO): Nmea in: $CATXD,1,12,1,64*4B

2020-01-10T18:18:24.683Z,1578680304.683 [Micromodem](INFO): Nmea in: $CADRQ,181824,1,12,0,64,3*70

2020-01-10T18:18:24.683Z,1578680304.683 [Micromodem](INFO): Nmea out: $CCTXD,1,12,1,5E65CAC7C6F90F3230E0449B85B630F13D7827F81D24EA5EFF616BA3849A321ABF9503BAB91BFCED449B93B13C259831BEAF1EF9ED3032F34465FB743B7269A0*32

2020-01-10T18:18:25.092Z,1578680305.092 [Micromodem](INFO): Nmea in: $CATXD,1,12,1,64*4B

2020-01-10T18:18:25.495Z,1578680305.495 [Micromodem](INFO): Nmea in: $CATXP,192*48

2020-01-10T18:18:28.814Z,1578680308.814 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2020-01-10T18:18:28.814Z,1578680308.814 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-01-10T18:18:28.832Z,1578680308.832 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-01-10T18:18:29.135Z,1578680309.135 [Micromodem](INFO): Nmea in: $CATXF,192*5E

2020-01-10T18:18:29.380Z,1578680309.380 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-01-10T18:18:29.380Z,1578680309.380 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2020-01-10T18:18:29.540Z,1578680309.540 [Micromodem](INFO): Nmea in: $CAXST,6,20200110,181825.779046,3,0,200,4000,10000,1,1,12,1,3,3,3,192*76

2020-01-10T18:18:30.379Z,1578680310.379 [Micromodem](INFO): Nmea in: $CAACK,12,1,1,1*79

2020-01-10T18:18:30.759Z,1578680310.759 [Micromodem](INFO): Nmea in: $CAACK,12,1,2,1*7A

2020-01-10T18:18:31.159Z,1578680311.159 [Micromodem](INFO): Nmea in: $CAACK,12,1,3,1*7B

2020-01-10T18:18:31.159Z,1578680311.159 [Micromodem](INFO): Sent 184 bytes from file Logs/20200110T181518/Courier0000.lzma.parts
2020-01-10T18:18:31.160Z,1578680311.160 [Micromodem](INFO): Packets left to send: 1
2020-01-10T18:18:31.574Z,1578680311.574 [Micromodem](INFO): Nmea in: $CACST,6,0,20200110181830.330712,06,227,23,0118,0150,59,01,01,00,03,1,012,001,0,4,1,0,150,20.8,6.00,17,-3.00,-01,-0.04,26,10000,4000*48

2020-01-10T18:18:32.640Z,1578680312.640 [Micromodem](INFO): Outgoing frame #1, 57 bytes: 36BF185E00000000FA7FE60E0D5D47AA2C6CF0742D99ADF923BFAF757CA1FE5EB2BC855FF4FB6483A9354F8A0A3B09D5FF810E57A0912F7BDE
2020-01-10T18:18:32.640Z,1578680312.640 [Micromodem](INFO): Nmea out: $CCCYC,0,1,12,1,0,1*6B

2020-01-10T18:18:33.639Z,1578680313.639 [Micromodem](INFO): Nmea in: $CACYC,0,1,12,1,0,1*69

2020-01-10T18:18:34.039Z,1578680314.039 [Micromodem](INFO): Nmea in: $CADRQ,181833,1,12,0,64,1*74

2020-01-10T18:18:34.039Z,1578680314.039 [Micromodem](INFO): Nmea out: $CCTXD,1,12,1,36BF185E00000000FA7FE60E0D5D47AA2C6CF0742D99ADF923BFAF757CA1FE5EB2BC855FF4FB6483A9354F8A0A3B09D5FF810E57A0912F7BDE*35

2020-01-10T18:18:34.364Z,1578680314.364 [DataOverHttps](INFO): Sending 233 bytes from file Logs/20200110T181518/Courier0000.lzma
2020-01-10T18:18:34.447Z,1578680314.447 [Micromodem](INFO): Nmea in: $CATXD,1,12,1,57*4B

2020-01-10T18:18:34.847Z,1578680314.847 [Micromodem](INFO): Nmea in: $CATXP,57*70

2020-01-10T18:18:36.059Z,1578680316.059 [Micromodem](INFO): Nmea in: $CATXF,57*66

2020-01-10T18:18:36.370Z,1578680316.370 [DataOverHttps](INFO): Moved sent file to Logs/20200110T181518/Courier0000.lzma.bak
2020-01-10T18:18:36.370Z,1578680316.370 [DataOverHttps](INFO): SBD MOMSN=12190316
2020-01-10T18:18:36.464Z,1578680316.464 [Micromodem](INFO): Nmea in: $CAXST,6,20200110,181835.103278,3,0,200,4000,10000,1,1,12,1,1,1,3,57*4B

2020-01-10T18:18:37.278Z,1578680317.278 [Micromodem](INFO): Nmea in: $CAACK,12,1,1,1*79

2020-01-10T18:18:37.279Z,1578680317.279 [Micromodem](INFO): Sent 49 bytes from file Logs/20200110T181518/Courier0000.lzma.parts
2020-01-10T18:18:37.279Z,1578680317.279 [Micromodem](INFO): Packets left to send: 0
2020-01-10T18:18:37.678Z,1578680317.678 [Micromodem](INFO): Nmea in: $CACST,6,0,20200110181837.114562,06,531,27,0092,0150,59,01,01,00,02,1,012,001,0,4,1,0,150,11.8,7.00,15,-4.00,-01,-0.03,36,10000,4000*48

2020-01-10T18:18:38.820Z,1578680318.820 [Startup:StartupSatComms:B] Stopped
2020-01-10T18:18:38.826Z,1578680318.826 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2020-01-10T18:18:38.826Z,1578680318.826 [Startup:StartupSatComms] Stopped
2020-01-10T18:18:38.826Z,1578680318.826 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2020-01-10T18:18:38.826Z,1578680318.826 [Startup](INFO): Completed Startup
2020-01-10T18:18:38.827Z,1578680318.827 [MissionManager](INFO): Startup is completed.
2020-01-10T18:18:38.827Z,1578680318.827 [MissionManager](INFO): Uninitializing Mission Startup
2020-01-10T18:18:38.827Z,1578680318.827 [Startup] Stopped
2020-01-10T18:18:38.827Z,1578680318.827 [Startup](DEBUG): Aggregate::uninitialize Startup
2020-01-10T18:18:38.827Z,1578680318.827 [Startup:A.GoToSurface] Stopped
2020-01-10T18:18:38.827Z,1578680318.827 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2020-01-10T18:18:39.003Z,1578680319.003 [MissionManager](IMPORTANT): Started mission Default
2020-01-10T18:18:39.003Z,1578680319.003 [Default] Running Loop=1
2020-01-10T18:18:39.003Z,1578680319.003 [Default](DEBUG): Aggregate::initialize Default
2020-01-10T18:18:39.003Z,1578680319.003 [Default:B.GoToSurface] Running Loop=1
2020-01-10T18:18:39.003Z,1578680319.003 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2020-01-10T18:18:39.003Z,1578680319.003 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2020-01-10T18:18:39.004Z,1578680319.004 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2020-01-10T18:18:39.004Z,1578680319.004 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2020-01-10T18:18:39.004Z,1578680319.004 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2020-01-10T18:18:39.013Z,1578680319.013 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2020-01-10T18:18:39.013Z,1578680319.013 [Default:A.Wait] Running Loop=1
2020-01-10T18:18:39.013Z,1578680319.013 [Default:A.Wait](DEBUG): Initialize Wait Component.
2020-01-10T18:18:47.772Z,1578680327.772 [NAL9602](INFO): SBD MO Status=2, MOMSN=10155, MT Status=2, MTMSN=0
2020-01-10T18:18:47.772Z,1578680327.772 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2020-01-10T18:18:52.340Z,1578680332.340 [Default:A.Wait](INFO): Done Waiting.
2020-01-10T18:18:52.340Z,1578680332.340 [Default:A.Wait] Stopped
2020-01-10T18:18:52.340Z,1578680332.340 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2020-01-10T18:18:52.695Z,1578680332.695 [Default:CheckIn] Running Loop=1
2020-01-10T18:18:52.695Z,1578680332.695 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2020-01-10T18:18:52.695Z,1578680332.695 [Default:CheckIn:Read_GPS] Running Loop=1
2020-01-10T18:18:53.108Z,1578680333.108 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2020-01-10T18:19:05.560Z,1578680345.560 [Micromodem](INFO): Nmea in: $CACYC,1,12,1,1,0,1*68

2020-01-10T18:19:05.561Z,1578680345.561 [Micromodem](INFO): Have incoming data
2020-01-10T18:19:05.963Z,1578680345.963 [Micromodem](INFO): Nmea in: $CARXD,12,1,0,1,3D90B8D172D0E11A94BB9A0D6EC0434A2AB488F6*51

2020-01-10T18:19:05.964Z,1578680345.964 [Micromodem](INFO): Frame:1
2020-01-10T18:19:05.965Z,1578680345.965 [Micromodem](INFO): Frame Size:41
2020-01-10T18:19:05.965Z,1578680345.965 [Micromodem](INFO): Data End:57
2020-01-10T18:19:05.965Z,1578680345.965 [Micromodem](INFO): Data At:16
2020-01-10T18:19:05.966Z,1578680345.966 [Micromodem](INFO): Deserialize. FrameCount:1
2020-01-10T18:19:05.966Z,1578680345.966 [Micromodem](INFO): Outer loop. Size:41
2020-01-10T18:19:05.966Z,1578680345.966 [Micromodem](INFO): Inner loop. C:61
2020-01-10T18:19:05.966Z,1578680345.966 [Micromodem](INFO): Inner loop. C:144
2020-01-10T18:19:05.966Z,1578680345.966 [Micromodem](INFO): Inner loop. C:184
2020-01-10T18:19:05.966Z,1578680345.966 [Micromodem](INFO): Inner loop. C:209
2020-01-10T18:19:05.967Z,1578680345.967 [Micromodem](INFO): Inner loop. C:114
2020-01-10T18:19:05.967Z,1578680345.967 [Micromodem](INFO): Inner loop. C:208
2020-01-10T18:19:05.967Z,1578680345.967 [Micromodem](INFO): Inner loop. C:225
2020-01-10T18:19:05.967Z,1578680345.967 [Micromodem](INFO): Inner loop. C:26
2020-01-10T18:19:05.967Z,1578680345.967 [Micromodem](INFO): Inner loop. C:148
2020-01-10T18:19:05.967Z,1578680345.967 [Micromodem](INFO): Inner loop. C:187
2020-01-10T18:19:05.968Z,1578680345.968 [Micromodem](INFO): Inner loop. C:154
2020-01-10T18:19:05.968Z,1578680345.968 [Micromodem](INFO): Inner loop. C:13
2020-01-10T18:19:05.968Z,1578680345.968 [Micromodem](INFO): Inner loop. C:110
2020-01-10T18:19:05.968Z,1578680345.968 [Micromodem](INFO): Inner loop. C:192
2020-01-10T18:19:05.968Z,1578680345.968 [Micromodem](INFO): Inner loop. C:67
2020-01-10T18:19:05.968Z,1578680345.968 [Micromodem](INFO): Inner loop. C:74
2020-01-10T18:19:05.969Z,1578680345.969 [Micromodem](INFO): Inner loop. C:42
2020-01-10T18:19:05.969Z,1578680345.969 [Micromodem](INFO): Inner loop. C:180
2020-01-10T18:19:05.969Z,1578680345.969 [Micromodem](INFO): Inner loop. C:136
2020-01-10T18:19:05.969Z,1578680345.969 [Micromodem](INFO): Inner loop. C:246
2020-01-10T18:19:05.970Z,1578680345.970 [Micromodem](INFO): Sending to RXSBD Size:20
2020-01-10T18:19:05.970Z,1578680345.970 [Micromodem](INFO): Received command:stop
2020-01-10T18:19:05.975Z,1578680345.975 [Micromodem](INFO): Nmea in: $CACST,6,0,20200110181904.655334,06,1692,32,0141,0150,29,01,01,00,03,1,012,001,0,3,1,0,150,5.5,8.00,00,-5.00,-01,-0.01,40,10000,4000*4E

2020-01-10T18:19:06.053Z,1578680346.053 [CommandLine](IMPORTANT): got command stop
2020-01-10T18:19:06.375Z,1578680346.375 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error
2020-01-10T18:19:06.376Z,1578680346.376 [RDI_Pathfinder](ERROR): Failed to parse:
:TS,20011011315726,35.0, -0.1,   0.0  0
2020-01-10T18:19:21.604Z,1578680361.604 [DataOverHttps](INFO): Sending 98 bytes from file Logs/20200109T215323/Express0005.lzma
2020-01-10T18:19:23.610Z,1578680363.610 [DataOverHttps](INFO): Moved sent file to Logs/20200109T215323/Express0005.lzma.bak
2020-01-10T18:19:23.610Z,1578680363.610 [DataOverHttps](INFO): SBD MOMSN=12190326
2020-01-10T18:19:32.621Z,1578680372.621 [NAL9602](INFO): SBD MO Status=2, MOMSN=10155, MT Status=2, MTMSN=0
2020-01-10T18:19:32.621Z,1578680372.621 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2020-01-10T18:19:41.508Z,1578680381.508 [Micromodem](INFO): Nmea in: $CACYC,1,12,1,1,0,1*68

2020-01-10T18:19:41.509Z,1578680381.509 [Micromodem](INFO): Have incoming data
2020-01-10T18:19:41.511Z,1578680381.511 [Micromodem](INFO): Nmea in: $CARXD,12,1,0,1,EA49DA6859B6D6FDD7866B1D923D9D8A099CA094*52

2020-01-10T18:19:41.511Z,1578680381.511 [Micromodem](INFO): Frame:1
2020-01-10T18:19:41.511Z,1578680381.511 [Micromodem](INFO): Frame Size:41
2020-01-10T18:19:41.512Z,1578680381.512 [Micromodem](INFO): Data End:57
2020-01-10T18:19:41.512Z,1578680381.512 [Micromodem](INFO): Data At:16
2020-01-10T18:19:41.512Z,1578680381.512 [Micromodem](INFO): Deserialize. FrameCount:1
2020-01-10T18:19:41.513Z,1578680381.513 [Micromodem](INFO): Outer loop. Size:41
2020-01-10T18:19:41.513Z,1578680381.513 [Micromodem](INFO): Inner loop. C:234
2020-01-10T18:19:41.513Z,1578680381.513 [Micromodem](INFO): Inner loop. C:73
2020-01-10T18:19:41.514Z,1578680381.514 [Micromodem](INFO): Inner loop. C:218
2020-01-10T18:19:41.514Z,1578680381.514 [Micromodem](INFO): Inner loop. C:104
2020-01-10T18:19:41.514Z,1578680381.514 [Micromodem](INFO): Inner loop. C:89
2020-01-10T18:19:41.515Z,1578680381.515 [Micromodem](INFO): Inner loop. C:182
2020-01-10T18:19:41.515Z,1578680381.515 [Micromodem](INFO): Inner loop. C:214
2020-01-10T18:19:41.515Z,1578680381.515 [Micromodem](INFO): Inner loop. C:253
2020-01-10T18:19:41.515Z,1578680381.515 [Micromodem](INFO): Inner loop. C:215
2020-01-10T18:19:41.516Z,1578680381.516 [Micromodem](INFO): Inner loop. C:134
2020-01-10T18:19:41.516Z,1578680381.516 [Micromodem](INFO): Inner loop. C:107
2020-01-10T18:19:41.516Z,1578680381.516 [Micromodem](INFO): Inner loop. C:29
2020-01-10T18:19:41.516Z,1578680381.516 [Micromodem](INFO): Inner loop. C:146
2020-01-10T18:19:41.517Z,1578680381.517 [Micromodem](INFO): Inner loop. C:61
2020-01-10T18:19:41.517Z,1578680381.517 [Micromodem](INFO): Inner loop. C:157
2020-01-10T18:19:41.518Z,1578680381.518 [Micromodem](INFO): Inner loop. C:138
2020-01-10T18:19:41.518Z,1578680381.518 [Micromodem](INFO): Inner loop. C:9
2020-01-10T18:19:41.518Z,1578680381.518 [Micromodem](INFO): Inner loop. C:156
2020-01-10T18:19:41.519Z,1578680381.519 [Micromodem](INFO): Inner loop. C:160
2020-01-10T18:19:41.519Z,1578680381.519 [Micromodem](INFO): Inner loop. C:148
2020-01-10T18:19:41.519Z,1578680381.519 [Micromodem](INFO): Sending to RXSBD Size:20
2020-01-10T18:19:41.520Z,1578680381.520 [Micromodem](INFO): Received command:failc
2020-01-10T18:19:41.566Z,1578680381.566 [CommandLine](IMPORTANT): got command failComponent
2020-01-10T18:19:41.566Z,1578680381.566 [CommandLine](IMPORTANT): Failed components:
2020-01-10T18:19:41.567Z,1578680381.567 [CommandLine](IMPORTANT): DropWeight: Hardware Fault
2020-01-10T18:19:41.919Z,1578680381.919 [Micromodem](INFO): Nmea in: $CACST,6,0,20200110181940.596345,06,1790,32,0141,0150,59,02,02,00,02,1,012,001,0,3,1,0,150,26.5,8.00,00,-5.00,-01,-0.01,24,10000,4000*72

2020-01-10T18:20:02.111Z,1578680402.111 [Micromodem](INFO): Nmea in: $CACYC,1,12,1,1,0,2*6B

2020-01-10T18:20:02.112Z,1578680402.112 [Micromodem](INFO): Have incoming data
2020-01-10T18:20:02.119Z,1578680402.119 [Micromodem](INFO): Nmea in: $CARXD,12,1,0,1,858A1AB878DB70DBE89704525FDC95B5C5FE9F4147C09B083E4A8CE30F9EA23DB7C2EC1A3F0C8416B2D6BA469C63028C955B1EDAD054116D0BA2C541AD2A74E9*5A

2020-01-10T18:20:02.120Z,1578680402.120 [Micromodem](INFO): Frame:1
2020-01-10T18:20:02.120Z,1578680402.120 [Micromodem](INFO): Frame Size:129
2020-01-10T18:20:02.120Z,1578680402.120 [Micromodem](INFO): Data End:145
2020-01-10T18:20:02.120Z,1578680402.120 [Micromodem](INFO): Data At:16
2020-01-10T18:20:02.512Z,1578680402.512 [Micromodem](INFO): Nmea in: $CARXD,12,1,0,2,4EEE1310BA042F91D0BD31A76379D458F2E8C122*52

2020-01-10T18:20:02.513Z,1578680402.513 [Micromodem](INFO): Frame:2
2020-01-10T18:20:02.513Z,1578680402.513 [Micromodem](INFO): Frame Size:41
2020-01-10T18:20:02.514Z,1578680402.514 [Micromodem](INFO): Data End:57
2020-01-10T18:20:02.514Z,1578680402.514 [Micromodem](INFO): Data At:16
2020-01-10T18:20:02.514Z,1578680402.514 [Micromodem](INFO): Deserialize. FrameCount:2
2020-01-10T18:20:02.514Z,1578680402.514 [Micromodem](INFO): Outer loop. Size:129
2020-01-10T18:20:02.514Z,1578680402.514 [Micromodem](INFO): Inner loop. C:133
2020-01-10T18:20:02.514Z,1578680402.514 [Micromodem](INFO): Inner loop. C:138
2020-01-10T18:20:02.515Z,1578680402.515 [Micromodem](INFO): Inner loop. C:26
2020-01-10T18:20:02.515Z,1578680402.515 [Micromodem](INFO): Inner loop. C:184
2020-01-10T18:20:02.515Z,1578680402.515 [Micromodem](INFO): Inner loop. C:120
2020-01-10T18:20:02.515Z,1578680402.515 [Micromodem](INFO): Inner loop. C:219
2020-01-10T18:20:02.515Z,1578680402.515 [Micromodem](INFO): Inner loop. C:112
2020-01-10T18:20:02.516Z,1578680402.516 [Micromodem](INFO): Inner loop. C:219
2020-01-10T18:20:02.516Z,1578680402.516 [Micromodem](INFO): Inner loop. C:232
2020-01-10T18:20:02.516Z,1578680402.516 [Micromodem](INFO): Inner loop. C:151
2020-01-10T18:20:02.516Z,1578680402.516 [Micromodem](INFO): Inner loop. C:4
2020-01-10T18:20:02.516Z,1578680402.516 [Micromodem](INFO): Inner loop. C:82
2020-01-10T18:20:02.516Z,1578680402.516 [Micromodem](INFO): Inner loop. C:95
2020-01-10T18:20:02.517Z,1578680402.517 [Micromodem](INFO): Inner loop. C:220
2020-01-10T18:20:02.517Z,1578680402.517 [Micromodem](INFO): Inner loop. C:149
2020-01-10T18:20:02.517Z,1578680402.517 [Micromodem](INFO): Inner loop. C:181
2020-01-10T18:20:02.517Z,1578680402.517 [Micromodem](INFO): Inner loop. C:197
2020-01-10T18:20:02.518Z,1578680402.518 [Micromodem](INFO): Inner loop. C:254
2020-01-10T18:20:02.518Z,1578680402.518 [Micromodem](INFO): Inner loop. C:159
2020-01-10T18:20:02.518Z,1578680402.518 [Micromodem](INFO): Inner loop. C:65
2020-01-10T18:20:02.518Z,1578680402.518 [Micromodem](INFO): Inner loop. C:71
2020-01-10T18:20:02.518Z,1578680402.518 [Micromodem](INFO): Inner loop. C:192
2020-01-10T18:20:02.518Z,1578680402.518 [Micromodem](INFO): Inner loop. C:155
2020-01-10T18:20:02.519Z,1578680402.519 [Micromodem](INFO): Inner loop. C:8
2020-01-10T18:20:02.519Z,1578680402.519 [Micromodem](INFO): Inner loop. C:62
2020-01-10T18:20:02.519Z,1578680402.519 [Micromodem](INFO): Inner loop. C:74
2020-01-10T18:20:02.519Z,1578680402.519 [Micromodem](INFO): Inner loop. C:140
2020-01-10T18:20:02.519Z,1578680402.519 [Micromodem](INFO): Inner loop. C:227
2020-01-10T18:20:02.520Z,1578680402.520 [Micromodem](INFO): Inner loop. C:15
2020-01-10T18:20:02.520Z,1578680402.520 [Micromodem](INFO): Inner loop. C:158
2020-01-10T18:20:02.520Z,1578680402.520 [Micromodem](INFO): Inner loop. C:162
2020-01-10T18:20:02.520Z,1578680402.520 [Micromodem](INFO): Inner loop. C:61
2020-01-10T18:20:02.520Z,1578680402.520 [Micromodem](INFO): Inner loop. C:183
2020-01-10T18:20:02.520Z,1578680402.520 [Micromodem](INFO): Inner loop. C:194
2020-01-10T18:20:02.521Z,1578680402.521 [Micromodem](INFO): Inner loop. C:236
2020-01-10T18:20:02.521Z,1578680402.521 [Micromodem](INFO): Inner loop. C:26
2020-01-10T18:20:02.521Z,1578680402.521 [Micromodem](INFO): Inner loop. C:63
2020-01-10T18:20:02.521Z,1578680402.521 [Micromodem](INFO): Inner loop. C:12
2020-01-10T18:20:02.522Z,1578680402.522 [Micromodem](INFO): Inner loop. C:132
2020-01-10T18:20:02.522Z,1578680402.522 [Micromodem](INFO): Inner loop. C:22
2020-01-10T18:20:02.522Z,1578680402.522 [Micromodem](INFO): Inner loop. C:178
2020-01-10T18:20:02.522Z,1578680402.522 [Micromodem](INFO): Inner loop. C:214
2020-01-10T18:20:02.522Z,1578680402.522 [Micromodem](INFO): Inner loop. C:186
2020-01-10T18:20:02.522Z,1578680402.522 [Micromodem](INFO): Inner loop. C:70
2020-01-10T18:20:02.523Z,1578680402.523 [Micromodem](INFO): Inner loop. C:156
2020-01-10T18:20:02.523Z,1578680402.523 [Micromodem](INFO): Inner loop. C:99
2020-01-10T18:20:02.523Z,1578680402.523 [Micromodem](INFO): Inner loop. C:2
2020-01-10T18:20:02.523Z,1578680402.523 [Micromodem](INFO): Inner loop. C:140
2020-01-10T18:20:02.523Z,1578680402.523 [Micromodem](INFO): Inner loop. C:149
2020-01-10T18:20:02.523Z,1578680402.523 [Micromodem](INFO): Inner loop. C:91
2020-01-10T18:20:02.524Z,1578680402.524 [Micromodem](INFO): Inner loop. C:30
2020-01-10T18:20:02.524Z,1578680402.524 [Micromodem](INFO): Inner loop. C:218
2020-01-10T18:20:02.524Z,1578680402.524 [Micromodem](INFO): Inner loop. C:208
2020-01-10T18:20:02.524Z,1578680402.524 [Micromodem](INFO): Inner loop. C:84
2020-01-10T18:20:02.524Z,1578680402.524 [Micromodem](INFO): Inner loop. C:17
2020-01-10T18:20:02.525Z,1578680402.525 [Micromodem](INFO): Inner loop. C:109
2020-01-10T18:20:02.525Z,1578680402.525 [Micromodem](INFO): Inner loop. C:11
2020-01-10T18:20:02.525Z,1578680402.525 [Micromodem](INFO): Inner loop. C:162
2020-01-10T18:20:02.525Z,1578680402.525 [Micromodem](INFO): Inner loop. C:197
2020-01-10T18:20:02.525Z,1578680402.525 [Micromodem](INFO): Inner loop. C:65
2020-01-10T18:20:02.526Z,1578680402.526 [Micromodem](INFO): Inner loop. C:173
2020-01-10T18:20:02.526Z,1578680402.526 [Micromodem](INFO): Inner loop. C:42
2020-01-10T18:20:02.526Z,1578680402.526 [Micromodem](INFO): Inner loop. C:116
2020-01-10T18:20:02.526Z,1578680402.526 [Micromodem](INFO): Inner loop. C:233
2020-01-10T18:20:02.526Z,1578680402.526 [Micromodem](INFO): Outer loop. Size:41
2020-01-10T18:20:02.527Z,1578680402.527 [Micromodem](INFO): Inner loop. C:78
2020-01-10T18:20:02.527Z,1578680402.527 [Micromodem](INFO): Inner loop. C:238
2020-01-10T18:20:02.527Z,1578680402.527 [Micromodem](INFO): Inner loop. C:19
2020-01-10T18:20:02.527Z,1578680402.527 [Micromodem](INFO): Inner loop. C:16
2020-01-10T18:20:02.527Z,1578680402.527 [Micromodem](INFO): Inner loop. C:186
2020-01-10T18:20:02.527Z,1578680402.527 [Micromodem](INFO): Inner loop. C:4
2020-01-10T18:20:02.528Z,1578680402.528 [Micromodem](INFO): Inner loop. C:47
2020-01-10T18:20:02.528Z,1578680402.528 [Micromodem](INFO): Inner loop. C:145
2020-01-10T18:20:02.528Z,1578680402.528 [Micromodem](INFO): Inner loop. C:208
2020-01-10T18:20:02.528Z,1578680402.528 [Micromodem](INFO): Inner loop. C:189
2020-01-10T18:20:02.528Z,1578680402.528 [Micromodem](INFO): Inner loop. C:49
2020-01-10T18:20:02.529Z,1578680402.529 [Micromodem](INFO): Inner loop. C:167
2020-01-10T18:20:02.529Z,1578680402.529 [Micromodem](INFO): Inner loop. C:99
2020-01-10T18:20:02.529Z,1578680402.529 [Micromodem](INFO): Inner loop. C:121
2020-01-10T18:20:02.529Z,1578680402.529 [Micromodem](INFO): Inner loop. C:212
2020-01-10T18:20:02.529Z,1578680402.529 [Micromodem](INFO): Inner loop. C:88
2020-01-10T18:20:02.530Z,1578680402.530 [Micromodem](INFO): Inner loop. C:242
2020-01-10T18:20:02.530Z,1578680402.530 [Micromodem](INFO): Inner loop. C:232
2020-01-10T18:20:02.530Z,1578680402.530 [Micromodem](INFO): Inner loop. C:193
2020-01-10T18:20:02.530Z,1578680402.530 [Micromodem](INFO): Inner loop. C:34
2020-01-10T18:20:02.530Z,1578680402.530 [Micromodem](INFO): Sending to RXSBD Size:84
2020-01-10T18:20:02.531Z,1578680402.531 [Micromodem](INFO): Received command:failc;stop;configSet list;get platform_orientation degree;stop;failc
2020-01-10T18:20:06.223Z,1578680406.223 [CommandLine](IMPORTANT): got command failComponent
2020-01-10T18:20:06.223Z,1578680406.223 [CommandLine](IMPORTANT): Failed components:
2020-01-10T18:20:06.223Z,1578680406.223 [CommandLine](IMPORTANT): DropWeight: Hardware Fault
2020-01-10T18:20:06.223Z,1578680406.223 [CommandLine](IMPORTANT): got command stop
2020-01-10T18:20:06.223Z,1578680406.223 [CommandLine](IMPORTANT): got command configSet list
2020-01-10T18:20:06.224Z,1578680406.224 [CommandLine](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2020-01-10T18:20:06.225Z,1578680406.225 [CommandLine](IMPORTANT): DDM.loadAtStartup=1 bool;

2020-01-10T18:20:06.225Z,1578680406.225 [CommandLine](IMPORTANT): DDM.verbosity=3 count;

2020-01-10T18:20:06.225Z,1578680406.225 [CommandLine](IMPORTANT): DUSBL_Hydroid.detectionThreshold=75 count;

2020-01-10T18:20:06.225Z,1578680406.225 [CommandLine](IMPORTANT): DUSBL_Hydroid.transmitLockout=40 millisecond;

2020-01-10T18:20:06.225Z,1578680406.225 [CommandLine](IMPORTANT): Express linearApproximation DDM.DDMMode 1.000000 count;

2020-01-10T18:20:06.225Z,1578680406.225 [CommandLine](IMPORTANT): Express all DDM.cablePresent;

2020-01-10T18:20:06.225Z,1578680406.225 [CommandLine](IMPORTANT): Express linearApproximation DDM.latchState 1.000000 count;

2020-01-10T18:20:06.225Z,1578680406.225 [CommandLine](IMPORTANT): Express linearApproximation DDM.whiskerState 1.000000 count;

2020-01-10T18:20:06.226Z,1578680406.226 [CommandLine](IMPORTANT): Express linearApproximation DUSBL_Hydroid.acoustic_contact_range 1.000000 meter;

2020-01-10T18:20:06.226Z,1578680406.226 [CommandLine](IMPORTANT): Express linearApproximation DUSBL_Hydroid.xAngle 2.000000 degree;

2020-01-10T18:20:06.226Z,1578680406.226 [CommandLine](IMPORTANT): Express linearApproximation RDI_Pathfinder.height_above_sea_floor 2.000000 meter;

2020-01-10T18:20:06.226Z,1578680406.226 [CommandLine](IMPORTANT): Express linearApproximation platform_orientation 5.000000 degree;

2020-01-10T18:20:06.226Z,1578680406.226 [CommandLine](IMPORTANT): Express linearApproximation platform_x_velocity_wrt_ground 0.100000 meter_per_second;

2020-01-10T18:20:06.226Z,1578680406.226 [CommandLine](IMPORTANT): Express linearApproximation platform_y_velocity_wrt_ground 0.100000 meter_per_second;

2020-01-10T18:20:06.226Z,1578680406.226 [CommandLine](IMPORTANT): HorizontalControl.kiHeading=0.002 reciprocal_second;

2020-01-10T18:20:06.226Z,1578680406.226 [CommandLine](IMPORTANT): HorizontalControl.kpHeading=0.8 none;

2020-01-10T18:20:06.226Z,1578680406.226 [CommandLine](IMPORTANT): HorizontalControl.rudDeadband=0.05 degree;

2020-01-10T18:20:06.227Z,1578680406.227 [CommandLine](IMPORTANT): Micromodem.destinationAddress=12 enum;

2020-01-10T18:20:06.227Z,1578680406.227 [CommandLine](IMPORTANT): Micromodem.surfaceThreshold=0 meter;

2020-01-10T18:20:06.227Z,1578680406.227 [CommandLine](IMPORTANT): PowerOnly.sampleTime=90 second;

2020-01-10T18:20:06.227Z,1578680406.227 [CommandLine](IMPORTANT): RudderServo.deviationAngle=0.0001 degree;

2020-01-10T18:20:06.227Z,1578680406.227 [CommandLine](IMPORTANT): VerticalControl.buoyancyNeutral=105 cubic_centimeter;

2020-01-10T18:20:06.227Z,1578680406.227 [CommandLine](IMPORTANT): VerticalControl.massDefault=-5 millimeter;

2020-01-10T18:20:06.228Z,1578680406.228 [CommandLine](IMPORTANT): got command get platform_orientation degree
2020-01-10T18:20:06.228Z,1578680406.228 [CommandLine](IMPORTANT): platform_orientation 72.879628 arcdeg
2020-01-10T18:20:06.228Z,1578680406.228 [CommandLine](IMPORTANT): got command stop
2020-01-10T18:20:06.229Z,1578680406.229 [CommandLine](IMPORTANT): got command failComponent
2020-01-10T18:20:06.229Z,1578680406.229 [CommandLine](IMPORTANT): Failed components:
2020-01-10T18:20:06.229Z,1578680406.229 [CommandLine](IMPORTANT): DropWeight: Hardware Fault
2020-01-10T18:20:06.234Z,1578680406.234 [Micromodem](INFO): Nmea in: $CACST,6,0,20200110181959.813495,06,1818,32,0141,0150,29,01,01,00,04,1,012,001,0,3,2,0,150,8.8,8.00,00,-5.00,-01,-0.02,37,10000,4000*4D

2020-01-10T18:20:06.236Z,1578680406.236 [NAL9602](INFO): SBD MO Status=2, MOMSN=10155, MT Status=2, MTMSN=0
2020-01-10T18:20:06.237Z,1578680406.237 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2020-01-10T18:20:31.128Z,1578680431.128 [NAL9602](INFO): SBD MO Status=0, MOMSN=10155, MT Status=0, MTMSN=0
2020-01-10T18:20:31.128Z,1578680431.128 [NAL9602](INFO): No messages in MT queue
2020-01-10T18:20:37.601Z,1578680437.601 [Micromodem](INFO): Nmea in: $CACYC,1,12,1,1,0,1*68

2020-01-10T18:20:37.601Z,1578680437.601 [Micromodem](INFO): Have incoming data
2020-01-10T18:20:37.604Z,1578680437.604 [Micromodem](INFO): Nmea in: $CARXD,12,1,0,1,3D90B8D172D0E11A94BB9A0D6EC0434A2AB488F6*51

2020-01-10T18:20:37.604Z,1578680437.604 [Micromodem](INFO): Frame:1
2020-01-10T18:20:37.605Z,1578680437.605 [Micromodem](INFO): Frame Size:41
2020-01-10T18:20:37.605Z,1578680437.605 [Micromodem](INFO): Data End:57
2020-01-10T18:20:37.605Z,1578680437.605 [Micromodem](INFO): Data At:16
2020-01-10T18:20:37.605Z,1578680437.605 [Micromodem](INFO): Deserialize. FrameCount:1
2020-01-10T18:20:37.605Z,1578680437.605 [Micromodem](INFO): Outer loop. Size:41
2020-01-10T18:20:37.606Z,1578680437.606 [Micromodem](INFO): Inner loop. C:61
2020-01-10T18:20:37.606Z,1578680437.606 [Micromodem](INFO): Inner loop. C:144
2020-01-10T18:20:37.606Z,1578680437.606 [Micromodem](INFO): Inner loop. C:184
2020-01-10T18:20:37.606Z,1578680437.606 [Micromodem](INFO): Inner loop. C:209
2020-01-10T18:20:37.606Z,1578680437.606 [Micromodem](INFO): Inner loop. C:114
2020-01-10T18:20:37.607Z,1578680437.607 [Micromodem](INFO): Inner loop. C:208
2020-01-10T18:20:37.607Z,1578680437.607 [Micromodem](INFO): Inner loop. C:225
2020-01-10T18:20:37.607Z,1578680437.607 [Micromodem](INFO): Inner loop. C:26
2020-01-10T18:20:37.607Z,1578680437.607 [Micromodem](INFO): Inner loop. C:148
2020-01-10T18:20:37.607Z,1578680437.607 [Micromodem](INFO): Inner loop. C:187
2020-01-10T18:20:37.607Z,1578680437.607 [Micromodem](INFO): Inner loop. C:154
2020-01-10T18:20:37.608Z,1578680437.608 [Micromodem](INFO): Inner loop. C:13
2020-01-10T18:20:37.608Z,1578680437.608 [Micromodem](INFO): Inner loop. C:110
2020-01-10T18:20:37.608Z,1578680437.608 [Micromodem](INFO): Inner loop. C:192
2020-01-10T18:20:37.608Z,1578680437.608 [Micromodem](INFO): Inner loop. C:67
2020-01-10T18:20:37.608Z,1578680437.608 [Micromodem](INFO): Inner loop. C:74
2020-01-10T18:20:37.609Z,1578680437.609 [Micromodem](INFO): Inner loop. C:42
2020-01-10T18:20:37.609Z,1578680437.609 [Micromodem](INFO): Inner loop. C:180
2020-01-10T18:20:37.609Z,1578680437.609 [Micromodem](INFO): Inner loop. C:136
2020-01-10T18:20:37.609Z,1578680437.609 [Micromodem](INFO): Inner loop. C:246
2020-01-10T18:20:37.610Z,1578680437.610 [Micromodem](INFO): Sending to RXSBD Size:20
2020-01-10T18:20:37.610Z,1578680437.610 [Micromodem](INFO): Received command:stop
2020-01-10T18:20:37.673Z,1578680437.673 [CommandLine](IMPORTANT): got command stop
2020-01-10T18:20:37.986Z,1578680437.986 [Micromodem](INFO): Nmea in: $CACST,6,0,20200110182036.575483,06,1892,32,0148,0150,59,02,02,00,04,1,012,001,0,3,1,0,150,27.4,8.00,00,-5.00,-01,-0.02,24,10000,4000*78

2020-01-10T18:20:42.071Z,1578680442.071 [CommandLine](IMPORTANT): got command restart application
2020-01-10T18:20:42.077Z,1578680442.077 [RDI_Pathfinder](ERROR): Failed to parse:
:SA,   +0.00,   +0.00,  0.00
2020-01-10T18:20:43.077Z,1578680443.077 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2020-01-10T18:20:43.077Z,1578680443.077 [CommandLine ThreadHandler](INFO): Thread cancelled.
2020-01-10T18:20:43.197Z,1578680443.197 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup.  Bye!
2020-01-10T18:20:43.197Z,1578680443.197 [CommandLine ThreadHandler](INFO): Thread cancelled.
2020-01-10T18:20:43.198Z,1578680443.198 [CommandLine](INFO): Join timeout helper Thread ID is 4774
2020-01-10T18:20:43.198Z,1578680443.198 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2020-01-10T18:20:43.198Z,1578680443.198 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2020-01-10T18:20:43.199Z,1578680443.199 [NavChartDb](INFO): Join timeout helper Thread ID is 4775
2020-01-10T18:20:43.437Z,1578680443.437 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2020-01-10T18:20:43.438Z,1578680443.438 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2020-01-10T18:20:43.441Z,1578680443.441 [ComponentRegistry](INFO): Shutting down WetLabsSeaOWL_UV_A ThreadHandler
2020-01-10T18:20:43.441Z,1578680443.441 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Thread cancelled.
2020-01-10T18:20:43.441Z,1578680443.441 [WetLabsSeaOWL_UV_A](INFO): Join timeout helper Thread ID is 4776
2020-01-10T18:20:43.821Z,1578680443.821 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Uninitializing protected caller thread.
2020-01-10T18:20:43.821Z,1578680443.821 [WetLabsSeaOWL_UV_A](INFO): Powering down
2020-01-10T18:20:43.822Z,1578680443.822 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Thread cancelled.
2020-01-10T18:20:43.825Z,1578680443.825 [ComponentRegistry](INFO): Shutting down CTD_NeilBrown ThreadHandler
2020-01-10T18:20:43.825Z,1578680443.825 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled.
2020-01-10T18:20:43.825Z,1578680443.825 [CTD_NeilBrown](INFO): Join timeout helper Thread ID is 4777
2020-01-10T18:20:43.921Z,1578680443.921 [CTD_NeilBrown ThreadHandler](INFO): Uninitializing protected caller thread.
2020-01-10T18:20:43.921Z,1578680443.921 [CTD_NeilBrown](INFO): Powering down
2020-01-10T18:20:43.933Z,1578680443.933 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled.
2020-01-10T18:20:43.945Z,1578680443.945 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2020-01-10T18:20:43.945Z,1578680443.945 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2020-01-10T18:20:43.945Z,1578680443.945 [Radio_Surface](INFO): Join timeout helper Thread ID is 4778
2020-01-10T18:20:44.085Z,1578680444.085 [Radio_Surface](INFO): Powering down
2020-01-10T18:20:44.086Z,1578680444.086 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2020-01-10T18:20:44.086Z,1578680444.086 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2020-01-10T18:20:44.090Z,1578680444.090 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler
2020-01-10T18:20:44.090Z,1578680444.090 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2020-01-10T18:20:44.090Z,1578680444.090 [DataOverHttps](INFO): Join timeout helper Thread ID is 4779
2020-01-10T18:20:44.605Z,1578680444.605 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread.
2020-01-10T18:20:44.605Z,1578680444.605 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2020-01-10T18:20:44.621Z,1578680444.621 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2020-01-10T18:20:44.622Z,1578680444.622 [logger ThreadHandler](INFO): Thread cancelled.
2020-01-10T18:20:44.622Z,1578680444.622 [logger](INFO): Join timeout helper Thread ID is 4780
2020-01-10T18:20:44.633Z,1578680444.633 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2020-01-10T18:20:44.633Z,1578680444.633 [logger ThreadHandler](INFO): Thread cancelled.
2020-01-10T18:20:44.641Z,1578680444.641 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2020-01-10T18:20:44.642Z,1578680444.642 [CommandLine ThreadHandler](INFO): Thread cancelled.
2020-01-10T18:20:44.642Z,1578680444.642 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2020-01-10T18:20:44.642Z,1578680444.642 [controlThread ThreadHandler](INFO): Thread cancelled.
2020-01-10T18:20:44.642Z,1578680444.642 [controlThread](INFO): Join timeout helper Thread ID is 4781
2020-01-10T18:20:44.837Z,1578680444.837 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2020-01-10T18:20:44.837Z,1578680444.837 [controlThread](DEBUG): Uninitializing ControlThread
2020-01-10T18:20:44.838Z,1578680444.838 [AHRS_M2](INFO): Powering down
2020-01-10T18:20:44.909Z,1578680444.909 [DDM](INFO): Powering down
2020-01-10T18:20:45.003Z,1578680445.003 [DUSBL_Hydroid](INFO): Powering down
2020-01-10T18:20:45.105Z,1578680445.105 [Micromodem](INFO): Powering down
2020-01-10T18:20:45.201Z,1578680445.201 [NAL9602](INFO): Powering down
2020-01-10T18:20:45.273Z,1578680445.273 [RDI_Pathfinder](INFO): Powering down
2020-01-10T18:20:45.275Z,1578680445.275 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2020-01-10T18:20:45.276Z,1578680445.276 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2020-01-10T18:20:45.276Z,1578680445.276 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2020-01-10T18:20:45.277Z,1578680445.277 [MissionManager](INFO): Uninitializing Mission Default
2020-01-10T18:20:45.277Z,1578680445.277 [Default] Stopped
2020-01-10T18:20:45.277Z,1578680445.277 [Default](DEBUG): Aggregate::uninitialize Default
2020-01-10T18:20:45.277Z,1578680445.277 [Default:B.GoToSurface] Stopped
2020-01-10T18:20:45.277Z,1578680445.277 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2020-01-10T18:20:45.277Z,1578680445.277 [Default:CheckIn] Stopped
2020-01-10T18:20:45.277Z,1578680445.277 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2020-01-10T18:20:45.277Z,1578680445.277 [Default:CheckIn:Read_GPS] Stopped
2020-01-10T18:20:45.280Z,1578680445.280 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2020-01-10T18:20:45.280Z,1578680445.280 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2020-01-10T18:20:45.280Z,1578680445.280 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2020-01-10T18:20:45.281Z,1578680445.281 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2020-01-10T18:20:45.281Z,1578680445.281 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2020-01-10T18:20:45.281Z,1578680445.281 [BuoyancyServo](INFO): Powering down
2020-01-10T18:20:45.293Z,1578680445.293 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2020-01-10T18:20:45.293Z,1578680445.293 [ElevatorServo](INFO): Powering down
2020-01-10T18:20:45.294Z,1578680445.294 [MassServo](DEBUG): Uninitialize Mass Servo.
2020-01-10T18:20:45.294Z,1578680445.294 [MassServo](INFO): Powering down
2020-01-10T18:20:45.295Z,1578680445.295 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2020-01-10T18:20:45.295Z,1578680445.295 [RudderServo](INFO): Powering down
2020-01-10T18:20:45.295Z,1578680445.295 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2020-01-10T18:20:45.296Z,1578680445.296 [ThrusterServo](INFO): Powering down
2020-01-10T18:20:45.296Z,1578680445.296 [SBIT](DEBUG): Uninitialize SBIT Component.
2020-01-10T18:20:45.297Z,1578680445.297 [IBIT](DEBUG): Uninitialize IBIT Component.
2020-01-10T18:20:45.297Z,1578680445.297 [CBIT](DEBUG): Uninitialize CBIT Component.
2020-01-10T18:20:45.297Z,1578680445.297 [CBIT](DEBUG): Powering off loads.
2020-01-10T18:20:45.309Z,1578680445.309 [CBIT](DEBUG): Disabling WDT.
2020-01-10T18:20:45.321Z,1578680445.321 [CBIT](DEBUG): Opening all GF detection circuits.
2020-01-10T18:20:45.322Z,1578680445.322 [controlThread ThreadHandler](INFO): Thread cancelled.
2020-01-10T18:20:45.380Z,1578680445.380 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2020-01-10T18:20:45.391Z,1578680445.391 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2020-01-10T18:20:45.434Z,1578680445.434 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Thread cancelled.
2020-01-10T18:20:45.436Z,1578680445.436 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled.
2020-01-10T18:20:45.496Z,1578680445.496 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2020-01-10T18:20:45.557Z,1578680445.557 [logger ThreadHandler](INFO): Thread cancelled.