2020-10-08T03:30:42.036Z,1602127842.036 [Supervisor](DEBUG): Initializing supervisor. 2020-10-08T03:30:42.042Z,1602127842.042 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2020-10-08T03:30:42.042Z,1602127842.042 [SyncHandler](INFO): Protected caller Thread ID is 6114 2020-10-08T03:30:42.043Z,1602127842.043 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2020-10-08T03:30:42.044Z,1602127842.044 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2020-10-08T03:30:42.044Z,1602127842.044 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 6115 2020-10-08T03:30:42.049Z,1602127842.049 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2020-10-08T03:30:42.068Z,1602127842.068 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2020-10-08T03:30:42.069Z,1602127842.069 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2020-10-08T03:30:42.069Z,1602127842.069 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 6116 2020-10-08T03:30:42.071Z,1602127842.071 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2020-10-08T03:30:42.072Z,1602127842.072 [logger ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2020-10-08T03:30:42.072Z,1602127842.072 [logger ThreadHandler](INFO): Protected caller Thread ID is 6117 2020-10-08T03:30:42.076Z,1602127842.076 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2020-10-08T03:30:42.076Z,1602127842.076 [Supervisor](INFO): Looking for Config files in directory: Config/ 2020-10-08T03:30:42.078Z,1602127842.078 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2020-10-08T03:30:42.181Z,1602127842.181 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2020-10-08T03:30:42.181Z,1602127842.181 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2020-10-08T03:30:42.841Z,1602127842.841 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2020-10-08T03:30:42.841Z,1602127842.841 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg 2020-10-08T03:30:43.061Z,1602127843.061 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock 2020-10-08T03:30:43.062Z,1602127843.062 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2020-10-08T03:30:43.147Z,1602127843.147 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2020-10-08T03:30:43.262Z,1602127843.262 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2020-10-08T03:30:43.262Z,1602127843.262 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2020-10-08T03:30:43.349Z,1602127843.349 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2020-10-08T03:30:43.457Z,1602127843.457 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2020-10-08T03:30:43.457Z,1602127843.457 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2020-10-08T03:30:43.788Z,1602127843.788 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2020-10-08T03:30:43.788Z,1602127843.788 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2020-10-08T03:30:44.355Z,1602127844.355 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2020-10-08T03:30:44.355Z,1602127844.355 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2020-10-08T03:30:44.517Z,1602127844.517 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2020-10-08T03:30:44.518Z,1602127844.518 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2020-10-08T03:30:44.736Z,1602127844.736 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2020-10-08T03:30:44.736Z,1602127844.736 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2020-10-08T03:30:45.355Z,1602127845.355 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2020-10-08T03:30:45.355Z,1602127845.355 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2020-10-08T03:30:45.920Z,1602127845.920 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2020-10-08T03:30:45.921Z,1602127845.921 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2020-10-08T03:30:46.142Z,1602127846.142 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2020-10-08T03:30:46.143Z,1602127846.143 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2020-10-08T03:30:46.518Z,1602127846.518 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2020-10-08T03:30:46.519Z,1602127846.519 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2020-10-08T03:30:46.888Z,1602127846.888 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2020-10-08T03:30:46.890Z,1602127846.890 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-pontus/ 2020-10-08T03:30:46.891Z,1602127846.891 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/secure.cfg 2020-10-08T03:30:46.981Z,1602127846.981 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Sensor.cfg 2020-10-08T03:30:47.155Z,1602127847.155 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Servo.cfg 2020-10-08T03:30:47.272Z,1602127847.272 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Simulator.cfg 2020-10-08T03:30:47.364Z,1602127847.364 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/logger.cfg 2020-10-08T03:30:47.466Z,1602127847.466 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/vehicle.cfg 2020-10-08T03:30:47.680Z,1602127847.680 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Battery.cfg 2020-10-08T03:30:47.949Z,1602127847.949 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2020-10-08T03:30:47.949Z,1602127847.949 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Navigation.cfg 2020-10-08T03:30:48.051Z,1602127848.051 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/BIT.cfg 2020-10-08T03:30:48.157Z,1602127848.157 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Science.cfg 2020-10-08T03:30:48.295Z,1602127848.295 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Control.cfg 2020-10-08T03:30:48.403Z,1602127848.403 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-pontus/root/ 2020-10-08T03:30:48.404Z,1602127848.404 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg 2020-10-08T03:30:48.421Z,1602127848.421 [Module Loader](DEBUG): Loading Module at Modules/Dock.so 2020-10-08T03:30:48.507Z,1602127848.507 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking) 2020-10-08T03:30:48.508Z,1602127848.508 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2020-10-08T03:30:48.564Z,1602127848.564 [VerticalControl](DEBUG): Construct VerticalControl. 2020-10-08T03:30:48.622Z,1602127848.622 [VerticalControl] Loaded 2020-10-08T03:30:48.622Z,1602127848.622 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2020-10-08T03:30:48.625Z,1602127848.625 [HorizontalControl](DEBUG): Construct HorizontalControl. 2020-10-08T03:30:48.662Z,1602127848.662 [HorizontalControl] Loaded 2020-10-08T03:30:48.662Z,1602127848.662 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2020-10-08T03:30:48.665Z,1602127848.665 [SpeedControl](DEBUG): Construct SpeedControl. 2020-10-08T03:30:48.668Z,1602127848.668 [SpeedControl] Loaded 2020-10-08T03:30:48.668Z,1602127848.668 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2020-10-08T03:30:48.671Z,1602127848.671 [LoopControl](DEBUG): Construct LoopControl. 2020-10-08T03:30:48.671Z,1602127848.671 [LoopControl] Loaded 2020-10-08T03:30:48.671Z,1602127848.671 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2020-10-08T03:30:48.672Z,1602127848.672 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2020-10-08T03:30:48.672Z,1602127848.672 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2020-10-08T03:30:48.715Z,1602127848.715 [DepthRateCalculator] Loaded 2020-10-08T03:30:48.715Z,1602127848.715 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2020-10-08T03:30:48.719Z,1602127848.719 [PitchRateCalculator] Loaded 2020-10-08T03:30:48.720Z,1602127848.720 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2020-10-08T03:30:48.730Z,1602127848.730 [SpeedCalculator] Loaded 2020-10-08T03:30:48.730Z,1602127848.730 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2020-10-08T03:30:48.743Z,1602127848.743 [TempGradientCalculator] Loaded 2020-10-08T03:30:48.743Z,1602127848.743 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread. 2020-10-08T03:30:48.747Z,1602127848.747 [YawRateCalculator] Loaded 2020-10-08T03:30:48.748Z,1602127848.748 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2020-10-08T03:30:48.764Z,1602127848.764 [ElevatorOffsetCalculator] Loaded 2020-10-08T03:30:48.764Z,1602127848.764 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread. 2020-10-08T03:30:48.765Z,1602127848.765 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2020-10-08T03:30:48.765Z,1602127848.765 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2020-10-08T03:30:48.793Z,1602127848.793 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2020-10-08T03:30:48.794Z,1602127848.794 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2020-10-08T03:30:48.852Z,1602127848.852 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2020-10-08T03:30:48.853Z,1602127848.853 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2020-10-08T03:30:49.190Z,1602127849.190 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2020-10-08T03:30:49.191Z,1602127849.191 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2020-10-08T03:30:49.298Z,1602127849.298 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2020-10-08T03:30:49.299Z,1602127849.299 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2020-10-08T03:30:49.668Z,1602127849.668 [AHRS_M2] Loaded 2020-10-08T03:30:49.669Z,1602127849.669 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread. 2020-10-08T03:30:49.698Z,1602127849.698 [BackseatComponent] Loaded 2020-10-08T03:30:49.698Z,1602127849.698 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread. 2020-10-08T03:30:49.699Z,1602127849.699 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 408F94E0 2020-10-08T03:30:49.699Z,1602127849.699 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 6199 2020-10-08T03:30:50.463Z,1602127850.463 [BPC1] Loaded 2020-10-08T03:30:50.464Z,1602127850.464 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2020-10-08T03:30:50.535Z,1602127850.535 [DataOverHttps] Loaded 2020-10-08T03:30:50.536Z,1602127850.536 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread. 2020-10-08T03:30:50.537Z,1602127850.537 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 409294E0 2020-10-08T03:30:50.537Z,1602127850.537 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 6200 2020-10-08T03:30:50.556Z,1602127850.556 [Depth_Keller] Loaded 2020-10-08T03:30:50.556Z,1602127850.556 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2020-10-08T03:30:50.615Z,1602127850.615 [NAL9602] Loaded 2020-10-08T03:30:50.615Z,1602127850.615 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2020-10-08T03:30:50.644Z,1602127850.644 [Onboard] Loaded 2020-10-08T03:30:50.645Z,1602127850.645 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread. 2020-10-08T03:30:50.646Z,1602127850.646 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 409594E0 2020-10-08T03:30:50.646Z,1602127850.646 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 6201 2020-10-08T03:30:50.659Z,1602127850.659 [Radio_Surface] Loaded 2020-10-08T03:30:50.659Z,1602127850.659 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2020-10-08T03:30:50.660Z,1602127850.660 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 409894E0 2020-10-08T03:30:50.661Z,1602127850.661 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 6202 2020-10-08T03:30:50.691Z,1602127850.691 [RDI_Pathfinder] Loaded 2020-10-08T03:30:50.691Z,1602127850.691 [ComponentRegistry](DEBUG): SyncComponent "RDI_Pathfinder" handled in the control thread. 2020-10-08T03:30:50.767Z,1602127850.767 [DAT] Loaded 2020-10-08T03:30:50.768Z,1602127850.768 [ComponentRegistry](DEBUG): SyncComponent "DAT" handled in the control thread. 2020-10-08T03:30:50.768Z,1602127850.768 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2020-10-08T03:30:50.769Z,1602127850.769 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2020-10-08T03:30:51.148Z,1602127851.148 [DeadReckonUsingMultipleVelocitySources] Loaded 2020-10-08T03:30:51.149Z,1602127851.149 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2020-10-08T03:30:51.198Z,1602127851.198 [NavChart] Loaded 2020-10-08T03:30:51.199Z,1602127851.199 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2020-10-08T03:30:51.216Z,1602127851.216 [UniversalFixResidualReporter] Loaded 2020-10-08T03:30:51.217Z,1602127851.217 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2020-10-08T03:30:51.217Z,1602127851.217 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2020-10-08T03:30:51.218Z,1602127851.218 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2020-10-08T03:30:51.470Z,1602127851.470 [SBIT](DEBUG): Construct Startup Built In Test. 2020-10-08T03:30:51.503Z,1602127851.503 [SBIT] Loaded 2020-10-08T03:30:51.503Z,1602127851.503 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2020-10-08T03:30:51.506Z,1602127851.506 [IBIT](DEBUG): Construct Initiated Built In Test. 2020-10-08T03:30:51.588Z,1602127851.588 [IBIT] Loaded 2020-10-08T03:30:51.588Z,1602127851.588 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2020-10-08T03:30:51.596Z,1602127851.596 [CBIT](DEBUG): Construct Continuous Built In Test. 2020-10-08T03:30:51.694Z,1602127851.694 [CBIT] Loaded 2020-10-08T03:30:51.694Z,1602127851.694 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2020-10-08T03:30:51.695Z,1602127851.695 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2020-10-08T03:30:51.695Z,1602127851.695 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2020-10-08T03:30:51.817Z,1602127851.817 [BuoyancyServo] Loaded 2020-10-08T03:30:51.817Z,1602127851.817 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2020-10-08T03:30:51.836Z,1602127851.836 [ElevatorServo] Loaded 2020-10-08T03:30:51.836Z,1602127851.836 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2020-10-08T03:30:51.855Z,1602127851.855 [MassServo] Loaded 2020-10-08T03:30:51.855Z,1602127851.855 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2020-10-08T03:30:51.873Z,1602127851.873 [RudderServo] Loaded 2020-10-08T03:30:51.873Z,1602127851.873 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2020-10-08T03:30:51.891Z,1602127851.891 [ThrusterServo] Loaded 2020-10-08T03:30:51.891Z,1602127851.891 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread. 2020-10-08T03:30:51.892Z,1602127851.892 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2020-10-08T03:30:51.892Z,1602127851.892 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2020-10-08T03:30:51.904Z,1602127851.904 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2020-10-08T03:30:51.905Z,1602127851.905 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2020-10-08T03:30:52.085Z,1602127852.085 [CTD_Seabird] Loaded 2020-10-08T03:30:52.086Z,1602127852.086 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread. 2020-10-08T03:30:52.087Z,1602127852.087 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40AB94E0 2020-10-08T03:30:52.087Z,1602127852.087 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 6203 2020-10-08T03:30:52.119Z,1602127852.119 [ESPComponent] Loaded 2020-10-08T03:30:52.119Z,1602127852.119 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread. 2020-10-08T03:30:52.139Z,1602127852.139 [PAR_Licor] Loaded 2020-10-08T03:30:52.139Z,1602127852.139 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread. 2020-10-08T03:30:52.171Z,1602127852.171 [WetLabsBB2FL] Loaded 2020-10-08T03:30:52.171Z,1602127852.171 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread. 2020-10-08T03:30:52.172Z,1602127852.172 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40AE94E0 2020-10-08T03:30:52.173Z,1602127852.173 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 6204 2020-10-08T03:30:52.192Z,1602127852.192 [WetLabsUBAT] Loaded 2020-10-08T03:30:52.192Z,1602127852.192 [ComponentRegistry](DEBUG): Component "WetLabsUBAT" handled in its own thread. 2020-10-08T03:30:52.193Z,1602127852.193 [WetLabsUBAT ThreadHandler](DEBUG): Created PCaller Thread at 40B194E0 2020-10-08T03:30:52.193Z,1602127852.193 [WetLabsUBAT ThreadHandler](INFO): Protected caller Thread ID is 6205 2020-10-08T03:30:52.194Z,1602127852.194 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2020-10-08T03:30:52.200Z,1602127852.200 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2020-10-08T03:30:52.203Z,1602127852.203 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2020-10-08T03:30:52.213Z,1602127852.213 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2020-10-08T03:30:52.214Z,1602127852.214 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40B494E0 2020-10-08T03:30:52.214Z,1602127852.214 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 6206 2020-10-08T03:30:52.219Z,1602127852.219 [Supervisor](INFO): Main Thread ID is 5734 2020-10-08T03:30:52.219Z,1602127852.219 [Supervisor](DEBUG): Running supervisor. 2020-10-08T03:30:52.220Z,1602127852.220 [CommandLine ThreadHandler](INFO): Handler Thread ID is 6207 2020-10-08T03:30:52.222Z,1602127852.222 [controlThread ThreadHandler](INFO): Handler Thread ID is 6208 2020-10-08T03:30:52.223Z,1602127852.223 [controlThread](DEBUG): Initializing ControlThread 2020-10-08T03:30:52.223Z,1602127852.223 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2020-10-08T03:30:52.225Z,1602127852.225 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2020-10-08T03:30:52.226Z,1602127852.226 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2020-10-08T03:30:52.226Z,1602127852.226 [LoopControl](DEBUG): Initialize LoopControlComponent. 2020-10-08T03:30:52.227Z,1602127852.227 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2020-10-08T03:30:52.227Z,1602127852.227 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2020-10-08T03:30:52.227Z,1602127852.227 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2020-10-08T03:30:52.228Z,1602127852.228 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator. 2020-10-08T03:30:52.229Z,1602127852.229 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2020-10-08T03:30:52.229Z,1602127852.229 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator. 2020-10-08T03:30:52.234Z,1602127852.234 [NavChart](DEBUG): Initialize NavChart Navigation. 2020-10-08T03:30:52.234Z,1602127852.234 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2020-10-08T03:30:52.234Z,1602127852.234 [SBIT](INFO): Initialize SBIT Component. 2020-10-08T03:30:52.235Z,1602127852.235 [SBIT](IMPORTANT): git: 2020-09-23a-38-g0705018 2020-10-08T03:30:52.235Z,1602127852.235 [SBIT](INFO): git hash: 07050183e37285877b4e85b27f87f7f45e39aa2e 2020-10-08T03:30:52.235Z,1602127852.235 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2020-10-08T03:30:52.237Z,1602127852.237 [SBIT](INFO): Kernel Reporting Different Version From Configuration. Kernel Expected: #1 PREEMPT Thu Feb 21 11:17:40 PST 2019 Kernel Reported: #1 PREEMPT Thu Aug 6 12:04:53 PDT 2020 2020-10-08T03:30:52.238Z,1602127852.238 [SBIT](INFO): Beginning SBIT in 99.000000 seconds. 2020-10-08T03:30:52.238Z,1602127852.238 [IBIT](INFO): Initialize IBIT Component. 2020-10-08T03:30:52.239Z,1602127852.239 [CBIT](DEBUG): Initialize CBIT Component. 2020-10-08T03:30:52.240Z,1602127852.240 [logger ThreadHandler](INFO): Handler Thread ID is 6209 2020-10-08T03:30:52.252Z,1602127852.252 [CBIT](DEBUG): Initialized mux pins. 2020-10-08T03:30:52.252Z,1602127852.252 [CBIT](DEBUG): Initializing the watchdog timer. 2020-10-08T03:30:52.257Z,1602127852.257 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 6210 2020-10-08T03:30:52.265Z,1602127852.265 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 6211 2020-10-08T03:30:52.266Z,1602127852.266 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2020-10-08T03:30:52.273Z,1602127852.273 [Onboard ThreadHandler](INFO): Handler Thread ID is 6212 2020-10-08T03:30:52.277Z,1602127852.277 [CBIT](INFO): Last reboot was NOT due to watchdog timer. 2020-10-08T03:30:52.277Z,1602127852.277 [CBIT](DEBUG): Initializing heartbeat. 2020-10-08T03:30:52.303Z,1602127852.303 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 6213 2020-10-08T03:30:52.313Z,1602127852.313 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 6214 2020-10-08T03:30:52.313Z,1602127852.313 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2020-10-08T03:30:52.318Z,1602127852.318 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 6216 2020-10-08T03:30:52.321Z,1602127852.321 [WetLabsBB2FL](INFO): Powering up 2020-10-08T03:30:52.322Z,1602127852.322 [WetLabsUBAT ThreadHandler](INFO): Handler Thread ID is 6218 2020-10-08T03:30:52.325Z,1602127852.325 [WetLabsUBAT](INFO): Powering up 2020-10-08T03:30:52.326Z,1602127852.326 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 6220 2020-10-08T03:30:52.330Z,1602127852.330 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000 2020-10-08T03:30:52.330Z,1602127852.330 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000 2020-10-08T03:30:52.330Z,1602127852.330 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000 2020-10-08T03:30:52.330Z,1602127852.330 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000 2020-10-08T03:30:52.330Z,1602127852.330 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000 2020-10-08T03:30:52.331Z,1602127852.331 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000 2020-10-08T03:30:52.331Z,1602127852.331 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000 2020-10-08T03:30:52.331Z,1602127852.331 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000 2020-10-08T03:30:52.331Z,1602127852.331 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000 2020-10-08T03:30:52.331Z,1602127852.331 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000 2020-10-08T03:30:52.331Z,1602127852.331 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000 2020-10-08T03:30:52.332Z,1602127852.332 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000 2020-10-08T03:30:52.332Z,1602127852.332 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000 2020-10-08T03:30:52.332Z,1602127852.332 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000 2020-10-08T03:30:52.332Z,1602127852.332 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000 2020-10-08T03:30:52.332Z,1602127852.332 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000 2020-10-08T03:30:52.348Z,1602127852.348 [CBIT](DEBUG): Deactivating GF circuits. 2020-10-08T03:30:52.348Z,1602127852.348 [CBIT](DEBUG): Deactivating emergency mode. 2020-10-08T03:30:52.384Z,1602127852.384 [CBIT](DEBUG): Backplane powered. 2020-10-08T03:30:52.389Z,1602127852.389 [MissionManager](INFO): Loading Mission: Missions/Startup.xml 2020-10-08T03:30:52.415Z,1602127852.415 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2020-10-08T03:30:52.454Z,1602127852.454 [MissionManager](DEBUG): 2020-10-08T03:30:52.455Z,1602127852.455 [MissionManager](INFO): Loading Mission: Missions/Default.xml 2020-10-08T03:30:52.531Z,1602127852.531 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min 2020-10-08T03:30:52.532Z,1602127852.532 [Default:A.Wait](DEBUG): Construct Wait. 2020-10-08T03:30:52.534Z,1602127852.534 [Default:B.GoToSurface](DEBUG): Construct GoToSurface. 2020-10-08T03:30:52.578Z,1602127852.578 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2020-10-08T03:30:52.581Z,1602127852.581 [Default:CheckIn:C.Wait](DEBUG): Construct Wait. 2020-10-08T03:30:52.604Z,1602127852.604 [Default:E.Execute](DEBUG): Construct Execute. 2020-10-08T03:30:52.609Z,1602127852.609 [MissionManager](DEBUG): 0 Wait a moment to see if the scheduler starts a new mission before starting to actually run Default. 13 Burn on Dropped weight due to communications timeout. 5 Default mission has been running for Restarting logs and Default mission. restart logs 2020-10-08T03:30:52.613Z,1602127852.613 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,NAL9602,RDI_Pathfinder,DAT,ESPComponent,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter, 2020-10-08T03:30:52.631Z,1602127852.631 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2020-10-08T03:30:52.701Z,1602127852.701 [Depth_Keller](ERROR): Pressure reading out of range: 1650.297119 decibar 2020-10-08T03:30:52.705Z,1602127852.705 [Radio_Surface](INFO): Powering up 2020-10-08T03:30:52.712Z,1602127852.712 [DAT](INFO): Powered 24V power converter LCB with command: ! echo 1 > /dev/loadB2 2020-10-08T03:30:52.712Z,1602127852.712 [DAT](INFO): Powering up 2020-10-08T03:30:52.712Z,1602127852.712 [DAT](DEBUG): Initializing DAT. 2020-10-08T03:30:52.721Z,1602127852.721 [CommandLine](IMPORTANT): got command ! echo 1 > /dev/loadB2 2020-10-08T03:30:52.773Z,1602127852.773 [DepthRateCalculator](ERROR): Depth measurement is not active 2020-10-08T03:30:52.812Z,1602127852.812 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2020-10-08T03:30:52.825Z,1602127852.825 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2020-10-08T03:30:52.826Z,1602127852.826 [ElevatorServo](DEBUG): Initializing EZServoServo. 2020-10-08T03:30:52.841Z,1602127852.841 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2020-10-08T03:30:52.842Z,1602127852.842 [MassServo](DEBUG): Initializing EZServoServo. 2020-10-08T03:30:52.857Z,1602127852.857 [MassServo](DEBUG): Initializing MassServo. 2020-10-08T03:30:52.858Z,1602127852.858 [RudderServo](DEBUG): Initializing EZServoServo. 2020-10-08T03:30:52.869Z,1602127852.869 [RudderServo](DEBUG): Initializing RudderServo. 2020-10-08T03:30:52.870Z,1602127852.870 [ThrusterServo](DEBUG): Initializing EZServoServo. 2020-10-08T03:30:52.885Z,1602127852.885 [ThrusterServo](DEBUG): Initializing ThrusterServo. 2020-10-08T03:30:53.756Z,1602127853.756 [RudderServo](ERROR): Rudder initialization uart error serial timeout 2020-10-08T03:30:53.757Z,1602127853.757 [RudderServo](FAULT): Rudder failed to initialize 2020-10-08T03:30:53.757Z,1602127853.757 [RudderServo] Communications Fault, FailCount= 1 2020-10-08T03:30:53.757Z,1602127853.757 [RudderServo](ERROR): Communications Fault 2020-10-08T03:30:53.868Z,1602127853.868 [CBIT](ERROR): Communications Fault in component: RudderServo 2020-10-08T03:30:54.041Z,1602127854.041 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2020-10-08T03:30:54.042Z,1602127854.042 [RudderServo](INFO): Powering down 2020-10-08T03:30:54.700Z,1602127854.700 [RudderServo](DEBUG): Initializing EZServoServo. 2020-10-08T03:30:54.817Z,1602127854.817 [RudderServo](DEBUG): Initializing RudderServo. 2020-10-08T03:30:54.821Z,1602127854.821 [CBIT](INFO): Clearing failed state for component RudderServo 2020-10-08T03:30:54.821Z,1602127854.821 [RudderServo] No Fault, FailCount= 1 2020-10-08T03:30:54.932Z,1602127854.932 [WetLabsBB2FL](INFO): Powering down 2020-10-08T03:31:01.596Z,1602127861.596 [WetLabsUBAT](INFO): Powering down 2020-10-08T03:31:06.808Z,1602127866.808 [DAT](INFO): commRate: 800 2020-10-08T03:31:08.838Z,1602127868.838 [DAT](INFO): entering command mode 2020-10-08T03:31:09.230Z,1602127869.230 [DAT](DEBUG): checking for command mode acknowledgment 2020-10-08T03:31:09.639Z,1602127869.639 [DAT](DEBUG): checking for command mode acknowledgment 2020-10-08T03:31:10.053Z,1602127870.053 [DAT](DEBUG): checking for command mode acknowledgment 2020-10-08T03:31:10.457Z,1602127870.457 [DAT](DEBUG): checking for command mode acknowledgment 2020-10-08T03:31:10.847Z,1602127870.847 [DAT](DEBUG): checking for command mode acknowledgment 2020-10-08T03:31:11.261Z,1602127871.261 [DAT](DEBUG): checking for command mode acknowledgment 2020-10-08T03:31:11.654Z,1602127871.654 [DAT](DEBUG): checking for command mode acknowledgment 2020-10-08T03:31:12.058Z,1602127872.058 [DAT](DEBUG): checking for command mode acknowledgment 2020-10-08T03:31:12.474Z,1602127872.474 [DAT](DEBUG): checking for command mode acknowledgment 2020-10-08T03:31:12.871Z,1602127872.871 [DAT](DEBUG): checking for command mode acknowledgment 2020-10-08T03:31:13.301Z,1602127873.301 [DAT](DEBUG): checking for command mode acknowledgment 2020-10-08T03:31:13.675Z,1602127873.675 [DAT](DEBUG): checking for command mode acknowledgment 2020-10-08T03:31:14.078Z,1602127874.078 [DAT](DEBUG): checking for command mode acknowledgment 2020-10-08T03:31:14.505Z,1602127874.505 [DAT](DEBUG): checking for command mode acknowledgment 2020-10-08T03:31:14.886Z,1602127874.886 [DAT](DEBUG): checking for command mode acknowledgment 2020-10-08T03:31:15.301Z,1602127875.301 [DAT](DEBUG): checking for command mode acknowledgment 2020-10-08T03:31:15.695Z,1602127875.695 [DAT](DEBUG): checking for command mode acknowledgment 2020-10-08T03:31:16.098Z,1602127876.098 [DAT](DEBUG): checking for command mode acknowledgment 2020-10-08T03:31:16.520Z,1602127876.520 [DAT](DEBUG): checking for command mode acknowledgment 2020-10-08T03:31:16.912Z,1602127876.912 [DAT](DEBUG): checking for command mode acknowledgment 2020-10-08T03:31:17.314Z,1602127877.314 [DAT](DEBUG): checking for command mode acknowledgment 2020-10-08T03:31:17.733Z,1602127877.733 [DAT](DEBUG): checking for command mode acknowledgment 2020-10-08T03:31:18.119Z,1602127878.119 [DAT](DEBUG): checking for command mode acknowledgment 2020-10-08T03:31:18.522Z,1602127878.522 [DAT](DEBUG): checking for command mode acknowledgment 2020-10-08T03:31:18.976Z,1602127878.976 [DAT](DEBUG): checking for command mode acknowledgment 2020-10-08T03:31:19.353Z,1602127879.353 [DAT](DEBUG): checking for command mode acknowledgment 2020-10-08T03:31:19.734Z,1602127879.734 [DAT](DEBUG): checking for command mode acknowledgment 2020-10-08T03:31:20.138Z,1602127880.138 [DAT](DEBUG): checking for command mode acknowledgment 2020-10-08T03:31:20.558Z,1602127880.558 [DAT](DEBUG): checking for command mode acknowledgment 2020-10-08T03:31:20.946Z,1602127880.946 [NAL9602](INFO): Powering up NAL9602 2020-10-08T03:31:20.947Z,1602127880.947 [DAT](DEBUG): checking for command mode acknowledgment 2020-10-08T03:31:21.367Z,1602127881.367 [DAT](DEBUG): checking for command mode acknowledgment 2020-10-08T03:31:21.754Z,1602127881.754 [DAT](DEBUG): checking for command mode acknowledgment 2020-10-08T03:31:22.162Z,1602127882.162 [DAT](DEBUG): checking for command mode acknowledgment 2020-10-08T03:31:22.573Z,1602127882.573 [DAT](DEBUG): checking for command mode acknowledgment 2020-10-08T03:31:22.991Z,1602127882.991 [DAT](DEBUG): checking for command mode acknowledgment 2020-10-08T03:31:23.396Z,1602127883.396 [DAT](DEBUG): checking for command mode acknowledgment 2020-10-08T03:31:23.778Z,1602127883.778 [DAT](DEBUG): checking for command mode acknowledgment 2020-10-08T03:31:24.182Z,1602127884.182 [DAT](DEBUG): checking for command mode acknowledgment 2020-10-08T03:31:24.182Z,1602127884.182 [DAT](FAULT): failed to enter command mode 2020-10-08T03:31:24.602Z,1602127884.602 [DAT](INFO): entering command mode 2020-10-08T03:31:24.991Z,1602127884.991 [DAT](INFO): setting verbose to 3 2020-10-08T03:31:25.406Z,1602127885.406 [DAT](INFO): set verbose to 3 2020-10-08T03:31:25.407Z,1602127885.407 [DAT](INFO): setting DatVerbose to 27440 2020-10-08T03:31:25.805Z,1602127885.805 [DAT](INFO): set DatVerbose to 27440 2020-10-08T03:31:25.805Z,1602127885.805 [DAT](INFO): setting transmit power to 8 2020-10-08T03:31:26.203Z,1602127886.203 [DAT](INFO): set transmit power to 8 2020-10-08T03:31:26.204Z,1602127886.204 [DAT](INFO): setting local address to 9 2020-10-08T03:31:26.607Z,1602127886.607 [DAT](INFO): set local address to 9 2020-10-08T03:31:31.858Z,1602127891.858 [NAL9602](INFO): NAL9602 initialized 2020-10-08T03:32:13.527Z,1602127933.527 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T03:32:31.692Z,1602127951.692 [SBIT](IMPORTANT): Beginning Startup BIT 2020-10-08T03:32:31.697Z,1602127951.697 [CBIT](IMPORTANT): Beginning ground fault scan 2020-10-08T03:32:42.645Z,1602127962.645 [CBIT](IMPORTANT): No ground fault detected mA: CHAN A0 (Batt): 0.009242 CHAN A1 (24V): -0.002350 CHAN A2 (12V): -0.007135 CHAN A3 (5V): 0.001586 CHAN B0 (3.3V): -0.000331 CHAN B1 (3.15aV): -0.000232 CHAN B2 (3.15bV): -0.000016 CHAN B3 (GND): 0.001909 OPEN: 0.005011 Full Scale Calc: 4.765 mA, -1.589 mA 2020-10-08T03:33:19.793Z,1602127999.793 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T03:33:21.111Z,1602128001.111 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004703 2020-10-08T03:33:25.429Z,1602128005.429 [SBIT](IMPORTANT): SBIT PASSED 2020-10-08T03:33:25.430Z,1602128005.430 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg 2020-10-08T03:33:25.430Z,1602128005.430 [SBIT](IMPORTANT): AMEcho.loadAtStartup=0 bool; 2020-10-08T03:33:25.431Z,1602128005.431 [SBIT](IMPORTANT): BPC1.batteryMissingStickThreshold=6 count; 2020-10-08T03:33:25.431Z,1602128005.431 [SBIT](IMPORTANT): BuoyancyServo.loadAtStartup=1 bool; 2020-10-08T03:33:25.431Z,1602128005.431 [SBIT](IMPORTANT): CBIT.gf24Offset=145 microampere; 2020-10-08T03:33:25.431Z,1602128005.431 [SBIT](IMPORTANT): DAT.loadAtStartup=1 bool; 2020-10-08T03:33:25.431Z,1602128005.431 [SBIT](IMPORTANT): DAT.sbdAddress=-1 enum; 2020-10-08T03:33:25.431Z,1602128005.431 [SBIT](IMPORTANT): DAT.surfaceThreshold=100 meter; 2020-10-08T03:33:25.431Z,1602128005.431 [SBIT](IMPORTANT): DAT.verbosity=0 count; 2020-10-08T03:33:25.431Z,1602128005.431 [SBIT](IMPORTANT): DropWeight.loadAtStartup=0 bool; 2020-10-08T03:33:25.432Z,1602128005.432 [SBIT](IMPORTANT): ESPComponent.loadAtStartup=1 bool; 2020-10-08T03:33:25.432Z,1602128005.432 [SBIT](IMPORTANT): Express linearApproximation AMEcho.altitude 1.000000 meter; 2020-10-08T03:33:25.432Z,1602128005.432 [SBIT](IMPORTANT): Express none ThrusterServo.component_avgCurrent; 2020-10-08T03:33:25.432Z,1602128005.432 [SBIT](IMPORTANT): Express linearApproximation WetLabsUBAT.flow_rate 1.000000 liter_per_second; 2020-10-08T03:33:25.432Z,1602128005.432 [SBIT](IMPORTANT): Express linearApproximation height_above_sea_floor 5.000000 meter; 2020-10-08T03:33:25.432Z,1602128005.432 [SBIT](IMPORTANT): IBIT.batteryVoltageThreshold=13 volt; 2020-10-08T03:33:25.432Z,1602128005.432 [SBIT](IMPORTANT): PAR_Licor.loadAtStartup=1 bool; 2020-10-08T03:33:25.433Z,1602128005.433 [SBIT](IMPORTANT): RDI_Pathfinder.loadAtStartup=1 bool; 2020-10-08T03:33:25.433Z,1602128005.433 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=170 cubic_centimeter; 2020-10-08T03:33:25.433Z,1602128005.433 [SBIT](IMPORTANT): VerticalControl.massDefault=20 millimeter; 2020-10-08T03:33:25.433Z,1602128005.433 [SBIT](IMPORTANT): WetLabsUBAT.loadAtStartup=1 bool; 2020-10-08T03:33:25.814Z,1602128005.814 [MissionManager](IMPORTANT): Started mission Startup 2020-10-08T03:33:25.815Z,1602128005.815 [Startup] Running Loop=1 2020-10-08T03:33:25.815Z,1602128005.815 [Startup](DEBUG): Aggregate::initialize Startup 2020-10-08T03:33:25.815Z,1602128005.815 [Startup:A.GoToSurface] Running Loop=1 2020-10-08T03:33:25.815Z,1602128005.815 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2020-10-08T03:33:25.815Z,1602128005.815 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2020-10-08T03:33:25.816Z,1602128005.816 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2020-10-08T03:33:25.836Z,1602128005.836 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2020-10-08T03:33:25.837Z,1602128005.837 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2020-10-08T03:33:25.837Z,1602128005.837 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2020-10-08T03:33:25.839Z,1602128005.839 [Startup:StartupSatComms] Running Loop=1 2020-10-08T03:33:25.839Z,1602128005.839 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms 2020-10-08T03:33:25.839Z,1602128005.839 [Startup:StartupSatComms:A] Running Loop=1 2020-10-08T03:33:26.261Z,1602128006.261 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix 2020-10-08T03:33:30.332Z,1602128010.332 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T03:33:41.220Z,1602128021.220 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T03:33:52.559Z,1602128032.559 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T03:33:52.634Z,1602128032.634 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1 2020-10-08T03:33:52.634Z,1602128032.634 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-10-08T03:33:52.656Z,1602128032.656 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-10-08T03:33:52.918Z,1602128032.918 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-10-08T03:33:52.918Z,1602128032.918 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1 2020-10-08T03:33:54.536Z,1602128034.536 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-10-08T03:34:03.437Z,1602128043.437 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T03:34:05.455Z,1602128045.455 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-10-08T03:34:14.340Z,1602128054.340 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T03:34:16.390Z,1602128056.390 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-10-08T03:34:25.254Z,1602128065.254 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T03:34:26.040Z,1602128066.040 [Startup:StartupSatComms:A](INFO): Timed out from 2020-10-08T03:33:25.8Z 2020-10-08T03:34:26.040Z,1602128066.040 [Startup:StartupSatComms:A] Stopped 2020-10-08T03:34:26.044Z,1602128066.044 [Startup:StartupSatComms:B] Running Loop=1 2020-10-08T03:34:26.434Z,1602128066.434 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications 2020-10-08T03:34:27.877Z,1602128067.877 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-10-08T03:34:30.581Z,1602128070.581 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20201008T030849/Courier0007.lzma 2020-10-08T03:34:30.714Z,1602128070.714 [DataOverHttps](INFO): Moved sent file to Logs/20201008T030849/Courier0007.lzma.bak 2020-10-08T03:34:30.714Z,1602128070.714 [DataOverHttps](INFO): SBD MOMSN=12816891 2020-10-08T03:34:36.766Z,1602128076.766 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T03:34:38.308Z,1602128078.308 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-10-08T03:34:46.664Z,1602128086.664 [DataOverHttps](INFO): Sending 151 bytes from file Logs/20201008T033042/Courier0000.lzma 2020-10-08T03:34:47.592Z,1602128087.592 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T03:34:47.666Z,1602128087.666 [DataOverHttps](INFO): Moved sent file to Logs/20201008T033042/Courier0000.lzma.bak 2020-10-08T03:34:47.666Z,1602128087.666 [DataOverHttps](INFO): SBD MOMSN=12816893 2020-10-08T03:34:48.856Z,1602128088.856 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-10-08T03:34:59.133Z,1602128099.133 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T03:34:59.514Z,1602128099.514 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-10-08T03:35:05.296Z,1602128105.296 [DataOverHttps](INFO): Sending 246 bytes from file Logs/20201008T030849/Express0008.lzma 2020-10-08T03:35:06.298Z,1602128106.298 [DataOverHttps](INFO): Moved sent file to Logs/20201008T030849/Express0008.lzma.bak 2020-10-08T03:35:06.298Z,1602128106.298 [DataOverHttps](INFO): SBD MOMSN=12816896 2020-10-08T03:35:09.803Z,1602128109.803 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2020-10-08T03:35:09.806Z,1602128109.806 [BPC1](ERROR): BPC1A failed to parse battery stick message. 2020-10-08T03:35:10.293Z,1602128110.293 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-10-08T03:35:20.844Z,1602128120.844 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T03:35:21.242Z,1602128121.241 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-10-08T03:35:24.082Z,1602128124.082 [DataOverHttps](INFO): Sending 1121 bytes from file Logs/20201008T033042/Express0001.lzma 2020-10-08T03:35:25.082Z,1602128125.082 [DataOverHttps](INFO): Moved sent file to Logs/20201008T033042/Express0001.lzma.bak 2020-10-08T03:35:25.082Z,1602128125.082 [DataOverHttps](INFO): SBD MOMSN=12816900 2020-10-08T03:35:26.411Z,1602128126.411 [Startup:StartupSatComms:B](INFO): Timed out from 2020-10-08T03:34:26.0Z 2020-10-08T03:35:26.411Z,1602128126.411 [Startup:StartupSatComms:B] Stopped 2020-10-08T03:35:26.411Z,1602128126.411 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms 2020-10-08T03:35:26.411Z,1602128126.411 [Startup:StartupSatComms] Stopped 2020-10-08T03:35:26.411Z,1602128126.411 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms 2020-10-08T03:35:26.412Z,1602128126.412 [Startup](INFO): Completed Startup 2020-10-08T03:35:26.412Z,1602128126.412 [MissionManager](INFO): Startup is completed. 2020-10-08T03:35:26.416Z,1602128126.416 [MissionManager](INFO): Uninitializing Mission Startup 2020-10-08T03:35:26.416Z,1602128126.416 [Startup] Stopped 2020-10-08T03:35:26.417Z,1602128126.417 [Startup](DEBUG): Aggregate::uninitialize Startup 2020-10-08T03:35:26.417Z,1602128126.417 [Startup:A.GoToSurface] Stopped 2020-10-08T03:35:26.417Z,1602128126.417 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2020-10-08T03:35:26.811Z,1602128126.811 [MissionManager](IMPORTANT): Started mission Default 2020-10-08T03:35:26.811Z,1602128126.811 [Default] Running Loop=1 2020-10-08T03:35:26.811Z,1602128126.811 [Default](DEBUG): Aggregate::initialize Default 2020-10-08T03:35:26.811Z,1602128126.811 [Default:B.GoToSurface] Running Loop=1 2020-10-08T03:35:26.811Z,1602128126.811 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2020-10-08T03:35:26.812Z,1602128126.812 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2020-10-08T03:35:26.816Z,1602128126.816 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2020-10-08T03:35:26.817Z,1602128126.817 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2020-10-08T03:35:26.817Z,1602128126.817 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2020-10-08T03:35:26.817Z,1602128126.817 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2020-10-08T03:35:26.818Z,1602128126.818 [Default:A.Wait] Running Loop=1 2020-10-08T03:35:26.818Z,1602128126.818 [Default:A.Wait](DEBUG): Initialize Wait Component. 2020-10-08T03:35:31.817Z,1602128131.817 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T03:35:32.060Z,1602128132.060 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-10-08T03:35:39.920Z,1602128139.920 [Default:A.Wait](INFO): Done Waiting. 2020-10-08T03:35:39.928Z,1602128139.928 [Default:A.Wait] Stopped 2020-10-08T03:35:39.928Z,1602128139.928 [Default:A.Wait](DEBUG): Uninitialize Wait Component. 2020-10-08T03:35:40.314Z,1602128140.314 [Default:CheckIn] Running Loop=1 2020-10-08T03:35:40.314Z,1602128140.314 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2020-10-08T03:35:40.314Z,1602128140.314 [Default:CheckIn:Read_GPS] Running Loop=1 2020-10-08T03:35:40.690Z,1602128140.690 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix 2020-10-08T03:35:42.730Z,1602128142.730 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T03:35:43.154Z,1602128143.154 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-10-08T03:35:53.649Z,1602128153.649 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T03:35:54.058Z,1602128154.058 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-10-08T03:36:04.548Z,1602128164.548 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T03:36:05.435Z,1602128165.435 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-10-08T03:36:15.465Z,1602128175.465 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T03:36:15.877Z,1602128175.877 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-10-08T03:36:21.871Z,1602128181.871 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-10-08T03:36:26.770Z,1602128186.770 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T03:36:34.790Z,1602128194.790 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2020-10-08T03:36:37.686Z,1602128197.686 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T03:36:48.591Z,1602128208.591 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T03:36:53.414Z,1602128213.414 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2 2020-10-08T03:36:53.414Z,1602128213.414 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-10-08T03:36:53.424Z,1602128213.424 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-10-08T03:36:53.791Z,1602128213.791 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-10-08T03:36:53.791Z,1602128213.791 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2 2020-10-08T03:36:58.267Z,1602128218.267 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-10-08T03:36:59.908Z,1602128219.908 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T03:37:10.809Z,1602128230.809 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T03:37:21.719Z,1602128241.719 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T03:37:26.909Z,1602128246.909 [CommandLine](IMPORTANT): got command run ./Missions/test.xml 2020-10-08T03:37:26.909Z,1602128246.909 [MissionManager](INFO): Loading Mission: ./Missions/test.xml 2020-10-08T03:37:26.961Z,1602128246.961 [MissionManager](DEBUG): 2020-10-08T03:37:26.963Z,1602128246.963 [CommandLine](IMPORTANT): Running ./Missions/test.xml 2020-10-08T03:37:26.983Z,1602128246.983 [Default] Stopped 2020-10-08T03:37:26.983Z,1602128246.983 [Default](DEBUG): Aggregate::uninitialize Default 2020-10-08T03:37:26.983Z,1602128246.983 [Default:B.GoToSurface] Stopped 2020-10-08T03:37:26.983Z,1602128246.983 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2020-10-08T03:37:26.983Z,1602128246.983 [Default:CheckIn] Stopped 2020-10-08T03:37:26.983Z,1602128246.983 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2020-10-08T03:37:26.983Z,1602128246.983 [Default:CheckIn:Read_GPS] Stopped 2020-10-08T03:37:26.983Z,1602128246.983 [MissionManager](IMPORTANT): Started mission test 2020-10-08T03:37:26.984Z,1602128246.984 [test] Running Loop=1 2020-10-08T03:37:26.984Z,1602128246.984 [test](DEBUG): Aggregate::initialize test 2020-10-08T03:37:26.984Z,1602128246.984 [test:A] Running Loop=1 2020-10-08T03:37:26.984Z,1602128246.984 [test:B] Running Loop=1 2020-10-08T03:37:26.984Z,1602128246.984 [test:B] Running Loop=1 2020-10-08T03:37:26.985Z,1602128246.985 [test:B](DEBUG): Initialize ReadDataComponent to sense WetLabsUBAT.enableBroadcast 2020-10-08T03:37:26.985Z,1602128246.985 [test:A] Running Loop=1 2020-10-08T03:37:26.986Z,1602128246.986 [test:A](DEBUG): Initialize ReadDataComponent to sense WetLabsUBAT.biolum_potential 2020-10-08T03:37:27.017Z,1602128247.017 [WetLabsUBAT](INFO): Activating messaging. 2020-10-08T03:37:27.421Z,1602128247.421 [WetLabsUBAT](INFO): Powering up 2020-10-08T03:37:32.645Z,1602128252.645 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T03:37:43.541Z,1602128263.541 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T03:37:47.152Z,1602128267.152 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-10-08T03:37:53.683Z,1602128273.683 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T03:37:58.875Z,1602128278.875 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-10-08T03:38:04.953Z,1602128284.953 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T03:38:07.194Z,1602128287.194 [WetLabsUBAT](FAULT): Failed to acquire valid data within specified timeout. 2020-10-08T03:38:07.194Z,1602128287.194 [WetLabsUBAT] Communications Fault, FailCount= 1 2020-10-08T03:38:07.195Z,1602128287.195 [WetLabsUBAT](ERROR): Communications Fault 2020-10-08T03:38:07.373Z,1602128287.373 [CBIT](ERROR): Communications Fault in component: WetLabsUBAT 2020-10-08T03:38:07.701Z,1602128287.701 [WetLabsUBAT](INFO): Powering down 2020-10-08T03:38:08.559Z,1602128288.559 [CBIT](INFO): Clearing failed state for component WetLabsUBAT 2020-10-08T03:38:08.559Z,1602128288.559 [WetLabsUBAT] No Fault, FailCount= 1 2020-10-08T03:38:08.917Z,1602128288.917 [WetLabsUBAT](INFO): Powering up 2020-10-08T03:38:13.553Z,1602128293.553 [CommandLine](IMPORTANT): got command stop 2020-10-08T03:38:13.553Z,1602128293.553 [CommandLine](IMPORTANT): Scheduling is paused 2020-10-08T03:38:13.553Z,1602128293.553 [Supervisor](INFO): Stop Mission called by CommandLine::commandStop 2020-10-08T03:38:13.779Z,1602128293.779 [MissionManager](INFO): MissionManager is completed. 2020-10-08T03:38:13.779Z,1602128293.779 [MissionManager](INFO): Uninitializing Mission test 2020-10-08T03:38:13.779Z,1602128293.779 [test] Stopped 2020-10-08T03:38:13.779Z,1602128293.779 [test](DEBUG): Aggregate::uninitialize test 2020-10-08T03:38:13.779Z,1602128293.779 [test:A] Stopped 2020-10-08T03:38:13.779Z,1602128293.779 [test:B] Stopped 2020-10-08T03:38:14.166Z,1602128294.166 [WetLabsUBAT](INFO): Deactivating messaging. 2020-10-08T03:38:14.239Z,1602128294.239 [MissionManager](IMPORTANT): Started mission Default 2020-10-08T03:38:14.239Z,1602128294.239 [Default] Running Loop=1 2020-10-08T03:38:14.239Z,1602128294.239 [Default](DEBUG): Aggregate::initialize Default 2020-10-08T03:38:14.240Z,1602128294.240 [Default:B.GoToSurface] Running Loop=1 2020-10-08T03:38:14.240Z,1602128294.240 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2020-10-08T03:38:14.240Z,1602128294.240 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2020-10-08T03:38:14.240Z,1602128294.240 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2020-10-08T03:38:14.241Z,1602128294.241 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2020-10-08T03:38:14.241Z,1602128294.241 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2020-10-08T03:38:14.241Z,1602128294.241 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2020-10-08T03:38:14.242Z,1602128294.242 [Default:A.Wait] Running Loop=1 2020-10-08T03:38:14.242Z,1602128294.242 [Default:A.Wait](DEBUG): Initialize Wait Component. 2020-10-08T03:38:18.176Z,1602128298.176 [WetLabsUBAT](INFO): Powering down 2020-10-08T03:38:27.530Z,1602128307.530 [Default:A.Wait](INFO): Done Waiting. 2020-10-08T03:38:27.530Z,1602128307.530 [Default:A.Wait] Stopped 2020-10-08T03:38:27.531Z,1602128307.531 [Default:A.Wait](DEBUG): Uninitialize Wait Component. 2020-10-08T03:38:27.923Z,1602128307.923 [Default:CheckIn] Running Loop=1 2020-10-08T03:38:27.923Z,1602128307.923 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2020-10-08T03:38:27.923Z,1602128307.923 [Default:CheckIn:Read_GPS] Running Loop=1 2020-10-08T03:39:38.295Z,1602128378.295 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T03:39:54.387Z,1602128394.387 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3 2020-10-08T03:39:54.387Z,1602128394.388 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-10-08T03:39:54.398Z,1602128394.398 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-10-08T03:39:54.802Z,1602128394.802 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-10-08T03:39:54.802Z,1602128394.802 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3 2020-10-08T03:40:06.133Z,1602128406.133 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-10-08T03:41:32.938Z,1602128492.938 [NAL9602](FAULT): GPS failed to acquire within timeout. 2020-10-08T03:41:32.938Z,1602128492.938 [NAL9602] Data Fault, FailCount= 1 2020-10-08T03:41:32.938Z,1602128492.938 [NAL9602](ERROR): Data Fault 2020-10-08T03:41:32.997Z,1602128492.997 [CBIT](ERROR): Data Fault in component: NAL9602 2020-10-08T03:41:33.338Z,1602128493.338 [NAL9602](INFO): Powering down 2020-10-08T03:41:34.179Z,1602128494.179 [CBIT](INFO): Clearing failed state for component NAL9602 2020-10-08T03:41:34.179Z,1602128494.179 [NAL9602] No Fault, FailCount= 1 2020-10-08T03:41:39.458Z,1602128499.458 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-10-08T03:41:56.423Z,1602128516.423 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T03:42:03.644Z,1602128523.644 [NAL9602](INFO): Powering up NAL9602 2020-10-08T03:42:06.123Z,1602128526.123 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-10-08T03:42:14.550Z,1602128534.550 [NAL9602](INFO): NAL9602 initialized 2020-10-08T03:42:19.051Z,1602128539.051 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-10-08T03:42:50.561Z,1602128570.561 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T03:42:55.387Z,1602128575.387 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4 2020-10-08T03:42:55.387Z,1602128575.387 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-10-08T03:42:55.397Z,1602128575.397 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-10-08T03:42:55.791Z,1602128575.791 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-10-08T03:42:55.791Z,1602128575.791 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4 2020-10-08T03:43:01.871Z,1602128581.871 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T03:43:12.844Z,1602128592.844 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T03:43:13.274Z,1602128593.274 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-10-08T03:43:23.295Z,1602128603.295 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T03:43:28.104Z,1602128608.104 [Default:CheckIn:Read_GPS](INFO): Timed out from 2020-10-08T03:38:27.9Z 2020-10-08T03:43:28.104Z,1602128608.104 [Default:CheckIn:Read_GPS] Stopped 2020-10-08T03:43:28.104Z,1602128608.104 [Default:CheckIn:Read_Iridium] Running Loop=1 2020-10-08T03:43:28.497Z,1602128608.497 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications 2020-10-08T03:43:34.247Z,1602128614.247 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T03:43:35.476Z,1602128615.476 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20201008T033042/Courier0004.lzma 2020-10-08T03:43:36.478Z,1602128616.478 [DataOverHttps](INFO): Moved sent file to Logs/20201008T033042/Courier0004.lzma.bak 2020-10-08T03:43:36.479Z,1602128616.479 [DataOverHttps](INFO): SBD MOMSN=12817009 2020-10-08T03:43:37.881Z,1602128617.881 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-10-08T03:43:45.117Z,1602128625.117 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T03:43:48.743Z,1602128628.743 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-10-08T03:43:53.981Z,1602128633.981 [DataOverHttps](INFO): Sending 468 bytes from file Logs/20201008T033042/Express0005.lzma 2020-10-08T03:43:54.986Z,1602128634.986 [DataOverHttps](INFO): Moved sent file to Logs/20201008T033042/Express0005.lzma.bak 2020-10-08T03:43:54.986Z,1602128634.986 [DataOverHttps](INFO): SBD MOMSN=12817011 2020-10-08T03:43:56.082Z,1602128636.082 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T03:43:58.031Z,1602128638.031 [Default:CheckIn:Read_Iridium] Stopped 2020-10-08T03:43:58.031Z,1602128638.031 [Default:CheckIn:C.Wait] Running Loop=1 2020-10-08T03:43:58.031Z,1602128638.031 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2020-10-08T03:44:00.057Z,1602128640.057 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-10-08T03:44:06.526Z,1602128646.526 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T03:44:10.991Z,1602128650.991 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-10-08T03:44:17.431Z,1602128657.431 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T03:44:21.468Z,1602128661.468 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-10-08T03:44:28.746Z,1602128668.746 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T03:44:32.376Z,1602128672.376 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-10-08T03:44:40.059Z,1602128680.059 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T03:44:43.285Z,1602128683.285 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-10-08T03:44:51.371Z,1602128691.371 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T03:44:54.192Z,1602128694.192 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-10-08T03:45:01.866Z,1602128701.866 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T03:45:05.101Z,1602128705.101 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-10-08T03:45:12.786Z,1602128712.786 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T03:45:16.009Z,1602128716.009 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-10-08T03:45:24.091Z,1602128724.091 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T03:45:27.727Z,1602128727.727 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-10-08T03:45:35.407Z,1602128735.407 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T03:45:38.668Z,1602128738.668 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-10-08T03:45:46.309Z,1602128746.309 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T03:45:49.566Z,1602128749.566 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-10-08T03:45:56.414Z,1602128756.414 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 5 2020-10-08T03:45:56.414Z,1602128756.414 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-10-08T03:45:56.437Z,1602128756.437 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-10-08T03:45:56.839Z,1602128756.839 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-10-08T03:45:56.839Z,1602128756.839 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 5 2020-10-08T03:45:57.671Z,1602128757.671 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T03:46:08.530Z,1602128768.530 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T03:46:19.442Z,1602128779.442 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T03:46:19.497Z,1602128779.497 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-10-08T03:46:30.346Z,1602128790.346 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T03:46:41.281Z,1602128801.281 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T03:46:52.162Z,1602128812.162 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T03:46:55.778Z,1602128815.778 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-10-08T03:47:02.674Z,1602128822.674 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T03:47:13.579Z,1602128833.579 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T03:47:20.427Z,1602128840.427 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-10-08T03:47:24.890Z,1602128844.890 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T03:47:35.793Z,1602128855.793 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T03:47:47.110Z,1602128867.110 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T03:48:54.589Z,1602128934.589 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T03:48:57.359Z,1602128937.359 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 6 2020-10-08T03:48:57.359Z,1602128937.359 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-10-08T03:48:57.369Z,1602128937.369 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-10-08T03:48:57.779Z,1602128937.779 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-10-08T03:48:57.779Z,1602128937.779 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 6 2020-10-08T03:48:58.655Z,1602128938.655 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2020-10-08T03:48:58.656Z,1602128938.656 [Default:CheckIn:C.Wait] Stopped 2020-10-08T03:48:58.656Z,1602128938.656 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2020-10-08T03:48:58.656Z,1602128938.656 [Default:CheckIn:D] Running Loop=1 2020-10-08T03:48:58.994Z,1602128938.994 [Default:CheckIn:D] Stopped 2020-10-08T03:48:58.994Z,1602128938.994 [Default:CheckIn:E] Running Loop=1 2020-10-08T03:48:59.390Z,1602128939.390 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 10.745911 min 2020-10-08T03:48:59.390Z,1602128939.390 [Default:CheckIn:E] Stopped 2020-10-08T03:48:59.390Z,1602128939.390 [Default:CheckIn](INFO): Completed Default:CheckIn 2020-10-08T03:48:59.390Z,1602128939.390 [Default:CheckIn] Stopped 2020-10-08T03:48:59.390Z,1602128939.390 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2020-10-08T03:48:59.390Z,1602128939.390 [Default:CheckIn](INFO): Running loop #2 2020-10-08T03:48:59.390Z,1602128939.390 [Default:CheckIn] Running Loop=2 2020-10-08T03:48:59.390Z,1602128939.390 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2020-10-08T03:48:59.391Z,1602128939.391 [Default:CheckIn:Read_GPS] Running Loop=1 2020-10-08T03:50:18.559Z,1602129018.559 [RDI_Pathfinder](ERROR): only read 2 of 4 data items 2020-10-08T03:51:28.491Z,1602129088.491 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-10-08T03:51:58.395Z,1602129118.395 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 7 2020-10-08T03:51:58.395Z,1602129118.395 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-10-08T03:51:58.422Z,1602129118.422 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-10-08T03:51:58.755Z,1602129118.755 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-10-08T03:51:58.755Z,1602129118.755 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 7 2020-10-08T03:52:16.914Z,1602129136.914 [NAL9602](FAULT): GPS failed to acquire within timeout. 2020-10-08T03:52:16.914Z,1602129136.914 [NAL9602] Data Fault, FailCount= 2 2020-10-08T03:52:16.914Z,1602129136.914 [NAL9602](ERROR): Data Fault 2020-10-08T03:52:16.936Z,1602129136.936 [CBIT](ERROR): Data Fault in component: NAL9602 2020-10-08T03:52:17.326Z,1602129137.326 [NAL9602](INFO): Powering down 2020-10-08T03:52:18.147Z,1602129138.147 [CBIT](INFO): Clearing failed state for component NAL9602 2020-10-08T03:52:18.148Z,1602129138.148 [NAL9602] No Fault, FailCount= 2 2020-10-08T03:52:38.745Z,1602129158.745 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for altitude 2020-10-08T03:52:45.284Z,1602129165.284 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T03:52:47.622Z,1602129167.622 [NAL9602](INFO): Powering up NAL9602 2020-10-08T03:52:56.170Z,1602129176.170 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T03:52:58.531Z,1602129178.531 [NAL9602](INFO): NAL9602 initialized 2020-10-08T03:53:02.669Z,1602129182.669 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-10-08T03:53:07.078Z,1602129187.078 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T03:53:13.541Z,1602129193.541 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-10-08T03:53:17.586Z,1602129197.586 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T03:53:24.448Z,1602129204.448 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-10-08T03:53:28.898Z,1602129208.898 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T03:53:35.360Z,1602129215.360 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-10-08T03:53:39.847Z,1602129219.847 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T03:53:45.857Z,1602129225.857 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-10-08T03:53:50.714Z,1602129230.714 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T03:53:56.769Z,1602129236.769 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-10-08T03:53:59.578Z,1602129239.578 [Default:CheckIn:Read_GPS](INFO): Timed out from 2020-10-08T03:48:59.4Z 2020-10-08T03:53:59.578Z,1602129239.578 [Default:CheckIn:Read_GPS] Stopped 2020-10-08T03:53:59.578Z,1602129239.578 [Default:CheckIn:Read_Iridium] Running Loop=1 2020-10-08T03:54:01.618Z,1602129241.618 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T03:54:06.656Z,1602129246.656 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20201008T033042/Courier0007.lzma 2020-10-08T03:54:07.658Z,1602129247.658 [DataOverHttps](INFO): Moved sent file to Logs/20201008T033042/Courier0007.lzma.bak 2020-10-08T03:54:07.658Z,1602129247.658 [DataOverHttps](INFO): SBD MOMSN=12817105 2020-10-08T03:54:07.708Z,1602129247.708 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-10-08T03:54:12.595Z,1602129252.595 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T03:54:18.587Z,1602129258.587 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-10-08T03:54:23.607Z,1602129263.607 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T03:54:27.084Z,1602129267.084 [DataOverHttps](INFO): Sending 287 bytes from file Logs/20201008T033042/Express0008.lzma 2020-10-08T03:54:28.086Z,1602129268.086 [DataOverHttps](INFO): Moved sent file to Logs/20201008T033042/Express0008.lzma.bak 2020-10-08T03:54:28.086Z,1602129268.086 [DataOverHttps](INFO): SBD MOMSN=12817107 2020-10-08T03:54:29.560Z,1602129269.560 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-10-08T03:54:31.059Z,1602129271.059 [Default:CheckIn:Read_Iridium] Stopped 2020-10-08T03:54:31.059Z,1602129271.059 [Default:CheckIn:C.Wait] Running Loop=1 2020-10-08T03:54:31.059Z,1602129271.059 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2020-10-08T03:54:34.777Z,1602129274.777 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T03:54:40.402Z,1602129280.402 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-10-08T03:54:45.660Z,1602129285.660 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T03:54:51.311Z,1602129291.311 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-10-08T03:54:56.564Z,1602129296.564 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T03:54:59.351Z,1602129299.351 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 8 2020-10-08T03:54:59.351Z,1602129299.351 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-10-08T03:54:59.361Z,1602129299.361 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-10-08T03:54:59.759Z,1602129299.759 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-10-08T03:54:59.759Z,1602129299.759 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 8 2020-10-08T03:55:02.222Z,1602129302.222 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-10-08T03:55:07.468Z,1602129307.468 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T03:55:13.554Z,1602129313.554 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-10-08T03:55:18.429Z,1602129318.429 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T03:55:24.841Z,1602129324.841 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-10-08T03:55:29.690Z,1602129329.690 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T03:55:40.602Z,1602129340.602 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T03:55:51.506Z,1602129351.506 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T03:56:02.821Z,1602129362.821 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T03:56:13.731Z,1602129373.731 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T03:56:24.639Z,1602129384.639 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T03:56:35.945Z,1602129395.945 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T03:56:47.284Z,1602129407.284 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T03:56:58.166Z,1602129418.166 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T03:57:09.079Z,1602129429.079 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T03:57:19.577Z,1602129439.577 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T03:57:30.894Z,1602129450.894 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T03:58:00.332Z,1602129480.332 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 9 2020-10-08T03:58:00.332Z,1602129480.332 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-10-08T03:58:00.363Z,1602129480.363 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-10-08T03:58:00.751Z,1602129480.751 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-10-08T03:58:00.751Z,1602129480.751 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 9 2020-10-08T03:59:29.690Z,1602129569.690 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T03:59:31.712Z,1602129571.712 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2020-10-08T03:59:31.712Z,1602129571.712 [Default:CheckIn:C.Wait] Stopped 2020-10-08T03:59:31.712Z,1602129571.712 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2020-10-08T03:59:31.713Z,1602129571.713 [Default:CheckIn:D] Running Loop=1 2020-10-08T03:59:32.067Z,1602129572.067 [Default:CheckIn:D] Stopped 2020-10-08T03:59:32.067Z,1602129572.067 [Default:CheckIn:E] Running Loop=1 2020-10-08T03:59:32.483Z,1602129572.483 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 21.297127 min 2020-10-08T03:59:32.483Z,1602129572.483 [Default:CheckIn:E] Stopped 2020-10-08T03:59:32.483Z,1602129572.483 [Default:CheckIn](INFO): Completed Default:CheckIn 2020-10-08T03:59:32.483Z,1602129572.483 [Default:CheckIn] Stopped 2020-10-08T03:59:32.484Z,1602129572.484 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2020-10-08T03:59:32.484Z,1602129572.484 [Default:CheckIn](INFO): Running loop #3 2020-10-08T03:59:32.484Z,1602129572.484 [Default:CheckIn] Running Loop=3 2020-10-08T03:59:32.484Z,1602129572.484 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2020-10-08T03:59:32.484Z,1602129572.484 [Default:CheckIn:Read_GPS] Running Loop=1 2020-10-08T03:59:43.782Z,1602129583.782 [RDI_Pathfinder](ERROR): only read 3 of 4 data items 2020-10-08T04:00:39.560Z,1602129639.560 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-10-08T04:00:53.661Z,1602129653.661 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error 2020-10-08T04:01:01.347Z,1602129661.347 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 10 2020-10-08T04:01:01.347Z,1602129661.347 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-10-08T04:01:01.389Z,1602129661.389 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-10-08T04:01:01.739Z,1602129661.739 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-10-08T04:01:01.739Z,1602129661.739 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 10 2020-10-08T04:01:47.026Z,1602129707.026 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-10-08T04:01:53.025Z,1602129713.025 [BPC1](INFO): Calculating totals. Valid battery stick count: 44. Valid reserve battery stick count: 4. 2020-10-08T04:01:53.028Z,1602129713.028 [BPC1](ERROR): Failed to receive data from all sticks prior to timeout. Will not retry this scan cycle. 2020-10-08T04:03:00.918Z,1602129780.918 [NAL9602](FAULT): GPS failed to acquire within timeout. 2020-10-08T04:03:00.918Z,1602129780.918 [NAL9602] Data Fault, FailCount= 3 2020-10-08T04:03:00.918Z,1602129780.918 [NAL9602](ERROR): Data Fault 2020-10-08T04:03:01.012Z,1602129781.012 [CBIT](ERROR): Data Fault in component: NAL9602 2020-10-08T04:03:01.301Z,1602129781.301 [NAL9602](INFO): Powering down 2020-10-08T04:03:02.176Z,1602129782.176 [CBIT](INFO): Clearing failed state for component NAL9602 2020-10-08T04:03:02.176Z,1602129782.176 [NAL9602] No Fault, FailCount= 3 2020-10-08T04:03:31.602Z,1602129811.602 [NAL9602](INFO): Powering up NAL9602 2020-10-08T04:03:42.510Z,1602129822.510 [NAL9602](INFO): NAL9602 initialized 2020-10-08T04:04:02.318Z,1602129842.318 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 11 2020-10-08T04:04:02.318Z,1602129842.318 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-10-08T04:04:02.332Z,1602129842.332 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-10-08T04:04:02.754Z,1602129842.754 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-10-08T04:04:02.754Z,1602129842.754 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 11 2020-10-08T04:04:32.622Z,1602129872.622 [Default:CheckIn:Read_GPS](INFO): Timed out from 2020-10-08T03:59:32.5Z 2020-10-08T04:04:32.622Z,1602129872.622 [Default:CheckIn:Read_GPS] Stopped 2020-10-08T04:04:32.623Z,1602129872.623 [Default:CheckIn:Read_Iridium] Running Loop=1 2020-10-08T04:04:39.872Z,1602129879.872 [DataOverHttps](INFO): Sending 168 bytes from file Logs/20201008T033042/Courier0010.lzma 2020-10-08T04:04:40.874Z,1602129880.874 [DataOverHttps](INFO): Moved sent file to Logs/20201008T033042/Courier0010.lzma.bak 2020-10-08T04:04:40.874Z,1602129880.874 [DataOverHttps](INFO): SBD MOMSN=12817255 2020-10-08T04:04:58.364Z,1602129898.364 [DataOverHttps](INFO): Sending 150 bytes from file Logs/20201008T033042/Express0011.lzma 2020-10-08T04:04:59.366Z,1602129899.366 [DataOverHttps](INFO): Moved sent file to Logs/20201008T033042/Express0011.lzma.bak 2020-10-08T04:04:59.367Z,1602129899.367 [DataOverHttps](INFO): SBD MOMSN=12817260 2020-10-08T04:05:02.549Z,1602129902.549 [Default:CheckIn:Read_Iridium] Stopped 2020-10-08T04:05:02.549Z,1602129902.549 [Default:CheckIn:C.Wait] Running Loop=1 2020-10-08T04:05:02.549Z,1602129902.549 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2020-10-08T04:07:03.340Z,1602130023.340 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 12 2020-10-08T04:07:03.341Z,1602130023.341 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-10-08T04:07:03.355Z,1602130023.355 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-10-08T04:07:03.775Z,1602130023.775 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-10-08T04:07:03.775Z,1602130023.775 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 12 2020-10-08T04:10:03.099Z,1602130203.099 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2020-10-08T04:10:03.099Z,1602130203.099 [Default:CheckIn:C.Wait] Stopped 2020-10-08T04:10:03.099Z,1602130203.099 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2020-10-08T04:10:03.099Z,1602130203.099 [Default:CheckIn:D] Running Loop=1 2020-10-08T04:10:03.515Z,1602130203.515 [Default:CheckIn:D] Stopped 2020-10-08T04:10:03.515Z,1602130203.515 [Default:CheckIn:E] Running Loop=1 2020-10-08T04:10:03.962Z,1602130203.962 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 31.821265 min 2020-10-08T04:10:03.962Z,1602130203.962 [Default:CheckIn:E] Stopped 2020-10-08T04:10:03.962Z,1602130203.962 [Default:CheckIn](INFO): Completed Default:CheckIn 2020-10-08T04:10:03.962Z,1602130203.962 [Default:CheckIn] Stopped 2020-10-08T04:10:03.963Z,1602130203.963 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2020-10-08T04:10:03.963Z,1602130203.963 [Default:CheckIn](INFO): Running loop #4 2020-10-08T04:10:03.963Z,1602130203.963 [Default:CheckIn] Running Loop=4 2020-10-08T04:10:03.963Z,1602130203.963 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2020-10-08T04:10:03.963Z,1602130203.963 [Default:CheckIn:Read_GPS] Running Loop=1 2020-10-08T04:10:04.329Z,1602130204.329 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 13 2020-10-08T04:10:04.329Z,1602130204.329 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-10-08T04:10:04.339Z,1602130204.339 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-10-08T04:10:04.773Z,1602130204.773 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-10-08T04:10:04.773Z,1602130204.773 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 13 2020-10-08T04:13:05.341Z,1602130385.341 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 14 2020-10-08T04:13:05.341Z,1602130385.341 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-10-08T04:13:05.352Z,1602130385.352 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-10-08T04:13:05.716Z,1602130385.716 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-10-08T04:13:05.716Z,1602130385.716 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 14 2020-10-08T04:13:44.478Z,1602130424.478 [NAL9602](FAULT): GPS failed to acquire within timeout. 2020-10-08T04:13:44.478Z,1602130424.478 [NAL9602] Data Fault, FailCount= 4 2020-10-08T04:13:44.478Z,1602130424.478 [NAL9602](ERROR): Data Fault 2020-10-08T04:13:44.507Z,1602130424.507 [CBIT](ERROR): Data Fault in component: NAL9602 2020-10-08T04:13:44.881Z,1602130424.881 [NAL9602](INFO): Powering down 2020-10-08T04:13:45.711Z,1602130425.711 [CBIT](INFO): Clearing failed state for component NAL9602 2020-10-08T04:13:45.711Z,1602130425.711 [NAL9602] No Fault, FailCount= 4 2020-10-08T04:14:15.182Z,1602130455.182 [NAL9602](INFO): Powering up NAL9602 2020-10-08T04:14:26.094Z,1602130466.094 [NAL9602](INFO): NAL9602 initialized 2020-10-08T04:15:04.106Z,1602130504.106 [Default:CheckIn:Read_GPS](INFO): Timed out from 2020-10-08T04:10:03.0Z 2020-10-08T04:15:04.106Z,1602130504.106 [Default:CheckIn:Read_GPS] Stopped 2020-10-08T04:15:04.107Z,1602130504.107 [Default:CheckIn:Read_Iridium] Running Loop=1 2020-10-08T04:15:11.684Z,1602130511.684 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20201008T033042/Courier0013.lzma 2020-10-08T04:15:12.686Z,1602130512.686 [DataOverHttps](INFO): Moved sent file to Logs/20201008T033042/Courier0013.lzma.bak 2020-10-08T04:15:12.686Z,1602130512.686 [DataOverHttps](INFO): SBD MOMSN=12817357 2020-10-08T04:15:30.128Z,1602130530.128 [DataOverHttps](INFO): Sending 160 bytes from file Logs/20201008T033042/Express0014.lzma 2020-10-08T04:15:31.130Z,1602130531.130 [DataOverHttps](INFO): Moved sent file to Logs/20201008T033042/Express0014.lzma.bak 2020-10-08T04:15:31.130Z,1602130531.130 [DataOverHttps](INFO): SBD MOMSN=12817359 2020-10-08T04:15:33.978Z,1602130533.978 [Default:CheckIn:Read_Iridium] Stopped 2020-10-08T04:15:33.978Z,1602130533.978 [Default:CheckIn:C.Wait] Running Loop=1 2020-10-08T04:15:33.978Z,1602130533.978 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2020-10-08T04:16:06.315Z,1602130566.315 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 15 2020-10-08T04:16:06.315Z,1602130566.315 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-10-08T04:16:06.346Z,1602130566.346 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-10-08T04:16:06.731Z,1602130566.731 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-10-08T04:16:06.731Z,1602130566.731 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 15 2020-10-08T04:18:09.937Z,1602130689.937 [RDI_Pathfinder](ERROR): only read 3 of 4 data items 2020-10-08T04:19:07.297Z,1602130747.297 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 16 2020-10-08T04:19:07.297Z,1602130747.297 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-10-08T04:19:07.307Z,1602130747.307 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-10-08T04:19:07.711Z,1602130747.711 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-10-08T04:19:07.711Z,1602130747.711 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 16 2020-10-08T04:20:34.566Z,1602130834.566 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2020-10-08T04:20:34.566Z,1602130834.566 [Default:CheckIn:C.Wait] Stopped 2020-10-08T04:20:34.566Z,1602130834.566 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2020-10-08T04:20:34.566Z,1602130834.566 [Default:CheckIn:D] Running Loop=1 2020-10-08T04:20:35.038Z,1602130835.038 [Default:CheckIn:D] Stopped 2020-10-08T04:20:35.038Z,1602130835.038 [Default:CheckIn:E] Running Loop=1 2020-10-08T04:20:35.405Z,1602130835.405 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 42.346639 min 2020-10-08T04:20:35.405Z,1602130835.405 [Default:CheckIn:E] Stopped 2020-10-08T04:20:35.405Z,1602130835.405 [Default:CheckIn](INFO): Completed Default:CheckIn 2020-10-08T04:20:35.405Z,1602130835.405 [Default:CheckIn] Stopped 2020-10-08T04:20:35.405Z,1602130835.405 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2020-10-08T04:20:35.406Z,1602130835.406 [Default:CheckIn](INFO): Running loop #5 2020-10-08T04:20:35.406Z,1602130835.406 [Default:CheckIn] Running Loop=5 2020-10-08T04:20:35.406Z,1602130835.406 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2020-10-08T04:20:35.406Z,1602130835.406 [Default:CheckIn:Read_GPS] Running Loop=1 2020-10-08T04:22:08.322Z,1602130928.322 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 17 2020-10-08T04:22:08.322Z,1602130928.322 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-10-08T04:22:08.332Z,1602130928.332 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-10-08T04:22:08.734Z,1602130928.734 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-10-08T04:22:08.734Z,1602130928.734 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 17 2020-10-08T04:24:28.070Z,1602131068.070 [NAL9602](FAULT): GPS failed to acquire within timeout. 2020-10-08T04:24:28.070Z,1602131068.070 [NAL9602] Data Fault, FailCount= 5 2020-10-08T04:24:28.070Z,1602131068.070 [NAL9602](ERROR): Data Fault 2020-10-08T04:24:28.099Z,1602131068.099 [CBIT](ERROR): Data Fault in component: NAL9602 2020-10-08T04:24:28.100Z,1602131068.100 [CBIT](CRITICAL): Data Fault in component: NAL9602 2020-10-08T04:24:28.481Z,1602131068.481 [NAL9602](INFO): Powering down 2020-10-08T04:24:28.505Z,1602131068.505 [CommandLine](FAULT): Scheduling is paused 2020-10-08T04:24:28.505Z,1602131068.505 [CBIT](INFO): Critical error at 20201008T042428 2020-10-08T04:25:09.306Z,1602131109.306 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 18 2020-10-08T04:25:09.306Z,1602131109.306 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-10-08T04:25:09.317Z,1602131109.317 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-10-08T04:25:09.725Z,1602131109.725 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-10-08T04:25:09.725Z,1602131109.725 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 18 2020-10-08T04:25:35.556Z,1602131135.556 [Default:CheckIn:Read_GPS](INFO): Timed out from 2020-10-08T04:20:35.4Z 2020-10-08T04:25:35.556Z,1602131135.556 [Default:CheckIn:Read_GPS] Stopped 2020-10-08T04:25:35.556Z,1602131135.556 [Default:CheckIn:Read_Iridium] Running Loop=1 2020-10-08T04:25:45.402Z,1602131145.402 [DataOverHttps](INFO): Sending 105 bytes from file Logs/20201008T033042/Courier0016.lzma 2020-10-08T04:25:46.402Z,1602131146.402 [DataOverHttps](INFO): Moved sent file to Logs/20201008T033042/Courier0016.lzma.bak 2020-10-08T04:25:46.403Z,1602131146.403 [DataOverHttps](INFO): SBD MOMSN=12817514 2020-10-08T04:26:07.360Z,1602131167.360 [DataOverHttps](INFO): Sending 174 bytes from file Logs/20201008T033042/Express0017.lzma 2020-10-08T04:26:08.362Z,1602131168.362 [DataOverHttps](INFO): Moved sent file to Logs/20201008T033042/Express0017.lzma.bak 2020-10-08T04:26:08.362Z,1602131168.362 [DataOverHttps](INFO): SBD MOMSN=12817517 2020-10-08T04:26:11.565Z,1602131171.565 [Default:CheckIn:Read_Iridium] Stopped 2020-10-08T04:26:11.565Z,1602131171.565 [Default:CheckIn:C.Wait] Running Loop=1 2020-10-08T04:26:11.565Z,1602131171.565 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2020-10-08T04:26:28.107Z,1602131188.107 [CBIT](INFO): Clearing failed state for component NAL9602 2020-10-08T04:26:28.107Z,1602131188.107 [NAL9602] No Fault, FailCount= 5 2020-10-08T04:26:28.490Z,1602131188.490 [NAL9602](INFO): Powering up NAL9602 2020-10-08T04:26:39.398Z,1602131199.398 [NAL9602](INFO): NAL9602 initialized 2020-10-08T04:28:10.353Z,1602131290.353 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 19 2020-10-08T04:28:10.353Z,1602131290.353 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-10-08T04:28:10.380Z,1602131290.380 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-10-08T04:28:10.759Z,1602131290.759 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-10-08T04:28:10.759Z,1602131290.759 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 19 2020-10-08T04:31:11.318Z,1602131471.318 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 20 2020-10-08T04:31:11.318Z,1602131471.318 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-10-08T04:31:11.333Z,1602131471.333 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-10-08T04:31:11.747Z,1602131471.747 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-10-08T04:31:11.747Z,1602131471.747 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 20 2020-10-08T04:31:12.110Z,1602131472.110 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2020-10-08T04:31:12.110Z,1602131472.110 [Default:CheckIn:C.Wait] Stopped 2020-10-08T04:31:12.110Z,1602131472.110 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2020-10-08T04:31:12.111Z,1602131472.111 [Default:CheckIn:D] Running Loop=1 2020-10-08T04:31:12.515Z,1602131472.515 [Default:CheckIn:D] Stopped 2020-10-08T04:31:12.515Z,1602131472.515 [Default:CheckIn:E] Running Loop=1 2020-10-08T04:31:12.937Z,1602131472.937 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 52.971257 min 2020-10-08T04:31:12.937Z,1602131472.937 [Default:CheckIn:E] Stopped 2020-10-08T04:31:12.937Z,1602131472.937 [Default:CheckIn](INFO): Completed Default:CheckIn 2020-10-08T04:31:12.938Z,1602131472.938 [Default:CheckIn] Stopped 2020-10-08T04:31:12.938Z,1602131472.938 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2020-10-08T04:31:12.938Z,1602131472.938 [Default:CheckIn](INFO): Running loop #6 2020-10-08T04:31:12.938Z,1602131472.938 [Default:CheckIn] Running Loop=6 2020-10-08T04:31:12.938Z,1602131472.938 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2020-10-08T04:31:12.938Z,1602131472.938 [Default:CheckIn:Read_GPS] Running Loop=1 2020-10-08T04:34:12.314Z,1602131652.314 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 21 2020-10-08T04:34:12.314Z,1602131652.314 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-10-08T04:34:12.324Z,1602131652.324 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-10-08T04:34:12.744Z,1602131652.744 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-10-08T04:34:12.744Z,1602131652.744 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 21 2020-10-08T04:36:13.090Z,1602131773.090 [Default:CheckIn:Read_GPS](INFO): Timed out from 2020-10-08T04:31:12.9Z 2020-10-08T04:36:13.091Z,1602131773.091 [Default:CheckIn:Read_GPS] Stopped 2020-10-08T04:36:13.091Z,1602131773.091 [Default:CheckIn:Read_Iridium] Running Loop=1 2020-10-08T04:36:20.696Z,1602131780.696 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20201008T033042/Courier0019.lzma 2020-10-08T04:36:21.698Z,1602131781.698 [DataOverHttps](INFO): Moved sent file to Logs/20201008T033042/Courier0019.lzma.bak 2020-10-08T04:36:21.698Z,1602131781.698 [DataOverHttps](INFO): SBD MOMSN=12817611 2020-10-08T04:36:23.229Z,1602131783.229 [RDI_Pathfinder](ERROR): only read 3 of 4 data items 2020-10-08T04:36:39.100Z,1602131799.100 [DataOverHttps](INFO): Sending 108 bytes from file Logs/20201008T033042/Express0020.lzma 2020-10-08T04:36:40.102Z,1602131800.102 [DataOverHttps](INFO): Moved sent file to Logs/20201008T033042/Express0020.lzma.bak 2020-10-08T04:36:40.102Z,1602131800.102 [DataOverHttps](INFO): SBD MOMSN=12817613 2020-10-08T04:36:41.358Z,1602131801.358 [NAL9602](FAULT): GPS failed to acquire within timeout. 2020-10-08T04:36:41.358Z,1602131801.358 [NAL9602] Data Fault, FailCount= 1 2020-10-08T04:36:41.358Z,1602131801.358 [NAL9602](ERROR): Data Fault 2020-10-08T04:36:41.484Z,1602131801.484 [CBIT](ERROR): Data Fault in component: NAL9602 2020-10-08T04:36:41.769Z,1602131801.769 [NAL9602](INFO): Powering down 2020-10-08T04:36:42.655Z,1602131802.655 [CBIT](INFO): Clearing failed state for component NAL9602 2020-10-08T04:36:42.655Z,1602131802.655 [NAL9602] No Fault, FailCount= 1 2020-10-08T04:36:42.994Z,1602131802.994 [Default:CheckIn:Read_Iridium] Stopped 2020-10-08T04:36:42.994Z,1602131802.994 [Default:CheckIn:C.Wait] Running Loop=1 2020-10-08T04:36:42.994Z,1602131802.994 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2020-10-08T04:37:12.066Z,1602131832.066 [NAL9602](INFO): Powering up NAL9602 2020-10-08T04:37:13.301Z,1602131833.301 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 22 2020-10-08T04:37:13.301Z,1602131833.301 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-10-08T04:37:13.311Z,1602131833.311 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-10-08T04:37:13.745Z,1602131833.745 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-10-08T04:37:13.746Z,1602131833.746 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 22 2020-10-08T04:37:22.974Z,1602131842.974 [NAL9602](INFO): NAL9602 initialized 2020-10-08T04:40:14.284Z,1602132014.284 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 23 2020-10-08T04:40:14.284Z,1602132014.284 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-10-08T04:40:14.315Z,1602132014.315 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-10-08T04:40:14.691Z,1602132014.691 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-10-08T04:40:14.691Z,1602132014.691 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 23 2020-10-08T04:41:43.562Z,1602132103.562 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2020-10-08T04:41:43.563Z,1602132103.563 [Default:CheckIn:C.Wait] Stopped 2020-10-08T04:41:43.563Z,1602132103.563 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2020-10-08T04:41:43.563Z,1602132103.563 [Default:CheckIn:D] Running Loop=1 2020-10-08T04:41:44.011Z,1602132104.011 [Default:CheckIn:D] Stopped 2020-10-08T04:41:44.011Z,1602132104.011 [Default:CheckIn:E] Running Loop=1 2020-10-08T04:41:44.396Z,1602132104.396 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 63.496187 min 2020-10-08T04:41:44.396Z,1602132104.396 [Default:CheckIn:E] Stopped 2020-10-08T04:41:44.396Z,1602132104.396 [Default:CheckIn](INFO): Completed Default:CheckIn 2020-10-08T04:41:44.397Z,1602132104.397 [Default:CheckIn] Stopped 2020-10-08T04:41:44.397Z,1602132104.397 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2020-10-08T04:41:44.397Z,1602132104.397 [Default:CheckIn](INFO): Running loop #7 2020-10-08T04:41:44.397Z,1602132104.397 [Default:CheckIn] Running Loop=7 2020-10-08T04:41:44.397Z,1602132104.397 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2020-10-08T04:41:44.397Z,1602132104.397 [Default:CheckIn:Read_GPS] Running Loop=1 2020-10-08T04:43:15.281Z,1602132195.281 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 24 2020-10-08T04:43:15.281Z,1602132195.281 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-10-08T04:43:15.292Z,1602132195.292 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-10-08T04:43:15.690Z,1602132195.690 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-10-08T04:43:15.690Z,1602132195.690 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 24 2020-10-08T04:46:16.311Z,1602132376.311 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 25 2020-10-08T04:46:16.311Z,1602132376.311 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-10-08T04:46:16.341Z,1602132376.341 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-10-08T04:46:16.727Z,1602132376.727 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-10-08T04:46:16.727Z,1602132376.727 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 25 2020-10-08T04:46:44.592Z,1602132404.592 [Default:CheckIn:Read_GPS](INFO): Timed out from 2020-10-08T04:41:44.4Z 2020-10-08T04:46:44.592Z,1602132404.592 [Default:CheckIn:Read_GPS] Stopped 2020-10-08T04:46:44.592Z,1602132404.592 [Default:CheckIn:Read_Iridium] Running Loop=1 2020-10-08T04:46:52.348Z,1602132412.348 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20201008T033042/Courier0022.lzma 2020-10-08T04:46:53.350Z,1602132413.350 [DataOverHttps](INFO): Moved sent file to Logs/20201008T033042/Courier0022.lzma.bak 2020-10-08T04:46:53.350Z,1602132413.350 [DataOverHttps](INFO): SBD MOMSN=12817695 2020-10-08T04:47:10.812Z,1602132430.812 [DataOverHttps](INFO): Sending 151 bytes from file Logs/20201008T033042/Express0023.lzma 2020-10-08T04:47:11.814Z,1602132431.814 [DataOverHttps](INFO): Moved sent file to Logs/20201008T033042/Express0023.lzma.bak 2020-10-08T04:47:11.814Z,1602132431.814 [DataOverHttps](INFO): SBD MOMSN=12817701 2020-10-08T04:47:14.916Z,1602132434.916 [Default:CheckIn:Read_Iridium] Stopped 2020-10-08T04:47:14.916Z,1602132434.916 [Default:CheckIn:C.Wait] Running Loop=1 2020-10-08T04:47:14.916Z,1602132434.916 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2020-10-08T04:47:24.962Z,1602132444.962 [NAL9602](FAULT): GPS failed to acquire within timeout. 2020-10-08T04:47:24.962Z,1602132444.962 [NAL9602] Data Fault, FailCount= 2 2020-10-08T04:47:24.962Z,1602132444.962 [NAL9602](ERROR): Data Fault 2020-10-08T04:47:25.132Z,1602132445.132 [CBIT](ERROR): Data Fault in component: NAL9602 2020-10-08T04:47:25.366Z,1602132445.366 [NAL9602](INFO): Powering down 2020-10-08T04:47:26.266Z,1602132446.266 [CBIT](INFO): Clearing failed state for component NAL9602 2020-10-08T04:47:26.266Z,1602132446.266 [NAL9602] No Fault, FailCount= 2 2020-10-08T04:47:55.666Z,1602132475.666 [NAL9602](INFO): Powering up NAL9602 2020-10-08T04:48:06.578Z,1602132486.578 [NAL9602](INFO): NAL9602 initialized 2020-10-08T04:49:17.296Z,1602132557.296 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 26 2020-10-08T04:49:17.312Z,1602132557.312 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-10-08T04:49:17.327Z,1602132557.327 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-10-08T04:49:17.699Z,1602132557.699 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-10-08T04:49:17.699Z,1602132557.699 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 26 2020-10-08T04:52:15.467Z,1602132735.467 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2020-10-08T04:52:15.467Z,1602132735.467 [Default:CheckIn:C.Wait] Stopped 2020-10-08T04:52:15.467Z,1602132735.467 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2020-10-08T04:52:15.468Z,1602132735.468 [Default:CheckIn:D] Running Loop=1 2020-10-08T04:52:15.870Z,1602132735.870 [Default:CheckIn:D] Stopped 2020-10-08T04:52:15.870Z,1602132735.870 [Default:CheckIn:E] Running Loop=1 2020-10-08T04:52:16.270Z,1602132736.270 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 74.027181 min 2020-10-08T04:52:16.270Z,1602132736.270 [Default:CheckIn:E] Stopped 2020-10-08T04:52:16.270Z,1602132736.270 [Default:CheckIn](INFO): Completed Default:CheckIn 2020-10-08T04:52:16.270Z,1602132736.270 [Default:CheckIn] Stopped 2020-10-08T04:52:16.270Z,1602132736.270 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2020-10-08T04:52:16.270Z,1602132736.270 [Default:CheckIn](INFO): Running loop #8 2020-10-08T04:52:16.270Z,1602132736.270 [Default:CheckIn] Running Loop=8 2020-10-08T04:52:16.271Z,1602132736.271 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2020-10-08T04:52:16.271Z,1602132736.271 [Default:CheckIn:Read_GPS] Running Loop=1 2020-10-08T04:52:18.302Z,1602132738.302 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 27 2020-10-08T04:52:18.302Z,1602132738.302 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-10-08T04:52:18.313Z,1602132738.313 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-10-08T04:52:18.714Z,1602132738.714 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-10-08T04:52:18.714Z,1602132738.714 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 27 2020-10-08T04:55:19.298Z,1602132919.298 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 28 2020-10-08T04:55:19.298Z,1602132919.298 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-10-08T04:55:19.308Z,1602132919.308 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-10-08T04:55:19.709Z,1602132919.709 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-10-08T04:55:19.709Z,1602132919.709 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 28 2020-10-08T04:57:16.453Z,1602133036.453 [Default:CheckIn:Read_GPS](INFO): Timed out from 2020-10-08T04:52:16.3Z 2020-10-08T04:57:16.453Z,1602133036.453 [Default:CheckIn:Read_GPS] Stopped 2020-10-08T04:57:16.453Z,1602133036.453 [Default:CheckIn:Read_Iridium] Running Loop=1 2020-10-08T04:57:23.376Z,1602133043.376 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20201008T033042/Courier0025.lzma 2020-10-08T04:57:24.378Z,1602133044.378 [DataOverHttps](INFO): Moved sent file to Logs/20201008T033042/Courier0025.lzma.bak 2020-10-08T04:57:24.378Z,1602133044.378 [DataOverHttps](INFO): SBD MOMSN=12817799 2020-10-08T04:57:41.784Z,1602133061.784 [DataOverHttps](INFO): Sending 161 bytes from file Logs/20201008T033042/Express0026.lzma 2020-10-08T04:57:42.787Z,1602133062.787 [DataOverHttps](INFO): Moved sent file to Logs/20201008T033042/Express0026.lzma.bak 2020-10-08T04:57:42.787Z,1602133062.787 [DataOverHttps](INFO): SBD MOMSN=12817801 2020-10-08T04:57:45.564Z,1602133065.564 [Default:CheckIn:Read_Iridium] Stopped 2020-10-08T04:57:45.564Z,1602133065.564 [Default:CheckIn:C.Wait] Running Loop=1 2020-10-08T04:57:45.564Z,1602133065.564 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2020-10-08T04:58:08.946Z,1602133088.946 [NAL9602](FAULT): GPS failed to acquire within timeout. 2020-10-08T04:58:08.946Z,1602133088.946 [NAL9602] Data Fault, FailCount= 3 2020-10-08T04:58:08.946Z,1602133088.946 [NAL9602](ERROR): Data Fault 2020-10-08T04:58:09.032Z,1602133089.032 [CBIT](ERROR): Data Fault in component: NAL9602 2020-10-08T04:58:09.345Z,1602133089.345 [NAL9602](INFO): Powering down 2020-10-08T04:58:10.184Z,1602133090.184 [CBIT](INFO): Clearing failed state for component NAL9602 2020-10-08T04:58:10.184Z,1602133090.184 [NAL9602] No Fault, FailCount= 3 2020-10-08T04:58:20.277Z,1602133100.277 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 29 2020-10-08T04:58:20.277Z,1602133100.277 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-10-08T04:58:20.288Z,1602133100.288 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-10-08T04:58:20.689Z,1602133100.689 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-10-08T04:58:20.689Z,1602133100.689 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 29 2020-10-08T04:58:39.656Z,1602133119.656 [NAL9602](INFO): Powering up NAL9602 2020-10-08T04:58:50.558Z,1602133130.558 [NAL9602](INFO): NAL9602 initialized 2020-10-08T05:01:21.292Z,1602133281.292 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 30 2020-10-08T05:01:21.292Z,1602133281.292 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-10-08T05:01:21.327Z,1602133281.327 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-10-08T05:01:21.675Z,1602133281.675 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-10-08T05:01:21.675Z,1602133281.675 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 30 2020-10-08T05:02:46.103Z,1602133366.103 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2020-10-08T05:02:46.103Z,1602133366.103 [Default:CheckIn:C.Wait] Stopped 2020-10-08T05:02:46.103Z,1602133366.103 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2020-10-08T05:02:46.103Z,1602133366.103 [Default:CheckIn:D] Running Loop=1 2020-10-08T05:02:46.510Z,1602133366.510 [Default:CheckIn:D] Stopped 2020-10-08T05:02:46.510Z,1602133366.510 [Default:CheckIn:E] Running Loop=1 2020-10-08T05:02:46.935Z,1602133366.935 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 84.537842 min 2020-10-08T05:02:46.936Z,1602133366.936 [Default:CheckIn:E] Stopped 2020-10-08T05:02:46.936Z,1602133366.936 [Default:CheckIn](INFO): Completed Default:CheckIn 2020-10-08T05:02:46.936Z,1602133366.936 [Default:CheckIn] Stopped 2020-10-08T05:02:46.936Z,1602133366.936 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2020-10-08T05:02:46.940Z,1602133366.940 [Default:CheckIn](INFO): Running loop #9 2020-10-08T05:02:46.940Z,1602133366.940 [Default:CheckIn] Running Loop=9 2020-10-08T05:02:46.941Z,1602133366.941 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2020-10-08T05:02:46.941Z,1602133366.941 [Default:CheckIn:Read_GPS] Running Loop=1 2020-10-08T05:03:04.766Z,1602133384.766 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T05:03:15.652Z,1602133395.652 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T05:03:26.966Z,1602133406.966 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T05:03:37.869Z,1602133417.869 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T05:03:48.778Z,1602133428.778 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T05:03:59.686Z,1602133439.686 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T05:04:10.594Z,1602133450.594 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T05:04:21.096Z,1602133461.096 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T05:04:22.260Z,1602133462.260 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 31 2020-10-08T05:04:22.260Z,1602133462.260 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-10-08T05:04:22.271Z,1602133462.271 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-10-08T05:04:22.679Z,1602133462.679 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-10-08T05:04:22.679Z,1602133462.679 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 31 2020-10-08T05:04:32.016Z,1602133472.016 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T05:04:42.919Z,1602133482.919 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T05:04:53.822Z,1602133493.822 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T05:05:04.753Z,1602133504.753 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T05:05:16.048Z,1602133516.048 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T05:05:18.463Z,1602133518.463 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-10-08T05:07:05.922Z,1602133625.922 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-10-08T05:07:23.254Z,1602133643.254 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 32 2020-10-08T05:07:23.254Z,1602133643.254 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-10-08T05:07:23.293Z,1602133643.293 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-10-08T05:07:23.666Z,1602133643.666 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-10-08T05:07:23.666Z,1602133643.666 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 32 2020-10-08T05:07:47.126Z,1602133667.126 [Default:CheckIn:Read_GPS](INFO): Timed out from 2020-10-08T05:02:46.9Z 2020-10-08T05:07:47.126Z,1602133667.126 [Default:CheckIn:Read_GPS] Stopped 2020-10-08T05:07:47.127Z,1602133667.127 [Default:CheckIn:Read_Iridium] Running Loop=1 2020-10-08T05:07:55.152Z,1602133675.152 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20201008T033042/Courier0028.lzma 2020-10-08T05:07:56.157Z,1602133676.157 [DataOverHttps](INFO): Moved sent file to Logs/20201008T033042/Courier0028.lzma.bak 2020-10-08T05:07:56.158Z,1602133676.158 [DataOverHttps](INFO): SBD MOMSN=12817902 2020-10-08T05:08:01.346Z,1602133681.346 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T05:08:13.864Z,1602133693.864 [DataOverHttps](INFO): Sending 151 bytes from file Logs/20201008T033042/Express0029.lzma 2020-10-08T05:08:14.866Z,1602133694.866 [DataOverHttps](INFO): Moved sent file to Logs/20201008T033042/Express0029.lzma.bak 2020-10-08T05:08:14.866Z,1602133694.866 [DataOverHttps](INFO): SBD MOMSN=12817904 2020-10-08T05:08:17.853Z,1602133697.853 [Default:CheckIn:Read_Iridium] Stopped 2020-10-08T05:08:17.853Z,1602133697.853 [Default:CheckIn:C.Wait] Running Loop=1 2020-10-08T05:08:17.853Z,1602133697.853 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2020-10-08T05:08:52.550Z,1602133732.550 [NAL9602](FAULT): GPS failed to acquire within timeout. 2020-10-08T05:08:52.550Z,1602133732.550 [NAL9602] Data Fault, FailCount= 4 2020-10-08T05:08:52.550Z,1602133732.550 [NAL9602](ERROR): Data Fault 2020-10-08T05:08:52.615Z,1602133732.615 [CBIT](ERROR): Data Fault in component: NAL9602 2020-10-08T05:08:52.957Z,1602133732.957 [NAL9602](INFO): Powering down 2020-10-08T05:08:53.794Z,1602133733.794 [CBIT](INFO): Clearing failed state for component NAL9602 2020-10-08T05:08:53.794Z,1602133733.794 [NAL9602] No Fault, FailCount= 4 2020-10-08T05:08:54.627Z,1602133734.627 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-10-08T05:09:07.579Z,1602133747.579 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-10-08T05:09:23.258Z,1602133763.258 [NAL9602](INFO): Powering up NAL9602 2020-10-08T05:09:34.168Z,1602133774.168 [NAL9602](INFO): NAL9602 initialized 2020-10-08T05:09:46.738Z,1602133786.738 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-10-08T05:09:57.666Z,1602133797.666 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-10-08T05:10:08.570Z,1602133808.570 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-10-08T05:10:16.246Z,1602133816.246 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T05:10:19.534Z,1602133819.534 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-10-08T05:10:24.273Z,1602133824.273 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 33 2020-10-08T05:10:24.273Z,1602133824.273 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-10-08T05:10:24.284Z,1602133824.284 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-10-08T05:10:24.714Z,1602133824.714 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-10-08T05:10:24.714Z,1602133824.714 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 33 2020-10-08T05:10:27.607Z,1602133827.607 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T05:10:30.471Z,1602133830.471 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-10-08T05:10:38.535Z,1602133838.535 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T05:10:41.335Z,1602133841.335 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-10-08T05:10:49.387Z,1602133849.387 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T05:10:51.809Z,1602133851.809 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-10-08T05:11:00.294Z,1602133860.294 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T05:11:02.750Z,1602133862.750 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-10-08T05:11:11.592Z,1602133871.592 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T05:11:13.626Z,1602133873.626 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-10-08T05:11:22.919Z,1602133882.919 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T05:11:24.538Z,1602133884.538 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-10-08T05:11:33.827Z,1602133893.827 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T05:11:35.846Z,1602133895.846 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-10-08T05:11:44.734Z,1602133904.734 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T05:11:46.782Z,1602133906.782 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-10-08T05:11:55.646Z,1602133915.646 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T05:11:57.305Z,1602133917.305 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-10-08T05:12:06.594Z,1602133926.594 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T05:12:08.578Z,1602133928.578 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-10-08T05:12:17.462Z,1602133937.462 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T05:12:28.774Z,1602133948.774 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T05:12:39.678Z,1602133959.678 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T05:12:50.585Z,1602133970.585 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T05:13:01.494Z,1602133981.494 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T05:13:12.805Z,1602133992.805 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T05:13:18.549Z,1602133998.549 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2020-10-08T05:13:18.549Z,1602133998.549 [Default:CheckIn:C.Wait] Stopped 2020-10-08T05:13:18.549Z,1602133998.549 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2020-10-08T05:13:18.549Z,1602133998.549 [Default:CheckIn:D] Running Loop=1 2020-10-08T05:13:18.847Z,1602133998.847 [Default:CheckIn:D] Stopped 2020-10-08T05:13:18.847Z,1602133998.847 [Default:CheckIn:E] Running Loop=1 2020-10-08T05:13:19.257Z,1602133999.257 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 95.076790 min 2020-10-08T05:13:19.257Z,1602133999.257 [Default:CheckIn:E] Stopped 2020-10-08T05:13:19.258Z,1602133999.258 [Default:CheckIn](INFO): Completed Default:CheckIn 2020-10-08T05:13:19.258Z,1602133999.258 [Default:CheckIn] Stopped 2020-10-08T05:13:19.258Z,1602133999.258 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2020-10-08T05:13:19.258Z,1602133999.258 [Default:CheckIn](INFO): Running loop #10 2020-10-08T05:13:19.258Z,1602133999.258 [Default:CheckIn] Running Loop=10 2020-10-08T05:13:19.258Z,1602133999.258 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2020-10-08T05:13:19.258Z,1602133999.258 [Default:CheckIn:Read_GPS] Running Loop=1 2020-10-08T05:13:24.118Z,1602134004.118 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T05:13:25.286Z,1602134005.286 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 34 2020-10-08T05:13:25.286Z,1602134005.286 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-10-08T05:13:25.297Z,1602134005.297 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-10-08T05:13:25.731Z,1602134005.731 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-10-08T05:13:25.731Z,1602134005.731 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 34 2020-10-08T05:13:35.026Z,1602134015.026 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T05:13:45.935Z,1602134025.935 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T05:13:56.846Z,1602134036.846 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T05:14:07.342Z,1602134047.342 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T05:14:18.255Z,1602134058.255 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T05:14:29.216Z,1602134069.216 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T05:14:40.070Z,1602134080.070 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T05:14:50.579Z,1602134090.579 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T05:15:35.407Z,1602134135.407 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-10-08T05:15:47.978Z,1602134147.978 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-10-08T05:16:15.846Z,1602134175.846 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T05:16:26.274Z,1602134186.274 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 35 2020-10-08T05:16:26.274Z,1602134186.274 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-10-08T05:16:26.284Z,1602134186.284 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-10-08T05:16:26.703Z,1602134186.703 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-10-08T05:16:26.703Z,1602134186.703 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 35 2020-10-08T05:17:09.552Z,1602134229.552 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-10-08T05:18:19.438Z,1602134299.438 [Default:CheckIn:Read_GPS](INFO): Timed out from 2020-10-08T05:13:19.3Z 2020-10-08T05:18:19.439Z,1602134299.439 [Default:CheckIn:Read_GPS] Stopped 2020-10-08T05:18:19.439Z,1602134299.439 [Default:CheckIn:Read_Iridium] Running Loop=1 2020-10-08T05:18:27.116Z,1602134307.116 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20201008T033042/Courier0031.lzma 2020-10-08T05:18:28.118Z,1602134308.118 [DataOverHttps](INFO): Moved sent file to Logs/20201008T033042/Courier0031.lzma.bak 2020-10-08T05:18:28.118Z,1602134308.118 [DataOverHttps](INFO): SBD MOMSN=12817994 2020-10-08T05:18:44.124Z,1602134324.124 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-10-08T05:18:45.756Z,1602134325.756 [DataOverHttps](INFO): Sending 151 bytes from file Logs/20201008T033042/Express0032.lzma 2020-10-08T05:18:46.758Z,1602134326.758 [DataOverHttps](INFO): Moved sent file to Logs/20201008T033042/Express0032.lzma.bak 2020-10-08T05:18:46.758Z,1602134326.758 [DataOverHttps](INFO): SBD MOMSN=12817996 2020-10-08T05:18:49.735Z,1602134329.735 [Default:CheckIn:Read_Iridium] Stopped 2020-10-08T05:18:49.735Z,1602134329.735 [Default:CheckIn:C.Wait] Running Loop=1 2020-10-08T05:18:49.735Z,1602134329.735 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2020-10-08T05:19:22.866Z,1602134362.866 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-10-08T05:19:27.289Z,1602134367.289 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 36 2020-10-08T05:19:27.289Z,1602134367.289 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-10-08T05:19:27.299Z,1602134367.299 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-10-08T05:19:27.791Z,1602134367.791 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-10-08T05:19:27.791Z,1602134367.791 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 36 2020-10-08T05:19:33.785Z,1602134373.785 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-10-08T05:19:36.142Z,1602134376.142 [NAL9602](FAULT): GPS failed to acquire within timeout. 2020-10-08T05:19:36.142Z,1602134376.142 [NAL9602] Data Fault, FailCount= 5 2020-10-08T05:19:36.142Z,1602134376.142 [NAL9602](ERROR): Data Fault 2020-10-08T05:19:36.168Z,1602134376.168 [CBIT](ERROR): Data Fault in component: NAL9602 2020-10-08T05:19:36.217Z,1602134376.217 [CBIT](CRITICAL): Data Fault in component: NAL9602 2020-10-08T05:19:36.545Z,1602134376.545 [NAL9602](INFO): Powering down 2020-10-08T05:19:36.578Z,1602134376.578 [CBIT](INFO): Critical error at 20201008T051936 2020-10-08T05:19:44.704Z,1602134384.704 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-10-08T05:19:53.175Z,1602134393.175 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T05:19:55.598Z,1602134395.598 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-10-08T05:20:04.490Z,1602134404.490 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T05:20:06.917Z,1602134406.917 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-10-08T05:20:15.444Z,1602134415.444 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T05:20:17.831Z,1602134417.831 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-10-08T05:20:25.901Z,1602134425.901 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T05:20:28.764Z,1602134428.764 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-10-08T05:20:36.814Z,1602134436.814 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T05:20:39.663Z,1602134439.663 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-10-08T05:20:47.723Z,1602134447.723 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T05:20:50.238Z,1602134450.238 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-10-08T05:20:59.030Z,1602134459.030 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T05:21:01.454Z,1602134461.454 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-10-08T05:21:09.943Z,1602134469.943 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T05:21:12.402Z,1602134472.402 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-10-08T05:21:20.846Z,1602134480.846 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T05:21:23.309Z,1602134483.309 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-10-08T05:21:31.778Z,1602134491.778 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T05:21:34.188Z,1602134494.188 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-10-08T05:21:36.152Z,1602134496.152 [CBIT](INFO): Clearing failed state for component NAL9602 2020-10-08T05:21:36.152Z,1602134496.152 [NAL9602] No Fault, FailCount= 5 2020-10-08T05:21:36.534Z,1602134496.534 [NAL9602](INFO): Powering up NAL9602 2020-10-08T05:21:43.066Z,1602134503.066 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T05:21:45.090Z,1602134505.090 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-10-08T05:21:47.442Z,1602134507.442 [NAL9602](INFO): NAL9602 initialized 2020-10-08T05:21:54.376Z,1602134514.376 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T05:22:05.689Z,1602134525.689 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T05:22:16.597Z,1602134536.597 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T05:22:27.506Z,1602134547.506 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T05:22:28.350Z,1602134548.350 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 37 2020-10-08T05:22:28.350Z,1602134548.350 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-10-08T05:22:28.360Z,1602134548.360 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-10-08T05:22:28.680Z,1602134548.680 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-10-08T05:22:28.681Z,1602134548.681 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 37 2020-10-08T05:22:38.418Z,1602134558.418 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T05:22:49.726Z,1602134569.726 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T05:23:01.038Z,1602134581.038 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T05:23:05.875Z,1602134585.875 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-10-08T05:23:12.003Z,1602134592.003 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T05:23:22.449Z,1602134602.449 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T05:23:33.358Z,1602134613.358 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T05:23:42.634Z,1602134622.634 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-10-08T05:23:43.861Z,1602134623.861 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T05:23:50.298Z,1602134630.298 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2020-10-08T05:23:50.298Z,1602134630.298 [Default:CheckIn:C.Wait] Stopped 2020-10-08T05:23:50.298Z,1602134630.298 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2020-10-08T05:23:50.299Z,1602134630.299 [Default:CheckIn:D] Running Loop=1 2020-10-08T05:23:50.676Z,1602134630.676 [Default:CheckIn:D] Stopped 2020-10-08T05:23:50.676Z,1602134630.676 [Default:CheckIn:E] Running Loop=1 2020-10-08T05:23:51.083Z,1602134631.083 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 105.607275 min 2020-10-08T05:23:51.084Z,1602134631.084 [Default:CheckIn:E] Stopped 2020-10-08T05:23:51.084Z,1602134631.084 [Default:CheckIn](INFO): Completed Default:CheckIn 2020-10-08T05:23:51.084Z,1602134631.084 [Default:CheckIn] Stopped 2020-10-08T05:23:51.084Z,1602134631.084 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2020-10-08T05:23:51.084Z,1602134631.084 [Default:CheckIn](INFO): Running loop #11 2020-10-08T05:23:51.084Z,1602134631.084 [Default:CheckIn] Running Loop=11 2020-10-08T05:23:51.084Z,1602134631.084 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2020-10-08T05:23:51.085Z,1602134631.085 [Default:CheckIn:Read_GPS] Running Loop=1 2020-10-08T05:23:54.769Z,1602134634.769 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T05:24:05.684Z,1602134645.684 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T05:24:16.585Z,1602134656.585 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T05:24:27.493Z,1602134667.493 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T05:24:38.812Z,1602134678.812 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T05:24:41.224Z,1602134681.224 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-10-08T05:24:53.744Z,1602134693.744 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-10-08T05:25:29.256Z,1602134729.256 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 38 2020-10-08T05:25:29.256Z,1602134729.256 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-10-08T05:25:29.267Z,1602134729.267 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-10-08T05:25:29.683Z,1602134729.683 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-10-08T05:25:29.683Z,1602134729.683 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 38 2020-10-08T05:26:14.546Z,1602134774.546 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-10-08T05:28:16.553Z,1602134896.553 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T05:28:16.627Z,1602134896.627 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-10-08T05:28:30.103Z,1602134910.103 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 39 2020-10-08T05:28:30.103Z,1602134910.103 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-10-08T05:28:30.144Z,1602134910.144 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-10-08T05:28:30.316Z,1602134910.316 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-10-08T05:28:30.316Z,1602134910.316 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 39 2020-10-08T05:28:42.818Z,1602134922.818 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T05:28:51.265Z,1602134931.265 [Default:CheckIn:Read_GPS](INFO): Timed out from 2020-10-08T05:23:51.1Z 2020-10-08T05:28:51.265Z,1602134931.265 [Default:CheckIn:Read_GPS] Stopped 2020-10-08T05:28:51.266Z,1602134931.266 [Default:CheckIn:Read_Iridium] Running Loop=1 2020-10-08T05:28:57.027Z,1602134937.027 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-10-08T05:28:58.936Z,1602134938.936 [DataOverHttps](INFO): Sending 81 bytes from file Logs/20201008T033042/Courier0034.lzma 2020-10-08T05:28:59.938Z,1602134939.938 [DataOverHttps](INFO): Moved sent file to Logs/20201008T033042/Courier0034.lzma.bak 2020-10-08T05:28:59.938Z,1602134939.938 [DataOverHttps](INFO): SBD MOMSN=12818108 2020-10-08T05:29:08.302Z,1602134948.302 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-10-08T05:29:17.524Z,1602134957.524 [DataOverHttps](INFO): Sending 162 bytes from file Logs/20201008T033042/Express0035.lzma 2020-10-08T05:29:18.523Z,1602134958.523 [DataOverHttps](INFO): Moved sent file to Logs/20201008T033042/Express0035.lzma.bak 2020-10-08T05:29:18.523Z,1602134958.523 [DataOverHttps](INFO): SBD MOMSN=12818111 2020-10-08T05:29:19.231Z,1602134959.231 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-10-08T05:29:21.617Z,1602134961.617 [Default:CheckIn:Read_Iridium] Stopped 2020-10-08T05:29:21.617Z,1602134961.617 [Default:CheckIn:C.Wait] Running Loop=1 2020-10-08T05:29:21.617Z,1602134961.617 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2020-10-08T05:29:28.443Z,1602134968.443 [RDI_Pathfinder](ERROR): only read 2 of 4 data items 2020-10-08T05:29:30.112Z,1602134970.112 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-10-08T05:29:35.017Z,1602134975.017 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T05:29:41.016Z,1602134981.016 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-10-08T05:29:43.379Z,1602134983.379 [RDI_Pathfinder](ERROR): only read 3 of 4 data items 2020-10-08T05:29:45.864Z,1602134985.864 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T05:29:51.933Z,1602134991.933 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-10-08T05:29:56.777Z,1602134996.777 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T05:30:03.288Z,1602135003.288 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-10-08T05:30:08.120Z,1602135008.120 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T05:30:14.553Z,1602135014.553 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-10-08T05:30:18.993Z,1602135018.993 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T05:30:25.534Z,1602135025.534 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-10-08T05:30:30.049Z,1602135030.049 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T05:30:36.914Z,1602135036.914 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-10-08T05:30:40.830Z,1602135040.830 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T05:30:47.685Z,1602135047.685 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-10-08T05:30:52.126Z,1602135052.126 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T05:30:59.016Z,1602135059.016 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-10-08T05:31:03.439Z,1602135063.439 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T05:31:09.901Z,1602135069.901 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-10-08T05:31:14.357Z,1602135074.357 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T05:31:20.887Z,1602135080.887 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-10-08T05:31:24.931Z,1602135084.931 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T05:31:30.878Z,1602135090.878 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 40 2020-10-08T05:31:30.878Z,1602135090.878 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-10-08T05:31:30.889Z,1602135090.889 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-10-08T05:31:31.312Z,1602135091.312 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-10-08T05:31:31.312Z,1602135091.312 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 40 2020-10-08T05:31:36.174Z,1602135096.174 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T05:31:47.068Z,1602135107.068 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T05:31:48.622Z,1602135108.622 [NAL9602](FAULT): GPS failed to acquire within timeout. 2020-10-08T05:31:48.622Z,1602135108.622 [NAL9602] Data Fault, FailCount= 1 2020-10-08T05:31:48.622Z,1602135108.622 [NAL9602](ERROR): Data Fault 2020-10-08T05:31:48.676Z,1602135108.676 [CBIT](ERROR): Data Fault in component: NAL9602 2020-10-08T05:31:49.022Z,1602135109.022 [NAL9602](INFO): Powering down 2020-10-08T05:31:49.871Z,1602135109.871 [CBIT](INFO): Clearing failed state for component NAL9602 2020-10-08T05:31:49.871Z,1602135109.871 [NAL9602] No Fault, FailCount= 1 2020-10-08T05:31:57.623Z,1602135117.623 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T05:32:08.487Z,1602135128.487 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T05:32:18.127Z,1602135138.127 [CommandLine](IMPORTANT): got command run 2020-10-08T05:32:18.127Z,1602135138.127 [CommandLine](FAULT): Incomplete syntax. Try: help run 2020-10-08T05:32:19.396Z,1602135139.396 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T05:32:19.399Z,1602135139.399 [NAL9602](INFO): Powering up NAL9602 2020-10-08T05:32:21.674Z,1602135141.674 [CommandLine](IMPORTANT): got command run ./Missions/test.xml 2020-10-08T05:32:21.675Z,1602135141.675 [MissionManager](INFO): Loading Mission: ./Missions/test.xml 2020-10-08T05:32:21.692Z,1602135141.692 [MissionManager](DEBUG): 2020-10-08T05:32:21.694Z,1602135141.694 [CommandLine](IMPORTANT): Running ./Missions/test.xml 2020-10-08T05:32:21.770Z,1602135141.770 [Default] Stopped 2020-10-08T05:32:21.770Z,1602135141.770 [Default](DEBUG): Aggregate::uninitialize Default 2020-10-08T05:32:21.770Z,1602135141.770 [Default:B.GoToSurface] Stopped 2020-10-08T05:32:21.770Z,1602135141.770 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2020-10-08T05:32:21.770Z,1602135141.770 [Default:CheckIn] Stopped 2020-10-08T05:32:21.770Z,1602135141.770 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2020-10-08T05:32:21.770Z,1602135141.770 [Default:CheckIn:C.Wait] Stopped 2020-10-08T05:32:21.770Z,1602135141.770 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2020-10-08T05:32:21.770Z,1602135141.770 [MissionManager](IMPORTANT): Started mission test 2020-10-08T05:32:21.770Z,1602135141.770 [test] Running Loop=1 2020-10-08T05:32:21.771Z,1602135141.771 [test](DEBUG): Aggregate::initialize test 2020-10-08T05:32:21.771Z,1602135141.771 [test:A] Running Loop=1 2020-10-08T05:32:21.771Z,1602135141.771 [test:B] Running Loop=1 2020-10-08T05:32:21.771Z,1602135141.771 [test:B] Running Loop=1 2020-10-08T05:32:21.771Z,1602135141.771 [test:B](DEBUG): Initialize ReadDataComponent to sense WetLabsUBAT.enableBroadcast 2020-10-08T05:32:21.771Z,1602135141.771 [test:A] Running Loop=1 2020-10-08T05:32:21.772Z,1602135141.772 [test:A](DEBUG): Initialize ReadDataComponent to sense WetLabsUBAT.biolum_potential 2020-10-08T05:32:21.981Z,1602135141.981 [WetLabsUBAT](INFO): Activating messaging. 2020-10-08T05:32:22.386Z,1602135142.386 [WetLabsUBAT](INFO): Powering up 2020-10-08T05:32:30.356Z,1602135150.356 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T05:32:30.378Z,1602135150.378 [NAL9602](INFO): NAL9602 initialized 2020-10-08T05:32:41.613Z,1602135161.613 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T05:32:52.521Z,1602135172.521 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T05:32:53.715Z,1602135173.715 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-10-08T05:32:54.078Z,1602135174.078 [BPC1](INFO): Calculating totals. Valid battery stick count: 40. Valid reserve battery stick count: 4. 2020-10-08T05:32:54.080Z,1602135174.080 [BPC1](ERROR): Failed to receive data from all sticks prior to timeout. Will not retry this scan cycle. 2020-10-08T05:33:02.070Z,1602135182.070 [WetLabsUBAT](FAULT): Failed to acquire valid data within specified timeout. 2020-10-08T05:33:02.070Z,1602135182.070 [WetLabsUBAT] Communications Fault, FailCount= 1 2020-10-08T05:33:02.070Z,1602135182.070 [WetLabsUBAT](ERROR): Communications Fault 2020-10-08T05:33:02.193Z,1602135182.193 [CBIT](ERROR): Communications Fault in component: WetLabsUBAT 2020-10-08T05:33:02.569Z,1602135182.569 [WetLabsUBAT](INFO): Powering down 2020-10-08T05:33:03.444Z,1602135183.444 [CBIT](INFO): Clearing failed state for component WetLabsUBAT 2020-10-08T05:33:03.444Z,1602135183.444 [WetLabsUBAT] No Fault, FailCount= 1 2020-10-08T05:33:03.782Z,1602135183.782 [WetLabsUBAT](INFO): Powering up 2020-10-08T05:33:43.486Z,1602135223.486 [WetLabsUBAT](FAULT): Failed to acquire valid data within specified timeout. 2020-10-08T05:33:43.486Z,1602135223.486 [WetLabsUBAT] Communications Fault, FailCount= 1 2020-10-08T05:33:43.486Z,1602135223.486 [WetLabsUBAT](ERROR): Communications Fault 2020-10-08T05:33:43.810Z,1602135223.810 [CBIT](ERROR): Communications Fault in component: WetLabsUBAT 2020-10-08T05:33:43.985Z,1602135223.985 [WetLabsUBAT](INFO): Powering down 2020-10-08T05:33:45.027Z,1602135225.027 [CBIT](INFO): Clearing failed state for component WetLabsUBAT 2020-10-08T05:33:45.027Z,1602135225.027 [WetLabsUBAT] No Fault, FailCount= 1 2020-10-08T05:33:45.201Z,1602135225.201 [WetLabsUBAT](INFO): Powering up 2020-10-08T05:33:56.759Z,1602135236.759 [CommandLine](IMPORTANT): got command stop 2020-10-08T05:33:56.759Z,1602135236.759 [CommandLine](IMPORTANT): Scheduling is paused 2020-10-08T05:33:56.759Z,1602135236.759 [Supervisor](INFO): Stop Mission called by CommandLine::commandStop 2020-10-08T05:33:57.123Z,1602135237.123 [MissionManager](INFO): MissionManager is completed. 2020-10-08T05:33:57.123Z,1602135237.123 [MissionManager](INFO): Uninitializing Mission test 2020-10-08T05:33:57.124Z,1602135237.124 [test] Stopped 2020-10-08T05:33:57.124Z,1602135237.124 [test](DEBUG): Aggregate::uninitialize test 2020-10-08T05:33:57.124Z,1602135237.124 [test:A] Stopped 2020-10-08T05:33:57.124Z,1602135237.124 [test:B] Stopped 2020-10-08T05:33:57.420Z,1602135237.420 [WetLabsUBAT](INFO): Deactivating messaging. 2020-10-08T05:33:57.517Z,1602135237.517 [WetLabsUBAT](INFO): Powering down 2020-10-08T05:33:57.520Z,1602135237.520 [MissionManager](IMPORTANT): Started mission Default 2020-10-08T05:33:57.520Z,1602135237.520 [Default] Running Loop=1 2020-10-08T05:33:57.520Z,1602135237.520 [Default](DEBUG): Aggregate::initialize Default 2020-10-08T05:33:57.520Z,1602135237.520 [Default:B.GoToSurface] Running Loop=1 2020-10-08T05:33:57.520Z,1602135237.520 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2020-10-08T05:33:57.521Z,1602135237.521 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2020-10-08T05:33:57.521Z,1602135237.521 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2020-10-08T05:33:57.521Z,1602135237.521 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2020-10-08T05:33:57.521Z,1602135237.521 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2020-10-08T05:33:57.522Z,1602135237.522 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2020-10-08T05:33:57.522Z,1602135237.522 [Default:A.Wait] Running Loop=1 2020-10-08T05:33:57.522Z,1602135237.522 [Default:A.Wait](DEBUG): Initialize Wait Component. 2020-10-08T05:34:10.851Z,1602135250.851 [Default:A.Wait](INFO): Done Waiting. 2020-10-08T05:34:10.851Z,1602135250.851 [Default:A.Wait] Stopped 2020-10-08T05:34:10.852Z,1602135250.852 [Default:A.Wait](DEBUG): Uninitialize Wait Component. 2020-10-08T05:34:11.250Z,1602135251.250 [Default:CheckIn] Running Loop=1 2020-10-08T05:34:11.250Z,1602135251.250 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2020-10-08T05:34:11.250Z,1602135251.250 [Default:CheckIn:Read_GPS] Running Loop=1 2020-10-08T05:34:31.847Z,1602135271.847 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 41 2020-10-08T05:34:31.847Z,1602135271.847 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-10-08T05:34:31.858Z,1602135271.858 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-10-08T05:34:32.275Z,1602135272.275 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-10-08T05:34:32.276Z,1602135272.276 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 41 2020-10-08T05:37:32.842Z,1602135452.842 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 42 2020-10-08T05:37:32.842Z,1602135452.842 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-10-08T05:37:32.880Z,1602135452.880 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-10-08T05:37:33.251Z,1602135453.251 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-10-08T05:37:33.251Z,1602135453.251 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 42 2020-10-08T05:38:03.675Z,1602135483.675 [CommandLine](IMPORTANT): got command run ./Missions/test.xml 2020-10-08T05:38:03.676Z,1602135483.676 [MissionManager](INFO): Loading Mission: ./Missions/test.xml 2020-10-08T05:38:03.686Z,1602135483.686 [MissionManager](DEBUG): 2020-10-08T05:38:03.687Z,1602135483.687 [CommandLine](IMPORTANT): Running ./Missions/test.xml 2020-10-08T05:38:03.958Z,1602135483.958 [Default] Stopped 2020-10-08T05:38:03.958Z,1602135483.958 [Default](DEBUG): Aggregate::uninitialize Default 2020-10-08T05:38:03.958Z,1602135483.958 [Default:B.GoToSurface] Stopped 2020-10-08T05:38:03.958Z,1602135483.958 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2020-10-08T05:38:03.958Z,1602135483.958 [Default:CheckIn] Stopped 2020-10-08T05:38:03.958Z,1602135483.958 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2020-10-08T05:38:03.958Z,1602135483.958 [Default:CheckIn:Read_GPS] Stopped 2020-10-08T05:38:03.958Z,1602135483.958 [MissionManager](IMPORTANT): Started mission test 2020-10-08T05:38:03.958Z,1602135483.958 [test] Running Loop=1 2020-10-08T05:38:03.959Z,1602135483.959 [test](DEBUG): Aggregate::initialize test 2020-10-08T05:38:03.959Z,1602135483.959 [test:A] Running Loop=1 2020-10-08T05:38:03.959Z,1602135483.959 [test:B] Running Loop=1 2020-10-08T05:38:03.959Z,1602135483.959 [test:B] Running Loop=1 2020-10-08T05:38:03.959Z,1602135483.959 [test:B](DEBUG): Initialize ReadDataComponent to sense WetLabsUBAT.enableBroadcast 2020-10-08T05:38:03.959Z,1602135483.959 [test:A] Running Loop=1 2020-10-08T05:38:03.960Z,1602135483.960 [test:A](DEBUG): Initialize ReadDataComponent to sense WetLabsUBAT.biolum_potential 2020-10-08T05:38:04.261Z,1602135484.261 [WetLabsUBAT](INFO): Activating messaging. 2020-10-08T05:38:04.666Z,1602135484.666 [WetLabsUBAT](INFO): Powering up 2020-10-08T05:38:21.865Z,1602135501.865 [CommandLine](IMPORTANT): got command stop 2020-10-08T05:38:21.865Z,1602135501.865 [Supervisor](INFO): Stop Mission called by CommandLine::commandStop 2020-10-08T05:38:22.139Z,1602135502.139 [MissionManager](INFO): MissionManager is completed. 2020-10-08T05:38:22.139Z,1602135502.139 [MissionManager](INFO): Uninitializing Mission test 2020-10-08T05:38:22.139Z,1602135502.139 [test] Stopped 2020-10-08T05:38:22.139Z,1602135502.139 [test](DEBUG): Aggregate::uninitialize test 2020-10-08T05:38:22.139Z,1602135502.139 [test:A] Stopped 2020-10-08T05:38:22.139Z,1602135502.139 [test:B] Stopped 2020-10-08T05:38:22.389Z,1602135502.389 [WetLabsUBAT](INFO): Deactivating messaging. 2020-10-08T05:38:22.481Z,1602135502.481 [WetLabsUBAT](INFO): Powering down 2020-10-08T05:38:22.567Z,1602135502.567 [MissionManager](IMPORTANT): Started mission Default 2020-10-08T05:38:22.567Z,1602135502.567 [Default] Running Loop=1 2020-10-08T05:38:22.567Z,1602135502.567 [Default](DEBUG): Aggregate::initialize Default 2020-10-08T05:38:22.567Z,1602135502.567 [Default:B.GoToSurface] Running Loop=1 2020-10-08T05:38:22.567Z,1602135502.567 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2020-10-08T05:38:22.568Z,1602135502.568 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2020-10-08T05:38:22.568Z,1602135502.568 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2020-10-08T05:38:22.572Z,1602135502.572 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2020-10-08T05:38:22.573Z,1602135502.573 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2020-10-08T05:38:22.573Z,1602135502.573 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2020-10-08T05:38:22.574Z,1602135502.574 [Default:A.Wait] Running Loop=1 2020-10-08T05:38:22.574Z,1602135502.574 [Default:A.Wait](DEBUG): Initialize Wait Component. 2020-10-08T05:38:35.891Z,1602135515.891 [Default:A.Wait](INFO): Done Waiting. 2020-10-08T05:38:35.891Z,1602135515.891 [Default:A.Wait] Stopped 2020-10-08T05:38:35.891Z,1602135515.891 [Default:A.Wait](DEBUG): Uninitialize Wait Component. 2020-10-08T05:38:36.284Z,1602135516.284 [Default:CheckIn] Running Loop=1 2020-10-08T05:38:36.284Z,1602135516.284 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2020-10-08T05:38:36.284Z,1602135516.284 [Default:CheckIn:Read_GPS] Running Loop=1 2020-10-08T05:39:19.187Z,1602135559.187 [CommandLine](IMPORTANT): got command run ./Missions/test.xml 2020-10-08T05:39:19.187Z,1602135559.187 [MissionManager](INFO): Loading Mission: ./Missions/test.xml 2020-10-08T05:39:19.199Z,1602135559.199 [MissionManager](DEBUG): 2020-10-08T05:39:19.201Z,1602135559.201 [CommandLine](IMPORTANT): Running ./Missions/test.xml 2020-10-08T05:39:19.534Z,1602135559.534 [Default] Stopped 2020-10-08T05:39:19.534Z,1602135559.534 [Default](DEBUG): Aggregate::uninitialize Default 2020-10-08T05:39:19.535Z,1602135559.535 [Default:B.GoToSurface] Stopped 2020-10-08T05:39:19.535Z,1602135559.535 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2020-10-08T05:39:19.535Z,1602135559.535 [Default:CheckIn] Stopped 2020-10-08T05:39:19.535Z,1602135559.535 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2020-10-08T05:39:19.535Z,1602135559.535 [Default:CheckIn:Read_GPS] Stopped 2020-10-08T05:39:19.535Z,1602135559.535 [MissionManager](IMPORTANT): Started mission test 2020-10-08T05:39:19.535Z,1602135559.535 [test] Running Loop=1 2020-10-08T05:39:19.535Z,1602135559.535 [test](DEBUG): Aggregate::initialize test 2020-10-08T05:39:19.535Z,1602135559.535 [test:A] Running Loop=1 2020-10-08T05:39:19.535Z,1602135559.535 [test:B] Running Loop=1 2020-10-08T05:39:19.536Z,1602135559.536 [test:B] Running Loop=1 2020-10-08T05:39:19.540Z,1602135559.540 [test:B](DEBUG): Initialize ReadDataComponent to sense WetLabsUBAT.enableBroadcast 2020-10-08T05:39:19.540Z,1602135559.540 [test:A] Running Loop=1 2020-10-08T05:39:19.541Z,1602135559.541 [test:A](DEBUG): Initialize ReadDataComponent to sense WetLabsUBAT.biolum_potential 2020-10-08T05:39:19.757Z,1602135559.757 [WetLabsUBAT](INFO): Activating messaging. 2020-10-08T05:39:20.162Z,1602135560.162 [WetLabsUBAT](INFO): Powering up 2020-10-08T05:39:55.210Z,1602135595.210 [CommandLine](IMPORTANT): got command stop 2020-10-08T05:39:55.211Z,1602135595.211 [Supervisor](INFO): Stop Mission called by CommandLine::commandStop 2020-10-08T05:39:55.489Z,1602135595.489 [MissionManager](INFO): MissionManager is completed. 2020-10-08T05:39:55.489Z,1602135595.489 [MissionManager](INFO): Uninitializing Mission test 2020-10-08T05:39:55.489Z,1602135595.489 [test] Stopped 2020-10-08T05:39:55.489Z,1602135595.489 [test](DEBUG): Aggregate::uninitialize test 2020-10-08T05:39:55.489Z,1602135595.489 [test:A] Stopped 2020-10-08T05:39:55.489Z,1602135595.489 [test:B] Stopped 2020-10-08T05:39:55.780Z,1602135595.780 [WetLabsUBAT](INFO): Deactivating messaging. 2020-10-08T05:39:55.873Z,1602135595.873 [MissionManager](IMPORTANT): Started mission Default 2020-10-08T05:39:55.873Z,1602135595.873 [Default] Running Loop=1 2020-10-08T05:39:55.873Z,1602135595.873 [Default](DEBUG): Aggregate::initialize Default 2020-10-08T05:39:55.873Z,1602135595.873 [Default:B.GoToSurface] Running Loop=1 2020-10-08T05:39:55.873Z,1602135595.873 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2020-10-08T05:39:55.874Z,1602135595.874 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2020-10-08T05:39:55.874Z,1602135595.874 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2020-10-08T05:39:55.874Z,1602135595.874 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2020-10-08T05:39:55.874Z,1602135595.874 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2020-10-08T05:39:55.875Z,1602135595.875 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2020-10-08T05:39:55.875Z,1602135595.875 [Default:A.Wait] Running Loop=1 2020-10-08T05:39:55.875Z,1602135595.875 [Default:A.Wait](DEBUG): Initialize Wait Component. 2020-10-08T05:39:55.881Z,1602135595.881 [WetLabsUBAT](INFO): Powering down 2020-10-08T05:40:09.213Z,1602135609.213 [Default:A.Wait](INFO): Done Waiting. 2020-10-08T05:40:09.213Z,1602135609.213 [Default:A.Wait] Stopped 2020-10-08T05:40:09.213Z,1602135609.213 [Default:A.Wait](DEBUG): Uninitialize Wait Component. 2020-10-08T05:40:09.614Z,1602135609.614 [Default:CheckIn] Running Loop=1 2020-10-08T05:40:09.614Z,1602135609.614 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2020-10-08T05:40:09.614Z,1602135609.614 [Default:CheckIn:Read_GPS] Running Loop=1 2020-10-08T05:40:33.909Z,1602135633.909 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 43 2020-10-08T05:40:33.909Z,1602135633.909 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-10-08T05:40:33.933Z,1602135633.933 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-10-08T05:40:34.312Z,1602135634.312 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-10-08T05:40:34.313Z,1602135634.313 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 43 2020-10-08T05:40:36.280Z,1602135636.280 [RDI_Pathfinder](ERROR): only read 3 of 4 data items 2020-10-08T05:42:31.390Z,1602135751.390 [NAL9602](FAULT): GPS failed to acquire within timeout. 2020-10-08T05:42:31.390Z,1602135751.390 [NAL9602] Data Fault, FailCount= 2 2020-10-08T05:42:31.390Z,1602135751.390 [NAL9602](ERROR): Data Fault 2020-10-08T05:42:31.452Z,1602135751.452 [CBIT](ERROR): Data Fault in component: NAL9602 2020-10-08T05:42:31.793Z,1602135751.793 [NAL9602](INFO): Powering down 2020-10-08T05:42:32.638Z,1602135752.638 [CBIT](INFO): Clearing failed state for component NAL9602 2020-10-08T05:42:32.638Z,1602135752.638 [NAL9602] No Fault, FailCount= 2 2020-10-08T05:43:02.094Z,1602135782.094 [NAL9602](INFO): Powering up NAL9602 2020-10-08T05:43:13.007Z,1602135793.007 [NAL9602](INFO): NAL9602 initialized 2020-10-08T05:43:34.872Z,1602135814.872 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 44 2020-10-08T05:43:34.873Z,1602135814.873 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-10-08T05:43:34.883Z,1602135814.883 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-10-08T05:43:35.286Z,1602135815.286 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-10-08T05:43:35.286Z,1602135815.286 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 44 2020-10-08T05:45:09.783Z,1602135909.783 [Default:CheckIn:Read_GPS](INFO): Timed out from 2020-10-08T05:40:09.6Z 2020-10-08T05:45:09.784Z,1602135909.784 [Default:CheckIn:Read_GPS] Stopped 2020-10-08T05:45:09.785Z,1602135909.785 [Default:CheckIn:Read_Iridium] Running Loop=1 2020-10-08T05:45:17.052Z,1602135917.052 [DataOverHttps](INFO): Sending 50 bytes from file Logs/20201008T033042/Courier0037.lzma 2020-10-08T05:45:18.054Z,1602135918.054 [DataOverHttps](INFO): Moved sent file to Logs/20201008T033042/Courier0037.lzma.bak 2020-10-08T05:45:18.054Z,1602135918.054 [DataOverHttps](INFO): SBD MOMSN=12818222 2020-10-08T05:45:35.621Z,1602135935.621 [DataOverHttps](INFO): Sending 374 bytes from file Logs/20201008T033042/Express0038.lzma 2020-10-08T05:45:36.622Z,1602135936.622 [DataOverHttps](INFO): Moved sent file to Logs/20201008T033042/Express0038.lzma.bak 2020-10-08T05:45:36.622Z,1602135936.622 [DataOverHttps](INFO): SBD MOMSN=12818224 2020-10-08T05:45:39.732Z,1602135939.732 [Default:CheckIn:Read_Iridium] Stopped 2020-10-08T05:45:39.732Z,1602135939.732 [Default:CheckIn:C.Wait] Running Loop=1 2020-10-08T05:45:39.732Z,1602135939.732 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2020-10-08T05:46:35.861Z,1602135995.861 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 45 2020-10-08T05:46:35.861Z,1602135995.861 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-10-08T05:46:35.872Z,1602135995.872 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-10-08T05:46:36.297Z,1602135996.297 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-10-08T05:46:36.297Z,1602135996.297 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 45 2020-10-08T05:49:36.866Z,1602136176.866 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 46 2020-10-08T05:49:36.866Z,1602136176.866 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-10-08T05:49:36.876Z,1602136176.876 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-10-08T05:49:37.282Z,1602136177.282 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-10-08T05:49:37.282Z,1602136177.282 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 46 2020-10-08T05:50:34.653Z,1602136234.653 [RDI_Pathfinder](ERROR): only read 3 of 4 data items 2020-10-08T05:50:40.316Z,1602136240.316 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2020-10-08T05:50:40.316Z,1602136240.316 [Default:CheckIn:C.Wait] Stopped 2020-10-08T05:50:40.316Z,1602136240.316 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2020-10-08T05:50:40.317Z,1602136240.317 [Default:CheckIn:D] Running Loop=1 2020-10-08T05:50:40.715Z,1602136240.715 [Default:CheckIn:D] Stopped 2020-10-08T05:50:40.715Z,1602136240.715 [Default:CheckIn:E] Running Loop=1 2020-10-08T05:50:41.106Z,1602136241.106 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 10.747368 min 2020-10-08T05:50:41.106Z,1602136241.106 [Default:CheckIn:E] Stopped 2020-10-08T05:50:41.106Z,1602136241.106 [Default:CheckIn](INFO): Completed Default:CheckIn 2020-10-08T05:50:41.106Z,1602136241.106 [Default:CheckIn] Stopped 2020-10-08T05:50:41.106Z,1602136241.106 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2020-10-08T05:50:41.107Z,1602136241.107 [Default:CheckIn](INFO): Running loop #2 2020-10-08T05:50:41.107Z,1602136241.107 [Default:CheckIn] Running Loop=2 2020-10-08T05:50:41.107Z,1602136241.107 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2020-10-08T05:50:41.107Z,1602136241.107 [Default:CheckIn:Read_GPS] Running Loop=1 2020-10-08T05:52:37.861Z,1602136357.861 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 47 2020-10-08T05:52:37.861Z,1602136357.861 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-10-08T05:52:37.872Z,1602136357.872 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-10-08T05:52:38.281Z,1602136358.281 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-10-08T05:52:38.281Z,1602136358.281 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 47 2020-10-08T05:52:40.476Z,1602136360.476 [CommandLine](IMPORTANT): got command run ./Missions/test.xml 2020-10-08T05:52:40.477Z,1602136360.477 [MissionManager](INFO): Loading Mission: ./Missions/test.xml 2020-10-08T05:52:40.492Z,1602136360.492 [MissionManager](DEBUG): 2020-10-08T05:52:40.494Z,1602136360.494 [CommandLine](IMPORTANT): Running ./Missions/test.xml 2020-10-08T05:52:40.701Z,1602136360.701 [Default] Stopped 2020-10-08T05:52:40.702Z,1602136360.702 [Default](DEBUG): Aggregate::uninitialize Default 2020-10-08T05:52:40.702Z,1602136360.702 [Default:B.GoToSurface] Stopped 2020-10-08T05:52:40.702Z,1602136360.702 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2020-10-08T05:52:40.703Z,1602136360.703 [Default:CheckIn] Stopped 2020-10-08T05:52:40.703Z,1602136360.703 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2020-10-08T05:52:40.703Z,1602136360.703 [Default:CheckIn:Read_GPS] Stopped 2020-10-08T05:52:40.704Z,1602136360.704 [MissionManager](IMPORTANT): Started mission test 2020-10-08T05:52:40.704Z,1602136360.704 [test] Running Loop=1 2020-10-08T05:52:40.704Z,1602136360.704 [test](DEBUG): Aggregate::initialize test 2020-10-08T05:52:40.704Z,1602136360.704 [test:A] Running Loop=1 2020-10-08T05:52:40.705Z,1602136360.705 [test:B] Running Loop=1 2020-10-08T05:52:40.705Z,1602136360.705 [test:C] Running Loop=1 2020-10-08T05:52:40.705Z,1602136360.705 [test:D] Running Loop=1 2020-10-08T05:52:40.705Z,1602136360.705 [test:D] Running Loop=1 2020-10-08T05:52:40.705Z,1602136360.705 [test:D](CRITICAL): Unable to read non-existent URI:WetLabsBB2F.enableBroadcast 2020-10-08T05:52:40.705Z,1602136360.705 [test:D](CRITICAL): Unable to read non-existent data element: WetLabsBB2F.enableBroadcast 2020-10-08T05:52:40.705Z,1602136360.705 [test:C] Running Loop=1 2020-10-08T05:52:40.706Z,1602136360.706 [test:C](DEBUG): Initialize ReadDataComponent to sense WetLabsBB2FL.mass_concentration_of_chlorophyll_in_sea_water 2020-10-08T05:52:40.706Z,1602136360.706 [test:B] Running Loop=1 2020-10-08T05:52:40.706Z,1602136360.706 [test:B](DEBUG): Initialize ReadDataComponent to sense WetLabsUBAT.enableBroadcast 2020-10-08T05:52:40.707Z,1602136360.707 [test:A] Running Loop=1 2020-10-08T05:52:40.707Z,1602136360.707 [test:A](DEBUG): Initialize ReadDataComponent to sense WetLabsUBAT.biolum_potential 2020-10-08T05:52:40.713Z,1602136360.713 [CommandLine](FAULT): Scheduling is paused 2020-10-08T05:52:40.714Z,1602136360.714 [CBIT](INFO): Critical error at 20201008T055240 2020-10-08T05:52:40.714Z,1602136360.714 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals 2020-10-08T05:52:40.826Z,1602136360.826 [WetLabsBB2FL](INFO): Powering up 2020-10-08T05:52:40.961Z,1602136360.961 [WetLabsUBAT](INFO): Activating messaging. 2020-10-08T05:52:41.087Z,1602136361.087 [test:D](CRITICAL): Unable to read non-existent URI:WetLabsBB2F.enableBroadcast 2020-10-08T05:52:41.087Z,1602136361.087 [test:D](CRITICAL): Unable to read non-existent data element: WetLabsBB2F.enableBroadcast 2020-10-08T05:52:41.087Z,1602136361.087 [MissionManager](INFO): MissionManager is completed. 2020-10-08T05:52:41.087Z,1602136361.087 [MissionManager](INFO): Uninitializing Mission test 2020-10-08T05:52:41.087Z,1602136361.087 [test] Stopped 2020-10-08T05:52:41.087Z,1602136361.087 [test](DEBUG): Aggregate::uninitialize test 2020-10-08T05:52:41.088Z,1602136361.088 [test:A] Stopped 2020-10-08T05:52:41.088Z,1602136361.088 [test:B] Stopped 2020-10-08T05:52:41.088Z,1602136361.088 [test:C] Stopped 2020-10-08T05:52:41.088Z,1602136361.088 [test:D] Stopped 2020-10-08T05:52:41.111Z,1602136361.111 [CBIT](INFO): Critical error at 20201008T055241 2020-10-08T05:52:41.366Z,1602136361.366 [WetLabsUBAT](INFO): Deactivating messaging. 2020-10-08T05:52:41.370Z,1602136361.370 [WetLabsUBAT](INFO): Powering up 2020-10-08T05:52:41.496Z,1602136361.496 [MissionManager](IMPORTANT): Started mission Default 2020-10-08T05:52:41.496Z,1602136361.496 [Default] Running Loop=1 2020-10-08T05:52:41.496Z,1602136361.496 [Default](DEBUG): Aggregate::initialize Default 2020-10-08T05:52:41.497Z,1602136361.497 [Default:B.GoToSurface] Running Loop=1 2020-10-08T05:52:41.497Z,1602136361.497 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2020-10-08T05:52:41.497Z,1602136361.497 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2020-10-08T05:52:41.497Z,1602136361.497 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2020-10-08T05:52:41.497Z,1602136361.497 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2020-10-08T05:52:41.498Z,1602136361.498 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2020-10-08T05:52:41.498Z,1602136361.498 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2020-10-08T05:52:41.499Z,1602136361.499 [Default:A.Wait] Running Loop=1 2020-10-08T05:52:41.499Z,1602136361.499 [Default:A.Wait](DEBUG): Initialize Wait Component. 2020-10-08T05:52:43.441Z,1602136363.441 [WetLabsBB2FL](INFO): Powering down 2020-10-08T05:52:50.633Z,1602136370.633 [WetLabsUBAT](INFO): Powering down 2020-10-08T05:52:54.834Z,1602136374.834 [Default:A.Wait](INFO): Done Waiting. 2020-10-08T05:52:54.834Z,1602136374.834 [Default:A.Wait] Stopped 2020-10-08T05:52:54.834Z,1602136374.834 [Default:A.Wait](DEBUG): Uninitialize Wait Component. 2020-10-08T05:52:55.254Z,1602136375.254 [Default:CheckIn] Running Loop=1 2020-10-08T05:52:55.254Z,1602136375.254 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2020-10-08T05:52:55.254Z,1602136375.254 [Default:CheckIn:Read_GPS] Running Loop=1 2020-10-08T05:53:15.010Z,1602136395.010 [NAL9602](FAULT): GPS failed to acquire within timeout. 2020-10-08T05:53:15.010Z,1602136395.010 [NAL9602] Data Fault, FailCount= 3 2020-10-08T05:53:15.010Z,1602136395.010 [NAL9602](ERROR): Data Fault 2020-10-08T05:53:15.028Z,1602136395.028 [CBIT](ERROR): Data Fault in component: NAL9602 2020-10-08T05:53:15.401Z,1602136395.401 [NAL9602](INFO): Powering down 2020-10-08T05:53:16.240Z,1602136396.240 [CBIT](INFO): Clearing failed state for component NAL9602 2020-10-08T05:53:16.240Z,1602136396.240 [NAL9602] No Fault, FailCount= 3 2020-10-08T05:53:23.294Z,1602136403.294 [CommandLine](IMPORTANT): got command run ./Missions/test.xml 2020-10-08T05:53:23.294Z,1602136403.294 [MissionManager](INFO): Loading Mission: ./Missions/test.xml 2020-10-08T05:53:23.359Z,1602136403.359 [MissionManager](DEBUG): 2020-10-08T05:53:23.412Z,1602136403.412 [CommandLine](IMPORTANT): Running ./Missions/test.xml 2020-10-08T05:53:23.542Z,1602136403.542 [Default] Stopped 2020-10-08T05:53:23.542Z,1602136403.542 [Default](DEBUG): Aggregate::uninitialize Default 2020-10-08T05:53:23.542Z,1602136403.542 [Default:B.GoToSurface] Stopped 2020-10-08T05:53:23.542Z,1602136403.542 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2020-10-08T05:53:23.543Z,1602136403.543 [Default:CheckIn] Stopped 2020-10-08T05:53:23.543Z,1602136403.543 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2020-10-08T05:53:23.543Z,1602136403.543 [Default:CheckIn:Read_GPS] Stopped 2020-10-08T05:53:23.543Z,1602136403.543 [MissionManager](IMPORTANT): Started mission test 2020-10-08T05:53:23.543Z,1602136403.543 [test] Running Loop=1 2020-10-08T05:53:23.543Z,1602136403.543 [test](DEBUG): Aggregate::initialize test 2020-10-08T05:53:23.543Z,1602136403.543 [test:A] Running Loop=1 2020-10-08T05:53:23.543Z,1602136403.543 [test:B] Running Loop=1 2020-10-08T05:53:23.543Z,1602136403.543 [test:C] Running Loop=1 2020-10-08T05:53:23.543Z,1602136403.543 [test:D] Running Loop=1 2020-10-08T05:53:23.544Z,1602136403.544 [test:D] Running Loop=1 2020-10-08T05:53:23.544Z,1602136403.544 [test:D](DEBUG): Initialize ReadDataComponent to sense WetLabsBB2FL.enableBroadcast 2020-10-08T05:53:23.545Z,1602136403.545 [test:C] Running Loop=1 2020-10-08T05:53:23.545Z,1602136403.545 [test:C](DEBUG): Initialize ReadDataComponent to sense WetLabsBB2FL.mass_concentration_of_chlorophyll_in_sea_water 2020-10-08T05:53:23.545Z,1602136403.545 [test:B] Running Loop=1 2020-10-08T05:53:23.546Z,1602136403.546 [test:B](DEBUG): Initialize ReadDataComponent to sense WetLabsUBAT.enableBroadcast 2020-10-08T05:53:23.546Z,1602136403.546 [test:A] Running Loop=1 2020-10-08T05:53:23.546Z,1602136403.546 [test:A](DEBUG): Initialize ReadDataComponent to sense WetLabsUBAT.biolum_potential 2020-10-08T05:53:23.665Z,1602136403.665 [WetLabsUBAT](INFO): Activating messaging. 2020-10-08T05:53:23.677Z,1602136403.677 [WetLabsBB2FL](INFO): Activating messaging. 2020-10-08T05:53:23.685Z,1602136403.685 [WetLabsBB2FL](INFO): Powering up 2020-10-08T05:53:24.070Z,1602136404.070 [WetLabsUBAT](INFO): Powering up 2020-10-08T05:53:45.730Z,1602136425.730 [NAL9602](INFO): Powering up NAL9602 2020-10-08T05:53:56.634Z,1602136436.634 [NAL9602](INFO): NAL9602 initialized 2020-10-08T05:54:03.722Z,1602136443.722 [WetLabsUBAT](FAULT): Failed to acquire valid data within specified timeout. 2020-10-08T05:54:03.722Z,1602136443.722 [WetLabsUBAT] Communications Fault, FailCount= 1 2020-10-08T05:54:03.722Z,1602136443.722 [WetLabsUBAT](ERROR): Communications Fault 2020-10-08T05:54:03.961Z,1602136443.961 [CBIT](ERROR): Communications Fault in component: WetLabsUBAT 2020-10-08T05:54:04.221Z,1602136444.221 [WetLabsUBAT](INFO): Powering down 2020-10-08T05:54:05.162Z,1602136445.162 [CBIT](INFO): Clearing failed state for component WetLabsUBAT 2020-10-08T05:54:05.162Z,1602136445.162 [WetLabsUBAT] No Fault, FailCount= 1 2020-10-08T05:54:05.434Z,1602136445.434 [WetLabsUBAT](INFO): Powering up 2020-10-08T05:54:45.082Z,1602136485.082 [WetLabsUBAT](FAULT): Failed to acquire valid data within specified timeout. 2020-10-08T05:54:45.082Z,1602136485.082 [WetLabsUBAT] Communications Fault, FailCount= 1 2020-10-08T05:54:45.082Z,1602136485.082 [WetLabsUBAT](ERROR): Communications Fault 2020-10-08T05:54:45.162Z,1602136485.162 [CBIT](ERROR): Communications Fault in component: WetLabsUBAT 2020-10-08T05:54:45.577Z,1602136485.577 [WetLabsUBAT](INFO): Powering down 2020-10-08T05:54:46.395Z,1602136486.395 [CBIT](INFO): Clearing failed state for component WetLabsUBAT 2020-10-08T05:54:46.395Z,1602136486.395 [WetLabsUBAT] No Fault, FailCount= 1 2020-10-08T05:54:46.798Z,1602136486.798 [WetLabsUBAT](INFO): Powering up 2020-10-08T05:55:26.462Z,1602136526.462 [WetLabsUBAT](FAULT): Failed to acquire valid data within specified timeout. 2020-10-08T05:55:26.462Z,1602136526.462 [WetLabsUBAT] Communications Fault, FailCount= 1 2020-10-08T05:55:26.462Z,1602136526.462 [WetLabsUBAT](ERROR): Communications Fault 2020-10-08T05:55:26.767Z,1602136526.767 [CBIT](ERROR): Communications Fault in component: WetLabsUBAT 2020-10-08T05:55:26.961Z,1602136526.961 [WetLabsUBAT](INFO): Powering down 2020-10-08T05:55:27.963Z,1602136527.963 [CBIT](INFO): Clearing failed state for component WetLabsUBAT 2020-10-08T05:55:27.963Z,1602136527.963 [WetLabsUBAT] No Fault, FailCount= 1 2020-10-08T05:55:28.175Z,1602136528.175 [WetLabsUBAT](INFO): Powering up 2020-10-08T05:55:33.051Z,1602136533.051 [CommandLine](IMPORTANT): got command stop 2020-10-08T05:55:33.051Z,1602136533.051 [CommandLine](IMPORTANT): Scheduling is paused 2020-10-08T05:55:33.051Z,1602136533.051 [Supervisor](INFO): Stop Mission called by CommandLine::commandStop 2020-10-08T05:55:33.250Z,1602136533.250 [MissionManager](INFO): MissionManager is completed. 2020-10-08T05:55:33.250Z,1602136533.250 [MissionManager](INFO): Uninitializing Mission test 2020-10-08T05:55:33.250Z,1602136533.250 [test] Stopped 2020-10-08T05:55:33.251Z,1602136533.251 [test](DEBUG): Aggregate::uninitialize test 2020-10-08T05:55:33.251Z,1602136533.251 [test:A] Stopped 2020-10-08T05:55:33.251Z,1602136533.251 [test:B] Stopped 2020-10-08T05:55:33.251Z,1602136533.251 [test:C] Stopped 2020-10-08T05:55:33.251Z,1602136533.251 [test:D] Stopped 2020-10-08T05:55:33.281Z,1602136533.281 [WetLabsBB2FL](INFO): Deactivating messaging. 2020-10-08T05:55:33.377Z,1602136533.377 [WetLabsBB2FL](INFO): Powering down 2020-10-08T05:55:33.425Z,1602136533.425 [WetLabsUBAT](INFO): Deactivating messaging. 2020-10-08T05:55:33.635Z,1602136533.635 [MissionManager](IMPORTANT): Started mission Default 2020-10-08T05:55:33.635Z,1602136533.635 [Default] Running Loop=1 2020-10-08T05:55:33.636Z,1602136533.636 [Default](DEBUG): Aggregate::initialize Default 2020-10-08T05:55:33.636Z,1602136533.636 [Default:B.GoToSurface] Running Loop=1 2020-10-08T05:55:33.636Z,1602136533.636 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2020-10-08T05:55:33.636Z,1602136533.636 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2020-10-08T05:55:33.641Z,1602136533.641 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2020-10-08T05:55:33.641Z,1602136533.641 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2020-10-08T05:55:33.641Z,1602136533.641 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2020-10-08T05:55:33.642Z,1602136533.642 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2020-10-08T05:55:33.642Z,1602136533.642 [Default:A.Wait] Running Loop=1 2020-10-08T05:55:33.642Z,1602136533.642 [Default:A.Wait](DEBUG): Initialize Wait Component. 2020-10-08T05:55:37.440Z,1602136537.440 [WetLabsUBAT](INFO): Powering down 2020-10-08T05:55:38.884Z,1602136538.884 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 48 2020-10-08T05:55:38.884Z,1602136538.884 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-10-08T05:55:38.895Z,1602136538.895 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-10-08T05:55:39.302Z,1602136539.302 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-10-08T05:55:39.302Z,1602136539.302 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 48 2020-10-08T05:55:46.942Z,1602136546.942 [Default:A.Wait](INFO): Done Waiting. 2020-10-08T05:55:46.942Z,1602136546.942 [Default:A.Wait] Stopped 2020-10-08T05:55:46.942Z,1602136546.942 [Default:A.Wait](DEBUG): Uninitialize Wait Component. 2020-10-08T05:55:47.346Z,1602136547.346 [Default:CheckIn] Running Loop=1 2020-10-08T05:55:47.346Z,1602136547.346 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2020-10-08T05:55:47.346Z,1602136547.346 [Default:CheckIn:Read_GPS] Running Loop=1 2020-10-08T05:58:39.870Z,1602136719.870 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 49 2020-10-08T05:58:39.870Z,1602136719.870 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-10-08T05:58:39.880Z,1602136719.880 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-10-08T05:58:40.307Z,1602136720.307 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-10-08T05:58:40.307Z,1602136720.307 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 49 2020-10-08T05:58:45.900Z,1602136725.900 [CommandLine](IMPORTANT): got command stop 2020-10-08T06:00:03.919Z,1602136803.919 [CommandLine](IMPORTANT): got command run ./Missions/test.xml 2020-10-08T06:00:03.919Z,1602136803.919 [MissionManager](INFO): Loading Mission: ./Missions/test.xml 2020-10-08T06:00:03.933Z,1602136803.933 [MissionManager](DEBUG): 2020-10-08T06:00:03.935Z,1602136803.935 [CommandLine](IMPORTANT): Running ./Missions/test.xml 2020-10-08T06:00:03.942Z,1602136803.942 [Default] Stopped 2020-10-08T06:00:03.942Z,1602136803.942 [Default](DEBUG): Aggregate::uninitialize Default 2020-10-08T06:00:03.942Z,1602136803.942 [Default:B.GoToSurface] Stopped 2020-10-08T06:00:03.942Z,1602136803.942 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2020-10-08T06:00:03.942Z,1602136803.942 [Default:CheckIn] Stopped 2020-10-08T06:00:03.942Z,1602136803.942 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2020-10-08T06:00:03.942Z,1602136803.942 [Default:CheckIn:Read_GPS] Stopped 2020-10-08T06:00:03.943Z,1602136803.943 [MissionManager](IMPORTANT): Started mission test 2020-10-08T06:00:03.943Z,1602136803.943 [test] Running Loop=1 2020-10-08T06:00:03.943Z,1602136803.943 [test](DEBUG): Aggregate::initialize test 2020-10-08T06:00:03.943Z,1602136803.943 [test:A] Running Loop=1 2020-10-08T06:00:03.943Z,1602136803.943 [test:B] Running Loop=1 2020-10-08T06:00:03.943Z,1602136803.943 [test:C] Running Loop=1 2020-10-08T06:00:03.943Z,1602136803.943 [test:D] Running Loop=1 2020-10-08T06:00:03.943Z,1602136803.943 [test:D] Running Loop=1 2020-10-08T06:00:03.947Z,1602136803.947 [test:D](DEBUG): Initialize ReadDataComponent to sense WetLabsBB2FL.enableBroadcast 2020-10-08T06:00:03.947Z,1602136803.947 [test:C] Running Loop=1 2020-10-08T06:00:03.948Z,1602136803.948 [test:C](DEBUG): Initialize ReadDataComponent to sense WetLabsBB2FL.mass_concentration_of_chlorophyll_in_sea_water 2020-10-08T06:00:03.948Z,1602136803.948 [test:B] Running Loop=1 2020-10-08T06:00:03.949Z,1602136803.949 [test:B](DEBUG): Initialize ReadDataComponent to sense WetLabsUBAT.enableBroadcast 2020-10-08T06:00:03.949Z,1602136803.949 [test:A] Running Loop=1 2020-10-08T06:00:03.949Z,1602136803.949 [test:A](DEBUG): Initialize ReadDataComponent to sense WetLabsUBAT.biolum_potential 2020-10-08T06:00:03.993Z,1602136803.993 [WetLabsBB2FL](INFO): Activating messaging. 2020-10-08T06:00:03.997Z,1602136803.997 [WetLabsUBAT](INFO): Activating messaging. 2020-10-08T06:00:04.006Z,1602136804.006 [WetLabsBB2FL](INFO): Powering up 2020-10-08T06:00:04.402Z,1602136804.402 [WetLabsUBAT](INFO): Powering up 2020-10-08T06:00:19.543Z,1602136819.543 [CommandLine](IMPORTANT): got command stop 2020-10-08T06:00:19.543Z,1602136819.543 [Supervisor](INFO): Stop Mission called by CommandLine::commandStop 2020-10-08T06:00:19.679Z,1602136819.679 [MissionManager](INFO): MissionManager is completed. 2020-10-08T06:00:19.679Z,1602136819.679 [MissionManager](INFO): Uninitializing Mission test 2020-10-08T06:00:19.679Z,1602136819.679 [test] Stopped 2020-10-08T06:00:19.679Z,1602136819.679 [test](DEBUG): Aggregate::uninitialize test 2020-10-08T06:00:19.679Z,1602136819.679 [test:A] Stopped 2020-10-08T06:00:19.679Z,1602136819.679 [test:B] Stopped 2020-10-08T06:00:19.680Z,1602136819.680 [test:C] Stopped 2020-10-08T06:00:19.680Z,1602136819.680 [test:D] Stopped 2020-10-08T06:00:19.691Z,1602136819.691 [WetLabsUBAT](INFO): Deactivating messaging. 2020-10-08T06:00:19.785Z,1602136819.785 [WetLabsUBAT](INFO): Powering down 2020-10-08T06:00:20.046Z,1602136820.046 [MissionManager](IMPORTANT): Started mission Default 2020-10-08T06:00:20.047Z,1602136820.047 [Default] Running Loop=1 2020-10-08T06:00:20.047Z,1602136820.047 [Default](DEBUG): Aggregate::initialize Default 2020-10-08T06:00:20.047Z,1602136820.047 [Default:B.GoToSurface] Running Loop=1 2020-10-08T06:00:20.047Z,1602136820.047 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2020-10-08T06:00:20.047Z,1602136820.047 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2020-10-08T06:00:20.048Z,1602136820.048 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2020-10-08T06:00:20.048Z,1602136820.048 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2020-10-08T06:00:20.049Z,1602136820.049 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2020-10-08T06:00:20.049Z,1602136820.049 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2020-10-08T06:00:20.049Z,1602136820.049 [Default:A.Wait] Running Loop=1 2020-10-08T06:00:20.050Z,1602136820.050 [Default:A.Wait](DEBUG): Initialize Wait Component. 2020-10-08T06:00:20.121Z,1602136820.121 [WetLabsBB2FL](INFO): Deactivating messaging. 2020-10-08T06:00:20.217Z,1602136820.217 [WetLabsBB2FL](INFO): Powering down 2020-10-08T06:00:33.427Z,1602136833.427 [Default:A.Wait](INFO): Done Waiting. 2020-10-08T06:00:33.427Z,1602136833.427 [Default:A.Wait] Stopped 2020-10-08T06:00:33.427Z,1602136833.427 [Default:A.Wait](DEBUG): Uninitialize Wait Component. 2020-10-08T06:00:33.819Z,1602136833.819 [Default:CheckIn] Running Loop=1 2020-10-08T06:00:33.819Z,1602136833.819 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2020-10-08T06:00:33.819Z,1602136833.819 [Default:CheckIn:Read_GPS] Running Loop=1 2020-10-08T06:01:40.873Z,1602136900.873 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 50 2020-10-08T06:01:40.873Z,1602136900.873 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-10-08T06:01:40.884Z,1602136900.884 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-10-08T06:01:41.293Z,1602136901.293 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-10-08T06:01:41.293Z,1602136901.293 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 50 2020-10-08T06:03:59.022Z,1602137039.022 [NAL9602](FAULT): GPS failed to acquire within timeout. 2020-10-08T06:03:59.022Z,1602137039.022 [NAL9602] Data Fault, FailCount= 4 2020-10-08T06:03:59.022Z,1602137039.022 [NAL9602](ERROR): Data Fault 2020-10-08T06:03:59.051Z,1602137039.051 [CBIT](ERROR): Data Fault in component: NAL9602 2020-10-08T06:03:59.409Z,1602137039.409 [NAL9602](INFO): Powering down 2020-10-08T06:04:00.262Z,1602137040.262 [CBIT](INFO): Clearing failed state for component NAL9602 2020-10-08T06:04:00.262Z,1602137040.262 [NAL9602] No Fault, FailCount= 4 2020-10-08T06:04:29.714Z,1602137069.714 [NAL9602](INFO): Powering up NAL9602 2020-10-08T06:04:40.624Z,1602137080.624 [NAL9602](INFO): NAL9602 initialized 2020-10-08T06:04:41.856Z,1602137081.856 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 51 2020-10-08T06:04:41.856Z,1602137081.856 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-10-08T06:04:41.882Z,1602137081.882 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-10-08T06:04:42.265Z,1602137082.265 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-10-08T06:04:42.265Z,1602137082.265 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 51 2020-10-08T06:05:33.970Z,1602137133.970 [Default:CheckIn:Read_GPS](INFO): Timed out from 2020-10-08T06:00:33.8Z 2020-10-08T06:05:33.970Z,1602137133.970 [Default:CheckIn:Read_GPS] Stopped 2020-10-08T06:05:33.970Z,1602137133.970 [Default:CheckIn:Read_Iridium] Running Loop=1 2020-10-08T06:05:46.780Z,1602137146.780 [DataOverHttps](INFO): Sending 160 bytes from file Logs/20201008T033042/Courier0040.lzma 2020-10-08T06:05:47.782Z,1602137147.782 [DataOverHttps](INFO): Moved sent file to Logs/20201008T033042/Courier0040.lzma.bak 2020-10-08T06:05:47.783Z,1602137147.783 [DataOverHttps](INFO): SBD MOMSN=12818499 2020-10-08T06:06:08.489Z,1602137168.489 [DataOverHttps](INFO): Sending 550 bytes from file Logs/20201008T033042/Express0041.lzma 2020-10-08T06:06:09.490Z,1602137169.490 [DataOverHttps](INFO): Moved sent file to Logs/20201008T033042/Express0041.lzma.bak 2020-10-08T06:06:09.490Z,1602137169.490 [DataOverHttps](INFO): SBD MOMSN=12818505 2020-10-08T06:06:12.530Z,1602137172.530 [Default:CheckIn:Read_Iridium] Stopped 2020-10-08T06:06:12.530Z,1602137172.530 [Default:CheckIn:C.Wait] Running Loop=1 2020-10-08T06:06:12.531Z,1602137172.531 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2020-10-08T06:07:43.035Z,1602137263.035 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 52 2020-10-08T06:07:43.035Z,1602137263.035 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-10-08T06:07:43.045Z,1602137263.045 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-10-08T06:07:43.448Z,1602137263.448 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-10-08T06:07:43.449Z,1602137263.449 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 52 2020-10-08T06:10:44.073Z,1602137444.073 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 53 2020-10-08T06:10:44.073Z,1602137444.073 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-10-08T06:10:44.113Z,1602137444.113 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-10-08T06:10:44.460Z,1602137444.460 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-10-08T06:10:44.460Z,1602137444.460 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 53 2020-10-08T06:11:13.131Z,1602137473.131 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2020-10-08T06:11:13.131Z,1602137473.131 [Default:CheckIn:C.Wait] Stopped 2020-10-08T06:11:13.131Z,1602137473.131 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2020-10-08T06:11:13.131Z,1602137473.131 [Default:CheckIn:D] Running Loop=1 2020-10-08T06:11:13.619Z,1602137473.619 [Default:CheckIn:D] Stopped 2020-10-08T06:11:13.620Z,1602137473.620 [Default:CheckIn:E] Running Loop=1 2020-10-08T06:11:13.958Z,1602137473.958 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 10.892877 min 2020-10-08T06:11:13.958Z,1602137473.958 [Default:CheckIn:E] Stopped 2020-10-08T06:11:13.960Z,1602137473.960 [Default:CheckIn](INFO): Completed Default:CheckIn 2020-10-08T06:11:13.960Z,1602137473.960 [Default:CheckIn] Stopped 2020-10-08T06:11:13.960Z,1602137473.960 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2020-10-08T06:11:13.961Z,1602137473.961 [Default:CheckIn](INFO): Running loop #2 2020-10-08T06:11:13.961Z,1602137473.961 [Default:CheckIn] Running Loop=2 2020-10-08T06:11:13.961Z,1602137473.961 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2020-10-08T06:11:13.961Z,1602137473.961 [Default:CheckIn:Read_GPS] Running Loop=1 2020-10-08T06:13:45.030Z,1602137625.030 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 54 2020-10-08T06:13:45.030Z,1602137625.030 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-10-08T06:13:45.040Z,1602137625.040 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-10-08T06:13:45.493Z,1602137625.493 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-10-08T06:13:45.493Z,1602137625.493 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 54 2020-10-08T06:14:42.770Z,1602137682.770 [NAL9602](FAULT): GPS failed to acquire within timeout. 2020-10-08T06:14:42.770Z,1602137682.770 [NAL9602] Data Fault, FailCount= 5 2020-10-08T06:14:42.770Z,1602137682.770 [NAL9602](ERROR): Data Fault 2020-10-08T06:14:42.799Z,1602137682.799 [CBIT](ERROR): Data Fault in component: NAL9602 2020-10-08T06:14:42.800Z,1602137682.800 [CBIT](CRITICAL): Data Fault in component: NAL9602 2020-10-08T06:14:43.179Z,1602137683.179 [NAL9602](INFO): Powering down 2020-10-08T06:14:43.210Z,1602137683.210 [CommandLine](FAULT): Scheduling is paused 2020-10-08T06:14:43.210Z,1602137683.210 [CBIT](INFO): Critical error at 20201008T061442 2020-10-08T06:16:14.098Z,1602137774.098 [Default:CheckIn:Read_GPS](INFO): Timed out from 2020-10-08T06:11:13.0Z 2020-10-08T06:16:14.098Z,1602137774.098 [Default:CheckIn:Read_GPS] Stopped 2020-10-08T06:16:14.098Z,1602137774.098 [Default:CheckIn:Read_Iridium] Running Loop=1 2020-10-08T06:16:21.108Z,1602137781.108 [DataOverHttps](INFO): Sending 81 bytes from file Logs/20201008T033042/Courier0043.lzma 2020-10-08T06:16:22.110Z,1602137782.110 [DataOverHttps](INFO): Moved sent file to Logs/20201008T033042/Courier0043.lzma.bak 2020-10-08T06:16:22.110Z,1602137782.110 [DataOverHttps](INFO): SBD MOMSN=12818617 2020-10-08T06:16:39.564Z,1602137799.564 [DataOverHttps](INFO): Sending 174 bytes from file Logs/20201008T033042/Express0044.lzma 2020-10-08T06:16:40.566Z,1602137800.566 [DataOverHttps](INFO): Moved sent file to Logs/20201008T033042/Express0044.lzma.bak 2020-10-08T06:16:40.566Z,1602137800.566 [DataOverHttps](INFO): SBD MOMSN=12818620 2020-10-08T06:16:42.834Z,1602137802.834 [CBIT](INFO): Clearing failed state for component NAL9602 2020-10-08T06:16:42.834Z,1602137802.834 [NAL9602] No Fault, FailCount= 5 2020-10-08T06:16:43.162Z,1602137803.162 [NAL9602](INFO): Powering up NAL9602 2020-10-08T06:16:43.578Z,1602137803.578 [Default:CheckIn:Read_Iridium] Stopped 2020-10-08T06:16:44.754Z,1602137804.754 [Default:CheckIn:C.Wait] Running Loop=1 2020-10-08T06:16:44.755Z,1602137804.755 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2020-10-08T06:16:46.017Z,1602137806.017 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 55 2020-10-08T06:16:46.017Z,1602137806.017 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-10-08T06:16:46.031Z,1602137806.031 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-10-08T06:16:46.437Z,1602137806.437 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-10-08T06:16:46.437Z,1602137806.437 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 55 2020-10-08T06:16:54.070Z,1602137814.070 [NAL9602](INFO): NAL9602 initialized 2020-10-08T06:19:46.990Z,1602137986.990 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 56 2020-10-08T06:19:46.990Z,1602137986.990 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-10-08T06:19:47.001Z,1602137987.001 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-10-08T06:19:47.427Z,1602137987.427 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-10-08T06:19:47.427Z,1602137987.427 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 56 2020-10-08T06:19:48.321Z,1602137988.321 [CommandLine](IMPORTANT): got command quit 2020-10-08T06:19:49.330Z,1602137989.330 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2020-10-08T06:19:49.330Z,1602137989.330 [CommandLine ThreadHandler](INFO): Thread cancelled. 2020-10-08T06:19:49.484Z,1602137989.484 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2020-10-08T06:19:49.485Z,1602137989.485 [CommandLine ThreadHandler](INFO): Thread cancelled. 2020-10-08T06:19:49.485Z,1602137989.485 [CommandLine](INFO): Join timeout helper Thread ID is 6463 2020-10-08T06:19:49.486Z,1602137989.486 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2020-10-08T06:19:49.486Z,1602137989.486 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2020-10-08T06:19:49.486Z,1602137989.486 [NavChartDb](INFO): Join timeout helper Thread ID is 6464 2020-10-08T06:19:49.760Z,1602137989.760 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2020-10-08T06:19:49.761Z,1602137989.761 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2020-10-08T06:19:49.764Z,1602137989.764 [ComponentRegistry](INFO): Shutting down WetLabsUBAT ThreadHandler 2020-10-08T06:19:49.764Z,1602137989.764 [WetLabsUBAT ThreadHandler](INFO): Thread cancelled. 2020-10-08T06:19:49.765Z,1602137989.765 [WetLabsUBAT](INFO): Join timeout helper Thread ID is 6465 2020-10-08T06:19:50.156Z,1602137990.156 [WetLabsUBAT ThreadHandler](INFO): Uninitializing protected caller thread. 2020-10-08T06:19:50.157Z,1602137990.157 [WetLabsUBAT](INFO): Powering down 2020-10-08T06:19:50.157Z,1602137990.157 [WetLabsUBAT ThreadHandler](INFO): Thread cancelled. 2020-10-08T06:19:50.164Z,1602137990.164 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler 2020-10-08T06:19:50.164Z,1602137990.164 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2020-10-08T06:19:50.165Z,1602137990.165 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 6466 2020-10-08T06:19:50.405Z,1602137990.405 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread. 2020-10-08T06:19:50.405Z,1602137990.405 [WetLabsBB2FL](INFO): Powering down 2020-10-08T06:19:50.405Z,1602137990.405 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2020-10-08T06:19:50.408Z,1602137990.408 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler 2020-10-08T06:19:50.408Z,1602137990.408 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2020-10-08T06:19:50.409Z,1602137990.409 [CTD_Seabird](INFO): Join timeout helper Thread ID is 6467 2020-10-08T06:19:51.305Z,1602137991.305 [CTD_Seabird](INFO): Powering down 2020-10-08T06:19:51.316Z,1602137991.316 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread. 2020-10-08T06:19:51.317Z,1602137991.317 [CTD_Seabird](INFO): Powering down 2020-10-08T06:19:51.328Z,1602137991.328 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2020-10-08T06:19:51.343Z,1602137991.343 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2020-10-08T06:19:51.343Z,1602137991.343 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2020-10-08T06:19:51.344Z,1602137991.344 [Radio_Surface](INFO): Join timeout helper Thread ID is 6468 2020-10-08T06:19:51.545Z,1602137991.545 [Radio_Surface](INFO): Powering down 2020-10-08T06:19:51.545Z,1602137991.545 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2020-10-08T06:19:51.546Z,1602137991.546 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2020-10-08T06:19:51.565Z,1602137991.565 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler 2020-10-08T06:19:51.565Z,1602137991.565 [Onboard ThreadHandler](INFO): Thread cancelled. 2020-10-08T06:19:51.566Z,1602137991.566 [Onboard](INFO): Join timeout helper Thread ID is 6469 2020-10-08T06:19:55.700Z,1602137995.700 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread. 2020-10-08T06:19:55.701Z,1602137995.701 [Onboard ThreadHandler](INFO): Thread cancelled. 2020-10-08T06:19:55.717Z,1602137995.717 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler 2020-10-08T06:19:55.717Z,1602137995.717 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2020-10-08T06:19:55.718Z,1602137995.718 [DataOverHttps](INFO): Join timeout helper Thread ID is 6470 2020-10-08T06:19:56.393Z,1602137996.393 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread. 2020-10-08T06:19:56.394Z,1602137996.394 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2020-10-08T06:19:56.397Z,1602137996.397 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler 2020-10-08T06:19:56.397Z,1602137996.397 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2020-10-08T06:19:56.398Z,1602137996.398 [BackseatComponent](INFO): Join timeout helper Thread ID is 6471 2020-10-08T06:19:56.572Z,1602137996.572 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread. 2020-10-08T06:19:56.573Z,1602137996.573 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2020-10-08T06:19:56.577Z,1602137996.577 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2020-10-08T06:19:56.577Z,1602137996.577 [logger ThreadHandler](INFO): Thread cancelled. 2020-10-08T06:19:56.578Z,1602137996.578 [logger](INFO): Join timeout helper Thread ID is 6472 2020-10-08T06:19:56.600Z,1602137996.600 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2020-10-08T06:19:56.601Z,1602137996.601 [logger ThreadHandler](INFO): Thread cancelled. 2020-10-08T06:19:56.617Z,1602137996.617 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2020-10-08T06:19:56.617Z,1602137996.617 [CommandLine ThreadHandler](INFO): Thread cancelled. 2020-10-08T06:19:56.617Z,1602137996.617 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2020-10-08T06:19:56.617Z,1602137996.617 [controlThread ThreadHandler](INFO): Thread cancelled. 2020-10-08T06:19:56.618Z,1602137996.618 [controlThread](INFO): Join timeout helper Thread ID is 6473 2020-10-08T06:19:56.669Z,1602137996.669 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2020-10-08T06:19:56.669Z,1602137996.669 [controlThread](DEBUG): Uninitializing ControlThread 2020-10-08T06:19:56.669Z,1602137996.669 [AHRS_M2](INFO): Powering down 2020-10-08T06:19:56.741Z,1602137996.741 [NAL9602](INFO): Powering down 2020-10-08T06:19:56.812Z,1602137996.812 [RDI_Pathfinder](INFO): Powering down 2020-10-08T06:19:56.813Z,1602137996.813 [DAT](INFO): Powering down 2020-10-08T06:19:56.934Z,1602137996.934 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator. 2020-10-08T06:19:56.935Z,1602137996.935 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator. 2020-10-08T06:19:56.936Z,1602137996.936 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2020-10-08T06:19:56.937Z,1602137996.937 [MissionManager](INFO): Uninitializing Mission Default 2020-10-08T06:19:56.937Z,1602137996.937 [Default] Stopped 2020-10-08T06:19:56.937Z,1602137996.937 [Default](DEBUG): Aggregate::uninitialize Default 2020-10-08T06:19:56.937Z,1602137996.937 [Default:B.GoToSurface] Stopped 2020-10-08T06:19:56.937Z,1602137996.937 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2020-10-08T06:19:56.937Z,1602137996.937 [Default:CheckIn] Stopped 2020-10-08T06:19:56.937Z,1602137996.937 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2020-10-08T06:19:56.937Z,1602137996.937 [Default:CheckIn:C.Wait] Stopped 2020-10-08T06:19:56.937Z,1602137996.937 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2020-10-08T06:19:56.940Z,1602137996.940 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2020-10-08T06:19:56.941Z,1602137996.941 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2020-10-08T06:19:56.941Z,1602137996.941 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2020-10-08T06:19:56.941Z,1602137996.941 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2020-10-08T06:19:56.941Z,1602137996.941 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2020-10-08T06:19:56.942Z,1602137996.942 [BuoyancyServo](INFO): Powering down 2020-10-08T06:19:56.957Z,1602137996.957 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2020-10-08T06:19:56.957Z,1602137996.957 [ElevatorServo](INFO): Powering down 2020-10-08T06:19:56.957Z,1602137996.957 [MassServo](DEBUG): Uninitialize Mass Servo. 2020-10-08T06:19:56.958Z,1602137996.958 [MassServo](INFO): Powering down 2020-10-08T06:19:56.958Z,1602137996.958 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2020-10-08T06:19:56.958Z,1602137996.958 [RudderServo](INFO): Powering down 2020-10-08T06:19:56.959Z,1602137996.959 [ThrusterServo](DEBUG): Uninitialize Thruster Servo. 2020-10-08T06:19:56.959Z,1602137996.959 [ThrusterServo](INFO): Powering down 2020-10-08T06:19:56.960Z,1602137996.960 [SBIT](DEBUG): Uninitialize SBIT Component. 2020-10-08T06:19:56.961Z,1602137996.961 [IBIT](DEBUG): Uninitialize IBIT Component. 2020-10-08T06:19:56.961Z,1602137996.961 [CBIT](DEBUG): Uninitialize CBIT Component. 2020-10-08T06:19:56.961Z,1602137996.961 [CBIT](DEBUG): Powering off loads. 2020-10-08T06:19:56.972Z,1602137996.972 [CBIT](DEBUG): Disabling WDT. 2020-10-08T06:19:56.984Z,1602137996.984 [CBIT](DEBUG): Opening all GF detection circuits. 2020-10-08T06:19:56.985Z,1602137996.985 [controlThread ThreadHandler](INFO): Thread cancelled. 2020-10-08T06:19:57.044Z,1602137997.044 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2020-10-08T06:19:57.046Z,1602137997.046 [Onboard ThreadHandler](INFO): Thread cancelled. 2020-10-08T06:19:57.052Z,1602137997.052 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2020-10-08T06:19:57.095Z,1602137997.095 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2020-10-08T06:19:57.149Z,1602137997.149 [WetLabsUBAT ThreadHandler](INFO): Thread cancelled. 2020-10-08T06:19:57.150Z,1602137997.150 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2020-10-08T06:19:57.155Z,1602137997.155 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2020-10-08T06:19:57.163Z,1602137997.163 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2020-10-08T06:19:57.223Z,1602137997.223 [logger ThreadHandler](INFO): Thread cancelled.