2020-02-08T23:05:09.990Z,1581203109.990 [Supervisor](DEBUG): Initializing supervisor.
2020-02-08T23:05:09.993Z,1581203109.993 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2020-02-08T23:05:09.994Z,1581203109.994 [SyncHandler](INFO): Protected caller Thread ID is 1507
2020-02-08T23:05:09.995Z,1581203109.995 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2020-02-08T23:05:09.995Z,1581203109.995 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2020-02-08T23:05:09.996Z,1581203109.996 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 1508
2020-02-08T23:05:09.999Z,1581203109.999 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2020-02-08T23:05:10.011Z,1581203110.011 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2020-02-08T23:05:10.012Z,1581203110.012 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2020-02-08T23:05:10.012Z,1581203110.012 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 1509
2020-02-08T23:05:10.013Z,1581203110.013 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2020-02-08T23:05:10.014Z,1581203110.014 [logger ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2020-02-08T23:05:10.014Z,1581203110.014 [logger ThreadHandler](INFO): Protected caller Thread ID is 1510
2020-02-08T23:05:10.016Z,1581203110.016 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2020-02-08T23:05:10.017Z,1581203110.017 [Supervisor](INFO): Looking for Config files in directory: Config/
2020-02-08T23:05:10.018Z,1581203110.018 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2020-02-08T23:05:10.449Z,1581203110.449 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2020-02-08T23:05:10.450Z,1581203110.450 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2020-02-08T23:05:10.547Z,1581203110.547 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample
2020-02-08T23:05:10.547Z,1581203110.547 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2020-02-08T23:05:10.864Z,1581203110.864 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2020-02-08T23:05:10.865Z,1581203110.865 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2020-02-08T23:05:11.069Z,1581203111.069 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2020-02-08T23:05:11.070Z,1581203111.070 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2020-02-08T23:05:11.260Z,1581203111.260 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2020-02-08T23:05:11.260Z,1581203111.260 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2020-02-08T23:05:11.701Z,1581203111.701 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2020-02-08T23:05:11.701Z,1581203111.701 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2020-02-08T23:05:11.914Z,1581203111.914 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2020-02-08T23:05:11.915Z,1581203111.915 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2020-02-08T23:05:12.061Z,1581203112.061 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2020-02-08T23:05:12.061Z,1581203112.061 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2020-02-08T23:05:12.250Z,1581203112.250 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2020-02-08T23:05:12.251Z,1581203112.251 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2020-02-08T23:05:12.347Z,1581203112.347 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2020-02-08T23:05:12.347Z,1581203112.347 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2020-02-08T23:05:12.644Z,1581203112.644 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2020-02-08T23:05:12.644Z,1581203112.644 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2020-02-08T23:05:12.725Z,1581203112.725 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2020-02-08T23:05:12.826Z,1581203112.826 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2020-02-08T23:05:12.827Z,1581203112.827 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2020-02-08T23:05:13.459Z,1581203113.459 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2020-02-08T23:05:13.459Z,1581203113.459 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2020-02-08T23:05:13.864Z,1581203113.864 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2020-02-08T23:05:13.866Z,1581203113.866 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-whoidhs/
2020-02-08T23:05:13.867Z,1581203113.867 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/vehicle.cfg
2020-02-08T23:05:14.075Z,1581203114.075 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Control.cfg
2020-02-08T23:05:14.174Z,1581203114.174 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/BIT.cfg
2020-02-08T23:05:14.273Z,1581203114.273 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Battery.cfg
2020-02-08T23:05:14.496Z,1581203114.496 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2020-02-08T23:05:14.496Z,1581203114.496 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Simulator.cfg
2020-02-08T23:05:14.581Z,1581203114.581 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Navigation.cfg
2020-02-08T23:05:14.675Z,1581203114.675 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/logger.cfg
2020-02-08T23:05:14.772Z,1581203114.772 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/secure.cfg
2020-02-08T23:05:14.855Z,1581203114.855 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Servo.cfg
2020-02-08T23:05:14.963Z,1581203114.963 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/workSite.cfg
2020-02-08T23:05:15.056Z,1581203115.056 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Sensor.cfg
2020-02-08T23:05:15.239Z,1581203115.239 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Science.cfg
2020-02-08T23:05:15.369Z,1581203115.369 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-whoidhs/root/
2020-02-08T23:05:15.369Z,1581203115.369 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg
2020-02-08T23:05:15.376Z,1581203115.376 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2020-02-08T23:05:15.676Z,1581203115.676 [AHRS_M2](DEBUG): LcmSlateWriter::add(): platform_orientation
2020-02-08T23:05:15.681Z,1581203115.681 [AHRS_M2](INFO): created writer for : platform_orientation
2020-02-08T23:05:15.682Z,1581203115.682 [AHRS_M2](DEBUG): LcmSlateWriter::add(): platform_magnetic_orientation
2020-02-08T23:05:15.687Z,1581203115.687 [AHRS_M2](INFO): created writer for : platform_magnetic_orientation
2020-02-08T23:05:15.688Z,1581203115.688 [AHRS_M2](DEBUG): LcmSlateWriter::add(): platform_pitch_angle
2020-02-08T23:05:15.693Z,1581203115.693 [AHRS_M2](INFO): created writer for : platform_pitch_angle
2020-02-08T23:05:15.693Z,1581203115.693 [AHRS_M2](DEBUG): LcmSlateWriter::add(): platform_roll_angle
2020-02-08T23:05:15.698Z,1581203115.698 [AHRS_M2](INFO): created writer for : platform_roll_angle
2020-02-08T23:05:15.765Z,1581203115.765 [AHRS_M2] Loaded
2020-02-08T23:05:15.765Z,1581203115.765 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread.
2020-02-08T23:05:15.843Z,1581203115.843 [DataOverHttps] Loaded
2020-02-08T23:05:15.844Z,1581203115.844 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2020-02-08T23:05:15.845Z,1581203115.845 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 407684E0
2020-02-08T23:05:15.845Z,1581203115.845 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 1592
2020-02-08T23:05:15.868Z,1581203115.868 [DDM] Loaded
2020-02-08T23:05:15.868Z,1581203115.868 [ComponentRegistry](DEBUG): SyncComponent "DDM" handled in the control thread.
2020-02-08T23:05:15.881Z,1581203115.881 [Depth_Keller] Loaded
2020-02-08T23:05:15.881Z,1581203115.881 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2020-02-08T23:05:15.885Z,1581203115.885 [DropWeight] Loaded
2020-02-08T23:05:15.885Z,1581203115.885 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2020-02-08T23:05:15.944Z,1581203115.944 [DUSBL_Hydroid] Loaded
2020-02-08T23:05:15.944Z,1581203115.944 [ComponentRegistry](DEBUG): SyncComponent "DUSBL_Hydroid" handled in the control thread.
2020-02-08T23:05:15.989Z,1581203115.989 [Micromodem] Loaded
2020-02-08T23:05:15.989Z,1581203115.989 [ComponentRegistry](DEBUG): SyncComponent "Micromodem" handled in the control thread.
2020-02-08T23:05:16.081Z,1581203116.081 [NAL9602] Loaded
2020-02-08T23:05:16.081Z,1581203116.081 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2020-02-08T23:05:16.119Z,1581203116.119 [Onboard] Loaded
2020-02-08T23:05:16.119Z,1581203116.119 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread.
2020-02-08T23:05:16.124Z,1581203116.124 [PowerOnly] Loaded
2020-02-08T23:05:16.125Z,1581203116.125 [ComponentRegistry](DEBUG): SyncComponent "PowerOnly" handled in the control thread.
2020-02-08T23:05:16.131Z,1581203116.131 [Radio_Surface] Loaded
2020-02-08T23:05:16.131Z,1581203116.131 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2020-02-08T23:05:16.132Z,1581203116.132 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 407984E0
2020-02-08T23:05:16.132Z,1581203116.132 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 1593
2020-02-08T23:05:16.174Z,1581203116.174 [RDI_Pathfinder] Loaded
2020-02-08T23:05:16.174Z,1581203116.174 [ComponentRegistry](DEBUG): SyncComponent "RDI_Pathfinder" handled in the control thread.
2020-02-08T23:05:18.366Z,1581203118.366 [BPC1] Loaded
2020-02-08T23:05:18.367Z,1581203118.367 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2020-02-08T23:05:18.367Z,1581203118.367 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2020-02-08T23:05:18.368Z,1581203118.368 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2020-02-08T23:05:18.380Z,1581203118.380 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2020-02-08T23:05:18.381Z,1581203118.381 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2020-02-08T23:05:18.493Z,1581203118.493 [DeadReckonUsingMultipleVelocitySources] Loaded
2020-02-08T23:05:18.494Z,1581203118.494 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2020-02-08T23:05:18.513Z,1581203118.513 [NavChart] Loaded
2020-02-08T23:05:18.514Z,1581203118.514 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2020-02-08T23:05:18.518Z,1581203118.518 [UniversalFixResidualReporter] Loaded
2020-02-08T23:05:18.518Z,1581203118.518 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2020-02-08T23:05:18.531Z,1581203118.531 [WorkSite] Loaded
2020-02-08T23:05:18.531Z,1581203118.531 [ComponentRegistry](DEBUG): SyncComponent "WorkSite" handled in the control thread.
2020-02-08T23:05:18.532Z,1581203118.532 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2020-02-08T23:05:18.532Z,1581203118.532 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2020-02-08T23:05:18.635Z,1581203118.635 [BuoyancyServo] Loaded
2020-02-08T23:05:18.635Z,1581203118.635 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2020-02-08T23:05:18.649Z,1581203118.649 [ElevatorServo] Loaded
2020-02-08T23:05:18.650Z,1581203118.650 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2020-02-08T23:05:18.664Z,1581203118.664 [MassServo] Loaded
2020-02-08T23:05:18.664Z,1581203118.664 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2020-02-08T23:05:18.679Z,1581203118.679 [RudderServo] Loaded
2020-02-08T23:05:18.679Z,1581203118.679 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2020-02-08T23:05:18.693Z,1581203118.693 [ThrusterServo] Loaded
2020-02-08T23:05:18.693Z,1581203118.693 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread.
2020-02-08T23:05:18.693Z,1581203118.693 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2020-02-08T23:05:18.694Z,1581203118.694 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2020-02-08T23:05:18.874Z,1581203118.874 [PAR_Licor] Loaded
2020-02-08T23:05:18.875Z,1581203118.875 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2020-02-08T23:05:18.916Z,1581203118.916 [WetLabsSeaOWL_UV_A] Loaded
2020-02-08T23:05:18.917Z,1581203118.917 [ComponentRegistry](DEBUG): Component "WetLabsSeaOWL_UV_A" handled in its own thread.
2020-02-08T23:05:18.918Z,1581203118.918 [WetLabsSeaOWL_UV_A ThreadHandler](DEBUG): Created PCaller Thread at 408F04E0
2020-02-08T23:05:18.918Z,1581203118.918 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Protected caller Thread ID is 1594
2020-02-08T23:05:18.919Z,1581203118.919 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2020-02-08T23:05:18.919Z,1581203118.919 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2020-02-08T23:05:19.252Z,1581203119.252 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2020-02-08T23:05:19.253Z,1581203119.253 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2020-02-08T23:05:19.292Z,1581203119.292 [DepthRateCalculator] Loaded
2020-02-08T23:05:19.292Z,1581203119.292 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2020-02-08T23:05:19.297Z,1581203119.297 [PitchRateCalculator] Loaded
2020-02-08T23:05:19.297Z,1581203119.297 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2020-02-08T23:05:19.309Z,1581203119.309 [SpeedCalculator] Loaded
2020-02-08T23:05:19.309Z,1581203119.309 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2020-02-08T23:05:19.329Z,1581203119.329 [TempGradientCalculator] Loaded
2020-02-08T23:05:19.330Z,1581203119.330 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread.
2020-02-08T23:05:19.335Z,1581203119.335 [YawRateCalculator] Loaded
2020-02-08T23:05:19.335Z,1581203119.335 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2020-02-08T23:05:19.373Z,1581203119.373 [ElevatorOffsetCalculator] Loaded
2020-02-08T23:05:19.374Z,1581203119.374 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2020-02-08T23:05:19.374Z,1581203119.374 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2020-02-08T23:05:19.374Z,1581203119.374 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2020-02-08T23:05:19.507Z,1581203119.507 [SBIT](DEBUG): Construct Startup Built In Test.
2020-02-08T23:05:19.528Z,1581203119.528 [SBIT] Loaded
2020-02-08T23:05:19.528Z,1581203119.528 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2020-02-08T23:05:19.529Z,1581203119.529 [IBIT](DEBUG): Construct Initiated Built In Test.
2020-02-08T23:05:19.541Z,1581203119.541 [IBIT] Loaded
2020-02-08T23:05:19.541Z,1581203119.541 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2020-02-08T23:05:19.545Z,1581203119.545 [CBIT](DEBUG): Construct Continuous Built In Test.
2020-02-08T23:05:19.676Z,1581203119.676 [CBIT] Loaded
2020-02-08T23:05:19.676Z,1581203119.676 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2020-02-08T23:05:19.677Z,1581203119.677 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2020-02-08T23:05:19.677Z,1581203119.677 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2020-02-08T23:05:19.755Z,1581203119.755 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2020-02-08T23:05:19.756Z,1581203119.756 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2020-02-08T23:05:19.849Z,1581203119.849 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2020-02-08T23:05:19.849Z,1581203119.849 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2020-02-08T23:05:19.895Z,1581203119.895 [VerticalControl](DEBUG): Construct VerticalControl.
2020-02-08T23:05:19.973Z,1581203119.973 [VerticalControl] Loaded
2020-02-08T23:05:19.974Z,1581203119.974 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2020-02-08T23:05:19.974Z,1581203119.974 [HorizontalControl](DEBUG): Construct HorizontalControl.
2020-02-08T23:05:20.041Z,1581203120.041 [HorizontalControl] Loaded
2020-02-08T23:05:20.041Z,1581203120.041 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2020-02-08T23:05:20.042Z,1581203120.042 [SpeedControl](DEBUG): Construct SpeedControl.
2020-02-08T23:05:20.043Z,1581203120.043 [SpeedControl] Loaded
2020-02-08T23:05:20.043Z,1581203120.043 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2020-02-08T23:05:20.044Z,1581203120.044 [LoopControl](DEBUG): Construct LoopControl.
2020-02-08T23:05:20.045Z,1581203120.045 [LoopControl] Loaded
2020-02-08T23:05:20.045Z,1581203120.045 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2020-02-08T23:05:20.045Z,1581203120.045 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2020-02-08T23:05:20.046Z,1581203120.046 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2020-02-08T23:05:20.076Z,1581203120.076 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2020-02-08T23:05:20.080Z,1581203120.080 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2020-02-08T23:05:20.081Z,1581203120.081 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2020-02-08T23:05:20.087Z,1581203120.087 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2020-02-08T23:05:20.088Z,1581203120.088 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40ADE4E0
2020-02-08T23:05:20.089Z,1581203120.089 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 1595
2020-02-08T23:05:20.093Z,1581203120.093 [Supervisor](INFO): Main Thread ID is 816
2020-02-08T23:05:20.093Z,1581203120.093 [Supervisor](DEBUG): Running supervisor.
2020-02-08T23:05:20.094Z,1581203120.094 [CommandLine ThreadHandler](INFO): Handler Thread ID is 1596
2020-02-08T23:05:20.096Z,1581203120.096 [controlThread ThreadHandler](INFO): Handler Thread ID is 1597
2020-02-08T23:05:20.097Z,1581203120.097 [controlThread](DEBUG): Initializing ControlThread
2020-02-08T23:05:20.104Z,1581203120.104 [NavChart](DEBUG): Initialize NavChart Navigation.
2020-02-08T23:05:20.104Z,1581203120.104 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2020-02-08T23:05:20.105Z,1581203120.105 [WorkSite](DEBUG): Initializing WorkSite component.
2020-02-08T23:05:20.109Z,1581203120.109 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2020-02-08T23:05:20.109Z,1581203120.109 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2020-02-08T23:05:20.110Z,1581203120.110 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2020-02-08T23:05:20.110Z,1581203120.110 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator.
2020-02-08T23:05:20.110Z,1581203120.110 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2020-02-08T23:05:20.111Z,1581203120.111 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2020-02-08T23:05:20.111Z,1581203120.111 [SBIT](INFO): Initialize SBIT Component.
2020-02-08T23:05:20.112Z,1581203120.112 [SBIT](IMPORTANT): git: 2020-02-07
2020-02-08T23:05:20.112Z,1581203120.112 [SBIT](INFO): git hash: 6707874467016a4fb4c344b7e74bc4738258579e
2020-02-08T23:05:20.112Z,1581203120.112 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2020-02-08T23:05:20.113Z,1581203120.113 [SBIT](INFO): Kernel Reporting Different Version From Configuration.
Kernel Expected: #2 PREEMPT Thu Jan 11 20:13:48 PST 2018
Kernel Reported: #1 PREEMPT Wed Nov 13 12:38:10 PST 2019
2020-02-08T23:05:20.114Z,1581203120.114 [SBIT](INFO): Beginning SBIT in 29.000000 seconds.
2020-02-08T23:05:20.115Z,1581203120.115 [IBIT](INFO): Initialize IBIT Component.
2020-02-08T23:05:20.116Z,1581203120.116 [CBIT](DEBUG): Initialize CBIT Component.
2020-02-08T23:05:20.117Z,1581203120.117 [logger ThreadHandler](INFO): Handler Thread ID is 1598
2020-02-08T23:05:20.129Z,1581203120.129 [CBIT](DEBUG): Initialized mux pins.
2020-02-08T23:05:20.129Z,1581203120.129 [CBIT](DEBUG): Initializing the watchdog timer.
2020-02-08T23:05:20.137Z,1581203120.137 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 1599
2020-02-08T23:05:20.138Z,1581203120.138 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2020-02-08T23:05:20.149Z,1581203120.149 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 1600
2020-02-08T23:05:20.153Z,1581203120.153 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2020-02-08T23:05:20.153Z,1581203120.153 [CBIT](DEBUG): Initializing heartbeat.
2020-02-08T23:05:20.161Z,1581203120.161 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Handler Thread ID is 1601
2020-02-08T23:05:20.162Z,1581203120.162 [WetLabsSeaOWL_UV_A](INFO): Powering down
2020-02-08T23:05:20.189Z,1581203120.189 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 1602
2020-02-08T23:05:20.192Z,1581203120.192 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2020-02-08T23:05:20.192Z,1581203120.192 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2020-02-08T23:05:20.193Z,1581203120.193 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2020-02-08T23:05:20.193Z,1581203120.193 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2020-02-08T23:05:20.193Z,1581203120.193 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2020-02-08T23:05:20.193Z,1581203120.193 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2020-02-08T23:05:20.194Z,1581203120.194 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000
2020-02-08T23:05:20.194Z,1581203120.194 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000
2020-02-08T23:05:20.194Z,1581203120.194 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2020-02-08T23:05:20.194Z,1581203120.194 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2020-02-08T23:05:20.194Z,1581203120.194 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000
2020-02-08T23:05:20.194Z,1581203120.194 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000
2020-02-08T23:05:20.195Z,1581203120.195 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000
2020-02-08T23:05:20.195Z,1581203120.195 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000
2020-02-08T23:05:20.195Z,1581203120.195 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000
2020-02-08T23:05:20.195Z,1581203120.195 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000
2020-02-08T23:05:20.225Z,1581203120.225 [CBIT](DEBUG): Deactivating GF circuits.
2020-02-08T23:05:20.225Z,1581203120.225 [CBIT](DEBUG): Deactivating emergency mode.
2020-02-08T23:05:20.261Z,1581203120.261 [CBIT](DEBUG): Backplane powered.
2020-02-08T23:05:20.261Z,1581203120.261 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2020-02-08T23:05:20.263Z,1581203120.263 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2020-02-08T23:05:20.263Z,1581203120.263 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2020-02-08T23:05:20.264Z,1581203120.264 [LoopControl](DEBUG): Initialize LoopControlComponent.
2020-02-08T23:05:20.265Z,1581203120.265 [MissionManager](INFO): Loading Mission: Missions/Startup.xml
2020-02-08T23:05:20.274Z,1581203120.274 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2020-02-08T23:05:20.293Z,1581203120.293 [MissionManager](DEBUG): 
<?xml version="1.0" encoding="UTF-8"?>
<Mission xmlns="Tethys"
       xmlns:Control="Tethys/Control"
       xmlns:Guidance="Tethys/Guidance" 
       xmlns:Units="Tethys/Units"
       xmlns:Universal="Tethys/Universal"
       xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"
       xsi:schemaLocation="Tethys http://okeanids.mbari.org/tethys/Xml/Tethys.xsd
                           Tethys/Control http://okeanids.mbari.org/tethys/Xml/Control.xsd
                           Tethys/Guidance http://okeanids.mbari.org/tethys/Xml/Guidance.xsd
                           Tethys/Units http://okeanids.mbari.org/tethys/Xml/Units.xsd
                           Tethys/Universal http://okeanids.mbari.org/tethys/Xml/Universal.xsd"
       Id="Startup">

    <Guidance:GoToSurface>
        <Progression/>
    </Guidance:GoToSurface>

    <Aggregate Id="StartupSatComms">

        <Sequence/>

        <ReadDatum>
            <Timeout Duration="P1M" />
            <Universal:latitude_fix/>
        </ReadDatum>

        <ReadDatum>
            <Timeout Duration="P1M" />
            <Universal:platform_communications/>
        </ReadDatum>

    </Aggregate>

</Mission>


2020-02-08T23:05:20.294Z,1581203120.294 [MissionManager](INFO): Loading Mission: Missions/underIce/DefaultWithUndock.xml
2020-02-08T23:05:20.375Z,1581203120.375 [MissionManager](INFO): DefineArg DefaultWithUndock.ElapsedSinceDefaultStarted = 0.000000 min
2020-02-08T23:05:20.387Z,1581203120.387 [MissionManager](INFO): DefineArg DefaultWithUndock.DetachTimeout = 30.000000 min
2020-02-08T23:05:20.390Z,1581203120.390 [MissionManager](INFO): DefineArg DefaultWithUndock.MicromodemCommsInterval = 2.000000 min
2020-02-08T23:05:20.391Z,1581203120.391 [DefaultWithUndock:A.Wait](DEBUG): Construct Wait.
2020-02-08T23:05:20.431Z,1581203120.431 [DefaultWithUndock:B.Undock](DEBUG): Construct.
2020-02-08T23:05:20.453Z,1581203120.453 [DefaultWithUndock:C.GoToSurface](DEBUG): Construct GoToSurface.
2020-02-08T23:05:20.491Z,1581203120.491 [DefaultWithUndock:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2020-02-08T23:05:20.508Z,1581203120.508 [DefaultWithUndock:CheckIn:C.Wait](DEBUG): Construct Wait.
2020-02-08T23:05:20.535Z,1581203120.535 [DefaultWithUndock:F.Execute](DEBUG): Construct Execute.
2020-02-08T23:05:20.538Z,1581203120.538 [MissionManager](DEBUG): 
<?xml version="1.0" encoding="UTF-8"?>
<Mission xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"
         xmlns="Tethys"
         xmlns:Units="Tethys/Units"
         xmlns:Guidance="Tethys/Guidance"
         xmlns:Universal="Tethys/Universal"
         xsi:schemaLocation="Tethys http://okeanids.mbari.org/tethys/Xml/Tethys.xsd
                             Tethys/Units http://okeanids.mbari.org/tethys/Xml/Units.xsd
                             Tethys/Guidance http://okeanids.mbari.org/tethys/Xml/Guidance.xsd
                             Tethys/Universal http://okeanids.mbari.org/tethys/Xml/Universal.xsd"
         Id="DefaultWithUndock">

    <DefineArg Name="ElapsedSinceDefaultStarted"><Units:minute/><Value>0</Value></DefineArg>

    <DefineArg Name="DetachTimeout"><Description>
        Maximum time duration for the vehicle to reach the approach depth after detaching form the dock.
        The vehicle will switch over to midcourse guidance after the timeout is expired.
    </Description><Units:minute/><Value>30</Value></DefineArg>

    <DefineArg Name="MicromodemCommsInterval"><Description>
        How often to trigger Umodem communications
    </Description><Units:minute/><Value>2</Value></DefineArg>
        
    <Guidance:Wait>
        <Description>
            Wait a moment to see if the scheduler starts a new mission before
            starting to actually run Default.
        </Description>
        <Sequence/>
        <Setting><Guidance:Wait.duration/><Units:second/><Value>30</Value></Setting>
    </Guidance:Wait>

    <!-- Leave the dock if necessary --> 
    <Guidance:Undock>
        <Sequence/>
        <Timeout Duration="DetachTimeout">
            <Syslog Severity="Important">Timed out while trying to detach from dock at current depth of <Universal:depth/><Units:meter/>.</Syslog>
        </Timeout>
    </Guidance:Undock>

    <!-- This mission assumes open water so from here on it's the same old default that's always used -->
    <Guidance:GoToSurface>
        <Progression/>
    </Guidance:GoToSurface>

    <Aggregate Id="CheckIn">

        <Sequence Repeat="288"/>

        <ReadDatum Id="Read_GPS">
            <Timeout Duration="P5M"/>
            <Universal:time_fix/>
        </ReadDatum>

        <ReadDatum Id="Read_Iridium">
            <Timeout Duration="P2H">
                <Guidance:Execute>
                    <Sequence/>
                    <Setting><Guidance:Execute.command/><String>Burn on</String></Setting>
                </Guidance:Execute>
                <Syslog Severity="Critical">Dropped weight due to communications timeout.</Syslog>
            </Timeout>
            <Universal:platform_communications/>
        </ReadDatum>

        <Guidance:Wait>
            <Sequence/>
            <Setting><Guidance:Wait.duration/><Units:minute/><Value>5</Value></Setting>
        </Guidance:Wait>

        <Assign><Sequence/><Arg Name="ElapsedSinceDefaultStarted"/><Elapsed><Universal:mission_started/></Elapsed></Assign>

        <Syslog Severity="Important">Default mission has been running for <Arg Name="ElapsedSinceDefaultStarted"/><Units:minute/></Syslog>

    </Aggregate>

    <Syslog Severity="Important">Restarting logs and Default mission.</Syslog>

    <Guidance:Execute>
        <Sequence/>
        <Setting><Guidance:Execute.command/><String>restart logs</String></Setting>
    </Guidance:Execute>

</Mission>


2020-02-08T23:05:20.553Z,1581203120.553 [Radio_Surface](INFO): Powering up
2020-02-08T23:05:20.561Z,1581203120.561 [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,WorkSite,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter,
2020-02-08T23:05:20.575Z,1581203120.575 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2020-02-08T23:05:20.609Z,1581203120.609 [DDM](INFO): Powering up
2020-02-08T23:05:20.609Z,1581203120.609 [DDM](DEBUG): Initializing DDM.
2020-02-08T23:05:20.630Z,1581203120.630 [Depth_Keller](ERROR): Pressure reading out of range: 1913.424561 decibar
2020-02-08T23:05:20.631Z,1581203120.631 [DUSBL_Hydroid](INFO): Powering up
2020-02-08T23:05:20.631Z,1581203120.631 [DUSBL_Hydroid](DEBUG): Initializing DUSBL_Hydroid.
2020-02-08T23:05:20.799Z,1581203120.799 [DepthRateCalculator](ERROR): Depth measurement is not active
2020-02-08T23:05:20.822Z,1581203120.822 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2020-02-08T23:05:20.829Z,1581203120.829 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2020-02-08T23:05:20.830Z,1581203120.830 [ElevatorServo](DEBUG): Initializing EZServoServo.
2020-02-08T23:05:20.837Z,1581203120.837 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2020-02-08T23:05:20.838Z,1581203120.838 [MassServo](DEBUG): Initializing EZServoServo.
2020-02-08T23:05:20.845Z,1581203120.845 [MassServo](DEBUG): Initializing MassServo.
2020-02-08T23:05:20.846Z,1581203120.846 [RudderServo](DEBUG): Initializing EZServoServo.
2020-02-08T23:05:20.853Z,1581203120.853 [RudderServo](DEBUG): Initializing RudderServo.
2020-02-08T23:05:20.854Z,1581203120.854 [ThrusterServo](DEBUG): Initializing EZServoServo.
2020-02-08T23:05:20.861Z,1581203120.861 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2020-02-08T23:05:20.990Z,1581203120.990 [Micromodem](INFO): Powering up
2020-02-08T23:05:20.990Z,1581203120.990 [Micromodem](DEBUG): Initializing Micromodem.
2020-02-08T23:05:21.065Z,1581203121.065 [DepthRateCalculator](ERROR): Depth measurement is not active
2020-02-08T23:05:21.741Z,1581203121.741 [RudderServo](ERROR): Rudder initialization uart error serial timeout
2020-02-08T23:05:21.741Z,1581203121.741 [RudderServo](FAULT): Rudder failed to initialize
2020-02-08T23:05:21.741Z,1581203121.741 [RudderServo] Communications Fault, FailCount= 1
2020-02-08T23:05:21.741Z,1581203121.741 [RudderServo](ERROR): Communications Fault
2020-02-08T23:05:21.852Z,1581203121.852 [CBIT](ERROR): Communications Fault in component: RudderServo
2020-02-08T23:05:22.038Z,1581203122.038 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2020-02-08T23:05:22.038Z,1581203122.038 [RudderServo](INFO): Powering down
2020-02-08T23:05:22.725Z,1581203122.725 [RudderServo](DEBUG): Initializing EZServoServo.
2020-02-08T23:05:22.842Z,1581203122.842 [RudderServo](DEBUG): Initializing RudderServo.
2020-02-08T23:05:22.846Z,1581203122.846 [CBIT](INFO): Clearing failed state for component RudderServo
2020-02-08T23:05:22.846Z,1581203122.846 [RudderServo] No Fault, FailCount= 1
2020-02-08T23:05:25.246Z,1581203125.246 [WorkSite](IMPORTANT): Reading workSite position from Data/workSite.cfg
2020-02-08T23:05:25.248Z,1581203125.248 [WorkSite](ERROR): Failed to parse: 

2020-02-08T23:05:25.258Z,1581203125.258 [WorkSite](IMPORTANT): WorkSite fix at 20200208T222546: (38.837070, -122.564635)
2020-02-08T23:05:25.939Z,1581203125.939 [Micromodem](INFO): Nmea out: $CCCFG,ALL,0*33

2020-02-08T23:05:27.991Z,1581203127.991 [Micromodem](INFO): Nmea in: $CACFG,ALL,0*31

2020-02-08T23:05:27.991Z,1581203127.991 [Micromodem](INFO): Nmea out: $CCCFG,SRC,1*31

2020-02-08T23:05:28.399Z,1581203128.399 [Micromodem](INFO): Nmea in: $CATMG,2020-02-08T23:05:26.361762Z,RTC,RTC*5D

2020-02-08T23:05:28.400Z,1581203128.400 [Micromodem](ERROR): CFG response from modem unexpected: $CATMG,2020-02-08T23:05:26.361762Z,RTC,RTC*5D

2020-02-08T23:05:28.787Z,1581203128.787 [Micromodem](INFO): Nmea in: $CACFG,SRC,1*33

2020-02-08T23:05:28.787Z,1581203128.787 [Micromodem](INFO): Nmea out: $CCCFG,nav.dt.txtrig_gpio4,1*64

2020-02-08T23:05:29.204Z,1581203129.204 [Micromodem](INFO): Nmea in: $CACFG,nav.dt.txtrig_gpio4,1*66

2020-02-08T23:05:29.204Z,1581203129.204 [Micromodem](INFO): Nmea out: $CCCFG,pwramp.txlevel,0*2F

2020-02-08T23:05:29.591Z,1581203129.591 [Micromodem](INFO): Nmea in: $CACFG,pwramp.txlevel,0*2D

2020-02-08T23:05:29.591Z,1581203129.591 [Micromodem](INFO): Nmea out: $CCCFG,DTO,30*1E

2020-02-08T23:05:30.009Z,1581203130.009 [Micromodem](INFO): Nmea in: $CACFG,DTO,30*1C

2020-02-08T23:05:30.010Z,1581203130.010 [Micromodem](INFO): Nmea out: $CCCFG,FC0,14500*47

2020-02-08T23:05:30.391Z,1581203130.391 [Micromodem](INFO): Nmea in: $CACFG,FC0,14500*45

2020-02-08T23:05:30.391Z,1581203130.391 [Micromodem](INFO): Nmea out: $CCCFG,BW0,2000*65

2020-02-08T23:05:30.795Z,1581203130.795 [Micromodem](INFO): Nmea in: $CACFG,BW0,2000*67

2020-02-08T23:05:30.795Z,1581203130.795 [Micromodem](INFO): Nmea out: $CCCFG,BND,0*3A

2020-02-08T23:05:31.207Z,1581203131.207 [Micromodem](INFO): Nmea in: $CACFG,BND,0*38

2020-02-08T23:05:31.208Z,1581203131.208 [Micromodem](INFO): Nmea out: $CCCLK,2020,02,08,23,05,32*4B

2020-02-08T23:05:31.599Z,1581203131.599 [Micromodem](INFO): Nmea in: $CACLK,2020,2,8,23,5,32*79

2020-02-08T23:05:32.011Z,1581203132.011 [Micromodem](INFO): Nmea in: $CATMS,0,2020-02-08T23:05:33Z*78

2020-02-08T23:05:32.013Z,1581203132.013 [Micromodem](INFO): Nmea in: $CATMG,2020-02-08T23:05:33.026144Z,USER_CMD,RTC*1A

2020-02-08T23:05:34.069Z,1581203134.069 [RDI_Pathfinder](ERROR): Failed to parse:Pathfinder
2020-02-08T23:05:36.039Z,1581203136.039 [DDM](INFO): Dynamic Docking Module:
2020-02-08T23:05:38.470Z,1581203138.470 [DUSBL_Hydroid](INFO): DUSBL Version:O
2020-02-08T23:05:46.144Z,1581203146.144 [NAL9602](INFO): Powering up NAL9602
2020-02-08T23:05:49.860Z,1581203149.860 [SBIT](IMPORTANT): Beginning Startup BIT
2020-02-08T23:05:49.881Z,1581203149.881 [CBIT](IMPORTANT): Beginning ground fault scan
2020-02-08T23:05:51.900Z,1581203151.900 [ElevatorServo](FAULT): Overload Error
2020-02-08T23:05:51.901Z,1581203151.901 [ElevatorServo] Hardware Fault, FailCount= 1
2020-02-08T23:05:51.901Z,1581203151.901 [ElevatorServo](ERROR): Hardware Fault
2020-02-08T23:05:52.013Z,1581203152.013 [CBIT](ERROR): Hardware Fault in component: ElevatorServo
2020-02-08T23:05:52.254Z,1581203152.254 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2020-02-08T23:05:52.254Z,1581203152.254 [ElevatorServo](INFO): Powering down
2020-02-08T23:05:53.288Z,1581203153.288 [ElevatorServo](DEBUG): Initializing EZServoServo.
2020-02-08T23:05:53.407Z,1581203153.407 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2020-02-08T23:05:53.474Z,1581203153.474 [CBIT](INFO): Clearing failed state for component ElevatorServo
2020-02-08T23:05:53.474Z,1581203153.474 [ElevatorServo] No Fault, FailCount= 1
2020-02-08T23:05:57.247Z,1581203157.247 [NAL9602](INFO): NAL9602 initialized
2020-02-08T23:05:58.545Z,1581203158.545 [ElevatorServo](FAULT): Overload Error
2020-02-08T23:05:58.545Z,1581203158.545 [ElevatorServo] Hardware Fault, FailCount= 2
2020-02-08T23:05:58.545Z,1581203158.545 [ElevatorServo](ERROR): Hardware Fault
2020-02-08T23:05:58.630Z,1581203158.630 [CBIT](ERROR): Hardware Fault in component: ElevatorServo
2020-02-08T23:05:58.932Z,1581203158.932 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2020-02-08T23:05:58.932Z,1581203158.932 [ElevatorServo](INFO): Powering down
2020-02-08T23:05:59.708Z,1581203159.708 [ElevatorServo](DEBUG): Initializing EZServoServo.
2020-02-08T23:05:59.824Z,1581203159.824 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2020-02-08T23:05:59.870Z,1581203159.870 [CBIT](INFO): Clearing failed state for component ElevatorServo
2020-02-08T23:05:59.870Z,1581203159.870 [ElevatorServo] No Fault, FailCount= 2
2020-02-08T23:06:01.081Z,1581203161.081 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): 0.016757
CHAN A1 (24V): -0.029764
CHAN A2 (12V): -0.006961
CHAN A3 (5V): -0.002730
CHAN B0 (3.3V): -0.000357
CHAN B1 (3.15aV): -0.000657
CHAN B2 (3.15bV): 0.000476
CHAN B3 (GND): 0.001824
OPEN: 0.005212
Full Scale Calc: 4.765 mA, -1.589 mA
2020-02-08T23:06:02.967Z,1581203162.967 [SBIT](FAULT): Elevator: EXPECTED:15.000000 ACTUAL:-0.019795
2020-02-08T23:06:05.005Z,1581203165.005 [ElevatorServo](FAULT): Overload Error
2020-02-08T23:06:05.005Z,1581203165.005 [ElevatorServo] Hardware Fault, FailCount= 3
2020-02-08T23:06:05.005Z,1581203165.005 [ElevatorServo](ERROR): Hardware Fault
2020-02-08T23:06:05.154Z,1581203165.154 [CBIT](ERROR): Hardware Fault in component: ElevatorServo
2020-02-08T23:06:05.154Z,1581203165.154 [CBIT](CRITICAL): Hardware Fault in component: ElevatorServo
2020-02-08T23:06:05.381Z,1581203165.381 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2020-02-08T23:06:05.381Z,1581203165.381 [ElevatorServo](INFO): Powering down
2020-02-08T23:06:05.795Z,1581203165.795 [CommandLine](FAULT): Scheduling is paused
2020-02-08T23:06:05.796Z,1581203165.796 [CBIT](INFO): Critical error at 20200208T230605
2020-02-08T23:06:05.796Z,1581203165.796 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals
2020-02-08T23:06:06.271Z,1581203166.271 [ElevatorServo](DEBUG): Initializing EZServoServo.
2020-02-08T23:06:06.390Z,1581203166.390 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2020-02-08T23:06:28.438Z,1581203188.438 [NAL9602](INFO): Not Powering down - fast GPS
2020-02-08T23:06:29.750Z,1581203189.750 [SBIT](ERROR): Could not read elevatorAngleReader_.
2020-02-08T23:06:29.750Z,1581203189.750 [SBIT](FAULT): Control surface position failure.
2020-02-08T23:06:43.518Z,1581203203.518 [SBIT](ERROR): Could not read elevatorAngleReader_.
2020-02-08T23:06:43.518Z,1581203203.518 [SBIT](FAULT): Control surface position failure.
2020-02-08T23:06:43.932Z,1581203203.932 [SBIT](CRITICAL): SBIT FAILED
2020-02-08T23:06:43.933Z,1581203203.933 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2020-02-08T23:06:43.934Z,1581203203.934 [SBIT](IMPORTANT): DUSBL_Hydroid.verbosity=3 enum;

2020-02-08T23:06:43.934Z,1581203203.934 [SBIT](IMPORTANT): Express linearApproximation DUSBL_Hydroid.acoustic_contact_range 10.000000 meter;

2020-02-08T23:06:43.934Z,1581203203.934 [SBIT](IMPORTANT): Express linearApproximation acoustic_contact_range 10.000000 meter;

2020-02-08T23:06:43.934Z,1581203203.934 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=320 cubic_centimeter;

2020-02-08T23:06:43.934Z,1581203203.934 [SBIT](IMPORTANT): VerticalControl.massDefault=2.4 millimeter;

2020-02-08T23:06:43.936Z,1581203203.936 [CBIT](INFO): Critical error at 20200208T230643
2020-02-08T23:06:44.324Z,1581203204.324 [MissionManager](IMPORTANT): Started mission Startup
2020-02-08T23:06:44.325Z,1581203204.325 [Startup] Running Loop=1
2020-02-08T23:06:44.325Z,1581203204.325 [Startup](DEBUG): Aggregate::initialize Startup
2020-02-08T23:06:44.325Z,1581203204.325 [Startup:A.GoToSurface] Running Loop=1
2020-02-08T23:06:44.325Z,1581203204.325 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2020-02-08T23:06:44.326Z,1581203204.326 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2020-02-08T23:06:44.326Z,1581203204.326 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2020-02-08T23:06:44.326Z,1581203204.326 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2020-02-08T23:06:44.327Z,1581203204.327 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2020-02-08T23:06:44.327Z,1581203204.327 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2020-02-08T23:06:44.329Z,1581203204.329 [Startup:StartupSatComms] Running Loop=1
2020-02-08T23:06:44.329Z,1581203204.329 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2020-02-08T23:06:44.329Z,1581203204.329 [Startup:StartupSatComms:A] Running Loop=1
2020-02-08T23:06:44.715Z,1581203204.715 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2020-02-08T23:06:49.178Z,1581203209.178 [RDI_Pathfinder](ERROR): Failed to parse:
:BE,-32768,-32768,-32768,V
2020-02-08T23:07:44.522Z,1581203264.522 [Startup:StartupSatComms:A](INFO): Timed out from 2020-02-08T23:06:44.3Z
2020-02-08T23:07:44.522Z,1581203264.522 [Startup:StartupSatComms:A] Stopped
2020-02-08T23:07:44.522Z,1581203264.522 [Startup:StartupSatComms:B] Running Loop=1
2020-02-08T23:07:44.937Z,1581203264.937 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2020-02-08T23:08:03.511Z,1581203283.511 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error
2020-02-08T23:08:03.511Z,1581203283.511 [RDI_Pathfinder](ERROR): Failed to parse:
:TS,20020816210280,35.0, -0.1,   0.0,1448.RA,  0.00,   0.00,   0.00,   0.00,   0.00
2020-02-08T23:08:44.723Z,1581203324.723 [Startup:StartupSatComms:B](INFO): Timed out from 2020-02-08T23:07:44.5Z
2020-02-08T23:08:44.723Z,1581203324.723 [Startup:StartupSatComms:B] Stopped
2020-02-08T23:08:44.723Z,1581203324.723 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2020-02-08T23:08:44.724Z,1581203324.724 [Startup:StartupSatComms] Stopped
2020-02-08T23:08:44.724Z,1581203324.724 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2020-02-08T23:08:44.725Z,1581203324.725 [Startup](INFO): Completed Startup
2020-02-08T23:08:44.726Z,1581203324.726 [MissionManager](INFO): Startup is completed.
2020-02-08T23:08:44.726Z,1581203324.726 [MissionManager](INFO): Uninitializing Mission Startup
2020-02-08T23:08:44.726Z,1581203324.726 [Startup] Stopped
2020-02-08T23:08:44.726Z,1581203324.726 [Startup](DEBUG): Aggregate::uninitialize Startup
2020-02-08T23:08:44.726Z,1581203324.726 [Startup:A.GoToSurface] Stopped
2020-02-08T23:08:44.726Z,1581203324.726 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2020-02-08T23:08:45.156Z,1581203325.156 [MissionManager](IMPORTANT): Started mission DefaultWithUndock
2020-02-08T23:08:45.156Z,1581203325.156 [DefaultWithUndock] Running Loop=1
2020-02-08T23:08:45.157Z,1581203325.157 [DefaultWithUndock](DEBUG): Aggregate::initialize DefaultWithUndock
2020-02-08T23:08:45.157Z,1581203325.157 [DefaultWithUndock:C.GoToSurface] Running Loop=1
2020-02-08T23:08:45.157Z,1581203325.157 [DefaultWithUndock:C.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2020-02-08T23:08:45.157Z,1581203325.157 [DefaultWithUndock:C.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2020-02-08T23:08:45.157Z,1581203325.157 [DefaultWithUndock:C.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2020-02-08T23:08:45.158Z,1581203325.158 [DefaultWithUndock:C.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2020-02-08T23:08:45.158Z,1581203325.158 [DefaultWithUndock:C.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2020-02-08T23:08:45.158Z,1581203325.158 [DefaultWithUndock:C.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2020-02-08T23:08:45.159Z,1581203325.159 [DefaultWithUndock:A.Wait] Running Loop=1
2020-02-08T23:08:45.159Z,1581203325.159 [DefaultWithUndock:A.Wait](DEBUG): Initialize Wait Component.
2020-02-08T23:09:00.031Z,1581203340.031 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004908
2020-02-08T23:09:12.798Z,1581203352.798 [CommandLine](IMPORTANT): got command get latitude
2020-02-08T23:09:12.799Z,1581203352.799 [CommandLine](IMPORTANT): latitude 38.837070 arcdeg
2020-02-08T23:09:15.433Z,1581203355.433 [DefaultWithUndock:A.Wait](INFO): Done Waiting.
2020-02-08T23:09:15.433Z,1581203355.433 [DefaultWithUndock:A.Wait] Stopped
2020-02-08T23:09:15.433Z,1581203355.433 [DefaultWithUndock:A.Wait](DEBUG): Uninitialize Wait Component.
2020-02-08T23:09:15.433Z,1581203355.433 [DefaultWithUndock:B.Undock] Running Loop=1
2020-02-08T23:09:15.433Z,1581203355.433 [DefaultWithUndock:B.Undock](DEBUG): Initialize.
2020-02-08T23:09:16.210Z,1581203356.210 [PowerOnly](INFO): Powering up
2020-02-08T23:09:23.168Z,1581203363.168 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for altitude
2020-02-08T23:09:23.169Z,1581203363.169 [RDI_Pathfinder](ERROR): Failed to parse:
:BD,        +0.00,        + 0,   0.00,229.00
2020-02-08T23:09:27.153Z,1581203367.153 [RDI_Pathfinder](ERROR): only read 3 of 4 data items
2020-02-08T23:09:27.153Z,1581203367.153 [RDI_Pathfinder](ERROR): Failed to parse:
:RA,  0.00,   0.00,   0.00,   0.00
2020-02-08T23:09:28.805Z,1581203368.805 [RDI_Pathfinder](ERROR): only read 2 of 4 data items
2020-02-08T23:09:28.806Z,1581203368.806 [RDI_Pathfinder](ERROR): Failed to parse:
:BS,-3268,-32768,V
2020-02-08T23:09:35.285Z,1581203375.285 [DefaultWithUndock:B.Undock](INFO): Detaching from dock.
2020-02-08T23:09:35.799Z,1581203375.799 [DefaultWithUndock:B.Undock](INFO): Detected possible detachment. Starting timer.
2020-02-08T23:09:47.776Z,1581203387.776 [RDI_Pathfinder](ERROR): only read 3 of 4 data items
2020-02-08T23:09:47.777Z,1581203387.777 [RDI_Pathfinder](ERROR): Failed to parse:
:RA,  0.00,   0.00,   0.00,   0.00
2020-02-08T23:09:55.867Z,1581203395.867 [DefaultWithUndock:B.Undock](INFO): Detached at range: nan m. Transitioning DDM to standby.
2020-02-08T23:10:14.057Z,1581203414.057 [DefaultWithUndock:B.Undock](INFO): DDM at standby.
2020-02-08T23:10:14.424Z,1581203414.424 [DefaultWithUndock:B.Undock](IMPORTANT): Undocking sequence complete.
2020-02-08T23:10:14.424Z,1581203414.424 [DefaultWithUndock:B.Undock] Stopped
2020-02-08T23:10:14.831Z,1581203414.831 [DefaultWithUndock:CheckIn] Running Loop=1
2020-02-08T23:10:14.831Z,1581203414.831 [DefaultWithUndock:CheckIn](DEBUG): Aggregate::initialize DefaultWithUndock:CheckIn
2020-02-08T23:10:14.831Z,1581203414.831 [DefaultWithUndock:CheckIn:Read_GPS] Running Loop=1
2020-02-08T23:10:15.297Z,1581203415.297 [DefaultWithUndock:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2020-02-08T23:10:47.525Z,1581203447.525 [PowerOnly](INFO): Powering down
2020-02-08T23:10:47.654Z,1581203447.654 [CommandLine](IMPORTANT): got command ibit
2020-02-08T23:10:47.956Z,1581203447.956 [IBIT](IMPORTANT): Beginning Initiated BIT
2020-02-08T23:10:47.956Z,1581203447.956 [IBIT](IMPORTANT): Beginning control surface checks.
2020-02-08T23:10:47.960Z,1581203447.960 [CBIT](IMPORTANT): Beginning ground fault scan
2020-02-08T23:10:58.734Z,1581203458.734 [CommandLine](IMPORTANT): got command strobe off
2020-02-08T23:10:58.734Z,1581203458.734 [CommandLine](IMPORTANT): Deactivating strobe
2020-02-08T23:10:58.912Z,1581203458.912 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): 0.017333
CHAN A1 (24V): -0.027828
CHAN A2 (12V): -0.007860
CHAN A3 (5V): -0.002183
CHAN B0 (3.3V): -0.000296
CHAN B1 (3.15aV): 0.000080
CHAN B2 (3.15bV): -0.000341
CHAN B3 (GND): 0.002013
OPEN: 0.005259
Full Scale Calc: 4.765 mA, -1.589 mA
2020-02-08T23:11:03.299Z,1581203463.299 [IBIT](FAULT): Could not read elevatorAngleReader_.
2020-02-08T23:11:03.299Z,1581203463.299 [IBIT](FAULT): Control surface position failure.
2020-02-08T23:11:07.078Z,1581203467.078 [CommandLine](IMPORTANT): got command failComponent
2020-02-08T23:11:07.079Z,1581203467.079 [CommandLine](IMPORTANT): Failed components:
2020-02-08T23:11:07.079Z,1581203467.079 [CommandLine](IMPORTANT): ElevatorServo: Hardware Fault
2020-02-08T23:11:08.151Z,1581203468.151 [RDI_Pathfinder](ERROR): Failed to parse:
:RA,  0.00,   0.00,   0.00,   0.00,   0.00
2020-02-08T23:11:10.687Z,1581203470.687 [CommandLine](IMPORTANT): got command failComponent none ElevatorServo
2020-02-08T23:11:10.687Z,1581203470.687 [ElevatorServo] No Fault, FailCount= 3
2020-02-08T23:11:10.687Z,1581203470.687 [CommandLine](IMPORTANT): ElevatorServo failureMode is No Fault
2020-02-08T23:11:15.045Z,1581203475.045 [ElevatorServo](FAULT): Overload Error
2020-02-08T23:11:15.045Z,1581203475.045 [ElevatorServo] Hardware Fault, FailCount= 4
2020-02-08T23:11:15.045Z,1581203475.045 [ElevatorServo](ERROR): Hardware Fault
2020-02-08T23:11:15.145Z,1581203475.145 [CBIT](ERROR): Hardware Fault in component: ElevatorServo
2020-02-08T23:11:15.145Z,1581203475.145 [CBIT](CRITICAL): Hardware Fault in component: ElevatorServo
2020-02-08T23:11:15.417Z,1581203475.417 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2020-02-08T23:11:15.417Z,1581203475.417 [ElevatorServo](INFO): Powering down
2020-02-08T23:11:15.495Z,1581203475.495 [CBIT](INFO): Critical error at 20200208T231115
2020-02-08T23:11:16.257Z,1581203476.257 [ElevatorServo](DEBUG): Initializing EZServoServo.
2020-02-08T23:11:16.378Z,1581203476.378 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2020-02-08T23:11:18.326Z,1581203478.326 [IBIT](FAULT): Could not read elevatorAngleReader_.
2020-02-08T23:11:18.326Z,1581203478.326 [IBIT](FAULT): Control surface position failure.
2020-02-08T23:11:33.608Z,1581203493.608 [IBIT](FAULT): Could not read elevatorAngleReader_.
2020-02-08T23:11:33.608Z,1581203493.608 [IBIT](FAULT): Control surface position failure.
2020-02-08T23:11:48.909Z,1581203508.909 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2020-02-08T23:11:50.134Z,1581203510.134 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,231133.00,A,4450.18758,N,06733.87558,W,0.369,23.08,080220,,,A*40
2020-02-08T23:11:50.137Z,1581203510.137 [NAL9602](INFO): GPS fix at 20200208T231133: (44.836460, -67.564593)
2020-02-08T23:11:50.203Z,1581203510.203 [IBIT](IMPORTANT): Communications Status:
Fix Status: 1
Iridium Signal Strength: 1
Latitude: 44.836460 Longitude: -67.564590
2020-02-08T23:11:50.585Z,1581203510.585 [IBIT](FAULT): Warning: Battery Data not active. Expected only when running primaries. Threshold checking not active.
2020-02-08T23:11:51.040Z,1581203511.040 [IBIT](IMPORTANT): bitHumidityThreshold: 55.000000 %
2020-02-08T23:11:51.040Z,1581203511.040 [IBIT](IMPORTANT): bitPressureThreshold: 0.750000 psi
2020-02-08T23:11:51.049Z,1581203511.049 [IBIT](IMPORTANT): Pressure:9.599019 PSI
2020-02-08T23:11:51.049Z,1581203511.049 [IBIT](IMPORTANT): Humidity:0.781345 %
2020-02-08T23:11:51.382Z,1581203511.382 [IBIT](IMPORTANT): Vehicle Pitch:-0.462156 degrees
2020-02-08T23:11:51.382Z,1581203511.382 [IBIT](IMPORTANT): Vehicle  Roll:-0.250385 degrees
2020-02-08T23:11:51.382Z,1581203511.382 [IBIT](IMPORTANT): Vehicle  Heading:107.749466 degrees
2020-02-08T23:11:51.897Z,1581203511.897 [IBIT](IMPORTANT): surfaceThreshold: 1.000000 m
2020-02-08T23:11:51.898Z,1581203511.898 [IBIT](IMPORTANT): buoyancyNeutral: 320.000000 cc
2020-02-08T23:11:51.898Z,1581203511.898 [IBIT](IMPORTANT): massDefault: 0.240000 cm
2020-02-08T23:11:51.898Z,1581203511.898 [IBIT](IMPORTANT): stopDepth: 16.000000 m
2020-02-08T23:11:51.899Z,1581203511.899 [IBIT](IMPORTANT): abortDepth: 20.000000 m
2020-02-08T23:11:51.899Z,1581203511.899 [IBIT](IMPORTANT): IBIT FAILED
2020-02-08T23:11:52.224Z,1581203512.224 [DefaultWithUndock:CheckIn:Read_GPS] Stopped
2020-02-08T23:11:52.224Z,1581203512.224 [DefaultWithUndock:CheckIn:Read_Iridium] Running Loop=1
2020-02-08T23:11:52.553Z,1581203512.553 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,231136.00,A,4450.18890,N,06733.87425,W,2.041,23.08,080220,,,A*4E
2020-02-08T23:11:52.555Z,1581203512.555 [NAL9602](INFO): GPS fix at 20200208T231136: (44.836482, -67.564571)
2020-02-08T23:11:52.632Z,1581203512.632 [DefaultWithUndock:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications
2020-02-08T23:11:55.706Z,1581203515.706 [CommandLine](IMPORTANT): got command get latitude
2020-02-08T23:11:55.706Z,1581203515.706 [CommandLine](IMPORTANT): latitude 44.836482 arcdeg
2020-02-08T23:11:55.948Z,1581203515.948 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20200208T222803/Courier0022.lzma
2020-02-08T23:11:57.658Z,1581203517.658 [DataOverHttps](INFO): Moved sent file to Logs/20200208T222803/Courier0022.lzma.bak
2020-02-08T23:11:57.659Z,1581203517.659 [DataOverHttps](INFO): SBD MOMSN=12238026
2020-02-08T23:11:59.169Z,1581203519.169 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error
2020-02-08T23:11:59.169Z,1581203519.169 [RDI_Pathfinder](ERROR): Failed to parse:
:TS,2002081624588-0.1,   0.0,1448.9,  0
2020-02-08T23:12:15.349Z,1581203535.349 [DataOverHttps](INFO): Sending 348 bytes from file Logs/20200208T230509/Courier0000.lzma
2020-02-08T23:12:17.354Z,1581203537.354 [DataOverHttps](INFO): Moved sent file to Logs/20200208T230509/Courier0000.lzma.bak
2020-02-08T23:12:17.355Z,1581203537.355 [DataOverHttps](INFO): SBD MOMSN=12238028
2020-02-08T23:12:24.999Z,1581203544.999 [NAL9602](INFO): Not Powering down - fast GPS
2020-02-08T23:12:37.184Z,1581203557.184 [DataOverHttps](INFO): Sending 124 bytes from file Logs/20200208T230509/Courier0004.lzma
2020-02-08T23:12:40.028Z,1581203560.028 [DataOverHttps](INFO): Moved sent file to Logs/20200208T230509/Courier0004.lzma.bak
2020-02-08T23:12:40.028Z,1581203560.028 [DataOverHttps](INFO): SBD MOMSN=12238033
2020-02-08T23:12:45.247Z,1581203565.247 [BPC1](INFO): Calculating totals. Valid battery stick count: 56. Valid reserve battery stick count: 6.
2020-02-08T23:12:45.254Z,1581203565.254 [BPC1](INFO): Received data from all battery sticks.
2020-02-08T23:12:56.824Z,1581203576.824 [DataOverHttps](INFO): Sending 100 bytes from file Logs/20200208T222803/Express0023.lzma
2020-02-08T23:12:58.830Z,1581203578.830 [DataOverHttps](INFO): Moved sent file to Logs/20200208T222803/Express0023.lzma.bak
2020-02-08T23:12:58.830Z,1581203578.830 [DataOverHttps](INFO): SBD MOMSN=12238037
2020-02-08T23:13:16.182Z,1581203596.182 [DataOverHttps](INFO): Sending 1011 bytes from file Logs/20200208T230509/Express0001.lzma
2020-02-08T23:13:18.186Z,1581203598.186 [DataOverHttps](INFO): Moved sent file to Logs/20200208T230509/Express0001.lzma.bak
2020-02-08T23:13:18.186Z,1581203598.186 [DataOverHttps](INFO): SBD MOMSN=12238042
2020-02-08T23:13:36.946Z,1581203616.946 [DataOverHttps](INFO): Sending 1121 bytes from file Logs/20200208T230509/Express0005.lzma
2020-02-08T23:13:38.950Z,1581203618.950 [DataOverHttps](INFO): Moved sent file to Logs/20200208T230509/Express0005.lzma.bak
2020-02-08T23:13:38.950Z,1581203618.950 [DataOverHttps](INFO): SBD MOMSN=12238071
2020-02-08T23:13:40.570Z,1581203620.570 [DefaultWithUndock:CheckIn:Read_Iridium] Stopped
2020-02-08T23:13:40.570Z,1581203620.570 [DefaultWithUndock:CheckIn:C.Wait] Running Loop=1
2020-02-08T23:13:40.570Z,1581203620.570 [DefaultWithUndock:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2020-02-08T23:13:51.394Z,1581203631.394 [CommandLine](IMPORTANT): got command failComponent
2020-02-08T23:13:51.395Z,1581203631.395 [CommandLine](IMPORTANT): Failed components:
2020-02-08T23:13:51.395Z,1581203631.395 [CommandLine](IMPORTANT): ElevatorServo: Hardware Fault
2020-02-08T23:14:01.398Z,1581203641.398 [CommandLine](IMPORTANT): got command failComponent none ElevatorServo
2020-02-08T23:14:01.399Z,1581203641.399 [ElevatorServo] No Fault, FailCount= 4
2020-02-08T23:14:01.399Z,1581203641.399 [CommandLine](IMPORTANT): ElevatorServo failureMode is No Fault
2020-02-08T23:14:30.230Z,1581203670.230 [CommandLine](IMPORTANT): got command failComponent
2020-02-08T23:14:30.230Z,1581203670.230 [CommandLine](IMPORTANT): Failed components:
2020-02-08T23:14:30.231Z,1581203670.231 [CommandLine](IMPORTANT): No failed Components.
2020-02-08T23:14:33.654Z,1581203673.654 [CommandLine](IMPORTANT): got command ibit
2020-02-08T23:14:33.942Z,1581203673.942 [IBIT](IMPORTANT): Beginning Initiated BIT
2020-02-08T23:14:33.942Z,1581203673.942 [IBIT](IMPORTANT): Beginning control surface checks.
2020-02-08T23:14:33.965Z,1581203673.965 [CBIT](IMPORTANT): Beginning ground fault scan
2020-02-08T23:14:35.529Z,1581203675.529 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,231420.00,A,4450.22551,N,06733.87914,W,0.428,307.83,080220,,,A*75
2020-02-08T23:14:35.531Z,1581203675.531 [NAL9602](INFO): GPS fix at 20200208T231420: (44.837092, -67.564652)
2020-02-08T23:14:37.609Z,1581203677.609 [ElevatorServo](FAULT): Overload Error
2020-02-08T23:14:37.609Z,1581203677.609 [ElevatorServo] Hardware Fault, FailCount= 5
2020-02-08T23:14:37.609Z,1581203677.609 [ElevatorServo](ERROR): Hardware Fault
2020-02-08T23:14:37.678Z,1581203677.678 [CBIT](ERROR): Hardware Fault in component: ElevatorServo
2020-02-08T23:14:37.678Z,1581203677.678 [CBIT](CRITICAL): Hardware Fault in component: ElevatorServo
2020-02-08T23:14:38.006Z,1581203678.006 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2020-02-08T23:14:38.007Z,1581203678.007 [ElevatorServo](INFO): Powering down
2020-02-08T23:14:38.037Z,1581203678.037 [CBIT](INFO): Critical error at 20200208T231437
2020-02-08T23:14:38.820Z,1581203678.820 [ElevatorServo](DEBUG): Initializing EZServoServo.
2020-02-08T23:14:38.934Z,1581203678.934 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2020-02-08T23:14:44.982Z,1581203684.982 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): 0.016928
CHAN A1 (24V): -0.029234
CHAN A2 (12V): -0.006788
CHAN A3 (5V): 0.000971
CHAN B0 (3.3V): -0.000614
CHAN B1 (3.15aV): 0.000272
CHAN B2 (3.15bV): -0.000022
CHAN B3 (GND): 0.001997
OPEN: 0.005229
Full Scale Calc: 4.765 mA, -1.589 mA
2020-02-08T23:14:49.009Z,1581203689.009 [IBIT](FAULT): Could not read elevatorAngleReader_.
2020-02-08T23:14:49.009Z,1581203689.009 [IBIT](FAULT): Control surface position failure.
2020-02-08T23:15:03.140Z,1581203703.140 [RDI_Pathfinder](ERROR): Failed to parse:
:8,-32768,-32768,V
2020-02-08T23:15:04.028Z,1581203704.028 [IBIT](FAULT): Could not read elevatorAngleReader_.
2020-02-08T23:15:04.028Z,1581203704.028 [IBIT](FAULT): Control surface position failure.
2020-02-08T23:15:08.809Z,1581203708.809 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for altitude
2020-02-08T23:15:08.809Z,1581203708.809 [RDI_Pathfinder](ERROR): Failed to parse:
:BD,        +0.00 +0.00,        +0.00,   0.00,574.99
2020-02-08T23:15:19.322Z,1581203719.322 [IBIT](FAULT): Could not read elevatorAngleReader_.
2020-02-08T23:15:19.322Z,1581203719.322 [IBIT](FAULT): Control surface position failure.
2020-02-08T23:15:46.786Z,1581203746.786 [RDI_Pathfinder](ERROR): Failed to parse:
:0,   0.00,   0.00,   0.00,   0.00
2020-02-08T23:15:49.182Z,1581203749.182 [RDI_Pathfinder](ERROR): only read 3 of 4 data items
2020-02-08T23:15:49.183Z,1581203749.183 [RDI_Pathfinder](ERROR): Failed to parse:
:RA,  0.00,   0.00,   0.00,   0.00,

2020-02-08T23:15:59.671Z,1581203759.671 [CommandLine](IMPORTANT): got command run ./Missions/underIce/DefaultWithUndock.xml
2020-02-08T23:15:59.671Z,1581203759.671 [MissionManager](INFO): Loading Mission: ./Missions/underIce/DefaultWithUndock.xml
2020-02-08T23:15:59.760Z,1581203759.760 [MissionManager](INFO): DefineArg DefaultWithUndock.ElapsedSinceDefaultStarted = 0.000000 min
2020-02-08T23:15:59.762Z,1581203759.762 [MissionManager](INFO): DefineArg DefaultWithUndock.DetachTimeout = 30.000000 min
2020-02-08T23:15:59.763Z,1581203759.763 [MissionManager](INFO): DefineArg DefaultWithUndock.MicromodemCommsInterval = 2.000000 min
2020-02-08T23:15:59.764Z,1581203759.764 [DefaultWithUndock:A.Wait](DEBUG): Construct Wait.
2020-02-08T23:15:59.766Z,1581203759.766 [DefaultWithUndock:B.Undock](DEBUG): Construct.
2020-02-08T23:15:59.771Z,1581203759.771 [DefaultWithUndock:C.GoToSurface](DEBUG): Construct GoToSurface.
2020-02-08T23:15:59.779Z,1581203759.779 [DefaultWithUndock:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2020-02-08T23:15:59.782Z,1581203759.782 [DefaultWithUndock:CheckIn:C.Wait](DEBUG): Construct Wait.
2020-02-08T23:15:59.814Z,1581203759.814 [DefaultWithUndock:F.Execute](DEBUG): Construct Execute.
2020-02-08T23:15:59.847Z,1581203759.847 [MissionManager](DEBUG): 
<?xml version="1.0" encoding="UTF-8"?>
<Mission xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"
         xmlns="Tethys"
         xmlns:Units="Tethys/Units"
         xmlns:Guidance="Tethys/Guidance"
         xmlns:Universal="Tethys/Universal"
         xsi:schemaLocation="Tethys http://okeanids.mbari.org/tethys/Xml/Tethys.xsd
                             Tethys/Units http://okeanids.mbari.org/tethys/Xml/Units.xsd
                             Tethys/Guidance http://okeanids.mbari.org/tethys/Xml/Guidance.xsd
                             Tethys/Universal http://okeanids.mbari.org/tethys/Xml/Universal.xsd"
         Id="DefaultWithUndock">

    <DefineArg Name="ElapsedSinceDefaultStarted"><Units:minute/><Value>0</Value></DefineArg>

    <DefineArg Name="DetachTimeout"><Description>
        Maximum time duration for the vehicle to reach the approach depth after detaching form the dock.
        The vehicle will switch over to midcourse guidance after the timeout is expired.
    </Description><Units:minute/><Value>30</Value></DefineArg>

    <DefineArg Name="MicromodemCommsInterval"><Description>
        How often to trigger Umodem communications
    </Description><Units:minute/><Value>2</Value></DefineArg>
        
    <Guidance:Wait>
        <Description>
            Wait a moment to see if the scheduler starts a new mission before
            starting to actually run Default.
        </Description>
        <Sequence/>
        <Setting><Guidance:Wait.duration/><Units:second/><Value>30</Value></Setting>
    </Guidance:Wait>

    <!-- Leave the dock if necessary --> 
    <Guidance:Undock>
        <Sequence/>
        <Timeout Duration="DetachTimeout">
            <Syslog Severity="Important">Timed out while trying to detach from dock at current depth of <Universal:depth/><Units:meter/>.</Syslog>
        </Timeout>
    </Guidance:Undock>

    <!-- This mission assumes open water so from here on it's the same old default that's always used -->
    <Guidance:GoToSurface>
        <Progression/>
    </Guidance:GoToSurface>

    <Aggregate Id="CheckIn">

        <Sequence Repeat="288"/>

        <ReadDatum Id="Read_GPS">
            <Timeout Duration="P5M"/>
            <Universal:time_fix/>
        </ReadDatum>

        <ReadDatum Id="Read_Iridium">
            <Timeout Duration="P2H">
                <Guidance:Execute>
                    <Sequence/>
                    <Setting><Guidance:Execute.command/><String>Burn on</String></Setting>
                </Guidance:Execute>
                <Syslog Severity="Critical">Dropped weight due to communications timeout.</Syslog>
            </Timeout>
            <Universal:platform_communications/>
        </ReadDatum>

        <Guidance:Wait>
            <Sequence/>
            <Setting><Guidance:Wait.duration/><Units:minute/><Value>5</Value></Setting>
        </Guidance:Wait>

        <Assign><Sequence/><Arg Name="ElapsedSinceDefaultStarted"/><Elapsed><Universal:mission_started/></Elapsed></Assign>

        <Syslog Severity="Important">Default mission has been running for <Arg Name="ElapsedSinceDefaultStarted"/><Units:minute/></Syslog>

    </Aggregate>

    <Syslog Severity="Important">Restarting logs and Default mission.</Syslog>

    <Guidance:Execute>
        <Sequence/>
        <Setting><Guidance:Execute.command/><String>restart logs</String></Setting>
    </Guidance:Execute>

</Mission>


2020-02-08T23:15:59.853Z,1581203759.853 [CommandLine](IMPORTANT): Running ./Missions/underIce/DefaultWithUndock.xml
2020-02-08T23:16:24.331Z,1581203784.331 [IBIT](FAULT): Error acquiring IBIT communications status. Timeout expired.
2020-02-08T23:16:24.746Z,1581203784.746 [IBIT](IMPORTANT): Battery Status:
Battery Charge (AH): 0.000000
Voltage: 15.343000
2020-02-08T23:16:24.747Z,1581203784.747 [IBIT](IMPORTANT): batteryCapacityThreshold: 50.000000 Ah
2020-02-08T23:16:24.748Z,1581203784.748 [IBIT](IMPORTANT): batteryVoltageThreshold: 13.700000 V
2020-02-08T23:16:25.166Z,1581203785.166 [IBIT](IMPORTANT): bitHumidityThreshold: 55.000000 %
2020-02-08T23:16:25.166Z,1581203785.166 [IBIT](IMPORTANT): bitPressureThreshold: 0.750000 psi
2020-02-08T23:16:25.166Z,1581203785.166 [IBIT](IMPORTANT): Pressure:9.499997 PSI
2020-02-08T23:16:25.167Z,1581203785.167 [IBIT](IMPORTANT): Humidity:0.781345 %
2020-02-08T23:16:25.554Z,1581203785.554 [IBIT](IMPORTANT): Vehicle Pitch:-0.399230 degrees
2020-02-08T23:16:25.554Z,1581203785.554 [IBIT](IMPORTANT): Vehicle  Roll:-0.267631 degrees
2020-02-08T23:16:25.554Z,1581203785.554 [IBIT](IMPORTANT): Vehicle  Heading:107.617722 degrees
2020-02-08T23:16:25.961Z,1581203785.961 [IBIT](IMPORTANT): surfaceThreshold: 1.000000 m
2020-02-08T23:16:25.962Z,1581203785.962 [IBIT](IMPORTANT): buoyancyNeutral: 320.000000 cc
2020-02-08T23:16:25.962Z,1581203785.962 [IBIT](IMPORTANT): massDefault: 0.240000 cm
2020-02-08T23:16:25.962Z,1581203785.962 [IBIT](IMPORTANT): stopDepth: 16.000000 m
2020-02-08T23:16:25.962Z,1581203785.962 [IBIT](IMPORTANT): abortDepth: 20.000000 m
2020-02-08T23:16:25.962Z,1581203785.962 [IBIT](IMPORTANT): IBIT FAILED
2020-02-08T23:16:26.352Z,1581203786.352 [DefaultWithUndock] Stopped
2020-02-08T23:16:26.352Z,1581203786.352 [DefaultWithUndock](DEBUG): Aggregate::uninitialize DefaultWithUndock
2020-02-08T23:16:26.352Z,1581203786.352 [DefaultWithUndock:C.GoToSurface] Stopped
2020-02-08T23:16:26.353Z,1581203786.353 [DefaultWithUndock:C.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2020-02-08T23:16:26.353Z,1581203786.353 [DefaultWithUndock:CheckIn] Stopped
2020-02-08T23:16:26.353Z,1581203786.353 [DefaultWithUndock:CheckIn](DEBUG): Aggregate::uninitialize DefaultWithUndock:CheckIn
2020-02-08T23:16:26.353Z,1581203786.353 [DefaultWithUndock:CheckIn:C.Wait] Stopped
2020-02-08T23:16:26.353Z,1581203786.353 [DefaultWithUndock:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2020-02-08T23:16:26.353Z,1581203786.353 [MissionManager](IMPORTANT): Started mission DefaultWithUndock
2020-02-08T23:16:26.353Z,1581203786.353 [DefaultWithUndock] Running Loop=1
2020-02-08T23:16:26.353Z,1581203786.353 [DefaultWithUndock](DEBUG): Aggregate::initialize DefaultWithUndock
2020-02-08T23:16:26.354Z,1581203786.354 [DefaultWithUndock:C.GoToSurface] Running Loop=1
2020-02-08T23:16:26.354Z,1581203786.354 [DefaultWithUndock:C.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2020-02-08T23:16:26.354Z,1581203786.354 [DefaultWithUndock:C.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2020-02-08T23:16:26.354Z,1581203786.354 [DefaultWithUndock:C.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2020-02-08T23:16:26.354Z,1581203786.354 [DefaultWithUndock:C.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2020-02-08T23:16:26.355Z,1581203786.355 [DefaultWithUndock:C.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2020-02-08T23:16:26.355Z,1581203786.355 [DefaultWithUndock:C.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2020-02-08T23:16:26.355Z,1581203786.355 [DefaultWithUndock:A.Wait] Running Loop=1
2020-02-08T23:16:26.355Z,1581203786.355 [DefaultWithUndock:A.Wait](DEBUG): Initialize Wait Component.
2020-02-08T23:16:56.646Z,1581203816.646 [DefaultWithUndock:A.Wait](INFO): Done Waiting.
2020-02-08T23:16:56.647Z,1581203816.647 [DefaultWithUndock:A.Wait] Stopped
2020-02-08T23:16:56.647Z,1581203816.647 [DefaultWithUndock:A.Wait](DEBUG): Uninitialize Wait Component.
2020-02-08T23:16:56.647Z,1581203816.647 [DefaultWithUndock:B.Undock] Running Loop=1
2020-02-08T23:16:56.647Z,1581203816.647 [DefaultWithUndock:B.Undock](DEBUG): Initialize.
2020-02-08T23:16:57.456Z,1581203817.456 [PowerOnly](INFO): Powering up
2020-02-08T23:17:06.784Z,1581203826.784 [RDI_Pathfinder](ERROR): only read 2 of 4 data items
2020-02-08T23:17:06.784Z,1581203826.784 [RDI_Pathfinder](ERROR): Failed to parse:
:BS,-3768,-32768,V
2020-02-08T23:17:16.104Z,1581203836.104 [DefaultWithUndock:B.Undock](INFO): Detaching from dock.
2020-02-08T23:17:16.469Z,1581203836.469 [DefaultWithUndock:B.Undock](INFO): Detected possible detachment. Starting timer.
2020-02-08T23:17:36.677Z,1581203856.677 [DefaultWithUndock:B.Undock](INFO): Detached at range: nan m. Transitioning DDM to standby.
2020-02-08T23:17:48.807Z,1581203868.807 [RDI_Pathfinder](ERROR): Failed to parse:
:BE,-32768,-32768,-32768,V
2020-02-08T23:18:06.158Z,1581203886.158 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error
2020-02-08T23:18:06.159Z,1581203886.159 [RDI_Pathfinder](ERROR): Failed to parse:
:TS,200208163105 -0.1,   0.0,1448.9,  0
2020-02-08T23:18:07.721Z,1581203887.721 [DDM](FAULT): Failed to close latch before timeout.
2020-02-08T23:18:07.721Z,1581203887.721 [DDM] Hardware Fault, FailCount= 1
2020-02-08T23:18:07.722Z,1581203887.722 [DDM](ERROR): Hardware Fault
2020-02-08T23:18:07.834Z,1581203887.834 [CBIT](ERROR): Hardware Fault in component: DDM
2020-02-08T23:18:08.119Z,1581203888.119 [DDM](INFO): Powering down
2020-02-08T23:18:08.987Z,1581203888.987 [CBIT](INFO): Clearing failed state for component DDM
2020-02-08T23:18:08.987Z,1581203888.987 [DDM] No Fault, FailCount= 1
2020-02-08T23:18:13.369Z,1581203893.369 [DDM](INFO): Powering up
2020-02-08T23:18:13.370Z,1581203893.370 [DDM](DEBUG): Initializing DDM.
2020-02-08T23:18:28.799Z,1581203908.799 [PowerOnly](INFO): Powering down
2020-02-08T23:18:29.125Z,1581203909.125 [DDM](INFO): Dynamic Docking Module:{
2020-02-08T23:18:47.405Z,1581203927.405 [DefaultWithUndock:B.Undock](INFO): DDM at standby.
2020-02-08T23:18:47.813Z,1581203927.813 [DefaultWithUndock:B.Undock](IMPORTANT): Undocking sequence complete.
2020-02-08T23:18:47.814Z,1581203927.814 [DefaultWithUndock:B.Undock] Stopped
2020-02-08T23:18:48.143Z,1581203928.143 [DefaultWithUndock:CheckIn] Running Loop=1
2020-02-08T23:18:48.143Z,1581203928.143 [DefaultWithUndock:CheckIn](DEBUG): Aggregate::initialize DefaultWithUndock:CheckIn
2020-02-08T23:18:48.143Z,1581203928.143 [DefaultWithUndock:CheckIn:Read_GPS] Running Loop=1
2020-02-08T23:18:48.542Z,1581203928.542 [DDM](FAULT): failed to deactivate IR emitter.
2020-02-08T23:18:48.542Z,1581203928.542 [DDM] Hardware Fault, FailCount= 1
2020-02-08T23:18:48.542Z,1581203928.542 [DDM](ERROR): Hardware Fault
2020-02-08T23:18:48.602Z,1581203928.602 [DefaultWithUndock:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2020-02-08T23:18:48.611Z,1581203928.611 [CBIT](ERROR): Hardware Fault in component: DDM
2020-02-08T23:18:48.920Z,1581203928.920 [DDM](INFO): Powering down
2020-02-08T23:18:49.794Z,1581203929.794 [CBIT](INFO): Clearing failed state for component DDM
2020-02-08T23:18:49.794Z,1581203929.794 [DDM] No Fault, FailCount= 1
2020-02-08T23:18:54.172Z,1581203934.172 [DDM](INFO): Powering up
2020-02-08T23:18:54.172Z,1581203934.172 [DDM](DEBUG): Initializing DDM.
2020-02-08T23:19:19.230Z,1581203959.230 [DDM](FAULT): failed to initialize; deviceResponse_ loaded: , available: 0
2020-02-08T23:19:19.230Z,1581203959.230 [DDM] Communications Fault, FailCount= 2
2020-02-08T23:19:19.230Z,1581203959.230 [DDM](ERROR): Communications Fault
2020-02-08T23:19:19.307Z,1581203959.307 [CBIT](ERROR): Communications Fault in component: DDM
2020-02-08T23:19:19.628Z,1581203959.628 [DDM](INFO): Powering down
2020-02-08T23:19:20.479Z,1581203960.479 [CBIT](INFO): Clearing failed state for component DDM
2020-02-08T23:19:20.479Z,1581203960.479 [DDM] No Fault, FailCount= 2
2020-02-08T23:19:24.885Z,1581203964.885 [DDM](INFO): Powering up
2020-02-08T23:19:24.885Z,1581203964.885 [DDM](DEBUG): Initializing DDM.
2020-02-08T23:19:27.778Z,1581203967.778 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error
2020-02-08T23:19:27.778Z,1581203967.778 [RDI_Pathfinder](ERROR): Failed to parse:
:TS,20020816322780,35.0, -0.1,   0.0,14
2020-02-08T23:19:30.846Z,1581203970.846 [CommandLine](IMPORTANT): got command failComponent
2020-02-08T23:19:30.847Z,1581203970.847 [CommandLine](IMPORTANT): Failed components:
2020-02-08T23:19:30.847Z,1581203970.847 [CommandLine](IMPORTANT): ElevatorServo: Hardware Fault
2020-02-08T23:19:40.334Z,1581203980.334 [CommandLine](IMPORTANT): got command failComponent none ElevatorServo
2020-02-08T23:19:40.334Z,1581203980.334 [ElevatorServo] No Fault, FailCount= 5
2020-02-08T23:19:40.334Z,1581203980.334 [CommandLine](IMPORTANT): ElevatorServo failureMode is No Fault
2020-02-08T23:19:47.937Z,1581203987.937 [NAL9602](INFO): SBD MO Status=2, MOMSN=10621, MT Status=2, MTMSN=0
2020-02-08T23:19:47.937Z,1581203987.937 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2020-02-08T23:19:48.340Z,1581203988.340 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2020-02-08T23:19:49.551Z,1581203989.551 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,231934.00,A,4450.22728,N,06733.88814,W,0.428,307.83,080220,,,A*7F
2020-02-08T23:19:49.553Z,1581203989.553 [NAL9602](INFO): GPS fix at 20200208T231934: (44.837121, -67.564802)
2020-02-08T23:19:49.612Z,1581203989.612 [DefaultWithUndock:CheckIn:Read_GPS] Stopped
2020-02-08T23:19:49.613Z,1581203989.613 [DefaultWithUndock:CheckIn:Read_Iridium] Running Loop=1
2020-02-08T23:19:49.928Z,1581203989.928 [DDM](FAULT): failed to initialize; deviceResponse_ loaded: !V1,H_RECOVERY_LATCH
!V2,H_RECOVERRS
!V1,H_RECOVERY_LATCH
!V2,H_RECOVERY_WHISKERS
!V1,H_RECOVERY_LATCH
!V2,H_RECOVERY_WHISKERS
!V1,H_RECOVERY_LATCH
!V2,H_RECOVEERS
, available: A4
2020-02-08T23:19:49.928Z,1581203989.928 [DDM] Communications Fault, FailCount= 3
2020-02-08T23:19:49.928Z,1581203989.928 [DDM](ERROR): Communications Fault
2020-02-08T23:19:50.030Z,1581203990.030 [DefaultWithUndock:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications
2020-02-08T23:19:50.044Z,1581203990.044 [CBIT](ERROR): Communications Fault in component: DDM
2020-02-08T23:19:50.044Z,1581203990.044 [CBIT](CRITICAL): Communications Fault in component: DDM
2020-02-08T23:19:50.332Z,1581203990.332 [DDM](INFO): Powering down
2020-02-08T23:19:50.395Z,1581203990.395 [CBIT](INFO): Critical error at 20200208T231950
2020-02-08T23:19:50.396Z,1581203990.396 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals
2020-02-08T23:19:50.795Z,1581203990.795 [MissionManager](INFO): MissionManager is completed.
2020-02-08T23:19:50.795Z,1581203990.795 [MissionManager](INFO): Uninitializing Mission DefaultWithUndock
2020-02-08T23:19:50.795Z,1581203990.795 [DefaultWithUndock] Stopped
2020-02-08T23:19:50.795Z,1581203990.795 [DefaultWithUndock](DEBUG): Aggregate::uninitialize DefaultWithUndock
2020-02-08T23:19:50.795Z,1581203990.795 [DefaultWithUndock:C.GoToSurface] Stopped
2020-02-08T23:19:50.795Z,1581203990.795 [DefaultWithUndock:C.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2020-02-08T23:19:50.796Z,1581203990.796 [DefaultWithUndock:CheckIn] Stopped
2020-02-08T23:19:50.796Z,1581203990.796 [DefaultWithUndock:CheckIn](DEBUG): Aggregate::uninitialize DefaultWithUndock:CheckIn
2020-02-08T23:19:50.796Z,1581203990.796 [DefaultWithUndock:CheckIn:Read_Iridium] Stopped
2020-02-08T23:19:51.217Z,1581203991.217 [MissionManager](IMPORTANT): Started mission DefaultWithUndock
2020-02-08T23:19:51.217Z,1581203991.217 [DefaultWithUndock] Running Loop=1
2020-02-08T23:19:51.217Z,1581203991.217 [DefaultWithUndock](DEBUG): Aggregate::initialize DefaultWithUndock
2020-02-08T23:19:51.217Z,1581203991.217 [DefaultWithUndock:C.GoToSurface] Running Loop=1
2020-02-08T23:19:51.217Z,1581203991.217 [DefaultWithUndock:C.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2020-02-08T23:19:51.217Z,1581203991.217 [DefaultWithUndock:C.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2020-02-08T23:19:51.218Z,1581203991.218 [DefaultWithUndock:C.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2020-02-08T23:19:51.218Z,1581203991.218 [DefaultWithUndock:C.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2020-02-08T23:19:51.218Z,1581203991.218 [DefaultWithUndock:C.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2020-02-08T23:19:51.219Z,1581203991.219 [DefaultWithUndock:C.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2020-02-08T23:19:51.219Z,1581203991.219 [DefaultWithUndock:A.Wait] Running Loop=1
2020-02-08T23:19:51.219Z,1581203991.219 [DefaultWithUndock:A.Wait](DEBUG): Initialize Wait Component.
2020-02-08T23:19:53.179Z,1581203993.179 [CommandLine](IMPORTANT): got command ibit
2020-02-08T23:19:53.254Z,1581203993.254 [IBIT](IMPORTANT): Beginning Initiated BIT
2020-02-08T23:19:53.254Z,1581203993.254 [IBIT](IMPORTANT): Beginning control surface checks.
2020-02-08T23:19:53.265Z,1581203993.265 [CBIT](IMPORTANT): Beginning ground fault scan
2020-02-08T23:19:54.800Z,1581203994.800 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,231939.00,A,4450.22754,N,06733.88669,W,0.564,307.83,080220,,,A*74
2020-02-08T23:19:54.807Z,1581203994.807 [NAL9602](INFO): GPS fix at 20200208T231939: (44.837126, -67.564778)
2020-02-08T23:19:56.909Z,1581203996.909 [ElevatorServo](FAULT): Overload Error
2020-02-08T23:19:56.909Z,1581203996.909 [ElevatorServo] Hardware Fault, FailCount= 6
2020-02-08T23:19:56.909Z,1581203996.909 [ElevatorServo](ERROR): Hardware Fault
2020-02-08T23:19:56.977Z,1581203996.977 [CBIT](ERROR): Hardware Fault in component: ElevatorServo
2020-02-08T23:19:56.978Z,1581203996.978 [CBIT](CRITICAL): Hardware Fault in component: ElevatorServo
2020-02-08T23:19:57.252Z,1581203997.252 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2020-02-08T23:19:57.269Z,1581203997.269 [ElevatorServo](INFO): Powering down
2020-02-08T23:19:57.299Z,1581203997.299 [CBIT](INFO): Critical error at 20200208T231956
2020-02-08T23:19:57.608Z,1581203997.608 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,231942.00,A,4450.22764,N,06733.88521,W,0.778,307.83,080220,,,A*7B
2020-02-08T23:19:57.610Z,1581203997.610 [NAL9602](INFO): GPS fix at 20200208T231942: (44.837127, -67.564753)
2020-02-08T23:19:58.073Z,1581203998.073 [ElevatorServo](DEBUG): Initializing EZServoServo.
2020-02-08T23:19:58.129Z,1581203998.129 [DataOverHttps](INFO): Sending 246 bytes from file Logs/20200208T230509/Courier0007.lzma
2020-02-08T23:19:58.190Z,1581203998.190 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2020-02-08T23:20:00.134Z,1581204000.134 [DataOverHttps](INFO): Moved sent file to Logs/20200208T230509/Courier0007.lzma.bak
2020-02-08T23:20:00.134Z,1581204000.134 [DataOverHttps](INFO): SBD MOMSN=12238112
2020-02-08T23:20:04.162Z,1581204004.162 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): 0.016675
CHAN A1 (24V): -0.028726
CHAN A2 (12V): -0.007351
CHAN A3 (5V): -0.001845
CHAN B0 (3.3V): 0.000079
CHAN B1 (3.15aV): 0.000175
CHAN B2 (3.15bV): 0.000110
CHAN B3 (GND): 0.001985
OPEN: 0.005430
Full Scale Calc: 4.765 mA, -1.589 mA
2020-02-08T23:20:04.484Z,1581204004.484 [CommandLine](IMPORTANT): got command failComponent hardware DDM
2020-02-08T23:20:04.484Z,1581204004.484 [DDM] Hardware Fault, FailCount= 3
2020-02-08T23:20:04.484Z,1581204004.484 [DDM](ERROR): Hardware Fault
2020-02-08T23:20:04.484Z,1581204004.484 [CommandLine](IMPORTANT): DDM failureMode is Hardware Fault
2020-02-08T23:20:05.963Z,1581204005.963 [CommandLine](IMPORTANT): got command failComponent hardware DDM
2020-02-08T23:20:05.963Z,1581204005.963 [CommandLine](IMPORTANT): DDM failureMode is Hardware Fault
2020-02-08T23:20:06.315Z,1581204006.315 [CommandLine](IMPORTANT): got command failComponent hardware DDM
2020-02-08T23:20:06.315Z,1581204006.315 [CommandLine](IMPORTANT): DDM failureMode is Hardware Fault
2020-02-08T23:20:06.498Z,1581204006.498 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,231951.00,A,4450.22722,N,06733.88746,W,0.233,307.83,080220,,,A*72
2020-02-08T23:20:06.500Z,1581204006.500 [NAL9602](INFO): GPS fix at 20200208T231951: (44.837120, -67.564791)
2020-02-08T23:20:06.653Z,1581204006.653 [CommandLine](IMPORTANT): got command failComponent hardware DDM
2020-02-08T23:20:06.654Z,1581204006.654 [CommandLine](IMPORTANT): DDM failureMode is Hardware Fault
2020-02-08T23:20:06.941Z,1581204006.941 [CommandLine](IMPORTANT): got command failComponent hardware DDM
2020-02-08T23:20:06.942Z,1581204006.942 [CommandLine](IMPORTANT): DDM failureMode is Hardware Fault
2020-02-08T23:20:07.155Z,1581204007.155 [CommandLine](IMPORTANT): got command failComponent hardware DDM
2020-02-08T23:20:07.155Z,1581204007.155 [CommandLine](IMPORTANT): DDM failureMode is Hardware Fault
2020-02-08T23:20:07.366Z,1581204007.366 [CommandLine](IMPORTANT): got command failComponent hardware DDM
2020-02-08T23:20:07.366Z,1581204007.366 [CommandLine](IMPORTANT): DDM failureMode is Hardware Fault
2020-02-08T23:20:07.794Z,1581204007.794 [CommandLine](IMPORTANT): got command failComponent hardware DDM
2020-02-08T23:20:07.794Z,1581204007.794 [CommandLine](IMPORTANT): DDM failureMode is Hardware Fault
2020-02-08T23:20:08.014Z,1581204008.014 [CommandLine](IMPORTANT): got command failComponent hardware DDM
2020-02-08T23:20:08.014Z,1581204008.014 [CommandLine](IMPORTANT): DDM failureMode is Hardware Fault
2020-02-08T23:20:08.242Z,1581204008.242 [CommandLine](IMPORTANT): got command failComponent hardware DDM
2020-02-08T23:20:08.242Z,1581204008.242 [CommandLine](IMPORTANT): DDM failureMode is Hardware Fault
2020-02-08T23:20:08.478Z,1581204008.478 [CommandLine](IMPORTANT): got command failComponent hardware DDM
2020-02-08T23:20:08.478Z,1581204008.478 [CommandLine](IMPORTANT): DDM failureMode is Hardware Fault
2020-02-08T23:20:08.586Z,1581204008.586 [IBIT](FAULT): Could not read elevatorAngleReader_.
2020-02-08T23:20:08.586Z,1581204008.586 [IBIT](FAULT): Control surface position failure.
2020-02-08T23:20:08.685Z,1581204008.685 [CommandLine](IMPORTANT): got command failComponent hardware DDM
2020-02-08T23:20:08.686Z,1581204008.686 [CommandLine](IMPORTANT): DDM failureMode is Hardware Fault
2020-02-08T23:20:08.862Z,1581204008.862 [CommandLine](IMPORTANT): got command failComponent hardware DDM
2020-02-08T23:20:08.862Z,1581204008.862 [CommandLine](IMPORTANT): DDM failureMode is Hardware Fault
2020-02-08T23:20:09.054Z,1581204009.054 [CommandLine](IMPORTANT): got command failComponent hardware DDM
2020-02-08T23:20:09.055Z,1581204009.055 [CommandLine](IMPORTANT): DDM failureMode is Hardware Fault
2020-02-08T23:20:09.382Z,1581204009.382 [CommandLine](IMPORTANT): got command failComponent hardware DDM
2020-02-08T23:20:09.382Z,1581204009.382 [CommandLine](IMPORTANT): DDM failureMode is Hardware Fault
2020-02-08T23:20:09.698Z,1581204009.698 [CommandLine](IMPORTANT): got command failComponent hardware DDM
2020-02-08T23:20:09.698Z,1581204009.698 [CommandLine](IMPORTANT): DDM failureMode is Hardware Fault
2020-02-08T23:20:09.734Z,1581204009.734 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,231954.00,A,4450.22623,N,06733.88976,W,0.369,307.83,080220,,,A*74
2020-02-08T23:20:09.736Z,1581204009.736 [NAL9602](INFO): GPS fix at 20200208T231954: (44.837104, -67.564829)
2020-02-08T23:20:11.154Z,1581204011.154 [CommandLine](IMPORTANT): got command failComponent hardware DDM
2020-02-08T23:20:11.155Z,1581204011.155 [CommandLine](IMPORTANT): DDM failureMode is Hardware Fault
2020-02-08T23:20:12.366Z,1581204012.366 [CommandLine](IMPORTANT): got command failComponent
2020-02-08T23:20:12.366Z,1581204012.366 [CommandLine](IMPORTANT): Failed components:
2020-02-08T23:20:12.366Z,1581204012.366 [CommandLine](IMPORTANT): DDM: Hardware Fault
2020-02-08T23:20:12.366Z,1581204012.366 [CommandLine](IMPORTANT): ElevatorServo: Hardware Fault
2020-02-08T23:20:12.561Z,1581204012.561 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,231957.00,A,4450.22604,N,06733.88976,W,0.311,307.83,080220,,,A*7D
2020-02-08T23:20:12.563Z,1581204012.563 [NAL9602](INFO): GPS fix at 20200208T231957: (44.837101, -67.564829)
2020-02-08T23:20:15.795Z,1581204015.795 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,232000.00,A,4450.22592,N,06733.88975,W,0.214,307.83,080220,,,A*7E
2020-02-08T23:20:15.797Z,1581204015.797 [NAL9602](INFO): GPS fix at 20200208T232000: (44.837099, -67.564829)
2020-02-08T23:20:18.632Z,1581204018.632 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,232003.00,A,4450.22581,N,06733.88952,W,0.292,307.83,080220,,,A*74
2020-02-08T23:20:18.634Z,1581204018.634 [NAL9602](INFO): GPS fix at 20200208T232003: (44.837097, -67.564825)
2020-02-08T23:20:21.460Z,1581204021.460 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,232006.00,A,4450.22623,N,06733.88876,W,0.408,307.83,080220,,,A*78
2020-02-08T23:20:21.463Z,1581204021.463 [NAL9602](INFO): GPS fix at 20200208T232006: (44.837104, -67.564813)
2020-02-08T23:20:23.926Z,1581204023.926 [IBIT](FAULT): Could not read elevatorAngleReader_.
2020-02-08T23:20:23.926Z,1581204023.926 [IBIT](FAULT): Control surface position failure.
2020-02-08T23:20:24.681Z,1581204024.681 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,232009.00,A,4450.22569,N,06733.89031,W,0.117,307.83,080220,,,A*7B
2020-02-08T23:20:24.683Z,1581204024.683 [NAL9602](INFO): GPS fix at 20200208T232009: (44.837095, -67.564838)
2020-02-08T23:20:27.512Z,1581204027.512 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,232012.00,A,4450.22533,N,06733.89128,W,0.564,307.83,080220,,,A*77
2020-02-08T23:20:27.515Z,1581204027.515 [NAL9602](INFO): GPS fix at 20200208T232012: (44.837089, -67.564855)
2020-02-08T23:20:30.740Z,1581204030.740 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,232015.00,A,4450.22531,N,06733.89132,W,1.030,307.83,080220,,,A*7C
2020-02-08T23:20:30.742Z,1581204030.742 [NAL9602](INFO): GPS fix at 20200208T232015: (44.837089, -67.564855)
2020-02-08T23:20:33.568Z,1581204033.568 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,232018.00,A,4450.22542,N,06733.89109,W,0.272,307.83,080220,,,A*78
2020-02-08T23:20:33.570Z,1581204033.570 [NAL9602](INFO): GPS fix at 20200208T232018: (44.837090, -67.564852)
2020-02-08T23:20:36.805Z,1581204036.805 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,232021.00,A,4450.22563,N,06733.89054,W,0.019,307.83,080220,,,A*77
2020-02-08T23:20:36.807Z,1581204036.807 [NAL9602](INFO): GPS fix at 20200208T232021: (44.837094, -67.564842)
2020-02-08T23:20:39.282Z,1581204039.282 [IBIT](FAULT): Could not read elevatorAngleReader_.
2020-02-08T23:20:39.282Z,1581204039.282 [IBIT](FAULT): Control surface position failure.
2020-02-08T23:20:39.628Z,1581204039.628 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,232024.00,A,4450.22585,N,06733.89012,W,0.564,307.83,080220,,,A*77
2020-02-08T23:20:39.631Z,1581204039.631 [NAL9602](INFO): GPS fix at 20200208T232024: (44.837097, -67.564835)
2020-02-08T23:20:39.689Z,1581204039.689 [IBIT](IMPORTANT): Communications Status:
Fix Status: 1
Iridium Signal Strength: 2
Latitude: 44.837097 Longitude: -67.564835
2020-02-08T23:20:40.124Z,1581204040.124 [IBIT](IMPORTANT): Battery Status:
Battery Charge (AH): 0.000000
Voltage: 15.343000
2020-02-08T23:20:40.124Z,1581204040.124 [IBIT](IMPORTANT): batteryCapacityThreshold: 50.000000 Ah
2020-02-08T23:20:40.124Z,1581204040.124 [IBIT](IMPORTANT): batteryVoltageThreshold: 13.700000 V
2020-02-08T23:20:40.529Z,1581204040.529 [IBIT](IMPORTANT): bitHumidityThreshold: 55.000000 %
2020-02-08T23:20:40.530Z,1581204040.530 [IBIT](IMPORTANT): bitPressureThreshold: 0.750000 psi
2020-02-08T23:20:40.530Z,1581204040.530 [IBIT](IMPORTANT): Pressure:9.510579 PSI
2020-02-08T23:20:40.530Z,1581204040.530 [IBIT](IMPORTANT): Humidity:0.781345 %
2020-02-08T23:20:40.874Z,1581204040.874 [IBIT](IMPORTANT): Vehicle Pitch:-0.402739 degrees
2020-02-08T23:20:40.874Z,1581204040.874 [IBIT](IMPORTANT): Vehicle  Roll:-0.266581 degrees
2020-02-08T23:20:40.874Z,1581204040.874 [IBIT](IMPORTANT): Vehicle  Heading:110.567474 degrees
2020-02-08T23:20:41.293Z,1581204041.293 [IBIT](IMPORTANT): surfaceThreshold: 1.000000 m
2020-02-08T23:20:41.294Z,1581204041.294 [IBIT](IMPORTANT): buoyancyNeutral: 320.000000 cc
2020-02-08T23:20:41.294Z,1581204041.294 [IBIT](IMPORTANT): massDefault: 0.240000 cm
2020-02-08T23:20:41.294Z,1581204041.294 [IBIT](IMPORTANT): stopDepth: 16.000000 m
2020-02-08T23:20:41.294Z,1581204041.294 [IBIT](IMPORTANT): abortDepth: 20.000000 m
2020-02-08T23:20:41.294Z,1581204041.294 [IBIT](IMPORTANT): IBIT FAILED
2020-02-08T23:20:41.684Z,1581204041.684 [DefaultWithUndock:A.Wait](INFO): Done Waiting.
2020-02-08T23:20:41.684Z,1581204041.684 [DefaultWithUndock:A.Wait] Stopped
2020-02-08T23:20:41.684Z,1581204041.684 [DefaultWithUndock:A.Wait](DEBUG): Uninitialize Wait Component.
2020-02-08T23:20:41.684Z,1581204041.684 [DefaultWithUndock:B.Undock] Running Loop=1
2020-02-08T23:20:41.685Z,1581204041.685 [DefaultWithUndock:B.Undock](DEBUG): Initialize.
2020-02-08T23:20:42.477Z,1581204042.477 [PowerOnly](INFO): Powering up
2020-02-08T23:21:05.034Z,1581204065.034 [CommandLine](IMPORTANT): got command show stack
2020-02-08T23:21:05.034Z,1581204065.034 [CommandLine](IMPORTANT): Behavior Stack:

2020-02-08T23:21:05.034Z,1581204065.034 [DefaultWithUndock](IMPORTANT): Priority 0: DefaultWithUndock:B.Undock
2020-02-08T23:21:05.034Z,1581204065.034 [DefaultWithUndock](IMPORTANT): Priority 1: DefaultWithUndock:C.GoToSurface
2020-02-08T23:21:11.955Z,1581204071.955 [NAL9602](INFO): Not Powering down - fast GPS
2020-02-08T23:22:13.813Z,1581204133.813 [PowerOnly](INFO): Powering down
2020-02-08T23:22:14.583Z,1581204134.583 [PowerOnly](INFO): Powering up
2020-02-08T23:23:45.929Z,1581204225.929 [PowerOnly](INFO): Powering down
2020-02-08T23:23:46.781Z,1581204226.781 [PowerOnly](INFO): Powering up
2020-02-08T23:24:50.202Z,1581204290.202 [CBIT](INFO): Clearing failed state for component DDM
2020-02-08T23:24:50.202Z,1581204290.202 [DDM] No Fault, FailCount= 3
2020-02-08T23:24:50.546Z,1581204290.546 [DDM](INFO): Powering up
2020-02-08T23:24:50.547Z,1581204290.547 [DDM](DEBUG): Initializing DDM.
2020-02-08T23:25:15.597Z,1581204315.597 [DDM](FAULT): failed to initialize; deviceResponse_ loaded: , available: 0
2020-02-08T23:25:15.597Z,1581204315.597 [DDM] Communications Fault, FailCount= 1
2020-02-08T23:25:15.597Z,1581204315.597 [DDM](ERROR): Communications Fault
2020-02-08T23:25:15.694Z,1581204315.694 [CBIT](ERROR): Communications Fault in component: DDM
2020-02-08T23:25:15.000Z,1581204316.000 [DDM](INFO): Powering down
2020-02-08T23:25:16.918Z,1581204316.918 [CBIT](INFO): Clearing failed state for component DDM
2020-02-08T23:25:16.918Z,1581204316.918 [DDM] No Fault, FailCount= 1
2020-02-08T23:25:18.043Z,1581204318.043 [PowerOnly](INFO): Powering down
2020-02-08T23:25:18.845Z,1581204318.845 [PowerOnly](INFO): Powering up
2020-02-08T23:25:21.251Z,1581204321.251 [DDM](INFO): Powering up
2020-02-08T23:25:21.252Z,1581204321.252 [DDM](DEBUG): Initializing DDM.
2020-02-08T23:25:43.162Z,1581204343.162 [RDI_Pathfinder](ERROR): only read 3 of 4 data items
2020-02-08T23:25:43.162Z,1581204343.162 [RDI_Pathfinder](ERROR): Failed to parse:
:RA,  0.00,   0.00,   0.00,   0.00
2020-02-08T23:25:46.299Z,1581204346.299 [DDM](FAULT): failed to initialize; deviceResponse_ loaded: , available: 0
2020-02-08T23:25:46.299Z,1581204346.299 [DDM] Communications Fault, FailCount= 2
2020-02-08T23:25:46.299Z,1581204346.299 [DDM](ERROR): Communications Fault
2020-02-08T23:25:46.372Z,1581204346.372 [CBIT](ERROR): Communications Fault in component: DDM
2020-02-08T23:25:46.703Z,1581204346.703 [DDM](INFO): Powering down
2020-02-08T23:25:47.561Z,1581204347.561 [CBIT](INFO): Clearing failed state for component DDM
2020-02-08T23:25:47.561Z,1581204347.561 [DDM] No Fault, FailCount= 2
2020-02-08T23:25:51.960Z,1581204351.960 [DDM](INFO): Powering up
2020-02-08T23:25:51.961Z,1581204351.961 [DDM](DEBUG): Initializing DDM.
2020-02-08T23:26:07.790Z,1581204367.790 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for altitude
2020-02-08T23:26:07.790Z,1581204367.790 [RDI_Pathfinder](ERROR): Failed to parse:
:BD,        +0.00,        +0.   +0.00,   0.00,1233.93
2020-02-08T23:26:17.008Z,1581204377.008 [DDM](FAULT): failed to initialize; deviceResponse_ loaded: , available: 0
2020-02-08T23:26:17.009Z,1581204377.009 [DDM] Communications Fault, FailCount= 3
2020-02-08T23:26:17.009Z,1581204377.009 [DDM](ERROR): Communications Fault
2020-02-08T23:26:17.145Z,1581204377.145 [CBIT](ERROR): Communications Fault in component: DDM
2020-02-08T23:26:17.146Z,1581204377.146 [CBIT](CRITICAL): Communications Fault in component: DDM
2020-02-08T23:26:17.410Z,1581204377.410 [DDM](INFO): Powering down
2020-02-08T23:26:17.517Z,1581204377.517 [CBIT](INFO): Critical error at 20200208T232617
2020-02-08T23:26:50.153Z,1581204410.153 [PowerOnly](INFO): Powering down
2020-02-08T23:26:50.977Z,1581204410.977 [PowerOnly](INFO): Powering up
2020-02-08T23:26:53.899Z,1581204413.899 [CommandLine](IMPORTANT): got command show stack
2020-02-08T23:26:53.900Z,1581204413.900 [CommandLine](IMPORTANT): Behavior Stack:

2020-02-08T23:26:53.900Z,1581204413.900 [DefaultWithUndock](IMPORTANT): Priority 0: DefaultWithUndock:B.Undock
2020-02-08T23:26:53.900Z,1581204413.900 [DefaultWithUndock](IMPORTANT): Priority 1: DefaultWithUndock:C.GoToSurface
2020-02-08T23:28:22.275Z,1581204502.275 [PowerOnly](INFO): Powering down
2020-02-08T23:28:23.083Z,1581204503.083 [PowerOnly](INFO): Powering up
2020-02-08T23:29:07.291Z,1581204547.291 [CommandLine](IMPORTANT): got command report touch PowerOnly.samplePowerOnly
2020-02-08T23:29:07.554Z,1581204547.554 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:29:07.966Z,1581204547.966 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:29:08.351Z,1581204548.351 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:29:08.798Z,1581204548.798 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:29:09.163Z,1581204549.163 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:29:09.562Z,1581204549.562 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:29:09.974Z,1581204549.974 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:29:10.386Z,1581204550.386 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:29:10.794Z,1581204550.794 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:29:11.188Z,1581204551.188 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:29:11.582Z,1581204551.582 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:29:12.001Z,1581204552.001 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:29:12.416Z,1581204552.416 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:29:12.796Z,1581204552.796 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:29:13.219Z,1581204553.219 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:29:13.621Z,1581204553.621 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:29:14.028Z,1581204554.028 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:29:14.412Z,1581204554.412 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:29:14.842Z,1581204554.842 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:29:15.244Z,1581204555.244 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:29:15.643Z,1581204555.643 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:29:15.651Z,1581204555.651 [CommandLine](IMPORTANT): got command failComponent
2020-02-08T23:29:15.651Z,1581204555.651 [CommandLine](IMPORTANT): Failed components:
2020-02-08T23:29:15.651Z,1581204555.651 [CommandLine](IMPORTANT): DDM: Communications Fault
2020-02-08T23:29:15.651Z,1581204555.651 [CommandLine](IMPORTANT): ElevatorServo: Hardware Fault
2020-02-08T23:29:16.041Z,1581204556.041 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:29:16.437Z,1581204556.437 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:29:16.880Z,1581204556.880 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:29:17.266Z,1581204557.266 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:29:17.646Z,1581204557.646 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:29:18.059Z,1581204558.059 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:29:18.452Z,1581204558.452 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:29:18.871Z,1581204558.871 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:29:19.264Z,1581204559.264 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:29:19.679Z,1581204559.679 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:29:20.067Z,1581204560.067 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:29:20.467Z,1581204560.467 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:29:20.876Z,1581204560.876 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:29:21.302Z,1581204561.302 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:29:21.684Z,1581204561.684 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:29:22.106Z,1581204562.106 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:29:22.519Z,1581204562.519 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:29:22.892Z,1581204562.892 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:29:23.358Z,1581204563.358 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:29:23.746Z,1581204563.746 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:29:24.159Z,1581204564.159 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:29:24.529Z,1581204564.529 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:29:24.948Z,1581204564.948 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:29:25.364Z,1581204565.364 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:29:25.785Z,1581204565.785 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:29:26.182Z,1581204566.182 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:29:26.564Z,1581204566.564 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:29:26.981Z,1581204566.981 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:29:27.360Z,1581204567.360 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:29:27.736Z,1581204567.736 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:29:28.155Z,1581204568.155 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:29:28.559Z,1581204568.559 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:29:28.974Z,1581204568.974 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:29:29.358Z,1581204569.358 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:29:29.696Z,1581204569.696 [CommandLine](IMPORTANT): got command failComponent
2020-02-08T23:29:29.696Z,1581204569.696 [CommandLine](IMPORTANT): Failed components:
2020-02-08T23:29:29.696Z,1581204569.696 [CommandLine](IMPORTANT): DDM: Communications Fault
2020-02-08T23:29:29.696Z,1581204569.696 [CommandLine](IMPORTANT): ElevatorServo: Hardware Fault
2020-02-08T23:29:29.818Z,1581204569.818 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:29:30.194Z,1581204570.194 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:29:30.571Z,1581204570.571 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:29:31.022Z,1581204571.022 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:29:31.388Z,1581204571.388 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:29:31.782Z,1581204571.782 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:29:32.203Z,1581204572.203 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:29:32.594Z,1581204572.594 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:29:33.004Z,1581204573.004 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:29:33.427Z,1581204573.427 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:29:33.842Z,1581204573.842 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:29:34.230Z,1581204574.230 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:29:34.604Z,1581204574.604 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:29:35.025Z,1581204575.025 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:29:35.439Z,1581204575.439 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:29:35.849Z,1581204575.849 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:29:36.117Z,1581204576.117 [CommandLine](IMPORTANT): got command failComponent none DDM
2020-02-08T23:29:36.118Z,1581204576.118 [DDM] No Fault, FailCount= 3
2020-02-08T23:29:36.118Z,1581204576.118 [CommandLine](IMPORTANT): DDM failureMode is No Fault
2020-02-08T23:29:36.181Z,1581204576.181 [DDM](INFO): Powering up
2020-02-08T23:29:36.181Z,1581204576.181 [DDM](DEBUG): Initializing DDM.
2020-02-08T23:29:36.283Z,1581204576.283 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:29:36.657Z,1581204576.657 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:29:37.046Z,1581204577.046 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:29:37.447Z,1581204577.447 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:29:37.867Z,1581204577.867 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:29:38.243Z,1581204578.243 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:29:38.652Z,1581204578.652 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:29:39.086Z,1581204579.086 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:29:39.530Z,1581204579.530 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:29:39.911Z,1581204579.911 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:29:40.268Z,1581204580.268 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:29:40.683Z,1581204580.683 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:29:41.110Z,1581204581.110 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:29:41.482Z,1581204581.482 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:29:41.887Z,1581204581.887 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:29:42.305Z,1581204582.305 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:29:42.694Z,1581204582.694 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:29:43.104Z,1581204583.104 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:29:43.511Z,1581204583.511 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:29:43.902Z,1581204583.902 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:29:44.310Z,1581204584.310 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:29:44.711Z,1581204584.711 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:29:45.139Z,1581204585.139 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:29:45.530Z,1581204585.530 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:29:45.935Z,1581204585.935 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:29:46.326Z,1581204586.326 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:29:46.738Z,1581204586.738 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:29:47.146Z,1581204587.146 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:29:47.554Z,1581204587.554 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:29:47.965Z,1581204587.965 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:29:48.346Z,1581204588.346 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:29:48.775Z,1581204588.775 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:29:49.179Z,1581204589.179 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:29:49.560Z,1581204589.560 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:29:49.994Z,1581204589.994 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:29:50.378Z,1581204590.378 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:29:50.791Z,1581204590.791 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:29:51.176Z,1581204591.176 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:29:51.586Z,1581204591.586 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:29:51.940Z,1581204591.940 [DDM](INFO): Dynamic Docking Module:!C REMUS Capture Rev 1.1
2020-02-08T23:29:52.155Z,1581204592.155 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:29:52.459Z,1581204592.459 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:29:52.773Z,1581204592.773 [DDM](INFO): Failure count cleared after critical for DDM
2020-02-08T23:29:52.835Z,1581204592.835 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:29:53.241Z,1581204593.241 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:29:53.622Z,1581204593.622 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:29:54.043Z,1581204594.043 [Reporter](INFO): PowerOnly.samplePowerOnly no_value
2020-02-08T23:29:54.416Z,1581204594.416 [PowerOnly](INFO): Powering down
2020-02-08T23:29:54.442Z,1581204594.442 [Reporter](INFO): PowerOnly.samplePowerOnly no_value
2020-02-08T23:29:55.217Z,1581204595.217 [PowerOnly](INFO): Powering up
2020-02-08T23:29:56.060Z,1581204596.060 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:29:56.461Z,1581204596.461 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:29:56.879Z,1581204596.879 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:29:57.263Z,1581204597.263 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:29:57.667Z,1581204597.667 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:29:58.084Z,1581204598.084 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:29:58.487Z,1581204598.487 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:29:58.946Z,1581204598.946 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:29:59.318Z,1581204599.318 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:29:59.718Z,1581204599.718 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:00.136Z,1581204600.136 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:00.528Z,1581204600.528 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:00.960Z,1581204600.960 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:01.328Z,1581204601.328 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:01.732Z,1581204601.732 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:02.149Z,1581204602.149 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:02.526Z,1581204602.526 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:02.932Z,1581204602.932 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:03.338Z,1581204603.338 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:03.723Z,1581204603.723 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:04.141Z,1581204604.141 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:04.531Z,1581204604.531 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:04.951Z,1581204604.951 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:05.352Z,1581204605.352 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:05.807Z,1581204605.807 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:06.173Z,1581204606.173 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:06.558Z,1581204606.558 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:06.979Z,1581204606.979 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:07.351Z,1581204607.351 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:07.800Z,1581204607.800 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:08.155Z,1581204608.155 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error
2020-02-08T23:30:08.155Z,1581204608.155 [RDI_Pathfinder](ERROR): Failed to parse:
:TS,20020816430780,35.0, -0.1,448.9,  0
2020-02-08T23:30:08.178Z,1581204608.178 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:08.584Z,1581204608.584 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:09.014Z,1581204609.014 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:09.380Z,1581204609.380 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:09.788Z,1581204609.788 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:10.206Z,1581204610.206 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:10.598Z,1581204610.598 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:11.020Z,1581204611.020 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:11.413Z,1581204611.413 [DefaultWithUndock:B.Undock](INFO): Detaching from dock.
2020-02-08T23:30:11.422Z,1581204611.422 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:11.791Z,1581204611.791 [DefaultWithUndock:B.Undock](INFO): Detached at range: nan m. Transitioning DDM to standby.
2020-02-08T23:30:11.800Z,1581204611.800 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:12.246Z,1581204612.246 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:12.616Z,1581204612.616 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:13.027Z,1581204613.027 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:13.451Z,1581204613.451 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:13.865Z,1581204613.865 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:14.239Z,1581204614.239 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:14.628Z,1581204614.628 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:15.066Z,1581204615.066 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:15.443Z,1581204615.443 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:15.881Z,1581204615.881 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:16.267Z,1581204616.267 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:16.734Z,1581204616.734 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:17.072Z,1581204617.072 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:17.472Z,1581204617.472 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:17.889Z,1581204617.889 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:18.294Z,1581204618.294 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:18.690Z,1581204618.690 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:19.235Z,1581204619.235 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:19.529Z,1581204619.529 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:19.978Z,1581204619.978 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:20.335Z,1581204620.335 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:20.707Z,1581204620.707 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:21.131Z,1581204621.131 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:21.601Z,1581204621.601 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:21.975Z,1581204621.975 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:22.338Z,1581204622.338 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:22.761Z,1581204622.761 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:23.162Z,1581204623.162 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:23.530Z,1581204623.530 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:23.945Z,1581204623.945 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:24.331Z,1581204624.331 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:24.740Z,1581204624.740 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:25.166Z,1581204625.166 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:25.565Z,1581204625.565 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:25.992Z,1581204625.992 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:26.370Z,1581204626.370 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:26.807Z,1581204626.807 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:27.174Z,1581204627.174 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:27.570Z,1581204627.570 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:27.989Z,1581204627.989 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:28.363Z,1581204628.363 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:28.809Z,1581204628.809 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:29.187Z,1581204629.187 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:29.592Z,1581204629.592 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:30.005Z,1581204630.005 [DefaultWithUndock:B.Undock](INFO): DDM at standby.
2020-02-08T23:30:30.014Z,1581204630.014 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:30.378Z,1581204630.378 [DefaultWithUndock:B.Undock](IMPORTANT): Undocking sequence complete.
2020-02-08T23:30:30.378Z,1581204630.378 [DefaultWithUndock:B.Undock] Stopped
2020-02-08T23:30:30.386Z,1581204630.386 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:30.761Z,1581204630.761 [DefaultWithUndock:CheckIn] Running Loop=1
2020-02-08T23:30:30.761Z,1581204630.761 [DefaultWithUndock:CheckIn](DEBUG): Aggregate::initialize DefaultWithUndock:CheckIn
2020-02-08T23:30:30.761Z,1581204630.761 [DefaultWithUndock:CheckIn:Read_GPS] Running Loop=1
2020-02-08T23:30:30.786Z,1581204630.786 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:31.234Z,1581204631.234 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:31.588Z,1581204631.588 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:31.983Z,1581204631.983 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:32.432Z,1581204632.432 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:32.743Z,1581204632.743 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,233017.00,A,4450.22007,N,06733.87177,W,0.039,234.91,080220,,,A*7A
2020-02-08T23:30:32.745Z,1581204632.745 [NAL9602](INFO): GPS fix at 20200208T233017: (44.837001, -67.564530)
2020-02-08T23:30:32.796Z,1581204632.796 [DefaultWithUndock:CheckIn:Read_GPS] Stopped
2020-02-08T23:30:32.796Z,1581204632.796 [DefaultWithUndock:CheckIn:Read_Iridium] Running Loop=1
2020-02-08T23:30:32.813Z,1581204632.813 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:33.216Z,1581204633.216 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:33.599Z,1581204633.599 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:34.022Z,1581204634.022 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:34.449Z,1581204634.449 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:34.884Z,1581204634.884 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:35.239Z,1581204635.239 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:35.645Z,1581204635.645 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:36.080Z,1581204636.080 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:36.445Z,1581204636.445 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:36.899Z,1581204636.899 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:37.269Z,1581204637.269 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:37.657Z,1581204637.657 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:38.099Z,1581204638.099 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:38.438Z,1581204638.438 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:38.873Z,1581204638.873 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:39.253Z,1581204639.253 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:39.360Z,1581204639.360 [DataOverHttps](INFO): Sending 74 bytes from file Logs/20200208T230509/Courier0008.lzma
2020-02-08T23:30:39.672Z,1581204639.672 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:40.074Z,1581204640.074 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:40.461Z,1581204640.461 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:40.868Z,1581204640.868 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:41.295Z,1581204641.295 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:41.366Z,1581204641.366 [DataOverHttps](INFO): Moved sent file to Logs/20200208T230509/Courier0008.lzma.bak
2020-02-08T23:30:41.366Z,1581204641.366 [DataOverHttps](INFO): SBD MOMSN=12238125
2020-02-08T23:30:41.671Z,1581204641.671 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:42.090Z,1581204642.090 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:42.532Z,1581204642.532 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:42.880Z,1581204642.880 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:43.299Z,1581204643.299 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:43.694Z,1581204643.694 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:44.112Z,1581204644.112 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:44.533Z,1581204644.533 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:44.950Z,1581204644.950 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:45.333Z,1581204645.333 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:45.747Z,1581204645.747 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:46.195Z,1581204646.195 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:46.561Z,1581204646.561 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:46.955Z,1581204646.955 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:47.369Z,1581204647.369 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:47.799Z,1581204647.799 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:48.164Z,1581204648.164 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:48.542Z,1581204648.542 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:48.959Z,1581204648.959 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:49.354Z,1581204649.354 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:49.764Z,1581204649.764 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:50.182Z,1581204650.182 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:50.563Z,1581204650.563 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:51.002Z,1581204651.002 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:51.334Z,1581204651.334 [NAL9602](INFO): SBD MO Status=2, MOMSN=10621, MT Status=2, MTMSN=0
2020-02-08T23:30:51.334Z,1581204651.334 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2020-02-08T23:30:51.406Z,1581204651.406 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:51.799Z,1581204651.799 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:52.207Z,1581204652.207 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:52.582Z,1581204652.582 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:52.996Z,1581204652.996 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:53.392Z,1581204653.392 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:53.839Z,1581204653.839 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:54.206Z,1581204654.206 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:54.633Z,1581204654.633 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:55.054Z,1581204655.054 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:55.454Z,1581204655.454 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:55.902Z,1581204655.902 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:56.306Z,1581204656.306 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:56.658Z,1581204656.658 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:57.090Z,1581204657.090 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:57.486Z,1581204657.486 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:57.921Z,1581204657.921 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:58.255Z,1581204658.255 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:58.381Z,1581204658.381 [CommandLine](IMPORTANT): got command failComponent
2020-02-08T23:30:58.381Z,1581204658.381 [CommandLine](IMPORTANT): Failed components:
2020-02-08T23:30:58.381Z,1581204658.381 [CommandLine](IMPORTANT): ElevatorServo: Hardware Fault
2020-02-08T23:30:58.658Z,1581204658.658 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:59.072Z,1581204659.072 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:59.549Z,1581204659.549 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:30:59.901Z,1581204659.901 [DataOverHttps](INFO): Sending 150 bytes from file Logs/20200208T230509/Courier0010.lzma
2020-02-08T23:30:59.997Z,1581204659.997 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:31:00.270Z,1581204660.270 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:31:00.674Z,1581204660.674 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:31:01.087Z,1581204661.087 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:31:01.194Z,1581204661.194 [DataOverHttps](INFO): Moved sent file to Logs/20200208T230509/Courier0010.lzma.bak
2020-02-08T23:31:01.194Z,1581204661.194 [DataOverHttps](INFO): SBD MOMSN=12238128
2020-02-08T23:31:01.474Z,1581204661.474 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:31:01.885Z,1581204661.885 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:31:02.349Z,1581204662.349 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:31:02.723Z,1581204662.723 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:31:03.107Z,1581204663.107 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:31:03.520Z,1581204663.520 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:31:03.926Z,1581204663.926 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:31:04.341Z,1581204664.341 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:31:04.736Z,1581204664.736 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:31:05.159Z,1581204665.159 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:31:05.557Z,1581204665.557 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:31:05.966Z,1581204665.966 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:31:06.386Z,1581204666.386 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:31:06.784Z,1581204666.784 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:31:07.190Z,1581204667.190 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:31:07.605Z,1581204667.605 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:31:08.009Z,1581204668.009 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:31:08.350Z,1581204668.350 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:31:08.754Z,1581204668.754 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:31:09.167Z,1581204669.167 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:31:09.547Z,1581204669.547 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:31:09.968Z,1581204669.968 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:31:10.367Z,1581204670.367 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:31:10.780Z,1581204670.780 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:31:11.190Z,1581204671.190 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:31:11.586Z,1581204671.586 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:31:12.002Z,1581204672.002 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:31:12.411Z,1581204672.411 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:31:12.784Z,1581204672.784 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:31:13.225Z,1581204673.225 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:31:13.598Z,1581204673.598 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:31:14.031Z,1581204674.031 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:31:14.441Z,1581204674.441 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:31:14.896Z,1581204674.896 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:31:14.900Z,1581204674.900 [CommandLine](IMPORTANT): got command failComponent
2020-02-08T23:31:14.901Z,1581204674.901 [CommandLine](IMPORTANT): Failed components:
2020-02-08T23:31:14.901Z,1581204674.901 [CommandLine](IMPORTANT): ElevatorServo: Hardware Fault
2020-02-08T23:31:15.237Z,1581204675.237 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:31:15.642Z,1581204675.642 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:31:16.074Z,1581204676.074 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:31:16.477Z,1581204676.477 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:31:16.878Z,1581204676.878 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:31:17.259Z,1581204677.259 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:31:17.665Z,1581204677.665 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:31:18.087Z,1581204678.087 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:31:18.455Z,1581204678.455 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:31:18.879Z,1581204678.879 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:31:19.183Z,1581204679.183 [DataOverHttps](INFO): Sending 1246 bytes from file Logs/20200208T230509/Express0008.lzma
2020-02-08T23:31:19.263Z,1581204679.263 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:31:19.662Z,1581204679.662 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:31:20.090Z,1581204680.090 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:31:20.502Z,1581204680.502 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:31:20.878Z,1581204680.878 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:31:21.186Z,1581204681.186 [DataOverHttps](INFO): Moved sent file to Logs/20200208T230509/Express0008.lzma.bak
2020-02-08T23:31:21.186Z,1581204681.186 [DataOverHttps](INFO): SBD MOMSN=12238133
2020-02-08T23:31:21.303Z,1581204681.303 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:31:21.692Z,1581204681.692 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:31:22.072Z,1581204682.072 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:31:22.511Z,1581204682.511 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:31:22.910Z,1581204682.910 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:31:23.333Z,1581204683.333 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:31:23.702Z,1581204683.702 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:31:24.113Z,1581204684.113 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:31:24.521Z,1581204684.521 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:31:24.946Z,1581204684.946 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:31:25.349Z,1581204685.349 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:31:25.773Z,1581204685.773 [Reporter](INFO): PowerOnly.samplePowerOnly 1 bool
2020-02-08T23:31:26.181Z,1581204686.181 [Reporter](INFO): PowerOnly.samplePowerOnly no_value
2020-02-08T23:31:26.514Z,1581204686.514 [PowerOnly](INFO): Powering down
2020-02-08T23:31:26.578Z,1581204686.578 [Reporter](INFO): PowerOnly.samplePowerOnly no_value
2020-02-08T23:31:32.191Z,1581204692.191 [RDI_Pathfinder](ERROR): Failed to parse:
:SA,   +0.00,   +0.00,  0.00
2020-02-08T23:31:39.439Z,1581204699.439 [DataOverHttps](INFO): Sending 1298 bytes from file Logs/20200208T230509/Express0011.lzma
2020-02-08T23:31:41.443Z,1581204701.443 [DataOverHttps](INFO): Moved sent file to Logs/20200208T230509/Express0011.lzma.bak
2020-02-08T23:31:41.443Z,1581204701.443 [DataOverHttps](INFO): SBD MOMSN=12238135
2020-02-08T23:31:43.075Z,1581204703.075 [DefaultWithUndock:CheckIn:Read_Iridium] Stopped
2020-02-08T23:31:43.075Z,1581204703.075 [DefaultWithUndock:CheckIn:C.Wait] Running Loop=1
2020-02-08T23:31:43.075Z,1581204703.075 [DefaultWithUndock:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2020-02-08T23:32:47.783Z,1581204767.783 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error
2020-02-08T23:32:47.783Z,1581204767.783 [RDI_Pathfinder](ERROR): Failed to parse:
:TS,20020816454780,35.0, -0.1,   0.0,1448:RA,  0.00,   0.00,   0.00,   0.00,   0.00
2020-02-08T23:34:13.812Z,1581204853.812 [RDI_Pathfinder](ERROR): only read 3 of 4 data items
2020-02-08T23:34:13.817Z,1581204853.817 [RDI_Pathfinder](ERROR): Failed to parse:
:BS,-32768,-32768,-3:BE,-32768,-32768,-32768,V
2020-02-08T23:34:57.051Z,1581204897.051 [CBIT](INFO): Clearing failed state for component ElevatorServo
2020-02-08T23:34:57.051Z,1581204897.051 [ElevatorServo] No Fault, FailCount= 6
2020-02-08T23:35:12.111Z,1581204912.111 [CommandLine](IMPORTANT): got command get latitude
2020-02-08T23:35:12.112Z,1581204912.112 [CommandLine](IMPORTANT): latitude 44.837001 arcdeg
2020-02-08T23:35:34.975Z,1581204934.975 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2020-02-08T23:36:05.678Z,1581204965.678 [NAL9602](INFO): Not Powering down - fast GPS
2020-02-08T23:36:43.692Z,1581205003.692 [DefaultWithUndock:CheckIn:C.Wait](INFO): Done Waiting.
2020-02-08T23:36:43.692Z,1581205003.692 [DefaultWithUndock:CheckIn:C.Wait] Stopped
2020-02-08T23:36:43.693Z,1581205003.693 [DefaultWithUndock:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2020-02-08T23:36:43.693Z,1581205003.693 [DefaultWithUndock:CheckIn:D] Running Loop=1
2020-02-08T23:36:44.103Z,1581205004.103 [DefaultWithUndock:CheckIn:D] Stopped
2020-02-08T23:36:44.104Z,1581205004.104 [DefaultWithUndock:CheckIn:E] Running Loop=1
2020-02-08T23:36:44.507Z,1581205004.507 [DefaultWithUndock:CheckIn:E](IMPORTANT): Default mission has been running for 16.881440 min 
2020-02-08T23:36:44.507Z,1581205004.507 [DefaultWithUndock:CheckIn:E] Stopped
2020-02-08T23:36:44.507Z,1581205004.507 [DefaultWithUndock:CheckIn](INFO): Completed DefaultWithUndock:CheckIn
2020-02-08T23:36:44.507Z,1581205004.507 [DefaultWithUndock:CheckIn] Stopped
2020-02-08T23:36:44.507Z,1581205004.507 [DefaultWithUndock:CheckIn](DEBUG): Aggregate::uninitialize DefaultWithUndock:CheckIn
2020-02-08T23:36:44.507Z,1581205004.507 [DefaultWithUndock:CheckIn](INFO): Running loop #2
2020-02-08T23:36:44.507Z,1581205004.507 [DefaultWithUndock:CheckIn] Running Loop=2
2020-02-08T23:36:44.508Z,1581205004.508 [DefaultWithUndock:CheckIn](DEBUG): Aggregate::initialize DefaultWithUndock:CheckIn
2020-02-08T23:36:44.508Z,1581205004.508 [DefaultWithUndock:CheckIn:Read_GPS] Running Loop=1
2020-02-08T23:36:46.486Z,1581205006.486 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,233631.00,A,4450.23000,N,06733.87824,W,0.194,317.43,080220,,,A*78
2020-02-08T23:36:46.488Z,1581205006.488 [NAL9602](INFO): GPS fix at 20200208T233631: (44.837167, -67.564637)
2020-02-08T23:36:46.512Z,1581205006.512 [DefaultWithUndock:CheckIn:Read_GPS] Stopped
2020-02-08T23:36:46.512Z,1581205006.512 [DefaultWithUndock:CheckIn:Read_Iridium] Running Loop=1
2020-02-08T23:36:53.775Z,1581205013.775 [DataOverHttps](INFO): Sending 74 bytes from file Logs/20200208T230509/Courier0013.lzma
2020-02-08T23:36:55.777Z,1581205015.777 [DataOverHttps](INFO): Moved sent file to Logs/20200208T230509/Courier0013.lzma.bak
2020-02-08T23:36:55.778Z,1581205015.778 [DataOverHttps](INFO): SBD MOMSN=12238215
2020-02-08T23:37:13.143Z,1581205033.143 [DataOverHttps](INFO): Sending 350 bytes from file Logs/20200208T230509/Express0014.lzma
2020-02-08T23:37:15.146Z,1581205035.146 [DataOverHttps](INFO): Moved sent file to Logs/20200208T230509/Express0014.lzma.bak
2020-02-08T23:37:15.147Z,1581205035.147 [DataOverHttps](INFO): SBD MOMSN=12238218
2020-02-08T23:37:16.836Z,1581205036.836 [DefaultWithUndock:CheckIn:Read_Iridium] Stopped
2020-02-08T23:37:16.837Z,1581205036.837 [DefaultWithUndock:CheckIn:C.Wait] Running Loop=1
2020-02-08T23:37:16.837Z,1581205036.837 [DefaultWithUndock:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2020-02-08T23:37:17.191Z,1581205037.191 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check.
2020-02-08T23:37:17.265Z,1581205037.265 [NAL9602](FAULT): received: 
+CSQ:0

OK621, 2, 0, 0, 0

OK
2020-02-08T23:37:17.265Z,1581205037.265 [NAL9602] Data Fault, FailCount= 1
2020-02-08T23:37:17.265Z,1581205037.265 [NAL9602](ERROR): Data Fault
2020-02-08T23:37:17.305Z,1581205037.305 [CBIT](ERROR): Data Fault in component: NAL9602
2020-02-08T23:37:17.596Z,1581205037.596 [NAL9602](INFO): Powering down
2020-02-08T23:37:18.486Z,1581205038.486 [CBIT](INFO): Clearing failed state for component NAL9602
2020-02-08T23:37:18.486Z,1581205038.486 [NAL9602] No Fault, FailCount= 1
2020-02-08T23:37:19.210Z,1581205039.210 [CommandLine](IMPORTANT): got command ibit
2020-02-08T23:37:19.282Z,1581205039.282 [IBIT](IMPORTANT): Beginning Initiated BIT
2020-02-08T23:37:19.282Z,1581205039.282 [IBIT](IMPORTANT): Beginning control surface checks.
2020-02-08T23:37:19.293Z,1581205039.293 [CBIT](IMPORTANT): Beginning ground fault scan
2020-02-08T23:37:24.137Z,1581205044.137 [ElevatorServo](INFO): Failure count cleared after critical for ElevatorServo
2020-02-08T23:37:30.196Z,1581205050.196 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): 0.017042
CHAN A1 (24V): -0.028629
CHAN A2 (12V): -0.007217
CHAN A3 (5V): 0.001201
CHAN B0 (3.3V): 0.000152
CHAN B1 (3.15aV): -0.000498
CHAN B2 (3.15bV): 0.000095
CHAN B3 (GND): 0.002151
OPEN: 0.005497
Full Scale Calc: 4.765 mA, -1.589 mA
2020-02-08T23:37:34.073Z,1581205054.073 [CommandLine](IMPORTANT): got command failComponent none ElevatorServo
2020-02-08T23:37:34.074Z,1581205054.074 [CommandLine](IMPORTANT): ElevatorServo failureMode is No Fault
2020-02-08T23:37:47.835Z,1581205067.835 [CommandLine](IMPORTANT): got command failComponent
2020-02-08T23:37:47.835Z,1581205067.835 [CommandLine](IMPORTANT): Failed components:
2020-02-08T23:37:47.835Z,1581205067.835 [CommandLine](IMPORTANT): No failed Components.
2020-02-08T23:37:47.919Z,1581205067.919 [NAL9602](INFO): Powering up NAL9602
2020-02-08T23:37:52.873Z,1581205072.873 [CommandLine](IMPORTANT): got command show stack
2020-02-08T23:37:52.874Z,1581205072.874 [CommandLine](IMPORTANT): Behavior Stack:

2020-02-08T23:37:52.874Z,1581205072.874 [DefaultWithUndock](IMPORTANT): Priority 0: DefaultWithUndock:C.GoToSurface
2020-02-08T23:37:52.874Z,1581205072.874 [DefaultWithUndock:CheckIn](IMPORTANT): Priority 1: DefaultWithUndock:CheckIn:C.Wait
2020-02-08T23:37:58.831Z,1581205078.831 [NAL9602](INFO): NAL9602 initialized
2020-02-08T23:38:01.397Z,1581205081.397 [CommandLine](IMPORTANT): got command ibit
2020-02-08T23:38:20.558Z,1581205100.558 [CommandLine](IMPORTANT): got command report mod platform_elevator_angle
2020-02-08T23:38:20.759Z,1581205100.759 [Reporter](INFO): platform_elevator_angle 0.000269 rad
2020-02-08T23:38:23.507Z,1581205103.507 [RDI_Pathfinder](ERROR): only read 3 of 4 data items
2020-02-08T23:38:23.508Z,1581205103.508 [RDI_Pathfinder](ERROR): Failed to parse:
:RA,  0.00,   0.00,   0.00,   0.00
2020-02-08T23:38:38.510Z,1581205118.510 [CommandLine](IMPORTANT): got command ibit
2020-02-08T23:38:56.658Z,1581205136.658 [IBIT](IMPORTANT): Communications Status:
Fix Status: 1
Iridium Signal Strength: 2
Latitude: 44.837166 Longitude: -67.564636
2020-02-08T23:38:57.066Z,1581205137.066 [IBIT](IMPORTANT): Battery Status:
Battery Charge (AH): 0.000000
Voltage: 15.303000
2020-02-08T23:38:57.066Z,1581205137.066 [IBIT](IMPORTANT): batteryCapacityThreshold: 50.000000 Ah
2020-02-08T23:38:57.066Z,1581205137.066 [IBIT](IMPORTANT): batteryVoltageThreshold: 13.700000 V
2020-02-08T23:38:57.453Z,1581205137.453 [IBIT](IMPORTANT): bitHumidityThreshold: 55.000000 %
2020-02-08T23:38:57.454Z,1581205137.454 [IBIT](IMPORTANT): bitPressureThreshold: 0.750000 psi
2020-02-08T23:38:57.454Z,1581205137.454 [IBIT](IMPORTANT): Pressure:9.531011 PSI
2020-02-08T23:38:57.454Z,1581205137.454 [IBIT](IMPORTANT): Humidity:0.885118 %
2020-02-08T23:38:57.870Z,1581205137.870 [IBIT](IMPORTANT): Vehicle Pitch:-0.391785 degrees
2020-02-08T23:38:57.871Z,1581205137.871 [IBIT](IMPORTANT): Vehicle  Roll:-0.215015 degrees
2020-02-08T23:38:57.871Z,1581205137.871 [IBIT](IMPORTANT): Vehicle  Heading:108.084175 degrees
2020-02-08T23:38:58.271Z,1581205138.271 [IBIT](IMPORTANT): surfaceThreshold: 1.000000 m
2020-02-08T23:38:58.272Z,1581205138.272 [IBIT](IMPORTANT): buoyancyNeutral: 320.000000 cc
2020-02-08T23:38:58.272Z,1581205138.272 [IBIT](IMPORTANT): massDefault: 0.240000 cm
2020-02-08T23:38:58.272Z,1581205138.272 [IBIT](IMPORTANT): stopDepth: 16.000000 m
2020-02-08T23:38:58.272Z,1581205138.272 [IBIT](IMPORTANT): abortDepth: 20.000000 m
2020-02-08T23:38:58.277Z,1581205138.277 [IBIT](IMPORTANT): IBIT PASSED
2020-02-08T23:39:07.120Z,1581205147.120 [NAL9602](INFO): SBD MO Status=0, MOMSN=10621, MT Status=0, MTMSN=0
2020-02-08T23:39:07.120Z,1581205147.120 [NAL9602](INFO): No messages in MT queue
2020-02-08T23:39:11.281Z,1581205151.281 [CommandLine](IMPORTANT): got command 
2020-02-08T23:39:11.281Z,1581205151.281 [CommandLine](FAULT): Incomplete syntax. Try: help
2020-02-08T23:39:12.469Z,1581205152.469 [CommandLine](IMPORTANT): got command 
2020-02-08T23:39:12.469Z,1581205152.469 [CommandLine](FAULT): Incomplete syntax. Try: help
2020-02-08T23:39:14.347Z,1581205154.347 [CommandLine](IMPORTANT): got command failComponent
2020-02-08T23:39:14.347Z,1581205154.347 [CommandLine](IMPORTANT): Failed components:
2020-02-08T23:39:14.347Z,1581205154.347 [CommandLine](IMPORTANT): No failed Components.
2020-02-08T23:39:15.790Z,1581205155.790 [CommandLine](IMPORTANT): got command ibit
2020-02-08T23:39:16.059Z,1581205156.059 [IBIT](IMPORTANT): Beginning Initiated BIT
2020-02-08T23:39:16.059Z,1581205156.059 [IBIT](IMPORTANT): Beginning control surface checks.
2020-02-08T23:39:16.062Z,1581205156.062 [CBIT](IMPORTANT): Beginning ground fault scan
2020-02-08T23:39:17.618Z,1581205157.618 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,233902.00,A,4450.22766,N,06733.85778,W,0.058,0.00,080220,,,A*76
2020-02-08T23:39:17.620Z,1581205157.620 [NAL9602](INFO): GPS fix at 20200208T233902: (44.837128, -67.564296)
2020-02-08T23:39:18.218Z,1581205158.218 [Reporter](INFO): platform_elevator_angle 0.000921 rad
2020-02-08T23:39:18.554Z,1581205158.554 [Reporter](INFO): platform_elevator_angle 0.015624 rad
2020-02-08T23:39:19.042Z,1581205159.042 [Reporter](INFO): platform_elevator_angle 0.061765 rad
2020-02-08T23:39:19.351Z,1581205159.351 [Reporter](INFO): platform_elevator_angle 0.107177 rad
2020-02-08T23:39:19.746Z,1581205159.746 [Reporter](INFO): platform_elevator_angle 0.153702 rad
2020-02-08T23:39:20.258Z,1581205160.258 [Reporter](INFO): platform_elevator_angle 0.202952 rad
2020-02-08T23:39:20.459Z,1581205160.459 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,233905.00,A,4450.22784,N,06733.85766,W,0.408,0.00,080220,,,A*73
2020-02-08T23:39:20.461Z,1581205160.461 [NAL9602](INFO): GPS fix at 20200208T233905: (44.837131, -67.564294)
2020-02-08T23:39:20.558Z,1581205160.558 [Reporter](INFO): platform_elevator_angle 0.246675 rad
2020-02-08T23:39:20.975Z,1581205160.975 [Reporter](INFO): platform_elevator_angle 0.261953 rad
2020-02-08T23:39:23.687Z,1581205163.687 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,233908.00,A,4450.22790,N,06733.85709,W,0.583,0.00,080220,,,A*70
2020-02-08T23:39:23.689Z,1581205163.689 [NAL9602](INFO): GPS fix at 20200208T233908: (44.837132, -67.564285)
2020-02-08T23:39:26.514Z,1581205166.514 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,233911.00,A,4450.22781,N,06733.85628,W,0.603,0.00,080220,,,A*71
2020-02-08T23:39:26.516Z,1581205166.516 [NAL9602](INFO): GPS fix at 20200208T233911: (44.837130, -67.564271)
2020-02-08T23:39:26.994Z,1581205166.994 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): 0.016723
CHAN A1 (24V): -0.028541
CHAN A2 (12V): -0.006844
CHAN A3 (5V): -0.000094
CHAN B0 (3.3V): 0.000172
CHAN B1 (3.15aV): -0.000086
CHAN B2 (3.15bV): 0.000055
CHAN B3 (GND): 0.002501
OPEN: 0.005112
Full Scale Calc: 4.765 mA, -1.589 mA
2020-02-08T23:39:29.739Z,1581205169.739 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,233914.00,A,4450.22799,N,06733.85934,W,0.389,0.00,080220,,,A*78
2020-02-08T23:39:29.741Z,1581205169.741 [NAL9602](INFO): GPS fix at 20200208T233914: (44.837133, -67.564322)
2020-02-08T23:39:32.573Z,1581205172.573 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,233917.00,A,4450.22809,N,06733.86089,W,0.136,0.00,080220,,,A*77
2020-02-08T23:39:32.575Z,1581205172.575 [NAL9602](INFO): GPS fix at 20200208T233917: (44.837135, -67.564348)
2020-02-08T23:39:33.546Z,1581205173.546 [Reporter](INFO): platform_elevator_angle 0.262568 rad
2020-02-08T23:39:33.927Z,1581205173.927 [Reporter](INFO): platform_elevator_angle 0.242837 rad
2020-02-08T23:39:34.286Z,1581205174.286 [Reporter](INFO): platform_elevator_angle 0.201993 rad
2020-02-08T23:39:34.678Z,1581205174.678 [Reporter](INFO): platform_elevator_angle 0.156235 rad
2020-02-08T23:39:35.134Z,1581205175.134 [Reporter](INFO): platform_elevator_angle 0.102839 rad
2020-02-08T23:39:35.395Z,1581205175.395 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,233920.00,A,4450.22824,N,06733.86195,W,1.050,0.00,080220,,,A*70
2020-02-08T23:39:35.408Z,1581205175.408 [NAL9602](INFO): GPS fix at 20200208T233920: (44.837137, -67.564366)
2020-02-08T23:39:35.490Z,1581205175.490 [Reporter](INFO): platform_elevator_angle 0.059999 rad
2020-02-08T23:39:35.922Z,1581205175.922 [Reporter](INFO): platform_elevator_angle 0.011324 rad
2020-02-08T23:39:36.314Z,1581205176.314 [Reporter](INFO): platform_elevator_angle -0.035316 rad
2020-02-08T23:39:36.694Z,1581205176.694 [Reporter](INFO): platform_elevator_angle -0.080805 rad
2020-02-08T23:39:37.114Z,1581205177.114 [Reporter](INFO): platform_elevator_angle -0.129326 rad
2020-02-08T23:39:37.518Z,1581205177.519 [Reporter](INFO): platform_elevator_angle -0.175582 rad
2020-02-08T23:39:37.938Z,1581205177.938 [Reporter](INFO): platform_elevator_angle -0.226292 rad
2020-02-08T23:39:38.346Z,1581205178.346 [Reporter](INFO): platform_elevator_angle -0.259535 rad
2020-02-08T23:39:38.627Z,1581205178.627 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,233923.00,A,4450.22839,N,06733.86271,W,0.525,0.00,080220,,,A*70
2020-02-08T23:39:38.640Z,1581205178.640 [NAL9602](INFO): GPS fix at 20200208T233923: (44.837140, -67.564379)
2020-02-08T23:39:38.813Z,1581205178.813 [Reporter](INFO): platform_elevator_angle -0.263028 rad
2020-02-08T23:39:39.278Z,1581205179.278 [Reporter](INFO): platform_elevator_angle -0.261877 rad
2020-02-08T23:39:41.493Z,1581205181.493 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,233926.00,A,4450.22843,N,06733.86303,W,0.350,0.00,080220,,,A*78
2020-02-08T23:39:41.495Z,1581205181.495 [NAL9602](INFO): GPS fix at 20200208T233926: (44.837140, -67.564384)
2020-02-08T23:39:44.697Z,1581205184.697 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,233929.00,A,4450.22835,N,06733.86285,W,0.408,0.00,080220,,,A*73
2020-02-08T23:39:44.699Z,1581205184.699 [NAL9602](INFO): GPS fix at 20200208T233929: (44.837139, -67.564381)
2020-02-08T23:39:47.521Z,1581205187.521 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,233932.00,A,4450.22825,N,06733.86326,W,0.719,0.00,080220,,,A*73
2020-02-08T23:39:47.523Z,1581205187.523 [NAL9602](INFO): GPS fix at 20200208T233932: (44.837137, -67.564388)
2020-02-08T23:39:48.954Z,1581205188.954 [Reporter](INFO): platform_elevator_angle -0.261992 rad
2020-02-08T23:39:49.267Z,1581205189.267 [Reporter](INFO): platform_elevator_angle -0.247788 rad
2020-02-08T23:39:49.634Z,1581205189.634 [Reporter](INFO): platform_elevator_angle -0.207904 rad
2020-02-08T23:39:50.086Z,1581205190.086 [Reporter](INFO): platform_elevator_angle -0.155583 rad
2020-02-08T23:39:50.348Z,1581205190.348 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,233934.00,A,4450.22822,N,06733.86393,W,0.156,0.00,080220,,,A*71
2020-02-08T23:39:50.351Z,1581205190.351 [NAL9602](INFO): GPS fix at 20200208T233934: (44.837137, -67.564399)
2020-02-08T23:39:50.470Z,1581205190.470 [Reporter](INFO): platform_elevator_angle -0.110862 rad
2020-02-08T23:39:50.866Z,1581205190.866 [Reporter](INFO): platform_elevator_angle -0.063032 rad
2020-02-08T23:39:51.258Z,1581205191.258 [Reporter](INFO): platform_elevator_angle -0.018004 rad
2020-02-08T23:39:51.758Z,1581205191.758 [Reporter](INFO): platform_elevator_angle 0.000345 rad
2020-02-08T23:39:53.585Z,1581205193.585 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,233938.00,A,4450.22803,N,06733.86577,W,0.136,0.00,080220,,,A*74
2020-02-08T23:39:53.587Z,1581205193.587 [NAL9602](INFO): GPS fix at 20200208T233938: (44.837134, -67.564430)
2020-02-08T23:39:56.420Z,1581205196.420 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,233941.00,A,4450.22790,N,06733.86648,W,0.797,0.00,080220,,,A*7D
2020-02-08T23:39:56.422Z,1581205196.422 [NAL9602](INFO): GPS fix at 20200208T233941: (44.837132, -67.564441)
2020-02-08T23:39:59.646Z,1581205199.646 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,233944.00,A,4450.22782,N,06733.86762,W,0.544,0.00,080220,,,A*7E
2020-02-08T23:39:59.648Z,1581205199.648 [NAL9602](INFO): GPS fix at 20200208T233944: (44.837130, -67.564460)
2020-02-08T23:40:02.464Z,1581205202.464 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,233947.00,A,4450.22775,N,06733.86850,W,0.486,0.00,080220,,,A*74
2020-02-08T23:40:02.466Z,1581205202.466 [NAL9602](INFO): GPS fix at 20200208T233947: (44.837129, -67.564475)
2020-02-08T23:40:02.532Z,1581205202.532 [IBIT](IMPORTANT): Communications Status:
Fix Status: 1
Iridium Signal Strength: 2
Latitude: 44.837128 Longitude: -67.564476
2020-02-08T23:40:02.939Z,1581205202.939 [IBIT](IMPORTANT): Battery Status:
Battery Charge (AH): 0.000000
Voltage: 15.303000
2020-02-08T23:40:02.939Z,1581205202.939 [IBIT](IMPORTANT): batteryCapacityThreshold: 50.000000 Ah
2020-02-08T23:40:02.939Z,1581205202.939 [IBIT](IMPORTANT): batteryVoltageThreshold: 13.700000 V
2020-02-08T23:40:03.315Z,1581205203.315 [IBIT](IMPORTANT): bitHumidityThreshold: 55.000000 %
2020-02-08T23:40:03.315Z,1581205203.315 [IBIT](IMPORTANT): bitPressureThreshold: 0.750000 psi
2020-02-08T23:40:03.316Z,1581205203.316 [IBIT](IMPORTANT): Pressure:9.515296 PSI
2020-02-08T23:40:03.316Z,1581205203.316 [IBIT](IMPORTANT): Humidity:0.854596 %
2020-02-08T23:40:03.714Z,1581205203.714 [IBIT](IMPORTANT): Vehicle Pitch:-0.418020 degrees
2020-02-08T23:40:03.714Z,1581205203.714 [IBIT](IMPORTANT): Vehicle  Roll:-0.222880 degrees
2020-02-08T23:40:03.714Z,1581205203.714 [IBIT](IMPORTANT): Vehicle  Heading:108.474876 degrees
2020-02-08T23:40:04.143Z,1581205204.143 [IBIT](IMPORTANT): surfaceThreshold: 1.000000 m
2020-02-08T23:40:04.143Z,1581205204.143 [IBIT](IMPORTANT): buoyancyNeutral: 320.000000 cc
2020-02-08T23:40:04.143Z,1581205204.143 [IBIT](IMPORTANT): massDefault: 0.240000 cm
2020-02-08T23:40:04.144Z,1581205204.144 [IBIT](IMPORTANT): stopDepth: 16.000000 m
2020-02-08T23:40:04.144Z,1581205204.144 [IBIT](IMPORTANT): abortDepth: 20.000000 m
2020-02-08T23:40:04.144Z,1581205204.144 [IBIT](IMPORTANT): IBIT PASSED
2020-02-08T23:40:16.286Z,1581205216.286 [CommandLine](IMPORTANT): got command failComponent
2020-02-08T23:40:16.286Z,1581205216.286 [CommandLine](IMPORTANT): Failed components:
2020-02-08T23:40:16.286Z,1581205216.286 [CommandLine](IMPORTANT): No failed Components.
2020-02-08T23:40:19.099Z,1581205219.099 [CommandLine](IMPORTANT): got command get latitude
2020-02-08T23:40:19.099Z,1581205219.099 [CommandLine](IMPORTANT): latitude 44.837129 arcdeg
2020-02-08T23:40:35.223Z,1581205235.223 [NAL9602](INFO): Not Powering down - fast GPS
2020-02-08T23:40:43.261Z,1581205243.261 [CommandLine](IMPORTANT): got command restart application
2020-02-08T23:40:44.265Z,1581205244.265 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2020-02-08T23:40:44.265Z,1581205244.265 [CommandLine ThreadHandler](INFO): Thread cancelled.
2020-02-08T23:40:44.417Z,1581205244.417 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup.  Bye!
2020-02-08T23:40:44.417Z,1581205244.417 [CommandLine ThreadHandler](INFO): Thread cancelled.
2020-02-08T23:40:44.417Z,1581205244.417 [CommandLine](INFO): Join timeout helper Thread ID is 1807
2020-02-08T23:40:44.418Z,1581205244.418 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2020-02-08T23:40:44.418Z,1581205244.418 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2020-02-08T23:40:44.418Z,1581205244.418 [NavChartDb](INFO): Join timeout helper Thread ID is 1808
2020-02-08T23:40:44.717Z,1581205244.717 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2020-02-08T23:40:44.717Z,1581205244.717 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2020-02-08T23:40:44.729Z,1581205244.729 [ComponentRegistry](INFO): Shutting down WetLabsSeaOWL_UV_A ThreadHandler
2020-02-08T23:40:44.729Z,1581205244.729 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Thread cancelled.
2020-02-08T23:40:44.729Z,1581205244.729 [WetLabsSeaOWL_UV_A](INFO): Join timeout helper Thread ID is 1809
2020-02-08T23:40:44.741Z,1581205244.741 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Uninitializing protected caller thread.
2020-02-08T23:40:44.741Z,1581205244.741 [WetLabsSeaOWL_UV_A](INFO): Powering down
2020-02-08T23:40:44.742Z,1581205244.742 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Thread cancelled.
2020-02-08T23:40:44.749Z,1581205244.749 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2020-02-08T23:40:44.749Z,1581205244.749 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2020-02-08T23:40:44.750Z,1581205244.750 [Radio_Surface](INFO): Join timeout helper Thread ID is 1810
2020-02-08T23:40:45.125Z,1581205245.125 [Radio_Surface](INFO): Powering down
2020-02-08T23:40:45.126Z,1581205245.126 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2020-02-08T23:40:45.126Z,1581205245.126 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2020-02-08T23:40:45.137Z,1581205245.137 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler
2020-02-08T23:40:45.137Z,1581205245.137 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2020-02-08T23:40:45.137Z,1581205245.137 [DataOverHttps](INFO): Join timeout helper Thread ID is 1811
2020-02-08T23:40:45.213Z,1581205245.213 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread.
2020-02-08T23:40:45.213Z,1581205245.213 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2020-02-08T23:40:45.222Z,1581205245.222 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2020-02-08T23:40:45.222Z,1581205245.222 [logger ThreadHandler](INFO): Thread cancelled.
2020-02-08T23:40:45.222Z,1581205245.222 [logger](INFO): Join timeout helper Thread ID is 1812
2020-02-08T23:40:45.257Z,1581205245.257 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2020-02-08T23:40:45.257Z,1581205245.257 [logger ThreadHandler](INFO): Thread cancelled.
2020-02-08T23:40:45.261Z,1581205245.261 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2020-02-08T23:40:45.262Z,1581205245.262 [CommandLine ThreadHandler](INFO): Thread cancelled.
2020-02-08T23:40:45.262Z,1581205245.262 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2020-02-08T23:40:45.262Z,1581205245.262 [controlThread ThreadHandler](INFO): Thread cancelled.
2020-02-08T23:40:45.262Z,1581205245.262 [controlThread](INFO): Join timeout helper Thread ID is 1813
2020-02-08T23:40:45.301Z,1581205245.301 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2020-02-08T23:40:45.301Z,1581205245.301 [controlThread](DEBUG): Uninitializing ControlThread
2020-02-08T23:40:45.302Z,1581205245.302 [AHRS_M2](INFO): Powering down
2020-02-08T23:40:45.373Z,1581205245.373 [DDM](INFO): Powering down
2020-02-08T23:40:45.445Z,1581205245.445 [DUSBL_Hydroid](INFO): Powering down
2020-02-08T23:40:45.533Z,1581205245.533 [Micromodem](INFO): Powering down
2020-02-08T23:40:45.629Z,1581205245.629 [NAL9602](INFO): Powering down
2020-02-08T23:40:45.701Z,1581205245.701 [RDI_Pathfinder](INFO): Powering down
2020-02-08T23:40:45.702Z,1581205245.702 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2020-02-08T23:40:45.703Z,1581205245.703 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2020-02-08T23:40:45.704Z,1581205245.704 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2020-02-08T23:40:45.704Z,1581205245.704 [MissionManager](INFO): Uninitializing Mission DefaultWithUndock
2020-02-08T23:40:45.704Z,1581205245.704 [DefaultWithUndock] Stopped
2020-02-08T23:40:45.705Z,1581205245.705 [DefaultWithUndock](DEBUG): Aggregate::uninitialize DefaultWithUndock
2020-02-08T23:40:45.705Z,1581205245.705 [DefaultWithUndock:C.GoToSurface] Stopped
2020-02-08T23:40:45.705Z,1581205245.705 [DefaultWithUndock:C.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2020-02-08T23:40:45.705Z,1581205245.705 [DefaultWithUndock:CheckIn] Stopped
2020-02-08T23:40:45.705Z,1581205245.705 [DefaultWithUndock:CheckIn](DEBUG): Aggregate::uninitialize DefaultWithUndock:CheckIn
2020-02-08T23:40:45.705Z,1581205245.705 [DefaultWithUndock:CheckIn:C.Wait] Stopped
2020-02-08T23:40:45.705Z,1581205245.705 [DefaultWithUndock:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2020-02-08T23:40:45.708Z,1581205245.708 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2020-02-08T23:40:45.708Z,1581205245.708 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2020-02-08T23:40:45.709Z,1581205245.709 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2020-02-08T23:40:45.709Z,1581205245.709 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2020-02-08T23:40:45.709Z,1581205245.709 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2020-02-08T23:40:45.709Z,1581205245.709 [BuoyancyServo](INFO): Powering down
2020-02-08T23:40:45.721Z,1581205245.721 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2020-02-08T23:40:45.721Z,1581205245.721 [ElevatorServo](INFO): Powering down
2020-02-08T23:40:45.722Z,1581205245.722 [MassServo](DEBUG): Uninitialize Mass Servo.
2020-02-08T23:40:45.722Z,1581205245.722 [MassServo](INFO): Powering down
2020-02-08T23:40:45.723Z,1581205245.723 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2020-02-08T23:40:45.723Z,1581205245.723 [RudderServo](INFO): Powering down
2020-02-08T23:40:45.724Z,1581205245.724 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2020-02-08T23:40:45.724Z,1581205245.724 [ThrusterServo](INFO): Powering down
2020-02-08T23:40:45.724Z,1581205245.724 [SBIT](DEBUG): Uninitialize SBIT Component.
2020-02-08T23:40:45.725Z,1581205245.725 [IBIT](DEBUG): Uninitialize IBIT Component.
2020-02-08T23:40:45.725Z,1581205245.725 [CBIT](DEBUG): Uninitialize CBIT Component.
2020-02-08T23:40:45.725Z,1581205245.725 [CBIT](DEBUG): Powering off loads.
2020-02-08T23:40:45.737Z,1581205245.737 [CBIT](DEBUG): Disabling WDT.
2020-02-08T23:40:45.749Z,1581205245.749 [CBIT](DEBUG): Opening all GF detection circuits.
2020-02-08T23:40:45.749Z,1581205245.749 [controlThread ThreadHandler](INFO): Thread cancelled.
2020-02-08T23:40:45.797Z,1581205245.797 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2020-02-08T23:40:45.808Z,1581205245.808 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2020-02-08T23:40:45.850Z,1581205245.850 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Thread cancelled.
2020-02-08T23:40:45.907Z,1581205245.907 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2020-02-08T23:40:45.973Z,1581205245.973 [logger ThreadHandler](INFO): Thread cancelled.