2018-09-25T18:34:01.916Z,1537900441.916 [Supervisor](DEBUG): Initializing supervisor.
2018-09-25T18:34:01.919Z,1537900441.919 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2018-09-25T18:34:01.920Z,1537900441.920 [SyncHandler](INFO): Protected caller Thread ID is 7523
2018-09-25T18:34:01.920Z,1537900441.920 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2018-09-25T18:34:01.922Z,1537900441.922 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2018-09-25T18:34:01.922Z,1537900441.922 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 7524
2018-09-25T18:34:01.926Z,1537900441.926 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2018-09-25T18:34:01.938Z,1537900441.938 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2018-09-25T18:34:01.939Z,1537900441.939 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2018-09-25T18:34:01.939Z,1537900441.939 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 7525
2018-09-25T18:34:01.940Z,1537900441.940 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2018-09-25T18:34:01.941Z,1537900441.941 [logger ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2018-09-25T18:34:01.941Z,1537900441.941 [logger ThreadHandler](INFO): Protected caller Thread ID is 7526
2018-09-25T18:34:01.943Z,1537900441.943 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2018-09-25T18:34:01.944Z,1537900441.944 [Supervisor](INFO): Looking for Config files in directory: Config/
2018-09-25T18:34:01.945Z,1537900441.945 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2018-09-25T18:34:02.134Z,1537900442.134 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2018-09-25T18:34:02.134Z,1537900442.134 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2018-09-25T18:34:02.278Z,1537900442.278 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2018-09-25T18:34:02.278Z,1537900442.278 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2018-09-25T18:34:02.623Z,1537900442.623 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2018-09-25T18:34:02.623Z,1537900442.623 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2018-09-25T18:34:02.762Z,1537900442.762 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2018-09-25T18:34:02.763Z,1537900442.763 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2018-09-25T18:34:02.843Z,1537900442.843 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2018-09-25T18:34:03.044Z,1537900443.044 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2018-09-25T18:34:03.045Z,1537900443.045 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2018-09-25T18:34:03.143Z,1537900443.143 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample
2018-09-25T18:34:03.143Z,1537900443.143 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2018-09-25T18:34:03.488Z,1537900443.488 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2018-09-25T18:34:03.489Z,1537900443.489 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2018-09-25T18:34:03.962Z,1537900443.962 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2018-09-25T18:34:03.963Z,1537900443.963 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2018-09-25T18:34:04.276Z,1537900444.276 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2018-09-25T18:34:04.277Z,1537900444.277 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2018-09-25T18:34:04.780Z,1537900444.780 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2018-09-25T18:34:04.781Z,1537900444.781 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2018-09-25T18:34:04.987Z,1537900444.987 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2018-09-25T18:34:04.987Z,1537900444.987 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2018-09-25T18:34:05.085Z,1537900445.085 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2018-09-25T18:34:05.086Z,1537900445.086 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2018-09-25T18:34:05.577Z,1537900445.577 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2018-09-25T18:34:05.578Z,1537900445.578 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2018-09-25T18:34:05.684Z,1537900445.684 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2018-09-25T18:34:05.686Z,1537900445.686 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-whoidhs/
2018-09-25T18:34:05.687Z,1537900445.687 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Battery.cfg
2018-09-25T18:34:05.917Z,1537900445.917 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2018-09-25T18:34:05.918Z,1537900445.918 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/BIT.cfg
2018-09-25T18:34:06.016Z,1537900446.016 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Navigation.cfg
2018-09-25T18:34:06.109Z,1537900446.109 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Control.cfg
2018-09-25T18:34:06.213Z,1537900446.213 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Simulator.cfg
2018-09-25T18:34:06.299Z,1537900446.299 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Science.cfg
2018-09-25T18:34:06.433Z,1537900446.433 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Sensor.cfg
2018-09-25T18:34:06.600Z,1537900446.600 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Servo.cfg
2018-09-25T18:34:06.711Z,1537900446.711 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/logger.cfg
2018-09-25T18:34:06.796Z,1537900446.796 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/secure.cfg
2018-09-25T18:34:06.925Z,1537900446.925 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/vehicle.cfg
2018-09-25T18:34:07.116Z,1537900447.116 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-whoidhs/root/
2018-09-25T18:34:07.117Z,1537900447.117 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg
2018-09-25T18:34:07.129Z,1537900447.129 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2018-09-25T18:34:07.264Z,1537900447.264 [SBIT](DEBUG): Construct Startup Built In Test.
2018-09-25T18:34:07.295Z,1537900447.295 [SBIT] Loaded
2018-09-25T18:34:07.295Z,1537900447.295 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2018-09-25T18:34:07.296Z,1537900447.296 [IBIT](DEBUG): Construct Initiated Built In Test.
2018-09-25T18:34:07.323Z,1537900447.323 [IBIT] Loaded
2018-09-25T18:34:07.323Z,1537900447.323 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2018-09-25T18:34:07.327Z,1537900447.327 [CBIT](DEBUG): Construct Continuous Built In Test.
2018-09-25T18:34:07.486Z,1537900447.486 [CBIT] Loaded
2018-09-25T18:34:07.486Z,1537900447.486 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2018-09-25T18:34:07.486Z,1537900447.486 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2018-09-25T18:34:07.487Z,1537900447.487 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2018-09-25T18:34:07.559Z,1537900447.559 [VerticalControl](DEBUG): Construct VerticalControl.
2018-09-25T18:34:07.661Z,1537900447.661 [VerticalControl] Loaded
2018-09-25T18:34:07.661Z,1537900447.661 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2018-09-25T18:34:07.662Z,1537900447.662 [HorizontalControl](DEBUG): Construct HorizontalControl.
2018-09-25T18:34:07.724Z,1537900447.724 [HorizontalControl] Loaded
2018-09-25T18:34:07.724Z,1537900447.724 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2018-09-25T18:34:07.725Z,1537900447.725 [SpeedControl](DEBUG): Construct SpeedControl.
2018-09-25T18:34:07.730Z,1537900447.730 [SpeedControl] Loaded
2018-09-25T18:34:07.731Z,1537900447.731 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2018-09-25T18:34:07.731Z,1537900447.731 [LoopControl](DEBUG): Construct LoopControl.
2018-09-25T18:34:07.732Z,1537900447.732 [LoopControl] Loaded
2018-09-25T18:34:07.732Z,1537900447.732 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2018-09-25T18:34:07.732Z,1537900447.732 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2018-09-25T18:34:07.733Z,1537900447.733 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2018-09-25T18:34:07.776Z,1537900447.776 [DepthRateCalculator] Loaded
2018-09-25T18:34:07.776Z,1537900447.776 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2018-09-25T18:34:07.781Z,1537900447.781 [PitchRateCalculator] Loaded
2018-09-25T18:34:07.782Z,1537900447.782 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2018-09-25T18:34:07.798Z,1537900447.798 [SpeedCalculator] Loaded
2018-09-25T18:34:07.798Z,1537900447.798 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2018-09-25T18:34:07.820Z,1537900447.820 [TempGradientCalculator] Loaded
2018-09-25T18:34:07.820Z,1537900447.820 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread.
2018-09-25T18:34:07.825Z,1537900447.825 [YawRateCalculator] Loaded
2018-09-25T18:34:07.826Z,1537900447.826 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2018-09-25T18:34:07.856Z,1537900447.856 [ElevatorOffsetCalculator] Loaded
2018-09-25T18:34:07.856Z,1537900447.856 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2018-09-25T18:34:07.856Z,1537900447.856 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2018-09-25T18:34:07.857Z,1537900447.857 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2018-09-25T18:34:07.923Z,1537900447.923 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2018-09-25T18:34:07.924Z,1537900447.924 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2018-09-25T18:34:08.336Z,1537900448.336 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2018-09-25T18:34:08.337Z,1537900448.337 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2018-09-25T18:34:08.437Z,1537900448.437 [DeadReckonUsingMultipleVelocitySources] Loaded
2018-09-25T18:34:08.437Z,1537900448.437 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2018-09-25T18:34:08.493Z,1537900448.493 [DeadReckonUsingSpeedCalculator] Loaded
2018-09-25T18:34:08.493Z,1537900448.493 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread.
2018-09-25T18:34:08.510Z,1537900448.510 [NavChart] Loaded
2018-09-25T18:34:08.511Z,1537900448.511 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2018-09-25T18:34:08.515Z,1537900448.515 [UniversalFixResidualReporter] Loaded
2018-09-25T18:34:08.515Z,1537900448.515 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2018-09-25T18:34:08.516Z,1537900448.516 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2018-09-25T18:34:08.516Z,1537900448.516 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2018-09-25T18:34:08.530Z,1537900448.530 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2018-09-25T18:34:08.531Z,1537900448.531 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2018-09-25T18:34:08.752Z,1537900448.752 [Aanderaa_O2] Loaded
2018-09-25T18:34:08.753Z,1537900448.753 [ComponentRegistry](DEBUG): SyncComponent "Aanderaa_O2" handled in the control thread.
2018-09-25T18:34:08.834Z,1537900448.834 [CTD_NeilBrown] Loaded
2018-09-25T18:34:08.835Z,1537900448.835 [ComponentRegistry](DEBUG): Component "CTD_NeilBrown" handled in its own thread.
2018-09-25T18:34:08.836Z,1537900448.836 [CTD_NeilBrown ThreadHandler](DEBUG): Created PCaller Thread at 406DC4E0
2018-09-25T18:34:08.836Z,1537900448.836 [CTD_NeilBrown ThreadHandler](INFO): Protected caller Thread ID is 7605
2018-09-25T18:34:08.882Z,1537900448.882 [WetLabsSeaOWL_UV_A] Loaded
2018-09-25T18:34:08.882Z,1537900448.882 [ComponentRegistry](DEBUG): Component "WetLabsSeaOWL_UV_A" handled in its own thread.
2018-09-25T18:34:08.883Z,1537900448.883 [WetLabsSeaOWL_UV_A ThreadHandler](DEBUG): Created PCaller Thread at 4070C4E0
2018-09-25T18:34:08.884Z,1537900448.884 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Protected caller Thread ID is 7606
2018-09-25T18:34:08.884Z,1537900448.884 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2018-09-25T18:34:08.885Z,1537900448.885 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2018-09-25T18:34:16.867Z,1537900456.867 [AHRS_M2] Loaded
2018-09-25T18:34:16.867Z,1537900456.867 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread.
2018-09-25T18:34:16.937Z,1537900456.937 [DataOverHttps] Loaded
2018-09-25T18:34:16.937Z,1537900456.937 [ComponentRegistry](DEBUG): SyncComponent "DataOverHttps" handled in the control thread.
2018-09-25T18:34:16.951Z,1537900456.951 [Depth_Keller] Loaded
2018-09-25T18:34:16.951Z,1537900456.951 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2018-09-25T18:34:16.956Z,1537900456.956 [DropWeight] Loaded
2018-09-25T18:34:16.956Z,1537900456.956 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2018-09-25T18:34:17.051Z,1537900457.051 [NAL9602] Loaded
2018-09-25T18:34:17.051Z,1537900457.051 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2018-09-25T18:34:17.056Z,1537900457.056 [Onboard] Loaded
2018-09-25T18:34:17.057Z,1537900457.057 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread.
2018-09-25T18:34:17.064Z,1537900457.064 [Radio_Surface] Loaded
2018-09-25T18:34:17.064Z,1537900457.064 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2018-09-25T18:34:17.065Z,1537900457.065 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 4096D4E0
2018-09-25T18:34:17.065Z,1537900457.065 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 7607
2018-09-25T18:34:17.094Z,1537900457.094 [RDI_Pathfinder] Loaded
2018-09-25T18:34:17.095Z,1537900457.095 [ComponentRegistry](DEBUG): SyncComponent "RDI_Pathfinder" handled in the control thread.
2018-09-25T18:34:17.101Z,1537900457.101 [SCPI] Loaded
2018-09-25T18:34:17.102Z,1537900457.102 [ComponentRegistry](DEBUG): SyncComponent "SCPI" handled in the control thread.
2018-09-25T18:34:19.251Z,1537900459.251 [BPC1] Loaded
2018-09-25T18:34:19.251Z,1537900459.251 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2018-09-25T18:34:19.251Z,1537900459.251 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2018-09-25T18:34:19.252Z,1537900459.252 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2018-09-25T18:34:19.354Z,1537900459.354 [BuoyancyServo] Loaded
2018-09-25T18:34:19.354Z,1537900459.354 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2018-09-25T18:34:19.366Z,1537900459.366 [ElevatorServo] Loaded
2018-09-25T18:34:19.366Z,1537900459.366 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2018-09-25T18:34:19.377Z,1537900459.377 [MassServo] Loaded
2018-09-25T18:34:19.378Z,1537900459.378 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2018-09-25T18:34:19.389Z,1537900459.389 [RudderServo] Loaded
2018-09-25T18:34:19.389Z,1537900459.389 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2018-09-25T18:34:19.400Z,1537900459.400 [ThrusterServo] Loaded
2018-09-25T18:34:19.401Z,1537900459.401 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread.
2018-09-25T18:34:19.401Z,1537900459.401 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2018-09-25T18:34:19.402Z,1537900459.402 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2018-09-25T18:34:19.506Z,1537900459.506 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2018-09-25T18:34:19.506Z,1537900459.506 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2018-09-25T18:34:19.531Z,1537900459.531 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2018-09-25T18:34:19.535Z,1537900459.535 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2018-09-25T18:34:19.536Z,1537900459.536 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2018-09-25T18:34:19.542Z,1537900459.542 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2018-09-25T18:34:19.543Z,1537900459.543 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40A164E0
2018-09-25T18:34:19.544Z,1537900459.544 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 7608
2018-09-25T18:34:19.548Z,1537900459.548 [Supervisor](INFO): Main Thread ID is 7118
2018-09-25T18:34:19.548Z,1537900459.548 [Supervisor](DEBUG): Running supervisor.
2018-09-25T18:34:19.549Z,1537900459.549 [CommandLine ThreadHandler](INFO): Handler Thread ID is 7609
2018-09-25T18:34:19.552Z,1537900459.552 [controlThread ThreadHandler](INFO): Handler Thread ID is 7610
2018-09-25T18:34:19.552Z,1537900459.552 [controlThread](DEBUG): Initializing ControlThread
2018-09-25T18:34:19.553Z,1537900459.553 [SBIT](INFO): Initialize SBIT Component.
2018-09-25T18:34:19.554Z,1537900459.554 [SBIT](IMPORTANT): git: 2018-09-20-5-g5e39eb3
2018-09-25T18:34:19.554Z,1537900459.554 [SBIT](INFO): git hash: 5e39eb3ba9bfec4d7f64e06abe2b60a1880c281e
2018-09-25T18:34:19.554Z,1537900459.554 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2018-09-25T18:34:19.554Z,1537900459.554 [SBIT](IMPORTANT): Kernel Version:#2 PREEMPT Thu Jan 11 20:13:48 PST 2018
2018-09-25T18:34:19.556Z,1537900459.556 [SBIT](INFO): Beginning SBIT in 20.000000 seconds.
2018-09-25T18:34:19.556Z,1537900459.556 [IBIT](INFO): Initialize IBIT Component.
2018-09-25T18:34:19.557Z,1537900459.557 [CBIT](DEBUG): Initialize CBIT Component.
2018-09-25T18:34:19.557Z,1537900459.557 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2018-09-25T18:34:19.558Z,1537900459.558 [logger ThreadHandler](INFO): Handler Thread ID is 7611
2018-09-25T18:34:19.585Z,1537900459.585 [CTD_NeilBrown ThreadHandler](INFO): Handler Thread ID is 7612
2018-09-25T18:34:19.586Z,1537900459.586 [CTD_NeilBrown](INFO): Powering down
2018-09-25T18:34:19.621Z,1537900459.621 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Handler Thread ID is 7613
2018-09-25T18:34:19.622Z,1537900459.622 [WetLabsSeaOWL_UV_A](INFO): Stop
2018-09-25T18:34:19.623Z,1537900459.623 [WetLabsSeaOWL_UV_A](INFO): Powering down
2018-09-25T18:34:19.661Z,1537900459.661 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 7614
2018-09-25T18:34:19.665Z,1537900459.665 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2018-09-25T18:34:19.667Z,1537900459.667 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2018-09-25T18:34:19.668Z,1537900459.668 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2018-09-25T18:34:19.668Z,1537900459.668 [LoopControl](DEBUG): Initialize LoopControlComponent.
2018-09-25T18:34:19.668Z,1537900459.668 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2018-09-25T18:34:19.669Z,1537900459.669 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2018-09-25T18:34:19.669Z,1537900459.669 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2018-09-25T18:34:19.670Z,1537900459.670 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator.
2018-09-25T18:34:19.670Z,1537900459.670 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2018-09-25T18:34:19.670Z,1537900459.670 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2018-09-25T18:34:19.671Z,1537900459.671 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2018-09-25T18:34:19.672Z,1537900459.672 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2018-09-25T18:34:19.672Z,1537900459.672 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2018-09-25T18:34:19.673Z,1537900459.673 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2018-09-25T18:34:19.673Z,1537900459.673 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2018-09-25T18:34:19.674Z,1537900459.674 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2018-09-25T18:34:19.674Z,1537900459.674 [NavChart](DEBUG): Initialize NavChart Navigation.
2018-09-25T18:34:19.674Z,1537900459.674 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2018-09-25T18:34:19.684Z,1537900459.684 [MissionManager](INFO): Loading Mission: Missions/Startup.xml
2018-09-25T18:34:19.689Z,1537900459.689 [Radio_Surface](INFO): Powering up
2018-09-25T18:34:19.700Z,1537900459.700 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2018-09-25T18:34:19.705Z,1537900459.705 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 7615
2018-09-25T18:34:19.709Z,1537900459.709 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2018-09-25T18:34:19.709Z,1537900459.709 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2018-09-25T18:34:19.709Z,1537900459.709 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2018-09-25T18:34:19.709Z,1537900459.709 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2018-09-25T18:34:19.710Z,1537900459.710 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2018-09-25T18:34:19.710Z,1537900459.710 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2018-09-25T18:34:19.710Z,1537900459.710 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000
2018-09-25T18:34:19.710Z,1537900459.710 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000
2018-09-25T18:34:19.711Z,1537900459.711 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2018-09-25T18:34:19.711Z,1537900459.711 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2018-09-25T18:34:19.711Z,1537900459.711 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000
2018-09-25T18:34:19.711Z,1537900459.711 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000
2018-09-25T18:34:19.711Z,1537900459.711 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000
2018-09-25T18:34:19.711Z,1537900459.711 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000
2018-09-25T18:34:19.712Z,1537900459.712 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000
2018-09-25T18:34:19.712Z,1537900459.712 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000
2018-09-25T18:34:19.760Z,1537900459.760 [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>


2018-09-25T18:34:19.761Z,1537900459.761 [MissionManager](INFO): Loading Mission: Missions/Default.xml
2018-09-25T18:34:19.858Z,1537900459.858 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2018-09-25T18:34:19.859Z,1537900459.859 [Default:A.Wait](DEBUG): Construct Wait.
2018-09-25T18:34:19.861Z,1537900459.861 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2018-09-25T18:34:19.880Z,1537900459.880 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2018-09-25T18:34:19.907Z,1537900459.907 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2018-09-25T18:34:19.930Z,1537900459.930 [Default:E.Execute](DEBUG): Construct Execute.
2018-09-25T18:34:19.934Z,1537900459.934 [MissionManager](DEBUG): 
<?xml version="1.0" encoding="UTF-8"?>
<Mission xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"
         xmlns="Tethys"
         xmlns:Units="Tethys/Units"
         xmlns:Guidance="Tethys/Guidance"
         xmlns:Universal="Tethys/Universal"
         xsi:schemaLocation="Tethys http://okeanids.mbari.org/tethys/Xml/Tethys.xsd
                             Tethys/Units http://okeanids.mbari.org/tethys/Xml/Units.xsd
                             Tethys/Guidance http://okeanids.mbari.org/tethys/Xml/Guidance.xsd
                             Tethys/Universal http://okeanids.mbari.org/tethys/Xml/Universal.xsd"
         Id="Default">

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

    <Guidance:Wait>
        <Description>
            Wait a moment to see if the scheduler starts a new mission before
            starting to actually run Default.
        </Description>
        <Sequence/>
        <Setting><Guidance:Wait.duration/><Units:second/><Value>13</Value></Setting>
    </Guidance:Wait>

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

    <Aggregate Id="CheckIn">

        <Sequence Repeat="288"/>

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

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

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

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

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

    </Aggregate>

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

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

</Mission>


2018-09-25T18:34:19.939Z,1537900459.939 [controlThread](DEBUG): Component order: CycleStarter,Aanderaa_O2,AHRS_M2,DataOverHttps,Depth_Keller,DropWeight,NAL9602,Onboard,RDI_Pathfinder,SCPI,BPC1,Depth_Keller,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,DeadReckonUsingSpeedCalculator,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter,
2018-09-25T18:34:20.015Z,1537900460.015 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2018-09-25T18:34:20.049Z,1537900460.049 [WetLabsSeaOWL_UV_A](INFO): Stopping
2018-09-25T18:34:20.083Z,1537900460.083 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2018-09-25T18:34:20.134Z,1537900460.134 [Depth_Keller](ERROR): Pressure reading out of range: 1913.424561 decibar
2018-09-25T18:34:20.300Z,1537900460.300 [DepthRateCalculator](ERROR): Depth measurement is not active
2018-09-25T18:34:20.381Z,1537900460.381 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2018-09-25T18:34:20.409Z,1537900460.409 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-09-25T18:34:20.517Z,1537900460.517 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2018-09-25T18:34:20.525Z,1537900460.525 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2018-09-25T18:34:20.549Z,1537900460.549 [ElevatorServo](DEBUG): Initializing EZServoServo.
2018-09-25T18:34:20.557Z,1537900460.557 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2018-09-25T18:34:20.571Z,1537900460.571 [MassServo](DEBUG): Initializing EZServoServo.
2018-09-25T18:34:20.577Z,1537900460.577 [MassServo](DEBUG): Initializing MassServo.
2018-09-25T18:34:20.591Z,1537900460.591 [RudderServo](DEBUG): Initializing EZServoServo.
2018-09-25T18:34:20.597Z,1537900460.597 [RudderServo](DEBUG): Initializing RudderServo.
2018-09-25T18:34:20.603Z,1537900460.603 [ThrusterServo](DEBUG): Initializing EZServoServo.
2018-09-25T18:34:20.609Z,1537900460.609 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2018-09-25T18:34:20.804Z,1537900460.804 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2018-09-25T18:34:20.805Z,1537900460.805 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-09-25T18:34:21.117Z,1537900461.117 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2018-09-25T18:34:21.118Z,1537900461.118 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-09-25T18:34:21.449Z,1537900461.449 [BuoyancyServo](ERROR): Buoyancy initialization uart error serial timeout
2018-09-25T18:34:21.449Z,1537900461.449 [BuoyancyServo](FAULT): Buoyancy failed to initialize
2018-09-25T18:34:21.449Z,1537900461.449 [BuoyancyServo] Communications Fault, FailCount= 1
2018-09-25T18:34:21.449Z,1537900461.449 [BuoyancyServo](ERROR): Communications Fault
2018-09-25T18:34:21.661Z,1537900461.661 [CBIT](ERROR): Communications Fault in component: BuoyancyServo
2018-09-25T18:34:21.700Z,1537900461.700 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2018-09-25T18:34:21.709Z,1537900461.709 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-09-25T18:34:21.723Z,1537900461.723 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2018-09-25T18:34:21.723Z,1537900461.723 [BuoyancyServo](INFO): Powering down
2018-09-25T18:34:22.100Z,1537900462.100 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2018-09-25T18:34:22.101Z,1537900462.101 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-09-25T18:34:22.504Z,1537900462.504 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2018-09-25T18:34:22.505Z,1537900462.505 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-09-25T18:34:22.896Z,1537900462.896 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2018-09-25T18:34:22.897Z,1537900462.897 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-09-25T18:34:23.389Z,1537900463.389 [Aanderaa_O2](INFO): Powering down
2018-09-25T18:34:23.512Z,1537900463.512 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2018-09-25T18:34:23.529Z,1537900463.529 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-09-25T18:34:23.733Z,1537900463.733 [AHRS_M2](ERROR): Read RFS packet UART error: serial timeout
2018-09-25T18:34:23.780Z,1537900463.780 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2018-09-25T18:34:23.790Z,1537900463.790 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-09-25T18:34:23.846Z,1537900463.846 [CBIT](INFO): Clearing failed state for component BuoyancyServo
2018-09-25T18:34:23.846Z,1537900463.846 [BuoyancyServo] No Fault, FailCount= 1
2018-09-25T18:34:24.131Z,1537900464.131 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2018-09-25T18:34:24.250Z,1537900464.250 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2018-09-25T18:34:33.540Z,1537900473.540 [RDI_Pathfinder](ERROR): Failed to parse:Pathfinder
2018-09-25T18:34:39.953Z,1537900479.953 [SBIT](IMPORTANT): Beginning Startup BIT
2018-09-25T18:34:39.977Z,1537900479.977 [CBIT](IMPORTANT): Beginning ground fault scan
2018-09-25T18:34:47.251Z,1537900487.251 [NAL9602](INFO): Powering up NAL9602
2018-09-25T18:34:50.987Z,1537900490.987 [CBIT](IMPORTANT): Ground fault detected
mA:
CHAN A0 (Batt): -0.009056
CHAN A1 (24V): -0.131424
CHAN A2 (12V): -0.007751
CHAN A3 (5V): -0.002109
CHAN B0 (3.3V): 0.000223
CHAN B1 (3.15aV): 0.000063
CHAN B2 (3.15bV): 0.000005
CHAN B3 (GND): 0.002066
OPEN: 0.005608
Full Scale Calc: 4.765 mA, -1.589 mA
2018-09-25T18:34:58.231Z,1537900498.231 [NAL9602](INFO): NAL9602 initialized
2018-09-25T18:35:34.051Z,1537900534.051 [SBIT](IMPORTANT): SBIT PASSED
2018-09-25T18:35:34.102Z,1537900534.102 [CommandLine](IMPORTANT): got command configSet list
2018-09-25T18:35:34.103Z,1537900534.103 [CommandLine](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2018-09-25T18:35:34.104Z,1537900534.104 [CommandLine](IMPORTANT): BPC1.batterySamplingInterval=1 hour;

2018-09-25T18:35:34.104Z,1537900534.104 [CommandLine](IMPORTANT): CTD_NeilBrown.loadAtStartup=1 bool;

2018-09-25T18:35:34.104Z,1537900534.104 [CommandLine](IMPORTANT): CTD_NeilBrown.simulateHardware=0 bool;

2018-09-25T18:35:34.104Z,1537900534.104 [CommandLine](IMPORTANT): CTD_Seabird.loadAtStartup=0 bool;

2018-09-25T18:35:34.104Z,1537900534.104 [CommandLine](IMPORTANT): CTD_Seabird.simulateHardware=1 bool;

2018-09-25T18:35:34.104Z,1537900534.104 [CommandLine](IMPORTANT): Express linearApproximation RDI_Pathfinder.height_above_sea_floor 5.000000 meter;

2018-09-25T18:35:34.104Z,1537900534.104 [CommandLine](IMPORTANT): Express linearApproximation WetLabsSeaOWL_UV_A.mass_concentration_of_chlorophyll_in_sea_water 0.500000 microgram_per_liter;

2018-09-25T18:35:34.105Z,1537900534.105 [CommandLine](IMPORTANT): Express linearApproximation height_above_sea_floor 5.000000 meter;

2018-09-25T18:35:34.106Z,1537900534.106 [CommandLine](IMPORTANT): IBIT.batteryVoltageThreshold=13.7 volt;

2018-09-25T18:35:34.106Z,1537900534.106 [CommandLine](IMPORTANT): RDI_PathfinderUp.loadAtStartup=0 bool;

2018-09-25T18:35:34.106Z,1537900534.106 [CommandLine](IMPORTANT): VerticalControl.buoyancyNeutral=205 cubic_centimeter;

2018-09-25T18:35:34.106Z,1537900534.106 [CommandLine](IMPORTANT): VerticalControl.massDefault=0 millimeter;

2018-09-25T18:35:34.458Z,1537900534.458 [MissionManager](IMPORTANT): Started mission Startup
2018-09-25T18:35:34.458Z,1537900534.458 [Startup] Running Loop=1
2018-09-25T18:35:34.458Z,1537900534.458 [Startup](DEBUG): Aggregate::initialize Startup
2018-09-25T18:35:34.458Z,1537900534.458 [Startup:A.GoToSurface] Running Loop=1
2018-09-25T18:35:34.458Z,1537900534.458 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2018-09-25T18:35:34.459Z,1537900534.459 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2018-09-25T18:35:34.459Z,1537900534.459 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2018-09-25T18:35:34.460Z,1537900534.460 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2018-09-25T18:35:34.460Z,1537900534.460 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2018-09-25T18:35:34.461Z,1537900534.461 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2018-09-25T18:35:34.467Z,1537900534.467 [Startup:StartupSatComms] Running Loop=1
2018-09-25T18:35:34.467Z,1537900534.467 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2018-09-25T18:35:34.467Z,1537900534.467 [Startup:StartupSatComms:A] Running Loop=1
2018-09-25T18:35:34.842Z,1537900534.842 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2018-09-25T18:36:00.464Z,1537900560.464 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2018-09-25T18:36:34.813Z,1537900594.813 [Startup:StartupSatComms:A](INFO): Timed out from 2018-09-25T18:35:34.5Z
2018-09-25T18:36:34.813Z,1537900594.813 [Startup:StartupSatComms:A] Stopped
2018-09-25T18:36:34.813Z,1537900594.813 [Startup:StartupSatComms:B] Running Loop=1
2018-09-25T18:36:35.229Z,1537900595.229 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2018-09-25T18:36:36.080Z,1537900596.080 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2018-09-25T18:36:54.486Z,1537900614.486 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2018-09-25T18:37:20.019Z,1537900640.019 [DeadReckonUsingMultipleVelocitySources](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2018-09-25T18:37:20.019Z,1537900640.019 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2018-09-25T18:37:20.019Z,1537900640.019 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2018-09-25T18:37:20.025Z,1537900640.025 [DeadReckonUsingSpeedCalculator](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2018-09-25T18:37:20.025Z,1537900640.025 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 1
2018-09-25T18:37:20.025Z,1537900640.025 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2018-09-25T18:37:20.063Z,1537900640.063 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2018-09-25T18:37:20.063Z,1537900640.063 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2018-09-25T18:37:20.439Z,1537900640.439 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2018-09-25T18:37:20.439Z,1537900640.439 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2018-09-25T18:37:20.439Z,1537900640.439 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2018-09-25T18:37:20.439Z,1537900640.439 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 1
2018-09-25T18:37:20.916Z,1537900640.916 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2018-09-25T18:37:20.917Z,1537900640.917 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2018-09-25T18:37:20.918Z,1537900640.918 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2018-09-25T18:37:20.918Z,1537900640.918 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2018-09-25T18:37:20.918Z,1537900640.918 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2018-09-25T18:37:20.919Z,1537900640.919 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2018-09-25T18:37:24.954Z,1537900644.954 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.010423
2018-09-25T18:37:29.975Z,1537900649.975 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2018-09-25T18:37:33.986Z,1537900653.986 [DataOverHttps](INFO): Sending 190 bytes from file Logs/20180925T182508/Courier0004.lzma
2018-09-25T18:37:34.767Z,1537900654.767 [DataOverHttps](INFO): Moved sent file to Logs/20180925T182508/Courier0004.lzma.bak
2018-09-25T18:37:34.767Z,1537900654.767 [DataOverHttps](INFO): SBD MOMSN=8586519
2018-09-25T18:37:35.023Z,1537900655.023 [Startup:StartupSatComms:B](INFO): Timed out from 2018-09-25T18:36:34.8Z
2018-09-25T18:37:35.023Z,1537900655.023 [Startup:StartupSatComms:B] Stopped
2018-09-25T18:37:35.024Z,1537900655.024 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2018-09-25T18:37:35.024Z,1537900655.024 [Startup:StartupSatComms] Stopped
2018-09-25T18:37:35.024Z,1537900655.024 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2018-09-25T18:37:35.025Z,1537900655.025 [Startup](INFO): Completed Startup
2018-09-25T18:37:35.025Z,1537900655.025 [MissionManager](INFO): Startup is completed.
2018-09-25T18:37:35.025Z,1537900655.025 [MissionManager](INFO): Uninitializing Mission Startup
2018-09-25T18:37:35.025Z,1537900655.025 [Startup] Stopped
2018-09-25T18:37:35.026Z,1537900655.026 [Startup](DEBUG): Aggregate::uninitialize Startup
2018-09-25T18:37:35.026Z,1537900655.026 [Startup:A.GoToSurface] Stopped
2018-09-25T18:37:35.026Z,1537900655.026 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2018-09-25T18:37:35.195Z,1537900655.195 [MissionManager](IMPORTANT): Started mission Default
2018-09-25T18:37:35.196Z,1537900655.196 [Default] Running Loop=1
2018-09-25T18:37:35.196Z,1537900655.196 [Default](DEBUG): Aggregate::initialize Default
2018-09-25T18:37:35.196Z,1537900655.196 [Default:B.GoToSurface] Running Loop=1
2018-09-25T18:37:35.196Z,1537900655.196 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2018-09-25T18:37:35.196Z,1537900655.196 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2018-09-25T18:37:35.197Z,1537900655.197 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2018-09-25T18:37:35.197Z,1537900655.197 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2018-09-25T18:37:35.198Z,1537900655.198 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2018-09-25T18:37:35.198Z,1537900655.198 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2018-09-25T18:37:35.199Z,1537900655.199 [Default:A.Wait] Running Loop=1
2018-09-25T18:37:35.200Z,1537900655.200 [Default:A.Wait](DEBUG): Initialize Wait Component.
2018-09-25T18:37:48.585Z,1537900668.585 [Default:A.Wait](INFO): Done Waiting.
2018-09-25T18:37:48.585Z,1537900668.585 [Default:A.Wait] Stopped
2018-09-25T18:37:48.585Z,1537900668.585 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2018-09-25T18:37:48.985Z,1537900668.985 [Default:CheckIn] Running Loop=1
2018-09-25T18:37:48.985Z,1537900668.985 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2018-09-25T18:37:48.986Z,1537900668.986 [Default:CheckIn:Read_GPS] Running Loop=1
2018-09-25T18:37:49.414Z,1537900669.414 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2018-09-25T18:38:50.895Z,1537900730.895 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2018-09-25T18:39:12.323Z,1537900752.323 [CommandLine](IMPORTANT): got command run ./Missions/Insert/Science.xml
2018-09-25T18:39:12.323Z,1537900752.323 [MissionManager](INFO): Loading Mission: ./Missions/Insert/Science.xml
2018-09-25T18:39:12.588Z,1537900752.588 [MissionManager](INFO): DefineArg Science.SampleISUS = 0 bool
2018-09-25T18:39:12.592Z,1537900752.592 [MissionManager](INFO): DefineArg Science.SampleISUSmaxPitch = 60.000000 arcdeg
2018-09-25T18:39:12.595Z,1537900752.595 [MissionManager](INFO): DefineArg Science.SampleISUSminPitch = -60.000000 arcdeg
2018-09-25T18:39:12.598Z,1537900752.598 [MissionManager](INFO): DefineArg Science.PeakDetectChlActive = 0 bool
2018-09-25T18:39:12.602Z,1537900752.602 [MissionManager](INFO): DefineArg Science.TimeWindowPeakReport = nan min
2018-09-25T18:39:12.605Z,1537900752.605 [MissionManager](INFO): DefineArg Science.HighestChlPeakReportActive = 0 bool
2018-09-25T18:39:12.608Z,1537900752.608 [MissionManager](INFO): DefineArg Science.PatchTracking = 0 bool
2018-09-25T18:39:12.611Z,1537900752.611 [MissionManager](INFO): DefineArg Science.FilterWidthHorizontal = 3.000000 count
2018-09-25T18:39:12.631Z,1537900752.631 [MissionManager](INFO): DefineArg Science.NumProfilesSlidingwindow = 100.000000 count
2018-09-25T18:39:12.636Z,1537900752.636 [MissionManager](INFO): DefineArg Science.OffPeakFractionHorizontal = 80.000000 %
2018-09-25T18:39:12.639Z,1537900752.639 [MissionManager](INFO): DefineArg Science.PeakDetectNO3Active = 0 bool
2018-09-25T18:39:12.642Z,1537900752.642 [MissionManager](INFO): DefineArg Science.PeakDetectOilActive = 0 bool
2018-09-25T18:39:12.670Z,1537900752.670 [MissionManager](INFO): DefineArg Science.UpwardDerivativeOfTemperatureActive = 0 bool
2018-09-25T18:39:12.709Z,1537900752.709 [MissionManager](INFO): DefineArg Science.EnabledAanderaaO2 = 1.000000 bool
2018-09-25T18:39:12.713Z,1537900752.713 [MissionManager](INFO): DefineArg Science.EnabledNeilBrown = 1.000000 bool
2018-09-25T18:39:12.717Z,1537900752.717 [MissionManager](INFO): DefineArg Science.EnabledSeabird = 0.000000 bool
2018-09-25T18:39:12.720Z,1537900752.720 [MissionManager](INFO): DefineArg Science.EnabledTurbulence_NPS = 0.000000 bool
2018-09-25T18:39:12.741Z,1537900752.741 [MissionManager](INFO): DefineArg Science.EnabledWetLabsBB2FL = 0.000000 bool
2018-09-25T18:39:12.749Z,1537900752.749 [MissionManager](INFO): DefineArg Science.EnabledWetLabsSeaOWL_UV_A = 1.000000 bool
2018-09-25T18:39:12.757Z,1537900752.757 [MissionManager](INFO): DefineArg Science.EnabledISUS = 0.000000 bool
2018-09-25T18:39:12.769Z,1537900752.769 [MissionManager](INFO): DefineArg Science.LowPassWindowLength = 20.000000 count
2018-09-25T18:39:12.772Z,1537900752.772 [MissionManager](INFO): DefineArg Science.PeakChlShallowBound = nan m
2018-09-25T18:39:12.796Z,1537900752.796 [MissionManager](INFO): DefineArg Science.PeakChlDeepBound = nan m
2018-09-25T18:39:12.826Z,1537900752.826 [MissionManager](INFO): DefineOutput Science.PeakChl = 0.000000 ug/l
2018-09-25T18:39:12.846Z,1537900752.846 [MissionManager](INFO): DefineOutput Science.PeakChlDepth = 0.000000 m
2018-09-25T18:39:12.858Z,1537900752.858 [MissionManager](INFO): DefineOutput Science.PeakChlTemperature = 0.000000 degC
2018-09-25T18:39:12.870Z,1537900752.870 [MissionManager](INFO): DefineOutput Science.PeakChlLatitude = nan arcdeg
2018-09-25T18:39:12.895Z,1537900752.895 [MissionManager](INFO): DefineOutput Science.PeakChlLongitude = nan arcdeg
2018-09-25T18:39:12.903Z,1537900752.903 [MissionManager](INFO): DefineOutput Science.PeakNO3 = 0.000000 umol/l
2018-09-25T18:39:12.911Z,1537900752.911 [MissionManager](INFO): DefineOutput Science.PeakNO3Depth = 0.000000 m
2018-09-25T18:39:12.923Z,1537900752.923 [MissionManager](INFO): DefineOutput Science.PeakNO3Latitude = nan arcdeg
2018-09-25T18:39:12.932Z,1537900752.932 [MissionManager](INFO): DefineOutput Science.PeakNO3Longitude = nan arcdeg
2018-09-25T18:39:12.944Z,1537900752.944 [MissionManager](INFO): DefineOutput Science.PatchChl = 0.000000 m
2018-09-25T18:39:12.956Z,1537900752.956 [MissionManager](INFO): DefineOutput Science.PatchChlDepth = 0.000000 m
2018-09-25T18:39:12.964Z,1537900752.964 [MissionManager](INFO): DefineOutput Science.PatchChlLatitude = nan arcdeg
2018-09-25T18:39:12.968Z,1537900752.968 [MissionManager](INFO): DefineOutput Science.PatchChlLongitude = nan arcdeg
2018-09-25T18:39:12.983Z,1537900752.983 [MissionManager](INFO): DefineOutput Science.PatchChlDistance = nan m
2018-09-25T18:39:12.988Z,1537900752.988 [MissionManager](INFO): DefineOutput Science.PeakOil = 0.000000 kg/m3
2018-09-25T18:39:13.007Z,1537900753.007 [MissionManager](INFO): DefineOutput Science.PeakOilDepth = 0.000000 m
2018-09-25T18:39:13.019Z,1537900753.019 [MissionManager](INFO): DefineOutput Science.PeakOilLatitude = nan arcdeg
2018-09-25T18:39:13.027Z,1537900753.027 [MissionManager](INFO): DefineOutput Science.PeakOilLongitude = nan arcdeg
2018-09-25T18:39:13.064Z,1537900753.064 [Science:PeakDetectChl:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2018-09-25T18:39:13.111Z,1537900753.111 [Science:HighestChlPeakReport:A.PeakDetectHorizontal](DEBUG): Construct PeakDetectHorizontal.
2018-09-25T18:39:13.145Z,1537900753.145 [Science:PeakDetectNO3:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2018-09-25T18:39:13.167Z,1537900753.167 [Science:PeakDetectOil:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2018-09-25T18:39:13.285Z,1537900753.285 [MissionManager](DEBUG): 
<?xml version="1.0" encoding="UTF-8"?>
<!-- ====================
     Generated by TethysL
     ==================== -->
<Aggregate xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"
           xmlns="Tethys"
           xmlns:Units="Tethys/Units"
           xmlns:Science="Tethys/Science"
           xmlns:Universal="Tethys/Universal"
           xmlns:Trigger="Tethys/Trigger"
           xsi:schemaLocation="Tethys http://okeanids.mbari.org/tethys/Xml/Tethys.xsd
                               Tethys/Units http://okeanids.mbari.org/tethys/Xml/Units.xsd
                               Tethys/Science http://okeanids.mbari.org/tethys/Xml/Science.xsd
                               Tethys/Universal http://okeanids.mbari.org/tethys/Xml/Universal.xsd
                               Tethys/Trigger http://okeanids.mbari.org/tethys/Xml/Trigger.xsd"
       Id="Science">

    <DefineArg Name="SampleISUS"><Description>
        Set either this or PeakDetectNO3Active to True in order to sample
        Nitrate. EnabledISUS must also be true.
    </Description><False/></DefineArg>

    <DefineArg Name="SampleISUSmaxPitch"><Description>
        Maximum pitch to sample ISUS. (EnabledISUS must also be true.)
    </Description><Units:degree/><Value>60.0</Value></DefineArg>

    <DefineArg Name="SampleISUSminPitch"><Description>
        Minimum pitch to sample ISUS. (EnabledISUS must also be true.)
    </Description><Units:degree/><Value>-60.0</Value></DefineArg>

    <DefineArg Name="PeakDetectChlActive"><Description>
        Turns on peak detection of Cholorphyll.
    </Description><False/></DefineArg>

    <DefineArg Name="TimeWindowPeakReport"><Description>
        If greater than zero, report a peak every window. If NaN or zero, this
        variable is ignored.
    </Description><Units:minute/><Value>NaN</Value></DefineArg>

    <DefineArg Name="HighestChlPeakReportActive"><Description>
        Turns on reporting of the highest peak value on yo-yo profiles in a
        horizontal sliding window (of length numProfilesSlidingwindow)
    </Description><False/></DefineArg>

    <DefineArg Name="PatchTracking"><Description>
        If tracking a patch
    </Description><False/></DefineArg>

<!--debug
    </Description><True/></DefineArg>
-->

    <DefineArg Name="FilterWidthHorizontal"><Description>
        Width of boxcar filter applied to yoyo-wise chl peaks to pick out the
        highest peak.
    </Description><Units:count/><Value>3</Value></DefineArg>

    <DefineArg Name="NumProfilesSlidingwindow"><Description>
        Length of horizontal sliding window. The highest yoyo-wise chl peak
        (after low-pass filtering by a filter of length FilterWidthHorizontal)
        within this window.
    </Description><Units:count/><Value>100</Value></DefineArg>

    <DefineArg Name="OffPeakFractionHorizontal"><Description>
        When filtered horizontal value is this fraction of the peak, consider it
        outside the patch.
    </Description><Units:percent/><Value>80</Value></DefineArg>

    <DefineArg Name="PeakDetectNO3Active"><Description>
        Turns on peak detection of Nitrate (and turns on ISUS).
    </Description><False/></DefineArg>

    <DefineArg Name="PeakDetectOilActive"><Description>
        Turns on peak detection of Dissolved Oil.
    </Description><False/></DefineArg>

    <DefineArg Name="UpwardDerivativeOfTemperatureActive"><Description>
        Turns on seawater temperature derivative.
    </Description><False/></DefineArg>

    <DefineArg Name="EnabledAanderaaO2"><Description>
        Automatically set to True if the Aanderaa O2 sensor is installed. Set to
        false to disable reading Aandera O2.
    </Description><Science:Aanderaa_O2.loadAtStartup/></DefineArg>

    <DefineArg Name="EnabledNeilBrown"><Description>
        Automatically set to true if the Neil Brown CTD is enabled. Set to false
        to disable reading from the Neil Brown.
    </Description><Science:CTD_NeilBrown.loadAtStartup/></DefineArg>

    <DefineArg Name="EnabledSeabird"><Description>
        Automatically set to true if the CTD is enabled. Set to false to disable
        reading from the CTD.
    </Description><Science:CTD_Seabird.loadAtStartup/></DefineArg>

    <DefineArg Name="EnabledTurbulence_NPS"><Description>
        Automatically set to true if the NPS Turbulence sensor is enabled. Set
        to false to disable reading from the NPS Turbulence sensor.
    </Description><Science:Turbulence_NPS.loadAtStartup/></DefineArg>

    <DefineArg Name="EnabledWetLabsBB2FL"><Description>
        Automatically set to true if the the WetLabs BB2FL is enabled. Set to
        false to disable the WetLabs BB2FL.
    </Description><Science:WetLabsBB2FL.loadAtStartup/></DefineArg>

    <DefineArg Name="EnabledWetLabsSeaOWL_UV_A"><Description>
        Automatically set to true if the the WetLabs SeaOWL UV-A is enabled. Set
        to false to disable the WetLabs SeaOWL UV-A.
    </Description><Science:WetLabsSeaOWL_UV_A.loadAtStartup/></DefineArg>

    <DefineArg Name="EnabledISUS"><Description>
        Automatically set to True if ISUS is enabled. Set to false to disable
        ISUS.
    </Description><Science:ISUS.loadAtStartup/></DefineArg>

    <DefineArg Name="LowPassWindowLength"><Description>
        Low-pass window length (based on depth sensor sampling interval 0.4
        second) for low-pass filtering.
    </Description><Units:count/><Value>20</Value></DefineArg>

    <DefineArg Name="PeakChlShallowBound"><Description>
        Shallow depth bound for detecting chl peak on each descent or ascent
        profile.
    </Description><Units:meter/><Value>NaN</Value></DefineArg>

<!--debug
    </Description><Units:meter/><Value>10</Value></DefineArg>
-->

    <DefineArg Name="PeakChlDeepBound"><Description>
        Deep depth bound for detecting chl peak on each descent or ascent
        profile.
    </Description><Units:meter/><Value>NaN</Value></DefineArg>

<!--debug
    </Description><Units:meter/><Value>20</Value></DefineArg>
-->

    <DefineOutput Name="PeakChl"><Units:microgram_per_liter/><Value>0</Value></DefineOutput>

    <DefineOutput Name="PeakChlDepth"><Units:meter/><Value>0</Value></DefineOutput>

    <DefineOutput Name="PeakChlTemperature"><Units:celsius/><Value>0</Value></DefineOutput>

    <DefineOutput Name="PeakChlLatitude"><Units:degree/><Value>NaN</Value></DefineOutput>

    <DefineOutput Name="PeakChlLongitude"><Units:degree/><Value>NaN</Value></DefineOutput>

    <DefineOutput Name="PeakNO3"><Units:micromole_per_liter/><Value>0</Value></DefineOutput>

    <DefineOutput Name="PeakNO3Depth"><Units:meter/><Value>0</Value></DefineOutput>

    <DefineOutput Name="PeakNO3Latitude"><Units:degree/><Value>NaN</Value></DefineOutput>

    <DefineOutput Name="PeakNO3Longitude"><Units:degree/><Value>NaN</Value></DefineOutput>

    <DefineOutput Name="PatchChl"><Units:meter/><Value>0</Value></DefineOutput>

    <DefineOutput Name="PatchChlDepth"><Units:meter/><Value>0</Value></DefineOutput>

    <DefineOutput Name="PatchChlLatitude"><Units:degree/><Value>NaN</Value></DefineOutput>

    <DefineOutput Name="PatchChlLongitude"><Units:degree/><Value>NaN</Value></DefineOutput>

    <DefineOutput Name="PatchChlDistance"><Units:meter/><Value>NaN</Value></DefineOutput>

    <DefineOutput Name="PeakOil"><Units:kilogram_per_cubic_meter/><Value>0</Value></DefineOutput>

    <DefineOutput Name="PeakOilDepth"><Units:meter/><Value>0</Value></DefineOutput>

    <DefineOutput Name="PeakOilLatitude"><Units:degree/><Value>NaN</Value></DefineOutput>

    <DefineOutput Name="PeakOilLongitude"><Units:degree/><Value>NaN</Value></DefineOutput>

    <Parallel/>

    <ReadData Strategy="MinError">
        <While>
            <Arg Name="EnabledAanderaaO2"/>
        </While>
        <Universal:mass_concentration_of_oxygen_in_sea_water/>
    </ReadData>

    <ReadData>
        <While>
            <Arg Name="EnabledISUS"/>
            <And><Universal:platform_pitch_angle/><Lt><Arg Name="SampleISUSmaxPitch"/></Lt><And><Universal:platform_pitch_angle/><Gt><Arg Name="SampleISUSminPitch"/></Gt><And><Arg Name="SampleISUS"/><Or><Arg Name="PeakDetectNO3Active"/></Or></And></And></And>
        </While>
        <Universal:mole_concentration_of_nitrate_in_sea_water/>
    </ReadData>

    <ReadData Strategy="MinError">
        <While>
            <Arg Name="EnabledNeilBrown"/>
            <Or><Arg Name="EnabledSeabird"/></Or>
        </While>
        <Universal:sea_water_temperature/>
        <Universal:sea_water_salinity/>
    </ReadData>

    <ReadData Strategy="MinError">
        <While>
            <Arg Name="EnabledSeabird"/>
        </While>
        <Science:CTD_Seabird.sea_water_temperature/>
        <Science:CTD_Seabird.sea_water_salinity/>
    </ReadData>

    <ReadData Strategy="MinError">
        <While>
            <Arg Name="EnabledNeilBrown"/>
            <Or><Arg Name="EnabledSeabird"/></Or>
            <And><Arg Name="UpwardDerivativeOfTemperatureActive"/></And>
        </While>
        <Universal:upward_derivative_of_sea_water_temperature/>
    </ReadData>

    <ReadData Strategy="MinError">
        <While>
            <Arg Name="EnabledTurbulence_NPS"/>
        </While>
        <Science:Turbulence_NPS.MicroCond/>
    </ReadData>

    <ReadData Strategy="MinError">
        <While>
            <Arg Name="EnabledWetLabsBB2FL"/>
            <Or><Arg Name="PeakDetectChlActive"/></Or>
        </While>
        <Universal:mass_concentration_of_chlorophyll_in_sea_water/>
    </ReadData>

<!--debug-->

    <ReadData Id="Read_Oil" Strategy="MinError">
        <While>
            <Arg Name="EnabledWetLabsSeaOWL_UV_A"/>
            <Or><Arg Name="PeakDetectOilActive"/></Or>
        </While>
        <Universal:mass_concentration_of_chlorophyll_in_sea_water/>
    </ReadData>

    <Aggregate Id="PeakDetectChl">

        <While>
            <Arg Name="PeakDetectChlActive"/>
        </While>

        <Trigger:PeakDetectVsDepth>
            <Sequence/>
            <Setting><Trigger:PeakDetectVsDepth.detect/><Universal:mass_concentration_of_chlorophyll_in_sea_water/></Setting>
            <Setting><Trigger:PeakDetectVsDepth.timeWindowPeakReport/><Arg Name="TimeWindowPeakReport"/></Setting>
            <Setting><Trigger:PeakDetectVsDepth.windowLength/><Arg Name="LowPassWindowLength"/></Setting>
            <Setting><Trigger:PeakDetectVsDepth.shallowBound/><Arg Name="PeakChlShallowBound"/></Setting>
            <Setting><Trigger:PeakDetectVsDepth.deepBound/><Arg Name="PeakChlDeepBound"/></Setting>
            <OutputArg Name="PeakChl"><Trigger:PeakDetectVsDepth.peakDetect/></OutputArg>
            <OutputArg Name="PeakChlDepth"><Trigger:PeakDetectVsDepth.peakDepth/></OutputArg>
            <OutputArg Name="PeakChlTemperature"><Trigger:PeakDetectVsDepth.peakTemperature/></OutputArg>
            <OutputArg Name="PeakChlLatitude"><Trigger:PeakDetectVsDepth.peakLatitude/></OutputArg>
            <OutputArg Name="PeakChlLongitude"><Trigger:PeakDetectVsDepth.peakLongitude/></OutputArg>
        </Trigger:PeakDetectVsDepth>

<!--debug
        <Syslog Severity="Important">PeakChl, PeakChlLatitude, PeakChlLongitude = <Arg Name="PeakChl"/><Units:microgram_per_liter/>, <Arg Name="PeakChlLatitude"/><Units:degree/>, <Arg Name="PeakChlLongitude"/><Units:degree/></Syslog>
-->

        <SendData Service="Express"><Arg Name="PeakChl"/><Arg Name="PeakChlDepth"/>
        </SendData>

    </Aggregate>

    <Aggregate Id="HighestChlPeakReport">

        <While>
            <Arg Name="HighestChlPeakReportActive"/>
        </While>

        <Trigger:PeakDetectHorizontal>
            <Sequence/>
            <Setting><Trigger:PeakDetectHorizontal.detectFrom/><Arg Name="PeakChl"/></Setting>
            <Setting><Trigger:PeakDetectHorizontal.depthFrom/><Arg Name="PeakChlDepth"/></Setting>
            <Setting><Trigger:PeakDetectHorizontal.latitudeFrom/><Arg Name="PeakChlLatitude"/></Setting>
            <Setting><Trigger:PeakDetectHorizontal.longitudeFrom/><Arg Name="PeakChlLongitude"/></Setting>
            <Setting><Trigger:PeakDetectHorizontal.patchTracking/><Arg Name="PatchTracking"/></Setting>
            <Setting><Trigger:PeakDetectHorizontal.filterWidth/><Arg Name="FilterWidthHorizontal"/></Setting>
            <Setting><Trigger:PeakDetectHorizontal.numProfilesSlidingwindow/><Arg Name="NumProfilesSlidingwindow"/></Setting>
            <Setting><Trigger:PeakDetectHorizontal.offPeakFraction/><Arg Name="OffPeakFractionHorizontal"/></Setting>
            <OutputArg Name="PatchChl"><Trigger:PeakDetectHorizontal.peakDetect/></OutputArg>
            <OutputArg Name="PatchChlDepth"><Trigger:PeakDetectHorizontal.peakDepth/></OutputArg>
            <OutputArg Name="PatchChlLatitude"><Trigger:PeakDetectHorizontal.peakLatitude/></OutputArg>
            <OutputArg Name="PatchChlLongitude"><Trigger:PeakDetectHorizontal.peakLongitude/></OutputArg>
            <OutputArg Name="PatchChlDistance"><Trigger:PeakDetectHorizontal.peakDistance/></OutputArg>
        </Trigger:PeakDetectHorizontal>

    </Aggregate>

    <Aggregate Id="PeakDetectNO3">

        <While>
            <Arg Name="PeakDetectNO3Active"/>
        </While>

        <Trigger:PeakDetectVsDepth>
            <Sequence/>
            <Setting><Trigger:PeakDetectVsDepth.detect/><Universal:mole_concentration_of_nitrate_in_sea_water/></Setting>
            <Setting><Trigger:PeakDetectVsDepth.timeWindowPeakReport/><Arg Name="TimeWindowPeakReport"/></Setting>
            <Setting><Trigger:PeakDetectVsDepth.windowLength/><Arg Name="LowPassWindowLength"/></Setting>
            <Setting><Trigger:PeakDetectVsDepth.shallowBound/><Arg Name="PeakChlShallowBound"/></Setting>
            <Setting><Trigger:PeakDetectVsDepth.deepBound/><Arg Name="PeakChlDeepBound"/></Setting>
            <OutputArg Name="PeakNO3"><Trigger:PeakDetectVsDepth.peakDetect/></OutputArg>
            <OutputArg Name="PeakNO3Depth"><Trigger:PeakDetectVsDepth.peakDepth/></OutputArg>
            <OutputArg Name="PeakNO3Latitude"><Trigger:PeakDetectVsDepth.peakLatitude/></OutputArg>
            <OutputArg Name="PeakNO3Longitude"><Trigger:PeakDetectVsDepth.peakLongitude/></OutputArg>
        </Trigger:PeakDetectVsDepth>

        <SendData Service="Express"><Arg Name="PeakNO3"/><Arg Name="PeakNO3Depth"/>
        </SendData>

    </Aggregate>

    <Aggregate Id="PeakDetectOil">

        <While>
            <Arg Name="PeakDetectOilActive"/>
        </While>

        <Trigger:PeakDetectVsDepth>
            <Sequence/>
            <Setting><Trigger:PeakDetectVsDepth.detect/><Universal:mass_concentration_of_petroleum_hydrocarbons_in_sea_water/></Setting>
            <Setting><Trigger:PeakDetectVsDepth.timeWindowPeakReport/><Arg Name="TimeWindowPeakReport"/></Setting>
            <Setting><Trigger:PeakDetectVsDepth.windowLength/><Arg Name="LowPassWindowLength"/></Setting>
            <Setting><Trigger:PeakDetectVsDepth.shallowBound/><Arg Name="PeakChlShallowBound"/></Setting>
            <Setting><Trigger:PeakDetectVsDepth.deepBound/><Arg Name="PeakChlDeepBound"/></Setting>
            <OutputArg Name="PeakOil"><Trigger:PeakDetectVsDepth.peakDetect/></OutputArg>
            <OutputArg Name="PeakOilDepth"><Trigger:PeakDetectVsDepth.peakDepth/></OutputArg>
            <OutputArg Name="PeakOilLatitude"><Trigger:PeakDetectVsDepth.peakLatitude/></OutputArg>
            <OutputArg Name="PeakOilLongitude"><Trigger:PeakDetectVsDepth.peakLongitude/></OutputArg>
        </Trigger:PeakDetectVsDepth>

        <SendData Service="Express"><Arg Name="PeakOil"/><Arg Name="PeakOilDepth"/>
        </SendData>

    </Aggregate>

</Aggregate>


2018-09-25T18:39:13.288Z,1537900753.288 [CommandLine](IMPORTANT): Running ./Missions/Insert/Science.xml
2018-09-25T18:39:13.653Z,1537900753.653 [Default] Stopped
2018-09-25T18:39:13.654Z,1537900753.654 [Default](DEBUG): Aggregate::uninitialize Default
2018-09-25T18:39:13.654Z,1537900753.654 [Default:B.GoToSurface] Stopped
2018-09-25T18:39:13.654Z,1537900753.654 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2018-09-25T18:39:13.654Z,1537900753.654 [Default:CheckIn] Stopped
2018-09-25T18:39:13.654Z,1537900753.654 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2018-09-25T18:39:13.654Z,1537900753.654 [Default:CheckIn:Read_GPS] Stopped
2018-09-25T18:39:13.654Z,1537900753.654 [MissionManager](IMPORTANT): Started mission Science
2018-09-25T18:39:13.655Z,1537900753.655 [Science] Running Loop=1
2018-09-25T18:39:13.655Z,1537900753.655 [Science](DEBUG): Aggregate::initialize Science
2018-09-25T18:39:13.655Z,1537900753.655 [Science:A] Running Loop=1
2018-09-25T18:39:13.655Z,1537900753.655 [Science:B] Running Loop=1
2018-09-25T18:39:13.655Z,1537900753.655 [Science:C] Running Loop=1
2018-09-25T18:39:13.655Z,1537900753.655 [Science:D] Running Loop=1
2018-09-25T18:39:13.655Z,1537900753.655 [Science:E] Running Loop=1
2018-09-25T18:39:13.655Z,1537900753.655 [Science:F] Running Loop=1
2018-09-25T18:39:13.655Z,1537900753.655 [Science:G] Running Loop=1
2018-09-25T18:39:13.655Z,1537900753.655 [Science:Read_Oil] Running Loop=1
2018-09-25T18:39:13.655Z,1537900753.655 [Science:PeakDetectChl] Running Loop=1
2018-09-25T18:39:13.656Z,1537900753.656 [Science:PeakDetectChl](DEBUG): Aggregate::initialize Science:PeakDetectChl
2018-09-25T18:39:13.656Z,1537900753.656 [Science:PeakDetectChl:A.PeakDetectVsDepth] Running Loop=1
2018-09-25T18:39:13.656Z,1537900753.656 [Science:PeakDetectChl:A.PeakDetectVsDepth](DEBUG): Initialize.
2018-09-25T18:39:13.658Z,1537900753.658 [Science:HighestChlPeakReport] Running Loop=1
2018-09-25T18:39:13.658Z,1537900753.658 [Science:HighestChlPeakReport](DEBUG): Aggregate::initialize Science:HighestChlPeakReport
2018-09-25T18:39:13.658Z,1537900753.658 [Science:HighestChlPeakReport:A.PeakDetectHorizontal] Running Loop=1
2018-09-25T18:39:13.658Z,1537900753.658 [Science:HighestChlPeakReport:A.PeakDetectHorizontal](INFO): Initialize.
2018-09-25T18:39:13.658Z,1537900753.658 [Science:PeakDetectNO3] Running Loop=1
2018-09-25T18:39:13.659Z,1537900753.659 [Science:PeakDetectNO3](DEBUG): Aggregate::initialize Science:PeakDetectNO3
2018-09-25T18:39:13.659Z,1537900753.659 [Science:PeakDetectNO3:A.PeakDetectVsDepth] Running Loop=1
2018-09-25T18:39:13.659Z,1537900753.659 [Science:PeakDetectNO3:A.PeakDetectVsDepth](DEBUG): Initialize.
2018-09-25T18:39:13.661Z,1537900753.661 [Science:PeakDetectOil] Running Loop=1
2018-09-25T18:39:13.661Z,1537900753.661 [Science:PeakDetectOil](DEBUG): Aggregate::initialize Science:PeakDetectOil
2018-09-25T18:39:13.661Z,1537900753.661 [Science:PeakDetectOil:A.PeakDetectVsDepth] Running Loop=1
2018-09-25T18:39:13.661Z,1537900753.661 [Science:PeakDetectOil:A.PeakDetectVsDepth](DEBUG): Initialize.
2018-09-25T18:39:13.663Z,1537900753.663 [Science:PeakDetectOil] Stopped
2018-09-25T18:39:13.663Z,1537900753.663 [Science:PeakDetectOil](DEBUG): Aggregate::uninitialize Science:PeakDetectOil
2018-09-25T18:39:13.663Z,1537900753.663 [Science:PeakDetectOil:A.PeakDetectVsDepth] Stopped
2018-09-25T18:39:13.663Z,1537900753.663 [Science:PeakDetectOil:A.PeakDetectVsDepth](DEBUG): Uninitialize.
2018-09-25T18:39:13.664Z,1537900753.664 [Science:PeakDetectNO3] Stopped
2018-09-25T18:39:13.664Z,1537900753.664 [Science:PeakDetectNO3](DEBUG): Aggregate::uninitialize Science:PeakDetectNO3
2018-09-25T18:39:13.664Z,1537900753.664 [Science:PeakDetectNO3:A.PeakDetectVsDepth] Stopped
2018-09-25T18:39:13.664Z,1537900753.664 [Science:PeakDetectNO3:A.PeakDetectVsDepth](DEBUG): Uninitialize.
2018-09-25T18:39:13.664Z,1537900753.664 [Science:HighestChlPeakReport] Stopped
2018-09-25T18:39:13.664Z,1537900753.664 [Science:HighestChlPeakReport](DEBUG): Aggregate::uninitialize Science:HighestChlPeakReport
2018-09-25T18:39:13.664Z,1537900753.664 [Science:HighestChlPeakReport:A.PeakDetectHorizontal] Stopped
2018-09-25T18:39:13.664Z,1537900753.664 [Science:HighestChlPeakReport:A.PeakDetectHorizontal](DEBUG): Uninitialize.
2018-09-25T18:39:13.664Z,1537900753.664 [Science:PeakDetectChl] Stopped
2018-09-25T18:39:13.664Z,1537900753.664 [Science:PeakDetectChl](DEBUG): Aggregate::uninitialize Science:PeakDetectChl
2018-09-25T18:39:13.678Z,1537900753.678 [Science:PeakDetectChl:A.PeakDetectVsDepth] Stopped
2018-09-25T18:39:13.678Z,1537900753.678 [Science:PeakDetectChl:A.PeakDetectVsDepth](DEBUG): Uninitialize.
2018-09-25T18:39:13.678Z,1537900753.678 [Science:Read_Oil] Running Loop=1
2018-09-25T18:39:13.679Z,1537900753.679 [Science:Read_Oil](DEBUG): Initialize ReadDataComponent to sense mass_concentration_of_chlorophyll_in_sea_water
2018-09-25T18:39:13.681Z,1537900753.681 [Science:G] Stopped
2018-09-25T18:39:13.681Z,1537900753.681 [Science:F] Stopped
2018-09-25T18:39:13.681Z,1537900753.681 [Science:E] Stopped
2018-09-25T18:39:13.681Z,1537900753.681 [Science:D] Stopped
2018-09-25T18:39:13.681Z,1537900753.681 [Science:C] Running Loop=1
2018-09-25T18:39:13.682Z,1537900753.682 [Science:C](DEBUG): Initialize ReadDataComponent to sense sea_water_temperature
2018-09-25T18:39:13.682Z,1537900753.682 [Science:C](DEBUG): Initialize ReadDataComponent to sense sea_water_salinity
2018-09-25T18:39:13.684Z,1537900753.684 [Science:B] Stopped
2018-09-25T18:39:13.684Z,1537900753.684 [Science:A] Running Loop=1
2018-09-25T18:39:13.685Z,1537900753.685 [Science:A](DEBUG): Initialize ReadDataComponent to sense mass_concentration_of_oxygen_in_sea_water
2018-09-25T18:39:13.877Z,1537900753.877 [WetLabsSeaOWL_UV_A](INFO): Start
2018-09-25T18:39:13.885Z,1537900753.885 [WetLabsSeaOWL_UV_A](INFO): Opening uart, block timeout 10ths=4
2018-09-25T18:39:13.885Z,1537900753.885 [WetLabsSeaOWL_UV_A](INFO): Powering up
2018-09-25T18:39:13.886Z,1537900753.886 [WetLabsSeaOWL_UV_A](INFO): Starting
2018-09-25T18:39:13.889Z,1537900753.889 [CTD_NeilBrown](DEBUG): Initializing CTD_NeilBrown.
2018-09-25T18:39:13.897Z,1537900753.897 [CTD_NeilBrown](INFO): Opening uart, block timeout 10ths=4
2018-09-25T18:39:13.965Z,1537900753.965 [CTD_NeilBrown](DEBUG): serial timeout
2018-09-25T18:39:14.298Z,1537900754.298 [WetLabsSeaOWL_UV_A](INFO): In starting, uart error:serial timeout
2018-09-25T18:39:14.299Z,1537900754.299 [WetLabsSeaOWL_UV_A](INFO): Starting
2018-09-25T18:39:14.370Z,1537900754.370 [CTD_NeilBrown](DEBUG): serial timeout
2018-09-25T18:39:14.705Z,1537900754.705 [WetLabsSeaOWL_UV_A](INFO): In starting, uart error:serial timeout
2018-09-25T18:39:14.706Z,1537900754.706 [WetLabsSeaOWL_UV_A](INFO): Starting
2018-09-25T18:39:14.797Z,1537900754.797 [CTD_NeilBrown](DEBUG): serial timeout
2018-09-25T18:39:15.113Z,1537900755.113 [WetLabsSeaOWL_UV_A](INFO): In starting, uart error:serial timeout
2018-09-25T18:39:15.113Z,1537900755.113 [WetLabsSeaOWL_UV_A](INFO): Starting
2018-09-25T18:39:15.209Z,1537900755.209 [CTD_NeilBrown](DEBUG): serial timeout
2018-09-25T18:39:15.525Z,1537900755.525 [WetLabsSeaOWL_UV_A](INFO): In starting, uart error:serial timeout
2018-09-25T18:39:15.526Z,1537900755.526 [WetLabsSeaOWL_UV_A](INFO): Starting
2018-09-25T18:39:15.622Z,1537900755.622 [CTD_NeilBrown](DEBUG): serial timeout
2018-09-25T18:39:15.961Z,1537900755.961 [WetLabsSeaOWL_UV_A](INFO): In starting, bytesRead=75
2018-09-25T18:39:15.962Z,1537900755.962 [WetLabsSeaOWL_UV_A](INFO): scanned=3, outputChl_=78, output700_=49770, outputFDOM_=3881
2018-09-25T18:39:15.963Z,1537900755.963 [WetLabsSeaOWL_UV_A](INFO): scaleFactorFDOM_=0.008096, outputFDOM_=3881, darkCountsFDOM_=50.
2018-09-25T18:39:15.964Z,1537900755.964 [WetLabsSeaOWL_UV_A](INFO): parsed, chlConc_=0.060760, volScat700_=0.015931, fdomConc_=31.015778, oilConc_=10726.799805
2018-09-25T18:39:16.025Z,1537900756.025 [CTD_NeilBrown](DEBUG): serial timeout
2018-09-25T18:39:16.441Z,1537900756.441 [CTD_NeilBrown](DEBUG): serial timeout
2018-09-25T18:39:16.849Z,1537900756.849 [CTD_NeilBrown](DEBUG): serial timeout
2018-09-25T18:39:17.187Z,1537900757.187 [WetLabsSeaOWL_UV_A](INFO): Got valid response. Skip count: 0.
2018-09-25T18:39:17.188Z,1537900757.188 [WetLabsSeaOWL_UV_A](INFO): scanned=3, outputChl_=78, output700_=49720, outputFDOM_=3869
2018-09-25T18:39:17.189Z,1537900757.189 [WetLabsSeaOWL_UV_A](INFO): scaleFactorFDOM_=0.008096, outputFDOM_=3869, darkCountsFDOM_=50.
2018-09-25T18:39:17.190Z,1537900757.190 [WetLabsSeaOWL_UV_A](INFO): parsed, chlConc_=0.060760, volScat700_=0.015915, fdomConc_=30.918625, oilConc_=10693.200195
2018-09-25T18:39:17.261Z,1537900757.261 [CTD_NeilBrown](DEBUG): serial timeout
2018-09-25T18:39:17.669Z,1537900757.669 [CTD_NeilBrown](DEBUG): serial timeout
2018-09-25T18:39:18.081Z,1537900758.081 [CTD_NeilBrown](DEBUG): serial timeout
2018-09-25T18:39:18.400Z,1537900758.400 [WetLabsSeaOWL_UV_A](INFO): Got valid response. Skip count: 0.
2018-09-25T18:39:18.400Z,1537900758.400 [WetLabsSeaOWL_UV_A](INFO): scanned=3, outputChl_=78, output700_=49710, outputFDOM_=3873
2018-09-25T18:39:18.401Z,1537900758.401 [WetLabsSeaOWL_UV_A](INFO): scaleFactorFDOM_=0.008096, outputFDOM_=3873, darkCountsFDOM_=50.
2018-09-25T18:39:18.402Z,1537900758.402 [WetLabsSeaOWL_UV_A](INFO): parsed, chlConc_=0.060760, volScat700_=0.015912, fdomConc_=30.951008, oilConc_=10704.399414
2018-09-25T18:39:18.485Z,1537900758.485 [CTD_NeilBrown](DEBUG): serial timeout
2018-09-25T18:39:18.897Z,1537900758.897 [CTD_NeilBrown](DEBUG): serial timeout
2018-09-25T18:39:19.208Z,1537900759.208 [WetLabsSeaOWL_UV_A](INFO): Got valid response. Skip count: 0.
2018-09-25T18:39:19.209Z,1537900759.209 [WetLabsSeaOWL_UV_A](INFO): scanned=3, outputChl_=82, output700_=49690, outputFDOM_=3867
2018-09-25T18:39:19.210Z,1537900759.210 [WetLabsSeaOWL_UV_A](INFO): scaleFactorFDOM_=0.008096, outputFDOM_=3867, darkCountsFDOM_=50.
2018-09-25T18:39:19.211Z,1537900759.211 [WetLabsSeaOWL_UV_A](INFO): parsed, chlConc_=0.069440, volScat700_=0.015905, fdomConc_=30.902433, oilConc_=10687.599609
2018-09-25T18:39:19.309Z,1537900759.309 [CTD_NeilBrown](DEBUG): serial timeout
2018-09-25T18:39:19.713Z,1537900759.713 [CTD_NeilBrown](DEBUG): serial timeout
2018-09-25T18:39:20.121Z,1537900760.121 [CTD_NeilBrown](DEBUG): serial timeout
2018-09-25T18:39:20.419Z,1537900760.419 [WetLabsSeaOWL_UV_A](INFO): Got valid response. Skip count: 0.
2018-09-25T18:39:20.420Z,1537900760.420 [WetLabsSeaOWL_UV_A](INFO): scanned=3, outputChl_=81, output700_=49690, outputFDOM_=3875
2018-09-25T18:39:20.421Z,1537900760.421 [WetLabsSeaOWL_UV_A](INFO): scaleFactorFDOM_=0.008096, outputFDOM_=3875, darkCountsFDOM_=50.
2018-09-25T18:39:20.422Z,1537900760.422 [WetLabsSeaOWL_UV_A](INFO): parsed, chlConc_=0.067270, volScat700_=0.015905, fdomConc_=30.967201, oilConc_=10710.000000
2018-09-25T18:39:20.529Z,1537900760.529 [CTD_NeilBrown](DEBUG): serial timeout
2018-09-25T18:39:20.941Z,1537900760.941 [CTD_NeilBrown](DEBUG): serial timeout
2018-09-25T18:39:20.941Z,1537900760.941 [CTD_NeilBrown](FAULT): No CTD communication! Re-initializing
2018-09-25T18:39:20.941Z,1537900760.941 [CTD_NeilBrown] Communications Fault, FailCount= 1
2018-09-25T18:39:20.941Z,1537900760.941 [CTD_NeilBrown](ERROR): Communications Fault
2018-09-25T18:39:21.273Z,1537900761.273 [WetLabsSeaOWL_UV_A](INFO): Got valid response. Skip count: 0.
2018-09-25T18:39:21.274Z,1537900761.274 [WetLabsSeaOWL_UV_A](INFO): scanned=3, outputChl_=80, output700_=49670, outputFDOM_=3866
2018-09-25T18:39:21.275Z,1537900761.275 [WetLabsSeaOWL_UV_A](INFO): scaleFactorFDOM_=0.008096, outputFDOM_=3866, darkCountsFDOM_=50.
2018-09-25T18:39:21.276Z,1537900761.276 [WetLabsSeaOWL_UV_A](INFO): parsed, chlConc_=0.065100, volScat700_=0.015899, fdomConc_=30.894337, oilConc_=10684.799805
2018-09-25T18:39:21.288Z,1537900761.288 [CBIT](ERROR): Communications Fault in component: CTD_NeilBrown
2018-09-25T18:39:21.465Z,1537900761.465 [CTD_NeilBrown](INFO): Powering down
2018-09-25T18:39:21.587Z,1537900761.587 [Aanderaa_O2](DEBUG): Error parsing data: 4831F	648		242.739		96.602		26.429		28.104		29.332		38.688		9.356		678.9		856.4		-37.9	



2018-09-25T18:39:21.587Z,1537900761.587 [Aanderaa_O2](DEBUG): Error parsing device response
2018-09-25T18:39:22.439Z,1537900762.439 [WetLabsSeaOWL_UV_A](INFO): Got valid response. Skip count: 0.
2018-09-25T18:39:22.440Z,1537900762.440 [WetLabsSeaOWL_UV_A](INFO): scanned=3, outputChl_=79, output700_=49660, outputFDOM_=3867
2018-09-25T18:39:22.440Z,1537900762.440 [WetLabsSeaOWL_UV_A](INFO): scaleFactorFDOM_=0.008096, outputFDOM_=3867, darkCountsFDOM_=50.
2018-09-25T18:39:22.450Z,1537900762.450 [WetLabsSeaOWL_UV_A](INFO): parsed, chlConc_=0.062930, volScat700_=0.015896, fdomConc_=30.902433, oilConc_=10687.599609
2018-09-25T18:39:22.783Z,1537900762.783 [Aanderaa_O2](DEBUG): Error parsing data: 4831F	648		242.833		96.636		26.428		28.101		29.329		38.683		9.354		679.1		855.5		-37.8	



2018-09-25T18:39:22.783Z,1537900762.783 [Aanderaa_O2](DEBUG): Error parsing device response
2018-09-25T18:39:22.884Z,1537900762.884 [CBIT](INFO): Clearing failed state for component CTD_NeilBrown
2018-09-25T18:39:22.889Z,1537900762.889 [CTD_NeilBrown] No Fault, FailCount= 1
2018-09-25T18:39:23.081Z,1537900763.081 [CTD_NeilBrown](DEBUG): Initializing CTD_NeilBrown.
2018-09-25T18:39:23.082Z,1537900763.082 [CTD_NeilBrown](INFO): Opening uart, block timeout 10ths=4
2018-09-25T18:39:23.205Z,1537900763.205 [CTD_NeilBrown](DEBUG): serial timeout
2018-09-25T18:39:23.617Z,1537900763.617 [CTD_NeilBrown](DEBUG): serial timeout
2018-09-25T18:39:23.652Z,1537900763.652 [WetLabsSeaOWL_UV_A](INFO): Got valid response. Skip count: 0.
2018-09-25T18:39:23.653Z,1537900763.653 [WetLabsSeaOWL_UV_A](INFO): scanned=3, outputChl_=78, output700_=49650, outputFDOM_=3861
2018-09-25T18:39:23.654Z,1537900763.654 [WetLabsSeaOWL_UV_A](INFO): scaleFactorFDOM_=0.008096, outputFDOM_=3861, darkCountsFDOM_=50.
2018-09-25T18:39:23.655Z,1537900763.655 [WetLabsSeaOWL_UV_A](INFO): parsed, chlConc_=0.060760, volScat700_=0.015892, fdomConc_=30.853857, oilConc_=10670.799805
2018-09-25T18:39:23.983Z,1537900763.983 [Aanderaa_O2](DEBUG): Error parsing data: 4831F	648		242.923		96.662		26.422		28.099		29.327		38.675		9.348		678.8		854.8		-37.7	

2018-09-25T18:39:23.983Z,1537900763.983 [Aanderaa_O2](DEBUG): Error parsing device response
2018-09-25T18:39:24.025Z,1537900764.025 [CTD_NeilBrown](DEBUG): serial timeout
2018-09-25T18:39:24.098Z,1537900764.098 [CTD_NeilBrown](ERROR): Salinity reading out of range: -0.169500 psu
2018-09-25T18:39:24.112Z,1537900764.112 [CTD_NeilBrown](INFO): some bad data, not updating bins
2018-09-25T18:39:24.300Z,1537900764.300 [CTD_NeilBrown](ERROR): Salinity reading out of range: -0.170600 psu
2018-09-25T18:39:24.304Z,1537900764.304 [CTD_NeilBrown](INFO): some bad data, not updating bins
2018-09-25T18:39:24.459Z,1537900764.459 [WetLabsSeaOWL_UV_A](INFO): Got valid response. Skip count: 0.
2018-09-25T18:39:24.460Z,1537900764.460 [WetLabsSeaOWL_UV_A](INFO): scanned=3, outputChl_=78, output700_=49640, outputFDOM_=3860
2018-09-25T18:39:24.461Z,1537900764.461 [WetLabsSeaOWL_UV_A](INFO): scaleFactorFDOM_=0.008096, outputFDOM_=3860, darkCountsFDOM_=50.
2018-09-25T18:39:24.462Z,1537900764.462 [WetLabsSeaOWL_UV_A](INFO): parsed, chlConc_=0.060760, volScat700_=0.015889, fdomConc_=30.845760, oilConc_=10668.000000
2018-09-25T18:39:24.502Z,1537900764.502 [CTD_NeilBrown](ERROR): Salinity reading out of range: -0.170500 psu
2018-09-25T18:39:24.505Z,1537900764.505 [CTD_NeilBrown](INFO): some bad data, not updating bins
2018-09-25T18:39:24.713Z,1537900764.713 [CTD_NeilBrown](ERROR): Salinity reading out of range: -0.170800 psu
2018-09-25T18:39:24.716Z,1537900764.716 [CTD_NeilBrown](INFO): some bad data, not updating bins
2018-09-25T18:39:24.917Z,1537900764.917 [CTD_NeilBrown](ERROR): Salinity reading out of range: -0.170400 psu
2018-09-25T18:39:24.920Z,1537900764.920 [CTD_NeilBrown](INFO): some bad data, not updating bins
2018-09-25T18:39:25.121Z,1537900765.121 [CTD_NeilBrown](ERROR): Salinity reading out of range: -0.173900 psu
2018-09-25T18:39:25.124Z,1537900765.124 [CTD_NeilBrown](INFO): some bad data, not updating bins
2018-09-25T18:39:25.323Z,1537900765.323 [CTD_NeilBrown](ERROR): Salinity reading out of range: -0.175300 psu
2018-09-25T18:39:25.331Z,1537900765.331 [CTD_NeilBrown](INFO): some bad data, not updating bins
2018-09-25T18:39:25.525Z,1537900765.525 [CTD_NeilBrown](ERROR): Salinity reading out of range: -0.173700 psu
2018-09-25T18:39:25.528Z,1537900765.528 [CTD_NeilBrown](INFO): some bad data, not updating bins
2018-09-25T18:39:25.671Z,1537900765.671 [WetLabsSeaOWL_UV_A](INFO): Got valid response. Skip count: 0.
2018-09-25T18:39:25.672Z,1537900765.672 [WetLabsSeaOWL_UV_A](INFO): scanned=3, outputChl_=76, output700_=49610, outputFDOM_=3854
2018-09-25T18:39:25.674Z,1537900765.674 [WetLabsSeaOWL_UV_A](INFO): scaleFactorFDOM_=0.008096, outputFDOM_=3854, darkCountsFDOM_=50.
2018-09-25T18:39:25.675Z,1537900765.675 [WetLabsSeaOWL_UV_A](INFO): parsed, chlConc_=0.056420, volScat700_=0.015880, fdomConc_=30.797184, oilConc_=10651.200195
2018-09-25T18:39:25.734Z,1537900765.734 [CTD_NeilBrown](ERROR): Salinity reading out of range: -0.172000 psu
2018-09-25T18:39:25.736Z,1537900765.736 [CTD_NeilBrown](INFO): some bad data, not updating bins
2018-09-25T18:39:25.929Z,1537900765.929 [CTD_NeilBrown](ERROR): Salinity reading out of range: -0.174700 psu
2018-09-25T18:39:25.932Z,1537900765.932 [CTD_NeilBrown](INFO): some bad data, not updating bins
2018-09-25T18:39:25.983Z,1537900765.983 [Aanderaa_O2](DEBUG): Error parsing data: 4831F	648		242.965		96.671		26.418		28.099		29.327		38.673		9.346		678.9		853.7		-37.5	

2018-09-25T18:39:25.983Z,1537900765.983 [Aanderaa_O2](DEBUG): Error parsing device response
2018-09-25T18:39:26.141Z,1537900766.141 [CTD_NeilBrown](ERROR): Salinity reading out of range: -0.170300 psu
2018-09-25T18:39:26.144Z,1537900766.144 [CTD_NeilBrown](INFO): some bad data, not updating bins
2018-09-25T18:39:26.339Z,1537900766.339 [CTD_NeilBrown](ERROR): Salinity reading out of range: -0.172300 psu
2018-09-25T18:39:26.344Z,1537900766.344 [CTD_NeilBrown](INFO): some bad data, not updating bins
2018-09-25T18:39:26.550Z,1537900766.550 [CTD_NeilBrown](ERROR): Salinity reading out of range: -0.172300 psu
2018-09-25T18:39:26.554Z,1537900766.554 [CTD_NeilBrown](INFO): some bad data, not updating bins
2018-09-25T18:39:26.753Z,1537900766.753 [CTD_NeilBrown](ERROR): Salinity reading out of range: -0.172400 psu
2018-09-25T18:39:26.756Z,1537900766.756 [CTD_NeilBrown](INFO): some bad data, not updating bins
2018-09-25T18:39:26.883Z,1537900766.883 [WetLabsSeaOWL_UV_A](INFO): Got valid response. Skip count: 0.
2018-09-25T18:39:26.884Z,1537900766.884 [WetLabsSeaOWL_UV_A](INFO): scanned=3, outputChl_=79, output700_=49610, outputFDOM_=3855
2018-09-25T18:39:26.885Z,1537900766.885 [WetLabsSeaOWL_UV_A](INFO): scaleFactorFDOM_=0.008096, outputFDOM_=3855, darkCountsFDOM_=50.
2018-09-25T18:39:26.886Z,1537900766.886 [WetLabsSeaOWL_UV_A](INFO): parsed, chlConc_=0.062930, volScat700_=0.015880, fdomConc_=30.805281, oilConc_=10654.000000
2018-09-25T18:39:26.954Z,1537900766.954 [CTD_NeilBrown](ERROR): Salinity reading out of range: -0.173400 psu
2018-09-25T18:39:26.956Z,1537900766.956 [CTD_NeilBrown](INFO): some bad data, not updating bins
2018-09-25T18:39:27.161Z,1537900767.161 [CTD_NeilBrown](ERROR): Salinity reading out of range: -0.174900 psu
2018-09-25T18:39:27.164Z,1537900767.164 [CTD_NeilBrown](INFO): some bad data, not updating bins
2018-09-25T18:39:27.365Z,1537900767.365 [CTD_NeilBrown](ERROR): Salinity reading out of range: -0.174900 psu
2018-09-25T18:39:27.368Z,1537900767.368 [CTD_NeilBrown](INFO): some bad data, not updating bins
2018-09-25T18:39:27.561Z,1537900767.561 [CTD_NeilBrown](ERROR): Salinity reading out of range: -0.169100 psu
2018-09-25T18:39:27.564Z,1537900767.564 [CTD_NeilBrown](INFO): some bad data, not updating bins
2018-09-25T18:39:27.692Z,1537900767.692 [WetLabsSeaOWL_UV_A](INFO): Got valid response. Skip count: 0.
2018-09-25T18:39:27.693Z,1537900767.693 [WetLabsSeaOWL_UV_A](INFO): scanned=3, outputChl_=78, output700_=49570, outputFDOM_=3845
2018-09-25T18:39:27.694Z,1537900767.694 [WetLabsSeaOWL_UV_A](INFO): scaleFactorFDOM_=0.008096, outputFDOM_=3845, darkCountsFDOM_=50.
2018-09-25T18:39:27.695Z,1537900767.695 [WetLabsSeaOWL_UV_A](INFO): parsed, chlConc_=0.060760, volScat700_=0.015867, fdomConc_=30.724321, oilConc_=10626.000000
2018-09-25T18:39:27.769Z,1537900767.769 [CTD_NeilBrown](ERROR): Salinity reading out of range: -0.174400 psu
2018-09-25T18:39:27.772Z,1537900767.772 [CTD_NeilBrown](INFO): some bad data, not updating bins
2018-09-25T18:39:27.973Z,1537900767.973 [CTD_NeilBrown](ERROR): Salinity reading out of range: -0.173900 psu
2018-09-25T18:39:27.976Z,1537900767.976 [CTD_NeilBrown](INFO): some bad data, not updating bins
2018-09-25T18:39:28.181Z,1537900768.181 [CTD_NeilBrown](ERROR): Salinity reading out of range: -0.167900 psu
2018-09-25T18:39:28.184Z,1537900768.184 [CTD_NeilBrown](INFO): some bad data, not updating bins
2018-09-25T18:39:28.393Z,1537900768.393 [CTD_NeilBrown](ERROR): Salinity reading out of range: -0.169700 psu
2018-09-25T18:39:28.396Z,1537900768.396 [CTD_NeilBrown](INFO): some bad data, not updating bins
2018-09-25T18:39:28.585Z,1537900768.585 [CTD_NeilBrown](ERROR): Salinity reading out of range: -0.174600 psu
2018-09-25T18:39:28.588Z,1537900768.588 [CTD_NeilBrown](INFO): some bad data, not updating bins
2018-09-25T18:39:28.790Z,1537900768.790 [CTD_NeilBrown](ERROR): Salinity reading out of range: -0.167000 psu
2018-09-25T18:39:28.793Z,1537900768.793 [CTD_NeilBrown](INFO): some bad data, not updating bins
2018-09-25T18:39:28.903Z,1537900768.903 [WetLabsSeaOWL_UV_A](INFO): Got valid response. Skip count: 0.
2018-09-25T18:39:28.904Z,1537900768.904 [WetLabsSeaOWL_UV_A](INFO): scanned=3, outputChl_=78, output700_=49550, outputFDOM_=3851
2018-09-25T18:39:28.905Z,1537900768.905 [WetLabsSeaOWL_UV_A](INFO): scaleFactorFDOM_=0.008096, outputFDOM_=3851, darkCountsFDOM_=50.
2018-09-25T18:39:28.906Z,1537900768.906 [WetLabsSeaOWL_UV_A](INFO): parsed, chlConc_=0.060760, volScat700_=0.015860, fdomConc_=30.772896, oilConc_=10642.799805
2018-09-25T18:39:28.990Z,1537900768.990 [CTD_NeilBrown](ERROR): Salinity reading out of range: -0.172700 psu
2018-09-25T18:39:28.992Z,1537900768.992 [CTD_NeilBrown](INFO): some bad data, not updating bins
2018-09-25T18:39:29.194Z,1537900769.194 [CTD_NeilBrown](ERROR): Salinity reading out of range: -0.174200 psu
2018-09-25T18:39:29.197Z,1537900769.197 [CTD_NeilBrown](INFO): some bad data, not updating bins
2018-09-25T18:39:29.399Z,1537900769.399 [CTD_NeilBrown](ERROR): Salinity reading out of range: -0.172800 psu
2018-09-25T18:39:29.407Z,1537900769.407 [CTD_NeilBrown](INFO): some bad data, not updating bins
2018-09-25T18:39:29.610Z,1537900769.610 [CTD_NeilBrown](ERROR): Salinity reading out of range: -0.166900 psu
2018-09-25T18:39:29.613Z,1537900769.613 [CTD_NeilBrown](INFO): some bad data, not updating bins
2018-09-25T18:39:29.703Z,1537900769.703 [CommandLine](IMPORTANT): got command stop
2018-09-25T18:39:29.703Z,1537900769.703 [CommandLine](IMPORTANT): Scheduling is paused
2018-09-25T18:39:29.703Z,1537900769.703 [Supervisor](INFO): Stop Mission called by CommandLine::commandStop
2018-09-25T18:39:29.770Z,1537900769.770 [WetLabsSeaOWL_UV_A](INFO): Got valid response. Skip count: 0.
2018-09-25T18:39:29.771Z,1537900769.771 [WetLabsSeaOWL_UV_A](INFO): scanned=3, outputChl_=82, output700_=49530, outputFDOM_=3840
2018-09-25T18:39:29.772Z,1537900769.772 [WetLabsSeaOWL_UV_A](INFO): scaleFactorFDOM_=0.008096, outputFDOM_=3840, darkCountsFDOM_=50.
2018-09-25T18:39:29.773Z,1537900769.773 [WetLabsSeaOWL_UV_A](INFO): parsed, chlConc_=0.069440, volScat700_=0.015854, fdomConc_=30.683840, oilConc_=10612.000000
2018-09-25T18:39:29.814Z,1537900769.814 [CTD_NeilBrown](ERROR): Salinity reading out of range: -0.166000 psu
2018-09-25T18:39:29.816Z,1537900769.816 [CTD_NeilBrown](INFO): some bad data, not updating bins
2018-09-25T18:39:30.022Z,1537900770.022 [CTD_NeilBrown](ERROR): Salinity reading out of range: -0.175000 psu
2018-09-25T18:39:30.027Z,1537900770.027 [CTD_NeilBrown](INFO): some bad data, not updating bins
2018-09-25T18:39:30.068Z,1537900770.068 [MissionManager](INFO): MissionManager is completed.
2018-09-25T18:39:30.068Z,1537900770.068 [MissionManager](INFO): Uninitializing Mission Science
2018-09-25T18:39:30.068Z,1537900770.068 [Science] Stopped
2018-09-25T18:39:30.068Z,1537900770.068 [Science](DEBUG): Aggregate::uninitialize Science
2018-09-25T18:39:30.069Z,1537900770.069 [Science:A] Stopped
2018-09-25T18:39:30.069Z,1537900770.069 [Science:C] Stopped
2018-09-25T18:39:30.069Z,1537900770.069 [Science:Read_Oil] Stopped
2018-09-25T18:39:30.114Z,1537900770.114 [WetLabsSeaOWL_UV_A](INFO): Stop
2018-09-25T18:39:30.209Z,1537900770.209 [WetLabsSeaOWL_UV_A](INFO): Powering down
2018-09-25T18:39:30.214Z,1537900770.214 [CTD_NeilBrown](ERROR): Salinity reading out of range: -0.173100 psu
2018-09-25T18:39:30.217Z,1537900770.217 [CTD_NeilBrown](INFO): some bad data, not updating bins
2018-09-25T18:39:30.433Z,1537900770.433 [MissionManager](IMPORTANT): Started mission Default
2018-09-25T18:39:30.444Z,1537900770.444 [Default] Running Loop=1
2018-09-25T18:39:30.444Z,1537900770.444 [Default](DEBUG): Aggregate::initialize Default
2018-09-25T18:39:30.444Z,1537900770.444 [Default:B.GoToSurface] Running Loop=1
2018-09-25T18:39:30.444Z,1537900770.444 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2018-09-25T18:39:30.444Z,1537900770.444 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2018-09-25T18:39:30.445Z,1537900770.445 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2018-09-25T18:39:30.445Z,1537900770.445 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2018-09-25T18:39:30.446Z,1537900770.446 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2018-09-25T18:39:30.446Z,1537900770.446 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2018-09-25T18:39:30.446Z,1537900770.446 [Default:A.Wait] Running Loop=1
2018-09-25T18:39:30.446Z,1537900770.446 [Default:A.Wait](DEBUG): Initialize Wait Component.
2018-09-25T18:39:30.613Z,1537900770.613 [WetLabsSeaOWL_UV_A](INFO): Stopping
2018-09-25T18:39:30.901Z,1537900770.901 [Aanderaa_O2](INFO): Powering down
2018-09-25T18:39:39.548Z,1537900779.548 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2018-09-25T18:39:43.668Z,1537900783.668 [Default:A.Wait](INFO): Done Waiting.
2018-09-25T18:39:43.668Z,1537900783.668 [Default:A.Wait] Stopped
2018-09-25T18:39:43.668Z,1537900783.668 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2018-09-25T18:39:44.073Z,1537900784.073 [Default:CheckIn] Running Loop=1
2018-09-25T18:39:44.073Z,1537900784.073 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2018-09-25T18:39:44.073Z,1537900784.073 [Default:CheckIn:Read_GPS] Running Loop=1
2018-09-25T18:39:50.339Z,1537900790.339 [CommandLine](IMPORTANT): got command configSet CBIT.gf24Offset 163.000000 microampere
2018-09-25T18:39:54.534Z,1537900794.534 [CommandLine](IMPORTANT): got command gfscan
2018-09-25T18:39:54.891Z,1537900794.891 [CBIT](IMPORTANT): Beginning ground fault scan
2018-09-25T18:40:02.016Z,1537900802.016 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2018-09-25T18:40:05.681Z,1537900805.681 [CBIT](IMPORTANT): Ground fault detected
mA:
CHAN A0 (Batt): -0.007770
CHAN A1 (24V): -0.187583
CHAN A2 (12V): -0.007158
CHAN A3 (5V): -0.002134
CHAN B0 (3.3V): 0.000281
CHAN B1 (3.15aV): -0.000101
CHAN B2 (3.15bV): -0.000093
CHAN B3 (GND): 0.002442
OPEN: 0.005394
Full Scale Calc: 4.765 mA, -1.589 mA
2018-09-25T18:40:19.035Z,1537900819.035 [CommandLine](IMPORTANT): got command get CBIT.gf24Offset
2018-09-25T18:40:19.035Z,1537900819.035 [CommandLine](IMPORTANT): CBIT.gf24Offset 163.000004 uA
2018-09-25T18:40:21.262Z,1537900821.262 [DeadReckonUsingMultipleVelocitySources](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2018-09-25T18:40:21.262Z,1537900821.262 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2
2018-09-25T18:40:21.262Z,1537900821.262 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2018-09-25T18:40:21.264Z,1537900821.264 [DeadReckonUsingSpeedCalculator](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2018-09-25T18:40:21.264Z,1537900821.264 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 2
2018-09-25T18:40:21.264Z,1537900821.264 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2018-09-25T18:40:21.277Z,1537900821.277 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2018-09-25T18:40:21.277Z,1537900821.277 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2018-09-25T18:40:21.694Z,1537900821.694 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2018-09-25T18:40:21.694Z,1537900821.694 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2
2018-09-25T18:40:21.695Z,1537900821.695 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2018-09-25T18:40:21.696Z,1537900821.696 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 2
2018-09-25T18:40:22.080Z,1537900822.080 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2018-09-25T18:40:22.080Z,1537900822.080 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2018-09-25T18:40:22.081Z,1537900822.081 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2018-09-25T18:40:22.081Z,1537900822.081 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2018-09-25T18:40:22.082Z,1537900822.082 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2018-09-25T18:40:22.082Z,1537900822.082 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2018-09-25T18:40:45.171Z,1537900845.171 [CommandLine](IMPORTANT): got command configSet CBIT.gf24Offset -163.000000 microampere
2018-09-25T18:40:45.732Z,1537900845.732 [RDI_Pathfinder](ERROR): only read 3 of 5 data items
2018-09-25T18:40:45.732Z,1537900845.732 [RDI_Pathfinder](ERROR): Failed to parse:
:BI,-32768,-2768,-32768,V
2018-09-25T18:40:51.032Z,1537900851.032 [CommandLine](IMPORTANT): got command gfscan
2018-09-25T18:40:51.365Z,1537900851.365 [CBIT](IMPORTANT): Beginning ground fault scan
2018-09-25T18:41:02.153Z,1537900862.153 [CBIT](IMPORTANT): Ground fault detected
mA:
CHAN A0 (Batt): -0.007778
CHAN A1 (24V): 0.138419
CHAN A2 (12V): -0.007344
CHAN A3 (5V): -0.002169
CHAN B0 (3.3V): 0.000031
CHAN B1 (3.15aV): 0.000267
CHAN B2 (3.15bV): 0.000348
CHAN B3 (GND): 0.002378
OPEN: 0.005318
Full Scale Calc: 4.765 mA, -1.589 mA
2018-09-25T18:41:30.260Z,1537900890.260 [CommandLine](IMPORTANT): got command get CBIT.gf24Offset
2018-09-25T18:41:30.260Z,1537900890.260 [CommandLine](IMPORTANT): CBIT.gf24Offset -163.000004 uA
2018-09-25T18:42:05.003Z,1537900925.003 [BPC1](INFO): Calculating totals. Valid battery stick count: 56. Valid reserve battery stick count: 6.
2018-09-25T18:43:22.298Z,1537901002.298 [DeadReckonUsingMultipleVelocitySources](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2018-09-25T18:43:22.298Z,1537901002.298 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3
2018-09-25T18:43:22.298Z,1537901002.298 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2018-09-25T18:43:22.300Z,1537901002.300 [DeadReckonUsingSpeedCalculator](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2018-09-25T18:43:22.300Z,1537901002.300 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 3
2018-09-25T18:43:22.300Z,1537901002.300 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2018-09-25T18:43:22.314Z,1537901002.314 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2018-09-25T18:43:22.314Z,1537901002.314 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2018-09-25T18:43:22.733Z,1537901002.733 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2018-09-25T18:43:22.733Z,1537901002.733 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3
2018-09-25T18:43:22.734Z,1537901002.734 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2018-09-25T18:43:22.734Z,1537901002.734 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 3
2018-09-25T18:43:23.117Z,1537901003.117 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2018-09-25T18:43:23.117Z,1537901003.117 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2018-09-25T18:43:23.118Z,1537901003.118 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2018-09-25T18:43:23.118Z,1537901003.118 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2018-09-25T18:43:23.118Z,1537901003.118 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2018-09-25T18:43:23.119Z,1537901003.119 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2018-09-25T18:44:44.080Z,1537901084.080 [Default:CheckIn:Read_GPS](INFO): Timed out from 2018-09-25T18:39:44.1Z
2018-09-25T18:44:44.080Z,1537901084.080 [Default:CheckIn:Read_GPS] Stopped
2018-09-25T18:44:44.080Z,1537901084.080 [Default:CheckIn:Read_Iridium] Running Loop=1
2018-09-25T18:44:44.491Z,1537901084.491 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications
2018-09-25T18:44:48.532Z,1537901088.532 [DataOverHttps](INFO): Sending 190 bytes from file Logs/20180925T183401/Courier0004.lzma
2018-09-25T18:44:49.300Z,1537901089.300 [DataOverHttps](INFO): Moved sent file to Logs/20180925T183401/Courier0004.lzma.bak
2018-09-25T18:44:49.300Z,1537901089.300 [DataOverHttps](INFO): SBD MOMSN=8586522
2018-09-25T18:44:54.651Z,1537901094.651 [RDI_Pathfinder](ERROR): Failed to parse:
:BI,-32768,-32768,-32768,-32768,V
2018-09-25T18:44:58.298Z,1537901098.298 [DataOverHttps](INFO): Sending 1065 bytes from file Logs/20180925T182508/Express0001.lzma
2018-09-25T18:44:59.076Z,1537901099.076 [DataOverHttps](INFO): Moved sent file to Logs/20180925T182508/Express0001.lzma.bak
2018-09-25T18:44:59.077Z,1537901099.077 [DataOverHttps](INFO): SBD MOMSN=8586525
2018-09-25T18:44:59.083Z,1537901099.083 [NAL9602](FAULT): GPS failed to acquire within timeout.
2018-09-25T18:44:59.083Z,1537901099.083 [NAL9602] Data Fault, FailCount= 1
2018-09-25T18:44:59.083Z,1537901099.083 [NAL9602](ERROR): Data Fault
2018-09-25T18:44:59.164Z,1537901099.164 [CBIT](ERROR): Data Fault in component: NAL9602
2018-09-25T18:44:59.664Z,1537901099.664 [NAL9602](INFO): Powering down
2018-09-25T18:45:03.134Z,1537901103.134 [CBIT](INFO): Clearing failed state for component NAL9602
2018-09-25T18:45:03.135Z,1537901103.135 [NAL9602] No Fault, FailCount= 1
2018-09-25T18:45:08.053Z,1537901108.053 [DataOverHttps](INFO): Sending 439 bytes from file Logs/20180925T182508/Express0005.lzma
2018-09-25T18:45:08.816Z,1537901108.816 [DataOverHttps](INFO): Moved sent file to Logs/20180925T182508/Express0005.lzma.bak
2018-09-25T18:45:08.816Z,1537901108.816 [DataOverHttps](INFO): SBD MOMSN=8586551
2018-09-25T18:45:17.762Z,1537901117.762 [DataOverHttps](INFO): Sending 1060 bytes from file Logs/20180925T183401/Express0001.lzma
2018-09-25T18:45:19.323Z,1537901119.323 [DataOverHttps](INFO): Moved sent file to Logs/20180925T183401/Express0001.lzma.bak
2018-09-25T18:45:19.324Z,1537901119.324 [DataOverHttps](INFO): SBD MOMSN=8586566
2018-09-25T18:45:23.106Z,1537901123.106 [RDI_Pathfinder](ERROR): Failed to parse:
:BE,-32768,-32768,-32768,V
2018-09-25T18:45:28.087Z,1537901128.087 [DataOverHttps](INFO): Sending 702 bytes from file Logs/20180925T183401/Express0005.lzma
2018-09-25T18:45:28.848Z,1537901128.848 [DataOverHttps](INFO): Moved sent file to Logs/20180925T183401/Express0005.lzma.bak
2018-09-25T18:45:28.848Z,1537901128.848 [DataOverHttps](INFO): SBD MOMSN=8586592
2018-09-25T18:45:29.493Z,1537901129.493 [Default:CheckIn:Read_Iridium] Stopped
2018-09-25T18:45:29.493Z,1537901129.493 [Default:CheckIn:C.Wait] Running Loop=1
2018-09-25T18:45:29.493Z,1537901129.493 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2018-09-25T18:45:32.821Z,1537901132.821 [NAL9602](INFO): Powering up NAL9602
2018-09-25T18:45:43.715Z,1537901143.715 [NAL9602](INFO): NAL9602 initialized
2018-09-25T18:46:23.387Z,1537901183.387 [DeadReckonUsingMultipleVelocitySources](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2018-09-25T18:46:23.387Z,1537901183.387 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4
2018-09-25T18:46:23.387Z,1537901183.387 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2018-09-25T18:46:23.393Z,1537901183.393 [DeadReckonUsingSpeedCalculator](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2018-09-25T18:46:23.393Z,1537901183.393 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 4
2018-09-25T18:46:23.393Z,1537901183.393 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2018-09-25T18:46:23.422Z,1537901183.422 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2018-09-25T18:46:23.423Z,1537901183.423 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2018-09-25T18:46:23.792Z,1537901183.792 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2018-09-25T18:46:23.792Z,1537901183.792 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4
2018-09-25T18:46:23.793Z,1537901183.793 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2018-09-25T18:46:23.793Z,1537901183.793 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 4
2018-09-25T18:46:24.138Z,1537901184.138 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2018-09-25T18:46:24.138Z,1537901184.138 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2018-09-25T18:46:24.138Z,1537901184.138 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2018-09-25T18:46:24.139Z,1537901184.139 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2018-09-25T18:46:24.139Z,1537901184.139 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2018-09-25T18:46:24.140Z,1537901184.140 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2018-09-25T18:49:22.058Z,1537901362.058 [RDI_Pathfinder](ERROR): only read 3 of 5 data items
2018-09-25T18:49:22.058Z,1537901362.058 [RDI_Pathfinder](ERROR): Failed to parse:
:BI,-32768,-32768,32768,V
2018-09-25T18:49:24.473Z,1537901364.473 [DeadReckonUsingMultipleVelocitySources](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2018-09-25T18:49:24.473Z,1537901364.473 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 5
2018-09-25T18:49:24.473Z,1537901364.473 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2018-09-25T18:49:24.475Z,1537901364.475 [DeadReckonUsingSpeedCalculator](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2018-09-25T18:49:24.475Z,1537901364.475 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 5
2018-09-25T18:49:24.475Z,1537901364.475 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2018-09-25T18:49:24.509Z,1537901364.509 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2018-09-25T18:49:24.509Z,1537901364.509 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2018-09-25T18:49:24.887Z,1537901364.887 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2018-09-25T18:49:24.887Z,1537901364.887 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 5
2018-09-25T18:49:24.888Z,1537901364.888 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2018-09-25T18:49:24.888Z,1537901364.888 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 5
2018-09-25T18:49:25.270Z,1537901365.270 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2018-09-25T18:49:25.270Z,1537901365.270 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2018-09-25T18:49:25.271Z,1537901365.271 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2018-09-25T18:49:25.271Z,1537901365.271 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2018-09-25T18:49:25.271Z,1537901365.271 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2018-09-25T18:49:25.272Z,1537901365.272 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2018-09-25T18:50:29.821Z,1537901429.821 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2018-09-25T18:50:29.821Z,1537901429.821 [Default:CheckIn:C.Wait] Stopped
2018-09-25T18:50:29.821Z,1537901429.821 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2018-09-25T18:50:29.821Z,1537901429.821 [Default:CheckIn:D] Running Loop=1
2018-09-25T18:50:30.219Z,1537901430.219 [Default:CheckIn:D] Stopped
2018-09-25T18:50:30.219Z,1537901430.219 [Default:CheckIn:E] Running Loop=1
2018-09-25T18:50:30.629Z,1537901430.629 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 10.996147 min 
2018-09-25T18:50:30.631Z,1537901430.631 [Default:CheckIn:E] Stopped
2018-09-25T18:50:30.631Z,1537901430.631 [Default:CheckIn](INFO): Completed Default:CheckIn
2018-09-25T18:50:30.632Z,1537901430.632 [Default:CheckIn] Stopped
2018-09-25T18:50:30.632Z,1537901430.632 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2018-09-25T18:50:30.632Z,1537901430.632 [Default:CheckIn](INFO): Running loop #2
2018-09-25T18:50:30.632Z,1537901430.632 [Default:CheckIn] Running Loop=2
2018-09-25T18:50:30.632Z,1537901430.632 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2018-09-25T18:50:30.632Z,1537901430.632 [Default:CheckIn:Read_GPS] Running Loop=1
2018-09-25T18:52:25.630Z,1537901545.630 [DeadReckonUsingMultipleVelocitySources](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2018-09-25T18:52:25.630Z,1537901545.630 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 6
2018-09-25T18:52:25.630Z,1537901545.630 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2018-09-25T18:52:25.632Z,1537901545.632 [DeadReckonUsingSpeedCalculator](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2018-09-25T18:52:25.632Z,1537901545.632 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 6
2018-09-25T18:52:25.632Z,1537901545.632 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2018-09-25T18:52:25.650Z,1537901545.650 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2018-09-25T18:52:25.650Z,1537901545.650 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2018-09-25T18:52:26.030Z,1537901546.030 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2018-09-25T18:52:26.030Z,1537901546.030 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 6
2018-09-25T18:52:26.031Z,1537901546.031 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2018-09-25T18:52:26.031Z,1537901546.031 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 6
2018-09-25T18:52:26.429Z,1537901546.429 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2018-09-25T18:52:26.429Z,1537901546.429 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2018-09-25T18:52:26.430Z,1537901546.430 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2018-09-25T18:52:26.430Z,1537901546.430 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2018-09-25T18:52:26.431Z,1537901546.431 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2018-09-25T18:52:26.431Z,1537901546.431 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2018-09-25T18:52:41.698Z,1537901561.698 [RDI_Pathfinder](ERROR): only read 1 of 1 data item for altitude
2018-09-25T18:52:41.698Z,1537901561.698 [RDI_Pathfinder](ERROR): Failed to parse:
:HM,,0ffd,*15.880,*-0.001,*0.000
2018-09-25T18:55:26.660Z,1537901726.660 [DeadReckonUsingMultipleVelocitySources](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2018-09-25T18:55:26.660Z,1537901726.660 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 7
2018-09-25T18:55:26.660Z,1537901726.660 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2018-09-25T18:55:26.662Z,1537901726.662 [DeadReckonUsingSpeedCalculator](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2018-09-25T18:55:26.662Z,1537901726.662 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 7
2018-09-25T18:55:26.662Z,1537901726.662 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2018-09-25T18:55:26.675Z,1537901726.675 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2018-09-25T18:55:26.676Z,1537901726.676 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2018-09-25T18:55:27.053Z,1537901727.053 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2018-09-25T18:55:27.053Z,1537901727.053 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 7
2018-09-25T18:55:27.053Z,1537901727.053 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2018-09-25T18:55:27.053Z,1537901727.053 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 7
2018-09-25T18:55:27.443Z,1537901727.443 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2018-09-25T18:55:27.444Z,1537901727.444 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2018-09-25T18:55:27.444Z,1537901727.444 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2018-09-25T18:55:27.453Z,1537901727.453 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2018-09-25T18:55:27.453Z,1537901727.453 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2018-09-25T18:55:27.454Z,1537901727.454 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2018-09-25T18:55:30.654Z,1537901730.654 [Default:CheckIn:Read_GPS](INFO): Timed out from 2018-09-25T18:50:30.6Z
2018-09-25T18:55:30.654Z,1537901730.654 [Default:CheckIn:Read_GPS] Stopped
2018-09-25T18:55:30.654Z,1537901730.654 [Default:CheckIn:Read_Iridium] Running Loop=1
2018-09-25T18:55:34.400Z,1537901734.400 [DataOverHttps](INFO): Sending 25 bytes from file Logs/20180925T183401/Courier0007.lzma
2018-09-25T18:55:35.172Z,1537901735.172 [DataOverHttps](INFO): Moved sent file to Logs/20180925T183401/Courier0007.lzma.bak
2018-09-25T18:55:35.172Z,1537901735.172 [DataOverHttps](INFO): SBD MOMSN=8586708
2018-09-25T18:55:35.779Z,1537901735.779 [RDI_Pathfinder](ERROR): Failed to parse:
:BS,-32768,-32768,-32768,V
2018-09-25T18:55:44.148Z,1537901744.148 [DataOverHttps](INFO): Sending 180 bytes from file Logs/20180925T183401/Express0008.lzma
2018-09-25T18:55:44.538Z,1537901744.538 [NAL9602](FAULT): GPS failed to acquire within timeout.
2018-09-25T18:55:44.539Z,1537901744.539 [NAL9602] Data Fault, FailCount= 2
2018-09-25T18:55:44.539Z,1537901744.539 [NAL9602](ERROR): Data Fault
2018-09-25T18:55:44.656Z,1537901744.656 [CBIT](ERROR): Data Fault in component: NAL9602
2018-09-25T18:55:44.924Z,1537901744.924 [DataOverHttps](INFO): Moved sent file to Logs/20180925T183401/Express0008.lzma.bak
2018-09-25T18:55:44.924Z,1537901744.924 [DataOverHttps](INFO): SBD MOMSN=8586710
2018-09-25T18:55:44.931Z,1537901744.931 [NAL9602](INFO): Powering down
2018-09-25T18:55:45.784Z,1537901745.784 [Default:CheckIn:Read_Iridium] Stopped
2018-09-25T18:55:45.784Z,1537901745.784 [Default:CheckIn:C.Wait] Running Loop=1
2018-09-25T18:55:45.784Z,1537901745.784 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2018-09-25T18:55:45.950Z,1537901745.950 [CBIT](INFO): Clearing failed state for component NAL9602
2018-09-25T18:55:45.950Z,1537901745.950 [NAL9602] No Fault, FailCount= 2
2018-09-25T18:56:14.947Z,1537901774.947 [NAL9602](INFO): Powering up NAL9602
2018-09-25T18:56:26.151Z,1537901786.151 [NAL9602](INFO): NAL9602 initialized
2018-09-25T18:56:50.694Z,1537901810.694 [RDI_Pathfinder](ERROR): Failed to parse:
:HM,G,D,0e8c,0ffd, 15.826, -0.004, 0.000
2018-09-25T18:58:27.606Z,1537901907.606 [DeadReckonUsingMultipleVelocitySources](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2018-09-25T18:58:27.606Z,1537901907.606 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 8
2018-09-25T18:58:27.606Z,1537901907.606 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2018-09-25T18:58:27.608Z,1537901907.608 [DeadReckonUsingSpeedCalculator](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2018-09-25T18:58:27.608Z,1537901907.608 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 8
2018-09-25T18:58:27.608Z,1537901907.608 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2018-09-25T18:58:27.637Z,1537901907.637 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2018-09-25T18:58:27.638Z,1537901907.638 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2018-09-25T18:58:28.015Z,1537901908.015 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2018-09-25T18:58:28.015Z,1537901908.015 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 8
2018-09-25T18:58:28.015Z,1537901908.015 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2018-09-25T18:58:28.015Z,1537901908.015 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 8
2018-09-25T18:58:28.406Z,1537901908.406 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2018-09-25T18:58:28.407Z,1537901908.407 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2018-09-25T18:58:28.407Z,1537901908.407 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2018-09-25T18:58:28.407Z,1537901908.407 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2018-09-25T18:58:28.408Z,1537901908.408 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2018-09-25T18:58:28.408Z,1537901908.408 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2018-09-25T18:59:38.454Z,1537901978.454 [RDI_Pathfinder](ERROR): Failed to parse:
:BI,-32768,-32768,-32768,-32768,V
2018-09-25T19:00:46.153Z,1537902046.153 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2018-09-25T19:00:46.153Z,1537902046.153 [Default:CheckIn:C.Wait] Stopped
2018-09-25T19:00:46.153Z,1537902046.153 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2018-09-25T19:00:46.154Z,1537902046.154 [Default:CheckIn:D] Running Loop=1
2018-09-25T19:00:46.562Z,1537902046.562 [Default:CheckIn:D] Stopped
2018-09-25T19:00:46.562Z,1537902046.562 [Default:CheckIn:E] Running Loop=1
2018-09-25T19:00:51.306Z,1537902051.306 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 21.268640 min 
2018-09-25T19:00:51.307Z,1537902051.307 [Default:CheckIn:E] Stopped
2018-09-25T19:00:51.307Z,1537902051.307 [Default:CheckIn](INFO): Completed Default:CheckIn
2018-09-25T19:00:51.307Z,1537902051.307 [Default:CheckIn] Stopped
2018-09-25T19:00:51.307Z,1537902051.307 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2018-09-25T19:00:51.307Z,1537902051.307 [Default:CheckIn](INFO): Running loop #3
2018-09-25T19:00:51.307Z,1537902051.307 [Default:CheckIn] Running Loop=3
2018-09-25T19:00:51.307Z,1537902051.307 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2018-09-25T19:00:51.308Z,1537902051.308 [Default:CheckIn:Read_GPS] Running Loop=1
2018-09-25T19:01:28.629Z,1537902088.629 [DeadReckonUsingMultipleVelocitySources](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2018-09-25T19:01:28.629Z,1537902088.629 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 9
2018-09-25T19:01:28.629Z,1537902088.629 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2018-09-25T19:01:28.631Z,1537902088.631 [DeadReckonUsingSpeedCalculator](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2018-09-25T19:01:28.631Z,1537902088.631 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 9
2018-09-25T19:01:28.631Z,1537902088.631 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2018-09-25T19:01:28.644Z,1537902088.644 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2018-09-25T19:01:28.661Z,1537902088.661 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2018-09-25T19:01:29.026Z,1537902089.026 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2018-09-25T19:01:29.027Z,1537902089.027 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 9
2018-09-25T19:01:29.027Z,1537902089.027 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2018-09-25T19:01:29.027Z,1537902089.027 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 9
2018-09-25T19:01:29.431Z,1537902089.431 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2018-09-25T19:01:29.432Z,1537902089.432 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2018-09-25T19:01:29.432Z,1537902089.432 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2018-09-25T19:01:29.432Z,1537902089.432 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2018-09-25T19:01:29.434Z,1537902089.434 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2018-09-25T19:01:29.434Z,1537902089.434 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2018-09-25T19:02:26.687Z,1537902146.687 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error
2018-09-25T19:02:26.687Z,1537902146.687 [RDI_Pathfinder](ERROR): Failed to parse:
:TS,18092512080562,35.0, -0.1,   0.0,1448.9,,-32768,-32768,-32768,-32768,V
2018-09-25T19:04:29.706Z,1537902269.706 [DeadReckonUsingMultipleVelocitySources](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2018-09-25T19:04:29.706Z,1537902269.706 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 10
2018-09-25T19:04:29.706Z,1537902269.706 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2018-09-25T19:04:29.708Z,1537902269.708 [DeadReckonUsingSpeedCalculator](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2018-09-25T19:04:29.708Z,1537902269.708 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 10
2018-09-25T19:04:29.708Z,1537902269.708 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2018-09-25T19:04:29.730Z,1537902269.730 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2018-09-25T19:04:29.730Z,1537902269.730 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2018-09-25T19:04:30.111Z,1537902270.111 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2018-09-25T19:04:30.111Z,1537902270.111 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 10
2018-09-25T19:04:30.111Z,1537902270.111 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2018-09-25T19:04:30.111Z,1537902270.111 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 10
2018-09-25T19:04:30.526Z,1537902270.526 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2018-09-25T19:04:30.526Z,1537902270.526 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2018-09-25T19:04:30.526Z,1537902270.526 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2018-09-25T19:04:30.527Z,1537902270.527 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2018-09-25T19:04:30.527Z,1537902270.527 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2018-09-25T19:04:30.528Z,1537902270.528 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2018-09-25T19:05:52.504Z,1537902352.504 [Default:CheckIn:Read_GPS](INFO): Timed out from 2018-09-25T19:00:51.3Z
2018-09-25T19:05:52.504Z,1537902352.504 [Default:CheckIn:Read_GPS] Stopped
2018-09-25T19:05:52.504Z,1537902352.504 [Default:CheckIn:Read_Iridium] Running Loop=1
2018-09-25T19:05:57.435Z,1537902357.435 [DataOverHttps](INFO): Sending 25 bytes from file Logs/20180925T183401/Courier0010.lzma
2018-09-25T19:05:58.200Z,1537902358.200 [DataOverHttps](INFO): Moved sent file to Logs/20180925T183401/Courier0010.lzma.bak
2018-09-25T19:05:58.200Z,1537902358.200 [DataOverHttps](INFO): SBD MOMSN=8586794
2018-09-25T19:06:11.238Z,1537902371.238 [DataOverHttps](INFO): Sending 149 bytes from file Logs/20180925T183401/Express0011.lzma
2018-09-25T19:06:12.019Z,1537902372.019 [DataOverHttps](INFO): Moved sent file to Logs/20180925T183401/Express0011.lzma.bak
2018-09-25T19:06:12.020Z,1537902372.020 [DataOverHttps](INFO): SBD MOMSN=8586796
2018-09-25T19:06:12.658Z,1537902372.658 [Default:CheckIn:Read_Iridium] Stopped
2018-09-25T19:06:12.658Z,1537902372.658 [Default:CheckIn:C.Wait] Running Loop=1
2018-09-25T19:06:12.659Z,1537902372.659 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2018-09-25T19:06:27.683Z,1537902387.683 [NAL9602](FAULT): GPS failed to acquire within timeout.
2018-09-25T19:06:27.683Z,1537902387.683 [NAL9602] Data Fault, FailCount= 3
2018-09-25T19:06:27.683Z,1537902387.683 [NAL9602](ERROR): Data Fault
2018-09-25T19:06:27.764Z,1537902387.764 [CBIT](ERROR): Data Fault in component: NAL9602
2018-09-25T19:06:28.083Z,1537902388.083 [NAL9602](INFO): Powering down
2018-09-25T19:06:28.946Z,1537902388.946 [CBIT](INFO): Clearing failed state for component NAL9602
2018-09-25T19:06:28.946Z,1537902388.946 [NAL9602] No Fault, FailCount= 3
2018-09-25T19:06:58.487Z,1537902418.487 [NAL9602](INFO): Powering up NAL9602
2018-09-25T19:07:09.693Z,1537902429.693 [NAL9602](INFO): NAL9602 initialized
2018-09-25T19:07:30.611Z,1537902450.611 [DeadReckonUsingMultipleVelocitySources](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2018-09-25T19:07:30.611Z,1537902450.611 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 11
2018-09-25T19:07:30.612Z,1537902450.612 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2018-09-25T19:07:30.613Z,1537902450.613 [DeadReckonUsingSpeedCalculator](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2018-09-25T19:07:30.614Z,1537902450.614 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 11
2018-09-25T19:07:30.614Z,1537902450.614 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2018-09-25T19:07:30.635Z,1537902450.635 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2018-09-25T19:07:30.635Z,1537902450.635 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2018-09-25T19:07:31.022Z,1537902451.022 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2018-09-25T19:07:31.022Z,1537902451.022 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 11
2018-09-25T19:07:31.023Z,1537902451.023 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2018-09-25T19:07:31.023Z,1537902451.023 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 11
2018-09-25T19:07:31.396Z,1537902451.396 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2018-09-25T19:07:31.397Z,1537902451.397 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2018-09-25T19:07:31.398Z,1537902451.398 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2018-09-25T19:07:31.398Z,1537902451.398 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2018-09-25T19:07:31.398Z,1537902451.398 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2018-09-25T19:07:31.399Z,1537902451.399 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2018-09-25T19:10:21.666Z,1537902621.666 [RDI_Pathfinder](ERROR): Failed to parse:
:BE,-32768,-32768,-32768,V
2018-09-25T19:10:31.684Z,1537902631.684 [DeadReckonUsingMultipleVelocitySources](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2018-09-25T19:10:31.685Z,1537902631.685 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 12
2018-09-25T19:10:31.685Z,1537902631.685 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2018-09-25T19:10:31.687Z,1537902631.687 [DeadReckonUsingSpeedCalculator](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2018-09-25T19:10:31.687Z,1537902631.687 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 12
2018-09-25T19:10:31.687Z,1537902631.687 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2018-09-25T19:10:31.712Z,1537902631.712 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2018-09-25T19:10:31.717Z,1537902631.717 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2018-09-25T19:10:32.070Z,1537902632.070 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2018-09-25T19:10:32.070Z,1537902632.070 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 12
2018-09-25T19:10:32.071Z,1537902632.071 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2018-09-25T19:10:32.071Z,1537902632.071 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 12
2018-09-25T19:10:32.434Z,1537902632.434 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2018-09-25T19:10:32.435Z,1537902632.435 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2018-09-25T19:10:32.435Z,1537902632.435 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2018-09-25T19:10:32.435Z,1537902632.435 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2018-09-25T19:10:32.436Z,1537902632.436 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2018-09-25T19:10:32.436Z,1537902632.436 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2018-09-25T19:11:12.878Z,1537902672.878 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2018-09-25T19:11:12.878Z,1537902672.878 [Default:CheckIn:C.Wait] Stopped
2018-09-25T19:11:12.878Z,1537902672.878 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2018-09-25T19:11:12.878Z,1537902672.878 [Default:CheckIn:D] Running Loop=1
2018-09-25T19:11:13.251Z,1537902673.251 [Default:CheckIn:D] Stopped
2018-09-25T19:11:13.251Z,1537902673.251 [Default:CheckIn:E] Running Loop=1
2018-09-25T19:11:13.673Z,1537902673.673 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 31.713452 min 
2018-09-25T19:11:13.673Z,1537902673.673 [Default:CheckIn:E] Stopped
2018-09-25T19:11:13.674Z,1537902673.674 [Default:CheckIn](INFO): Completed Default:CheckIn
2018-09-25T19:11:13.674Z,1537902673.674 [Default:CheckIn] Stopped
2018-09-25T19:11:13.674Z,1537902673.674 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2018-09-25T19:11:13.674Z,1537902673.674 [Default:CheckIn](INFO): Running loop #4
2018-09-25T19:11:13.674Z,1537902673.674 [Default:CheckIn] Running Loop=4
2018-09-25T19:11:13.674Z,1537902673.674 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2018-09-25T19:11:13.674Z,1537902673.674 [Default:CheckIn:Read_GPS] Running Loop=1
2018-09-25T19:13:03.045Z,1537902783.045 [RDI_Pathfinder](ERROR): Failed to parse:
:B,-32768,-32768,-32768,V
2018-09-25T19:13:32.759Z,1537902812.759 [DeadReckonUsingMultipleVelocitySources](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2018-09-25T19:13:32.759Z,1537902812.759 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 13
2018-09-25T19:13:32.759Z,1537902812.759 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2018-09-25T19:13:32.765Z,1537902812.765 [DeadReckonUsingSpeedCalculator](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2018-09-25T19:13:32.765Z,1537902812.765 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 13
2018-09-25T19:13:32.765Z,1537902812.765 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2018-09-25T19:13:32.790Z,1537902812.790 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2018-09-25T19:13:32.791Z,1537902812.791 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2018-09-25T19:13:33.169Z,1537902813.169 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2018-09-25T19:13:33.169Z,1537902813.169 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 13
2018-09-25T19:13:33.170Z,1537902813.170 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2018-09-25T19:13:33.170Z,1537902813.170 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 13
2018-09-25T19:13:33.557Z,1537902813.557 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2018-09-25T19:13:33.557Z,1537902813.557 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2018-09-25T19:13:33.558Z,1537902813.558 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2018-09-25T19:13:33.558Z,1537902813.558 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2018-09-25T19:13:33.559Z,1537902813.559 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2018-09-25T19:13:33.559Z,1537902813.559 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2018-09-25T19:16:13.710Z,1537902973.710 [Default:CheckIn:Read_GPS](INFO): Timed out from 2018-09-25T19:11:13.7Z
2018-09-25T19:16:13.710Z,1537902973.710 [Default:CheckIn:Read_GPS] Stopped
2018-09-25T19:16:13.710Z,1537902973.710 [Default:CheckIn:Read_Iridium] Running Loop=1
2018-09-25T19:16:17.474Z,1537902977.474 [DataOverHttps](INFO): Sending 25 bytes from file Logs/20180925T183401/Courier0013.lzma
2018-09-25T19:16:18.224Z,1537902978.224 [DataOverHttps](INFO): Moved sent file to Logs/20180925T183401/Courier0013.lzma.bak
2018-09-25T19:16:18.224Z,1537902978.224 [DataOverHttps](INFO): SBD MOMSN=8586887
2018-09-25T19:16:27.298Z,1537902987.298 [DataOverHttps](INFO): Sending 149 bytes from file Logs/20180925T183401/Express0014.lzma
2018-09-25T19:16:28.052Z,1537902988.052 [DataOverHttps](INFO): Moved sent file to Logs/20180925T183401/Express0014.lzma.bak
2018-09-25T19:16:28.052Z,1537902988.052 [DataOverHttps](INFO): SBD MOMSN=8586889
2018-09-25T19:16:28.682Z,1537902988.682 [Default:CheckIn:Read_Iridium] Stopped
2018-09-25T19:16:28.683Z,1537902988.683 [Default:CheckIn:C.Wait] Running Loop=1
2018-09-25T19:16:28.683Z,1537902988.683 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2018-09-25T19:16:33.795Z,1537902993.795 [DeadReckonUsingMultipleVelocitySources](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2018-09-25T19:16:33.795Z,1537902993.795 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 14
2018-09-25T19:16:33.795Z,1537902993.795 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2018-09-25T19:16:33.801Z,1537902993.801 [DeadReckonUsingSpeedCalculator](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2018-09-25T19:16:33.801Z,1537902993.801 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 14
2018-09-25T19:16:33.801Z,1537902993.801 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2018-09-25T19:16:33.821Z,1537902993.821 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2018-09-25T19:16:33.822Z,1537902993.822 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2018-09-25T19:16:34.226Z,1537902994.226 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2018-09-25T19:16:34.226Z,1537902994.226 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 14
2018-09-25T19:16:34.227Z,1537902994.227 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2018-09-25T19:16:34.227Z,1537902994.227 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 14
2018-09-25T19:16:34.619Z,1537902994.619 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2018-09-25T19:16:34.619Z,1537902994.619 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2018-09-25T19:16:34.620Z,1537902994.620 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2018-09-25T19:16:34.620Z,1537902994.620 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2018-09-25T19:16:34.620Z,1537902994.620 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2018-09-25T19:16:34.625Z,1537902994.625 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2018-09-25T19:17:10.563Z,1537903030.563 [NAL9602](FAULT): GPS failed to acquire within timeout.
2018-09-25T19:17:10.563Z,1537903030.563 [NAL9602] Data Fault, FailCount= 4
2018-09-25T19:17:10.563Z,1537903030.563 [NAL9602](ERROR): Data Fault
2018-09-25T19:17:10.644Z,1537903030.644 [CBIT](ERROR): Data Fault in component: NAL9602
2018-09-25T19:17:10.959Z,1537903030.959 [NAL9602](INFO): Powering down
2018-09-25T19:17:11.836Z,1537903031.836 [CBIT](INFO): Clearing failed state for component NAL9602
2018-09-25T19:17:11.836Z,1537903031.836 [NAL9602] No Fault, FailCount= 4
2018-09-25T19:17:41.047Z,1537903061.047 [NAL9602](INFO): Powering up NAL9602
2018-09-25T19:17:52.247Z,1537903072.247 [NAL9602](INFO): NAL9602 initialized
2018-09-25T19:19:34.855Z,1537903174.855 [DeadReckonUsingMultipleVelocitySources](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2018-09-25T19:19:34.855Z,1537903174.855 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 15
2018-09-25T19:19:34.855Z,1537903174.855 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2018-09-25T19:19:34.861Z,1537903174.861 [DeadReckonUsingSpeedCalculator](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2018-09-25T19:19:34.861Z,1537903174.861 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 15
2018-09-25T19:19:34.861Z,1537903174.861 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2018-09-25T19:19:34.883Z,1537903174.883 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2018-09-25T19:19:34.883Z,1537903174.883 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2018-09-25T19:19:35.308Z,1537903175.308 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2018-09-25T19:19:35.308Z,1537903175.308 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 15
2018-09-25T19:19:35.313Z,1537903175.313 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2018-09-25T19:19:35.313Z,1537903175.313 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 15
2018-09-25T19:19:35.648Z,1537903175.648 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2018-09-25T19:19:35.665Z,1537903175.665 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2018-09-25T19:19:35.666Z,1537903175.666 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2018-09-25T19:19:35.666Z,1537903175.666 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2018-09-25T19:19:35.666Z,1537903175.666 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2018-09-25T19:19:35.667Z,1537903175.667 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2018-09-25T19:21:28.951Z,1537903288.951 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2018-09-25T19:21:28.951Z,1537903288.951 [Default:CheckIn:C.Wait] Stopped
2018-09-25T19:21:28.951Z,1537903288.951 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2018-09-25T19:21:28.951Z,1537903288.951 [Default:CheckIn:D] Running Loop=1
2018-09-25T19:21:29.370Z,1537903289.370 [Default:CheckIn:D] Stopped
2018-09-25T19:21:29.370Z,1537903289.370 [Default:CheckIn:E] Running Loop=1
2018-09-25T19:21:29.790Z,1537903289.790 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 41.982096 min 
2018-09-25T19:21:29.790Z,1537903289.790 [Default:CheckIn:E] Stopped
2018-09-25T19:21:29.791Z,1537903289.791 [Default:CheckIn](INFO): Completed Default:CheckIn
2018-09-25T19:21:29.791Z,1537903289.791 [Default:CheckIn] Stopped
2018-09-25T19:21:29.791Z,1537903289.791 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2018-09-25T19:21:29.791Z,1537903289.791 [Default:CheckIn](INFO): Running loop #5
2018-09-25T19:21:29.791Z,1537903289.791 [Default:CheckIn] Running Loop=5
2018-09-25T19:21:29.791Z,1537903289.791 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2018-09-25T19:21:29.791Z,1537903289.791 [Default:CheckIn:Read_GPS] Running Loop=1
2018-09-25T19:22:35.932Z,1537903355.932 [DeadReckonUsingMultipleVelocitySources](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2018-09-25T19:22:35.932Z,1537903355.932 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 16
2018-09-25T19:22:35.932Z,1537903355.932 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2018-09-25T19:22:35.934Z,1537903355.934 [DeadReckonUsingSpeedCalculator](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2018-09-25T19:22:35.934Z,1537903355.934 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 16
2018-09-25T19:22:35.934Z,1537903355.934 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2018-09-25T19:22:35.959Z,1537903355.959 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2018-09-25T19:22:35.960Z,1537903355.960 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2018-09-25T19:22:36.386Z,1537903356.386 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2018-09-25T19:22:36.386Z,1537903356.386 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 16
2018-09-25T19:22:36.387Z,1537903356.387 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2018-09-25T19:22:36.387Z,1537903356.387 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 16
2018-09-25T19:22:36.730Z,1537903356.730 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2018-09-25T19:22:36.730Z,1537903356.730 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2018-09-25T19:22:36.731Z,1537903356.731 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2018-09-25T19:22:36.731Z,1537903356.731 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2018-09-25T19:22:36.731Z,1537903356.731 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2018-09-25T19:22:36.732Z,1537903356.732 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2018-09-25T19:25:37.031Z,1537903537.031 [DeadReckonUsingMultipleVelocitySources](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2018-09-25T19:25:37.031Z,1537903537.031 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 17
2018-09-25T19:25:37.031Z,1537903537.031 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2018-09-25T19:25:37.045Z,1537903537.045 [DeadReckonUsingSpeedCalculator](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2018-09-25T19:25:37.046Z,1537903537.046 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 17
2018-09-25T19:25:37.046Z,1537903537.046 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2018-09-25T19:25:37.075Z,1537903537.075 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2018-09-25T19:25:37.075Z,1537903537.075 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2018-09-25T19:25:37.485Z,1537903537.485 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2018-09-25T19:25:37.485Z,1537903537.485 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 17
2018-09-25T19:25:37.486Z,1537903537.486 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2018-09-25T19:25:37.486Z,1537903537.486 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 17
2018-09-25T19:25:37.849Z,1537903537.849 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2018-09-25T19:25:37.850Z,1537903537.850 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2018-09-25T19:25:37.850Z,1537903537.850 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2018-09-25T19:25:37.851Z,1537903537.851 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2018-09-25T19:25:37.851Z,1537903537.851 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2018-09-25T19:25:37.851Z,1537903537.851 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2018-09-25T19:26:29.862Z,1537903589.862 [Default:CheckIn:Read_GPS](INFO): Timed out from 2018-09-25T19:21:29.8Z
2018-09-25T19:26:29.862Z,1537903589.862 [Default:CheckIn:Read_GPS] Stopped
2018-09-25T19:26:29.862Z,1537903589.862 [Default:CheckIn:Read_Iridium] Running Loop=1
2018-09-25T19:26:33.597Z,1537903593.597 [DataOverHttps](INFO): Sending 25 bytes from file Logs/20180925T183401/Courier0016.lzma
2018-09-25T19:26:34.368Z,1537903594.368 [DataOverHttps](INFO): Moved sent file to Logs/20180925T183401/Courier0016.lzma.bak
2018-09-25T19:26:34.368Z,1537903594.368 [DataOverHttps](INFO): SBD MOMSN=8586988
2018-09-25T19:26:43.381Z,1537903603.381 [DataOverHttps](INFO): Sending 152 bytes from file Logs/20180925T183401/Express0017.lzma
2018-09-25T19:26:44.228Z,1537903604.228 [DataOverHttps](INFO): Moved sent file to Logs/20180925T183401/Express0017.lzma.bak
2018-09-25T19:26:44.228Z,1537903604.228 [DataOverHttps](INFO): SBD MOMSN=8586990
2018-09-25T19:26:44.299Z,1537903604.299 [RDI_Pathfinder](ERROR): Failed to parse:
:HM,G,D,0e8c,0ffd, 15.847, -0.010, 0.000
2018-09-25T19:26:44.856Z,1537903604.856 [Default:CheckIn:Read_Iridium] Stopped
2018-09-25T19:26:44.857Z,1537903604.857 [Default:CheckIn:C.Wait] Running Loop=1
2018-09-25T19:26:44.857Z,1537903604.857 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2018-09-25T19:27:53.887Z,1537903673.887 [NAL9602](FAULT): GPS failed to acquire within timeout.
2018-09-25T19:27:53.887Z,1537903673.887 [NAL9602] Data Fault, FailCount= 5
2018-09-25T19:27:53.887Z,1537903673.887 [NAL9602](ERROR): Data Fault
2018-09-25T19:27:53.957Z,1537903673.957 [CBIT](ERROR): Data Fault in component: NAL9602
2018-09-25T19:27:53.957Z,1537903673.957 [CBIT](CRITICAL): Data Fault in component: NAL9602
2018-09-25T19:27:54.298Z,1537903674.298 [NAL9602](INFO): Powering down
2018-09-25T19:27:54.369Z,1537903674.369 [CommandLine](FAULT): Scheduling is paused
2018-09-25T19:27:54.369Z,1537903674.369 [CBIT](INFO): Critical error at 20180925T192753
2018-09-25T19:28:37.911Z,1537903717.911 [DeadReckonUsingMultipleVelocitySources](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2018-09-25T19:28:37.911Z,1537903717.911 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 18
2018-09-25T19:28:37.911Z,1537903717.911 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2018-09-25T19:28:37.917Z,1537903717.917 [DeadReckonUsingSpeedCalculator](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2018-09-25T19:28:37.917Z,1537903717.917 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 18
2018-09-25T19:28:37.917Z,1537903717.917 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2018-09-25T19:28:37.936Z,1537903717.936 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2018-09-25T19:28:37.936Z,1537903717.936 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2018-09-25T19:28:38.374Z,1537903718.374 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2018-09-25T19:28:38.374Z,1537903718.374 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 18
2018-09-25T19:28:38.374Z,1537903718.374 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2018-09-25T19:28:38.374Z,1537903718.374 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 18
2018-09-25T19:28:38.718Z,1537903718.718 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2018-09-25T19:28:38.718Z,1537903718.718 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2018-09-25T19:28:38.719Z,1537903718.719 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2018-09-25T19:28:38.719Z,1537903718.719 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2018-09-25T19:28:38.720Z,1537903718.720 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2018-09-25T19:28:38.720Z,1537903718.720 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2018-09-25T19:29:54.146Z,1537903794.146 [CBIT](INFO): Clearing failed state for component NAL9602
2018-09-25T19:29:54.146Z,1537903794.146 [NAL9602] No Fault, FailCount= 5
2018-09-25T19:29:54.477Z,1537903794.477 [NAL9602](INFO): Powering up NAL9602
2018-09-25T19:30:05.299Z,1537903805.299 [NAL9602](INFO): NAL9602 initialized
2018-09-25T19:31:39.075Z,1537903899.075 [DeadReckonUsingMultipleVelocitySources](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2018-09-25T19:31:39.076Z,1537903899.076 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 19
2018-09-25T19:31:39.076Z,1537903899.076 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2018-09-25T19:31:39.082Z,1537903899.082 [DeadReckonUsingSpeedCalculator](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2018-09-25T19:31:39.082Z,1537903899.082 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 19
2018-09-25T19:31:39.082Z,1537903899.082 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2018-09-25T19:31:39.111Z,1537903899.111 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2018-09-25T19:31:39.112Z,1537903899.112 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2018-09-25T19:31:39.532Z,1537903899.532 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2018-09-25T19:31:39.533Z,1537903899.533 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 19
2018-09-25T19:31:39.537Z,1537903899.537 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2018-09-25T19:31:39.537Z,1537903899.537 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 19
2018-09-25T19:31:39.882Z,1537903899.882 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2018-09-25T19:31:39.882Z,1537903899.882 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2018-09-25T19:31:39.883Z,1537903899.883 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2018-09-25T19:31:39.883Z,1537903899.883 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2018-09-25T19:31:39.884Z,1537903899.884 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2018-09-25T19:31:39.884Z,1537903899.884 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2018-09-25T19:31:45.072Z,1537903905.072 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2018-09-25T19:31:45.073Z,1537903905.073 [Default:CheckIn:C.Wait] Stopped
2018-09-25T19:31:45.089Z,1537903905.089 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2018-09-25T19:31:45.089Z,1537903905.089 [Default:CheckIn:D] Running Loop=1
2018-09-25T19:31:45.508Z,1537903905.508 [Default:CheckIn:D] Stopped
2018-09-25T19:31:45.508Z,1537903905.508 [Default:CheckIn:E] Running Loop=1
2018-09-25T19:31:45.901Z,1537903905.901 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 52.251066 min 
2018-09-25T19:31:45.901Z,1537903905.901 [Default:CheckIn:E] Stopped
2018-09-25T19:31:45.902Z,1537903905.902 [Default:CheckIn](INFO): Completed Default:CheckIn
2018-09-25T19:31:45.902Z,1537903905.902 [Default:CheckIn] Stopped
2018-09-25T19:31:45.902Z,1537903905.902 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2018-09-25T19:31:45.902Z,1537903905.902 [Default:CheckIn](INFO): Running loop #6
2018-09-25T19:31:45.902Z,1537903905.902 [Default:CheckIn] Running Loop=6
2018-09-25T19:31:45.902Z,1537903905.902 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2018-09-25T19:31:45.902Z,1537903905.902 [Default:CheckIn:Read_GPS] Running Loop=1
2018-09-25T19:34:40.132Z,1537904080.132 [DeadReckonUsingMultipleVelocitySources](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2018-09-25T19:34:40.132Z,1537904080.132 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 20
2018-09-25T19:34:40.132Z,1537904080.132 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2018-09-25T19:34:40.134Z,1537904080.134 [DeadReckonUsingSpeedCalculator](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2018-09-25T19:34:40.134Z,1537904080.134 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 20
2018-09-25T19:34:40.134Z,1537904080.134 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2018-09-25T19:34:40.148Z,1537904080.148 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2018-09-25T19:34:40.148Z,1537904080.148 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2018-09-25T19:34:40.572Z,1537904080.572 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2018-09-25T19:34:40.572Z,1537904080.572 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 20
2018-09-25T19:34:40.572Z,1537904080.572 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2018-09-25T19:34:40.572Z,1537904080.572 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 20
2018-09-25T19:34:40.942Z,1537904080.942 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2018-09-25T19:34:40.942Z,1537904080.942 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2018-09-25T19:34:40.943Z,1537904080.943 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2018-09-25T19:34:40.943Z,1537904080.943 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2018-09-25T19:34:40.944Z,1537904080.944 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2018-09-25T19:34:40.944Z,1537904080.944 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2018-09-25T19:34:50.599Z,1537904090.599 [RDI_Pathfinder](ERROR): Failed to parse:
:BE,-32768,-32768,-32768,V
2018-09-25T19:36:45.917Z,1537904205.917 [Default:CheckIn:Read_GPS](INFO): Timed out from 2018-09-25T19:31:45.9Z
2018-09-25T19:36:45.918Z,1537904205.918 [Default:CheckIn:Read_GPS] Stopped
2018-09-25T19:36:45.918Z,1537904205.918 [Default:CheckIn:Read_Iridium] Running Loop=1
2018-09-25T19:36:49.648Z,1537904209.648 [DataOverHttps](INFO): Sending 93 bytes from file Logs/20180925T183401/Courier0019.lzma
2018-09-25T19:36:50.439Z,1537904210.439 [DataOverHttps](INFO): Moved sent file to Logs/20180925T183401/Courier0019.lzma.bak
2018-09-25T19:36:50.443Z,1537904210.443 [DataOverHttps](INFO): SBD MOMSN=8587073
2018-09-25T19:36:59.505Z,1537904219.505 [DataOverHttps](INFO): Sending 171 bytes from file Logs/20180925T183401/Express0020.lzma
2018-09-25T19:37:00.280Z,1537904220.280 [DataOverHttps](INFO): Moved sent file to Logs/20180925T183401/Express0020.lzma.bak
2018-09-25T19:37:00.280Z,1537904220.280 [DataOverHttps](INFO): SBD MOMSN=8587076
2018-09-25T19:37:00.927Z,1537904220.927 [Default:CheckIn:Read_Iridium] Stopped
2018-09-25T19:37:00.927Z,1537904220.927 [Default:CheckIn:C.Wait] Running Loop=1
2018-09-25T19:37:00.927Z,1537904220.927 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2018-09-25T19:37:41.263Z,1537904261.263 [DeadReckonUsingMultipleVelocitySources](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2018-09-25T19:37:41.263Z,1537904261.263 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 21
2018-09-25T19:37:41.263Z,1537904261.263 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2018-09-25T19:37:41.265Z,1537904261.265 [DeadReckonUsingSpeedCalculator](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2018-09-25T19:37:41.265Z,1537904261.265 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 21
2018-09-25T19:37:41.265Z,1537904261.265 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2018-09-25T19:37:41.278Z,1537904261.278 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2018-09-25T19:37:41.278Z,1537904261.278 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2018-09-25T19:37:41.680Z,1537904261.680 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2018-09-25T19:37:41.680Z,1537904261.680 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 21
2018-09-25T19:37:41.681Z,1537904261.681 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2018-09-25T19:37:41.681Z,1537904261.681 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 21
2018-09-25T19:37:42.042Z,1537904262.042 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2018-09-25T19:37:42.042Z,1537904262.042 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2018-09-25T19:37:42.043Z,1537904262.043 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2018-09-25T19:37:42.043Z,1537904262.043 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2018-09-25T19:37:42.043Z,1537904262.043 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2018-09-25T19:37:42.044Z,1537904262.044 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2018-09-25T19:39:58.666Z,1537904398.666 [RDI_Pathfinder](ERROR): Failed to parse:
68,-32768,-32768,-32768,V
2018-09-25T19:40:07.139Z,1537904407.139 [NAL9602](FAULT): GPS failed to acquire within timeout.
2018-09-25T19:40:07.139Z,1537904407.139 [NAL9602] Data Fault, FailCount= 1
2018-09-25T19:40:07.139Z,1537904407.139 [NAL9602](ERROR): Data Fault
2018-09-25T19:40:07.199Z,1537904407.199 [CBIT](ERROR): Data Fault in component: NAL9602
2018-09-25T19:40:07.543Z,1537904407.543 [NAL9602](INFO): Powering down
2018-09-25T19:40:08.418Z,1537904408.418 [CBIT](INFO): Clearing failed state for component NAL9602
2018-09-25T19:40:08.419Z,1537904408.419 [NAL9602] No Fault, FailCount= 1
2018-09-25T19:40:37.947Z,1537904437.947 [NAL9602](INFO): Powering up NAL9602
2018-09-25T19:40:42.387Z,1537904442.387 [DeadReckonUsingMultipleVelocitySources](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2018-09-25T19:40:42.387Z,1537904442.387 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 22
2018-09-25T19:40:42.387Z,1537904442.387 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2018-09-25T19:40:42.394Z,1537904442.394 [DeadReckonUsingSpeedCalculator](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2018-09-25T19:40:42.394Z,1537904442.394 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 22
2018-09-25T19:40:42.394Z,1537904442.394 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2018-09-25T19:40:42.457Z,1537904442.457 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2018-09-25T19:40:42.458Z,1537904442.458 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2018-09-25T19:40:42.887Z,1537904442.887 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2018-09-25T19:40:42.887Z,1537904442.887 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 22
2018-09-25T19:40:42.888Z,1537904442.888 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2018-09-25T19:40:42.888Z,1537904442.888 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 22
2018-09-25T19:40:43.202Z,1537904443.202 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2018-09-25T19:40:43.202Z,1537904443.202 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2018-09-25T19:40:43.203Z,1537904443.203 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2018-09-25T19:40:43.203Z,1537904443.203 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2018-09-25T19:40:43.203Z,1537904443.203 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2018-09-25T19:40:43.204Z,1537904443.204 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2018-09-25T19:40:49.139Z,1537904449.139 [NAL9602](INFO): NAL9602 initialized
2018-09-25T19:42:01.242Z,1537904521.242 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2018-09-25T19:42:01.242Z,1537904521.242 [Default:CheckIn:C.Wait] Stopped
2018-09-25T19:42:01.243Z,1537904521.243 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2018-09-25T19:42:01.243Z,1537904521.243 [Default:CheckIn:D] Running Loop=1
2018-09-25T19:42:01.684Z,1537904521.684 [Default:CheckIn:D] Stopped
2018-09-25T19:42:01.684Z,1537904521.684 [Default:CheckIn:E] Running Loop=1
2018-09-25T19:42:02.066Z,1537904522.066 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 62.520671 min 
2018-09-25T19:42:02.067Z,1537904522.067 [Default:CheckIn:E] Stopped
2018-09-25T19:42:02.067Z,1537904522.067 [Default:CheckIn](INFO): Completed Default:CheckIn
2018-09-25T19:42:02.067Z,1537904522.067 [Default:CheckIn] Stopped
2018-09-25T19:42:02.067Z,1537904522.067 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2018-09-25T19:42:02.067Z,1537904522.067 [Default:CheckIn](INFO): Running loop #7
2018-09-25T19:42:02.067Z,1537904522.067 [Default:CheckIn] Running Loop=7
2018-09-25T19:42:02.068Z,1537904522.068 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2018-09-25T19:42:02.068Z,1537904522.068 [Default:CheckIn:Read_GPS] Running Loop=1
2018-09-25T19:42:06.543Z,1537904526.543 [RDI_Pathfinder](ERROR): Failed to parse:

2018-09-25T19:43:43.549Z,1537904623.549 [DeadReckonUsingMultipleVelocitySources](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2018-09-25T19:43:43.549Z,1537904623.549 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 23
2018-09-25T19:43:43.549Z,1537904623.549 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2018-09-25T19:43:43.551Z,1537904623.551 [DeadReckonUsingSpeedCalculator](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2018-09-25T19:43:43.551Z,1537904623.551 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 23
2018-09-25T19:43:43.551Z,1537904623.551 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2018-09-25T19:43:43.581Z,1537904623.581 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2018-09-25T19:43:43.581Z,1537904623.581 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2018-09-25T19:43:43.938Z,1537904623.938 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2018-09-25T19:43:43.938Z,1537904623.938 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 23
2018-09-25T19:43:43.939Z,1537904623.939 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2018-09-25T19:43:43.939Z,1537904623.939 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 23
2018-09-25T19:43:44.346Z,1537904624.346 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2018-09-25T19:43:44.347Z,1537904624.347 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2018-09-25T19:43:44.347Z,1537904624.347 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2018-09-25T19:43:44.348Z,1537904624.348 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2018-09-25T19:43:44.348Z,1537904624.348 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2018-09-25T19:43:44.348Z,1537904624.348 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2018-09-25T19:44:13.311Z,1537904653.311 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2018-09-25T19:44:26.107Z,1537904666.107 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2018-09-25T19:44:38.900Z,1537904678.900 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2018-09-25T19:45:29.343Z,1537904729.343 [RDI_Pathfinder](ERROR): Unknown system health message
2018-09-25T19:45:29.343Z,1537904729.343 [RDI_Pathfinder] Hardware Fault, FailCount= 1
2018-09-25T19:45:29.343Z,1537904729.343 [RDI_Pathfinder](ERROR): Hardware Fault
2018-09-25T19:45:29.373Z,1537904729.373 [CBIT](ERROR): Hardware Fault in component: RDI_Pathfinder
2018-09-25T19:45:29.785Z,1537904729.785 [RDI_Pathfinder](INFO): Powering down
2018-09-25T19:45:30.568Z,1537904730.568 [CBIT](INFO): Clearing failed state for component RDI_Pathfinder
2018-09-25T19:45:30.568Z,1537904730.568 [RDI_Pathfinder] No Fault, FailCount= 0
2018-09-25T19:45:44.105Z,1537904744.105 [RDI_Pathfinder](ERROR): Failed to parse:Pathfinder
2018-09-25T19:46:44.630Z,1537904804.630 [DeadReckonUsingMultipleVelocitySources](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2018-09-25T19:46:44.630Z,1537904804.630 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 24
2018-09-25T19:46:44.630Z,1537904804.630 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2018-09-25T19:46:44.632Z,1537904804.632 [DeadReckonUsingSpeedCalculator](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2018-09-25T19:46:44.632Z,1537904804.632 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 24
2018-09-25T19:46:44.632Z,1537904804.632 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2018-09-25T19:46:44.645Z,1537904804.645 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2018-09-25T19:46:44.646Z,1537904804.646 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2018-09-25T19:46:45.062Z,1537904805.062 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2018-09-25T19:46:45.062Z,1537904805.062 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 24
2018-09-25T19:46:45.063Z,1537904805.063 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2018-09-25T19:46:45.063Z,1537904805.063 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 24
2018-09-25T19:46:45.404Z,1537904805.404 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2018-09-25T19:46:45.404Z,1537904805.404 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2018-09-25T19:46:45.404Z,1537904805.404 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2018-09-25T19:46:45.409Z,1537904805.409 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2018-09-25T19:46:45.410Z,1537904805.410 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2018-09-25T19:46:45.410Z,1537904805.410 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2018-09-25T19:46:57.827Z,1537904817.827 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for altitude
2018-09-25T19:46:57.827Z,1537904817.827 [RDI_Pathfinder](ERROR): Failed to parse:
:BD,        +0.00 +0.00,        +0.00,   0.00, 74.00
2018-09-25T19:47:02.255Z,1537904822.255 [Default:CheckIn:Read_GPS](INFO): Timed out from 2018-09-25T19:42:02.1Z
2018-09-25T19:47:02.255Z,1537904822.255 [Default:CheckIn:Read_GPS] Stopped
2018-09-25T19:47:02.255Z,1537904822.255 [Default:CheckIn:Read_Iridium] Running Loop=1
2018-09-25T19:47:06.074Z,1537904826.074 [DataOverHttps](INFO): Sending 25 bytes from file Logs/20180925T183401/Courier0022.lzma
2018-09-25T19:47:06.868Z,1537904826.868 [DataOverHttps](INFO): Moved sent file to Logs/20180925T183401/Courier0022.lzma.bak
2018-09-25T19:47:06.868Z,1537904826.868 [DataOverHttps](INFO): SBD MOMSN=8587172
2018-09-25T19:47:15.858Z,1537904835.858 [DataOverHttps](INFO): Sending 162 bytes from file Logs/20180925T183401/Express0023.lzma
2018-09-25T19:47:16.632Z,1537904836.632 [DataOverHttps](INFO): Moved sent file to Logs/20180925T183401/Express0023.lzma.bak
2018-09-25T19:47:16.632Z,1537904836.632 [DataOverHttps](INFO): SBD MOMSN=8587174
2018-09-25T19:47:17.310Z,1537904837.310 [Default:CheckIn:Read_Iridium] Stopped
2018-09-25T19:47:17.310Z,1537904837.310 [Default:CheckIn:C.Wait] Running Loop=1
2018-09-25T19:47:17.310Z,1537904837.310 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2018-09-25T19:47:33.840Z,1537904853.840 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2018-09-25T19:48:00.160Z,1537904880.160 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2018-09-25T19:48:13.027Z,1537904893.027 [CommandLine](IMPORTANT): got command restart application
2018-09-25T19:48:14.036Z,1537904894.036 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2018-09-25T19:48:14.036Z,1537904894.036 [CommandLine ThreadHandler](INFO): Thread cancelled.
2018-09-25T19:48:14.057Z,1537904894.057 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup.  Bye!
2018-09-25T19:48:14.057Z,1537904894.057 [CommandLine ThreadHandler](INFO): Thread cancelled.
2018-09-25T19:48:14.058Z,1537904894.058 [CommandLine](INFO): Join timeout helper Thread ID is 7720
2018-09-25T19:48:14.058Z,1537904894.058 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2018-09-25T19:48:14.060Z,1537904894.060 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2018-09-25T19:48:14.080Z,1537904894.080 [NavChartDb](INFO): Join timeout helper Thread ID is 7721
2018-09-25T19:48:14.273Z,1537904894.273 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2018-09-25T19:48:14.273Z,1537904894.273 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2018-09-25T19:48:14.281Z,1537904894.281 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2018-09-25T19:48:14.281Z,1537904894.281 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2018-09-25T19:48:14.281Z,1537904894.281 [Radio_Surface](INFO): Join timeout helper Thread ID is 7722
2018-09-25T19:48:14.325Z,1537904894.325 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2018-09-25T19:48:14.325Z,1537904894.325 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2018-09-25T19:48:14.326Z,1537904894.326 [ComponentRegistry](INFO): Shutting down WetLabsSeaOWL_UV_A ThreadHandler
2018-09-25T19:48:14.326Z,1537904894.326 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Thread cancelled.
2018-09-25T19:48:14.326Z,1537904894.326 [WetLabsSeaOWL_UV_A](INFO): Join timeout helper Thread ID is 7723
2018-09-25T19:48:14.689Z,1537904894.689 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Uninitializing protected caller thread.
2018-09-25T19:48:14.689Z,1537904894.689 [WetLabsSeaOWL_UV_A](INFO): Powering down
2018-09-25T19:48:14.690Z,1537904894.690 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Thread cancelled.
2018-09-25T19:48:14.705Z,1537904894.705 [ComponentRegistry](INFO): Shutting down CTD_NeilBrown ThreadHandler
2018-09-25T19:48:14.705Z,1537904894.705 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled.
2018-09-25T19:48:14.705Z,1537904894.705 [CTD_NeilBrown](INFO): Join timeout helper Thread ID is 7724
2018-09-25T19:48:15.053Z,1537904895.053 [CTD_NeilBrown ThreadHandler](INFO): Uninitializing protected caller thread.
2018-09-25T19:48:15.053Z,1537904895.053 [CTD_NeilBrown](INFO): Powering down
2018-09-25T19:48:15.054Z,1537904895.054 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled.
2018-09-25T19:48:15.074Z,1537904895.074 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2018-09-25T19:48:15.074Z,1537904895.074 [logger ThreadHandler](INFO): Thread cancelled.
2018-09-25T19:48:15.074Z,1537904895.074 [logger](INFO): Join timeout helper Thread ID is 7725
2018-09-25T19:48:15.081Z,1537904895.081 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2018-09-25T19:48:15.081Z,1537904895.081 [logger ThreadHandler](INFO): Thread cancelled.
2018-09-25T19:48:15.094Z,1537904895.094 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2018-09-25T19:48:15.094Z,1537904895.094 [CommandLine ThreadHandler](INFO): Thread cancelled.
2018-09-25T19:48:15.094Z,1537904895.094 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2018-09-25T19:48:15.094Z,1537904895.094 [controlThread ThreadHandler](INFO): Thread cancelled.
2018-09-25T19:48:15.094Z,1537904895.094 [controlThread](INFO): Join timeout helper Thread ID is 7726
2018-09-25T19:48:15.217Z,1537904895.217 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2018-09-25T19:48:15.217Z,1537904895.217 [controlThread](DEBUG): Uninitializing ControlThread
2018-09-25T19:48:15.218Z,1537904895.218 [Aanderaa_O2](INFO): Powering down
2018-09-25T19:48:15.219Z,1537904895.219 [AHRS_M2](INFO): Powering down
2018-09-25T19:48:15.290Z,1537904895.290 [NAL9602](INFO): Powering down
2018-09-25T19:48:15.361Z,1537904895.361 [RDI_Pathfinder](INFO): Powering down
2018-09-25T19:48:15.363Z,1537904895.363 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2018-09-25T19:48:15.364Z,1537904895.364 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2018-09-25T19:48:15.364Z,1537904895.364 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2018-09-25T19:48:15.365Z,1537904895.365 [MissionManager](INFO): Uninitializing Mission Default
2018-09-25T19:48:15.365Z,1537904895.365 [Default] Stopped
2018-09-25T19:48:15.365Z,1537904895.365 [Default](DEBUG): Aggregate::uninitialize Default
2018-09-25T19:48:15.365Z,1537904895.365 [Default:B.GoToSurface] Stopped
2018-09-25T19:48:15.365Z,1537904895.365 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2018-09-25T19:48:15.366Z,1537904895.366 [Default:CheckIn] Stopped
2018-09-25T19:48:15.366Z,1537904895.366 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2018-09-25T19:48:15.366Z,1537904895.366 [Default:CheckIn:C.Wait] Stopped
2018-09-25T19:48:15.366Z,1537904895.366 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2018-09-25T19:48:15.369Z,1537904895.369 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2018-09-25T19:48:15.370Z,1537904895.370 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2018-09-25T19:48:15.370Z,1537904895.370 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2018-09-25T19:48:15.370Z,1537904895.370 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2018-09-25T19:48:15.370Z,1537904895.370 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2018-09-25T19:48:15.371Z,1537904895.371 [BuoyancyServo](INFO): Powering down
2018-09-25T19:48:15.385Z,1537904895.385 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2018-09-25T19:48:15.385Z,1537904895.385 [ElevatorServo](INFO): Powering down
2018-09-25T19:48:15.386Z,1537904895.386 [MassServo](DEBUG): Uninitialize Mass Servo.
2018-09-25T19:48:15.386Z,1537904895.386 [MassServo](INFO): Powering down
2018-09-25T19:48:15.387Z,1537904895.387 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2018-09-25T19:48:15.387Z,1537904895.387 [RudderServo](INFO): Powering down
2018-09-25T19:48:15.388Z,1537904895.388 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2018-09-25T19:48:15.388Z,1537904895.388 [ThrusterServo](INFO): Powering down
2018-09-25T19:48:15.389Z,1537904895.389 [SBIT](DEBUG): Uninitialize SBIT Component.
2018-09-25T19:48:15.389Z,1537904895.389 [IBIT](DEBUG): Uninitialize IBIT Component.
2018-09-25T19:48:15.390Z,1537904895.390 [CBIT](DEBUG): Uninitialize CBIT Component.
2018-09-25T19:48:15.390Z,1537904895.390 [controlThread ThreadHandler](INFO): Thread cancelled.
2018-09-25T19:48:15.454Z,1537904895.454 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Thread cancelled.
2018-09-25T19:48:15.457Z,1537904895.457 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled.
2018-09-25T19:48:15.519Z,1537904895.519 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2018-09-25T19:48:15.568Z,1537904895.568 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2018-09-25T19:48:15.624Z,1537904895.624 [logger ThreadHandler](INFO): Thread cancelled.