2019-06-09T17:19:51.820Z,1560100791.820 [Supervisor](DEBUG): Initializing supervisor. 2019-06-09T17:19:51.823Z,1560100791.823 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2019-06-09T17:19:51.823Z,1560100791.823 [SyncHandler](INFO): Protected caller Thread ID is 807 2019-06-09T17:19:51.823Z,1560100791.823 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2019-06-09T17:19:51.824Z,1560100791.824 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2019-06-09T17:19:51.825Z,1560100791.825 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 808 2019-06-09T17:19:51.827Z,1560100791.827 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2019-06-09T17:19:51.839Z,1560100791.839 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2019-06-09T17:19:51.840Z,1560100791.840 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2019-06-09T17:19:51.840Z,1560100791.840 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 809 2019-06-09T17:19:51.841Z,1560100791.841 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2019-06-09T17:19:51.842Z,1560100791.842 [logger ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2019-06-09T17:19:51.842Z,1560100791.842 [logger ThreadHandler](INFO): Protected caller Thread ID is 810 2019-06-09T17:19:51.844Z,1560100791.844 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2019-06-09T17:19:51.845Z,1560100791.845 [Supervisor](INFO): Looking for Config files in directory: Config/ 2019-06-09T17:19:51.849Z,1560100791.849 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2019-06-09T17:19:52.275Z,1560100792.275 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2019-06-09T17:19:52.276Z,1560100792.276 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2019-06-09T17:19:52.374Z,1560100792.374 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample 2019-06-09T17:19:52.376Z,1560100792.376 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2019-06-09T17:19:52.702Z,1560100792.702 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2019-06-09T17:19:52.703Z,1560100792.703 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2019-06-09T17:19:52.845Z,1560100792.845 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2019-06-09T17:19:52.847Z,1560100792.847 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2019-06-09T17:19:53.040Z,1560100793.040 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2019-06-09T17:19:53.042Z,1560100793.042 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2019-06-09T17:19:53.497Z,1560100793.497 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2019-06-09T17:19:53.499Z,1560100793.499 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2019-06-09T17:19:53.709Z,1560100793.709 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2019-06-09T17:19:53.710Z,1560100793.710 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2019-06-09T17:19:53.855Z,1560100793.855 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2019-06-09T17:19:53.857Z,1560100793.857 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2019-06-09T17:19:54.052Z,1560100794.052 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2019-06-09T17:19:54.054Z,1560100794.054 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2019-06-09T17:19:54.149Z,1560100794.149 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2019-06-09T17:19:54.151Z,1560100794.151 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2019-06-09T17:19:54.473Z,1560100794.473 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2019-06-09T17:19:54.474Z,1560100794.474 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2019-06-09T17:19:54.554Z,1560100794.554 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2019-06-09T17:19:54.658Z,1560100794.658 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2019-06-09T17:19:54.659Z,1560100794.659 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2019-06-09T17:19:55.242Z,1560100795.242 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2019-06-09T17:19:55.243Z,1560100795.243 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2019-06-09T17:19:56.515Z,1560100796.515 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2019-06-09T17:19:56.517Z,1560100796.517 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-whoidhs/ 2019-06-09T17:19:56.519Z,1560100796.519 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/vehicle.cfg 2019-06-09T17:19:56.729Z,1560100796.729 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Control.cfg 2019-06-09T17:19:56.829Z,1560100796.829 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/BIT.cfg 2019-06-09T17:19:56.928Z,1560100796.928 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Battery.cfg 2019-06-09T17:19:57.153Z,1560100797.153 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2019-06-09T17:19:57.154Z,1560100797.154 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Simulator.cfg 2019-06-09T17:19:57.238Z,1560100797.238 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Navigation.cfg 2019-06-09T17:19:57.333Z,1560100797.333 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/logger.cfg 2019-06-09T17:19:57.430Z,1560100797.430 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/secure.cfg 2019-06-09T17:19:57.515Z,1560100797.515 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Servo.cfg 2019-06-09T17:19:57.623Z,1560100797.623 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Sensor.cfg 2019-06-09T17:19:57.794Z,1560100797.794 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Science.cfg 2019-06-09T17:19:57.925Z,1560100797.925 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg 2019-06-09T17:19:57.947Z,1560100797.947 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2019-06-09T17:19:58.651Z,1560100798.651 [AHRS_M2] Loaded 2019-06-09T17:19:58.651Z,1560100798.651 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread. 2019-06-09T17:19:58.792Z,1560100798.792 [DataOverHttps] Loaded 2019-06-09T17:19:58.792Z,1560100798.792 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread. 2019-06-09T17:19:58.793Z,1560100798.793 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 4075A4E0 2019-06-09T17:19:58.794Z,1560100798.794 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 889 2019-06-09T17:19:58.807Z,1560100798.807 [Depth_Keller] Loaded 2019-06-09T17:19:58.807Z,1560100798.807 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2019-06-09T17:19:58.812Z,1560100798.812 [DropWeight] Loaded 2019-06-09T17:19:58.812Z,1560100798.812 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread. 2019-06-09T17:19:58.868Z,1560100798.868 [DUSBL_Hydroid] Loaded 2019-06-09T17:19:58.868Z,1560100798.868 [ComponentRegistry](DEBUG): SyncComponent "DUSBL_Hydroid" handled in the control thread. 2019-06-09T17:19:58.907Z,1560100798.907 [Micromodem] Loaded 2019-06-09T17:19:58.908Z,1560100798.908 [ComponentRegistry](DEBUG): SyncComponent "Micromodem" handled in the control thread. 2019-06-09T17:19:59.005Z,1560100799.005 [NAL9602] Loaded 2019-06-09T17:19:59.005Z,1560100799.005 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2019-06-09T17:19:59.021Z,1560100799.021 [Onboard] Loaded 2019-06-09T17:19:59.021Z,1560100799.021 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread. 2019-06-09T17:19:59.027Z,1560100799.027 [PowerOnly] Loaded 2019-06-09T17:19:59.027Z,1560100799.027 [ComponentRegistry](DEBUG): SyncComponent "PowerOnly" handled in the control thread. 2019-06-09T17:19:59.033Z,1560100799.033 [Radio_Surface] Loaded 2019-06-09T17:19:59.034Z,1560100799.034 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2019-06-09T17:19:59.035Z,1560100799.035 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 4078A4E0 2019-06-09T17:19:59.035Z,1560100799.035 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 890 2019-06-09T17:19:59.078Z,1560100799.078 [RDI_Pathfinder] Loaded 2019-06-09T17:19:59.079Z,1560100799.079 [ComponentRegistry](DEBUG): SyncComponent "RDI_Pathfinder" handled in the control thread. 2019-06-09T17:20:00.552Z,1560100800.552 [BPC1] Loaded 2019-06-09T17:20:00.553Z,1560100800.553 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2019-06-09T17:20:00.553Z,1560100800.553 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2019-06-09T17:20:00.554Z,1560100800.554 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2019-06-09T17:20:01.163Z,1560100801.163 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2019-06-09T17:20:01.163Z,1560100801.163 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2019-06-09T17:20:01.404Z,1560100801.404 [DeadReckonUsingMultipleVelocitySources] Loaded 2019-06-09T17:20:01.404Z,1560100801.404 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2019-06-09T17:20:01.424Z,1560100801.424 [NavChart] Loaded 2019-06-09T17:20:01.425Z,1560100801.425 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2019-06-09T17:20:01.428Z,1560100801.428 [UniversalFixResidualReporter] Loaded 2019-06-09T17:20:01.429Z,1560100801.429 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2019-06-09T17:20:01.429Z,1560100801.429 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2019-06-09T17:20:01.430Z,1560100801.430 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2019-06-09T17:20:01.559Z,1560100801.559 [BuoyancyServo] Loaded 2019-06-09T17:20:01.559Z,1560100801.559 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2019-06-09T17:20:01.574Z,1560100801.574 [ElevatorServo] Loaded 2019-06-09T17:20:01.574Z,1560100801.574 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2019-06-09T17:20:01.589Z,1560100801.589 [MassServo] Loaded 2019-06-09T17:20:01.589Z,1560100801.589 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2019-06-09T17:20:01.604Z,1560100801.604 [RudderServo] Loaded 2019-06-09T17:20:01.604Z,1560100801.604 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2019-06-09T17:20:01.619Z,1560100801.619 [ThrusterServo] Loaded 2019-06-09T17:20:01.619Z,1560100801.619 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread. 2019-06-09T17:20:01.620Z,1560100801.620 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2019-06-09T17:20:01.620Z,1560100801.620 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2019-06-09T17:20:01.899Z,1560100801.899 [WetLabsSeaOWL_UV_A] Loaded 2019-06-09T17:20:01.900Z,1560100801.900 [ComponentRegistry](DEBUG): Component "WetLabsSeaOWL_UV_A" handled in its own thread. 2019-06-09T17:20:01.901Z,1560100801.901 [WetLabsSeaOWL_UV_A ThreadHandler](DEBUG): Created PCaller Thread at 408CC4E0 2019-06-09T17:20:01.901Z,1560100801.901 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Protected caller Thread ID is 892 2019-06-09T17:20:01.902Z,1560100801.902 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2019-06-09T17:20:01.902Z,1560100801.902 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2019-06-09T17:20:02.237Z,1560100802.237 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2019-06-09T17:20:02.238Z,1560100802.238 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2019-06-09T17:20:02.294Z,1560100802.294 [DepthRateCalculator] Loaded 2019-06-09T17:20:02.295Z,1560100802.295 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2019-06-09T17:20:02.300Z,1560100802.300 [PitchRateCalculator] Loaded 2019-06-09T17:20:02.300Z,1560100802.300 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2019-06-09T17:20:02.313Z,1560100802.313 [SpeedCalculator] Loaded 2019-06-09T17:20:02.313Z,1560100802.313 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2019-06-09T17:20:02.334Z,1560100802.334 [TempGradientCalculator] Loaded 2019-06-09T17:20:02.334Z,1560100802.334 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread. 2019-06-09T17:20:02.340Z,1560100802.340 [YawRateCalculator] Loaded 2019-06-09T17:20:02.340Z,1560100802.340 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2019-06-09T17:20:02.379Z,1560100802.379 [ElevatorOffsetCalculator] Loaded 2019-06-09T17:20:02.380Z,1560100802.380 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread. 2019-06-09T17:20:02.380Z,1560100802.380 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2019-06-09T17:20:02.382Z,1560100802.382 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2019-06-09T17:20:02.539Z,1560100802.539 [SBIT](DEBUG): Construct Startup Built In Test. 2019-06-09T17:20:02.561Z,1560100802.561 [SBIT] Loaded 2019-06-09T17:20:02.561Z,1560100802.561 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2019-06-09T17:20:02.562Z,1560100802.562 [IBIT](DEBUG): Construct Initiated Built In Test. 2019-06-09T17:20:02.574Z,1560100802.574 [IBIT] Loaded 2019-06-09T17:20:02.574Z,1560100802.574 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2019-06-09T17:20:02.577Z,1560100802.577 [CBIT](DEBUG): Construct Continuous Built In Test. 2019-06-09T17:20:02.715Z,1560100802.715 [CBIT] Loaded 2019-06-09T17:20:02.715Z,1560100802.715 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2019-06-09T17:20:02.716Z,1560100802.716 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2019-06-09T17:20:02.716Z,1560100802.716 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2019-06-09T17:20:02.835Z,1560100802.835 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2019-06-09T17:20:02.837Z,1560100802.837 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2019-06-09T17:20:02.961Z,1560100802.961 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2019-06-09T17:20:02.962Z,1560100802.962 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2019-06-09T17:20:03.050Z,1560100803.050 [VerticalControl](DEBUG): Construct VerticalControl. 2019-06-09T17:20:03.133Z,1560100803.133 [VerticalControl] Loaded 2019-06-09T17:20:03.133Z,1560100803.133 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2019-06-09T17:20:03.134Z,1560100803.134 [HorizontalControl](DEBUG): Construct HorizontalControl. 2019-06-09T17:20:03.190Z,1560100803.190 [HorizontalControl] Loaded 2019-06-09T17:20:03.190Z,1560100803.190 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2019-06-09T17:20:03.191Z,1560100803.191 [SpeedControl](DEBUG): Construct SpeedControl. 2019-06-09T17:20:03.193Z,1560100803.193 [SpeedControl] Loaded 2019-06-09T17:20:03.193Z,1560100803.193 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2019-06-09T17:20:03.194Z,1560100803.194 [LoopControl](DEBUG): Construct LoopControl. 2019-06-09T17:20:03.194Z,1560100803.194 [LoopControl] Loaded 2019-06-09T17:20:03.194Z,1560100803.194 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2019-06-09T17:20:03.195Z,1560100803.195 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2019-06-09T17:20:03.196Z,1560100803.196 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2019-06-09T17:20:03.236Z,1560100803.236 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2019-06-09T17:20:03.240Z,1560100803.240 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2019-06-09T17:20:03.241Z,1560100803.241 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2019-06-09T17:20:03.247Z,1560100803.247 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2019-06-09T17:20:03.249Z,1560100803.249 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40AA54E0 2019-06-09T17:20:03.249Z,1560100803.249 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 893 2019-06-09T17:20:03.254Z,1560100803.254 [Supervisor](INFO): Main Thread ID is 803 2019-06-09T17:20:03.254Z,1560100803.254 [Supervisor](DEBUG): Running supervisor. 2019-06-09T17:20:03.254Z,1560100803.254 [CommandLine ThreadHandler](INFO): Handler Thread ID is 894 2019-06-09T17:20:03.257Z,1560100803.257 [controlThread ThreadHandler](INFO): Handler Thread ID is 895 2019-06-09T17:20:03.257Z,1560100803.257 [controlThread](DEBUG): Initializing ControlThread 2019-06-09T17:20:03.264Z,1560100803.264 [NavChart](DEBUG): Initialize NavChart Navigation. 2019-06-09T17:20:03.264Z,1560100803.264 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2019-06-09T17:20:03.266Z,1560100803.266 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2019-06-09T17:20:03.266Z,1560100803.266 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2019-06-09T17:20:03.266Z,1560100803.266 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2019-06-09T17:20:03.266Z,1560100803.266 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator. 2019-06-09T17:20:03.267Z,1560100803.267 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2019-06-09T17:20:03.267Z,1560100803.267 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator. 2019-06-09T17:20:03.268Z,1560100803.268 [SBIT](INFO): Initialize SBIT Component. 2019-06-09T17:20:03.268Z,1560100803.268 [SBIT](IMPORTANT): git: 2019-05-29 2019-06-09T17:20:03.268Z,1560100803.268 [SBIT](INFO): git hash: 3a408d161d85e02f941062c72493668314c507d3 2019-06-09T17:20:03.269Z,1560100803.269 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2019-06-09T17:20:03.270Z,1560100803.270 [SBIT](INFO): Kernel Reporting Different Version From Configuration. Kernel Expected: #2 PREEMPT Thu Jan 11 20:13:48 PST 2018 Kernel Reported: #1 PREEMPT Thu Feb 21 11:17:40 PST 2019 2019-06-09T17:20:03.271Z,1560100803.271 [SBIT](INFO): Beginning SBIT in 20.000000 seconds. 2019-06-09T17:20:03.272Z,1560100803.272 [IBIT](INFO): Initialize IBIT Component. 2019-06-09T17:20:03.272Z,1560100803.272 [CBIT](DEBUG): Initialize CBIT Component. 2019-06-09T17:20:03.273Z,1560100803.273 [logger ThreadHandler](INFO): Handler Thread ID is 896 2019-06-09T17:20:03.285Z,1560100803.285 [CBIT](DEBUG): Initialized mux pins. 2019-06-09T17:20:03.285Z,1560100803.285 [CBIT](DEBUG): Initializing the watchdog timer. 2019-06-09T17:20:03.293Z,1560100803.293 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 897 2019-06-09T17:20:03.294Z,1560100803.294 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2019-06-09T17:20:03.305Z,1560100803.305 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 898 2019-06-09T17:20:03.309Z,1560100803.309 [CBIT](INFO): Last reboot was NOT due to watchdog timer. 2019-06-09T17:20:03.309Z,1560100803.309 [CBIT](DEBUG): Initializing heartbeat. 2019-06-09T17:20:03.317Z,1560100803.317 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Handler Thread ID is 899 2019-06-09T17:20:03.318Z,1560100803.318 [WetLabsSeaOWL_UV_A](INFO): Powering down 2019-06-09T17:20:03.344Z,1560100803.344 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 900 2019-06-09T17:20:03.354Z,1560100803.354 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000 2019-06-09T17:20:03.354Z,1560100803.354 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000 2019-06-09T17:20:03.354Z,1560100803.354 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000 2019-06-09T17:20:03.355Z,1560100803.355 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000 2019-06-09T17:20:03.355Z,1560100803.355 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000 2019-06-09T17:20:03.355Z,1560100803.355 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000 2019-06-09T17:20:03.355Z,1560100803.355 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000 2019-06-09T17:20:03.355Z,1560100803.355 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000 2019-06-09T17:20:03.356Z,1560100803.356 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000 2019-06-09T17:20:03.356Z,1560100803.356 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000 2019-06-09T17:20:03.356Z,1560100803.356 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000 2019-06-09T17:20:03.356Z,1560100803.356 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000 2019-06-09T17:20:03.356Z,1560100803.356 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000 2019-06-09T17:20:03.357Z,1560100803.357 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000 2019-06-09T17:20:03.357Z,1560100803.357 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000 2019-06-09T17:20:03.357Z,1560100803.357 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000 2019-06-09T17:20:03.381Z,1560100803.381 [CBIT](DEBUG): Deactivating GF circuits. 2019-06-09T17:20:03.381Z,1560100803.381 [CBIT](DEBUG): Deactivating emergency mode. 2019-06-09T17:20:03.417Z,1560100803.417 [CBIT](DEBUG): Backplane powered. 2019-06-09T17:20:03.417Z,1560100803.417 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2019-06-09T17:20:03.419Z,1560100803.419 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2019-06-09T17:20:03.419Z,1560100803.419 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2019-06-09T17:20:03.420Z,1560100803.420 [LoopControl](DEBUG): Initialize LoopControlComponent. 2019-06-09T17:20:03.421Z,1560100803.421 [MissionManager](INFO): Loading Mission: Missions/Startup.xml 2019-06-09T17:20:03.450Z,1560100803.450 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2019-06-09T17:20:03.470Z,1560100803.470 [MissionManager](DEBUG): 2019-06-09T17:20:03.470Z,1560100803.470 [MissionManager](INFO): Loading Mission: Missions/Default.xml 2019-06-09T17:20:03.519Z,1560100803.519 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min 2019-06-09T17:20:03.520Z,1560100803.520 [Default:A.Wait](DEBUG): Construct Wait. 2019-06-09T17:20:03.538Z,1560100803.538 [Default:B.GoToSurface](DEBUG): Construct GoToSurface. 2019-06-09T17:20:03.565Z,1560100803.565 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2019-06-09T17:20:03.567Z,1560100803.567 [Default:CheckIn:C.Wait](DEBUG): Construct Wait. 2019-06-09T17:20:03.583Z,1560100803.583 [Default:E.Execute](DEBUG): Construct Execute. 2019-06-09T17:20:03.603Z,1560100803.603 [MissionManager](DEBUG): 0 Wait a moment to see if the scheduler starts a new mission before starting to actually run Default. 13 Burn on Dropped weight due to communications timeout. 5 Default mission has been running for Restarting logs and Default mission. restart logs 2019-06-09T17:20:03.607Z,1560100803.607 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,Depth_Keller,DropWeight,DUSBL_Hydroid,Micromodem,NAL9602,Onboard,PowerOnly,RDI_Pathfinder,BPC1,Depth_Keller,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter, 2019-06-09T17:20:03.629Z,1560100803.629 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2019-06-09T17:20:03.709Z,1560100803.709 [Radio_Surface](INFO): Powering up 2019-06-09T17:20:03.732Z,1560100803.732 [Depth_Keller](ERROR): Pressure reading out of range: 1913.424561 decibar 2019-06-09T17:20:03.733Z,1560100803.733 [DUSBL_Hydroid](INFO): Powering up 2019-06-09T17:20:03.733Z,1560100803.733 [DUSBL_Hydroid](DEBUG): Initializing DUSBL_Hydroid. 2019-06-09T17:20:03.805Z,1560100803.805 [DepthRateCalculator](ERROR): Depth measurement is not active 2019-06-09T17:20:03.861Z,1560100803.861 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2019-06-09T17:20:03.869Z,1560100803.869 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2019-06-09T17:20:03.870Z,1560100803.870 [ElevatorServo](DEBUG): Initializing EZServoServo. 2019-06-09T17:20:03.877Z,1560100803.877 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2019-06-09T17:20:03.878Z,1560100803.878 [MassServo](DEBUG): Initializing EZServoServo. 2019-06-09T17:20:03.885Z,1560100803.885 [MassServo](DEBUG): Initializing MassServo. 2019-06-09T17:20:03.886Z,1560100803.886 [RudderServo](DEBUG): Initializing EZServoServo. 2019-06-09T17:20:03.893Z,1560100803.893 [RudderServo](DEBUG): Initializing RudderServo. 2019-06-09T17:20:03.894Z,1560100803.894 [ThrusterServo](DEBUG): Initializing EZServoServo. 2019-06-09T17:20:03.901Z,1560100803.901 [ThrusterServo](DEBUG): Initializing ThrusterServo. 2019-06-09T17:20:04.032Z,1560100804.032 [Micromodem](INFO): Powering up 2019-06-09T17:20:04.032Z,1560100804.032 [Micromodem](DEBUG): Initializing Micromodem. 2019-06-09T17:20:04.761Z,1560100804.761 [RudderServo](ERROR): Rudder initialization uart error serial timeout 2019-06-09T17:20:04.761Z,1560100804.761 [RudderServo](FAULT): Rudder failed to initialize 2019-06-09T17:20:04.761Z,1560100804.761 [RudderServo] Communications Fault, FailCount= 1 2019-06-09T17:20:04.761Z,1560100804.761 [RudderServo](ERROR): Communications Fault 2019-06-09T17:20:04.896Z,1560100804.896 [CBIT](ERROR): Communications Fault in component: RudderServo 2019-06-09T17:20:05.058Z,1560100805.058 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2019-06-09T17:20:05.058Z,1560100805.058 [RudderServo](INFO): Powering down 2019-06-09T17:20:05.740Z,1560100805.740 [RudderServo](DEBUG): Initializing EZServoServo. 2019-06-09T17:20:05.862Z,1560100805.862 [RudderServo](DEBUG): Initializing RudderServo. 2019-06-09T17:20:05.866Z,1560100805.866 [CBIT](INFO): Clearing failed state for component RudderServo 2019-06-09T17:20:05.866Z,1560100805.866 [RudderServo] No Fault, FailCount= 1 2019-06-09T17:20:17.057Z,1560100817.057 [RDI_Pathfinder](ERROR): Failed to parse:Pathfinder 2019-06-09T17:20:21.874Z,1560100821.874 [DUSBL_Hydroid](INFO): DUSBL Version:O 2019-06-09T17:20:23.939Z,1560100823.939 [SBIT](IMPORTANT): Beginning Startup BIT 2019-06-09T17:20:23.951Z,1560100823.951 [CBIT](IMPORTANT): Beginning ground fault scan 2019-06-09T17:20:29.219Z,1560100829.219 [NAL9602](INFO): Powering up NAL9602 2019-06-09T17:20:34.942Z,1560100834.942 [CBIT](IMPORTANT): No ground fault detected mA: CHAN A0 (Batt): -0.008723 CHAN A1 (24V): -0.027410 CHAN A2 (12V): -0.006874 CHAN A3 (5V): -0.002286 CHAN B0 (3.3V): 0.000040 CHAN B1 (3.15aV): 0.000024 CHAN B2 (3.15bV): -0.000093 CHAN B3 (GND): 0.002083 OPEN: 0.006671 Full Scale Calc: 4.765 mA, -1.589 mA 2019-06-09T17:20:35.700Z,1560100835.700 [RDI_Pathfinder](ERROR): only read 3 of 4 data items 2019-06-09T17:20:35.700Z,1560100835.700 [RDI_Pathfinder](ERROR): Failed to parse: :RA, 0.00, 0.00, 0.00, 0.00 2019-06-09T17:20:40.291Z,1560100840.291 [NAL9602](INFO): NAL9602 initialized 2019-06-09T17:20:41.117Z,1560100841.117 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:21:14.839Z,1560100874.839 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2019-06-09T17:21:14.918Z,1560100874.918 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2019-06-09T17:21:18.128Z,1560100878.128 [SBIT](IMPORTANT): SBIT PASSED 2019-06-09T17:21:18.197Z,1560100878.197 [CommandLine](IMPORTANT): got command configSet list 2019-06-09T17:21:18.198Z,1560100878.198 [CommandLine](IMPORTANT): Listing configuration overrides from Data/persisted.cfg 2019-06-09T17:21:18.199Z,1560100878.199 [CommandLine](IMPORTANT): BPC1.batterySamplingInterval=3 hour; 2019-06-09T17:21:18.199Z,1560100878.199 [CommandLine](IMPORTANT): BPC1.loadAtStartup=1 bool; 2019-06-09T17:21:18.199Z,1560100878.199 [CommandLine](IMPORTANT): CTD_NeilBrown.loadAtStartup=0 bool; 2019-06-09T17:21:18.199Z,1560100878.199 [CommandLine](IMPORTANT): DUSBL_Hydroid.detectionThreshold=75 count; 2019-06-09T17:21:18.199Z,1560100878.199 [CommandLine](IMPORTANT): Express linearApproximation DUSBL_Hydroid.range 2.000000 meter; 2019-06-09T17:21:18.199Z,1560100878.199 [CommandLine](IMPORTANT): Express linearApproximation DUSBL_Hydroid.xAngle 2.000000 angular_degree; 2019-06-09T17:21:18.199Z,1560100878.199 [CommandLine](IMPORTANT): Express linearApproximation RDI_Pathfinder.BottomVelocityFlag 0.000000 count; 2019-06-09T17:21:18.199Z,1560100878.199 [CommandLine](IMPORTANT): Express linearApproximation RDI_Pathfinder.height_above_sea_floor 2.000000 meter; 2019-06-09T17:21:18.200Z,1560100878.200 [CommandLine](IMPORTANT): Express none TrackAcousticContact.contact_latitude; 2019-06-09T17:21:18.200Z,1560100878.200 [CommandLine](IMPORTANT): Express none TrackAcousticContact.contact_longitude; 2019-06-09T17:21:18.200Z,1560100878.200 [CommandLine](IMPORTANT): Express linearApproximation WetLabsSeaOWL_UV_A.OutputFDOM 100.000000 count; 2019-06-09T17:21:18.200Z,1560100878.200 [CommandLine](IMPORTANT): Express linearApproximation WetLabsSeaOWL_UV_A.darkCountsOil 250.000000 count; 2019-06-09T17:21:18.200Z,1560100878.200 [CommandLine](IMPORTANT): Express linearApproximation WetLabsSeaOWL_UV_A.mass_concentration_of_petroleum_hydrocarbons_in_sea_water 0.000020 kilogram_per_cubic_meter; 2019-06-09T17:21:18.200Z,1560100878.200 [CommandLine](IMPORTANT): Express linearApproximation acoustic_contact_range 1.000000 meter; 2019-06-09T17:21:18.200Z,1560100878.200 [CommandLine](IMPORTANT): Express linearApproximation mass_concentration_of_chlorophyll_in_sea_water 5.000000 microgram_per_liter; 2019-06-09T17:21:18.200Z,1560100878.200 [CommandLine](IMPORTANT): Express none mass_concentration_of_oxygen_in_sea_water; 2019-06-09T17:21:18.200Z,1560100878.200 [CommandLine](IMPORTANT): NAL9602.fastGPSFix=1 bool; 2019-06-09T17:21:18.201Z,1560100878.201 [CommandLine](IMPORTANT): VerticalControl.buoyancyNeutral=190 cubic_centimeter; 2019-06-09T17:21:18.201Z,1560100878.201 [CommandLine](IMPORTANT): VerticalControl.massDefault=0 centimeter; 2019-06-09T17:21:18.386Z,1560100878.386 [MissionManager](IMPORTANT): Started mission Startup 2019-06-09T17:21:18.387Z,1560100878.387 [Startup] Running Loop=1 2019-06-09T17:21:18.387Z,1560100878.387 [Startup](DEBUG): Aggregate::initialize Startup 2019-06-09T17:21:18.387Z,1560100878.387 [Startup:A.GoToSurface] Running Loop=1 2019-06-09T17:21:18.387Z,1560100878.387 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2019-06-09T17:21:18.387Z,1560100878.387 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2019-06-09T17:21:18.388Z,1560100878.388 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2019-06-09T17:21:18.388Z,1560100878.388 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2019-06-09T17:21:18.393Z,1560100878.393 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2019-06-09T17:21:18.393Z,1560100878.393 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2019-06-09T17:21:18.395Z,1560100878.395 [Startup:StartupSatComms] Running Loop=1 2019-06-09T17:21:18.395Z,1560100878.395 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms 2019-06-09T17:21:18.395Z,1560100878.395 [Startup:StartupSatComms:A] Running Loop=1 2019-06-09T17:21:18.799Z,1560100878.799 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix 2019-06-09T17:21:25.753Z,1560100885.753 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2019-06-09T17:21:26.136Z,1560100886.136 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2019-06-09T17:21:36.227Z,1560100896.227 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2019-06-09T17:21:37.441Z,1560100897.441 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2019-06-09T17:21:47.167Z,1560100907.167 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2019-06-09T17:21:48.383Z,1560100908.383 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2019-06-09T17:21:58.114Z,1560100918.114 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2019-06-09T17:21:59.290Z,1560100919.290 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2019-06-09T17:22:04.416Z,1560100924.416 [NAL9602](INFO): SBD MO Status=2, MOMSN=7417, MT Status=2, MTMSN=0 2019-06-09T17:22:04.417Z,1560100924.417 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2019-06-09T17:22:09.003Z,1560100929.003 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2019-06-09T17:22:10.196Z,1560100930.196 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2019-06-09T17:22:18.598Z,1560100938.598 [Startup:StartupSatComms:A](INFO): Timed out from 2019-06-09T17:21:18.4Z 2019-06-09T17:22:18.598Z,1560100938.598 [Startup:StartupSatComms:A] Stopped 2019-06-09T17:22:18.598Z,1560100938.598 [Startup:StartupSatComms:B] Running Loop=1 2019-06-09T17:22:19.007Z,1560100939.007 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications 2019-06-09T17:22:19.864Z,1560100939.864 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2019-06-09T17:22:20.666Z,1560100940.666 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2019-06-09T17:22:30.769Z,1560100950.769 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2019-06-09T17:22:31.192Z,1560100951.192 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2019-06-09T17:22:41.691Z,1560100961.691 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2019-06-09T17:22:42.121Z,1560100962.121 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2019-06-09T17:22:53.012Z,1560100973.012 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2019-06-09T17:22:53.090Z,1560100973.090 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2019-06-09T17:23:03.490Z,1560100983.490 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2019-06-09T17:23:03.571Z,1560100983.571 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2019-06-09T17:23:03.576Z,1560100983.576 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1 2019-06-09T17:23:03.576Z,1560100983.576 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2019-06-09T17:23:03.586Z,1560100983.586 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2019-06-09T17:23:03.872Z,1560100983.872 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2019-06-09T17:23:03.872Z,1560100983.872 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1 2019-06-09T17:23:14.455Z,1560100994.455 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2019-06-09T17:23:14.526Z,1560100994.526 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2019-06-09T17:23:18.778Z,1560100998.778 [Startup:StartupSatComms:B](INFO): Timed out from 2019-06-09T17:22:18.6Z 2019-06-09T17:23:18.778Z,1560100998.778 [Startup:StartupSatComms:B] Stopped 2019-06-09T17:23:18.778Z,1560100998.778 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms 2019-06-09T17:23:18.778Z,1560100998.778 [Startup:StartupSatComms] Stopped 2019-06-09T17:23:18.778Z,1560100998.778 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms 2019-06-09T17:23:18.779Z,1560100998.779 [Startup](INFO): Completed Startup 2019-06-09T17:23:18.779Z,1560100998.779 [MissionManager](INFO): Startup is completed. 2019-06-09T17:23:18.779Z,1560100998.779 [MissionManager](INFO): Uninitializing Mission Startup 2019-06-09T17:23:18.780Z,1560100998.780 [Startup] Stopped 2019-06-09T17:23:18.780Z,1560100998.780 [Startup](DEBUG): Aggregate::uninitialize Startup 2019-06-09T17:23:18.780Z,1560100998.780 [Startup:A.GoToSurface] Stopped 2019-06-09T17:23:18.780Z,1560100998.780 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2019-06-09T17:23:19.208Z,1560100999.208 [MissionManager](IMPORTANT): Started mission Default 2019-06-09T17:23:19.208Z,1560100999.208 [Default] Running Loop=1 2019-06-09T17:23:19.208Z,1560100999.208 [Default](DEBUG): Aggregate::initialize Default 2019-06-09T17:23:19.208Z,1560100999.208 [Default:B.GoToSurface] Running Loop=1 2019-06-09T17:23:19.208Z,1560100999.208 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2019-06-09T17:23:19.209Z,1560100999.209 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2019-06-09T17:23:19.209Z,1560100999.209 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2019-06-09T17:23:19.210Z,1560100999.210 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2019-06-09T17:23:19.210Z,1560100999.210 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2019-06-09T17:23:19.210Z,1560100999.210 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2019-06-09T17:23:19.210Z,1560100999.210 [Default:A.Wait] Running Loop=1 2019-06-09T17:23:19.211Z,1560100999.211 [Default:A.Wait](DEBUG): Initialize Wait Component. 2019-06-09T17:23:25.353Z,1560101005.353 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2019-06-09T17:23:25.761Z,1560101005.761 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2019-06-09T17:23:32.514Z,1560101012.514 [Default:A.Wait](INFO): Done Waiting. 2019-06-09T17:23:32.514Z,1560101012.514 [Default:A.Wait] Stopped 2019-06-09T17:23:32.514Z,1560101012.514 [Default:A.Wait](DEBUG): Uninitialize Wait Component. 2019-06-09T17:23:32.934Z,1560101012.934 [Default:CheckIn] Running Loop=1 2019-06-09T17:23:32.934Z,1560101012.934 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2019-06-09T17:23:32.935Z,1560101012.935 [Default:CheckIn:Read_GPS] Running Loop=1 2019-06-09T17:23:33.361Z,1560101013.361 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix 2019-06-09T17:23:36.224Z,1560101016.224 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2019-06-09T17:23:36.637Z,1560101016.637 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2019-06-09T17:23:36.954Z,1560101016.954 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.013418 2019-06-09T17:23:47.157Z,1560101027.157 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2019-06-09T17:23:47.548Z,1560101027.548 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2019-06-09T17:23:58.102Z,1560101038.102 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2019-06-09T17:23:58.167Z,1560101038.167 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2019-06-09T17:24:09.036Z,1560101049.036 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2019-06-09T17:24:16.986Z,1560101056.986 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for altitude 2019-06-09T17:24:16.986Z,1560101056.986 [RDI_Pathfinder](ERROR): Failed to parse: :BD, +0.00, +0.00, , 0.00,240.00 2019-06-09T17:24:19.852Z,1560101059.852 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2019-06-09T17:24:30.806Z,1560101070.806 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2019-06-09T17:24:41.700Z,1560101081.700 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2019-06-09T17:24:52.583Z,1560101092.583 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2019-06-09T17:25:03.142Z,1560101103.142 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2019-06-09T17:25:14.420Z,1560101114.420 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2019-06-09T17:25:25.737Z,1560101125.737 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2019-06-09T17:25:37.087Z,1560101137.087 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2019-06-09T17:25:43.791Z,1560101143.791 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2019-06-09T17:25:44.613Z,1560101144.613 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:25:47.511Z,1560101147.511 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2019-06-09T17:25:48.653Z,1560101148.653 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:25:51.885Z,1560101151.885 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:25:54.713Z,1560101154.713 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:25:57.965Z,1560101157.965 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:25:58.442Z,1560101158.442 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2019-06-09T17:26:00.773Z,1560101160.773 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:26:03.609Z,1560101163.609 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:26:04.447Z,1560101164.447 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2 2019-06-09T17:26:04.447Z,1560101164.447 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2019-06-09T17:26:04.457Z,1560101164.457 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2019-06-09T17:26:04.853Z,1560101164.853 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2019-06-09T17:26:04.854Z,1560101164.854 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2 2019-06-09T17:26:06.029Z,1560101166.029 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:26:08.853Z,1560101168.853 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:26:09.377Z,1560101169.377 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2019-06-09T17:26:12.089Z,1560101172.089 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:26:14.913Z,1560101174.913 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:26:17.745Z,1560101177.745 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:26:20.573Z,1560101180.573 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:26:20.687Z,1560101180.687 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2019-06-09T17:26:23.412Z,1560101183.412 [RDI_Pathfinder](ERROR): only read 2 of 4 data items 2019-06-09T17:26:23.412Z,1560101183.412 [RDI_Pathfinder](ERROR): Failed to parse: :BS,-3768,-32768,V 2019-06-09T17:26:23.805Z,1560101183.805 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:26:26.633Z,1560101186.633 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:26:29.861Z,1560101189.861 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:26:31.617Z,1560101191.617 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2019-06-09T17:26:32.372Z,1560101192.372 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2019-06-09T17:26:32.689Z,1560101192.689 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:26:35.921Z,1560101195.921 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:26:38.749Z,1560101198.749 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:26:41.993Z,1560101201.993 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:26:42.488Z,1560101202.488 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2019-06-09T17:26:43.303Z,1560101203.303 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2019-06-09T17:26:44.809Z,1560101204.809 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:26:48.045Z,1560101208.045 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:26:50.877Z,1560101210.877 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:26:53.401Z,1560101213.401 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2019-06-09T17:26:54.105Z,1560101214.105 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:26:54.238Z,1560101214.238 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2019-06-09T17:26:56.937Z,1560101216.937 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:26:59.372Z,1560101219.372 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2019-06-09T17:26:59.757Z,1560101219.757 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:27:02.589Z,1560101222.589 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:27:05.150Z,1560101225.150 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2019-06-09T17:27:05.817Z,1560101225.817 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:27:08.645Z,1560101228.645 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:27:11.877Z,1560101231.877 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:27:14.705Z,1560101234.705 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:27:15.992Z,1560101235.992 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2019-06-09T17:27:17.949Z,1560101237.949 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:27:20.765Z,1560101240.765 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:27:24.001Z,1560101244.001 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:27:26.829Z,1560101246.829 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:27:26.930Z,1560101246.930 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2019-06-09T17:27:30.057Z,1560101250.057 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:27:32.885Z,1560101252.885 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:27:36.117Z,1560101256.117 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:27:37.799Z,1560101257.799 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2019-06-09T17:27:38.981Z,1560101258.981 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:27:41.781Z,1560101261.781 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:27:44.609Z,1560101264.609 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:27:47.833Z,1560101267.833 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:27:48.731Z,1560101268.731 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2019-06-09T17:27:50.661Z,1560101270.661 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:27:53.897Z,1560101273.897 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:27:56.721Z,1560101276.721 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:27:59.629Z,1560101279.629 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2019-06-09T17:27:59.969Z,1560101279.969 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:28:02.785Z,1560101282.785 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:28:06.013Z,1560101286.013 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:28:08.841Z,1560101288.841 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:28:10.535Z,1560101290.535 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2019-06-09T17:28:12.081Z,1560101292.081 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:28:14.905Z,1560101294.905 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:28:17.729Z,1560101297.729 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:28:20.561Z,1560101300.561 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:28:21.442Z,1560101301.443 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2019-06-09T17:28:22.577Z,1560101302.577 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:28:25.809Z,1560101305.809 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:28:25.888Z,1560101305.888 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2019-06-09T17:28:28.637Z,1560101308.637 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:28:31.873Z,1560101311.873 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:28:32.777Z,1560101312.777 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2019-06-09T17:28:33.138Z,1560101313.138 [Default:CheckIn:Read_GPS](INFO): Timed out from 2019-06-09T17:23:32.9Z 2019-06-09T17:28:33.138Z,1560101313.138 [Default:CheckIn:Read_GPS] Stopped 2019-06-09T17:28:33.138Z,1560101313.138 [Default:CheckIn:Read_Iridium] Running Loop=1 2019-06-09T17:28:33.510Z,1560101313.510 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications 2019-06-09T17:28:34.697Z,1560101314.697 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:28:37.645Z,1560101317.645 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2019-06-09T17:28:37.941Z,1560101317.941 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:28:38.958Z,1560101318.958 [DataOverHttps](INFO): Sending 25 bytes from file Logs/20190608T182400/Courier0429.lzma 2019-06-09T17:28:39.755Z,1560101319.755 [DataOverHttps](INFO): Moved sent file to Logs/20190608T182400/Courier0429.lzma.bak 2019-06-09T17:28:39.755Z,1560101319.755 [DataOverHttps](INFO): SBD MOMSN=11357985 2019-06-09T17:28:40.757Z,1560101320.757 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:28:43.589Z,1560101323.589 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:28:44.172Z,1560101324.172 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2019-06-09T17:28:46.817Z,1560101326.817 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:28:49.649Z,1560101329.649 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:28:52.877Z,1560101332.877 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:28:55.045Z,1560101335.045 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2019-06-09T17:28:55.721Z,1560101335.721 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:28:58.961Z,1560101338.961 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:29:01.769Z,1560101341.769 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:29:04.593Z,1560101344.593 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:29:05.440Z,1560101345.440 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3 2019-06-09T17:29:05.440Z,1560101345.440 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2019-06-09T17:29:05.463Z,1560101345.463 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2019-06-09T17:29:05.942Z,1560101345.942 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2019-06-09T17:29:05.973Z,1560101345.973 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2019-06-09T17:29:05.973Z,1560101345.973 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3 2019-06-09T17:29:07.829Z,1560101347.829 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:29:10.657Z,1560101350.657 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:29:13.889Z,1560101353.889 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:29:16.717Z,1560101356.717 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:29:17.221Z,1560101357.221 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2019-06-09T17:29:19.965Z,1560101359.965 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:29:22.777Z,1560101362.777 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:29:25.605Z,1560101365.605 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:29:26.115Z,1560101366.115 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2019-06-09T17:29:28.138Z,1560101368.138 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2019-06-09T17:29:28.833Z,1560101368.833 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:29:31.661Z,1560101371.661 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:29:34.897Z,1560101374.897 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:29:37.499Z,1560101377.499 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2019-06-09T17:29:37.721Z,1560101377.721 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:29:39.127Z,1560101379.127 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2019-06-09T17:29:40.549Z,1560101380.549 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:29:43.781Z,1560101383.781 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:29:46.617Z,1560101386.617 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:29:48.773Z,1560101388.773 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2019-06-09T17:29:49.853Z,1560101389.853 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:29:50.040Z,1560101390.040 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2019-06-09T17:29:52.673Z,1560101392.673 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:29:55.901Z,1560101395.901 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:29:58.733Z,1560101398.733 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:29:58.819Z,1560101398.819 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2019-06-09T17:30:00.890Z,1560101400.890 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2019-06-09T17:30:01.557Z,1560101401.557 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:30:04.793Z,1560101404.793 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:30:07.617Z,1560101407.617 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:30:09.600Z,1560101409.600 [DataOverHttps](INFO): Sending 25 bytes from file Logs/20190609T171951/Courier0004.lzma 2019-06-09T17:30:09.723Z,1560101409.723 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2019-06-09T17:30:10.406Z,1560101410.406 [DataOverHttps](INFO): Moved sent file to Logs/20190609T171951/Courier0004.lzma.bak 2019-06-09T17:30:10.406Z,1560101410.406 [DataOverHttps](INFO): SBD MOMSN=11357987 2019-06-09T17:30:10.857Z,1560101410.857 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:30:11.747Z,1560101411.747 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2019-06-09T17:30:13.681Z,1560101413.681 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:30:16.913Z,1560101416.913 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:30:19.737Z,1560101419.737 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:30:21.163Z,1560101421.163 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2019-06-09T17:30:22.111Z,1560101422.111 [DataOverHttps](INFO): Sending 1144 bytes from file Logs/20190608T182400/Express0430.lzma 2019-06-09T17:30:22.569Z,1560101422.569 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:30:22.915Z,1560101422.915 [DataOverHttps](INFO): Moved sent file to Logs/20190608T182400/Express0430.lzma.bak 2019-06-09T17:30:22.915Z,1560101422.915 [DataOverHttps](INFO): SBD MOMSN=11357990 2019-06-09T17:30:23.092Z,1560101423.092 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2019-06-09T17:30:25.805Z,1560101425.805 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:30:28.625Z,1560101428.625 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:30:31.857Z,1560101431.857 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:30:32.048Z,1560101432.048 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2019-06-09T17:30:34.017Z,1560101434.017 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2019-06-09T17:30:34.685Z,1560101434.685 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:30:37.922Z,1560101437.922 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:30:40.745Z,1560101440.745 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:30:41.143Z,1560101441.143 [NAL9602](FAULT): GPS failed to acquire within timeout. 2019-06-09T17:30:41.143Z,1560101441.143 [NAL9602] Data Fault, FailCount= 1 2019-06-09T17:30:41.143Z,1560101441.143 [NAL9602](ERROR): Data Fault 2019-06-09T17:30:41.201Z,1560101441.201 [CBIT](ERROR): Data Fault in component: NAL9602 2019-06-09T17:30:41.543Z,1560101441.543 [NAL9602](INFO): Powering down 2019-06-09T17:30:42.382Z,1560101442.382 [CBIT](INFO): Clearing failed state for component NAL9602 2019-06-09T17:30:42.382Z,1560101442.382 [NAL9602] No Fault, FailCount= 1 2019-06-09T17:30:42.844Z,1560101442.844 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2019-06-09T17:30:44.931Z,1560101444.931 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2019-06-09T17:30:53.762Z,1560101453.762 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2019-06-09T17:30:55.837Z,1560101455.837 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2019-06-09T17:30:59.357Z,1560101459.357 [RDI_Pathfinder](ERROR): only read 3 of 4 data items 2019-06-09T17:30:59.357Z,1560101459.357 [RDI_Pathfinder](ERROR): Failed to parse: :RA, 0.00, 0.00, 0.00, 0.00 2019-06-09T17:31:04.658Z,1560101464.658 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2019-06-09T17:31:11.845Z,1560101471.845 [NAL9602](INFO): Powering up NAL9602 2019-06-09T17:31:15.668Z,1560101475.668 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2019-06-09T17:31:20.441Z,1560101480.441 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2019-06-09T17:31:22.747Z,1560101482.747 [NAL9602](INFO): NAL9602 initialized 2019-06-09T17:31:25.589Z,1560101485.589 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:31:26.951Z,1560101486.951 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2019-06-09T17:31:28.421Z,1560101488.421 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:31:30.963Z,1560101490.963 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2019-06-09T17:31:31.653Z,1560101491.653 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:31:34.481Z,1560101494.481 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:31:37.313Z,1560101497.313 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:31:37.870Z,1560101497.870 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2019-06-09T17:31:39.329Z,1560101499.329 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:31:41.833Z,1560101501.833 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2019-06-09T17:31:42.557Z,1560101502.557 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:31:45.389Z,1560101505.389 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:31:48.617Z,1560101508.617 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:31:48.707Z,1560101508.707 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2019-06-09T17:31:51.449Z,1560101511.449 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:31:52.785Z,1560101512.785 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2019-06-09T17:31:53.175Z,1560101513.175 [DataOverHttps](INFO): Sending 1484 bytes from file Logs/20190609T171951/Express0001.lzma 2019-06-09T17:31:53.978Z,1560101513.978 [DataOverHttps](INFO): Moved sent file to Logs/20190609T171951/Express0001.lzma.bak 2019-06-09T17:31:53.978Z,1560101513.978 [DataOverHttps](INFO): SBD MOMSN=11358000 2019-06-09T17:31:54.681Z,1560101514.681 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:31:57.509Z,1560101517.509 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:31:59.614Z,1560101519.614 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2019-06-09T17:32:00.333Z,1560101520.333 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:32:03.569Z,1560101523.569 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:32:03.734Z,1560101523.734 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2019-06-09T17:32:05.673Z,1560101525.673 [DataOverHttps](INFO): Sending 674 bytes from file Logs/20190609T171951/Express0005.lzma 2019-06-09T17:32:06.393Z,1560101526.393 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:32:06.423Z,1560101526.423 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4 2019-06-09T17:32:06.423Z,1560101526.423 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2019-06-09T17:32:06.433Z,1560101526.433 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2019-06-09T17:32:06.478Z,1560101526.478 [DataOverHttps](INFO): Moved sent file to Logs/20190609T171951/Express0005.lzma.bak 2019-06-09T17:32:06.478Z,1560101526.478 [DataOverHttps](INFO): SBD MOMSN=11358032 2019-06-09T17:32:06.829Z,1560101526.829 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2019-06-09T17:32:06.830Z,1560101526.830 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4 2019-06-09T17:32:07.626Z,1560101527.626 [Default:CheckIn:Read_Iridium] Stopped 2019-06-09T17:32:07.626Z,1560101527.626 [Default:CheckIn:C.Wait] Running Loop=1 2019-06-09T17:32:07.626Z,1560101527.626 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2019-06-09T17:32:08.817Z,1560101528.817 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:32:11.024Z,1560101531.024 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2019-06-09T17:32:12.069Z,1560101532.069 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:32:14.670Z,1560101534.670 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2019-06-09T17:32:14.877Z,1560101534.877 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:32:18.109Z,1560101538.109 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:32:18.971Z,1560101538.971 [RDI_Pathfinder](ERROR): only read 2 of 4 data items 2019-06-09T17:32:18.971Z,1560101538.971 [RDI_Pathfinder](ERROR): Failed to parse: :BS,32768,-32768,V 2019-06-09T17:32:20.969Z,1560101540.969 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:32:21.845Z,1560101541.845 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2019-06-09T17:32:23.773Z,1560101543.773 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:32:25.489Z,1560101545.489 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2019-06-09T17:32:26.597Z,1560101546.597 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:32:29.829Z,1560101549.829 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:32:32.657Z,1560101552.657 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:32:32.748Z,1560101552.748 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2019-06-09T17:32:35.889Z,1560101555.889 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:32:36.437Z,1560101556.437 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2019-06-09T17:32:38.713Z,1560101558.713 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:32:41.957Z,1560101561.957 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:32:44.057Z,1560101564.057 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2019-06-09T17:32:44.773Z,1560101564.773 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:32:47.309Z,1560101567.309 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2019-06-09T17:32:48.009Z,1560101568.009 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:32:50.837Z,1560101570.837 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:32:54.065Z,1560101574.065 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:32:54.965Z,1560101574.965 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2019-06-09T17:32:56.901Z,1560101576.901 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:32:58.228Z,1560101578.228 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2019-06-09T17:32:59.721Z,1560101579.721 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:33:02.957Z,1560101582.957 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:33:05.781Z,1560101585.781 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:33:05.879Z,1560101585.879 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2019-06-09T17:33:08.613Z,1560101588.613 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:33:09.135Z,1560101589.135 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2019-06-09T17:33:11.841Z,1560101591.841 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:33:14.673Z,1560101594.673 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:33:17.189Z,1560101597.189 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2019-06-09T17:33:17.901Z,1560101597.901 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:33:20.062Z,1560101600.062 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2019-06-09T17:33:20.729Z,1560101600.729 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:33:23.973Z,1560101603.973 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:33:26.793Z,1560101606.793 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:33:28.494Z,1560101608.494 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2019-06-09T17:33:30.021Z,1560101610.021 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:33:30.953Z,1560101610.953 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2019-06-09T17:33:32.853Z,1560101612.853 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:33:36.081Z,1560101616.081 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:33:38.909Z,1560101618.909 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:33:39.810Z,1560101619.810 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2019-06-09T17:33:41.745Z,1560101621.745 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:33:41.843Z,1560101621.843 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2019-06-09T17:33:44.565Z,1560101624.565 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:33:46.589Z,1560101626.589 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:33:49.817Z,1560101629.817 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:33:50.714Z,1560101630.714 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2019-06-09T17:33:52.649Z,1560101632.649 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:33:55.881Z,1560101635.881 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:33:58.721Z,1560101638.721 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:34:00.875Z,1560101640.875 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2019-06-09T17:34:01.941Z,1560101641.941 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:34:04.773Z,1560101644.773 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:34:07.593Z,1560101647.593 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:34:10.833Z,1560101650.833 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:34:12.136Z,1560101652.136 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2019-06-09T17:34:13.653Z,1560101653.653 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:34:16.889Z,1560101656.889 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:34:19.713Z,1560101659.713 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:34:22.945Z,1560101662.945 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:34:23.477Z,1560101663.477 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2019-06-09T17:34:25.773Z,1560101665.773 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:34:28.605Z,1560101668.605 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:34:31.833Z,1560101671.833 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:34:34.382Z,1560101674.382 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2019-06-09T17:34:34.673Z,1560101674.673 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:34:36.685Z,1560101676.685 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error 2019-06-09T17:34:36.685Z,1560101676.685 [RDI_Pathfinder](ERROR): Failed to parse: :TS,19060910432112,35.0, -0.1, 0., 0 2019-06-09T17:34:37.897Z,1560101677.897 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:34:40.725Z,1560101680.725 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:34:43.953Z,1560101683.953 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:34:45.243Z,1560101685.243 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2019-06-09T17:34:46.785Z,1560101686.785 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:34:49.609Z,1560101689.609 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:34:52.845Z,1560101692.845 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:34:55.669Z,1560101695.669 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:34:55.796Z,1560101695.796 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2019-06-09T17:34:58.901Z,1560101698.901 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:35:01.741Z,1560101701.741 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:35:04.557Z,1560101704.557 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:35:06.581Z,1560101706.581 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:35:06.708Z,1560101706.708 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2019-06-09T17:35:07.424Z,1560101707.424 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 5 2019-06-09T17:35:07.425Z,1560101707.425 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2019-06-09T17:35:07.435Z,1560101707.435 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2019-06-09T17:35:07.813Z,1560101707.813 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2019-06-09T17:35:07.813Z,1560101707.813 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 5 2019-06-09T17:35:08.605Z,1560101708.605 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:35:11.833Z,1560101711.833 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:35:14.661Z,1560101714.661 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:35:17.572Z,1560101717.572 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2019-06-09T17:35:17.889Z,1560101717.889 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:35:20.721Z,1560101720.721 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:35:23.949Z,1560101723.949 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:35:26.777Z,1560101726.777 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:35:28.479Z,1560101728.479 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2019-06-09T17:35:30.009Z,1560101730.009 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:35:32.837Z,1560101732.837 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:35:36.069Z,1560101736.069 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:35:38.901Z,1560101738.901 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:35:39.021Z,1560101739.021 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2019-06-09T17:35:41.729Z,1560101741.729 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:35:44.957Z,1560101744.957 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:35:47.789Z,1560101747.789 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:35:49.888Z,1560101749.888 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2019-06-09T17:35:50.613Z,1560101750.613 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:35:53.845Z,1560101753.845 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:35:56.673Z,1560101756.673 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:35:59.905Z,1560101759.905 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:36:00.805Z,1560101760.805 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2019-06-09T17:36:02.737Z,1560101762.737 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:36:05.965Z,1560101765.965 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:36:08.793Z,1560101768.793 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:36:11.244Z,1560101771.244 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2019-06-09T17:36:11.346Z,1560101771.346 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2019-06-09T17:36:12.025Z,1560101772.025 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:36:14.857Z,1560101774.857 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:36:18.085Z,1560101778.085 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:36:20.918Z,1560101780.918 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:36:22.319Z,1560101782.319 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2019-06-09T17:36:22.466Z,1560101782.466 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2019-06-09T17:36:23.741Z,1560101783.741 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:36:26.573Z,1560101786.573 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:36:28.593Z,1560101788.593 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:36:31.821Z,1560101791.821 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:36:33.128Z,1560101793.128 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2019-06-09T17:36:34.653Z,1560101794.653 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:36:37.881Z,1560101797.881 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:36:40.709Z,1560101800.709 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:36:43.622Z,1560101803.622 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2019-06-09T17:36:43.941Z,1560101803.941 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:36:46.773Z,1560101806.773 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:36:49.605Z,1560101809.605 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:36:52.833Z,1560101812.833 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:36:54.557Z,1560101814.557 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2019-06-09T17:36:55.661Z,1560101815.661 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:36:58.897Z,1560101818.897 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:37:01.721Z,1560101821.721 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:37:04.953Z,1560101824.953 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:37:05.474Z,1560101825.474 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2019-06-09T17:37:07.777Z,1560101827.777 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:37:08.217Z,1560101828.217 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2019-06-09T17:37:08.217Z,1560101828.217 [Default:CheckIn:C.Wait] Stopped 2019-06-09T17:37:08.217Z,1560101828.217 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2019-06-09T17:37:08.217Z,1560101828.217 [Default:CheckIn:D] Running Loop=1 2019-06-09T17:37:08.614Z,1560101828.614 [Default:CheckIn:D] Stopped 2019-06-09T17:37:08.614Z,1560101828.614 [Default:CheckIn:E] Running Loop=1 2019-06-09T17:37:09.007Z,1560101829.007 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 13.823424 min 2019-06-09T17:37:09.007Z,1560101829.007 [Default:CheckIn:E] Stopped 2019-06-09T17:37:09.007Z,1560101829.007 [Default:CheckIn](INFO): Completed Default:CheckIn 2019-06-09T17:37:09.007Z,1560101829.007 [Default:CheckIn] Stopped 2019-06-09T17:37:09.007Z,1560101829.007 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2019-06-09T17:37:09.007Z,1560101829.007 [Default:CheckIn](INFO): Running loop #2 2019-06-09T17:37:09.008Z,1560101829.008 [Default:CheckIn] Running Loop=2 2019-06-09T17:37:09.008Z,1560101829.008 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2019-06-09T17:37:09.008Z,1560101829.008 [Default:CheckIn:Read_GPS] Running Loop=1 2019-06-09T17:37:10.605Z,1560101830.605 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:37:13.845Z,1560101833.845 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:37:16.370Z,1560101836.370 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2019-06-09T17:37:16.669Z,1560101836.669 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:37:19.907Z,1560101839.907 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:37:22.725Z,1560101842.725 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:37:25.961Z,1560101845.961 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:37:27.659Z,1560101847.659 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2019-06-09T17:37:28.785Z,1560101848.785 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:37:31.617Z,1560101851.617 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:37:34.849Z,1560101854.849 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:37:37.673Z,1560101857.673 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:37:38.571Z,1560101858.571 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2019-06-09T17:37:40.909Z,1560101860.909 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:37:43.737Z,1560101863.737 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:37:46.569Z,1560101866.569 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:37:48.581Z,1560101868.581 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:37:49.484Z,1560101869.484 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2019-06-09T17:37:51.813Z,1560101871.813 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:37:54.645Z,1560101874.645 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:37:57.873Z,1560101877.873 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:38:00.012Z,1560101880.012 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2019-06-09T17:38:00.705Z,1560101880.705 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:38:03.937Z,1560101883.937 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:38:06.765Z,1560101886.765 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:38:08.493Z,1560101888.493 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 6 2019-06-09T17:38:08.493Z,1560101888.493 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2019-06-09T17:38:08.531Z,1560101888.531 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2019-06-09T17:38:08.854Z,1560101888.854 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2019-06-09T17:38:08.854Z,1560101888.854 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 6 2019-06-09T17:38:09.597Z,1560101889.597 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:38:10.898Z,1560101890.898 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2019-06-09T17:38:12.013Z,1560101892.013 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:38:14.841Z,1560101894.841 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:38:18.073Z,1560101898.073 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:38:20.901Z,1560101900.901 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:38:21.809Z,1560101901.809 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2019-06-09T17:38:23.729Z,1560101903.729 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:38:26.561Z,1560101906.561 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:38:28.581Z,1560101908.581 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:38:31.809Z,1560101911.809 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:38:32.715Z,1560101912.715 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2019-06-09T17:38:34.641Z,1560101914.641 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:38:37.869Z,1560101917.869 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:38:40.701Z,1560101920.701 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:38:43.930Z,1560101923.930 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:38:45.641Z,1560101925.641 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2019-06-09T17:38:46.757Z,1560101926.757 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:38:49.589Z,1560101929.589 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:38:51.255Z,1560101931.255 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2019-06-09T17:38:52.817Z,1560101932.817 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:38:55.649Z,1560101935.649 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:38:58.877Z,1560101938.877 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:39:01.705Z,1560101941.705 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:39:02.609Z,1560101942.609 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2019-06-09T17:39:04.937Z,1560101944.937 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:39:07.765Z,1560101947.765 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:39:10.593Z,1560101950.593 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:39:13.568Z,1560101953.568 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2019-06-09T17:39:13.825Z,1560101953.825 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:39:16.653Z,1560101956.653 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:39:19.885Z,1560101959.885 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:39:22.713Z,1560101962.713 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:39:24.422Z,1560101964.422 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2019-06-09T17:39:25.541Z,1560101965.541 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:39:27.565Z,1560101967.565 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:39:29.989Z,1560101969.989 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:39:32.813Z,1560101972.813 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:39:35.346Z,1560101975.346 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2019-06-09T17:39:36.045Z,1560101976.045 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:39:38.873Z,1560101978.873 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:39:41.705Z,1560101981.705 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:39:44.937Z,1560101984.937 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:39:47.761Z,1560101987.761 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:39:50.593Z,1560101990.593 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:39:53.838Z,1560101993.838 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:39:56.657Z,1560101996.657 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:39:59.881Z,1560101999.881 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:40:02.713Z,1560102002.713 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:40:05.945Z,1560102005.945 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:40:08.769Z,1560102008.769 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:40:12.001Z,1560102012.001 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:40:14.829Z,1560102014.829 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:40:18.061Z,1560102018.061 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:40:20.889Z,1560102020.889 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:40:23.721Z,1560102023.721 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:40:26.557Z,1560102026.557 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:40:28.565Z,1560102028.565 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:40:31.805Z,1560102031.805 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:40:34.629Z,1560102034.629 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:40:37.857Z,1560102037.857 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:40:40.685Z,1560102040.685 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:40:43.917Z,1560102043.917 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:40:46.749Z,1560102046.749 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:40:49.581Z,1560102049.581 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:40:52.805Z,1560102052.805 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:40:55.645Z,1560102055.645 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:40:58.869Z,1560102058.869 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:41:01.697Z,1560102061.697 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:41:04.925Z,1560102064.925 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:41:07.757Z,1560102067.757 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:41:09.397Z,1560102069.397 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 7 2019-06-09T17:41:09.397Z,1560102069.397 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2019-06-09T17:41:09.407Z,1560102069.407 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2019-06-09T17:41:09.798Z,1560102069.798 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2019-06-09T17:41:09.798Z,1560102069.798 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 7 2019-06-09T17:41:10.585Z,1560102070.585 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:41:13.823Z,1560102073.823 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:41:16.645Z,1560102076.645 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:41:19.877Z,1560102079.877 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:41:22.701Z,1560102082.701 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:41:25.923Z,1560102085.923 [NAL9602](FAULT): GPS failed to acquire within timeout. 2019-06-09T17:41:25.923Z,1560102085.923 [NAL9602] Data Fault, FailCount= 2 2019-06-09T17:41:25.923Z,1560102085.923 [NAL9602](ERROR): Data Fault 2019-06-09T17:41:25.958Z,1560102085.958 [CBIT](ERROR): Data Fault in component: NAL9602 2019-06-09T17:41:26.327Z,1560102086.327 [NAL9602](INFO): Powering down 2019-06-09T17:41:27.180Z,1560102087.180 [CBIT](INFO): Clearing failed state for component NAL9602 2019-06-09T17:41:27.180Z,1560102087.180 [NAL9602] No Fault, FailCount= 2 2019-06-09T17:41:48.988Z,1560102108.988 [BPC1](ERROR): BPC1B: No match for serial number 1717 in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2019-06-09T17:41:56.627Z,1560102116.627 [NAL9602](INFO): Powering up NAL9602 2019-06-09T17:42:07.546Z,1560102127.546 [NAL9602](INFO): NAL9602 initialized 2019-06-09T17:42:08.357Z,1560102128.357 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:42:09.222Z,1560102129.222 [Default:CheckIn:Read_GPS](INFO): Timed out from 2019-06-09T17:37:09.0Z 2019-06-09T17:42:09.222Z,1560102129.222 [Default:CheckIn:Read_GPS] Stopped 2019-06-09T17:42:09.222Z,1560102129.222 [Default:CheckIn:Read_Iridium] Running Loop=1 2019-06-09T17:42:11.277Z,1560102131.277 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:42:14.097Z,1560102134.097 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:42:14.596Z,1560102134.596 [DataOverHttps](INFO): Sending 25 bytes from file Logs/20190609T171951/Courier0007.lzma 2019-06-09T17:42:15.402Z,1560102135.402 [DataOverHttps](INFO): Moved sent file to Logs/20190609T171951/Courier0007.lzma.bak 2019-06-09T17:42:15.402Z,1560102135.402 [DataOverHttps](INFO): SBD MOMSN=11358045 2019-06-09T17:42:16.117Z,1560102136.117 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:42:19.349Z,1560102139.349 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:42:22.173Z,1560102142.173 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:42:25.409Z,1560102145.409 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:42:26.962Z,1560102146.962 [DataOverHttps](INFO): Sending 1182 bytes from file Logs/20190609T171951/Express0008.lzma 2019-06-09T17:42:27.754Z,1560102147.754 [DataOverHttps](INFO): Moved sent file to Logs/20190609T171951/Express0008.lzma.bak 2019-06-09T17:42:27.754Z,1560102147.754 [DataOverHttps](INFO): SBD MOMSN=11358047 2019-06-09T17:42:28.233Z,1560102148.233 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:42:29.251Z,1560102149.251 [Default:CheckIn:Read_Iridium] Stopped 2019-06-09T17:42:29.251Z,1560102149.251 [Default:CheckIn:C.Wait] Running Loop=1 2019-06-09T17:42:29.251Z,1560102149.251 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2019-06-09T17:42:31.085Z,1560102151.085 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:42:33.081Z,1560102153.081 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:42:35.101Z,1560102155.101 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:42:37.125Z,1560102157.125 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:42:40.357Z,1560102160.357 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:42:43.181Z,1560102163.181 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:42:46.429Z,1560102166.429 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:42:49.241Z,1560102169.241 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:42:52.069Z,1560102172.069 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:42:54.105Z,1560102174.105 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:42:56.109Z,1560102176.109 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:42:59.345Z,1560102179.345 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:43:02.173Z,1560102182.173 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:43:05.401Z,1560102185.401 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:43:08.233Z,1560102188.233 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:43:11.481Z,1560102191.481 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:43:14.289Z,1560102194.289 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:43:17.117Z,1560102197.117 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:43:20.349Z,1560102200.349 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:43:23.181Z,1560102203.181 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:43:26.409Z,1560102206.409 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:43:29.237Z,1560102209.237 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:43:32.065Z,1560102212.065 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:43:34.101Z,1560102214.101 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:43:36.109Z,1560102216.109 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:43:39.341Z,1560102219.341 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:43:42.165Z,1560102222.165 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:43:45.397Z,1560102225.397 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:43:48.225Z,1560102228.225 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:43:51.461Z,1560102231.461 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:43:54.293Z,1560102234.293 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:43:57.113Z,1560102237.113 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:44:00.349Z,1560102240.349 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:44:03.177Z,1560102243.177 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:44:06.409Z,1560102246.409 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:44:09.237Z,1560102249.237 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:44:10.469Z,1560102250.469 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 8 2019-06-09T17:44:10.469Z,1560102250.469 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2019-06-09T17:44:10.479Z,1560102250.479 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2019-06-09T17:44:10.886Z,1560102250.886 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2019-06-09T17:44:10.892Z,1560102250.892 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 8 2019-06-09T17:44:12.469Z,1560102252.469 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:44:15.317Z,1560102255.317 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:44:18.141Z,1560102258.141 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:44:20.965Z,1560102260.965 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:44:23.381Z,1560102263.381 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error 2019-06-09T17:44:23.381Z,1560102263.381 [RDI_Pathfinder](ERROR): Failed to parse: :TS,19060910530812,35. 0.0,1448.9, 0 2019-06-09T17:44:23.781Z,1560102263.781 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:44:26.613Z,1560102266.613 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:44:29.841Z,1560102269.841 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:44:32.693Z,1560102272.693 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:44:35.901Z,1560102275.901 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:44:38.737Z,1560102278.737 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:44:41.989Z,1560102281.989 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:44:44.797Z,1560102284.797 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:44:48.021Z,1560102288.021 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:44:50.849Z,1560102290.849 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:44:53.677Z,1560102293.677 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:44:56.921Z,1560102296.921 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:44:59.737Z,1560102299.737 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:45:02.565Z,1560102302.565 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:45:04.589Z,1560102304.589 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:45:05.006Z,1560102305.006 [CommandLine](IMPORTANT): got command failComponent 2019-06-09T17:45:05.006Z,1560102305.006 [CommandLine](IMPORTANT): Failed components: 2019-06-09T17:45:05.006Z,1560102305.006 [CommandLine](IMPORTANT): No failed Components. 2019-06-09T17:45:07.821Z,1560102307.821 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:45:08.164Z,1560102308.164 [CommandLine](IMPORTANT): got command show stack 2019-06-09T17:45:08.164Z,1560102308.164 [CommandLine](IMPORTANT): Behavior Stack: 2019-06-09T17:45:08.164Z,1560102308.164 [Default](IMPORTANT): Priority 0: Default:B.GoToSurface 2019-06-09T17:45:08.165Z,1560102308.165 [Default:CheckIn](IMPORTANT): Priority 1: Default:CheckIn:C.Wait 2019-06-09T17:45:10.249Z,1560102310.249 [CommandLine](IMPORTANT): got command get latitude 2019-06-09T17:45:10.249Z,1560102310.249 [CommandLine](FAULT): Element has no value 2019-06-09T17:45:10.657Z,1560102310.657 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:45:13.893Z,1560102313.893 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:45:14.604Z,1560102314.604 [CommandLine](IMPORTANT): got command get latitude 2019-06-09T17:45:14.605Z,1560102314.605 [CommandLine](FAULT): Element has no value 2019-06-09T17:45:16.705Z,1560102316.705 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:45:19.957Z,1560102319.957 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:45:22.769Z,1560102322.769 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:45:25.593Z,1560102325.593 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:45:28.825Z,1560102328.825 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:45:31.661Z,1560102331.661 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:45:34.889Z,1560102334.889 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:45:37.713Z,1560102337.713 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:45:40.334Z,1560102340.334 [CommandLine](IMPORTANT): got command failComponent 2019-06-09T17:45:40.334Z,1560102340.334 [CommandLine](IMPORTANT): Failed components: 2019-06-09T17:45:40.335Z,1560102340.335 [CommandLine](IMPORTANT): No failed Components. 2019-06-09T17:45:40.961Z,1560102340.961 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:45:43.773Z,1560102343.773 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:45:46.605Z,1560102346.605 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:45:48.241Z,1560102348.241 [BPC1](INFO): Calculating totals. Valid battery stick count: 56. Valid reserve battery stick count: 6. 2019-06-09T17:45:48.244Z,1560102348.244 [BPC1](INFO): Received data from all battery sticks. 2019-06-09T17:45:49.837Z,1560102349.837 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:45:52.661Z,1560102352.661 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:45:55.897Z,1560102355.897 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:45:58.729Z,1560102358.729 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:46:01.985Z,1560102361.985 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:46:04.373Z,1560102364.373 [Micromodem](ERROR): Response from modem failed NMEA checksum: ,EFB,10*00 2019-06-09T17:46:04.789Z,1560102364.789 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:46:07.609Z,1560102367.609 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:46:08.407Z,1560102368.407 [Micromodem](ERROR): Response from modem failed NMEA checksum: $CACFG,FC0,$CAREV,174608,AUV,2.0.27690*19 2019-06-09T17:46:10.841Z,1560102370.841 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:46:13.669Z,1560102373.669 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:46:16.901Z,1560102376.901 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:46:19.729Z,1560102379.729 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:46:22.561Z,1560102382.561 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:46:23.033Z,1560102383.033 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for altitude 2019-06-09T17:46:23.033Z,1560102383.033 [RDI_Pathfinder](ERROR): Failed to parse: :BD, +0.00, , +0.00, 0.00,1565.89 2019-06-09T17:46:24.577Z,1560102384.577 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:46:27.809Z,1560102387.809 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:46:30.637Z,1560102390.637 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:46:33.869Z,1560102393.869 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:46:36.697Z,1560102396.697 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:46:39.966Z,1560102399.966 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:46:42.761Z,1560102402.761 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:46:45.589Z,1560102405.589 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:46:48.009Z,1560102408.009 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:46:50.837Z,1560102410.837 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:46:54.073Z,1560102414.073 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:46:56.917Z,1560102416.917 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:46:59.725Z,1560102419.725 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:47:02.553Z,1560102422.553 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:47:04.573Z,1560102424.573 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:47:07.805Z,1560102427.805 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:47:10.633Z,1560102430.633 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:47:11.469Z,1560102431.469 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 9 2019-06-09T17:47:11.469Z,1560102431.469 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2019-06-09T17:47:11.479Z,1560102431.479 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2019-06-09T17:47:11.871Z,1560102431.871 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2019-06-09T17:47:11.871Z,1560102431.871 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 9 2019-06-09T17:47:13.865Z,1560102433.865 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:47:16.693Z,1560102436.693 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:47:19.961Z,1560102439.961 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:47:22.753Z,1560102442.753 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:47:25.581Z,1560102445.581 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:47:28.813Z,1560102448.813 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:47:29.666Z,1560102449.666 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2019-06-09T17:47:29.666Z,1560102449.666 [Default:CheckIn:C.Wait] Stopped 2019-06-09T17:47:29.666Z,1560102449.666 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2019-06-09T17:47:29.666Z,1560102449.666 [Default:CheckIn:D] Running Loop=1 2019-06-09T17:47:30.066Z,1560102450.066 [Default:CheckIn:D] Stopped 2019-06-09T17:47:30.066Z,1560102450.066 [Default:CheckIn:E] Running Loop=1 2019-06-09T17:47:30.448Z,1560102450.448 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 24.180959 min 2019-06-09T17:47:30.448Z,1560102450.448 [Default:CheckIn:E] Stopped 2019-06-09T17:47:30.448Z,1560102450.448 [Default:CheckIn](INFO): Completed Default:CheckIn 2019-06-09T17:47:30.448Z,1560102450.448 [Default:CheckIn] Stopped 2019-06-09T17:47:30.448Z,1560102450.448 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2019-06-09T17:47:30.449Z,1560102450.449 [Default:CheckIn](INFO): Running loop #3 2019-06-09T17:47:30.449Z,1560102450.449 [Default:CheckIn] Running Loop=3 2019-06-09T17:47:30.449Z,1560102450.449 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2019-06-09T17:47:30.449Z,1560102450.449 [Default:CheckIn:Read_GPS] Running Loop=1 2019-06-09T17:47:31.661Z,1560102451.661 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:47:34.873Z,1560102454.873 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:47:37.701Z,1560102457.701 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:47:40.961Z,1560102460.961 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:47:43.761Z,1560102463.761 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:47:46.597Z,1560102466.597 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:47:49.821Z,1560102469.821 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:47:52.669Z,1560102472.669 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:47:55.881Z,1560102475.881 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:47:58.709Z,1560102478.709 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:48:01.981Z,1560102481.981 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:48:04.773Z,1560102484.773 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:48:07.599Z,1560102487.599 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:48:10.837Z,1560102490.837 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:48:13.657Z,1560102493.657 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:48:16.893Z,1560102496.893 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:48:19.721Z,1560102499.721 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:48:22.545Z,1560102502.545 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:48:24.565Z,1560102504.565 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:48:26.585Z,1560102506.585 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:48:29.821Z,1560102509.821 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:48:32.653Z,1560102512.653 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:48:35.877Z,1560102515.877 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:48:38.705Z,1560102518.705 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:48:41.937Z,1560102521.937 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:48:44.773Z,1560102524.773 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:48:47.997Z,1560102527.997 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:48:50.825Z,1560102530.825 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:48:54.057Z,1560102534.057 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:48:56.889Z,1560102536.889 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:48:59.713Z,1560102539.713 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:49:02.541Z,1560102542.541 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:49:04.561Z,1560102544.561 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:49:06.593Z,1560102546.593 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:49:09.817Z,1560102549.817 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:49:12.649Z,1560102552.649 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:49:15.881Z,1560102555.881 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:49:18.705Z,1560102558.705 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:49:21.529Z,1560102561.529 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:49:23.953Z,1560102563.953 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:49:26.785Z,1560102566.785 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:49:30.013Z,1560102570.013 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:49:32.841Z,1560102572.841 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:49:36.081Z,1560102576.081 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:49:38.905Z,1560102578.905 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:49:41.729Z,1560102581.729 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:49:44.557Z,1560102584.557 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:49:46.589Z,1560102586.589 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:49:49.813Z,1560102589.813 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:49:52.645Z,1560102592.645 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:49:55.885Z,1560102595.885 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:49:58.701Z,1560102598.701 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:50:01.937Z,1560102601.937 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:50:04.761Z,1560102604.761 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:50:07.589Z,1560102607.589 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:50:10.825Z,1560102610.825 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:50:12.445Z,1560102612.445 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 10 2019-06-09T17:50:12.445Z,1560102612.445 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2019-06-09T17:50:12.455Z,1560102612.455 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2019-06-09T17:50:12.873Z,1560102612.873 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2019-06-09T17:50:12.873Z,1560102612.873 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 10 2019-06-09T17:50:13.645Z,1560102613.645 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:50:16.881Z,1560102616.881 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:50:19.713Z,1560102619.713 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:50:22.533Z,1560102622.533 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:50:24.557Z,1560102624.557 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:50:26.573Z,1560102626.573 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:50:28.593Z,1560102628.593 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:50:31.837Z,1560102631.837 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:50:34.653Z,1560102634.653 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:50:37.885Z,1560102637.885 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:50:40.713Z,1560102640.713 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:50:43.545Z,1560102643.545 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:50:45.561Z,1560102645.561 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:50:47.993Z,1560102647.993 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:50:50.817Z,1560102650.817 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:50:54.045Z,1560102654.045 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:50:56.877Z,1560102656.877 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:50:59.701Z,1560102659.701 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:51:02.937Z,1560102662.937 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:51:05.761Z,1560102665.761 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:51:08.589Z,1560102668.589 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:51:11.821Z,1560102671.821 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:51:14.649Z,1560102674.649 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:51:17.881Z,1560102677.881 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:51:20.713Z,1560102680.713 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:51:23.941Z,1560102683.941 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:51:26.773Z,1560102686.773 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:51:30.001Z,1560102690.001 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:51:32.829Z,1560102692.829 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:51:36.061Z,1560102696.061 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:51:38.890Z,1560102698.890 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:51:41.718Z,1560102701.718 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:51:44.545Z,1560102704.545 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:51:46.565Z,1560102706.565 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:51:48.593Z,1560102708.593 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:51:51.817Z,1560102711.817 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:51:54.649Z,1560102714.649 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:51:57.877Z,1560102717.877 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:52:00.705Z,1560102720.705 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:52:03.941Z,1560102723.941 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:52:06.765Z,1560102726.765 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:52:09.583Z,1560102729.583 [NAL9602](FAULT): GPS failed to acquire within timeout. 2019-06-09T17:52:09.583Z,1560102729.583 [NAL9602] Data Fault, FailCount= 3 2019-06-09T17:52:09.583Z,1560102729.583 [NAL9602](ERROR): Data Fault 2019-06-09T17:52:09.618Z,1560102729.618 [CBIT](ERROR): Data Fault in component: NAL9602 2019-06-09T17:52:09.987Z,1560102729.987 [NAL9602](INFO): Powering down 2019-06-09T17:52:10.846Z,1560102730.846 [CBIT](INFO): Clearing failed state for component NAL9602 2019-06-09T17:52:10.846Z,1560102730.846 [NAL9602] No Fault, FailCount= 3 2019-06-09T17:52:30.614Z,1560102750.614 [Default:CheckIn:Read_GPS](INFO): Timed out from 2019-06-09T17:47:30.4Z 2019-06-09T17:52:30.614Z,1560102750.614 [Default:CheckIn:Read_GPS] Stopped 2019-06-09T17:52:30.614Z,1560102750.614 [Default:CheckIn:Read_Iridium] Running Loop=1 2019-06-09T17:52:36.249Z,1560102756.249 [DataOverHttps](INFO): Sending 187 bytes from file Logs/20190609T171951/Courier0010.lzma 2019-06-09T17:52:37.054Z,1560102757.054 [DataOverHttps](INFO): Moved sent file to Logs/20190609T171951/Courier0010.lzma.bak 2019-06-09T17:52:37.054Z,1560102757.054 [DataOverHttps](INFO): SBD MOMSN=11358063 2019-06-09T17:52:39.991Z,1560102759.991 [NAL9602](INFO): Powering up NAL9602 2019-06-09T17:52:49.022Z,1560102769.022 [DataOverHttps](INFO): Sending 1181 bytes from file Logs/20190609T171951/Express0011.lzma 2019-06-09T17:52:49.826Z,1560102769.826 [DataOverHttps](INFO): Moved sent file to Logs/20190609T171951/Express0011.lzma.bak 2019-06-09T17:52:49.827Z,1560102769.827 [DataOverHttps](INFO): SBD MOMSN=11358065 2019-06-09T17:52:50.939Z,1560102770.939 [NAL9602](INFO): NAL9602 initialized 2019-06-09T17:52:50.994Z,1560102770.994 [Default:CheckIn:Read_Iridium] Stopped 2019-06-09T17:52:50.994Z,1560102770.994 [Default:CheckIn:C.Wait] Running Loop=1 2019-06-09T17:52:50.994Z,1560102770.994 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2019-06-09T17:52:51.717Z,1560102771.717 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:52:53.737Z,1560102773.737 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:52:56.569Z,1560102776.569 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:52:59.797Z,1560102779.797 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:53:02.629Z,1560102782.629 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:53:05.857Z,1560102785.857 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:53:08.689Z,1560102788.689 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:53:11.917Z,1560102791.917 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:53:13.549Z,1560102793.549 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 11 2019-06-09T17:53:13.549Z,1560102793.549 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2019-06-09T17:53:13.559Z,1560102793.559 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2019-06-09T17:53:13.977Z,1560102793.977 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2019-06-09T17:53:13.978Z,1560102793.978 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 11 2019-06-09T17:53:14.749Z,1560102794.749 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:53:17.977Z,1560102797.977 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:53:20.821Z,1560102800.821 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:53:24.045Z,1560102804.045 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:53:26.873Z,1560102806.873 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:53:29.697Z,1560102809.697 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:53:32.525Z,1560102812.525 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:53:34.545Z,1560102814.545 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:53:37.773Z,1560102817.773 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:53:40.605Z,1560102820.605 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:53:43.837Z,1560102823.837 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:53:46.665Z,1560102826.665 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:53:49.902Z,1560102829.902 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:53:52.721Z,1560102832.721 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:53:55.561Z,1560102835.561 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:53:58.384Z,1560102838.384 [Micromodem](ERROR): Response from modem failed NMEA checksum: .10.0.46*4A 2019-06-09T17:53:58.789Z,1560102838.789 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:54:01.609Z,1560102841.609 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:54:04.849Z,1560102844.849 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:54:07.669Z,1560102847.669 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:54:10.509Z,1560102850.509 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:54:12.517Z,1560102852.517 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:54:14.545Z,1560102854.545 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:54:16.561Z,1560102856.561 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:54:19.789Z,1560102859.789 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:54:22.617Z,1560102862.617 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:54:25.849Z,1560102865.849 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:54:28.677Z,1560102868.677 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:54:31.517Z,1560102871.517 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:54:33.529Z,1560102873.529 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:54:35.949Z,1560102875.949 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:54:38.777Z,1560102878.777 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:54:42.013Z,1560102882.013 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:54:44.841Z,1560102884.841 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:54:45.671Z,1560102885.671 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error 2019-06-09T17:54:45.671Z,1560102885.671 [RDI_Pathfinder](ERROR): Failed to parse: :TS,19060911033012,35.0, -0.1, 0.0,144 2019-06-09T17:54:48.073Z,1560102888.073 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:54:50.910Z,1560102890.910 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:54:53.725Z,1560102893.725 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:54:56.557Z,1560102896.557 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:54:59.785Z,1560102899.785 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:55:02.621Z,1560102902.621 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:55:05.861Z,1560102905.861 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:55:08.681Z,1560102908.681 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:55:11.909Z,1560102911.909 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:55:14.737Z,1560102914.737 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:55:17.977Z,1560102917.977 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:55:20.793Z,1560102920.793 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:55:24.025Z,1560102924.025 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:55:26.857Z,1560102926.857 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:55:29.685Z,1560102929.685 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:55:32.517Z,1560102932.517 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:55:34.529Z,1560102934.529 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:55:36.557Z,1560102936.557 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:55:39.781Z,1560102939.781 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:55:42.625Z,1560102942.625 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:55:45.841Z,1560102945.841 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:55:48.669Z,1560102948.669 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:55:51.901Z,1560102951.901 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:55:54.729Z,1560102954.729 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:55:57.557Z,1560102957.557 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:55:59.992Z,1560102959.992 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:56:02.809Z,1560102962.809 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:56:06.049Z,1560102966.049 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:56:08.869Z,1560102968.869 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:56:11.705Z,1560102971.705 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:56:14.529Z,1560102974.529 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:56:14.553Z,1560102974.553 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 12 2019-06-09T17:56:14.553Z,1560102974.553 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2019-06-09T17:56:14.583Z,1560102974.583 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2019-06-09T17:56:14.967Z,1560102974.967 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2019-06-09T17:56:14.968Z,1560102974.968 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 12 2019-06-09T17:56:16.549Z,1560102976.549 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:56:19.789Z,1560102979.789 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:56:22.613Z,1560102982.613 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:56:25.837Z,1560102985.837 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:56:28.669Z,1560102988.669 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:56:31.897Z,1560102991.897 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:56:34.729Z,1560102994.729 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:56:37.553Z,1560102997.553 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:56:40.785Z,1560103000.785 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:56:43.617Z,1560103003.617 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:56:46.849Z,1560103006.849 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:56:49.681Z,1560103009.681 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:56:52.501Z,1560103012.501 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:56:54.537Z,1560103014.537 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:56:56.545Z,1560103016.545 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:56:59.773Z,1560103019.773 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:57:02.605Z,1560103022.605 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:57:05.833Z,1560103025.833 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:57:08.665Z,1560103028.665 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:57:11.893Z,1560103031.893 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:57:14.725Z,1560103034.725 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:57:17.969Z,1560103037.969 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:57:20.781Z,1560103040.781 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:57:24.013Z,1560103044.013 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:57:26.845Z,1560103046.845 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:57:30.093Z,1560103050.093 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:57:32.905Z,1560103052.905 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:57:35.737Z,1560103055.737 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:57:38.565Z,1560103058.565 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:57:41.793Z,1560103061.793 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:57:44.617Z,1560103064.617 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:57:47.857Z,1560103067.857 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:57:50.681Z,1560103070.681 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:57:51.514Z,1560103071.514 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2019-06-09T17:57:51.514Z,1560103071.514 [Default:CheckIn:C.Wait] Stopped 2019-06-09T17:57:51.514Z,1560103071.514 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2019-06-09T17:57:51.514Z,1560103071.514 [Default:CheckIn:D] Running Loop=1 2019-06-09T17:57:51.912Z,1560103071.912 [Default:CheckIn:D] Stopped 2019-06-09T17:57:51.912Z,1560103071.912 [Default:CheckIn:E] Running Loop=1 2019-06-09T17:57:52.319Z,1560103072.319 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 34.545060 min 2019-06-09T17:57:52.319Z,1560103072.319 [Default:CheckIn:E] Stopped 2019-06-09T17:57:52.319Z,1560103072.319 [Default:CheckIn](INFO): Completed Default:CheckIn 2019-06-09T17:57:52.319Z,1560103072.319 [Default:CheckIn] Stopped 2019-06-09T17:57:52.319Z,1560103072.319 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2019-06-09T17:57:52.319Z,1560103072.319 [Default:CheckIn](INFO): Running loop #4 2019-06-09T17:57:52.319Z,1560103072.319 [Default:CheckIn] Running Loop=4 2019-06-09T17:57:52.320Z,1560103072.320 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2019-06-09T17:57:52.320Z,1560103072.320 [Default:CheckIn:Read_GPS] Running Loop=1 2019-06-09T17:57:53.909Z,1560103073.909 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:57:56.741Z,1560103076.741 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:57:59.973Z,1560103079.973 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:58:02.801Z,1560103082.801 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:58:06.045Z,1560103086.045 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:58:08.861Z,1560103088.861 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:58:11.689Z,1560103091.689 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:58:14.517Z,1560103094.517 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:58:16.537Z,1560103096.537 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:58:19.765Z,1560103099.765 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:58:22.601Z,1560103102.601 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:58:25.825Z,1560103105.825 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:58:28.653Z,1560103108.653 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:58:31.885Z,1560103111.885 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:58:34.717Z,1560103114.717 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:58:37.541Z,1560103117.541 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:58:40.777Z,1560103120.777 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:58:43.605Z,1560103123.605 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:58:46.833Z,1560103126.833 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:58:49.677Z,1560103129.677 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:58:52.893Z,1560103132.893 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:58:55.729Z,1560103135.729 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:58:58.549Z,1560103138.549 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:59:01.781Z,1560103141.781 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:59:04.609Z,1560103144.609 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:59:07.841Z,1560103147.841 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:59:10.669Z,1560103150.669 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:59:13.905Z,1560103153.905 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:59:15.551Z,1560103155.551 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 13 2019-06-09T17:59:15.551Z,1560103155.551 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2019-06-09T17:59:15.573Z,1560103155.573 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2019-06-09T17:59:15.960Z,1560103155.960 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2019-06-09T17:59:15.960Z,1560103155.960 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 13 2019-06-09T17:59:16.745Z,1560103156.745 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:59:19.561Z,1560103159.561 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:59:22.789Z,1560103162.789 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:59:25.621Z,1560103165.621 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:59:28.448Z,1560103168.448 [Micromodem](ERROR): Response from modem failed NMEA checksum: CAREV175928,AUV,2.0.27690*15 2019-06-09T17:59:28.857Z,1560103168.857 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:59:31.681Z,1560103171.681 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:59:34.505Z,1560103174.505 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:59:36.525Z,1560103176.525 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:59:38.545Z,1560103178.545 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:59:41.781Z,1560103181.781 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:59:44.609Z,1560103184.609 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:59:47.845Z,1560103187.845 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:59:50.669Z,1560103190.669 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:59:53.913Z,1560103193.913 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:59:56.729Z,1560103196.729 [NAL9602](DEBUG): Fix Requested 2019-06-09T17:59:59.965Z,1560103199.965 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:00:02.789Z,1560103202.789 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:00:06.029Z,1560103206.029 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:00:08.853Z,1560103208.853 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:00:11.681Z,1560103211.681 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:00:14.909Z,1560103214.909 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:00:17.737Z,1560103217.737 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:00:20.569Z,1560103220.569 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:00:23.797Z,1560103223.797 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:00:26.625Z,1560103226.625 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:00:29.865Z,1560103229.865 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:00:32.689Z,1560103232.689 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:00:35.917Z,1560103235.917 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:00:38.757Z,1560103238.757 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:00:41.989Z,1560103241.989 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:00:44.809Z,1560103244.809 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:00:48.037Z,1560103248.037 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:00:50.865Z,1560103250.865 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:00:53.693Z,1560103253.693 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:00:56.529Z,1560103256.529 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:00:58.541Z,1560103258.541 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:01:01.773Z,1560103261.773 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:01:04.605Z,1560103264.605 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:01:07.833Z,1560103267.833 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:01:10.661Z,1560103270.661 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:01:13.897Z,1560103273.897 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:01:16.721Z,1560103276.721 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:01:19.553Z,1560103279.553 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:01:22.784Z,1560103282.784 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:01:25.617Z,1560103285.617 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:01:28.845Z,1560103288.845 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:01:31.669Z,1560103291.669 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:01:34.905Z,1560103294.905 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:01:37.729Z,1560103297.729 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:01:40.569Z,1560103300.569 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:01:43.789Z,1560103303.789 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:01:46.621Z,1560103306.621 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:01:49.853Z,1560103309.853 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:01:52.685Z,1560103312.685 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:01:55.913Z,1560103315.913 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:01:58.745Z,1560103318.745 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:02:01.569Z,1560103321.569 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:02:04.797Z,1560103324.797 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:02:07.625Z,1560103327.625 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:02:10.861Z,1560103330.861 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:02:13.685Z,1560103333.685 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:02:16.525Z,1560103336.525 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:02:16.554Z,1560103336.554 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 14 2019-06-09T18:02:16.554Z,1560103336.554 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2019-06-09T18:02:16.565Z,1560103336.565 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2019-06-09T18:02:16.990Z,1560103336.990 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2019-06-09T18:02:16.990Z,1560103336.990 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 14 2019-06-09T18:02:18.537Z,1560103338.537 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:02:20.557Z,1560103340.557 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:02:23.785Z,1560103343.785 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:02:26.621Z,1560103346.621 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:02:29.849Z,1560103349.849 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:02:32.685Z,1560103352.685 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:02:35.913Z,1560103355.913 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:02:38.733Z,1560103358.733 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:02:41.977Z,1560103361.977 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:02:44.797Z,1560103364.797 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:02:48.029Z,1560103368.029 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:02:50.877Z,1560103370.877 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:02:52.490Z,1560103372.490 [Default:CheckIn:Read_GPS](INFO): Timed out from 2019-06-09T17:57:52.3Z 2019-06-09T18:02:52.490Z,1560103372.490 [Default:CheckIn:Read_GPS] Stopped 2019-06-09T18:02:52.490Z,1560103372.490 [Default:CheckIn:Read_Iridium] Running Loop=1 2019-06-09T18:02:53.755Z,1560103373.755 [NAL9602](FAULT): GPS failed to acquire within timeout. 2019-06-09T18:02:53.755Z,1560103373.755 [NAL9602] Data Fault, FailCount= 4 2019-06-09T18:02:53.755Z,1560103373.755 [NAL9602](ERROR): Data Fault 2019-06-09T18:02:53.790Z,1560103373.790 [CBIT](ERROR): Data Fault in component: NAL9602 2019-06-09T18:02:54.167Z,1560103374.167 [NAL9602](INFO): Powering down 2019-06-09T18:02:55.039Z,1560103375.039 [CBIT](INFO): Clearing failed state for component NAL9602 2019-06-09T18:02:55.039Z,1560103375.039 [NAL9602] No Fault, FailCount= 4 2019-06-09T18:02:58.284Z,1560103378.284 [DataOverHttps](INFO): Sending 25 bytes from file Logs/20190609T171951/Courier0013.lzma 2019-06-09T18:02:59.090Z,1560103379.090 [DataOverHttps](INFO): Moved sent file to Logs/20190609T171951/Courier0013.lzma.bak 2019-06-09T18:02:59.091Z,1560103379.091 [DataOverHttps](INFO): SBD MOMSN=11358097 2019-06-09T18:03:10.766Z,1560103390.766 [DataOverHttps](INFO): Sending 862 bytes from file Logs/20190609T171951/Express0014.lzma 2019-06-09T18:03:11.570Z,1560103391.570 [DataOverHttps](INFO): Moved sent file to Logs/20190609T171951/Express0014.lzma.bak 2019-06-09T18:03:11.571Z,1560103391.571 [DataOverHttps](INFO): SBD MOMSN=11358099 2019-06-09T18:03:12.798Z,1560103392.798 [Default:CheckIn:Read_Iridium] Stopped 2019-06-09T18:03:12.798Z,1560103392.798 [Default:CheckIn:C.Wait] Running Loop=1 2019-06-09T18:03:12.798Z,1560103392.798 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2019-06-09T18:03:24.459Z,1560103404.459 [NAL9602](INFO): Powering up NAL9602 2019-06-09T18:03:28.511Z,1560103408.511 [Micromodem](ERROR): Response from modem failed NMEA checksum: $CAREV,1ut of range*0E 2019-06-09T18:03:28.512Z,1560103408.512 [Micromodem](ERROR): Response from modem failed NMEA checksum: 80328,AUV,2.0.27690*15 2019-06-09T18:03:35.371Z,1560103415.371 [NAL9602](INFO): NAL9602 initialized 2019-06-09T18:03:36.193Z,1560103416.193 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:03:39.021Z,1560103419.021 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:03:42.253Z,1560103422.253 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:03:45.081Z,1560103425.081 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:03:47.957Z,1560103427.957 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:03:49.953Z,1560103429.953 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:03:51.977Z,1560103431.977 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:03:55.201Z,1560103435.201 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:03:58.005Z,1560103438.005 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:04:01.237Z,1560103441.237 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:04:04.065Z,1560103444.065 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:04:07.297Z,1560103447.297 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:04:10.133Z,1560103450.133 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:04:12.953Z,1560103452.953 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:04:16.185Z,1560103456.185 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:04:19.013Z,1560103459.013 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:04:22.257Z,1560103462.257 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:04:25.073Z,1560103465.073 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:04:27.910Z,1560103467.910 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:04:27.948Z,1560103467.948 [RDI_Pathfinder](ERROR): only read 2 of 4 data items 2019-06-09T18:04:27.948Z,1560103467.948 [RDI_Pathfinder](ERROR): Failed to parse: :BS,32768,-32768,V 2019-06-09T18:04:30.729Z,1560103470.729 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:04:33.569Z,1560103473.569 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:04:35.989Z,1560103475.989 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:04:38.821Z,1560103478.821 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:04:42.053Z,1560103482.053 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:04:44.877Z,1560103484.877 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:04:47.705Z,1560103487.705 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:04:48.508Z,1560103488.508 [Micromodem](ERROR): Response from modem failed NMEA checksum: .mode,0*1A 2019-06-09T18:04:48.526Z,1560103488.526 [Micromodem](ERROR): Response from modem failed NMEA checksum: AREV,180448,AUV,2.0.27690*14 2019-06-09T18:04:50.537Z,1560103490.537 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:04:52.553Z,1560103492.553 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:04:55.789Z,1560103495.789 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:04:58.613Z,1560103498.613 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:05:01.853Z,1560103501.853 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:05:04.673Z,1560103504.673 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:05:07.505Z,1560103507.505 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:05:09.521Z,1560103509.521 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:05:11.973Z,1560103511.973 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:05:14.777Z,1560103514.777 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:05:17.611Z,1560103517.611 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 15 2019-06-09T18:05:17.611Z,1560103517.611 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2019-06-09T18:05:17.621Z,1560103517.621 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2019-06-09T18:05:18.009Z,1560103518.009 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:05:18.047Z,1560103518.047 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2019-06-09T18:05:18.047Z,1560103518.047 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 15 2019-06-09T18:05:20.833Z,1560103520.833 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:05:24.070Z,1560103524.070 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:05:24.490Z,1560103524.490 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error 2019-06-09T18:05:24.490Z,1560103524.490 [RDI_Pathfinder](ERROR): Failed to parse: :TS,19060911140912,35.0, -0.1, 0.0,14 2019-06-09T18:05:26.894Z,1560103526.894 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:05:28.520Z,1560103528.520 [Micromodem](ERROR): Response from modem failed NMEA checksum: $448,COPROC,0.10.0.46*41 2019-06-09T18:05:29.721Z,1560103529.721 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:05:32.549Z,1560103532.549 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:05:35.789Z,1560103535.789 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:05:38.609Z,1560103538.609 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:05:41.857Z,1560103541.857 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:05:44.669Z,1560103544.669 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:05:47.910Z,1560103547.910 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:05:50.733Z,1560103550.733 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:05:53.961Z,1560103553.961 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:05:56.789Z,1560103556.789 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:06:00.021Z,1560103560.021 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:06:02.853Z,1560103562.853 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:06:05.685Z,1560103565.685 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:06:08.514Z,1560103568.514 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:06:10.525Z,1560103570.525 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:06:12.553Z,1560103572.553 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:06:15.793Z,1560103575.793 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:06:18.609Z,1560103578.609 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:06:21.837Z,1560103581.837 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:06:24.665Z,1560103584.665 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:06:27.910Z,1560103587.910 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:06:30.725Z,1560103590.725 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:06:33.553Z,1560103593.553 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:06:35.989Z,1560103595.989 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:06:38.821Z,1560103598.821 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:06:42.041Z,1560103602.041 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:06:44.869Z,1560103604.869 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:06:47.693Z,1560103607.693 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:06:50.525Z,1560103610.525 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:06:52.541Z,1560103612.541 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:06:53.394Z,1560103613.394 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error 2019-06-09T18:06:53.394Z,1560103613.394 [RDI_Pathfinder](ERROR): Failed to parse: :TS,19060911150, -0.1, 0.0,1448.9, 0 2019-06-09T18:06:55.781Z,1560103615.781 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:06:58.591Z,1560103618.591 [Micromodem](ERROR): Response from modem failed NMEA checksum: ,188,AUV,2.0.27690*17 2019-06-09T18:06:58.605Z,1560103618.605 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:07:01.833Z,1560103621.833 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:07:04.665Z,1560103624.665 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:07:07.898Z,1560103627.898 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:07:10.721Z,1560103630.721 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:07:13.549Z,1560103633.549 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:07:16.781Z,1560103636.781 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:07:19.613Z,1560103639.613 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:07:22.845Z,1560103642.845 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:07:25.673Z,1560103645.673 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:07:28.929Z,1560103648.929 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:07:31.733Z,1560103651.733 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:07:34.561Z,1560103654.561 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:07:37.789Z,1560103657.789 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:07:40.621Z,1560103660.621 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:07:43.849Z,1560103663.849 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:07:46.681Z,1560103666.681 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:07:49.513Z,1560103669.513 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:07:51.529Z,1560103671.529 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:07:53.949Z,1560103673.949 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:07:56.777Z,1560103676.777 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:08:00.009Z,1560103680.009 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:08:02.837Z,1560103682.837 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:08:05.677Z,1560103685.677 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:08:08.901Z,1560103688.901 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:08:11.725Z,1560103691.725 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:08:13.380Z,1560103693.380 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2019-06-09T18:08:13.380Z,1560103693.380 [Default:CheckIn:C.Wait] Stopped 2019-06-09T18:08:13.380Z,1560103693.380 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2019-06-09T18:08:13.380Z,1560103693.380 [Default:CheckIn:D] Running Loop=1 2019-06-09T18:08:13.758Z,1560103693.758 [Default:CheckIn:D] Stopped 2019-06-09T18:08:13.758Z,1560103693.758 [Default:CheckIn:E] Running Loop=1 2019-06-09T18:08:14.170Z,1560103694.170 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 44.909159 min 2019-06-09T18:08:14.170Z,1560103694.170 [Default:CheckIn:E] Stopped 2019-06-09T18:08:14.171Z,1560103694.171 [Default:CheckIn](INFO): Completed Default:CheckIn 2019-06-09T18:08:14.171Z,1560103694.171 [Default:CheckIn] Stopped 2019-06-09T18:08:14.171Z,1560103694.171 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2019-06-09T18:08:14.171Z,1560103694.171 [Default:CheckIn](INFO): Running loop #5 2019-06-09T18:08:14.171Z,1560103694.171 [Default:CheckIn] Running Loop=5 2019-06-09T18:08:14.171Z,1560103694.171 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2019-06-09T18:08:14.171Z,1560103694.171 [Default:CheckIn:Read_GPS] Running Loop=1 2019-06-09T18:08:14.553Z,1560103694.553 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:08:17.789Z,1560103697.789 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:08:18.637Z,1560103698.637 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 16 2019-06-09T18:08:18.637Z,1560103698.637 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2019-06-09T18:08:18.647Z,1560103698.647 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2019-06-09T18:08:19.050Z,1560103699.050 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2019-06-09T18:08:19.050Z,1560103699.050 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 16 2019-06-09T18:08:20.617Z,1560103700.617 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:08:23.845Z,1560103703.845 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:08:26.673Z,1560103706.673 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:08:29.914Z,1560103709.914 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:08:32.737Z,1560103712.737 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:08:35.969Z,1560103715.969 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:08:38.798Z,1560103718.798 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:08:42.029Z,1560103722.029 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:08:44.857Z,1560103724.857 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:08:47.681Z,1560103727.681 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:08:50.509Z,1560103730.509 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:08:52.529Z,1560103732.529 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:08:55.765Z,1560103735.765 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:08:58.592Z,1560103738.592 [Micromodem](ERROR): Response from modem failed NMEA checksum: 6*48 2019-06-09T18:08:58.594Z,1560103738.594 [Micromodem](ERROR): Response from modem failed NMEA checksum: 180858,AUV,2.0.27690*19 2019-06-09T18:08:58.610Z,1560103738.610 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:09:01.821Z,1560103741.821 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:09:04.649Z,1560103744.649 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:09:07.881Z,1560103747.881 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:09:10.709Z,1560103750.709 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:09:13.537Z,1560103753.537 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:09:15.557Z,1560103755.557 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:09:17.981Z,1560103757.981 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:09:20.813Z,1560103760.813 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:09:24.045Z,1560103764.045 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:09:26.877Z,1560103766.877 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:09:29.701Z,1560103769.701 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:09:32.525Z,1560103772.525 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:09:35.761Z,1560103775.761 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:09:38.585Z,1560103778.585 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:09:41.821Z,1560103781.821 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:09:44.645Z,1560103784.645 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:09:47.881Z,1560103787.881 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:09:50.707Z,1560103790.707 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:09:53.949Z,1560103793.949 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:09:56.765Z,1560103796.765 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:10:00.001Z,1560103800.001 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:10:02.829Z,1560103802.829 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:10:06.061Z,1560103806.061 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:10:08.894Z,1560103808.894 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:10:11.713Z,1560103811.713 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:10:14.549Z,1560103814.549 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:10:17.777Z,1560103817.777 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:10:20.605Z,1560103820.605 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:10:23.833Z,1560103823.833 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:10:26.665Z,1560103826.665 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:10:29.901Z,1560103829.901 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:10:32.737Z,1560103832.737 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:10:35.965Z,1560103835.965 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:10:38.789Z,1560103838.789 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:10:42.025Z,1560103842.025 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:10:44.857Z,1560103844.857 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:10:47.677Z,1560103847.677 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:10:50.509Z,1560103850.509 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:10:52.541Z,1560103852.541 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:10:55.765Z,1560103855.765 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:10:58.589Z,1560103858.589 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:11:01.841Z,1560103861.841 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:11:04.649Z,1560103864.649 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:11:07.881Z,1560103867.881 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:11:10.709Z,1560103870.709 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:11:13.537Z,1560103873.537 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:11:16.769Z,1560103876.769 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:11:19.597Z,1560103879.597 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:11:19.631Z,1560103879.631 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 17 2019-06-09T18:11:19.631Z,1560103879.631 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2019-06-09T18:11:19.641Z,1560103879.641 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2019-06-09T18:11:20.064Z,1560103880.064 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2019-06-09T18:11:20.064Z,1560103880.064 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 17 2019-06-09T18:11:22.829Z,1560103882.829 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:11:25.665Z,1560103885.665 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:11:28.906Z,1560103888.906 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:11:31.725Z,1560103891.725 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:11:34.549Z,1560103894.549 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:11:37.777Z,1560103897.777 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:11:40.613Z,1560103900.613 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:11:43.837Z,1560103903.837 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:11:46.669Z,1560103906.669 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:11:49.949Z,1560103909.949 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:11:52.725Z,1560103912.725 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:11:55.557Z,1560103915.557 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:11:58.801Z,1560103918.801 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:12:01.613Z,1560103921.613 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:12:04.849Z,1560103924.849 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:12:07.673Z,1560103927.673 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:12:10.505Z,1560103930.505 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:12:12.522Z,1560103932.522 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:12:13.368Z,1560103933.368 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error 2019-06-09T18:12:13.369Z,1560103933.369 [RDI_Pathfinder](ERROR): Failed to parse: :TS,190609115.0, -0.1, 0.0,1448.9, 0 2019-06-09T18:12:15.757Z,1560103935.757 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:12:18.589Z,1560103938.589 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:12:21.817Z,1560103941.817 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:12:24.645Z,1560103944.645 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:12:27.873Z,1560103947.873 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:12:28.677Z,1560103948.677 [Micromodem](ERROR): Response from modem failed NMEA checksum: $CA*15 2019-06-09T18:12:30.705Z,1560103950.705 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:12:33.529Z,1560103953.529 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:12:35.961Z,1560103955.961 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:12:38.785Z,1560103958.785 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:12:42.021Z,1560103962.021 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:12:44.845Z,1560103964.845 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:12:48.081Z,1560103968.081 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:12:50.501Z,1560103970.501 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:12:52.517Z,1560103972.517 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:12:54.545Z,1560103974.545 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:12:57.773Z,1560103977.773 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:13:00.601Z,1560103980.601 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:13:03.829Z,1560103983.829 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:13:06.661Z,1560103986.661 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:13:09.897Z,1560103989.897 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:13:12.721Z,1560103992.721 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:13:14.350Z,1560103994.350 [Default:CheckIn:Read_GPS](INFO): Timed out from 2019-06-09T18:08:14.2Z 2019-06-09T18:13:14.351Z,1560103994.351 [Default:CheckIn:Read_GPS] Stopped 2019-06-09T18:13:14.351Z,1560103994.351 [Default:CheckIn:Read_Iridium] Running Loop=1 2019-06-09T18:13:15.625Z,1560103995.625 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:13:18.057Z,1560103998.057 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:13:18.847Z,1560103998.847 [Micromodem](ERROR): Response from modem failed NMEA checksum: ,0.10.0.46*43 2019-06-09T18:13:19.576Z,1560103999.576 [DataOverHttps](INFO): Sending 25 bytes from file Logs/20190609T171951/Courier0016.lzma 2019-06-09T18:13:20.382Z,1560104000.382 [DataOverHttps](INFO): Moved sent file to Logs/20190609T171951/Courier0016.lzma.bak 2019-06-09T18:13:20.382Z,1560104000.382 [DataOverHttps](INFO): SBD MOMSN=11358111 2019-06-09T18:13:20.873Z,1560104000.873 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:13:23.705Z,1560104003.705 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:13:26.529Z,1560104006.529 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:13:29.765Z,1560104009.765 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:13:32.278Z,1560104012.278 [DataOverHttps](INFO): Sending 905 bytes from file Logs/20190609T171951/Express0017.lzma 2019-06-09T18:13:32.589Z,1560104012.589 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:13:33.082Z,1560104013.082 [DataOverHttps](INFO): Moved sent file to Logs/20190609T171951/Express0017.lzma.bak 2019-06-09T18:13:33.082Z,1560104013.082 [DataOverHttps](INFO): SBD MOMSN=11358113 2019-06-09T18:13:34.226Z,1560104014.226 [Default:CheckIn:Read_Iridium] Stopped 2019-06-09T18:13:34.226Z,1560104014.226 [Default:CheckIn:C.Wait] Running Loop=1 2019-06-09T18:13:34.226Z,1560104014.226 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2019-06-09T18:13:35.833Z,1560104015.833 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:13:36.211Z,1560104016.211 [NAL9602](FAULT): GPS failed to acquire within timeout. 2019-06-09T18:13:36.211Z,1560104016.211 [NAL9602] Data Fault, FailCount= 5 2019-06-09T18:13:36.211Z,1560104016.211 [NAL9602](ERROR): Data Fault 2019-06-09T18:13:36.314Z,1560104016.314 [CBIT](ERROR): Data Fault in component: NAL9602 2019-06-09T18:13:36.315Z,1560104016.315 [CBIT](CRITICAL): Data Fault in component: NAL9602 2019-06-09T18:13:36.614Z,1560104016.614 [NAL9602](INFO): Powering down 2019-06-09T18:13:36.644Z,1560104016.644 [CommandLine](FAULT): Scheduling is paused 2019-06-09T18:13:36.649Z,1560104016.649 [CBIT](INFO): Critical error at 20190609T181336 2019-06-09T18:13:36.649Z,1560104016.649 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals 2019-06-09T18:13:45.379Z,1560104025.379 [CommandLine](IMPORTANT): got command failComponent 2019-06-09T18:13:45.379Z,1560104025.379 [CommandLine](IMPORTANT): Failed components: 2019-06-09T18:13:45.379Z,1560104025.379 [CommandLine](IMPORTANT): NAL9602: Data Fault 2019-06-09T18:13:51.667Z,1560104031.667 [CommandLine](IMPORTANT): got command failComponent none NAL9602 2019-06-09T18:13:51.667Z,1560104031.667 [NAL9602] No Fault, FailCount= 5 2019-06-09T18:13:51.668Z,1560104031.668 [CommandLine](IMPORTANT): NAL9602 failureMode is No Fault 2019-06-09T18:13:53.643Z,1560104033.643 [CommandLine](IMPORTANT): got command get latitude 2019-06-09T18:13:53.643Z,1560104033.643 [CommandLine](FAULT): Element has no value 2019-06-09T18:14:06.934Z,1560104046.934 [NAL9602](INFO): Powering up NAL9602 2019-06-09T18:14:17.827Z,1560104057.827 [NAL9602](INFO): NAL9602 initialized 2019-06-09T18:14:20.669Z,1560104060.669 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:14:20.709Z,1560104060.709 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 18 2019-06-09T18:14:20.709Z,1560104060.709 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2019-06-09T18:14:20.723Z,1560104060.723 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2019-06-09T18:14:21.128Z,1560104061.128 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2019-06-09T18:14:21.128Z,1560104061.128 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 18 2019-06-09T18:14:23.901Z,1560104063.901 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:14:26.733Z,1560104066.733 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:14:29.977Z,1560104069.977 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:14:32.789Z,1560104072.789 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:14:36.029Z,1560104076.029 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:14:38.849Z,1560104078.849 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:14:41.681Z,1560104081.681 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:14:44.509Z,1560104084.509 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:14:47.737Z,1560104087.737 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:14:50.569Z,1560104090.569 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:14:53.797Z,1560104093.797 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:14:56.629Z,1560104096.629 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:14:59.861Z,1560104099.861 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:15:02.693Z,1560104102.693 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:15:05.929Z,1560104105.929 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:15:08.749Z,1560104108.749 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:15:11.977Z,1560104111.977 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:15:14.809Z,1560104114.809 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:15:18.041Z,1560104118.041 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:15:20.865Z,1560104120.865 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:15:23.693Z,1560104123.693 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:15:26.521Z,1560104126.521 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:15:29.757Z,1560104129.757 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:15:32.589Z,1560104132.589 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:15:35.817Z,1560104135.817 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:15:38.641Z,1560104138.641 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:15:41.881Z,1560104141.881 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:15:44.705Z,1560104144.705 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:15:47.953Z,1560104147.953 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:15:49.762Z,1560104149.762 [CommandLine](IMPORTANT): got command failComponent 2019-06-09T18:15:49.762Z,1560104149.762 [CommandLine](IMPORTANT): Failed components: 2019-06-09T18:15:49.763Z,1560104149.763 [CommandLine](IMPORTANT): No failed Components. 2019-06-09T18:15:50.761Z,1560104150.761 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:15:52.253Z,1560104152.253 [CommandLine](IMPORTANT): got command get latitude 2019-06-09T18:15:52.253Z,1560104152.253 [CommandLine](FAULT): Element has no value 2019-06-09T18:15:53.997Z,1560104153.997 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:15:56.090Z,1560104156.090 [CommandLine](IMPORTANT): got command show variable numsat 2019-06-09T18:15:56.173Z,1560104156.173 [CommandLine](IMPORTANT): NAL9602.numSatellites (count) 2019-06-09T18:15:56.825Z,1560104156.825 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:16:00.053Z,1560104160.053 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:16:02.881Z,1560104162.881 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:16:05.721Z,1560104165.721 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:16:06.484Z,1560104166.484 [CommandLine](IMPORTANT): got command report touch NAL9602.numSatellites 2019-06-09T18:16:08.541Z,1560104168.541 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:16:11.769Z,1560104171.769 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:16:14.601Z,1560104174.601 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:16:17.837Z,1560104177.837 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:16:20.661Z,1560104180.661 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:16:23.889Z,1560104183.889 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:16:26.725Z,1560104186.725 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:16:29.961Z,1560104189.961 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:16:32.781Z,1560104192.781 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:16:36.013Z,1560104196.013 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:16:38.841Z,1560104198.841 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:16:41.106Z,1560104201.106 [CommandLine](IMPORTANT): got command get NAL9602.numSatellites 2019-06-09T18:16:41.106Z,1560104201.106 [CommandLine](IMPORTANT): NAL9602.numSatellites 0 count 2019-06-09T18:16:41.665Z,1560104201.665 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:16:44.901Z,1560104204.901 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:16:47.725Z,1560104207.725 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:16:50.557Z,1560104210.557 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:16:53.789Z,1560104213.789 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:16:56.621Z,1560104216.621 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:16:59.849Z,1560104219.849 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:17:02.677Z,1560104222.677 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:17:05.905Z,1560104225.905 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:17:08.737Z,1560104228.737 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:17:11.973Z,1560104231.973 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:17:14.793Z,1560104234.793 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:17:18.029Z,1560104238.029 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:17:20.853Z,1560104240.853 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:17:21.685Z,1560104241.685 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 19 2019-06-09T18:17:21.685Z,1560104241.685 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2019-06-09T18:17:21.710Z,1560104241.710 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2019-06-09T18:17:22.090Z,1560104242.090 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2019-06-09T18:17:22.090Z,1560104242.090 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 19 2019-06-09T18:17:23.689Z,1560104243.689 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:17:26.509Z,1560104246.509 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:17:29.741Z,1560104249.741 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:17:32.573Z,1560104252.573 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:17:35.805Z,1560104255.805 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:17:38.629Z,1560104258.629 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:17:41.861Z,1560104261.861 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:17:44.689Z,1560104264.689 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:17:47.960Z,1560104267.960 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:17:50.749Z,1560104270.749 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:17:51.630Z,1560104271.630 [DataOverHttps](IMPORTANT): SBD MTMSN=20190609T181658 2019-06-09T18:17:53.985Z,1560104273.985 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:17:56.741Z,1560104276.741 [DataOverHttps](INFO): Received command:restart app 2019-06-09T18:17:56.758Z,1560104276.758 [CommandLine](IMPORTANT): got command restart application 2019-06-09T18:17:56.809Z,1560104276.809 [NAL9602](DEBUG): Fix Requested 2019-06-09T18:17:57.761Z,1560104277.761 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2019-06-09T18:17:57.761Z,1560104277.761 [CommandLine ThreadHandler](INFO): Thread cancelled. 2019-06-09T18:17:57.885Z,1560104277.885 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2019-06-09T18:17:57.885Z,1560104277.885 [CommandLine ThreadHandler](INFO): Thread cancelled. 2019-06-09T18:17:57.886Z,1560104277.886 [CommandLine](INFO): Join timeout helper Thread ID is 969 2019-06-09T18:17:57.886Z,1560104277.886 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2019-06-09T18:17:57.886Z,1560104277.886 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2019-06-09T18:17:57.887Z,1560104277.887 [NavChartDb](INFO): Join timeout helper Thread ID is 970 2019-06-09T18:17:58.169Z,1560104278.169 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2019-06-09T18:17:58.169Z,1560104278.169 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2019-06-09T18:17:58.189Z,1560104278.189 [ComponentRegistry](INFO): Shutting down WetLabsSeaOWL_UV_A ThreadHandler 2019-06-09T18:17:58.189Z,1560104278.189 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Thread cancelled. 2019-06-09T18:17:58.189Z,1560104278.189 [WetLabsSeaOWL_UV_A](INFO): Join timeout helper Thread ID is 971 2019-06-09T18:17:58.529Z,1560104278.529 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Uninitializing protected caller thread. 2019-06-09T18:17:58.529Z,1560104278.529 [WetLabsSeaOWL_UV_A](INFO): Powering down 2019-06-09T18:17:58.530Z,1560104278.530 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Thread cancelled. 2019-06-09T18:17:58.537Z,1560104278.537 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2019-06-09T18:17:58.537Z,1560104278.537 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2019-06-09T18:17:58.537Z,1560104278.537 [Radio_Surface](INFO): Join timeout helper Thread ID is 972 2019-06-09T18:17:58.910Z,1560104278.910 [Radio_Surface](INFO): Powering down 2019-06-09T18:17:58.912Z,1560104278.912 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2019-06-09T18:17:58.914Z,1560104278.914 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2019-06-09T18:17:58.929Z,1560104278.929 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler 2019-06-09T18:17:58.929Z,1560104278.929 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2019-06-09T18:17:58.929Z,1560104278.929 [DataOverHttps](INFO): Join timeout helper Thread ID is 973 2019-06-09T18:17:59.161Z,1560104279.161 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread. 2019-06-09T18:17:59.161Z,1560104279.161 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2019-06-09T18:17:59.182Z,1560104279.182 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2019-06-09T18:17:59.182Z,1560104279.182 [logger ThreadHandler](INFO): Thread cancelled. 2019-06-09T18:17:59.182Z,1560104279.182 [logger](INFO): Join timeout helper Thread ID is 974 2019-06-09T18:17:59.185Z,1560104279.185 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2019-06-09T18:17:59.185Z,1560104279.185 [logger ThreadHandler](INFO): Thread cancelled. 2019-06-09T18:17:59.201Z,1560104279.201 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2019-06-09T18:17:59.202Z,1560104279.202 [CommandLine ThreadHandler](INFO): Thread cancelled. 2019-06-09T18:17:59.202Z,1560104279.202 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2019-06-09T18:17:59.202Z,1560104279.202 [controlThread ThreadHandler](INFO): Thread cancelled. 2019-06-09T18:17:59.202Z,1560104279.202 [controlThread](INFO): Join timeout helper Thread ID is 975 2019-06-09T18:17:59.209Z,1560104279.209 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2019-06-09T18:17:59.209Z,1560104279.209 [controlThread](DEBUG): Uninitializing ControlThread 2019-06-09T18:17:59.210Z,1560104279.210 [AHRS_M2](INFO): Powering down 2019-06-09T18:17:59.281Z,1560104279.281 [DUSBL_Hydroid](INFO): Powering down 2019-06-09T18:17:59.373Z,1560104279.373 [Micromodem](INFO): Powering down 2019-06-09T18:17:59.469Z,1560104279.469 [NAL9602](INFO): Powering down 2019-06-09T18:17:59.541Z,1560104279.541 [RDI_Pathfinder](INFO): Powering down 2019-06-09T18:17:59.542Z,1560104279.542 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator. 2019-06-09T18:17:59.543Z,1560104279.543 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator. 2019-06-09T18:17:59.543Z,1560104279.543 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2019-06-09T18:17:59.544Z,1560104279.544 [MissionManager](INFO): Uninitializing Mission Default 2019-06-09T18:17:59.544Z,1560104279.544 [Default] Stopped 2019-06-09T18:17:59.544Z,1560104279.544 [Default](DEBUG): Aggregate::uninitialize Default 2019-06-09T18:17:59.544Z,1560104279.544 [Default:B.GoToSurface] Stopped 2019-06-09T18:17:59.544Z,1560104279.544 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2019-06-09T18:17:59.544Z,1560104279.544 [Default:CheckIn] Stopped 2019-06-09T18:17:59.545Z,1560104279.545 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2019-06-09T18:17:59.545Z,1560104279.545 [Default:CheckIn:C.Wait] Stopped 2019-06-09T18:17:59.545Z,1560104279.545 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2019-06-09T18:17:59.547Z,1560104279.547 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2019-06-09T18:17:59.547Z,1560104279.547 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2019-06-09T18:17:59.548Z,1560104279.548 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2019-06-09T18:17:59.548Z,1560104279.548 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2019-06-09T18:17:59.548Z,1560104279.548 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2019-06-09T18:17:59.548Z,1560104279.548 [BuoyancyServo](INFO): Powering down 2019-06-09T18:17:59.561Z,1560104279.561 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2019-06-09T18:17:59.561Z,1560104279.561 [ElevatorServo](INFO): Powering down 2019-06-09T18:17:59.562Z,1560104279.562 [MassServo](DEBUG): Uninitialize Mass Servo. 2019-06-09T18:17:59.562Z,1560104279.562 [MassServo](INFO): Powering down 2019-06-09T18:17:59.563Z,1560104279.563 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2019-06-09T18:17:59.563Z,1560104279.563 [RudderServo](INFO): Powering down 2019-06-09T18:17:59.564Z,1560104279.564 [ThrusterServo](DEBUG): Uninitialize Thruster Servo. 2019-06-09T18:17:59.564Z,1560104279.564 [ThrusterServo](INFO): Powering down 2019-06-09T18:17:59.564Z,1560104279.564 [SBIT](DEBUG): Uninitialize SBIT Component. 2019-06-09T18:17:59.565Z,1560104279.565 [IBIT](DEBUG): Uninitialize IBIT Component. 2019-06-09T18:17:59.565Z,1560104279.565 [CBIT](DEBUG): Uninitialize CBIT Component. 2019-06-09T18:17:59.565Z,1560104279.565 [CBIT](DEBUG): Powering off loads. 2019-06-09T18:17:59.577Z,1560104279.577 [CBIT](DEBUG): Disabling WDT. 2019-06-09T18:17:59.589Z,1560104279.589 [CBIT](DEBUG): Opening all GF detection circuits. 2019-06-09T18:17:59.590Z,1560104279.590 [controlThread ThreadHandler](INFO): Thread cancelled. 2019-06-09T18:17:59.637Z,1560104279.637 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2019-06-09T18:17:59.646Z,1560104279.646 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2019-06-09T18:17:59.684Z,1560104279.684 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Thread cancelled. 2019-06-09T18:17:59.739Z,1560104279.739 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2019-06-09T18:17:59.793Z,1560104279.793 [logger ThreadHandler](INFO): Thread cancelled.