2015-05-18T19:20:05.963Z,1431976805.963 [Supervisor](DEBUG): Initializing supervisor. 2015-05-18T19:20:05.966Z,1431976805.966 [SyncHandler](DEBUG): Created PCaller Thread at 4034C4E0 2015-05-18T19:20:05.967Z,1431976805.967 [SyncHandler](INFO): Protected caller Thread ID is 770 2015-05-18T19:20:05.967Z,1431976805.967 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2015-05-18T19:20:05.971Z,1431976805.971 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 4037C4E0 2015-05-18T19:20:05.971Z,1431976805.971 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 771 2015-05-18T19:20:05.974Z,1431976805.974 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2015-05-18T19:20:05.987Z,1431976805.987 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2015-05-18T19:20:05.991Z,1431976805.991 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 403AC4E0 2015-05-18T19:20:05.991Z,1431976805.991 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 772 2015-05-18T19:20:05.992Z,1431976805.992 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2015-05-18T19:20:05.995Z,1431976805.995 [logger ThreadHandler](DEBUG): Created PCaller Thread at 403DC4E0 2015-05-18T19:20:05.995Z,1431976805.995 [logger ThreadHandler](INFO): Protected caller Thread ID is 773 2015-05-18T19:20:05.998Z,1431976805.998 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2015-05-18T19:20:05.998Z,1431976805.998 [Supervisor](INFO): Looking for Config files in directory: Config/ 2015-05-18T19:20:06.002Z,1431976806.002 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2015-05-18T19:20:06.401Z,1431976806.401 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2015-05-18T19:20:06.402Z,1431976806.402 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2015-05-18T19:20:06.593Z,1431976806.593 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2015-05-18T19:20:06.595Z,1431976806.595 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2015-05-18T19:20:06.721Z,1431976806.721 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2015-05-18T19:20:06.722Z,1431976806.722 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2015-05-18T19:20:06.865Z,1431976806.865 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2015-05-18T19:20:06.867Z,1431976806.867 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2015-05-18T19:20:06.966Z,1431976806.966 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2015-05-18T19:20:07.150Z,1431976807.150 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2015-05-18T19:20:07.152Z,1431976807.152 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2015-05-18T19:20:07.248Z,1431976807.248 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample 2015-05-18T19:20:07.249Z,1431976807.249 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2015-05-18T19:20:07.506Z,1431976807.506 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2015-05-18T19:20:07.507Z,1431976807.507 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2015-05-18T19:20:07.922Z,1431976807.922 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2015-05-18T19:20:07.924Z,1431976807.924 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2015-05-18T19:20:08.280Z,1431976808.280 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2015-05-18T19:20:08.281Z,1431976808.281 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2015-05-18T19:20:08.881Z,1431976808.881 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2015-05-18T19:20:08.882Z,1431976808.882 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2015-05-18T19:20:09.105Z,1431976809.105 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2015-05-18T19:20:09.106Z,1431976809.106 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2015-05-18T19:20:09.230Z,1431976809.230 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2015-05-18T19:20:09.231Z,1431976809.231 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2015-05-18T19:20:09.742Z,1431976809.742 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2015-05-18T19:20:09.743Z,1431976809.743 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2015-05-18T19:20:09.870Z,1431976809.870 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2015-05-18T19:20:09.872Z,1431976809.872 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-daphne/ 2015-05-18T19:20:09.875Z,1431976809.875 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Battery.cfg 2015-05-18T19:20:10.147Z,1431976810.147 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2015-05-18T19:20:10.147Z,1431976810.147 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/BIT.cfg 2015-05-18T19:20:10.287Z,1431976810.287 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Estimation.cfg 2015-05-18T19:20:10.412Z,1431976810.412 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Control.cfg 2015-05-18T19:20:10.529Z,1431976810.529 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Servo.cfg 2015-05-18T19:20:10.640Z,1431976810.640 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Navigation.cfg 2015-05-18T19:20:10.748Z,1431976810.748 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Science.cfg 2015-05-18T19:20:10.900Z,1431976810.900 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Sensor.cfg 2015-05-18T19:20:11.076Z,1431976811.076 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Simulator.cfg 2015-05-18T19:20:11.178Z,1431976811.178 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/logger.cfg 2015-05-18T19:20:11.285Z,1431976811.285 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/secure.cfg 2015-05-18T19:20:11.393Z,1431976811.393 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/vehicle.cfg 2015-05-18T19:20:11.527Z,1431976811.527 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/workSite.cfg 2015-05-18T19:20:11.619Z,1431976811.619 [Supervisor](FAULT): Ignoring configuration overrides from Data/persisted.cfg 2015-05-18T19:20:11.623Z,1431976811.623 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2015-05-18T19:20:11.699Z,1431976811.699 [VerticalControl](DEBUG): Construct VerticalControl. 2015-05-18T19:20:11.830Z,1431976811.830 [VerticalControl] Loaded 2015-05-18T19:20:11.831Z,1431976811.831 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2015-05-18T19:20:11.831Z,1431976811.831 [HorizontalControl](DEBUG): Construct HorizontalControl. 2015-05-18T19:20:11.912Z,1431976811.912 [HorizontalControl] Loaded 2015-05-18T19:20:11.912Z,1431976811.912 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2015-05-18T19:20:11.913Z,1431976811.913 [SpeedControl](DEBUG): Construct SpeedControl. 2015-05-18T19:20:11.918Z,1431976811.918 [SpeedControl] Loaded 2015-05-18T19:20:11.919Z,1431976811.919 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2015-05-18T19:20:11.919Z,1431976811.919 [LoopControl](DEBUG): Construct LoopControl. 2015-05-18T19:20:11.920Z,1431976811.920 [LoopControl] Loaded 2015-05-18T19:20:11.920Z,1431976811.920 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2015-05-18T19:20:11.921Z,1431976811.921 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2015-05-18T19:20:11.921Z,1431976811.921 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2015-05-18T19:20:12.084Z,1431976812.084 [SBIT](DEBUG): Construct Startup Built In Test. 2015-05-18T19:20:12.096Z,1431976812.096 [SBIT] Loaded 2015-05-18T19:20:12.096Z,1431976812.096 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2015-05-18T19:20:12.097Z,1431976812.097 [IBIT](DEBUG): Construct Initiated Built In Test. 2015-05-18T19:20:12.130Z,1431976812.130 [IBIT] Loaded 2015-05-18T19:20:12.130Z,1431976812.130 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2015-05-18T19:20:12.133Z,1431976812.133 [CBIT](DEBUG): Construct Continuous Built In Test. 2015-05-18T19:20:12.287Z,1431976812.287 [CBIT] Loaded 2015-05-18T19:20:12.287Z,1431976812.287 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2015-05-18T19:20:12.288Z,1431976812.288 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2015-05-18T19:20:12.288Z,1431976812.288 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2015-05-18T19:20:12.321Z,1431976812.321 [DepthRateCalculator] Loaded 2015-05-18T19:20:12.321Z,1431976812.321 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2015-05-18T19:20:12.327Z,1431976812.327 [PitchRateCalculator] Loaded 2015-05-18T19:20:12.327Z,1431976812.327 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2015-05-18T19:20:12.343Z,1431976812.343 [SpeedCalculator] Loaded 2015-05-18T19:20:12.343Z,1431976812.343 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2015-05-18T19:20:12.364Z,1431976812.364 [TempGradientCalculator] Loaded 2015-05-18T19:20:12.364Z,1431976812.364 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread. 2015-05-18T19:20:12.369Z,1431976812.369 [YawRateCalculator] Loaded 2015-05-18T19:20:12.370Z,1431976812.370 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2015-05-18T19:20:12.370Z,1431976812.370 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2015-05-18T19:20:12.371Z,1431976812.371 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2015-05-18T19:20:16.880Z,1431976816.880 [HFRadarCompactModelForecaster] Loaded 2015-05-18T19:20:16.880Z,1431976816.880 [ComponentRegistry](DEBUG): SyncComponent "HFRadarCompactModelForecaster" handled in the control thread. 2015-05-18T19:20:18.077Z,1431976818.077 [HFRCMSpaceInterpolator] Loaded 2015-05-18T19:20:18.077Z,1431976818.077 [ComponentRegistry](DEBUG): SyncComponent "HFRCMSpaceInterpolator" handled in the control thread. 2015-05-18T19:20:18.079Z,1431976818.079 [HFRCMTimeInterpolator] Loaded 2015-05-18T19:20:18.080Z,1431976818.080 [ComponentRegistry](DEBUG): SyncComponent "HFRCMTimeInterpolator" handled in the control thread. 2015-05-18T19:20:19.262Z,1431976819.262 [HFRCMReconstructedInterpolator] Loaded 2015-05-18T19:20:19.262Z,1431976819.262 [ComponentRegistry](DEBUG): SyncComponent "HFRCMReconstructedInterpolator" handled in the control thread. 2015-05-18T19:20:19.274Z,1431976819.274 [HFRCMSurfaceCurrentAtVehicleLocation] Loaded 2015-05-18T19:20:19.275Z,1431976819.275 [ComponentRegistry](DEBUG): SyncComponent "HFRCMSurfaceCurrentAtVehicleLocation" handled in the control thread. 2015-05-18T19:20:19.306Z,1431976819.306 [HFRCMVirtualSurfaceDrifter] Loaded 2015-05-18T19:20:19.306Z,1431976819.306 [ComponentRegistry](DEBUG): SyncComponent "HFRCMVirtualSurfaceDrifter" handled in the control thread. 2015-05-18T19:20:19.307Z,1431976819.307 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2015-05-18T19:20:19.307Z,1431976819.307 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2015-05-18T19:20:19.598Z,1431976819.598 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2015-05-18T19:20:19.599Z,1431976819.599 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2015-05-18T19:20:19.723Z,1431976819.723 [DeadReckonUsingMultipleVelocitySources] Loaded 2015-05-18T19:20:19.723Z,1431976819.723 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2015-05-18T19:20:19.783Z,1431976819.783 [DeadReckonUsingSpeedCalculator] Loaded 2015-05-18T19:20:19.783Z,1431976819.783 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread. 2015-05-18T19:20:19.805Z,1431976819.805 [NavChart] Loaded 2015-05-18T19:20:19.805Z,1431976819.805 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2015-05-18T19:20:19.810Z,1431976819.810 [UniversalFixResidualReporter] Loaded 2015-05-18T19:20:19.810Z,1431976819.810 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2015-05-18T19:20:19.810Z,1431976819.810 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2015-05-18T19:20:19.811Z,1431976819.811 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2015-05-18T19:20:19.819Z,1431976819.819 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2015-05-18T19:20:19.820Z,1431976819.820 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2015-05-18T19:20:20.033Z,1431976820.033 [Aanderaa_O2] Loaded 2015-05-18T19:20:20.033Z,1431976820.033 [ComponentRegistry](DEBUG): SyncComponent "Aanderaa_O2" handled in the control thread. 2015-05-18T19:20:20.044Z,1431976820.044 [CANONSampler] Loaded 2015-05-18T19:20:20.044Z,1431976820.044 [ComponentRegistry](DEBUG): SyncComponent "CANONSampler" handled in the control thread. 2015-05-18T19:20:20.130Z,1431976820.130 [CTD_NeilBrown] Loaded 2015-05-18T19:20:20.130Z,1431976820.130 [ComponentRegistry](DEBUG): Component "CTD_NeilBrown" handled in its own thread. 2015-05-18T19:20:20.133Z,1431976820.133 [CTD_NeilBrown ThreadHandler](DEBUG): Created PCaller Thread at 406EA4E0 2015-05-18T19:20:20.133Z,1431976820.133 [CTD_NeilBrown ThreadHandler](INFO): Protected caller Thread ID is 858 2015-05-18T19:20:20.146Z,1431976820.146 [ISUS] Loaded 2015-05-18T19:20:20.147Z,1431976820.147 [ComponentRegistry](DEBUG): SyncComponent "ISUS" handled in the control thread. 2015-05-18T19:20:20.166Z,1431976820.166 [PAR_Licor] Loaded 2015-05-18T19:20:20.166Z,1431976820.166 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread. 2015-05-18T19:20:20.217Z,1431976820.217 [WetLabsBB2FL] Loaded 2015-05-18T19:20:20.218Z,1431976820.218 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread. 2015-05-18T19:20:20.221Z,1431976820.221 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 4071A4E0 2015-05-18T19:20:20.222Z,1431976820.222 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 859 2015-05-18T19:20:20.222Z,1431976820.222 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2015-05-18T19:20:20.223Z,1431976820.223 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2015-05-18T19:20:20.953Z,1431976820.953 [AHRS_sp3003D] Loaded 2015-05-18T19:20:20.953Z,1431976820.953 [ComponentRegistry](DEBUG): SyncComponent "AHRS_sp3003D" handled in the control thread. 2015-05-18T19:20:21.139Z,1431976821.139 [DataOverHttps] Loaded 2015-05-18T19:20:21.140Z,1431976821.140 [ComponentRegistry](DEBUG): SyncComponent "DataOverHttps" handled in the control thread. 2015-05-18T19:20:21.154Z,1431976821.154 [Depth_Keller] Loaded 2015-05-18T19:20:21.154Z,1431976821.154 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2015-05-18T19:20:21.159Z,1431976821.159 [DropWeight] Loaded 2015-05-18T19:20:21.160Z,1431976821.160 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread. 2015-05-18T19:20:21.311Z,1431976821.311 [DVL_micro] Loaded 2015-05-18T19:20:21.311Z,1431976821.311 [ComponentRegistry](DEBUG): SyncComponent "DVL_micro" handled in the control thread. 2015-05-18T19:20:21.419Z,1431976821.419 [NAL9602] Loaded 2015-05-18T19:20:21.419Z,1431976821.419 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2015-05-18T19:20:21.465Z,1431976821.465 [Onboard] Loaded 2015-05-18T19:20:21.466Z,1431976821.466 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread. 2015-05-18T19:20:21.473Z,1431976821.473 [Radio_Surface] Loaded 2015-05-18T19:20:21.473Z,1431976821.473 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2015-05-18T19:20:21.475Z,1431976821.475 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 4095E4E0 2015-05-18T19:20:21.475Z,1431976821.475 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 860 2015-05-18T19:20:21.627Z,1431976821.627 [DAT] Loaded 2015-05-18T19:20:21.628Z,1431976821.628 [ComponentRegistry](DEBUG): SyncComponent "DAT" handled in the control thread. 2015-05-18T19:20:23.699Z,1431976823.699 [BPC1] Loaded 2015-05-18T19:20:23.700Z,1431976823.700 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2015-05-18T19:20:23.700Z,1431976823.700 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2015-05-18T19:20:23.701Z,1431976823.701 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2015-05-18T19:20:23.830Z,1431976823.830 [BuoyancyServo] Loaded 2015-05-18T19:20:23.830Z,1431976823.830 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2015-05-18T19:20:23.847Z,1431976823.847 [ElevatorServo] Loaded 2015-05-18T19:20:23.847Z,1431976823.847 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2015-05-18T19:20:23.860Z,1431976823.860 [MassServo] Loaded 2015-05-18T19:20:23.860Z,1431976823.860 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2015-05-18T19:20:23.872Z,1431976823.872 [RudderServo] Loaded 2015-05-18T19:20:23.872Z,1431976823.872 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2015-05-18T19:20:23.884Z,1431976823.884 [ThrusterServo] Loaded 2015-05-18T19:20:23.885Z,1431976823.885 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread. 2015-05-18T19:20:23.885Z,1431976823.885 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2015-05-18T19:20:23.886Z,1431976823.886 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2015-05-18T19:20:24.028Z,1431976824.028 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2015-05-18T19:20:24.029Z,1431976824.029 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2015-05-18T19:20:24.067Z,1431976824.067 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2015-05-18T19:20:24.075Z,1431976824.075 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2015-05-18T19:20:24.076Z,1431976824.076 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2015-05-18T19:20:24.083Z,1431976824.083 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2015-05-18T19:20:24.087Z,1431976824.087 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40A0C4E0 2015-05-18T19:20:24.087Z,1431976824.087 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 861 2015-05-18T19:20:24.093Z,1431976824.093 [Supervisor](INFO): Main Thread ID is 765 2015-05-18T19:20:24.093Z,1431976824.093 [Supervisor](DEBUG): Running supervisor. 2015-05-18T19:20:24.093Z,1431976824.093 [CommandLine ThreadHandler](INFO): Handler Thread ID is 862 2015-05-18T19:20:24.100Z,1431976824.100 [controlThread ThreadHandler](INFO): Handler Thread ID is 863 2015-05-18T19:20:24.100Z,1431976824.100 [controlThread](DEBUG): Initializing ControlThread 2015-05-18T19:20:24.101Z,1431976824.101 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2015-05-18T19:20:24.103Z,1431976824.103 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2015-05-18T19:20:24.104Z,1431976824.104 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2015-05-18T19:20:24.104Z,1431976824.104 [LoopControl](DEBUG): Initialize LoopControlComponent. 2015-05-18T19:20:24.104Z,1431976824.104 [SBIT](INFO): Initialize SBIT Component. 2015-05-18T19:20:24.105Z,1431976824.105 [SBIT](IMPORTANT): Tethys CM Info: SVN revision:12241 2015-05-18T19:20:24.105Z,1431976824.105 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2015-05-18T19:20:24.105Z,1431976824.105 [SBIT](IMPORTANT): Kernel Version:#639 PREEMPT Wed Mar 12 12:53:33 PDT 2014 2015-05-18T19:20:24.106Z,1431976824.106 [IBIT](INFO): Initialize IBIT Component. 2015-05-18T19:20:24.107Z,1431976824.107 [CBIT](DEBUG): Initialize CBIT Component. 2015-05-18T19:20:24.107Z,1431976824.107 [CBIT](FAULT): LAST RESTART WAS UNINTENTIONAL. 2015-05-18T19:20:24.107Z,1431976824.107 [CBIT](INFO): Last reboot was NOT due to watchdog timer. 2015-05-18T19:20:24.112Z,1431976824.112 [logger ThreadHandler](INFO): Handler Thread ID is 864 2015-05-18T19:20:24.131Z,1431976824.131 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2015-05-18T19:20:24.132Z,1431976824.132 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2015-05-18T19:20:24.132Z,1431976824.132 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2015-05-18T19:20:24.132Z,1431976824.132 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator. 2015-05-18T19:20:24.133Z,1431976824.133 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2015-05-18T19:20:24.142Z,1431976824.142 [HFRadarCompactModelForecaster](DEBUG): Found new ECs! 2015-05-18T19:20:24.172Z,1431976824.172 [CTD_NeilBrown ThreadHandler](INFO): Handler Thread ID is 865 2015-05-18T19:20:24.173Z,1431976824.173 [CTD_NeilBrown](DEBUG): Initializing CTD_NeilBrown. 2015-05-18T19:20:24.180Z,1431976824.180 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 867 2015-05-18T19:20:24.181Z,1431976824.181 [WetLabsBB2FL](INFO): Powering down 2015-05-18T19:20:24.200Z,1431976824.200 [CTD_NeilBrown](INFO): Opening uart, block timeout 10ths=4 2015-05-18T19:20:24.221Z,1431976824.221 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 868 2015-05-18T19:20:24.229Z,1431976824.229 [Radio_Surface](INFO): Powering up 2015-05-18T19:20:24.237Z,1431976824.237 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 869 2015-05-18T19:20:24.243Z,1431976824.243 [NavChartDb](INFO): Looking for Electronic Nav Chart files in directory: Resources 2015-05-18T19:20:24.244Z,1431976824.244 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000 2015-05-18T19:20:24.244Z,1431976824.244 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000 2015-05-18T19:20:24.244Z,1431976824.244 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000 2015-05-18T19:20:24.244Z,1431976824.244 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000 2015-05-18T19:20:24.245Z,1431976824.245 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000 2015-05-18T19:20:24.245Z,1431976824.245 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000 2015-05-18T19:20:24.245Z,1431976824.245 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000 2015-05-18T19:20:24.245Z,1431976824.245 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000 2015-05-18T19:20:24.620Z,1431976824.620 [CTD_NeilBrown](DEBUG): CTD uart timeout: serial timeout 2015-05-18T19:20:24.621Z,1431976824.621 [CTD_NeilBrown](ERROR): Could not get real or simulated CTD data. startTime.elapsed() = 0.420252 2015-05-18T19:20:33.473Z,1431976833.473 [HFRadarCompactModelForecaster](IMPORTANT): forecast time 201505181600 published 2015-05-18T19:20:33.490Z,1431976833.490 [HFRCMSpaceInterpolator](DEBUG): Initializing HFRCMSpaceInterpolator component with verbosity level 0. 2015-05-18T19:20:33.492Z,1431976833.492 [HFRCMTimeInterpolator](DEBUG): Initializing HFRCMTimeInterpolator component. 2015-05-18T19:20:33.492Z,1431976833.492 [HFRCMReconstructedInterpolator](INFO): Initializing HFRCMReconstructedInterpolator component with velocityAccuracy_ = 0.300000 m/s. 2015-05-18T19:20:33.511Z,1431976833.511 [HFRCMSurfaceCurrentAtVehicleLocation](DEBUG): Initializing HFRCMSurfaceCurrentAtVehicleLocation component. 2015-05-18T19:20:33.511Z,1431976833.511 [HFRCMVirtualSurfaceDrifter](DEBUG): Initializing HFRCMVirtualSurfaceDrifter component. 2015-05-18T19:20:33.511Z,1431976833.511 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component. 2015-05-18T19:20:33.512Z,1431976833.512 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2015-05-18T19:20:33.512Z,1431976833.512 [NavChart](DEBUG): Initialize NavChart Navigation. 2015-05-18T19:20:33.513Z,1431976833.513 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2015-05-18T19:20:33.540Z,1431976833.540 [MissionManager](INFO): Loading Mission: Missions/Startup.xml 2015-05-18T19:20:33.571Z,1431976833.571 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2015-05-18T19:20:33.592Z,1431976833.592 [MissionManager](DEBUG): 2015-05-18T19:20:33.593Z,1431976833.593 [MissionManager](INFO): Loading Mission: Missions/Default.xml 2015-05-18T19:20:33.674Z,1431976833.674 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min 2015-05-18T19:20:33.691Z,1431976833.691 [Default:A.GoToSurface](DEBUG): Construct GoToSurface. 2015-05-18T19:20:33.720Z,1431976833.720 [Default:CheckIn:A.SetSpeed](DEBUG): Construct. 2015-05-18T19:20:33.752Z,1431976833.752 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2015-05-18T19:20:33.776Z,1431976833.776 [Default:WaitAtTheSurface:RunApplicationAtLowSpeed.SetSpeed](DEBUG): Construct. 2015-05-18T19:20:33.782Z,1431976833.782 [MissionManager](DEBUG): 0 5.0 1.0 400 10 500 Default mission has been running for Burn 300 Dropped weight due to communications timeout. 5 2015-05-18T19:20:33.804Z,1431976833.804 [controlThread](DEBUG): Component order: CycleStarter,Aanderaa_O2,CANONSampler,ISUS,PAR_Licor,AHRS_sp3003D,DataOverHttps,Depth_Keller,DropWeight,DVL_micro,NAL9602,Onboard,DAT,BPC1,PAR_Licor,Depth_Keller,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,HFRadarCompactModelForecaster,HFRCMSpaceInterpolator,HFRCMTimeInterpolator,HFRCMReconstructedInterpolator,HFRCMSurfaceCurrentAtVehicleLocation,HFRCMVirtualSurfaceDrifter,DeadReckonUsingMultipleVelocitySources,DeadReckonUsingSpeedCalculator,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter, 2015-05-18T19:20:33.861Z,1431976833.861 [CANONSampler](INFO): Powering down 2015-05-18T19:20:33.957Z,1431976833.957 [AHRS_sp3003D](DEBUG): Initializing AHRS_sp3003D. 2015-05-18T19:20:34.744Z,1431976834.744 [DVL_micro](INFO): Initializing 2015-05-18T19:20:34.767Z,1431976834.767 [NAL9602](INFO): Powering up NAL9602 2015-05-18T19:20:34.840Z,1431976834.840 [DAT](INFO): Powering up 2015-05-18T19:20:34.840Z,1431976834.840 [DAT](DEBUG): Initializing DAT. 2015-05-18T19:20:44.335Z,1431976844.335 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 3.140000 seconds. 2015-05-18T19:20:44.335Z,1431976844.335 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1 2015-05-18T19:20:44.335Z,1431976844.335 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2015-05-18T19:20:44.359Z,1431976844.359 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 3.140000 seconds. 2015-05-18T19:20:44.359Z,1431976844.359 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 1 2015-05-18T19:20:44.359Z,1431976844.359 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2015-05-18T19:20:44.477Z,1431976844.477 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2015-05-18T19:20:44.483Z,1431976844.483 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2015-05-18T19:20:44.507Z,1431976844.507 [ElevatorServo](DEBUG): Initializing EZServoServo. 2015-05-18T19:20:44.519Z,1431976844.519 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2015-05-18T19:20:44.541Z,1431976844.541 [MassServo](DEBUG): Initializing EZServoServo. 2015-05-18T19:20:44.547Z,1431976844.547 [MassServo](DEBUG): Initializing MassServo. 2015-05-18T19:20:44.561Z,1431976844.561 [RudderServo](DEBUG): Initializing EZServoServo. 2015-05-18T19:20:44.567Z,1431976844.567 [RudderServo](DEBUG): Initializing RudderServo. 2015-05-18T19:20:44.579Z,1431976844.579 [ThrusterServo](DEBUG): Initializing EZServoServo. 2015-05-18T19:20:44.587Z,1431976844.587 [ThrusterServo](DEBUG): Initializing ThrusterServo. 2015-05-18T19:20:44.634Z,1431976844.634 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2015-05-18T19:20:44.634Z,1431976844.634 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2015-05-18T19:20:44.712Z,1431976844.712 [Aanderaa_O2](FAULT): Timed out starting 2015-05-18T19:20:44.712Z,1431976844.712 [Aanderaa_O2] Communications Fault, FailCount= 1 2015-05-18T19:20:44.713Z,1431976844.713 [Aanderaa_O2](ERROR): Communications Fault 2015-05-18T19:20:44.979Z,1431976844.979 [SBIT](IMPORTANT): Beginning Startup BIT 2015-05-18T19:20:44.989Z,1431976844.989 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2015-05-18T19:20:44.989Z,1431976844.989 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1 2015-05-18T19:20:44.990Z,1431976844.990 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2015-05-18T19:20:44.990Z,1431976844.990 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 1 2015-05-18T19:20:44.990Z,1431976844.990 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2015-05-18T19:20:44.991Z,1431976844.991 [CBIT](IMPORTANT): Beginning GF scan 2015-05-18T19:20:45.188Z,1431976845.188 [Aanderaa_O2](INFO): Powering down 2015-05-18T19:20:45.624Z,1431976845.624 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component. 2015-05-18T19:20:45.625Z,1431976845.625 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2015-05-18T19:20:46.334Z,1431976846.334 [NAL9602](INFO): NAL9602 initialized 2015-05-18T19:20:46.895Z,1431976846.895 [CBIT](INFO): Clearing failed state for component Aanderaa_O2 2015-05-18T19:20:46.895Z,1431976846.895 [Aanderaa_O2] No Fault, FailCount= 1 2015-05-18T19:20:47.894Z,1431976847.894 [DAT](DEBUG): 2015-05-18T19:20:47.895Z,1431976847.895 [DAT](DEBUG): Teledyne Benthos ATM-900 Series 2015-05-18T19:20:47.895Z,1431976847.895 [DAT](DEBUG): MF Frequency Band 2015-05-18T19:20:47.897Z,1431976847.897 [DAT](DEBUG): Directional Acoustic Transponder version 8.3.1 2015-05-18T19:20:48.356Z,1431976848.356 [DAT](DEBUG): May 18 2015 20:18:55 2015-05-18T19:20:49.764Z,1431976849.764 [DAT](INFO): entering command mode 2015-05-18T19:20:50.172Z,1431976850.172 [Aanderaa_O2](INFO): Powering down 2015-05-18T19:20:50.567Z,1431976850.567 [DAT](DEBUG): checking for command mode acknowledgment 2015-05-18T19:20:50.572Z,1431976850.572 [DAT](DEBUG): read user prompt 1: user:1> 2015-05-18T19:20:50.572Z,1431976850.572 [DAT](INFO): command mode acknowledged 2015-05-18T19:20:51.106Z,1431976851.106 [DAT](INFO): setting local address to 2 2015-05-18T19:20:51.653Z,1431976851.653 [DAT](DEBUG): checking for local address setting acknowledgment 2015-05-18T19:20:51.658Z,1431976851.658 [DAT](INFO): set local address to 2 2015-05-18T19:20:52.344Z,1431976852.344 [DAT](DEBUG): read user prompt 2: user:2> 2015-05-18T19:20:58.079Z,1431976858.079 [SBIT](FAULT): Mass: EXPECTED:0.003400 ACTUAL:0.000599 2015-05-18T19:21:11.340Z,1431976871.340 [CBIT](IMPORTANT): No ground fault detected 2015-05-18T19:21:16.271Z,1431976876.271 [NAL9602](IMPORTANT): SBD MO Status=0, MOMSN=56837, MT Status=1, MTMSN=457 2015-05-18T19:21:16.271Z,1431976876.271 [NAL9602](INFO): Data available in MT queue 2015-05-18T19:21:17.097Z,1431976877.097 [NAL9602](IMPORTANT): Initialized file: Data/HFRadarModel/2015051500 2015-05-18T19:21:17.099Z,1431976877.099 [NAL9602](IMPORTANT): Executing cat Logs/latest/55555905.part > Data/HFRadarModel/2015051500 2015-05-18T19:21:17.532Z,1431976877.532 [CommandLine](IMPORTANT): c382bbe85a77276419c5200bd35efebe Data/HFRadarModel/2015051500 2015-05-18T19:21:39.355Z,1431976899.355 [SBIT](CRITICAL): SBIT FAILED 2015-05-18T19:21:39.357Z,1431976899.357 [CommandLine](FAULT): Scheduling is paused 2015-05-18T19:21:39.796Z,1431976899.796 [MissionManager](IMPORTANT): Started mission Startup 2015-05-18T19:21:39.796Z,1431976899.796 [Startup] Running Loop=1 2015-05-18T19:21:39.796Z,1431976899.796 [Startup](INFO): Aggregate::initialize Startup 2015-05-18T19:21:39.796Z,1431976899.796 [Startup:A.GoToSurface] Running Loop=1 2015-05-18T19:21:39.796Z,1431976899.796 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2015-05-18T19:21:39.797Z,1431976899.797 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2015-05-18T19:21:39.797Z,1431976899.797 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2015-05-18T19:21:39.798Z,1431976899.798 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 0.500000 m/s. 2015-05-18T19:21:39.803Z,1431976899.803 [Startup:StartupSatComms] Running Loop=1 2015-05-18T19:21:39.804Z,1431976899.804 [Startup:StartupSatComms](INFO): Aggregate::initialize Startup:StartupSatComms 2015-05-18T19:21:39.804Z,1431976899.804 [Startup:StartupSatComms:A] Running Loop=1 2015-05-18T19:21:40.346Z,1431976900.346 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix 2015-05-18T19:22:40.143Z,1431976960.143 [Startup:StartupSatComms:A](INFO): Timed out from 2015-05-18T19:21:39.8Z 2015-05-18T19:22:40.143Z,1431976960.143 [Startup:StartupSatComms:A] Stopped 2015-05-18T19:22:40.143Z,1431976960.143 [Startup:StartupSatComms:B] Running Loop=1 2015-05-18T19:22:40.587Z,1431976960.587 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications 2015-05-18T19:23:40.260Z,1431977020.260 [Startup:StartupSatComms:B](INFO): Timed out from 2015-05-18T19:22:40.1Z 2015-05-18T19:23:40.260Z,1431977020.260 [Startup:StartupSatComms:B] Stopped 2015-05-18T19:23:40.260Z,1431977020.260 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms 2015-05-18T19:23:40.260Z,1431977020.260 [Startup:StartupSatComms] Stopped 2015-05-18T19:23:40.260Z,1431977020.260 [Startup:StartupSatComms](INFO): Aggregate::uninitialize Startup:StartupSatComms 2015-05-18T19:23:40.261Z,1431977020.261 [Startup](INFO): Completed Startup 2015-05-18T19:23:40.261Z,1431977020.261 [Startup] Stopped 2015-05-18T19:23:40.261Z,1431977020.261 [Startup](INFO): Aggregate::uninitialize Startup 2015-05-18T19:23:40.262Z,1431977020.262 [Startup:A.GoToSurface] Stopped 2015-05-18T19:23:40.262Z,1431977020.262 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2015-05-18T19:23:40.698Z,1431977020.698 [MissionManager](IMPORTANT): Started mission Default 2015-05-18T19:23:40.698Z,1431977020.698 [Default] Running Loop=1 2015-05-18T19:23:40.698Z,1431977020.698 [Default](INFO): Aggregate::initialize Default 2015-05-18T19:23:40.698Z,1431977020.698 [Default:A.GoToSurface] Running Loop=1 2015-05-18T19:23:40.698Z,1431977020.698 [Default:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2015-05-18T19:23:40.699Z,1431977020.699 [Default:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2015-05-18T19:23:40.699Z,1431977020.699 [Default:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2015-05-18T19:23:40.699Z,1431977020.699 [Default:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 0.500000 m/s. 2015-05-18T19:23:40.700Z,1431977020.700 [Default:CheckIn] Running Loop=1 2015-05-18T19:23:40.700Z,1431977020.700 [Default:CheckIn](INFO): Aggregate::initialize Default:CheckIn 2015-05-18T19:23:40.700Z,1431977020.700 [Default:CheckIn:A.SetSpeed] Running Loop=1 2015-05-18T19:23:40.700Z,1431977020.700 [Default:CheckIn:A.SetSpeed](DEBUG): Initialize. 2015-05-18T19:23:40.700Z,1431977020.700 [Default:CheckIn:Read_GPS] Running Loop=1 2015-05-18T19:23:40.701Z,1431977020.701 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix 2015-05-18T19:23:40.703Z,1431977020.703 [Default:CheckIn:A.SetSpeed] Running Loop=1 2015-05-18T19:23:40.714Z,1431977020.714 [Default:WaitAtTheSurface] Running Loop=1 2015-05-18T19:23:40.714Z,1431977020.714 [Default:WaitAtTheSurface](INFO): Aggregate::initialize Default:WaitAtTheSurface 2015-05-18T19:23:40.714Z,1431977020.714 [Default:WaitAtTheSurface:RunApplicationAtLowSpeed.SetSpeed] Running Loop=1 2015-05-18T19:23:40.714Z,1431977020.714 [Default:WaitAtTheSurface:RunApplicationAtLowSpeed.SetSpeed](DEBUG): Initialize. 2015-05-18T19:23:41.113Z,1431977021.113 [Default:WaitAtTheSurface:RunApplicationAtLowSpeed.SetSpeed] Running Loop=1 2015-05-18T19:23:45.842Z,1431977025.842 [DeadReckonUsingMultipleVelocitySources](FAULT): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2015-05-18T19:23:45.843Z,1431977025.843 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2 2015-05-18T19:23:45.843Z,1431977025.843 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2015-05-18T19:23:45.845Z,1431977025.845 [DeadReckonUsingSpeedCalculator](FAULT): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2015-05-18T19:23:45.845Z,1431977025.845 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 2 2015-05-18T19:23:45.845Z,1431977025.845 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2015-05-18T19:23:45.882Z,1431977025.882 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2015-05-18T19:23:45.882Z,1431977025.882 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2015-05-18T19:23:46.333Z,1431977026.333 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2015-05-18T19:23:46.333Z,1431977026.333 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2 2015-05-18T19:23:46.334Z,1431977026.334 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2015-05-18T19:23:46.334Z,1431977026.334 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 2 2015-05-18T19:23:46.743Z,1431977026.743 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component. 2015-05-18T19:23:46.743Z,1431977026.743 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2015-05-18T19:23:47.149Z,1431977027.149 [DeadReckonUsingMultipleVelocitySources](DEBUG): No bottom track data -- 1.307225 seconds since last successful read, accepting data for 3.140000 seconds. 2015-05-18T19:23:47.596Z,1431977027.596 [DeadReckonUsingMultipleVelocitySources](DEBUG): No bottom track data -- 1.753520 seconds since last successful read, accepting data for 3.140000 seconds. 2015-05-18T19:23:48.002Z,1431977028.002 [DeadReckonUsingMultipleVelocitySources](DEBUG): No bottom track data -- 2.160348 seconds since last successful read, accepting data for 3.140000 seconds. 2015-05-18T19:23:48.448Z,1431977028.448 [DeadReckonUsingMultipleVelocitySources](DEBUG): No bottom track data -- 2.605637 seconds since last successful read, accepting data for 3.140000 seconds. 2015-05-18T19:23:48.897Z,1431977028.897 [DeadReckonUsingMultipleVelocitySources](DEBUG): No bottom track data -- 3.054633 seconds since last successful read, accepting data for 3.140000 seconds. 2015-05-18T19:23:49.291Z,1431977029.291 [DVL_micro](FAULT): DVL failed to acquire valid data within timeout. 2015-05-18T19:23:49.291Z,1431977029.291 [DVL_micro] Data Fault, FailCount= 1 2015-05-18T19:23:49.291Z,1431977029.291 [DVL_micro](ERROR): Data Fault 2015-05-18T19:23:49.381Z,1431977029.381 [CBIT](ERROR): Data Fault in component: DVL_micro 2015-05-18T19:23:49.802Z,1431977029.802 [DVL_micro](INFO): uninitialize:Powering down 2015-05-18T19:23:50.766Z,1431977030.766 [CBIT](INFO): Clearing failed state for component DVL_micro 2015-05-18T19:23:50.767Z,1431977030.767 [DVL_micro] No Fault, FailCount= 1 2015-05-18T19:23:51.120Z,1431977031.120 [DVL_micro](INFO): Initializing 2015-05-18T19:25:52.338Z,1431977152.338 [Depth_Keller](ERROR): Pressure reading out of range: 1830.386841 decibar 2015-05-18T19:25:53.664Z,1431977153.664 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.003307 2015-05-18T19:25:56.461Z,1431977156.461 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-05-18T19:25:56.892Z,1431977156.892 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-05-18T19:25:57.314Z,1431977157.314 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-05-18T19:25:57.746Z,1431977157.746 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-05-18T19:25:58.156Z,1431977158.156 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-05-18T19:25:58.582Z,1431977158.582 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-05-18T19:25:59.032Z,1431977159.032 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-05-18T19:25:59.462Z,1431977159.462 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-05-18T19:25:59.918Z,1431977159.918 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-05-18T19:26:00.363Z,1431977160.363 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-05-18T19:26:00.803Z,1431977160.803 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-05-18T19:26:01.256Z,1431977161.256 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-05-18T19:26:01.701Z,1431977161.701 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-05-18T19:26:02.181Z,1431977162.181 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-05-18T19:26:02.646Z,1431977162.646 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-05-18T19:26:03.104Z,1431977163.104 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-05-18T19:26:03.556Z,1431977163.556 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-05-18T19:26:04.036Z,1431977164.036 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-05-18T19:26:04.545Z,1431977164.545 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-05-18T19:26:04.970Z,1431977164.970 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-05-18T19:26:05.410Z,1431977165.410 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-05-18T19:26:05.855Z,1431977165.855 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-05-18T19:26:06.290Z,1431977166.290 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-05-18T19:26:06.724Z,1431977166.724 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-05-18T19:26:07.149Z,1431977167.149 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-05-18T19:26:07.566Z,1431977167.566 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-05-18T19:26:07.997Z,1431977167.997 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-05-18T19:26:08.435Z,1431977168.435 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-05-18T19:26:08.860Z,1431977168.860 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-05-18T19:26:09.307Z,1431977169.307 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-05-18T19:26:09.737Z,1431977169.737 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-05-18T19:26:10.160Z,1431977170.160 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-05-18T19:26:10.570Z,1431977170.570 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-05-18T19:26:10.995Z,1431977170.995 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-05-18T19:26:11.480Z,1431977171.480 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-05-18T19:26:11.929Z,1431977171.929 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-05-18T19:26:12.357Z,1431977172.357 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-05-18T19:26:12.782Z,1431977172.782 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-05-18T19:26:13.198Z,1431977173.198 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-05-18T19:26:13.608Z,1431977173.608 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-05-18T19:26:14.024Z,1431977174.024 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-05-18T19:26:14.500Z,1431977174.500 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-05-18T19:26:14.947Z,1431977174.947 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-05-18T19:26:15.370Z,1431977175.370 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-05-18T19:26:15.778Z,1431977175.778 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-05-18T19:26:16.199Z,1431977176.199 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-05-18T19:26:16.692Z,1431977176.692 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-05-18T19:26:17.113Z,1431977177.113 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-05-18T19:26:17.617Z,1431977177.617 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-05-18T19:26:18.042Z,1431977178.042 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-05-18T19:26:18.522Z,1431977178.522 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-05-18T19:26:18.975Z,1431977178.975 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-05-18T19:26:19.392Z,1431977179.392 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-05-18T19:26:19.817Z,1431977179.817 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-05-18T19:26:20.249Z,1431977180.249 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-05-18T19:26:20.734Z,1431977180.734 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-05-18T19:26:21.155Z,1431977181.155 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-05-18T19:26:21.599Z,1431977181.599 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-05-18T19:26:22.008Z,1431977182.008 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-05-18T19:26:22.425Z,1431977182.425 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-05-18T19:26:22.854Z,1431977182.854 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-05-18T19:26:23.271Z,1431977183.271 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-05-18T19:26:23.727Z,1431977183.727 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-05-18T19:26:24.167Z,1431977184.167 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-05-18T19:26:24.600Z,1431977184.600 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-05-18T19:26:25.021Z,1431977185.021 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-05-18T19:26:25.429Z,1431977185.429 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-05-18T19:26:25.842Z,1431977185.842 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-05-18T19:26:26.275Z,1431977186.275 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-05-18T19:26:26.761Z,1431977186.761 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-05-18T19:26:27.200Z,1431977187.200 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-05-18T19:26:27.649Z,1431977187.649 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-05-18T19:26:28.078Z,1431977188.078 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-05-18T19:26:28.487Z,1431977188.487 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-05-18T19:26:28.903Z,1431977188.903 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-05-18T19:26:29.335Z,1431977189.335 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-05-18T19:26:29.792Z,1431977189.792 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-05-18T19:26:30.243Z,1431977190.243 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-05-18T19:26:30.670Z,1431977190.670 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-05-18T19:26:31.158Z,1431977191.158 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-05-18T19:26:31.572Z,1431977191.572 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-05-18T19:26:31.000Z,1431977192.000 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-05-18T19:26:32.464Z,1431977192.464 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-05-18T19:26:32.949Z,1431977192.949 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-05-18T19:26:33.417Z,1431977193.417 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-05-18T19:26:33.869Z,1431977193.869 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-05-18T19:26:34.285Z,1431977194.285 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-05-18T19:26:34.688Z,1431977194.688 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-05-18T19:26:35.104Z,1431977195.104 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-05-18T19:26:35.541Z,1431977195.541 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-05-18T19:26:36.014Z,1431977196.014 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-05-18T19:26:36.447Z,1431977196.447 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-05-18T19:26:36.855Z,1431977196.855 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-05-18T19:26:37.268Z,1431977197.268 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-05-18T19:26:37.693Z,1431977197.693 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-05-18T19:26:38.110Z,1431977198.110 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-05-18T19:26:38.558Z,1431977198.558 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-05-18T19:26:39.051Z,1431977199.051 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-05-18T19:26:39.479Z,1431977199.479 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-05-18T19:26:39.903Z,1431977199.903 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-05-18T19:26:40.321Z,1431977200.321 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-05-18T19:26:40.745Z,1431977200.745 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-05-18T19:26:41.174Z,1431977201.174 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-05-18T19:26:41.611Z,1431977201.611 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-05-18T19:26:42.091Z,1431977202.091 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-05-18T19:26:42.524Z,1431977202.524 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-05-18T19:26:42.937Z,1431977202.937 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-05-18T19:26:43.357Z,1431977203.357 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-05-18T19:26:43.786Z,1431977203.786 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-05-18T19:26:44.195Z,1431977204.195 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-05-18T19:26:44.643Z,1431977204.643 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-05-18T19:26:45.129Z,1431977205.129 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-05-18T19:26:45.580Z,1431977205.580 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-05-18T19:26:46.053Z,1431977206.053 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-05-18T19:26:46.470Z,1431977206.470 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-05-18T19:26:46.911Z,1431977206.911 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-05-18T19:26:46.928Z,1431977206.928 [DeadReckonUsingMultipleVelocitySources](FAULT): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2015-05-18T19:26:46.928Z,1431977206.928 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3 2015-05-18T19:26:46.929Z,1431977206.929 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2015-05-18T19:26:46.931Z,1431977206.931 [DeadReckonUsingSpeedCalculator](FAULT): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2015-05-18T19:26:46.931Z,1431977206.931 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 3 2015-05-18T19:26:46.932Z,1431977206.932 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2015-05-18T19:26:46.972Z,1431977206.972 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2015-05-18T19:26:46.972Z,1431977206.972 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2015-05-18T19:26:47.323Z,1431977207.323 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-05-18T19:26:47.422Z,1431977207.422 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2015-05-18T19:26:47.422Z,1431977207.422 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3 2015-05-18T19:26:47.422Z,1431977207.422 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2015-05-18T19:26:47.422Z,1431977207.422 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 3 2015-05-18T19:26:47.808Z,1431977207.808 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-05-18T19:26:47.924Z,1431977207.924 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component. 2015-05-18T19:26:47.924Z,1431977207.924 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2015-05-18T19:26:48.317Z,1431977208.317 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-05-18T19:26:48.365Z,1431977208.365 [DeadReckonUsingMultipleVelocitySources](DEBUG): No bottom track data -- 1.437730 seconds since last successful read, accepting data for 3.140000 seconds. 2015-05-18T19:26:48.766Z,1431977208.766 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-05-18T19:26:48.784Z,1431977208.784 [DeadReckonUsingMultipleVelocitySources](DEBUG): No bottom track data -- 1.856182 seconds since last successful read, accepting data for 3.140000 seconds. 2015-05-18T19:26:49.190Z,1431977209.190 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-05-18T19:26:49.221Z,1431977209.221 [DeadReckonUsingMultipleVelocitySources](DEBUG): No bottom track data -- 2.292959 seconds since last successful read, accepting data for 3.140000 seconds. 2015-05-18T19:26:52.464Z,1431977212.464 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-05-18T19:26:52.910Z,1431977212.910 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-05-18T19:26:53.345Z,1431977213.345 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-05-18T19:26:53.783Z,1431977213.783 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-05-18T19:26:54.222Z,1431977214.222 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-05-18T19:26:54.635Z,1431977214.635 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-05-18T19:26:55.055Z,1431977215.055 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-05-18T19:26:55.488Z,1431977215.488 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-05-18T19:26:55.488Z,1431977215.488 [DVL_micro](FAULT): DVL failed to acquire valid data within timeout. 2015-05-18T19:26:55.488Z,1431977215.488 [DVL_micro] Data Fault, FailCount= 1 2015-05-18T19:26:55.488Z,1431977215.488 [DVL_micro](ERROR): Data Fault 2015-05-18T19:26:55.553Z,1431977215.553 [CBIT](ERROR): Data Fault in component: DVL_micro 2015-05-18T19:26:55.971Z,1431977215.971 [DVL_micro](INFO): uninitialize:Powering down 2015-05-18T19:26:56.397Z,1431977216.397 [DVL_micro](DEBUG): LCB error: Software Overcurrent. 2015-05-18T19:26:56.905Z,1431977216.905 [CBIT](INFO): Clearing failed state for component DVL_micro 2015-05-18T19:26:56.905Z,1431977216.905 [DVL_micro] No Fault, FailCount= 1 2015-05-18T19:26:57.301Z,1431977217.301 [DVL_micro](INFO): Initializing 2015-05-18T19:27:43.816Z,1431977263.816 [BPC1](ERROR): Failed to parse bank A battery data 2015-05-18T19:27:43.817Z,1431977263.817 [BPC1] Data Fault, FailCount= 1 2015-05-18T19:27:43.817Z,1431977263.817 [BPC1](ERROR): Data Fault 2015-05-18T19:27:43.861Z,1431977263.861 [CBIT](ERROR): Data Fault in component: BPC1 2015-05-18T19:27:45.155Z,1431977265.155 [CBIT](INFO): Clearing failed state for component BPC1 2015-05-18T19:27:45.155Z,1431977265.155 [BPC1] No Fault, FailCount= 1 2015-05-18T19:28:01.054Z,1431977281.054 [BPC1](DEBUG): Received data from all battery sticks 2015-05-18T19:28:40.760Z,1431977320.760 [Default:CheckIn:Read_GPS](INFO): Timed out from 2015-05-18T19:23:40.7Z 2015-05-18T19:28:40.760Z,1431977320.760 [Default:CheckIn:Read_GPS] Stopped 2015-05-18T19:28:40.760Z,1431977320.760 [Default:Ch