2020-01-15T23:06:13.707Z,1579129573.707 [Supervisor](DEBUG): Initializing supervisor. 2020-01-15T23:06:13.709Z,1579129573.709 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2020-01-15T23:06:13.710Z,1579129573.710 [SyncHandler](INFO): Protected caller Thread ID is 5576 2020-01-15T23:06:13.710Z,1579129573.710 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2020-01-15T23:06:13.711Z,1579129573.711 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2020-01-15T23:06:13.712Z,1579129573.712 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 5577 2020-01-15T23:06:13.714Z,1579129573.714 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2020-01-15T23:06:13.725Z,1579129573.725 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2020-01-15T23:06:13.726Z,1579129573.726 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2020-01-15T23:06:13.726Z,1579129573.726 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 5578 2020-01-15T23:06:13.727Z,1579129573.727 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2020-01-15T23:06:13.728Z,1579129573.728 [logger ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2020-01-15T23:06:13.728Z,1579129573.728 [logger ThreadHandler](INFO): Protected caller Thread ID is 5579 2020-01-15T23:06:13.730Z,1579129573.730 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2020-01-15T23:06:13.731Z,1579129573.731 [Supervisor](INFO): Looking for Config files in directory: Config/ 2020-01-15T23:06:13.732Z,1579129573.732 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2020-01-15T23:06:14.156Z,1579129574.156 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2020-01-15T23:06:14.156Z,1579129574.156 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2020-01-15T23:06:14.251Z,1579129574.251 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample 2020-01-15T23:06:14.251Z,1579129574.251 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2020-01-15T23:06:14.553Z,1579129574.553 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2020-01-15T23:06:14.554Z,1579129574.554 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2020-01-15T23:06:14.688Z,1579129574.688 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2020-01-15T23:06:14.689Z,1579129574.689 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2020-01-15T23:06:14.922Z,1579129574.922 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2020-01-15T23:06:14.922Z,1579129574.922 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2020-01-15T23:06:15.351Z,1579129575.351 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2020-01-15T23:06:15.351Z,1579129575.351 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2020-01-15T23:06:15.555Z,1579129575.555 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2020-01-15T23:06:15.555Z,1579129575.555 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2020-01-15T23:06:15.694Z,1579129575.694 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2020-01-15T23:06:15.695Z,1579129575.695 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2020-01-15T23:06:15.874Z,1579129575.874 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2020-01-15T23:06:15.874Z,1579129575.874 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2020-01-15T23:06:15.968Z,1579129575.968 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2020-01-15T23:06:15.968Z,1579129575.968 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2020-01-15T23:06:16.307Z,1579129576.307 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2020-01-15T23:06:16.308Z,1579129576.308 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2020-01-15T23:06:16.589Z,1579129576.589 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2020-01-15T23:06:16.849Z,1579129576.849 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2020-01-15T23:06:16.850Z,1579129576.850 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2020-01-15T23:06:17.591Z,1579129577.591 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2020-01-15T23:06:17.592Z,1579129577.592 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2020-01-15T23:06:17.987Z,1579129577.987 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2020-01-15T23:06:17.989Z,1579129577.989 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-whoidhs/ 2020-01-15T23:06:17.990Z,1579129577.990 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/vehicle.cfg 2020-01-15T23:06:18.187Z,1579129578.187 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Control.cfg 2020-01-15T23:06:18.282Z,1579129578.282 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/BIT.cfg 2020-01-15T23:06:18.378Z,1579129578.378 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Battery.cfg 2020-01-15T23:06:18.598Z,1579129578.598 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2020-01-15T23:06:18.598Z,1579129578.598 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Simulator.cfg 2020-01-15T23:06:18.680Z,1579129578.680 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Navigation.cfg 2020-01-15T23:06:18.771Z,1579129578.771 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/logger.cfg 2020-01-15T23:06:18.867Z,1579129578.867 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/secure.cfg 2020-01-15T23:06:18.948Z,1579129578.948 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Servo.cfg 2020-01-15T23:06:19.052Z,1579129579.052 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Sensor.cfg 2020-01-15T23:06:19.228Z,1579129579.228 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Science.cfg 2020-01-15T23:06:19.354Z,1579129579.354 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-whoidhs/root/ 2020-01-15T23:06:19.354Z,1579129579.354 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg 2020-01-15T23:06:19.369Z,1579129579.369 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2020-01-15T23:06:19.668Z,1579129579.668 [AHRS_M2](DEBUG): LcmSlateWriter::add(): platform_orientation 2020-01-15T23:06:19.673Z,1579129579.673 [AHRS_M2](INFO): created writer for : platform_orientation 2020-01-15T23:06:19.675Z,1579129579.675 [AHRS_M2](DEBUG): LcmSlateWriter::add(): platform_magnetic_orientation 2020-01-15T23:06:19.679Z,1579129579.679 [AHRS_M2](INFO): created writer for : platform_magnetic_orientation 2020-01-15T23:06:19.680Z,1579129579.680 [AHRS_M2](DEBUG): LcmSlateWriter::add(): platform_pitch_angle 2020-01-15T23:06:19.685Z,1579129579.685 [AHRS_M2](INFO): created writer for : platform_pitch_angle 2020-01-15T23:06:19.686Z,1579129579.686 [AHRS_M2](DEBUG): LcmSlateWriter::add(): platform_roll_angle 2020-01-15T23:06:19.690Z,1579129579.690 [AHRS_M2](INFO): created writer for : platform_roll_angle 2020-01-15T23:06:19.758Z,1579129579.758 [AHRS_M2] Loaded 2020-01-15T23:06:19.758Z,1579129579.758 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread. 2020-01-15T23:06:19.836Z,1579129579.836 [DataOverHttps] Loaded 2020-01-15T23:06:19.836Z,1579129579.836 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread. 2020-01-15T23:06:19.837Z,1579129579.837 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 4076F4E0 2020-01-15T23:06:19.837Z,1579129579.837 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 5658 2020-01-15T23:06:19.860Z,1579129579.860 [DDM] Loaded 2020-01-15T23:06:19.860Z,1579129579.860 [ComponentRegistry](DEBUG): SyncComponent "DDM" handled in the control thread. 2020-01-15T23:06:19.901Z,1579129579.901 [Depth_Keller] Loaded 2020-01-15T23:06:19.901Z,1579129579.901 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2020-01-15T23:06:19.935Z,1579129579.935 [DropWeight] Loaded 2020-01-15T23:06:19.936Z,1579129579.936 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread. 2020-01-15T23:06:20.127Z,1579129580.127 [DUSBL_Hydroid] Loaded 2020-01-15T23:06:20.127Z,1579129580.127 [ComponentRegistry](DEBUG): SyncComponent "DUSBL_Hydroid" handled in the control thread. 2020-01-15T23:06:20.294Z,1579129580.294 [Micromodem] Loaded 2020-01-15T23:06:20.294Z,1579129580.294 [ComponentRegistry](DEBUG): SyncComponent "Micromodem" handled in the control thread. 2020-01-15T23:06:20.386Z,1579129580.386 [NAL9602] Loaded 2020-01-15T23:06:20.387Z,1579129580.387 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2020-01-15T23:06:20.422Z,1579129580.422 [Onboard](ERROR): Can't open SysFS node file: /sys/class/power_supply/ds2782-0/voltage_now 2020-01-15T23:06:20.422Z,1579129580.422 [Onboard](ERROR): Can't open SysFS node file: /sys/class/power_supply/ds2782-0/current_now 2020-01-15T23:06:20.423Z,1579129580.423 [Onboard](ERROR): Can't open SysFS node file: /sys/class/power_supply/ds2782-0/charge_now 2020-01-15T23:06:20.423Z,1579129580.423 [Onboard](ERROR): Can't open SysFS node file: /sys/class/power_supply/ds2782-0/charge_full 2020-01-15T23:06:20.424Z,1579129580.424 [Onboard](ERROR): Can't open SysFS node file: /sys/class/power_supply/ds2782-1/voltage_now 2020-01-15T23:06:20.424Z,1579129580.424 [Onboard](ERROR): Can't open SysFS node file: /sys/class/power_supply/ds2782-1/current_now 2020-01-15T23:06:20.425Z,1579129580.425 [Onboard](ERROR): Can't open SysFS node file: /sys/class/power_supply/ds2782-1/charge_now 2020-01-15T23:06:20.425Z,1579129580.425 [Onboard](ERROR): Can't open SysFS node file: /sys/class/power_supply/ds2782-1/charge_full 2020-01-15T23:06:20.426Z,1579129580.426 [Onboard] Loaded 2020-01-15T23:06:20.426Z,1579129580.426 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread. 2020-01-15T23:06:20.431Z,1579129580.431 [PowerOnly] Loaded 2020-01-15T23:06:20.432Z,1579129580.432 [ComponentRegistry](DEBUG): SyncComponent "PowerOnly" handled in the control thread. 2020-01-15T23:06:20.473Z,1579129580.473 [RDI_Pathfinder] Loaded 2020-01-15T23:06:20.473Z,1579129580.473 [ComponentRegistry](DEBUG): SyncComponent "RDI_Pathfinder" handled in the control thread. 2020-01-15T23:06:22.498Z,1579129582.498 [BPC1] Loaded 2020-01-15T23:06:22.498Z,1579129582.498 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2020-01-15T23:06:22.499Z,1579129582.499 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2020-01-15T23:06:22.499Z,1579129582.499 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2020-01-15T23:06:22.512Z,1579129582.512 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2020-01-15T23:06:22.512Z,1579129582.512 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2020-01-15T23:06:22.616Z,1579129582.616 [DeadReckonUsingMultipleVelocitySources] Loaded 2020-01-15T23:06:22.617Z,1579129582.617 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2020-01-15T23:06:22.636Z,1579129582.636 [NavChart] Loaded 2020-01-15T23:06:22.636Z,1579129582.636 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2020-01-15T23:06:22.640Z,1579129582.640 [UniversalFixResidualReporter] Loaded 2020-01-15T23:06:22.641Z,1579129582.641 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2020-01-15T23:06:22.641Z,1579129582.641 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2020-01-15T23:06:22.641Z,1579129582.641 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2020-01-15T23:06:22.746Z,1579129582.746 [BuoyancyServo] Loaded 2020-01-15T23:06:22.746Z,1579129582.746 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2020-01-15T23:06:22.761Z,1579129582.761 [ElevatorServo] Loaded 2020-01-15T23:06:22.761Z,1579129582.761 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2020-01-15T23:06:22.775Z,1579129582.775 [MassServo] Loaded 2020-01-15T23:06:22.776Z,1579129582.776 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2020-01-15T23:06:22.790Z,1579129582.790 [RudderServo] Loaded 2020-01-15T23:06:22.790Z,1579129582.790 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2020-01-15T23:06:22.804Z,1579129582.804 [ThrusterServo] Loaded 2020-01-15T23:06:22.804Z,1579129582.804 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread. 2020-01-15T23:06:22.805Z,1579129582.805 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2020-01-15T23:06:22.805Z,1579129582.805 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2020-01-15T23:06:23.052Z,1579129583.052 [CTD_NeilBrown] Loaded 2020-01-15T23:06:23.052Z,1579129583.052 [ComponentRegistry](DEBUG): Component "CTD_NeilBrown" handled in its own thread. 2020-01-15T23:06:23.053Z,1579129583.053 [CTD_NeilBrown ThreadHandler](DEBUG): Created PCaller Thread at 408C34E0 2020-01-15T23:06:23.054Z,1579129583.054 [CTD_NeilBrown ThreadHandler](INFO): Protected caller Thread ID is 5659 2020-01-15T23:06:23.067Z,1579129583.067 [PAR_Licor] Loaded 2020-01-15T23:06:23.068Z,1579129583.068 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread. 2020-01-15T23:06:23.109Z,1579129583.109 [WetLabsSeaOWL_UV_A] Loaded 2020-01-15T23:06:23.109Z,1579129583.109 [ComponentRegistry](DEBUG): Component "WetLabsSeaOWL_UV_A" handled in its own thread. 2020-01-15T23:06:23.110Z,1579129583.110 [WetLabsSeaOWL_UV_A ThreadHandler](DEBUG): Created PCaller Thread at 408F34E0 2020-01-15T23:06:23.111Z,1579129583.111 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Protected caller Thread ID is 5660 2020-01-15T23:06:23.111Z,1579129583.111 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2020-01-15T23:06:23.112Z,1579129583.112 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2020-01-15T23:06:23.435Z,1579129583.435 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2020-01-15T23:06:23.435Z,1579129583.435 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2020-01-15T23:06:23.474Z,1579129583.474 [DepthRateCalculator] Loaded 2020-01-15T23:06:23.475Z,1579129583.475 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2020-01-15T23:06:23.480Z,1579129583.480 [PitchRateCalculator] Loaded 2020-01-15T23:06:23.480Z,1579129583.480 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2020-01-15T23:06:23.492Z,1579129583.492 [SpeedCalculator] Loaded 2020-01-15T23:06:23.492Z,1579129583.492 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2020-01-15T23:06:23.512Z,1579129583.512 [TempGradientCalculator] Loaded 2020-01-15T23:06:23.512Z,1579129583.512 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread. 2020-01-15T23:06:23.518Z,1579129583.518 [YawRateCalculator] Loaded 2020-01-15T23:06:23.518Z,1579129583.518 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2020-01-15T23:06:23.556Z,1579129583.556 [ElevatorOffsetCalculator] Loaded 2020-01-15T23:06:23.557Z,1579129583.557 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread. 2020-01-15T23:06:23.557Z,1579129583.557 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2020-01-15T23:06:23.558Z,1579129583.558 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2020-01-15T23:06:23.688Z,1579129583.688 [SBIT](DEBUG): Construct Startup Built In Test. 2020-01-15T23:06:23.712Z,1579129583.712 [SBIT] Loaded 2020-01-15T23:06:23.712Z,1579129583.712 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2020-01-15T23:06:23.713Z,1579129583.713 [IBIT](DEBUG): Construct Initiated Built In Test. 2020-01-15T23:06:23.726Z,1579129583.726 [IBIT] Loaded 2020-01-15T23:06:23.726Z,1579129583.726 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2020-01-15T23:06:23.729Z,1579129583.729 [CBIT](DEBUG): Construct Continuous Built In Test. 2020-01-15T23:06:23.860Z,1579129583.860 [CBIT] Loaded 2020-01-15T23:06:23.860Z,1579129583.860 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2020-01-15T23:06:23.861Z,1579129583.861 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2020-01-15T23:06:23.861Z,1579129583.861 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2020-01-15T23:06:23.940Z,1579129583.940 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2020-01-15T23:06:23.941Z,1579129583.941 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2020-01-15T23:06:24.035Z,1579129584.035 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2020-01-15T23:06:24.035Z,1579129584.035 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2020-01-15T23:06:24.081Z,1579129584.081 [VerticalControl](DEBUG): Construct VerticalControl. 2020-01-15T23:06:24.162Z,1579129584.162 [VerticalControl] Loaded 2020-01-15T23:06:24.162Z,1579129584.162 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2020-01-15T23:06:24.163Z,1579129584.163 [HorizontalControl](DEBUG): Construct HorizontalControl. 2020-01-15T23:06:24.229Z,1579129584.229 [HorizontalControl] Loaded 2020-01-15T23:06:24.229Z,1579129584.229 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2020-01-15T23:06:24.230Z,1579129584.230 [SpeedControl](DEBUG): Construct SpeedControl. 2020-01-15T23:06:24.231Z,1579129584.231 [SpeedControl] Loaded 2020-01-15T23:06:24.232Z,1579129584.232 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2020-01-15T23:06:24.232Z,1579129584.232 [LoopControl](DEBUG): Construct LoopControl. 2020-01-15T23:06:24.233Z,1579129584.233 [LoopControl] Loaded 2020-01-15T23:06:24.233Z,1579129584.233 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2020-01-15T23:06:24.233Z,1579129584.233 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2020-01-15T23:06:24.234Z,1579129584.234 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2020-01-15T23:06:24.265Z,1579129584.265 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2020-01-15T23:06:24.269Z,1579129584.269 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2020-01-15T23:06:24.270Z,1579129584.270 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2020-01-15T23:06:24.276Z,1579129584.276 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2020-01-15T23:06:24.277Z,1579129584.277 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40AD94E0 2020-01-15T23:06:24.278Z,1579129584.278 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 5661 2020-01-15T23:06:24.282Z,1579129584.282 [Supervisor](INFO): Main Thread ID is 5419 2020-01-15T23:06:24.282Z,1579129584.282 [Supervisor](DEBUG): Running supervisor. 2020-01-15T23:06:24.283Z,1579129584.283 [CommandLine ThreadHandler](INFO): Handler Thread ID is 5662 2020-01-15T23:06:24.286Z,1579129584.286 [controlThread ThreadHandler](INFO): Handler Thread ID is 5663 2020-01-15T23:06:24.286Z,1579129584.286 [controlThread](DEBUG): Initializing ControlThread 2020-01-15T23:06:24.292Z,1579129584.292 [NavChart](DEBUG): Initialize NavChart Navigation. 2020-01-15T23:06:24.292Z,1579129584.292 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2020-01-15T23:06:24.297Z,1579129584.297 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2020-01-15T23:06:24.297Z,1579129584.297 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2020-01-15T23:06:24.298Z,1579129584.298 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2020-01-15T23:06:24.298Z,1579129584.298 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator. 2020-01-15T23:06:24.299Z,1579129584.299 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2020-01-15T23:06:24.299Z,1579129584.299 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator. 2020-01-15T23:06:24.299Z,1579129584.299 [SBIT](INFO): Initialize SBIT Component. 2020-01-15T23:06:24.300Z,1579129584.300 [SBIT](IMPORTANT): git: 2019-12-03-34-g1420f60 2020-01-15T23:06:24.300Z,1579129584.300 [SBIT](INFO): git hash: 1420f6075bfd9e2317cf67bc08ebc33a04e592a5 2020-01-15T23:06:24.300Z,1579129584.300 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2020-01-15T23:06:24.301Z,1579129584.301 [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-15T23:06:24.303Z,1579129584.303 [SBIT](INFO): Beginning SBIT in 39.000000 seconds. 2020-01-15T23:06:24.303Z,1579129584.303 [IBIT](INFO): Initialize IBIT Component. 2020-01-15T23:06:24.304Z,1579129584.304 [CBIT](DEBUG): Initialize CBIT Component. 2020-01-15T23:06:24.305Z,1579129584.305 [logger ThreadHandler](INFO): Handler Thread ID is 5664 2020-01-15T23:06:24.317Z,1579129584.317 [CBIT](DEBUG): Initialized mux pins. 2020-01-15T23:06:24.317Z,1579129584.317 [CBIT](DEBUG): Initializing the watchdog timer. 2020-01-15T23:06:24.325Z,1579129584.325 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 5665 2020-01-15T23:06:24.326Z,1579129584.326 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2020-01-15T23:06:24.337Z,1579129584.337 [CTD_NeilBrown ThreadHandler](INFO): Handler Thread ID is 5666 2020-01-15T23:06:24.338Z,1579129584.338 [CTD_NeilBrown](INFO): Powering down 2020-01-15T23:06:24.345Z,1579129584.345 [CBIT](INFO): Last reboot was NOT due to watchdog timer. 2020-01-15T23:06:24.345Z,1579129584.345 [CBIT](DEBUG): Initializing heartbeat. 2020-01-15T23:06:24.365Z,1579129584.365 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Handler Thread ID is 5667 2020-01-15T23:06:24.366Z,1579129584.366 [WetLabsSeaOWL_UV_A](INFO): Powering down 2020-01-15T23:06:24.393Z,1579129584.393 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 5668 2020-01-15T23:06:24.396Z,1579129584.396 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000 2020-01-15T23:06:24.396Z,1579129584.396 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000 2020-01-15T23:06:24.397Z,1579129584.397 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000 2020-01-15T23:06:24.397Z,1579129584.397 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000 2020-01-15T23:06:24.397Z,1579129584.397 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000 2020-01-15T23:06:24.397Z,1579129584.397 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000 2020-01-15T23:06:24.397Z,1579129584.397 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000 2020-01-15T23:06:24.397Z,1579129584.397 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000 2020-01-15T23:06:24.398Z,1579129584.398 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000 2020-01-15T23:06:24.398Z,1579129584.398 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000 2020-01-15T23:06:24.398Z,1579129584.398 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000 2020-01-15T23:06:24.398Z,1579129584.398 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000 2020-01-15T23:06:24.398Z,1579129584.398 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000 2020-01-15T23:06:24.399Z,1579129584.399 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000 2020-01-15T23:06:24.399Z,1579129584.399 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000 2020-01-15T23:06:24.399Z,1579129584.399 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000 2020-01-15T23:06:24.417Z,1579129584.417 [CBIT](DEBUG): Deactivating GF circuits. 2020-01-15T23:06:24.417Z,1579129584.417 [CBIT](DEBUG): Deactivating emergency mode. 2020-01-15T23:06:24.453Z,1579129584.453 [CBIT](DEBUG): Backplane powered. 2020-01-15T23:06:24.453Z,1579129584.453 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2020-01-15T23:06:24.455Z,1579129584.455 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2020-01-15T23:06:24.455Z,1579129584.455 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2020-01-15T23:06:24.456Z,1579129584.456 [LoopControl](DEBUG): Initialize LoopControlComponent. 2020-01-15T23:06:24.457Z,1579129584.457 [MissionManager](INFO): Loading Mission: Missions/Startup.xml 2020-01-15T23:06:24.466Z,1579129584.466 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2020-01-15T23:06:24.476Z,1579129584.476 [MissionManager](DEBUG): 2020-01-15T23:06:24.493Z,1579129584.493 [MissionManager](INFO): Loading Mission: Missions/Default.xml 2020-01-15T23:06:24.541Z,1579129584.541 [CTD_NeilBrown](FAULT): LCB fault: LCB Watchdog Reset. Invalid Command. Hardware Overcurrent Shutdown. Software Overcurrent. Current Limiter Activated. 2020-01-15T23:06:24.542Z,1579129584.542 [CTD_NeilBrown] Hardware Fault, FailCount= 1 2020-01-15T23:06:24.542Z,1579129584.542 [CTD_NeilBrown](ERROR): Hardware Fault 2020-01-15T23:06:24.560Z,1579129584.560 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min 2020-01-15T23:06:24.561Z,1579129584.561 [Default:A.Wait](DEBUG): Construct Wait. 2020-01-15T23:06:24.563Z,1579129584.563 [Default:B.GoToSurface](DEBUG): Construct GoToSurface. 2020-01-15T23:06:24.589Z,1579129584.589 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2020-01-15T23:06:24.592Z,1579129584.592 [Default:CheckIn:C.Wait](DEBUG): Construct Wait. 2020-01-15T23:06:24.613Z,1579129584.613 [Default:E.Execute](DEBUG): Construct Execute. 2020-01-15T23:06:24.616Z,1579129584.616 [MissionManager](DEBUG): 0 Wait a moment to see if the scheduler starts a new mission before starting to actually run Default. 13 Burn on Dropped weight due to communications timeout. 5 Default mission has been running for Restarting logs and Default mission. restart logs 2020-01-15T23:06:24.654Z,1579129584.654 [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-15T23:06:24.671Z,1579129584.671 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2020-01-15T23:06:24.701Z,1579129584.701 [DDM](INFO): Powering up 2020-01-15T23:06:24.702Z,1579129584.702 [DDM](DEBUG): Initializing DDM. 2020-01-15T23:06:24.834Z,1579129584.834 [DUSBL_Hydroid](INFO): Powering up 2020-01-15T23:06:24.834Z,1579129584.834 [DUSBL_Hydroid](DEBUG): Initializing DUSBL_Hydroid. 2020-01-15T23:06:25.038Z,1579129585.038 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2020-01-15T23:06:25.045Z,1579129585.045 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2020-01-15T23:06:25.046Z,1579129585.046 [ElevatorServo](DEBUG): Initializing EZServoServo. 2020-01-15T23:06:25.057Z,1579129585.057 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2020-01-15T23:06:25.058Z,1579129585.058 [MassServo](DEBUG): Initializing EZServoServo. 2020-01-15T23:06:25.065Z,1579129585.065 [MassServo](DEBUG): Initializing MassServo. 2020-01-15T23:06:25.066Z,1579129585.066 [RudderServo](DEBUG): Initializing EZServoServo. 2020-01-15T23:06:25.073Z,1579129585.073 [RudderServo](DEBUG): Initializing RudderServo. 2020-01-15T23:06:25.074Z,1579129585.074 [ThrusterServo](DEBUG): Initializing EZServoServo. 2020-01-15T23:06:25.081Z,1579129585.081 [ThrusterServo](DEBUG): Initializing ThrusterServo. 2020-01-15T23:06:25.086Z,1579129585.086 [CBIT](ERROR): Hardware Fault in component: CTD_NeilBrown 2020-01-15T23:06:25.087Z,1579129585.087 [CBIT](FAULT): Hardware Fault in component: CTD_NeilBrown 2020-01-15T23:06:25.143Z,1579129585.143 [DropWeight](CRITICAL): DROP WEIGHT MISSING. 2020-01-15T23:06:25.143Z,1579129585.143 [DropWeight] Hardware Fault, FailCount= 1 2020-01-15T23:06:25.143Z,1579129585.143 [DropWeight](ERROR): Hardware Fault 2020-01-15T23:06:25.145Z,1579129585.145 [Micromodem](INFO): Powering up 2020-01-15T23:06:25.145Z,1579129585.145 [Micromodem](DEBUG): Initializing Micromodem. 2020-01-15T23:06:25.226Z,1579129585.226 [CommandLine](FAULT): Scheduling is paused 2020-01-15T23:06:25.227Z,1579129585.227 [CBIT](INFO): Critical error at 20200115T230625 2020-01-15T23:06:25.227Z,1579129585.227 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals 2020-01-15T23:06:25.229Z,1579129585.229 [CBIT](ERROR): Hardware Fault in component: DropWeight 2020-01-15T23:06:25.230Z,1579129585.230 [CBIT](CRITICAL): Hardware Fault in component: DropWeight 2020-01-15T23:06:25.905Z,1579129585.905 [RudderServo](ERROR): Rudder initialization uart error serial timeout 2020-01-15T23:06:25.905Z,1579129585.905 [RudderServo](FAULT): Rudder failed to initialize 2020-01-15T23:06:25.905Z,1579129585.905 [RudderServo] Communications Fault, FailCount= 1 2020-01-15T23:06:25.905Z,1579129585.905 [RudderServo](ERROR): Communications Fault 2020-01-15T23:06:26.026Z,1579129586.026 [CBIT](INFO): Critical error at 20200115T230625 2020-01-15T23:06:26.029Z,1579129586.029 [CBIT](ERROR): Communications Fault in component: RudderServo 2020-01-15T23:06:26.234Z,1579129586.234 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2020-01-15T23:06:26.234Z,1579129586.234 [RudderServo](INFO): Powering down 2020-01-15T23:06:26.889Z,1579129586.889 [RudderServo](DEBUG): Initializing EZServoServo. 2020-01-15T23:06:27.010Z,1579129587.010 [RudderServo](DEBUG): Initializing RudderServo. 2020-01-15T23:06:27.014Z,1579129587.014 [CBIT](INFO): Clearing failed state for component RudderServo 2020-01-15T23:06:27.014Z,1579129587.014 [RudderServo] No Fault, FailCount= 1 2020-01-15T23:06:30.115Z,1579129590.115 [Micromodem](INFO): Nmea out: $CCCFG,ALL,0*33 2020-01-15T23:06:34.625Z,1579129594.625 [CBIT](CRITICAL): Environmental Failure. Press:14.698754 PSI. Humidity:29%. Temp:24 C. ABORTING MISSION 2020-01-15T23:06:35.015Z,1579129595.015 [CBIT](INFO): Critical error at 20200115T230634 2020-01-15T23:06:35.345Z,1579129595.345 [DDM](INFO): Dynamic Docking Module:!C REMUS Capture Rev 1.1 2020-01-15T23:06:38.188Z,1579129598.188 [RDI_Pathfinder](ERROR): Failed to parse:Pathfinder 2020-01-15T23:06:41.395Z,1579129601.395 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:06:43.018Z,1579129603.018 [DUSBL_Hydroid](INFO): DUSBL Version:O 2020-01-15T23:06:50.683Z,1579129610.683 [NAL9602](INFO): Powering up NAL9602 2020-01-15T23:06:52.702Z,1579129612.702 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:06:55.457Z,1579129615.457 [DataOverHttps](INFO): Radio surface powered OFF, will not connect. 2020-01-15T23:07:01.596Z,1579129621.596 [NAL9602](INFO): NAL9602 initialized 2020-01-15T23:07:03.667Z,1579129623.667 [SBIT](IMPORTANT): Beginning Startup BIT 2020-01-15T23:07:03.691Z,1579129623.691 [CBIT](IMPORTANT): Beginning ground fault scan 2020-01-15T23:07:04.014Z,1579129624.014 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:07:14.773Z,1579129634.773 [CBIT](IMPORTANT): No ground fault detected mA: CHAN A0 (Batt): -0.009520 CHAN A1 (24V): -0.028490 CHAN A2 (12V): -0.007470 CHAN A3 (5V): -0.001943 CHAN B0 (3.3V): 0.000116 CHAN B1 (3.15aV): 0.000287 CHAN B2 (3.15bV): -0.000032 CHAN B3 (GND): 0.002309 OPEN: 0.005040 Full Scale Calc: 4.765 mA, -1.589 mA 2020-01-15T23:07:15.062Z,1579129635.062 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:07:26.070Z,1579129646.070 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:07:31.362Z,1579129651.362 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error 2020-01-15T23:07:31.362Z,1579129651.362 [RDI_Pathfinder](ERROR): Failed to parse: :TS,20011516193800,35.0 0.0,1448.9, 0 2020-01-15T23:07:36.698Z,1579129656.698 [CommandLine](IMPORTANT): got command show stack 2020-01-15T23:07:36.698Z,1579129656.698 [CommandLine](IMPORTANT): Behavior Stack: 2020-01-15T23:07:36.698Z,1579129656.698 [MissionManager](IMPORTANT): Mission loaded, but not running. 2020-01-15T23:07:37.386Z,1579129657.386 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:07:48.442Z,1579129668.442 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:07:57.396Z,1579129677.396 [SBIT](IMPORTANT): SBIT PASSED 2020-01-15T23:07:57.424Z,1579129677.424 [CommandLine](IMPORTANT): got command configSet list 2020-01-15T23:07:57.424Z,1579129677.424 [CommandLine](IMPORTANT): Listing configuration overrides from Data/persisted.cfg 2020-01-15T23:07:57.425Z,1579129677.425 [CommandLine](IMPORTANT): DDM.loadAtStartup=1 bool; 2020-01-15T23:07:57.425Z,1579129677.425 [CommandLine](IMPORTANT): DDM.verbosity=3 count; 2020-01-15T23:07:57.425Z,1579129677.425 [CommandLine](IMPORTANT): DUSBL_Hydroid.detectionThreshold=25 count; 2020-01-15T23:07:57.425Z,1579129677.425 [CommandLine](IMPORTANT): DUSBL_Hydroid.transmitLockout=40 millisecond; 2020-01-15T23:07:57.425Z,1579129677.425 [CommandLine](IMPORTANT): Express linearApproximation DDM.DDMMode 1.000000 count; 2020-01-15T23:07:57.425Z,1579129677.425 [CommandLine](IMPORTANT): Express all DDM.cablePresent; 2020-01-15T23:07:57.425Z,1579129677.425 [CommandLine](IMPORTANT): HorizontalControl.kiHeading=0.002 reciprocal_second; 2020-01-15T23:07:57.426Z,1579129677.426 [CommandLine](IMPORTANT): HorizontalControl.kpHeading=0.8 none; 2020-01-15T23:07:57.426Z,1579129677.426 [CommandLine](IMPORTANT): HorizontalControl.rudDeadband=0.05 degree; 2020-01-15T23:07:57.426Z,1579129677.426 [CommandLine](IMPORTANT): Micromodem.destinationAddress=12 enum; 2020-01-15T23:07:57.426Z,1579129677.426 [CommandLine](IMPORTANT): Micromodem.sendExpress=1 bool; 2020-01-15T23:07:57.426Z,1579129677.426 [CommandLine](IMPORTANT): Micromodem.surfaceThreshold=0 meter; 2020-01-15T23:07:57.426Z,1579129677.426 [CommandLine](IMPORTANT): PowerOnly.sampleTime=90 second; 2020-01-15T23:07:57.426Z,1579129677.426 [CommandLine](IMPORTANT): Radio_Surface.loadAtStartup=0 bool; 2020-01-15T23:07:57.426Z,1579129677.426 [CommandLine](IMPORTANT): RudderServo.deviationAngle=0.0001 degree; 2020-01-15T23:07:57.426Z,1579129677.426 [CommandLine](IMPORTANT): VerticalControl.buoyancyNeutral=105 cubic_centimeter; 2020-01-15T23:07:57.427Z,1579129677.427 [CommandLine](IMPORTANT): VerticalControl.massDefault=-5 millimeter; 2020-01-15T23:07:57.783Z,1579129677.783 [MissionManager](IMPORTANT): Started mission Startup 2020-01-15T23:07:57.784Z,1579129677.784 [Startup] Running Loop=1 2020-01-15T23:07:57.784Z,1579129677.784 [Startup](DEBUG): Aggregate::initialize Startup 2020-01-15T23:07:57.784Z,1579129677.784 [Startup:A.GoToSurface] Running Loop=1 2020-01-15T23:07:57.784Z,1579129677.784 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2020-01-15T23:07:57.784Z,1579129677.784 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2020-01-15T23:07:57.814Z,1579129677.814 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2020-01-15T23:07:57.814Z,1579129677.814 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2020-01-15T23:07:57.815Z,1579129677.815 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2020-01-15T23:07:57.815Z,1579129677.815 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2020-01-15T23:07:57.818Z,1579129677.818 [Startup:StartupSatComms] Running Loop=1 2020-01-15T23:07:57.818Z,1579129677.818 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms 2020-01-15T23:07:57.818Z,1579129677.818 [Startup:StartupSatComms:A] Running Loop=1 2020-01-15T23:07:58.187Z,1579129678.187 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix 2020-01-15T23:07:59.747Z,1579129679.747 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:08:11.062Z,1579129691.062 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:08:22.374Z,1579129702.374 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:08:25.207Z,1579129705.207 [Micromodem](FAULT): failed to initialize; deviceResponse_ loaded: , available: 2020-01-15T23:08:25.207Z,1579129705.207 [Micromodem] Communications Fault, FailCount= 1 2020-01-15T23:08:25.207Z,1579129705.207 [Micromodem](ERROR): Communications Fault 2020-01-15T23:08:25.286Z,1579129705.286 [CBIT](ERROR): Communications Fault in component: Micromodem 2020-01-15T23:08:25.606Z,1579129705.606 [Micromodem](INFO): Powering down 2020-01-15T23:08:26.495Z,1579129706.495 [CBIT](INFO): Clearing failed state for component Micromodem 2020-01-15T23:08:26.495Z,1579129706.495 [Micromodem] No Fault, FailCount= 1 2020-01-15T23:08:29.242Z,1579129709.242 [Micromodem](INFO): Powering up 2020-01-15T23:08:29.242Z,1579129709.242 [Micromodem](DEBUG): Initializing Micromodem. 2020-01-15T23:08:33.683Z,1579129713.683 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:08:44.998Z,1579129724.998 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:08:55.553Z,1579129735.553 [RDI_Pathfinder](ERROR): only read 3 of 4 data items 2020-01-15T23:08:55.554Z,1579129735.554 [RDI_Pathfinder](ERROR): Failed to parse: :RA, 0.00, 0.00, 0.00, 0.00, BI,-32768,-32768,-32768,-32768,V 2020-01-15T23:08:56.341Z,1579129736.341 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:08:57.985Z,1579129737.985 [Startup:StartupSatComms:A](INFO): Timed out from 2020-01-15T23:07:57.8Z 2020-01-15T23:08:57.985Z,1579129737.985 [Startup:StartupSatComms:A] Stopped 2020-01-15T23:08:57.986Z,1579129737.986 [Startup:StartupSatComms:B] Running Loop=1 2020-01-15T23:08:58.373Z,1579129738.373 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications 2020-01-15T23:09:07.626Z,1579129747.626 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:09:12.276Z,1579129752.276 [CommandLine](IMPORTANT): got command show stack 2020-01-15T23:09:12.276Z,1579129752.276 [CommandLine](IMPORTANT): Behavior Stack: 2020-01-15T23:09:12.277Z,1579129752.277 [Startup](IMPORTANT): Priority 0: Startup:A.GoToSurface 2020-01-15T23:09:12.277Z,1579129752.277 [Startup:StartupSatComms](IMPORTANT): Priority 1: Startup:StartupSatComms:B 2020-01-15T23:09:18.930Z,1579129758.930 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:09:24.618Z,1579129764.618 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1 2020-01-15T23:09:24.618Z,1579129764.618 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-01-15T23:09:24.660Z,1579129764.660 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-01-15T23:09:25.032Z,1579129765.032 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-01-15T23:09:25.032Z,1579129765.032 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1 2020-01-15T23:09:30.250Z,1579129770.250 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:09:41.558Z,1579129781.558 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:09:52.870Z,1579129792.870 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:09:58.183Z,1579129798.183 [Startup:StartupSatComms:B](INFO): Timed out from 2020-01-15T23:08:57.0Z 2020-01-15T23:09:58.183Z,1579129798.183 [Startup:StartupSatComms:B] Stopped 2020-01-15T23:09:58.183Z,1579129798.183 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms 2020-01-15T23:09:58.183Z,1579129798.183 [Startup:StartupSatComms] Stopped 2020-01-15T23:09:58.183Z,1579129798.183 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms 2020-01-15T23:09:58.184Z,1579129798.184 [Startup](INFO): Completed Startup 2020-01-15T23:09:58.184Z,1579129798.184 [MissionManager](INFO): Startup is completed. 2020-01-15T23:09:58.184Z,1579129798.184 [MissionManager](INFO): Uninitializing Mission Startup 2020-01-15T23:09:58.184Z,1579129798.184 [Startup] Stopped 2020-01-15T23:09:58.185Z,1579129798.185 [Startup](DEBUG): Aggregate::uninitialize Startup 2020-01-15T23:09:58.185Z,1579129798.185 [Startup:A.GoToSurface] Stopped 2020-01-15T23:09:58.185Z,1579129798.185 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2020-01-15T23:09:58.581Z,1579129798.581 [MissionManager](IMPORTANT): Started mission Default 2020-01-15T23:09:58.582Z,1579129798.582 [Default] Running Loop=1 2020-01-15T23:09:58.582Z,1579129798.582 [Default](DEBUG): Aggregate::initialize Default 2020-01-15T23:09:58.582Z,1579129798.582 [Default:B.GoToSurface] Running Loop=1 2020-01-15T23:09:58.582Z,1579129798.582 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2020-01-15T23:09:58.582Z,1579129798.582 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2020-01-15T23:09:58.582Z,1579129798.582 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2020-01-15T23:09:58.583Z,1579129798.583 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2020-01-15T23:09:58.583Z,1579129798.583 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2020-01-15T23:09:58.583Z,1579129798.583 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2020-01-15T23:09:58.584Z,1579129798.584 [Default:A.Wait] Running Loop=1 2020-01-15T23:09:58.584Z,1579129798.584 [Default:A.Wait](DEBUG): Initialize Wait Component. 2020-01-15T23:10:04.182Z,1579129804.182 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:10:11.889Z,1579129811.889 [Default:A.Wait](INFO): Done Waiting. 2020-01-15T23:10:11.889Z,1579129811.889 [Default:A.Wait] Stopped 2020-01-15T23:10:11.890Z,1579129811.890 [Default:A.Wait](DEBUG): Uninitialize Wait Component. 2020-01-15T23:10:12.299Z,1579129812.299 [Default:CheckIn] Running Loop=1 2020-01-15T23:10:12.299Z,1579129812.299 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2020-01-15T23:10:12.299Z,1579129812.299 [Default:CheckIn:Read_GPS] Running Loop=1 2020-01-15T23:10:12.695Z,1579129812.695 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix 2020-01-15T23:10:15.494Z,1579129815.494 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:10:20.370Z,1579129820.370 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error 2020-01-15T23:10:20.370Z,1579129820.370 [RDI_Pathfinder](ERROR): Failed to parse: :TS,200115165.0, -0.1, 0.0,1448.9, 0 2020-01-15T23:10:26.806Z,1579129826.806 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:10:29.226Z,1579129829.226 [Micromodem](FAULT): failed to initialize; deviceResponse_ loaded: , available: 2020-01-15T23:10:29.227Z,1579129829.227 [Micromodem] Communications Fault, FailCount= 2 2020-01-15T23:10:29.227Z,1579129829.227 [Micromodem](ERROR): Communications Fault 2020-01-15T23:10:29.344Z,1579129829.344 [CBIT](ERROR): Communications Fault in component: Micromodem 2020-01-15T23:10:29.642Z,1579129829.642 [Micromodem](INFO): Powering down 2020-01-15T23:10:30.038Z,1579129830.038 [Micromodem](FAULT): LCB 1 fault: Software Overcurrent. 2020-01-15T23:10:30.038Z,1579129830.038 [Micromodem] Hardware Fault, FailCount= 2 2020-01-15T23:10:30.038Z,1579129830.038 [Micromodem](ERROR): Hardware Fault 2020-01-15T23:10:30.484Z,1579129830.484 [CBIT](INFO): Clearing failed state for component Micromodem 2020-01-15T23:10:30.484Z,1579129830.484 [Micromodem] No Fault, FailCount= 2 2020-01-15T23:10:33.274Z,1579129833.274 [Micromodem](INFO): Powering up 2020-01-15T23:10:33.274Z,1579129833.274 [Micromodem](DEBUG): Initializing Micromodem. 2020-01-15T23:10:37.358Z,1579129837.358 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for altitude 2020-01-15T23:10:37.358Z,1579129837.358 [RDI_Pathfinder](ERROR): Failed to parse: :BD, +0 +0.00, +0.00, 0.00,239.00 2020-01-15T23:10:38.122Z,1579129838.122 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:10:49.436Z,1579129849.436 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:11:00.370Z,1579129860.370 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error 2020-01-15T23:11:00.371Z,1579129860.371 [RDI_Pathfinder](ERROR): Failed to parse: :TS,20011516230, -0.1, 0.0,1448.9, 0 2020-01-15T23:11:00.747Z,1579129860.747 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:11:12.062Z,1579129872.062 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:11:23.362Z,1579129883.362 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:11:28.292Z,1579129888.292 [CommandLine](IMPORTANT): got command show stack 2020-01-15T23:11:28.292Z,1579129888.292 [CommandLine](IMPORTANT): Behavior Stack: 2020-01-15T23:11:28.292Z,1579129888.292 [Default](IMPORTANT): Priority 0: Default:B.GoToSurface 2020-01-15T23:11:28.293Z,1579129888.293 [Default:CheckIn](IMPORTANT): Priority 1: Default:CheckIn:Read_GPS 2020-01-15T23:11:34.684Z,1579129894.684 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:11:36.725Z,1579129896.725 [RDI_Pathfinder](ERROR): only read 3 of 4 data items 2020-01-15T23:11:36.725Z,1579129896.725 [RDI_Pathfinder](ERROR): Failed to parse: :RA, 0.00, 0.00, 0.00, 0.00 2020-01-15T23:11:45.990Z,1579129905.990 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:11:49.756Z,1579129909.756 [CommandLine](IMPORTANT): got command run ./Missions/Insert/Docked.xml 2020-01-15T23:11:49.756Z,1579129909.756 [MissionManager](INFO): Loading Mission: ./Missions/Insert/Docked.xml 2020-01-15T23:11:49.820Z,1579129909.820 [MissionManager](INFO): DefineArg Docked.MaxDockRange = 8.000000 m 2020-01-15T23:11:49.823Z,1579129909.823 [MissionManager](INFO): DefineArg Docked.DetachedTimeout = 5.000000 min 2020-01-15T23:11:49.826Z,1579129909.826 [MissionManager](INFO): DefineArg Docked.Depth = 5.000000 m 2020-01-15T23:11:49.830Z,1579129909.830 [MissionManager](INFO): DefineArg Docked.TransponderCode = 2.000000 count 2020-01-15T23:11:49.867Z,1579129909.867 [MissionManager](INFO): DefineArg Docked.TrackingUpdatePeriod = 60.000000 s 2020-01-15T23:11:49.890Z,1579129909.890 [MissionManager](INFO): DefineArg Docked.NumberOfPings = 1.000000 count 2020-01-15T23:11:49.912Z,1579129909.912 [MissionManager](INFO): DefineArg Docked.Speed = 0.000000 m/s 2020-01-15T23:11:49.916Z,1579129909.916 [MissionManager](INFO): DefineArg Docked.DepthDeadband = 1.500000 m 2020-01-15T23:11:49.920Z,1579129909.920 [MissionManager](INFO): DefineArg Docked.PitchLimit = 20.000000 arcdeg 2020-01-15T23:11:49.924Z,1579129909.924 [MissionManager](INFO): DefineArg Docked.MinDepth = 1.000000 m 2020-01-15T23:11:49.928Z,1579129909.928 [MissionManager](INFO): DefineArg Docked.MaxDepth = 215.000000 m 2020-01-15T23:11:49.969Z,1579129909.969 [Docked:A.DepthEnvelope](DEBUG): Construct DepthEnvelope. 2020-01-15T23:11:50.283Z,1579129910.283 [Docked:E.Pitch](DEBUG): Construct. 2020-01-15T23:11:50.298Z,1579129910.298 [Docked:F.SetSpeed](DEBUG): Construct. 2020-01-15T23:11:50.307Z,1579129910.307 [Docked:G.Docked](DEBUG): Construct. 2020-01-15T23:11:50.328Z,1579129910.328 [MissionManager](DEBUG): Maximum range allowed from the dock. 8 Time duration limit for determining if the vehicle is detached from the dock. 5 Depth to maintain while docked. 5 Transponder Address. 2 How long to wait between acoustic queries. 60 Number of pings requested each time. 1 Thruster speed while docked. 0.0 How much vertical drift from the specified depth is allowed while docked. 1.5 Max vehicle pitch (+/-) while on dock. 20 Minimum depth while docked. Maximum depth while docked. <0.0 2020-01-15T23:11:50.334Z,1579129910.334 [CommandLine](IMPORTANT): Running ./Missions/Insert/Docked.xml 2020-01-15T23:11:50.473Z,1579129910.473 [Default] Stopped 2020-01-15T23:11:50.473Z,1579129910.473 [Default](DEBUG): Aggregate::uninitialize Default 2020-01-15T23:11:50.474Z,1579129910.474 [Default:B.GoToSurface] Stopped 2020-01-15T23:11:50.474Z,1579129910.474 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2020-01-15T23:11:50.474Z,1579129910.474 [Default:CheckIn] Stopped 2020-01-15T23:11:50.474Z,1579129910.474 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2020-01-15T23:11:50.474Z,1579129910.474 [Default:CheckIn:Read_GPS] Stopped 2020-01-15T23:11:50.474Z,1579129910.474 [MissionManager](IMPORTANT): Started mission Docked 2020-01-15T23:11:50.474Z,1579129910.474 [Docked] Running Loop=1 2020-01-15T23:11:50.474Z,1579129910.474 [Docked](DEBUG): Aggregate::initialize Docked 2020-01-15T23:11:50.474Z,1579129910.474 [Docked:A.DepthEnvelope] Running Loop=1 2020-01-15T23:11:50.474Z,1579129910.474 [Docked:A.DepthEnvelope](DEBUG): Initialize DepthEnvelopeComponent. 2020-01-15T23:11:50.475Z,1579129910.475 [Docked:B.] Running Loop=1 2020-01-15T23:11:50.475Z,1579129910.475 [Docked:B.](INFO): Initializing TrackAcousticContact. 2020-01-15T23:11:50.475Z,1579129910.475 [Docked:C] Running Loop=1 2020-01-15T23:11:50.475Z,1579129910.475 [Docked:D] Running Loop=1 2020-01-15T23:11:50.475Z,1579129910.475 [Docked:E.Pitch] Running Loop=1 2020-01-15T23:11:50.475Z,1579129910.475 [Docked:E.Pitch](DEBUG): Initialize. 2020-01-15T23:11:50.476Z,1579129910.476 [Docked:F.SetSpeed] Running Loop=1 2020-01-15T23:11:50.476Z,1579129910.476 [Docked:F.SetSpeed](DEBUG): Initialize. 2020-01-15T23:11:50.476Z,1579129910.476 [Docked:G.Docked] Running Loop=1 2020-01-15T23:11:50.476Z,1579129910.476 [Docked:G.Docked](DEBUG): Initialize. 2020-01-15T23:11:50.476Z,1579129910.476 [Docked:F.SetSpeed] Running Loop=1 2020-01-15T23:11:50.476Z,1579129910.476 [Docked:E.Pitch] Running Loop=1 2020-01-15T23:11:50.477Z,1579129910.477 [Docked:D] Running Loop=1 2020-01-15T23:11:50.478Z,1579129910.478 [Docked:C] Running Loop=1 2020-01-15T23:11:50.478Z,1579129910.478 [Docked:B.] Running Loop=1 2020-01-15T23:11:50.478Z,1579129910.478 [Docked:A.DepthEnvelope] Running Loop=1 2020-01-15T23:11:52.045Z,1579129912.045 [DDM](INFO): Closing Latch 2020-01-15T23:11:52.448Z,1579129912.448 [DDM](INFO): Closing Latch 2020-01-15T23:11:52.853Z,1579129912.853 [DDM](INFO): Closing Latch 2020-01-15T23:11:53.257Z,1579129913.257 [DDM](INFO): Closing Latch 2020-01-15T23:11:57.314Z,1579129917.314 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:12:04.983Z,1579129924.983 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2020-01-15T23:12:08.619Z,1579129928.619 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:12:19.655Z,1579129939.655 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:12:25.750Z,1579129945.750 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2 2020-01-15T23:12:25.750Z,1579129945.750 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-01-15T23:12:25.849Z,1579129945.849 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-01-15T23:12:26.202Z,1579129946.202 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-01-15T23:12:26.202Z,1579129946.202 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2 2020-01-15T23:12:30.979Z,1579129950.979 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:12:33.016Z,1579129953.016 [Micromodem](FAULT): failed to initialize; deviceResponse_ loaded: , available: 2020-01-15T23:12:33.016Z,1579129953.016 [Micromodem] Communications Fault, FailCount= 3 2020-01-15T23:12:33.016Z,1579129953.016 [Micromodem](ERROR): Communications Fault 2020-01-15T23:12:33.220Z,1579129953.220 [CBIT](ERROR): Communications Fault in component: Micromodem 2020-01-15T23:12:33.400Z,1579129953.400 [Micromodem](INFO): Powering down 2020-01-15T23:12:34.002Z,1579129954.002 [Micromodem](FAULT): LCB 2 fault: Software Overcurrent. 2020-01-15T23:12:34.002Z,1579129954.002 [Micromodem] Hardware Fault, FailCount= 3 2020-01-15T23:12:34.002Z,1579129954.002 [Micromodem](ERROR): Hardware Fault 2020-01-15T23:12:34.561Z,1579129954.561 [CBIT](INFO): Clearing failed state for component Micromodem 2020-01-15T23:12:34.562Z,1579129954.562 [Micromodem] No Fault, FailCount= 3 2020-01-15T23:12:36.830Z,1579129956.830 [Micromodem](INFO): Powering up 2020-01-15T23:12:36.831Z,1579129956.831 [Micromodem](DEBUG): Initializing Micromodem. 2020-01-15T23:12:39.333Z,1579129959.333 [CommandLine](IMPORTANT): got command show stack 2020-01-15T23:12:39.333Z,1579129959.333 [CommandLine](IMPORTANT): Behavior Stack: 2020-01-15T23:12:39.333Z,1579129959.333 [Docked](IMPORTANT): Priority 0: Docked:A.DepthEnvelope 2020-01-15T23:12:39.333Z,1579129959.333 [Docked](IMPORTANT): Priority 1: Docked:B. 2020-01-15T23:12:39.334Z,1579129959.334 [Docked](IMPORTANT): Priority 2: Docked:C 2020-01-15T23:12:39.334Z,1579129959.334 [Docked](IMPORTANT): Priority 3: Docked:D 2020-01-15T23:12:39.334Z,1579129959.334 [Docked](IMPORTANT): Priority 4: Docked:E.Pitch 2020-01-15T23:12:39.334Z,1579129959.334 [Docked](IMPORTANT): Priority 5: Docked:F.SetSpeed 2020-01-15T23:12:39.335Z,1579129959.335 [Docked](IMPORTANT): Priority 6: Docked:G.Docked 2020-01-15T23:12:42.074Z,1579129962.074 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:12:50.597Z,1579129970.597 [Docked:B.](INFO): *** querying acoustic contact *** 2020-01-15T23:12:53.387Z,1579129973.387 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:13:04.467Z,1579129984.467 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:13:15.782Z,1579129995.782 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:13:26.819Z,1579130006.819 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:13:38.130Z,1579130018.130 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:13:48.780Z,1579130028.780 [BPC1](INFO): Calculating totals. Valid battery stick count: 56. Valid reserve battery stick count: 6. 2020-01-15T23:13:48.784Z,1579130028.784 [BPC1](INFO): Received data from all battery sticks. 2020-01-15T23:13:49.158Z,1579130029.158 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:13:50.828Z,1579130030.828 [Docked:B.](INFO): *** querying acoustic contact *** 2020-01-15T23:14:00.456Z,1579130040.456 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:14:09.472Z,1579130049.472 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error 2020-01-15T23:14:09.472Z,1579130049.472 [RDI_Pathfinder](ERROR): Failed to parse: :TS,20011516261600,35.0, -0.1, 0.0,1448:RA, 0.00, 0.00, 0.00, 0.00, 0.00 2020-01-15T23:14:11.850Z,1579130051.850 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:14:16.349Z,1579130056.349 [RDI_Pathfinder](ERROR): only read 3 of 4 data items 2020-01-15T23:14:16.349Z,1579130056.349 [RDI_Pathfinder](ERROR): Failed to parse: :RA, 0.00, 0.00, 0.00, 0.00 2020-01-15T23:14:22.708Z,1579130062.708 [CommandLine](IMPORTANT): got command show stack 2020-01-15T23:14:22.708Z,1579130062.708 [CommandLine](IMPORTANT): Behavior Stack: 2020-01-15T23:14:22.708Z,1579130062.708 [Docked](IMPORTANT): Priority 0: Docked:A.DepthEnvelope 2020-01-15T23:14:22.708Z,1579130062.708 [Docked](IMPORTANT): Priority 1: Docked:B. 2020-01-15T23:14:22.709Z,1579130062.709 [Docked](IMPORTANT): Priority 2: Docked:C 2020-01-15T23:14:22.709Z,1579130062.709 [Docked](IMPORTANT): Priority 3: Docked:D 2020-01-15T23:14:22.709Z,1579130062.709 [Docked](IMPORTANT): Priority 4: Docked:E.Pitch 2020-01-15T23:14:22.710Z,1579130062.710 [Docked](IMPORTANT): Priority 5: Docked:F.SetSpeed 2020-01-15T23:14:22.710Z,1579130062.710 [Docked](IMPORTANT): Priority 6: Docked:G.Docked 2020-01-15T23:14:23.159Z,1579130063.159 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:14:32.572Z,1579130072.572 [CommandLine](IMPORTANT): got command stop 2020-01-15T23:14:32.572Z,1579130072.572 [CommandLine](IMPORTANT): Scheduling is paused 2020-01-15T23:14:32.572Z,1579130072.572 [Supervisor](INFO): Stop Mission called by CommandLine::commandStop 2020-01-15T23:14:32.884Z,1579130072.884 [MissionManager](INFO): MissionManager is completed. 2020-01-15T23:14:32.884Z,1579130072.884 [MissionManager](INFO): Uninitializing Mission Docked 2020-01-15T23:14:32.884Z,1579130072.884 [Docked] Stopped 2020-01-15T23:14:32.885Z,1579130072.885 [Docked](DEBUG): Aggregate::uninitialize Docked 2020-01-15T23:14:32.885Z,1579130072.885 [Docked:A.DepthEnvelope] Stopped 2020-01-15T23:14:32.885Z,1579130072.885 [Docked:A.DepthEnvelope](DEBUG): Uninitialize. 2020-01-15T23:14:32.885Z,1579130072.885 [Docked:B.] Stopped 2020-01-15T23:14:32.885Z,1579130072.885 [Docked:C] Stopped 2020-01-15T23:14:32.885Z,1579130072.885 [Docked:D] Stopped 2020-01-15T23:14:32.885Z,1579130072.885 [Docked:E.Pitch] Stopped 2020-01-15T23:14:32.885Z,1579130072.885 [Docked:F.SetSpeed] Stopped 2020-01-15T23:14:32.885Z,1579130072.885 [Docked:F.SetSpeed](DEBUG): Uninitialize. 2020-01-15T23:14:32.885Z,1579130072.885 [Docked:G.Docked] Stopped 2020-01-15T23:14:33.294Z,1579130073.294 [MissionManager](IMPORTANT): Started mission Default 2020-01-15T23:14:33.294Z,1579130073.294 [Default] Running Loop=1 2020-01-15T23:14:33.294Z,1579130073.294 [Default](DEBUG): Aggregate::initialize Default 2020-01-15T23:14:33.294Z,1579130073.294 [Default:B.GoToSurface] Running Loop=1 2020-01-15T23:14:33.294Z,1579130073.294 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2020-01-15T23:14:33.295Z,1579130073.295 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2020-01-15T23:14:33.295Z,1579130073.295 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2020-01-15T23:14:33.295Z,1579130073.295 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2020-01-15T23:14:33.296Z,1579130073.296 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2020-01-15T23:14:33.296Z,1579130073.296 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2020-01-15T23:14:33.296Z,1579130073.296 [Default:A.Wait] Running Loop=1 2020-01-15T23:14:33.296Z,1579130073.296 [Default:A.Wait](DEBUG): Initialize Wait Component. 2020-01-15T23:14:33.703Z,1579130073.703 [DDM](INFO): Pause: Retracting whiskers 2020-01-15T23:14:34.111Z,1579130074.111 [DDM](INFO): Pausing: Closing Latch 2020-01-15T23:14:34.509Z,1579130074.509 [DDM](INFO): Pausing: Closing Latch 2020-01-15T23:14:34.547Z,1579130074.547 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:14:34.913Z,1579130074.913 [DDM](INFO): Pausing: Closing Latch 2020-01-15T23:14:35.317Z,1579130075.317 [DDM](INFO): Pausing: Closing Latch 2020-01-15T23:14:35.722Z,1579130075.722 [DDM](INFO): Pausing: Closing Latch 2020-01-15T23:14:36.562Z,1579130076.562 [Micromodem](FAULT): failed to initialize; deviceResponse_ loaded: , available: 2020-01-15T23:14:36.562Z,1579130076.562 [Micromodem] Communications Fault, FailCount= 4 2020-01-15T23:14:36.563Z,1579130076.563 [Micromodem](ERROR): Communications Fault 2020-01-15T23:14:36.666Z,1579130076.666 [CBIT](ERROR): Communications Fault in component: Micromodem 2020-01-15T23:14:36.994Z,1579130076.994 [Micromodem](INFO): Powering down 2020-01-15T23:14:37.897Z,1579130077.897 [CBIT](INFO): Clearing failed state for component Micromodem 2020-01-15T23:14:37.897Z,1579130077.897 [Micromodem] No Fault, FailCount= 4 2020-01-15T23:14:40.574Z,1579130080.574 [Micromodem](INFO): Powering up 2020-01-15T23:14:40.575Z,1579130080.575 [Micromodem](DEBUG): Initializing Micromodem. 2020-01-15T23:14:45.826Z,1579130085.826 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:14:46.689Z,1579130086.689 [Default:A.Wait](INFO): Done Waiting. 2020-01-15T23:14:46.689Z,1579130086.689 [Default:A.Wait] Stopped 2020-01-15T23:14:46.689Z,1579130086.689 [Default:A.Wait](DEBUG): Uninitialize Wait Component. 2020-01-15T23:14:47.090Z,1579130087.090 [Default:CheckIn] Running Loop=1 2020-01-15T23:14:47.090Z,1579130087.090 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2020-01-15T23:14:47.090Z,1579130087.090 [Default:CheckIn:Read_GPS] Running Loop=1 2020-01-15T23:14:57.142Z,1579130097.142 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:15:08.447Z,1579130108.447 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:15:15.868Z,1579130115.868 [CommandLine](IMPORTANT): got command load ./Missions/Insert/Docked.xml 2020-01-15T23:15:15.868Z,1579130115.868 [MissionManager](INFO): Loading Mission: ./Missions/Insert/Docked.xml 2020-01-15T23:15:15.906Z,1579130115.906 [MissionManager](INFO): DefineArg Docked.MaxDockRange = 8.000000 m 2020-01-15T23:15:15.908Z,1579130115.908 [MissionManager](INFO): DefineArg Docked.DetachedTimeout = 5.000000 min 2020-01-15T23:15:15.935Z,1579130115.935 [MissionManager](INFO): DefineArg Docked.Depth = 5.000000 m 2020-01-15T23:15:15.936Z,1579130115.936 [MissionManager](INFO): DefineArg Docked.TransponderCode = 2.000000 count 2020-01-15T23:15:15.951Z,1579130115.951 [MissionManager](INFO): DefineArg Docked.TrackingUpdatePeriod = 60.000000 s 2020-01-15T23:15:15.953Z,1579130115.953 [MissionManager](INFO): DefineArg Docked.NumberOfPings = 1.000000 count 2020-01-15T23:15:15.955Z,1579130115.955 [MissionManager](INFO): DefineArg Docked.Speed = 0.000000 m/s 2020-01-15T23:15:15.966Z,1579130115.966 [MissionManager](INFO): DefineArg Docked.DepthDeadband = 1.500000 m 2020-01-15T23:15:15.968Z,1579130115.968 [MissionManager](INFO): DefineArg Docked.PitchLimit = 20.000000 arcdeg 2020-01-15T23:15:15.975Z,1579130115.975 [MissionManager](INFO): DefineArg Docked.MinDepth = 1.000000 m 2020-01-15T23:15:15.985Z,1579130115.985 [MissionManager](INFO): DefineArg Docked.MaxDepth = 215.000000 m 2020-01-15T23:15:15.986Z,1579130115.986 [Docked:A.DepthEnvelope](DEBUG): Construct DepthEnvelope. 2020-01-15T23:15:16.036Z,1579130116.036 [Docked:E.Pitch](DEBUG): Construct. 2020-01-15T23:15:16.044Z,1579130116.044 [Docked:F.SetSpeed](DEBUG): Construct. 2020-01-15T23:15:16.051Z,1579130116.051 [Docked:G.Docked](DEBUG): Construct. 2020-01-15T23:15:16.068Z,1579130116.068 [MissionManager](DEBUG): Maximum range allowed from the dock. 8 Time duration limit for determining if the vehicle is detached from the dock. 5 Depth to maintain while docked. 5 Transponder Address. 2 How long to wait between acoustic queries. 60 Number of pings requested each time. 1 Thruster speed while docked. 0.0 How much vertical drift from the specified depth is allowed while docked. 1.5 Max vehicle pitch (+/-) while on dock. 20 Minimum depth while docked. Maximum depth while docked. <0.0 2020-01-15T23:15:16.068Z,1579130116.068 [CommandLine](IMPORTANT): Loaded ./Missions/Insert/Docked.xml 2020-01-15T23:15:19.766Z,1579130119.766 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:15:26.678Z,1579130126.678 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3 2020-01-15T23:15:26.678Z,1579130126.678 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-01-15T23:15:26.710Z,1579130126.710 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-01-15T23:15:27.122Z,1579130127.122 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-01-15T23:15:27.122Z,1579130127.122 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3 2020-01-15T23:15:29.486Z,1579130129.486 [CommandLine](IMPORTANT): got command set Docked.DetachedTimeout 10.000000 2020-01-15T23:15:29.486Z,1579130129.486 [CommandLine](FAULT): Incomplete syntax. Try: help set 2020-01-15T23:15:31.074Z,1579130131.074 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:15:33.226Z,1579130133.226 [CommandLine](IMPORTANT): got command set Docked.DetachedTimeout 10.000000 second 2020-01-15T23:15:40.848Z,1579130140.848 [CommandLine](IMPORTANT): got command run 2020-01-15T23:15:40.849Z,1579130140.849 [CommandLine](IMPORTANT): Running 2020-01-15T23:15:41.224Z,1579130141.224 [Default] Stopped 2020-01-15T23:15:41.224Z,1579130141.224 [Default](DEBUG): Aggregate::uninitialize Default 2020-01-15T23:15:41.224Z,1579130141.224 [Default:B.GoToSurface] Stopped 2020-01-15T23:15:41.224Z,1579130141.224 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2020-01-15T23:15:41.224Z,1579130141.224 [Default:CheckIn] Stopped 2020-01-15T23:15:41.224Z,1579130141.224 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2020-01-15T23:15:41.225Z,1579130141.225 [Default:CheckIn:Read_GPS] Stopped 2020-01-15T23:15:41.241Z,1579130141.241 [MissionManager](IMPORTANT): Started mission Docked 2020-01-15T23:15:41.241Z,1579130141.241 [Docked] Running Loop=1 2020-01-15T23:15:41.241Z,1579130141.241 [Docked](DEBUG): Aggregate::initialize Docked 2020-01-15T23:15:41.241Z,1579130141.241 [Docked:A.DepthEnvelope] Running Loop=1 2020-01-15T23:15:41.241Z,1579130141.241 [Docked:A.DepthEnvelope](DEBUG): Initialize DepthEnvelopeComponent. 2020-01-15T23:15:41.241Z,1579130141.241 [Docked:B.] Running Loop=1 2020-01-15T23:15:41.242Z,1579130141.242 [Docked:B.](INFO): Initializing TrackAcousticContact. 2020-01-15T23:15:41.242Z,1579130141.242 [Docked:C] Running Loop=1 2020-01-15T23:15:41.242Z,1579130141.242 [Docked:D] Running Loop=1 2020-01-15T23:15:41.242Z,1579130141.242 [Docked:E.Pitch] Running Loop=1 2020-01-15T23:15:41.242Z,1579130141.242 [Docked:E.Pitch](DEBUG): Initialize. 2020-01-15T23:15:41.242Z,1579130141.242 [Docked:F.SetSpeed] Running Loop=1 2020-01-15T23:15:41.242Z,1579130141.242 [Docked:F.SetSpeed](DEBUG): Initialize. 2020-01-15T23:15:41.242Z,1579130141.242 [Docked:G.Docked] Running Loop=1 2020-01-15T23:15:41.242Z,1579130141.242 [Docked:G.Docked](DEBUG): Initialize. 2020-01-15T23:15:41.243Z,1579130141.243 [Docked:F.SetSpeed] Running Loop=1 2020-01-15T23:15:41.243Z,1579130141.243 [Docked:E.Pitch] Running Loop=1 2020-01-15T23:15:41.243Z,1579130141.243 [Docked:D] Running Loop=1 2020-01-15T23:15:41.243Z,1579130141.243 [Docked:C] Running Loop=1 2020-01-15T23:15:41.244Z,1579130141.244 [Docked:B.] Running Loop=1 2020-01-15T23:15:41.244Z,1579130141.244 [Docked:A.DepthEnvelope] Running Loop=1 2020-01-15T23:15:42.491Z,1579130142.491 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:15:42.784Z,1579130142.784 [DDM](INFO): Closing Latch 2020-01-15T23:15:43.189Z,1579130143.189 [DDM](INFO): Closing Latch 2020-01-15T23:15:43.598Z,1579130143.598 [DDM](INFO): Closing Latch 2020-01-15T23:15:44.001Z,1579130144.001 [DDM](INFO): Closing Latch 2020-01-15T23:15:44.401Z,1579130144.401 [DDM](INFO): Closing Latch 2020-01-15T23:15:44.804Z,1579130144.804 [DDM](INFO): Closing Latch 2020-01-15T23:15:45.209Z,1579130145.209 [DDM](INFO): Closing Latch 2020-01-15T23:15:53.703Z,1579130153.703 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:16:04.738Z,1579130164.738 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:16:13.556Z,1579130173.556 [CommandLine](IMPORTANT): got command show stack 2020-01-15T23:16:13.556Z,1579130173.556 [CommandLine](IMPORTANT): Behavior Stack: 2020-01-15T23:16:13.556Z,1579130173.556 [Docked](IMPORTANT): Priority 0: Docked:A.DepthEnvelope 2020-01-15T23:16:13.556Z,1579130173.556 [Docked](IMPORTANT): Priority 1: Docked:B. 2020-01-15T23:16:13.557Z,1579130173.557 [Docked](IMPORTANT): Priority 2: Docked:C 2020-01-15T23:16:13.557Z,1579130173.557 [Docked](IMPORTANT): Priority 3: Docked:D 2020-01-15T23:16:13.557Z,1579130173.557 [Docked](IMPORTANT): Priority 4: Docked:E.Pitch 2020-01-15T23:16:13.557Z,1579130173.557 [Docked](IMPORTANT): Priority 5: Docked:F.SetSpeed 2020-01-15T23:16:13.558Z,1579130173.558 [Docked](IMPORTANT): Priority 6: Docked:G.Docked 2020-01-15T23:16:16.050Z,1579130176.050 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:16:27.091Z,1579130187.091 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:16:38.398Z,1579130198.398 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:16:40.415Z,1579130200.415 [Micromodem](FAULT): failed to initialize; deviceResponse_ loaded: , available: 2020-01-15T23:16:40.415Z,1579130200.415 [Micromodem] Communications Fault, FailCount= 5 2020-01-15T23:16:40.415Z,1579130200.415 [Micromodem](ERROR): Communications Fault 2020-01-15T23:16:40.558Z,1579130200.558 [CBIT](ERROR): Communications Fault in component: Micromodem 2020-01-15T23:16:40.818Z,1579130200.818 [Micromodem](INFO): Powering down 2020-01-15T23:16:41.278Z,1579130201.278 [Docked:B.](INFO): *** querying acoustic contact *** 2020-01-15T23:16:41.701Z,1579130201.701 [CBIT](INFO): Clearing failed state for component Micromodem 2020-01-15T23:16:41.702Z,1579130201.702 [Micromodem] No Fault, FailCount= 5 2020-01-15T23:16:44.447Z,1579130204.447 [Micromodem](INFO): Powering up 2020-01-15T23:16:44.447Z,1579130204.447 [Micromodem](DEBUG): Initializing Micromodem. 2020-01-15T23:16:47.735Z,1579130207.735 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error 2020-01-15T23:16:47.735Z,1579130207.735 [RDI_Pathfinder](ERROR): Failed to parse: :TS,20011516285400,35.0, -0.1, 0.0,1448.9,, 0.00, 0.00, 0.00, 0.00, 0.00 2020-01-15T23:16:49.447Z,1579130209.447 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:17:00.754Z,1579130220.754 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:17:02.780Z,1579130222.780 [CommandLine](IMPORTANT): got command get Docked.DetachedTimeout 2020-01-15T23:17:02.780Z,1579130222.780 [CommandLine](IMPORTANT): Docked.DetachedTimeout 0.166667 min 2020-01-15T23:17:03.183Z,1579130223.183 [NAL9602](FAULT): GPS failed to acquire within timeout. 2020-01-15T23:17:03.183Z,1579130223.183 [NAL9602] Data Fault, FailCount= 1 2020-01-15T23:17:03.183Z,1579130223.183 [NAL9602](ERROR): Data Fault 2020-01-15T23:17:03.321Z,1579130223.321 [CBIT](ERROR): Data Fault in component: NAL9602 2020-01-15T23:17:03.576Z,1579130223.576 [NAL9602](INFO): Powering down 2020-01-15T23:17:04.523Z,1579130224.523 [CBIT](INFO): Clearing failed state for component NAL9602 2020-01-15T23:17:04.523Z,1579130224.523 [NAL9602] No Fault, FailCount= 1 2020-01-15T23:17:12.186Z,1579130232.186 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:17:23.494Z,1579130243.494 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:17:26.180Z,1579130246.180 [CommandLine](IMPORTANT): got command report mod DDM.cablePresent 2020-01-15T23:17:26.467Z,1579130246.467 [Reporter](INFO): DDM.cablePresent 0 bool 2020-01-15T23:17:33.599Z,1579130253.599 [NAL9602](INFO): Powering up NAL9602 2020-01-15T23:17:34.819Z,1579130254.819 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:17:41.418Z,1579130261.418 [Docked:B.](INFO): *** querying acoustic contact *** 2020-01-15T23:17:44.627Z,1579130264.627 [NAL9602](INFO): NAL9602 initialized 2020-01-15T23:17:45.839Z,1579130265.839 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:17:57.150Z,1579130277.150 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:17:58.180Z,1579130278.180 [CommandLine](IMPORTANT): got command report mod DDM.cablePresent 2020-01-15T23:18:08.490Z,1579130288.490 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:18:15.466Z,1579130295.466 [CommandLine](IMPORTANT): got command get DDM.cablePresent 2020-01-15T23:18:15.466Z,1579130295.466 [CommandLine](IMPORTANT): DDM.cablePresent 0 bool 2020-01-15T23:18:19.803Z,1579130299.803 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:18:27.575Z,1579130307.575 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4 2020-01-15T23:18:27.576Z,1579130307.576 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-01-15T23:18:27.600Z,1579130307.600 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-01-15T23:18:28.018Z,1579130308.018 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-01-15T23:18:28.018Z,1579130308.018 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4 2020-01-15T23:18:31.179Z,1579130311.179 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:18:34.446Z,1579130314.446 [RDI_Pathfinder](ERROR): only read 3 of 4 data items 2020-01-15T23:18:34.446Z,1579130314.446 [RDI_Pathfinder](ERROR): Failed to parse: :RA, 0.00, 0.00, 0.00, 0.00 2020-01-15T23:18:41.724Z,1579130321.724 [Docked:B.](INFO): *** querying acoustic contact *** 2020-01-15T23:18:42.487Z,1579130322.487 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:18:44.103Z,1579130324.103 [Micromodem](FAULT): failed to initialize; deviceResponse_ loaded: , available: 2020-01-15T23:18:44.103Z,1579130324.103 [Micromodem] Communications Fault, FailCount= 6 2020-01-15T23:18:44.103Z,1579130324.103 [Micromodem](ERROR): Communications Fault 2020-01-15T23:18:44.213Z,1579130324.213 [CBIT](ERROR): Communications Fault in component: Micromodem 2020-01-15T23:18:44.495Z,1579130324.495 [Micromodem](INFO): Powering down 2020-01-15T23:18:45.380Z,1579130325.380 [CBIT](INFO): Clearing failed state for component Micromodem 2020-01-15T23:18:45.380Z,1579130325.380 [Micromodem] No Fault, FailCount= 6 2020-01-15T23:18:48.201Z,1579130328.201 [Micromodem](INFO): Powering up 2020-01-15T23:18:48.202Z,1579130328.202 [Micromodem](DEBUG): Initializing Micromodem. 2020-01-15T23:18:53.851Z,1579130333.851 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:19:05.162Z,1579130345.162 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:19:16.506Z,1579130356.506 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:19:27.811Z,1579130367.811 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:19:39.199Z,1579130379.199 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:19:42.085Z,1579130382.085 [Docked:B.](INFO): *** querying acoustic contact *** 2020-01-15T23:19:50.510Z,1579130390.510 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:20:01.883Z,1579130401.883 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:20:05.552Z,1579130405.552 [CommandLine](IMPORTANT): got command stop 2020-01-15T23:20:05.552Z,1579130405.552 [Supervisor](INFO): Stop Mission called by CommandLine::commandStop 2020-01-15T23:20:05.611Z,1579130405.611 [MissionManager](INFO): MissionManager is completed. 2020-01-15T23:20:05.611Z,1579130405.611 [MissionManager](INFO): Uninitializing Mission Docked 2020-01-15T23:20:05.611Z,1579130405.611 [Docked] Stopped 2020-01-15T23:20:05.611Z,1579130405.611 [Docked](DEBUG): Aggregate::uninitialize Docked 2020-01-15T23:20:05.611Z,1579130405.611 [Docked:A.DepthEnvelope] Stopped 2020-01-15T23:20:05.611Z,1579130405.611 [Docked:A.DepthEnvelope](DEBUG): Uninitialize. 2020-01-15T23:20:05.611Z,1579130405.611 [Docked:B.] Stopped 2020-01-15T23:20:05.611Z,1579130405.611 [Docked:C] Stopped 2020-01-15T23:20:05.611Z,1579130405.611 [Docked:D] Stopped 2020-01-15T23:20:05.612Z,1579130405.612 [Docked:E.Pitch] Stopped 2020-01-15T23:20:05.612Z,1579130405.612 [Docked:F.SetSpeed] Stopped 2020-01-15T23:20:05.612Z,1579130405.612 [Docked:F.SetSpeed](DEBUG): Uninitialize. 2020-01-15T23:20:05.612Z,1579130405.612 [Docked:G.Docked] Stopped 2020-01-15T23:20:05.960Z,1579130405.960 [MissionManager](IMPORTANT): Started mission Default 2020-01-15T23:20:05.960Z,1579130405.960 [Default] Running Loop=1 2020-01-15T23:20:05.961Z,1579130405.961 [Default](DEBUG): Aggregate::initialize Default 2020-01-15T23:20:05.961Z,1579130405.961 [Default:B.GoToSurface] Running Loop=1 2020-01-15T23:20:05.961Z,1579130405.961 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2020-01-15T23:20:05.961Z,1579130405.961 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2020-01-15T23:20:05.961Z,1579130405.961 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2020-01-15T23:20:05.962Z,1579130405.962 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2020-01-15T23:20:05.962Z,1579130405.962 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2020-01-15T23:20:05.962Z,1579130405.962 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2020-01-15T23:20:05.963Z,1579130405.963 [Default:A.Wait] Running Loop=1 2020-01-15T23:20:05.963Z,1579130405.963 [Default:A.Wait](DEBUG): Initialize Wait Component. 2020-01-15T23:20:05.973Z,1579130405.973 [Reporter](INFO): DDM.cablePresent no_value 2020-01-15T23:20:06.330Z,1579130406.330 [DDM](INFO): Pause: Retracting whiskers 2020-01-15T23:20:06.717Z,1579130406.717 [DDM](INFO): Pausing: Closing Latch 2020-01-15T23:20:07.120Z,1579130407.120 [DDM](INFO): Pausing: Closing Latch 2020-01-15T23:20:07.525Z,1579130407.525 [DDM](INFO): Pausing: Closing Latch 2020-01-15T23:20:08.018Z,1579130408.018 [DDM](INFO): Pausing: Closing Latch 2020-01-15T23:20:13.278Z,1579130413.278 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:20:18.998Z,1579130418.998 [Default:A.Wait](INFO): Done Waiting. 2020-01-15T23:20:18.998Z,1579130418.998 [Default:A.Wait] Stopped 2020-01-15T23:20:18.998Z,1579130418.998 [Default:A.Wait](DEBUG): Uninitialize Wait Component. 2020-01-15T23:20:19.374Z,1579130419.374 [Default:CheckIn] Running Loop=1 2020-01-15T23:20:19.374Z,1579130419.374 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2020-01-15T23:20:19.375Z,1579130419.375 [Default:CheckIn:Read_GPS] Running Loop=1 2020-01-15T23:20:24.590Z,1579130424.590 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:20:35.902Z,1579130435.902 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:20:40.371Z,1579130440.371 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error 2020-01-15T23:20:40.371Z,1579130440.371 [RDI_Pathfinder](ERROR): Failed to parse: :TS,20011516324700,35.0, -0.1, 48.9, 0 2020-01-15T23:20:47.210Z,1579130447.210 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:20:48.027Z,1579130448.027 [Micromodem](FAULT): failed to initialize; deviceResponse_ loaded: , available: 2020-01-15T23:20:48.027Z,1579130448.027 [Micromodem] Communications Fault, FailCount= 7 2020-01-15T23:20:48.027Z,1579130448.027 [Micromodem](ERROR): Communications Fault 2020-01-15T23:20:48.157Z,1579130448.157 [CBIT](ERROR): Communications Fault in component: Micromodem 2020-01-15T23:20:48.418Z,1579130448.418 [Micromodem](INFO): Powering down 2020-01-15T23:20:49.333Z,1579130449.333 [CBIT](INFO): Clearing failed state for component Micromodem 2020-01-15T23:20:49.333Z,1579130449.333 [Micromodem] No Fault, FailCount= 7 2020-01-15T23:20:52.054Z,1579130452.054 [Micromodem](INFO): Powering up 2020-01-15T23:20:52.055Z,1579130452.055 [Micromodem](DEBUG): Initializing Micromodem. 2020-01-15T23:20:58.522Z,1579130458.522 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:21:09.834Z,1579130469.834 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:21:21.146Z,1579130481.146 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:21:24.839Z,1579130484.839 [CBIT](INFO): Clearing failed state for component CTD_NeilBrown 2020-01-15T23:21:24.839Z,1579130484.839 [CTD_NeilBrown] No Fault, FailCount= 1 2020-01-15T23:21:24.889Z,1579130484.889 [CTD_NeilBrown](DEBUG): Initializing CTD_NeilBrown. 2020-01-15T23:21:25.250Z,1579130485.250 [CBIT](INFO): Clearing failed state for component DropWeight 2020-01-15T23:21:25.251Z,1579130485.251 [DropWeight] No Fault, FailCount= 1 2020-01-15T23:21:28.450Z,1579130488.450 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 5 2020-01-15T23:21:28.450Z,1579130488.450 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-01-15T23:21:28.459Z,1579130488.459 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-01-15T23:21:28.866Z,1579130488.866 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-01-15T23:21:28.866Z,1579130488.866 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 5 2020-01-15T23:21:32.472Z,1579130492.472 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:21:34.508Z,1579130494.508 [RDI_Pathfinder](ERROR): No DVL communication! Re-initializing 2020-01-15T23:21:34.508Z,1579130494.508 [RDI_Pathfinder] Communications Fault, FailCount= 1 2020-01-15T23:21:34.508Z,1579130494.508 [RDI_Pathfinder](ERROR): Communications Fault 2020-01-15T23:21:34.524Z,1579130494.524 [CBIT](ERROR): Communications Fault in component: RDI_Pathfinder 2020-01-15T23:21:34.981Z,1579130494.981 [RDI_Pathfinder](INFO): Powering down 2020-01-15T23:21:35.734Z,1579130495.734 [CBIT](INFO): Clearing failed state for component RDI_Pathfinder 2020-01-15T23:21:35.734Z,1579130495.734 [RDI_Pathfinder] No Fault, FailCount= 1 2020-01-15T23:21:42.965Z,1579130502.965 [AHRS_M2](FAULT): Failed to acquire valid data within timeout. 2020-01-15T23:21:42.965Z,1579130502.965 [AHRS_M2] Data Fault, FailCount= 1 2020-01-15T23:21:42.965Z,1579130502.965 [AHRS_M2](ERROR): Data Fault 2020-01-15T23:21:43.062Z,1579130503.062 [CBIT](ERROR): Data Fault in component: AHRS_M2 2020-01-15T23:21:43.356Z,1579130503.356 [AHRS_M2](INFO): Powering down 2020-01-15T23:21:43.763Z,1579130503.763 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:21:44.210Z,1579130504.210 [CBIT](INFO): Clearing failed state for component AHRS_M2 2020-01-15T23:21:44.210Z,1579130504.210 [AHRS_M2] No Fault, FailCount= 1 2020-01-15T23:21:44.568Z,1579130504.568 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2020-01-15T23:21:55.094Z,1579130515.094 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:21:57.913Z,1579130517.913 [AHRS_M2](FAULT): Failed to acquire valid data within timeout. 2020-01-15T23:21:57.913Z,1579130517.913 [AHRS_M2] Data Fault, FailCount= 2 2020-01-15T23:21:57.913Z,1579130517.913 [AHRS_M2](ERROR): Data Fault 2020-01-15T23:21:57.995Z,1579130517.995 [CBIT](ERROR): Data Fault in component: AHRS_M2 2020-01-15T23:21:58.304Z,1579130518.304 [AHRS_M2](INFO): Powering down 2020-01-15T23:21:58.398Z,1579130518.398 [RDI_Pathfinder](ERROR): No DVL communication! Re-initializing 2020-01-15T23:21:58.398Z,1579130518.398 [RDI_Pathfinder] Communications Fault, FailCount= 2 2020-01-15T23:21:58.398Z,1579130518.398 [RDI_Pathfinder](ERROR): Communications Fault 2020-01-15T23:21:58.414Z,1579130518.414 [CBIT](ERROR): Communications Fault in component: RDI_Pathfinder 2020-01-15T23:21:58.801Z,1579130518.801 [RDI_Pathfinder](INFO): Powering down 2020-01-15T23:21:59.153Z,1579130519.153 [CBIT](INFO): Clearing failed state for component AHRS_M2 2020-01-15T23:21:59.153Z,1579130519.153 [AHRS_M2] No Fault, FailCount= 2 2020-01-15T23:21:59.516Z,1579130519.516 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2020-01-15T23:21:59.562Z,1579130519.562 [CBIT](INFO): Clearing failed state for component RDI_Pathfinder 2020-01-15T23:21:59.562Z,1579130519.562 [RDI_Pathfinder] No Fault, FailCount= 2 2020-01-15T23:22:06.398Z,1579130526.398 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:22:12.886Z,1579130532.886 [RDI_Pathfinder](ERROR): Failed to parse:> 2020-01-15T23:22:17.706Z,1579130537.706 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:22:29.019Z,1579130549.019 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:22:40.338Z,1579130560.338 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:22:51.643Z,1579130571.643 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:22:52.043Z,1579130572.043 [Micromodem](FAULT): failed to initialize; deviceResponse_ loaded: , available: 2020-01-15T23:22:52.043Z,1579130572.043 [Micromodem] Communications Fault, FailCount= 8 2020-01-15T23:22:52.043Z,1579130572.043 [Micromodem](ERROR): Communications Fault 2020-01-15T23:22:52.143Z,1579130572.143 [CBIT](ERROR): Communications Fault in component: Micromodem 2020-01-15T23:22:52.144Z,1579130572.144 [CBIT](FAULT): Communications Fault in component: Micromodem 2020-01-15T23:22:52.456Z,1579130572.456 [Micromodem](INFO): Powering down 2020-01-15T23:24:29.453Z,1579130669.453 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 6 2020-01-15T23:24:29.453Z,1579130669.453 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-01-15T23:24:29.490Z,1579130669.490 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-01-15T23:24:29.863Z,1579130669.863 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-01-15T23:24:29.863Z,1579130669.863 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 6 2020-01-15T23:25:19.551Z,1579130719.551 [Default:CheckIn:Read_GPS](INFO): Timed out from 2020-01-15T23:20:19.4Z 2020-01-15T23:25:19.551Z,1579130719.551 [Default:CheckIn:Read_GPS] Stopped 2020-01-15T23:25:19.551Z,1579130719.551 [Default:CheckIn:Read_Iridium] Running Loop=1 2020-01-15T23:25:19.972Z,1579130719.972 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications 2020-01-15T23:27:30.462Z,1579130850.462 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 7 2020-01-15T23:27:30.462Z,1579130850.462 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-01-15T23:27:30.471Z,1579130850.471 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-01-15T23:27:30.866Z,1579130850.866 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-01-15T23:27:30.866Z,1579130850.866 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 7 2020-01-15T23:27:47.387Z,1579130867.387 [NAL9602](FAULT): GPS failed to acquire within timeout. 2020-01-15T23:27:47.387Z,1579130867.387 [NAL9602] Data Fault, FailCount= 2 2020-01-15T23:27:47.387Z,1579130867.387 [NAL9602](ERROR): Data Fault 2020-01-15T23:27:47.417Z,1579130867.417 [CBIT](ERROR): Data Fault in component: NAL9602 2020-01-15T23:27:47.787Z,1579130867.787 [NAL9602](INFO): Powering down 2020-01-15T23:27:48.265Z,1579130868.265 [RDI_Pathfinder](ERROR): DVL uart error: serial timeout 2020-01-15T23:27:48.265Z,1579130868.265 [RDI_Pathfinder] Communications Fault, FailCount= 1 2020-01-15T23:27:48.265Z,1579130868.265 [RDI_Pathfinder](ERROR): Communications Fault 2020-01-15T23:27:48.265Z,1579130868.265 [RDI_Pathfinder](ERROR): Failed to parse: 2020-01-15T23:27:48.332Z,1579130868.332 [CBIT](ERROR): Communications Fault in component: RDI_Pathfinder 2020-01-15T23:27:48.677Z,1579130868.677 [RDI_Pathfinder](INFO): Powering down 2020-01-15T23:27:48.693Z,1579130868.693 [CBIT](INFO): Clearing failed state for component NAL9602 2020-01-15T23:27:48.693Z,1579130868.693 [NAL9602] No Fault, FailCount= 2 2020-01-15T23:27:49.424Z,1579130869.424 [CBIT](INFO): Clearing failed state for component RDI_Pathfinder 2020-01-15T23:27:49.424Z,1579130869.424 [RDI_Pathfinder] No Fault, FailCount= 1 2020-01-15T23:27:52.259Z,1579130872.259 [CBIT](INFO): Clearing failed state for component Micromodem 2020-01-15T23:27:52.259Z,1579130872.259 [Micromodem] No Fault, FailCount= 8 2020-01-15T23:27:53.034Z,1579130873.034 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:27:53.035Z,1579130873.035 [Micromodem](INFO): Powering up 2020-01-15T23:27:53.035Z,1579130873.035 [Micromodem](DEBUG): Initializing Micromodem. 2020-01-15T23:28:02.746Z,1579130882.746 [RDI_Pathfinder](ERROR): Failed to parse:Pathfinder 2020-01-15T23:28:04.350Z,1579130884.350 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:28:15.672Z,1579130895.672 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:28:18.079Z,1579130898.079 [NAL9602](INFO): Powering up NAL9602 2020-01-15T23:28:26.970Z,1579130906.970 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:28:28.991Z,1579130908.991 [NAL9602](INFO): NAL9602 initialized 2020-01-15T23:28:33.076Z,1579130913.076 [RDI_Pathfinder](ERROR): Failed to parse: :RA, 0.00, 0.00, 0.00, 0.00, 0.00 2020-01-15T23:28:38.286Z,1579130918.286 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:28:49.595Z,1579130929.595 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:29:00.907Z,1579130940.907 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:29:12.222Z,1579130952.222 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:29:23.531Z,1579130963.531 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:29:34.842Z,1579130974.842 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:29:46.151Z,1579130986.151 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:29:53.019Z,1579130993.019 [Micromodem](FAULT): failed to initialize; deviceResponse_ loaded: , available: 2020-01-15T23:29:53.019Z,1579130993.019 [Micromodem] Communications Fault, FailCount= 1 2020-01-15T23:29:53.019Z,1579130993.019 [Micromodem](ERROR): Communications Fault 2020-01-15T23:29:53.099Z,1579130993.099 [CBIT](ERROR): Communications Fault in component: Micromodem 2020-01-15T23:29:53.432Z,1579130993.432 [Micromodem](INFO): Powering down 2020-01-15T23:29:53.830Z,1579130993.830 [Micromodem](FAULT): LCB 2 fault: Software Overcurrent. 2020-01-15T23:29:53.830Z,1579130993.830 [Micromodem] Hardware Fault, FailCount= 1 2020-01-15T23:29:53.830Z,1579130993.830 [Micromodem](ERROR): Hardware Fault 2020-01-15T23:29:54.293Z,1579130994.293 [CBIT](INFO): Clearing failed state for component Micromodem 2020-01-15T23:29:54.293Z,1579130994.293 [Micromodem] No Fault, FailCount= 1 2020-01-15T23:29:57.059Z,1579130997.059 [Micromodem](INFO): Powering up 2020-01-15T23:29:57.059Z,1579130997.059 [Micromodem](DEBUG): Initializing Micromodem. 2020-01-15T23:29:57.466Z,1579130997.466 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:30:08.778Z,1579131008.778 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:30:20.095Z,1579131020.095 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:30:31.403Z,1579131031.403 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:30:31.466Z,1579131031.466 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 8 2020-01-15T23:30:31.466Z,1579131031.466 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-01-15T23:30:31.501Z,1579131031.501 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-01-15T23:30:31.860Z,1579131031.860 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-01-15T23:30:31.860Z,1579131031.860 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 8 2020-01-15T23:30:42.719Z,1579131042.719 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:30:54.023Z,1579131054.023 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:31:05.339Z,1579131065.339 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:31:16.658Z,1579131076.658 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:31:27.959Z,1579131087.959 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:31:32.055Z,1579131092.055 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for altitude 2020-01-15T23:31:32.055Z,1579131092.055 [RDI_Pathfinder](ERROR): Failed to parse: :BD, +0.00, +0 +0.00, 0.00,209.00 2020-01-15T23:31:39.275Z,1579131099.275 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:31:50.586Z,1579131110.586 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:31:57.051Z,1579131117.051 [Micromodem](FAULT): failed to initialize; deviceResponse_ loaded: , available: 2020-01-15T23:31:57.051Z,1579131117.051 [Micromodem] Communications Fault, FailCount= 2 2020-01-15T23:31:57.051Z,1579131117.051 [Micromodem](ERROR): Communications Fault 2020-01-15T23:31:57.130Z,1579131117.130 [CBIT](ERROR): Communications Fault in component: Micromodem 2020-01-15T23:31:57.459Z,1579131117.459 [Micromodem](INFO): Powering down 2020-01-15T23:31:58.319Z,1579131118.319 [CBIT](INFO): Clearing failed state for component Micromodem 2020-01-15T23:31:58.319Z,1579131118.319 [Micromodem] No Fault, FailCount= 2 2020-01-15T23:32:01.087Z,1579131121.087 [Micromodem](INFO): Powering up 2020-01-15T23:32:01.087Z,1579131121.087 [Micromodem](DEBUG): Initializing Micromodem. 2020-01-15T23:32:01.902Z,1579131121.902 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:32:12.426Z,1579131132.426 [RDI_Pathfinder](ERROR): Failed to parse:.00, 0.00, 0.00, 0.00, 0.00 2020-01-15T23:32:13.207Z,1579131133.207 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:32:24.523Z,1579131144.523 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:32:35.838Z,1579131155.838 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:32:47.143Z,1579131167.143 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:32:56.881Z,1579131176.881 [RDI_Pathfinder](ERROR): Failed to parse: :SA, +0.00, +0.00, 0.00 2020-01-15T23:32:58.459Z,1579131178.459 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:33:09.771Z,1579131189.771 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:33:21.086Z,1579131201.086 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:33:32.399Z,1579131212.399 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:33:32.479Z,1579131212.479 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 9 2020-01-15T23:33:32.479Z,1579131212.479 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-01-15T23:33:32.497Z,1579131212.497 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-01-15T23:33:32.846Z,1579131212.846 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-01-15T23:33:32.846Z,1579131212.846 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 9 2020-01-15T23:33:43.715Z,1579131223.715 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:33:55.019Z,1579131235.019 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:34:01.080Z,1579131241.080 [Micromodem](FAULT): failed to initialize; deviceResponse_ loaded: , available: 2020-01-15T23:34:01.080Z,1579131241.080 [Micromodem] Communications Fault, FailCount= 3 2020-01-15T23:34:01.080Z,1579131241.080 [Micromodem](ERROR): Communications Fault 2020-01-15T23:34:01.123Z,1579131241.123 [CBIT](ERROR): Communications Fault in component: Micromodem 2020-01-15T23:34:01.482Z,1579131241.482 [Micromodem](INFO): Powering down 2020-01-15T23:34:02.368Z,1579131242.368 [CBIT](INFO): Clearing failed state for component Micromodem 2020-01-15T23:34:02.368Z,1579131242.368 [Micromodem] No Fault, FailCount= 3 2020-01-15T23:34:05.118Z,1579131245.118 [Micromodem](INFO): Powering up 2020-01-15T23:34:05.119Z,1579131245.119 [Micromodem](DEBUG): Initializing Micromodem. 2020-01-15T23:34:06.330Z,1579131246.330 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:34:17.647Z,1579131257.647 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:34:28.966Z,1579131268.966 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:34:40.266Z,1579131280.266 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:34:51.578Z,1579131291.578 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:35:02.894Z,1579131302.894 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:35:14.198Z,1579131314.198 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:35:25.518Z,1579131325.518 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:35:36.827Z,1579131336.827 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:35:48.140Z,1579131348.140 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:35:59.456Z,1579131359.456 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:36:05.103Z,1579131365.103 [Micromodem](FAULT): failed to initialize; deviceResponse_ loaded: , available: 2020-01-15T23:36:05.103Z,1579131365.103 [Micromodem] Communications Fault, FailCount= 4 2020-01-15T23:36:05.103Z,1579131365.103 [Micromodem](ERROR): Communications Fault 2020-01-15T23:36:05.175Z,1579131365.175 [CBIT](ERROR): Communications Fault in component: Micromodem 2020-01-15T23:36:05.510Z,1579131365.510 [Micromodem](INFO): Powering down 2020-01-15T23:36:05.915Z,1579131365.915 [Micromodem](FAULT): LCB 2 fault: Software Overcurrent. 2020-01-15T23:36:05.915Z,1579131365.915 [Micromodem] Hardware Fault, FailCount= 4 2020-01-15T23:36:05.915Z,1579131365.915 [Micromodem](ERROR): Hardware Fault 2020-01-15T23:36:06.369Z,1579131366.369 [CBIT](INFO): Clearing failed state for component Micromodem 2020-01-15T23:36:06.369Z,1579131366.369 [Micromodem] No Fault, FailCount= 4 2020-01-15T23:36:09.153Z,1579131369.153 [Micromodem](INFO): Powering up 2020-01-15T23:36:09.153Z,1579131369.153 [Micromodem](DEBUG): Initializing Micromodem. 2020-01-15T23:36:10.770Z,1579131370.770 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:36:22.079Z,1579131382.079 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:36:33.392Z,1579131393.392 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:36:33.429Z,1579131393.429 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 10 2020-01-15T23:36:33.430Z,1579131393.430 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-01-15T23:36:33.479Z,1579131393.479 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-01-15T23:36:33.837Z,1579131393.837 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-01-15T23:36:33.837Z,1579131393.837 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 10 2020-01-15T23:36:44.706Z,1579131404.706 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:36:56.014Z,1579131416.014 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:37:07.322Z,1579131427.322 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:37:18.631Z,1579131438.631 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:37:29.951Z,1579131449.951 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:37:41.262Z,1579131461.262 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:37:52.571Z,1579131472.571 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:38:03.894Z,1579131483.894 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:38:09.135Z,1579131489.135 [Micromodem](FAULT): failed to initialize; deviceResponse_ loaded: , available: 2020-01-15T23:38:09.135Z,1579131489.135 [Micromodem] Communications Fault, FailCount= 5 2020-01-15T23:38:09.135Z,1579131489.135 [Micromodem](ERROR): Communications Fault 2020-01-15T23:38:09.214Z,1579131489.214 [CBIT](ERROR): Communications Fault in component: Micromodem 2020-01-15T23:38:09.543Z,1579131489.543 [Micromodem](INFO): Powering down 2020-01-15T23:38:09.946Z,1579131489.946 [Micromodem](FAULT): LCB 2 fault: Software Overcurrent. 2020-01-15T23:38:09.946Z,1579131489.946 [Micromodem] Hardware Fault, FailCount= 5 2020-01-15T23:38:09.946Z,1579131489.946 [Micromodem](ERROR): Hardware Fault 2020-01-15T23:38:10.407Z,1579131490.407 [CBIT](INFO): Clearing failed state for component Micromodem 2020-01-15T23:38:10.407Z,1579131490.407 [Micromodem] No Fault, FailCount= 5 2020-01-15T23:38:13.171Z,1579131493.171 [Micromodem](INFO): Powering up 2020-01-15T23:38:13.171Z,1579131493.171 [Micromodem](DEBUG): Initializing Micromodem. 2020-01-15T23:38:15.194Z,1579131495.194 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:38:26.510Z,1579131506.510 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:38:30.139Z,1579131510.139 [NAL9602](FAULT): GPS failed to acquire within timeout. 2020-01-15T23:38:30.140Z,1579131510.140 [NAL9602] Data Fault, FailCount= 3 2020-01-15T23:38:30.140Z,1579131510.140 [NAL9602](ERROR): Data Fault 2020-01-15T23:38:30.233Z,1579131510.233 [CBIT](ERROR): Data Fault in component: NAL9602 2020-01-15T23:38:30.547Z,1579131510.547 [NAL9602](INFO): Powering down 2020-01-15T23:38:31.400Z,1579131511.400 [CBIT](INFO): Clearing failed state for component NAL9602 2020-01-15T23:38:31.401Z,1579131511.401 [NAL9602] No Fault, FailCount= 3 2020-01-15T23:38:37.818Z,1579131517.818 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:38:49.127Z,1579131529.127 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:39:00.443Z,1579131540.443 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:39:00.843Z,1579131540.843 [NAL9602](INFO): Powering up NAL9602 2020-01-15T23:39:11.751Z,1579131551.751 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:39:11.754Z,1579131551.754 [NAL9602](INFO): NAL9602 initialized 2020-01-15T23:39:23.072Z,1579131563.072 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:39:34.385Z,1579131574.385 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:39:34.426Z,1579131574.426 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 11 2020-01-15T23:39:34.426Z,1579131574.426 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-01-15T23:39:34.488Z,1579131574.488 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-01-15T23:39:34.834Z,1579131574.834 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-01-15T23:39:34.834Z,1579131574.834 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 11 2020-01-15T23:39:45.691Z,1579131585.691 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:39:57.011Z,1579131597.011 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:40:08.315Z,1579131608.315 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:40:13.163Z,1579131613.163 [Micromodem](FAULT): failed to initialize; deviceResponse_ loaded: , available: 2020-01-15T23:40:13.163Z,1579131613.163 [Micromodem] Communications Fault, FailCount= 6 2020-01-15T23:40:13.163Z,1579131613.163 [Micromodem](ERROR): Communications Fault 2020-01-15T23:40:13.235Z,1579131613.235 [CBIT](ERROR): Communications Fault in component: Micromodem 2020-01-15T23:40:13.570Z,1579131613.570 [Micromodem](INFO): Powering down 2020-01-15T23:40:13.970Z,1579131613.970 [Micromodem](FAULT): LCB 1 fault: Software Overcurrent. 2020-01-15T23:40:13.971Z,1579131613.971 [Micromodem] Hardware Fault, FailCount= 6 2020-01-15T23:40:13.971Z,1579131613.971 [Micromodem](ERROR): Hardware Fault 2020-01-15T23:40:14.442Z,1579131614.442 [CBIT](INFO): Clearing failed state for component Micromodem 2020-01-15T23:40:14.442Z,1579131614.442 [Micromodem] No Fault, FailCount= 6 2020-01-15T23:40:17.202Z,1579131617.202 [Micromodem](INFO): Powering up 2020-01-15T23:40:17.203Z,1579131617.203 [Micromodem](DEBUG): Initializing Micromodem. 2020-01-15T23:40:19.626Z,1579131619.626 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:40:30.935Z,1579131630.935 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:40:39.876Z,1579131639.876 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for altitude 2020-01-15T23:40:39.876Z,1579131639.876 [RDI_Pathfinder](ERROR): Failed to parse: :BD, +0.00, +0.00, , 0.00,756.97 2020-01-15T23:40:42.251Z,1579131642.251 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:40:53.562Z,1579131653.562 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:41:04.882Z,1579131664.882 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:41:16.187Z,1579131676.187 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:41:27.498Z,1579131687.498 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:41:38.827Z,1579131698.827 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:41:50.130Z,1579131710.130 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:42:01.435Z,1579131721.435 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:42:12.754Z,1579131732.754 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:42:17.190Z,1579131737.190 [Micromodem](FAULT): failed to initialize; deviceResponse_ loaded: , available: 2020-01-15T23:42:17.191Z,1579131737.191 [Micromodem] Communications Fault, FailCount= 7 2020-01-15T23:42:17.191Z,1579131737.191 [Micromodem](ERROR): Communications Fault 2020-01-15T23:42:17.221Z,1579131737.221 [CBIT](ERROR): Communications Fault in component: Micromodem 2020-01-15T23:42:17.594Z,1579131737.594 [Micromodem](INFO): Powering down 2020-01-15T23:42:18.468Z,1579131738.468 [CBIT](INFO): Clearing failed state for component Micromodem 2020-01-15T23:42:18.468Z,1579131738.468 [Micromodem] No Fault, FailCount= 7 2020-01-15T23:42:18.956Z,1579131738.956 [CommandLine](IMPORTANT): got command get depth 2020-01-15T23:42:18.956Z,1579131738.956 [CommandLine](IMPORTANT): depth 0.145290 m 2020-01-15T23:42:21.227Z,1579131741.227 [Micromodem](INFO): Powering up 2020-01-15T23:42:21.227Z,1579131741.227 [Micromodem](DEBUG): Initializing Micromodem. 2020-01-15T23:42:24.059Z,1579131744.059 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:42:35.366Z,1579131755.366 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:42:35.423Z,1579131755.423 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 12 2020-01-15T23:42:35.423Z,1579131755.423 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-01-15T23:42:35.432Z,1579131755.432 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-01-15T23:42:35.821Z,1579131755.821 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-01-15T23:42:35.821Z,1579131755.821 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 12 2020-01-15T23:42:46.684Z,1579131766.684 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:42:57.991Z,1579131777.991 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:43:09.306Z,1579131789.306 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:43:20.622Z,1579131800.622 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:43:31.931Z,1579131811.931 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:43:43.239Z,1579131823.239 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:43:54.559Z,1579131834.559 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:44:05.871Z,1579131845.871 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:44:17.179Z,1579131857.179 [Micromodem](ERROR): Nmea resend: $CCCFG,ALL,0*33 2020-01-15T23:44:21.215Z,1579131861.215 [Micromodem](FAULT): failed to initialize; deviceResponse_ loaded: , available: 2020-01-15T23:44:21.215Z,1579131861.215 [Micromodem] Communications Fault, FailCount= 8 2020-01-15T23:44:21.215Z,1579131861.215 [Micromodem](ERROR): Communications Fault 2020-01-15T23:44:21.282Z,1579131861.282 [CBIT](ERROR): Communications Fault in component: Micromodem 2020-01-15T23:44:21.282Z,1579131861.282 [CBIT](FAULT): Communications Fault in component: Micromodem 2020-01-15T23:44:21.622Z,1579131861.622 [Micromodem](INFO): Powering down 2020-01-15T23:45:30.036Z,1579131930.036 [CommandLine](IMPORTANT): got command restart application 2020-01-15T23:45:31.049Z,1579131931.049 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2020-01-15T23:45:31.049Z,1579131931.049 [CommandLine ThreadHandler](INFO): Thread cancelled. 2020-01-15T23:45:31.221Z,1579131931.221 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2020-01-15T23:45:31.221Z,1579131931.221 [CommandLine ThreadHandler](INFO): Thread cancelled. 2020-01-15T23:45:31.222Z,1579131931.222 [CommandLine](INFO): Join timeout helper Thread ID is 5787 2020-01-15T23:45:31.222Z,1579131931.222 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2020-01-15T23:45:31.222Z,1579131931.222 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2020-01-15T23:45:31.223Z,1579131931.223 [NavChartDb](INFO): Join timeout helper Thread ID is 5788 2020-01-15T23:45:31.513Z,1579131931.513 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2020-01-15T23:45:31.513Z,1579131931.513 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2020-01-15T23:45:31.531Z,1579131931.531 [ComponentRegistry](INFO): Shutting down WetLabsSeaOWL_UV_A ThreadHandler 2020-01-15T23:45:31.531Z,1579131931.531 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Thread cancelled. 2020-01-15T23:45:31.531Z,1579131931.531 [WetLabsSeaOWL_UV_A](INFO): Join timeout helper Thread ID is 5789 2020-01-15T23:45:31.841Z,1579131931.841 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Uninitializing protected caller thread. 2020-01-15T23:45:31.841Z,1579131931.841 [WetLabsSeaOWL_UV_A](INFO): Powering down 2020-01-15T23:45:31.842Z,1579131931.842 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Thread cancelled. 2020-01-15T23:45:31.857Z,1579131931.857 [ComponentRegistry](INFO): Shutting down CTD_NeilBrown ThreadHandler 2020-01-15T23:45:31.857Z,1579131931.857 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled. 2020-01-15T23:45:31.857Z,1579131931.857 [CTD_NeilBrown](INFO): Join timeout helper Thread ID is 5790 2020-01-15T23:45:31.885Z,1579131931.885 [CTD_NeilBrown](INFO): Powering down 2020-01-15T23:45:31.897Z,1579131931.897 [CTD_NeilBrown ThreadHandler](INFO): Uninitializing protected caller thread. 2020-01-15T23:45:31.897Z,1579131931.897 [CTD_NeilBrown](INFO): Powering down 2020-01-15T23:45:31.909Z,1579131931.909 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled. 2020-01-15T23:45:31.925Z,1579131931.925 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler 2020-01-15T23:45:31.925Z,1579131931.925 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2020-01-15T23:45:31.927Z,1579131931.927 [DataOverHttps](INFO): Join timeout helper Thread ID is 5791 2020-01-15T23:45:31.941Z,1579131931.941 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread. 2020-01-15T23:45:31.941Z,1579131931.941 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2020-01-15T23:45:31.950Z,1579131931.950 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2020-01-15T23:45:31.950Z,1579131931.950 [logger ThreadHandler](INFO): Thread cancelled. 2020-01-15T23:45:31.950Z,1579131931.950 [logger](INFO): Join timeout helper Thread ID is 5792 2020-01-15T23:45:31.964Z,1579131931.964 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2020-01-15T23:45:31.964Z,1579131931.964 [logger ThreadHandler](INFO): Thread cancelled. 2020-01-15T23:45:31.974Z,1579131931.974 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2020-01-15T23:45:31.974Z,1579131931.974 [CommandLine ThreadHandler](INFO): Thread cancelled. 2020-01-15T23:45:31.974Z,1579131931.974 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2020-01-15T23:45:31.974Z,1579131931.974 [controlThread ThreadHandler](INFO): Thread cancelled. 2020-01-15T23:45:31.975Z,1579131931.975 [controlThread](INFO): Join timeout helper Thread ID is 5793 2020-01-15T23:45:31.987Z,1579131931.987 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2020-01-15T23:45:31.987Z,1579131931.987 [controlThread](DEBUG): Uninitializing ControlThread 2020-01-15T23:45:31.987Z,1579131931.987 [AHRS_M2](INFO): Powering down 2020-01-15T23:45:32.057Z,1579131932.057 [DDM](INFO): Powering down 2020-01-15T23:45:32.150Z,1579131932.150 [DUSBL_Hydroid](INFO): Powering down 2020-01-15T23:45:32.221Z,1579131932.221 [Micromodem](INFO): Powering down 2020-01-15T23:45:32.222Z,1579131932.222 [NAL9602](INFO): Powering down 2020-01-15T23:45:32.293Z,1579131932.293 [RDI_Pathfinder](INFO): Powering down 2020-01-15T23:45:32.294Z,1579131932.294 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator. 2020-01-15T23:45:32.295Z,1579131932.295 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator. 2020-01-15T23:45:32.296Z,1579131932.296 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2020-01-15T23:45:32.296Z,1579131932.296 [MissionManager](INFO): Uninitializing Mission Default 2020-01-15T23:45:32.296Z,1579131932.296 [Default] Stopped 2020-01-15T23:45:32.296Z,1579131932.296 [Default](DEBUG): Aggregate::uninitialize Default 2020-01-15T23:45:32.296Z,1579131932.296 [Default:B.GoToSurface] Stopped 2020-01-15T23:45:32.297Z,1579131932.297 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2020-01-15T23:45:32.297Z,1579131932.297 [Default:CheckIn] Stopped 2020-01-15T23:45:32.297Z,1579131932.297 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2020-01-15T23:45:32.297Z,1579131932.297 [Default:CheckIn:Read_Iridium] Stopped 2020-01-15T23:45:32.299Z,1579131932.299 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2020-01-15T23:45:32.299Z,1579131932.299 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2020-01-15T23:45:32.300Z,1579131932.300 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2020-01-15T23:45:32.300Z,1579131932.300 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2020-01-15T23:45:32.300Z,1579131932.300 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2020-01-15T23:45:32.300Z,1579131932.300 [BuoyancyServo](INFO): Powering down 2020-01-15T23:45:32.313Z,1579131932.313 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2020-01-15T23:45:32.313Z,1579131932.313 [ElevatorServo](INFO): Powering down 2020-01-15T23:45:32.314Z,1579131932.314 [MassServo](DEBUG): Uninitialize Mass Servo. 2020-01-15T23:45:32.314Z,1579131932.314 [MassServo](INFO): Powering down 2020-01-15T23:45:32.315Z,1579131932.315 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2020-01-15T23:45:32.315Z,1579131932.315 [RudderServo](INFO): Powering down 2020-01-15T23:45:32.315Z,1579131932.315 [ThrusterServo](DEBUG): Uninitialize Thruster Servo. 2020-01-15T23:45:32.316Z,1579131932.316 [ThrusterServo](INFO): Powering down 2020-01-15T23:45:32.316Z,1579131932.316 [SBIT](DEBUG): Uninitialize SBIT Component. 2020-01-15T23:45:32.317Z,1579131932.317 [IBIT](DEBUG): Uninitialize IBIT Component. 2020-01-15T23:45:32.317Z,1579131932.317 [CBIT](DEBUG): Uninitialize CBIT Component. 2020-01-15T23:45:32.317Z,1579131932.317 [CBIT](DEBUG): Powering off loads. 2020-01-15T23:45:32.329Z,1579131932.329 [CBIT](DEBUG): Disabling WDT. 2020-01-15T23:45:32.341Z,1579131932.341 [CBIT](DEBUG): Opening all GF detection circuits. 2020-01-15T23:45:32.342Z,1579131932.342 [controlThread ThreadHandler](INFO): Thread cancelled. 2020-01-15T23:45:32.392Z,1579131932.392 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2020-01-15T23:45:32.438Z,1579131932.438 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Thread cancelled. 2020-01-15T23:45:32.440Z,1579131932.440 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled. 2020-01-15T23:45:32.499Z,1579131932.499 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2020-01-15T23:45:32.558Z,1579131932.558 [logger ThreadHandler](INFO): Thread cancelled.