2017-08-28T18:41:33.886Z,1503945693.886 [Supervisor](DEBUG): Initializing supervisor.
2017-08-28T18:41:33.889Z,1503945693.889 [SyncHandler](DEBUG): Created PCaller Thread at 4051A4E0
2017-08-28T18:41:33.890Z,1503945693.890 [SyncHandler](INFO): Protected caller Thread ID is 1131
2017-08-28T18:41:33.890Z,1503945693.890 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2017-08-28T18:41:33.891Z,1503945693.891 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 4054A4E0
2017-08-28T18:41:33.892Z,1503945693.892 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 1132
2017-08-28T18:41:33.894Z,1503945693.894 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2017-08-28T18:41:33.907Z,1503945693.907 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2017-08-28T18:41:33.908Z,1503945693.908 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 4057A4E0
2017-08-28T18:41:33.908Z,1503945693.908 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 1133
2017-08-28T18:41:33.909Z,1503945693.909 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2017-08-28T18:41:33.910Z,1503945693.910 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405AA4E0
2017-08-28T18:41:33.910Z,1503945693.910 [logger ThreadHandler](INFO): Protected caller Thread ID is 1134
2017-08-28T18:41:33.913Z,1503945693.913 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2017-08-28T18:41:33.913Z,1503945693.913 [Supervisor](INFO): Looking for Config files in directory: Config/
2017-08-28T18:41:33.914Z,1503945693.914 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2017-08-28T18:41:34.105Z,1503945694.105 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2017-08-28T18:41:34.105Z,1503945694.105 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2017-08-28T18:41:34.240Z,1503945694.240 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2017-08-28T18:41:34.240Z,1503945694.240 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2017-08-28T18:41:34.601Z,1503945694.601 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2017-08-28T18:41:34.601Z,1503945694.601 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2017-08-28T18:41:34.742Z,1503945694.742 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2017-08-28T18:41:34.742Z,1503945694.742 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2017-08-28T18:41:34.827Z,1503945694.827 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2017-08-28T18:41:35.029Z,1503945695.029 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2017-08-28T18:41:35.030Z,1503945695.030 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2017-08-28T18:41:35.116Z,1503945695.116 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample
2017-08-28T18:41:35.116Z,1503945695.116 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2017-08-28T18:41:35.421Z,1503945695.421 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2017-08-28T18:41:35.422Z,1503945695.422 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2017-08-28T18:41:35.839Z,1503945695.839 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2017-08-28T18:41:35.840Z,1503945695.840 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2017-08-28T18:41:36.146Z,1503945696.146 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2017-08-28T18:41:36.146Z,1503945696.146 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2017-08-28T18:41:36.654Z,1503945696.654 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2017-08-28T18:41:36.655Z,1503945696.655 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2017-08-28T18:41:36.858Z,1503945696.858 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2017-08-28T18:41:36.858Z,1503945696.858 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2017-08-28T18:41:36.962Z,1503945696.962 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2017-08-28T18:41:36.963Z,1503945696.963 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2017-08-28T18:41:37.424Z,1503945697.424 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2017-08-28T18:41:37.425Z,1503945697.425 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2017-08-28T18:41:37.538Z,1503945697.538 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2017-08-28T18:41:37.540Z,1503945697.540 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-daphne/
2017-08-28T18:41:37.541Z,1503945697.541 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Battery.cfg
2017-08-28T18:41:37.782Z,1503945697.782 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2017-08-28T18:41:37.782Z,1503945697.782 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/BIT.cfg
2017-08-28T18:41:37.888Z,1503945697.888 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Navigation.cfg
2017-08-28T18:41:37.983Z,1503945697.983 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Control.cfg
2017-08-28T18:41:38.090Z,1503945698.090 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Simulator.cfg
2017-08-28T18:41:38.179Z,1503945698.179 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Science.cfg
2017-08-28T18:41:38.311Z,1503945698.311 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Sensor.cfg
2017-08-28T18:41:38.470Z,1503945698.470 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Servo.cfg
2017-08-28T18:41:38.570Z,1503945698.570 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/logger.cfg
2017-08-28T18:41:38.667Z,1503945698.667 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/secure.cfg
2017-08-28T18:41:38.755Z,1503945698.755 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/vehicle.cfg
2017-08-28T18:41:38.937Z,1503945698.937 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/workSite.cfg
2017-08-28T18:41:39.018Z,1503945699.018 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg
2017-08-28T18:41:39.030Z,1503945699.030 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2017-08-28T18:41:39.153Z,1503945699.153 [SBIT](DEBUG): Construct Startup Built In Test.
2017-08-28T18:41:39.183Z,1503945699.183 [SBIT] Loaded
2017-08-28T18:41:39.183Z,1503945699.183 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2017-08-28T18:41:39.184Z,1503945699.184 [IBIT](DEBUG): Construct Initiated Built In Test.
2017-08-28T18:41:39.212Z,1503945699.212 [IBIT] Loaded
2017-08-28T18:41:39.212Z,1503945699.212 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2017-08-28T18:41:39.216Z,1503945699.216 [CBIT](DEBUG): Construct Continuous Built In Test.
2017-08-28T18:41:39.363Z,1503945699.363 [CBIT] Loaded
2017-08-28T18:41:39.364Z,1503945699.364 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2017-08-28T18:41:39.364Z,1503945699.364 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2017-08-28T18:41:39.365Z,1503945699.365 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2017-08-28T18:41:39.430Z,1503945699.430 [VerticalControl](DEBUG): Construct VerticalControl.
2017-08-28T18:41:39.529Z,1503945699.529 [VerticalControl] Loaded
2017-08-28T18:41:39.529Z,1503945699.529 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2017-08-28T18:41:39.530Z,1503945699.530 [HorizontalControl](DEBUG): Construct HorizontalControl.
2017-08-28T18:41:39.592Z,1503945699.592 [HorizontalControl] Loaded
2017-08-28T18:41:39.592Z,1503945699.592 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2017-08-28T18:41:39.593Z,1503945699.593 [SpeedControl](DEBUG): Construct SpeedControl.
2017-08-28T18:41:39.599Z,1503945699.599 [SpeedControl] Loaded
2017-08-28T18:41:39.599Z,1503945699.599 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2017-08-28T18:41:39.600Z,1503945699.600 [BackSeatDriver](DEBUG): Construct BackSeatDriver.
2017-08-28T18:41:39.602Z,1503945699.602 [BackSeatDriver] Loaded
2017-08-28T18:41:39.603Z,1503945699.603 [ComponentRegistry](DEBUG): SyncComponent "BackSeatDriver" handled in the control thread.
2017-08-28T18:41:39.603Z,1503945699.603 [LoopControl](DEBUG): Construct LoopControl.
2017-08-28T18:41:39.604Z,1503945699.604 [LoopControl] Loaded
2017-08-28T18:41:39.604Z,1503945699.604 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2017-08-28T18:41:39.605Z,1503945699.605 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2017-08-28T18:41:39.605Z,1503945699.605 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2017-08-28T18:41:39.629Z,1503945699.629 [DepthRateCalculator] Loaded
2017-08-28T18:41:39.629Z,1503945699.629 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2017-08-28T18:41:39.634Z,1503945699.634 [PitchRateCalculator] Loaded
2017-08-28T18:41:39.635Z,1503945699.635 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2017-08-28T18:41:39.650Z,1503945699.650 [SpeedCalculator] Loaded
2017-08-28T18:41:39.650Z,1503945699.650 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2017-08-28T18:41:39.672Z,1503945699.672 [TempGradientCalculator] Loaded
2017-08-28T18:41:39.672Z,1503945699.672 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread.
2017-08-28T18:41:39.688Z,1503945699.688 [VerticalTemperatureHomogeneityIndexCalculator] Loaded
2017-08-28T18:41:39.688Z,1503945699.688 [ComponentRegistry](DEBUG): SyncComponent "VerticalTemperatureHomogeneityIndexCalculator" handled in the control thread.
2017-08-28T18:41:39.693Z,1503945699.693 [YawRateCalculator] Loaded
2017-08-28T18:41:39.693Z,1503945699.693 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2017-08-28T18:41:39.694Z,1503945699.694 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2017-08-28T18:41:39.694Z,1503945699.694 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2017-08-28T18:41:39.770Z,1503945699.770 [StratificationFrontDetector](INFO): threshold set to: 0.399988 degC
2017-08-28T18:41:39.771Z,1503945699.771 [StratificationFrontDetector](DEBUG): (re)initializing
2017-08-28T18:41:39.771Z,1503945699.771 [StratificationFrontDetector] Loaded
2017-08-28T18:41:39.771Z,1503945699.771 [ComponentRegistry](DEBUG): SyncComponent "StratificationFrontDetector" handled in the control thread.
2017-08-28T18:41:39.772Z,1503945699.772 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2017-08-28T18:41:39.772Z,1503945699.772 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2017-08-28T18:41:39.996Z,1503945699.996 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2017-08-28T18:41:39.997Z,1503945699.997 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2017-08-28T18:41:40.091Z,1503945700.091 [DeadReckonUsingMultipleVelocitySources] Loaded
2017-08-28T18:41:40.091Z,1503945700.091 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2017-08-28T18:41:40.145Z,1503945700.145 [DeadReckonUsingSpeedCalculator] Loaded
2017-08-28T18:41:40.145Z,1503945700.145 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread.
2017-08-28T18:41:40.162Z,1503945700.162 [NavChart] Loaded
2017-08-28T18:41:40.162Z,1503945700.162 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2017-08-28T18:41:40.167Z,1503945700.167 [UniversalFixResidualReporter] Loaded
2017-08-28T18:41:40.167Z,1503945700.167 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2017-08-28T18:41:40.167Z,1503945700.167 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2017-08-28T18:41:40.168Z,1503945700.168 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2017-08-28T18:41:40.174Z,1503945700.174 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2017-08-28T18:41:40.175Z,1503945700.175 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2017-08-28T18:41:40.312Z,1503945700.312 [Aanderaa_O2] Loaded
2017-08-28T18:41:40.312Z,1503945700.312 [ComponentRegistry](DEBUG): SyncComponent "Aanderaa_O2" handled in the control thread.
2017-08-28T18:41:40.324Z,1503945700.324 [CANONSampler] Loaded
2017-08-28T18:41:40.324Z,1503945700.324 [ComponentRegistry](DEBUG): SyncComponent "CANONSampler" handled in the control thread.
2017-08-28T18:41:40.403Z,1503945700.403 [CTD_NeilBrown] Loaded
2017-08-28T18:41:40.403Z,1503945700.403 [ComponentRegistry](DEBUG): Component "CTD_NeilBrown" handled in its own thread.
2017-08-28T18:41:40.404Z,1503945700.404 [CTD_NeilBrown ThreadHandler](DEBUG): Created PCaller Thread at 4077A4E0
2017-08-28T18:41:40.405Z,1503945700.405 [CTD_NeilBrown ThreadHandler](INFO): Protected caller Thread ID is 1216
2017-08-28T18:41:40.439Z,1503945700.439 [CTD_Seabird] Loaded
2017-08-28T18:41:40.439Z,1503945700.439 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread.
2017-08-28T18:41:40.440Z,1503945700.440 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 407AA4E0
2017-08-28T18:41:40.440Z,1503945700.440 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 1217
2017-08-28T18:41:40.455Z,1503945700.455 [PAR_Licor] Loaded
2017-08-28T18:41:40.456Z,1503945700.456 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2017-08-28T18:41:40.504Z,1503945700.504 [WetLabsBB2FL] Loaded
2017-08-28T18:41:40.504Z,1503945700.504 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2017-08-28T18:41:40.505Z,1503945700.505 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 407DA4E0
2017-08-28T18:41:40.506Z,1503945700.506 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 1218
2017-08-28T18:41:40.506Z,1503945700.506 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2017-08-28T18:41:40.507Z,1503945700.507 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2017-08-28T18:41:40.821Z,1503945700.821 [DataOverHttps] Loaded
2017-08-28T18:41:40.821Z,1503945700.821 [ComponentRegistry](DEBUG): SyncComponent "DataOverHttps" handled in the control thread.
2017-08-28T18:41:40.835Z,1503945700.835 [Depth_Keller] Loaded
2017-08-28T18:41:40.835Z,1503945700.835 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2017-08-28T18:41:40.840Z,1503945700.840 [DropWeight] Loaded
2017-08-28T18:41:40.840Z,1503945700.840 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2017-08-28T18:41:40.929Z,1503945700.929 [NAL9602] Loaded
2017-08-28T18:41:40.929Z,1503945700.929 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2017-08-28T18:41:40.938Z,1503945700.938 [Onboard] Loaded
2017-08-28T18:41:40.939Z,1503945700.939 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread.
2017-08-28T18:41:40.946Z,1503945700.946 [Radio_Surface] Loaded
2017-08-28T18:41:40.946Z,1503945700.946 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2017-08-28T18:41:40.947Z,1503945700.947 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 40A254E0
2017-08-28T18:41:40.948Z,1503945700.948 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 1219
2017-08-28T18:41:40.995Z,1503945700.995 [PNI_TCM] Loaded
2017-08-28T18:41:40.995Z,1503945700.995 [ComponentRegistry](DEBUG): SyncComponent "PNI_TCM" handled in the control thread.
2017-08-28T18:41:42.765Z,1503945702.765 [BPC1] Loaded
2017-08-28T18:41:42.765Z,1503945702.765 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2017-08-28T18:41:42.766Z,1503945702.766 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2017-08-28T18:41:42.766Z,1503945702.766 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2017-08-28T18:41:42.859Z,1503945702.859 [BuoyancyServo] Loaded
2017-08-28T18:41:42.859Z,1503945702.859 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2017-08-28T18:41:42.871Z,1503945702.871 [ElevatorServo] Loaded
2017-08-28T18:41:42.872Z,1503945702.872 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2017-08-28T18:41:42.883Z,1503945702.883 [MassServo] Loaded
2017-08-28T18:41:42.884Z,1503945702.884 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2017-08-28T18:41:42.896Z,1503945702.896 [RudderServo] Loaded
2017-08-28T18:41:42.896Z,1503945702.896 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2017-08-28T18:41:42.908Z,1503945702.908 [ThrusterServo] Loaded
2017-08-28T18:41:42.908Z,1503945702.908 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread.
2017-08-28T18:41:42.909Z,1503945702.909 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2017-08-28T18:41:42.909Z,1503945702.909 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2017-08-28T18:41:43.003Z,1503945703.003 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2017-08-28T18:41:43.004Z,1503945703.004 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2017-08-28T18:41:43.028Z,1503945703.028 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2017-08-28T18:41:43.032Z,1503945703.032 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2017-08-28T18:41:43.032Z,1503945703.032 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2017-08-28T18:41:43.040Z,1503945703.040 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2017-08-28T18:41:43.041Z,1503945703.041 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40AD64E0
2017-08-28T18:41:43.041Z,1503945703.041 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 1220
2017-08-28T18:41:43.046Z,1503945703.046 [Supervisor](INFO): Main Thread ID is 764
2017-08-28T18:41:43.046Z,1503945703.046 [Supervisor](DEBUG): Running supervisor.
2017-08-28T18:41:43.046Z,1503945703.046 [CommandLine ThreadHandler](INFO): Handler Thread ID is 1221
2017-08-28T18:41:43.049Z,1503945703.049 [controlThread ThreadHandler](INFO): Handler Thread ID is 1222
2017-08-28T18:41:43.050Z,1503945703.050 [controlThread](DEBUG): Initializing ControlThread
2017-08-28T18:41:43.051Z,1503945703.051 [SBIT](INFO): Initialize SBIT Component.
2017-08-28T18:41:43.051Z,1503945703.051 [SBIT](IMPORTANT): git: 2017-08-02
2017-08-28T18:41:43.051Z,1503945703.051 [SBIT](INFO): git hash: b8bd19726fcc84d3133bb9e1cbad184cc93bb52c
2017-08-28T18:41:43.053Z,1503945703.053 [SBIT](INFO): Kernel Reporting Different Release From Configuration.
Kernel Expected: 2.6.27.8
Kernel Reported: 2.6.27.8-00011-g2bc81df-dirty
2017-08-28T18:41:43.053Z,1503945703.053 [SBIT](INFO): Kernel Reporting Different Version From Configuration.
Kernel Expected: #639 PREEMPT Wed Mar 12 12:53:33 PDT 2014
Kernel Reported: #646 PREEMPT Thu Feb 11 17:01:12 PST 2016
2017-08-28T18:41:43.054Z,1503945703.054 [SBIT](INFO): Beginning SBIT in 71.000000 seconds.
2017-08-28T18:41:43.055Z,1503945703.055 [IBIT](INFO): Initialize IBIT Component.
2017-08-28T18:41:43.056Z,1503945703.056 [CBIT](DEBUG): Initialize CBIT Component.
2017-08-28T18:41:43.056Z,1503945703.056 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2017-08-28T18:41:43.057Z,1503945703.057 [logger ThreadHandler](INFO): Handler Thread ID is 1223
2017-08-28T18:41:43.085Z,1503945703.085 [CTD_NeilBrown ThreadHandler](INFO): Handler Thread ID is 1224
2017-08-28T18:41:43.086Z,1503945703.086 [CTD_NeilBrown](INFO): Powering down
2017-08-28T18:41:43.119Z,1503945703.119 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 1225
2017-08-28T18:41:43.119Z,1503945703.119 [CTD_Seabird](INFO): Initializing
2017-08-28T18:41:43.153Z,1503945703.153 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2017-08-28T18:41:43.156Z,1503945703.156 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2017-08-28T18:41:43.157Z,1503945703.157 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2017-08-28T18:41:43.157Z,1503945703.157 [BackSeatDriver](DEBUG): Initialize BackSeatDriver Component.
2017-08-28T18:41:43.182Z,1503945703.182 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 1228
2017-08-28T18:41:43.183Z,1503945703.183 [WetLabsBB2FL](INFO): Powering down
2017-08-28T18:41:43.216Z,1503945703.216 [LoopControl](DEBUG): Initialize LoopControlComponent.
2017-08-28T18:41:43.217Z,1503945703.217 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2017-08-28T18:41:43.234Z,1503945703.234 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 1229
2017-08-28T18:41:43.240Z,1503945703.240 [Radio_Surface](INFO): Powering up
2017-08-28T18:41:43.241Z,1503945703.241 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2017-08-28T18:41:43.241Z,1503945703.241 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2017-08-28T18:41:43.242Z,1503945703.242 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator.
2017-08-28T18:41:43.242Z,1503945703.242 [VerticalTemperatureHomogeneityIndexCalculator](DEBUG): (re)initializing
2017-08-28T18:41:43.243Z,1503945703.243 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2017-08-28T18:41:43.244Z,1503945703.244 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2017-08-28T18:41:43.246Z,1503945703.246 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2017-08-28T18:41:43.246Z,1503945703.246 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2017-08-28T18:41:43.246Z,1503945703.246 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2017-08-28T18:41:43.247Z,1503945703.247 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2017-08-28T18:41:43.247Z,1503945703.247 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2017-08-28T18:41:43.248Z,1503945703.248 [NavChart](DEBUG): Initialize NavChart Navigation.
2017-08-28T18:41:43.248Z,1503945703.248 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2017-08-28T18:41:43.250Z,1503945703.250 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 1230
2017-08-28T18:41:43.253Z,1503945703.253 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2017-08-28T18:41:43.253Z,1503945703.253 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2017-08-28T18:41:43.254Z,1503945703.254 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2017-08-28T18:41:43.254Z,1503945703.254 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2017-08-28T18:41:43.254Z,1503945703.254 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2017-08-28T18:41:43.254Z,1503945703.254 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2017-08-28T18:41:43.254Z,1503945703.254 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000
2017-08-28T18:41:43.255Z,1503945703.255 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000
2017-08-28T18:41:43.255Z,1503945703.255 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2017-08-28T18:41:43.255Z,1503945703.255 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2017-08-28T18:41:43.255Z,1503945703.255 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000
2017-08-28T18:41:43.255Z,1503945703.255 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000
2017-08-28T18:41:43.256Z,1503945703.256 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000
2017-08-28T18:41:43.256Z,1503945703.256 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000
2017-08-28T18:41:43.256Z,1503945703.256 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000
2017-08-28T18:41:43.256Z,1503945703.256 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000
2017-08-28T18:41:43.328Z,1503945703.328 [MissionManager](INFO): Loading Mission: Missions/Startup.xml
2017-08-28T18:41:43.374Z,1503945703.374 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2017-08-28T18:41:43.409Z,1503945703.409 [MissionManager](DEBUG): 
<?xml version="1.0" encoding="UTF-8"?>
<Mission xmlns="Tethys"
       xmlns:Control="Tethys/Control"
       xmlns:Guidance="Tethys/Guidance" 
       xmlns:Units="Tethys/Units"
       xmlns:Universal="Tethys/Universal"
       xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"
       xsi:schemaLocation="Tethys http://okeanids.mbari.org/tethys/Xml/Tethys.xsd
                           Tethys/Control http://okeanids.mbari.org/tethys/Xml/Control.xsd
                           Tethys/Guidance http://okeanids.mbari.org/tethys/Xml/Guidance.xsd
                           Tethys/Units http://okeanids.mbari.org/tethys/Xml/Units.xsd
                           Tethys/Universal http://okeanids.mbari.org/tethys/Xml/Universal.xsd"
       Id="Startup">

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

    <Aggregate Id="StartupSatComms">

        <Sequence/>

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

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

    </Aggregate>

</Mission>


2017-08-28T18:41:43.433Z,1503945703.433 [MissionManager](INFO): Loading Mission: Missions/Default.xml
2017-08-28T18:41:43.440Z,1503945703.440 [CTD_Seabird](INFO): Stopping potential previous instance(s) of CTD_Seabird LCM interface
2017-08-28T18:41:43.440Z,1503945703.440 [CTD_Seabird](INFO): Powering down
2017-08-28T18:41:43.516Z,1503945703.516 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2017-08-28T18:41:43.517Z,1503945703.517 [Default:A.Wait](DEBUG): Construct Wait.
2017-08-28T18:41:43.518Z,1503945703.518 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2017-08-28T18:41:43.560Z,1503945703.560 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2017-08-28T18:41:43.580Z,1503945703.580 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2017-08-28T18:41:43.585Z,1503945703.585 [Default:E.Execute](DEBUG): Construct Execute.
2017-08-28T18:41:43.605Z,1503945703.605 [MissionManager](DEBUG): 
<?xml version="1.0" encoding="UTF-8"?>
<Mission xmlns="Tethys"
xmlns:Guidance="Tethys/Guidance"
xmlns:Units="Tethys/Units"
xmlns:Universal="Tethys/Universal"
xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"
xsi:schemaLocation="Tethys http://okeanids.mbari.org/tethys/Xml/Tethys.xsd
Tethys/Guidance http://okeanids.mbari.org/tethys/Xml/Guidance.xsd
Tethys/Units http://okeanids.mbari.org/tethys/Xml/Units.xsd
Tethys/Universal http://okeanids.mbari.org/tethys/Xml/Universal.xsd"
Id="Default">

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

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

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

    <Aggregate Id="CheckIn">

        <Sequence Repeat="288"/>

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

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

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

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

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

    </Aggregate>

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

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

</Mission>


2017-08-28T18:41:43.630Z,1503945703.630 [controlThread](DEBUG): Component order: CycleStarter,Aanderaa_O2,CANONSampler,PAR_Licor,DataOverHttps,Depth_Keller,DropWeight,NAL9602,Onboard,PNI_TCM,BPC1,PAR_Licor,Depth_Keller,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,VerticalTemperatureHomogeneityIndexCalculator,YawRateCalculator,StratificationFrontDetector,DeadReckonUsingMultipleVelocitySources,DeadReckonUsingSpeedCalculator,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,BackSeatDriver,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter,
2017-08-28T18:41:43.669Z,1503945703.669 [CANONSampler](INFO): Powering down
2017-08-28T18:41:43.895Z,1503945703.895 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2017-08-28T18:41:44.291Z,1503945704.291 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-08-28T18:41:44.319Z,1503945704.319 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-08-28T18:41:44.530Z,1503945704.530 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2017-08-28T18:41:44.536Z,1503945704.536 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2017-08-28T18:41:44.542Z,1503945704.542 [ElevatorServo](DEBUG): Initializing EZServoServo.
2017-08-28T18:41:44.548Z,1503945704.548 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2017-08-28T18:41:44.553Z,1503945704.553 [MassServo](DEBUG): Initializing EZServoServo.
2017-08-28T18:41:44.560Z,1503945704.560 [MassServo](DEBUG): Initializing MassServo.
2017-08-28T18:41:44.565Z,1503945704.565 [RudderServo](DEBUG): Initializing EZServoServo.
2017-08-28T18:41:44.572Z,1503945704.572 [RudderServo](DEBUG): Initializing RudderServo.
2017-08-28T18:41:44.593Z,1503945704.593 [ThrusterServo](DEBUG): Initializing EZServoServo.
2017-08-28T18:41:44.600Z,1503945704.600 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2017-08-28T18:41:44.820Z,1503945704.820 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-08-28T18:41:44.821Z,1503945704.821 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-08-28T18:41:45.096Z,1503945705.096 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-08-28T18:41:45.108Z,1503945705.108 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-08-28T18:41:45.644Z,1503945705.644 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-08-28T18:41:45.649Z,1503945705.649 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-08-28T18:41:45.979Z,1503945705.979 [NAL9602](INFO): Powering up NAL9602
2017-08-28T18:41:46.029Z,1503945706.029 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-08-28T18:41:46.046Z,1503945706.046 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-08-28T18:41:46.402Z,1503945706.402 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-08-28T18:41:46.410Z,1503945706.410 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-08-28T18:41:46.887Z,1503945706.887 [Aanderaa_O2](INFO): Powering down
2017-08-28T18:41:46.991Z,1503945706.991 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-08-28T18:41:46.999Z,1503945706.999 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-08-28T18:41:47.305Z,1503945707.305 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-08-28T18:41:47.306Z,1503945707.306 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-08-28T18:41:57.009Z,1503945717.009 [NAL9602](INFO): NAL9602 initialized
2017-08-28T18:41:59.885Z,1503945719.885 [BPC1](ERROR): Failed to receive battery data
2017-08-28T18:41:59.885Z,1503945719.885 [BPC1] Communications Fault, FailCount= 1
2017-08-28T18:41:59.885Z,1503945719.885 [BPC1](ERROR): Communications Fault
2017-08-28T18:42:00.057Z,1503945720.057 [CBIT](ERROR): Communications Fault in component: BPC1
2017-08-28T18:42:01.202Z,1503945721.202 [CBIT](INFO): Clearing failed state for component BPC1
2017-08-28T18:42:01.202Z,1503945721.202 [BPC1] No Fault, FailCount= 1
2017-08-28T18:42:17.044Z,1503945737.044 [BPC1](ERROR): Failed to receive battery data
2017-08-28T18:42:17.044Z,1503945737.044 [BPC1] Communications Fault, FailCount= 2
2017-08-28T18:42:17.044Z,1503945737.044 [BPC1](ERROR): Communications Fault
2017-08-28T18:42:17.213Z,1503945737.213 [CBIT](ERROR): Communications Fault in component: BPC1
2017-08-28T18:42:18.414Z,1503945738.414 [CBIT](INFO): Clearing failed state for component BPC1
2017-08-28T18:42:18.414Z,1503945738.414 [BPC1] No Fault, FailCount= 2
2017-08-28T18:42:21.008Z,1503945741.008 [NAL9602](INFO): SBD MO Status=0, MOMSN=98, MT Status=0, MTMSN=0
2017-08-28T18:42:21.008Z,1503945741.008 [NAL9602](INFO): No messages in MT queue
2017-08-28T18:42:25.414Z,1503945745.414 [NAL9602](INFO): GPS fix at 20170828T184223: (36.802337, -121.787147)
2017-08-28T18:42:32.609Z,1503945752.609 [NAL9602](INFO): Powering down
2017-08-28T18:42:34.633Z,1503945754.633 [BPC1](ERROR): Failed to receive battery data
2017-08-28T18:42:34.633Z,1503945754.633 [BPC1] Communications Fault, FailCount= 3
2017-08-28T18:42:34.633Z,1503945754.633 [BPC1](ERROR): Communications Fault
2017-08-28T18:42:34.793Z,1503945754.793 [CBIT](ERROR): Communications Fault in component: BPC1
2017-08-28T18:42:36.007Z,1503945756.007 [CBIT](INFO): Clearing failed state for component BPC1
2017-08-28T18:42:36.007Z,1503945756.007 [BPC1] No Fault, FailCount= 3
2017-08-28T18:42:51.834Z,1503945771.834 [BPC1](ERROR): Failed to receive battery data
2017-08-28T18:42:51.834Z,1503945771.834 [BPC1] Communications Fault, FailCount= 4
2017-08-28T18:42:51.834Z,1503945771.834 [BPC1](ERROR): Communications Fault
2017-08-28T18:42:51.988Z,1503945771.988 [CBIT](ERROR): Communications Fault in component: BPC1
2017-08-28T18:42:53.186Z,1503945773.186 [CBIT](INFO): Clearing failed state for component BPC1
2017-08-28T18:42:53.186Z,1503945773.186 [BPC1] No Fault, FailCount= 4
2017-08-28T18:42:54.750Z,1503945774.750 [SBIT](IMPORTANT): Beginning Startup BIT
2017-08-28T18:42:54.763Z,1503945774.763 [CBIT](IMPORTANT): Beginning ground fault scan
2017-08-28T18:43:05.000Z,1503945785.000 [CBIT](IMPORTANT): Ground fault detected
mA:
CHAN A0 (Batt): 4.657929
CHAN A1 (24V): 0.027541
CHAN A2 (12V): 4.697929
CHAN A3 (5V): -0.011120
CHAN B0 (3.3V): 4.766929
CHAN B1 (3.15aV): 0.002447
CHAN B2 (3.15bV): 4.767929
CHAN B3 (GND): 0.027670
OPEN: -0.000141
Full Scale Calc: 4.765 mA, -1.589 mA
2017-08-28T18:43:48.434Z,1503945828.434 [SBIT](IMPORTANT): SBIT PASSED
2017-08-28T18:43:48.677Z,1503945828.677 [MissionManager](IMPORTANT): Started mission Startup
2017-08-28T18:43:48.677Z,1503945828.677 [Startup] Running Loop=1
2017-08-28T18:43:48.677Z,1503945828.677 [Startup](DEBUG): Aggregate::initialize Startup
2017-08-28T18:43:48.677Z,1503945828.677 [Startup:A.GoToSurface] Running Loop=1
2017-08-28T18:43:48.677Z,1503945828.677 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2017-08-28T18:43:48.678Z,1503945828.678 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2017-08-28T18:43:48.678Z,1503945828.678 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2017-08-28T18:43:48.679Z,1503945828.679 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2017-08-28T18:43:48.679Z,1503945828.679 [Startup:A.GoToSurface](DEBUG): No pitch timeout specified. Using default value of 20.000000 seconds.
2017-08-28T18:43:48.680Z,1503945828.680 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2017-08-28T18:43:48.686Z,1503945828.686 [Startup:StartupSatComms] Running Loop=1
2017-08-28T18:43:48.686Z,1503945828.686 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2017-08-28T18:43:48.686Z,1503945828.686 [Startup:StartupSatComms:A] Running Loop=1
2017-08-28T18:43:49.121Z,1503945829.121 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2017-08-28T18:43:49.434Z,1503945829.434 [NAL9602](INFO): Powering up
2017-08-28T18:44:00.632Z,1503945840.632 [NAL9602](INFO): NAL9602 initialized
2017-08-28T18:44:13.033Z,1503945853.033 [NAL9602](INFO): SBD MO Status=0, MOMSN=99, MT Status=0, MTMSN=0
2017-08-28T18:44:13.033Z,1503945853.033 [NAL9602](INFO): No messages in MT queue
2017-08-28T18:44:26.633Z,1503945866.633 [NAL9602](INFO): GPS fix at 20170828T184424: (36.802339, -121.787149)
2017-08-28T18:44:26.701Z,1503945866.701 [Startup:StartupSatComms:A] Stopped
2017-08-28T18:44:26.701Z,1503945866.701 [Startup:StartupSatComms:B] Running Loop=1
2017-08-28T18:44:27.089Z,1503945867.089 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2017-08-28T18:44:30.276Z,1503945870.276 [BPC1](ERROR): Failed to parse bank A battery data
2017-08-28T18:44:30.276Z,1503945870.276 [BPC1] Data Fault, FailCount= 1
2017-08-28T18:44:30.276Z,1503945870.276 [BPC1](ERROR): Data Fault
2017-08-28T18:44:30.432Z,1503945870.432 [CBIT](ERROR): Data Fault in component: BPC1
2017-08-28T18:44:31.634Z,1503945871.634 [CBIT](INFO): Clearing failed state for component BPC1
2017-08-28T18:44:31.634Z,1503945871.634 [BPC1] No Fault, FailCount= 1
2017-08-28T18:44:52.070Z,1503945892.070 [NAL9602](INFO): SBD MO Status=1, MOMSN=100, MT Status=0, MTMSN=0
2017-08-28T18:44:52.120Z,1503945892.120 [NAL9602](INFO): Sent 25 bytes from file Logs/20170828T180003/Courier0028.lzma
2017-08-28T18:44:52.121Z,1503945892.121 [NAL9602](INFO): Packets left to send: 0
2017-08-28T18:44:52.122Z,1503945892.122 [NAL9602](DEBUG): Stored copy of sent data in Logs/20170828T180003/Courier0028.lzma.parts/0000.sbd
2017-08-28T18:44:52.123Z,1503945892.123 [NAL9602](DEBUG): Completed sending Logs/20170828T180003/Courier0028.lzma
2017-08-28T18:45:07.486Z,1503945907.486 [NAL9602](INFO): SBD MO Status=1, MOMSN=101, MT Status=0, MTMSN=0
2017-08-28T18:45:07.535Z,1503945907.535 [NAL9602](INFO): Sent 215 bytes from file Logs/20170828T184133/Courier0000.lzma
2017-08-28T18:45:07.535Z,1503945907.535 [NAL9602](INFO): Packets left to send: 0
2017-08-28T18:45:07.536Z,1503945907.536 [NAL9602](DEBUG): Stored copy of sent data in Logs/20170828T184133/Courier0000.lzma.parts/0000.sbd
2017-08-28T18:45:07.537Z,1503945907.537 [NAL9602](DEBUG): Completed sending Logs/20170828T184133/Courier0000.lzma
2017-08-28T18:45:16.505Z,1503945916.505 [BPC1](ERROR): Failed to receive battery data
2017-08-28T18:45:16.505Z,1503945916.505 [BPC1] Communications Fault, FailCount= 1
2017-08-28T18:45:16.505Z,1503945916.505 [BPC1](ERROR): Communications Fault
2017-08-28T18:45:16.657Z,1503945916.657 [CBIT](ERROR): Communications Fault in component: BPC1
2017-08-28T18:45:17.846Z,1503945917.846 [CBIT](INFO): Clearing failed state for component BPC1
2017-08-28T18:45:17.846Z,1503945917.846 [BPC1] No Fault, FailCount= 1
2017-08-28T18:45:18.079Z,1503945918.079 [NAL9602](INFO): SBD MO Status=1, MOMSN=102, MT Status=0, MTMSN=0
2017-08-28T18:45:18.129Z,1503945918.129 [NAL9602](INFO): Sent 195 bytes from file Logs/20170828T180003/Express0029.lzma
2017-08-28T18:45:18.129Z,1503945918.129 [NAL9602](INFO): Packets left to send: 0
2017-08-28T18:45:18.131Z,1503945918.131 [NAL9602](DEBUG): Stored copy of sent data in Logs/20170828T180003/Express0029.lzma.parts/0000.sbd
2017-08-28T18:45:18.131Z,1503945918.131 [NAL9602](DEBUG): Completed sending Logs/20170828T180003/Express0029.lzma
2017-08-28T18:45:26.744Z,1503945926.744 [Startup:StartupSatComms:B](INFO): Timed out from 2017-08-28T18:44:26.7Z
2017-08-28T18:45:26.744Z,1503945926.744 [Startup:StartupSatComms:B] Stopped
2017-08-28T18:45:26.744Z,1503945926.744 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2017-08-28T18:45:26.744Z,1503945926.744 [Startup:StartupSatComms] Stopped
2017-08-28T18:45:26.744Z,1503945926.744 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2017-08-28T18:45:26.745Z,1503945926.745 [Startup](INFO): Completed Startup
2017-08-28T18:45:26.745Z,1503945926.745 [MissionManager](INFO): Startup is completed.
2017-08-28T18:45:26.745Z,1503945926.745 [MissionManager](INFO): Uninitializing Mission Startup
2017-08-28T18:45:26.745Z,1503945926.745 [Startup] Stopped
2017-08-28T18:45:26.746Z,1503945926.746 [Startup](DEBUG): Aggregate::uninitialize Startup
2017-08-28T18:45:26.746Z,1503945926.746 [Startup:A.GoToSurface] Stopped
2017-08-28T18:45:26.746Z,1503945926.746 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2017-08-28T18:45:27.144Z,1503945927.144 [MissionManager](IMPORTANT): Started mission Default
2017-08-28T18:45:27.145Z,1503945927.145 [Default] Running Loop=1
2017-08-28T18:45:27.145Z,1503945927.145 [Default](DEBUG): Aggregate::initialize Default
2017-08-28T18:45:27.145Z,1503945927.145 [Default:B.GoToSurface] Running Loop=1
2017-08-28T18:45:27.145Z,1503945927.145 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2017-08-28T18:45:27.145Z,1503945927.145 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2017-08-28T18:45:27.145Z,1503945927.145 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2017-08-28T18:45:27.146Z,1503945927.146 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2017-08-28T18:45:27.146Z,1503945927.146 [Default:B.GoToSurface](DEBUG): No pitch timeout specified. Using default value of 20.000000 seconds.
2017-08-28T18:45:27.146Z,1503945927.146 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2017-08-28T18:45:27.147Z,1503945927.147 [Default:A.Wait] Running Loop=1
2017-08-28T18:45:27.147Z,1503945927.147 [Default:A.Wait](DEBUG): Initialize Wait Component.
2017-08-28T18:45:31.089Z,1503945931.089 [NAL9602](INFO): SBD MO Status=1, MOMSN=103, MT Status=0, MTMSN=0
2017-08-28T18:45:31.134Z,1503945931.134 [NAL9602](INFO): Sent 332 bytes from file Logs/20170828T184133/Express0001.lzma
2017-08-28T18:45:31.134Z,1503945931.134 [NAL9602](INFO): Packets left to send: 1
2017-08-28T18:45:31.136Z,1503945931.136 [NAL9602](DEBUG): Stored copy of sent data in Logs/20170828T184133/Express0001.lzma.parts/0001.sbd
2017-08-28T18:45:36.687Z,1503945936.687 [NAL9602](INFO): Powering down
2017-08-28T18:45:40.328Z,1503945940.328 [Default:A.Wait](INFO): Done Waiting.
2017-08-28T18:45:40.328Z,1503945940.328 [Default:A.Wait] Stopped
2017-08-28T18:45:40.329Z,1503945940.329 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2017-08-28T18:45:40.734Z,1503945940.734 [Default:CheckIn] Running Loop=1
2017-08-28T18:45:40.734Z,1503945940.734 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2017-08-28T18:45:40.734Z,1503945940.734 [Default:CheckIn:Read_GPS] Running Loop=1
2017-08-28T18:45:41.142Z,1503945941.142 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2017-08-28T18:45:41.491Z,1503945941.491 [NAL9602](INFO): Powering up
2017-08-28T18:45:44.322Z,1503945944.322 [BPC1](ERROR): Failed to parse bank A battery data
2017-08-28T18:45:44.322Z,1503945944.322 [BPC1] Data Fault, FailCount= 1
2017-08-28T18:45:44.322Z,1503945944.322 [BPC1](ERROR): Data Fault
2017-08-28T18:45:44.445Z,1503945944.445 [CBIT](ERROR): Data Fault in component: BPC1
2017-08-28T18:45:45.650Z,1503945945.650 [CBIT](INFO): Clearing failed state for component BPC1
2017-08-28T18:45:45.651Z,1503945945.651 [BPC1] No Fault, FailCount= 1
2017-08-28T18:45:52.687Z,1503945952.687 [NAL9602](INFO): NAL9602 initialized
2017-08-28T18:46:08.692Z,1503945968.692 [NAL9602](INFO): SBD MO Status=0, MOMSN=104, MT Status=0, MTMSN=0
2017-08-28T18:46:08.692Z,1503945968.692 [NAL9602](INFO): No messages in MT queue
2017-08-28T18:46:27.124Z,1503945987.124 [NAL9602](INFO): GPS fix at 20170828T184624: (36.802362, -121.787109)
2017-08-28T18:46:27.161Z,1503945987.161 [Default:CheckIn:Read_GPS] Stopped
2017-08-28T18:46:27.161Z,1503945987.161 [Default:CheckIn:Read_Iridium] Running Loop=1
2017-08-28T18:46:27.548Z,1503945987.548 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications
2017-08-28T18:46:52.145Z,1503946012.145 [NAL9602](INFO): SBD MO Status=1, MOMSN=105, MT Status=0, MTMSN=0
2017-08-28T18:46:52.198Z,1503946012.198 [NAL9602](INFO): Sent 63 bytes from file Logs/20170828T184133/Courier0004.lzma
2017-08-28T18:46:52.198Z,1503946012.198 [NAL9602](INFO): Packets left to send: 0
2017-08-28T18:46:52.200Z,1503946012.200 [NAL9602](DEBUG): Stored copy of sent data in Logs/20170828T184133/Courier0004.lzma.parts/0000.sbd
2017-08-28T18:46:52.200Z,1503946012.200 [NAL9602](DEBUG): Completed sending Logs/20170828T184133/Courier0004.lzma
2017-08-28T18:47:11.174Z,1503946031.174 [NAL9602](INFO): SBD MO Status=2, MOMSN=106, MT Status=2, MTMSN=0
2017-08-28T18:47:11.175Z,1503946031.175 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2017-08-28T18:47:31.395Z,1503946051.395 [NAL9602](INFO): SBD MO Status=1, MOMSN=106, MT Status=0, MTMSN=0
2017-08-28T18:47:31.461Z,1503946051.461 [NAL9602](INFO): Sent 257 bytes from file Logs/20170828T184133/Express0001.lzma
2017-08-28T18:47:31.461Z,1503946051.461 [NAL9602](INFO): Packets left to send: 0
2017-08-28T18:47:31.463Z,1503946051.463 [NAL9602](DEBUG): Stored copy of sent data in Logs/20170828T184133/Express0001.lzma.parts/0000.sbd
2017-08-28T18:47:31.463Z,1503946051.463 [NAL9602](DEBUG): Completed sending Logs/20170828T184133/Express0001.lzma
2017-08-28T18:47:43.173Z,1503946063.173 [NAL9602](INFO): SBD MO Status=1, MOMSN=107, MT Status=0, MTMSN=0
2017-08-28T18:47:43.231Z,1503946063.231 [NAL9602](INFO): Sent 95 bytes from file Logs/20170828T184133/Express0005.lzma
2017-08-28T18:47:43.231Z,1503946063.231 [NAL9602](INFO): Packets left to send: 0
2017-08-28T18:47:43.232Z,1503946063.232 [NAL9602](DEBUG): Stored copy of sent data in Logs/20170828T184133/Express0005.lzma.parts/0000.sbd
2017-08-28T18:47:43.233Z,1503946063.233 [NAL9602](DEBUG): Completed sending Logs/20170828T184133/Express0005.lzma
2017-08-28T18:47:51.176Z,1503946071.176 [NAL9602](INFO): SBD MO Status=0, MOMSN=108, MT Status=0, MTMSN=0
2017-08-28T18:47:51.290Z,1503946071.290 [Default:CheckIn:Read_Iridium] Stopped
2017-08-28T18:47:51.291Z,1503946071.291 [Default:CheckIn:C.Wait] Running Loop=1
2017-08-28T18:47:51.291Z,1503946071.291 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2017-08-28T18:47:56.771Z,1503946076.771 [NAL9602](INFO): Powering down
2017-08-28T18:48:34.801Z,1503946114.801 [BPC1](ERROR): Failed to parse bank B battery data
2017-08-28T18:48:34.801Z,1503946114.801 [BPC1] Data Fault, FailCount= 1
2017-08-28T18:48:34.801Z,1503946114.801 [BPC1](ERROR): Data Fault
2017-08-28T18:48:34.952Z,1503946114.952 [CBIT](ERROR): Data Fault in component: BPC1
2017-08-28T18:48:36.132Z,1503946116.132 [CBIT](INFO): Clearing failed state for component BPC1
2017-08-28T18:48:36.132Z,1503946116.132 [BPC1] No Fault, FailCount= 1
2017-08-28T18:49:06.400Z,1503946146.400 [BPC1](ERROR): Failed to receive battery data
2017-08-28T18:49:06.400Z,1503946146.400 [BPC1] Communications Fault, FailCount= 1
2017-08-28T18:49:06.400Z,1503946146.400 [BPC1](ERROR): Communications Fault
2017-08-28T18:49:06.544Z,1503946146.544 [CBIT](ERROR): Communications Fault in component: BPC1
2017-08-28T18:49:07.754Z,1503946147.754 [CBIT](INFO): Clearing failed state for component BPC1
2017-08-28T18:49:07.754Z,1503946147.754 [BPC1] No Fault, FailCount= 1
2017-08-28T18:49:32.407Z,1503946172.407 [BPC1](ERROR): Failed to parse message.
2017-08-28T18:49:32.407Z,1503946172.407 [BPC1](ERROR): Failed to parse bank A battery data
2017-08-28T18:49:32.407Z,1503946172.407 [BPC1] Data Fault, FailCount= 1
2017-08-28T18:49:32.408Z,1503946172.408 [BPC1](ERROR): Data Fault
2017-08-28T18:49:32.585Z,1503946172.585 [CBIT](ERROR): Data Fault in component: BPC1
2017-08-28T18:49:33.761Z,1503946173.761 [CBIT](INFO): Clearing failed state for component BPC1
2017-08-28T18:49:33.761Z,1503946173.761 [BPC1] No Fault, FailCount= 1
2017-08-28T18:50:04.385Z,1503946204.385 [BPC1](ERROR): Failed to receive battery data
2017-08-28T18:50:04.385Z,1503946204.385 [BPC1] Communications Fault, FailCount= 1
2017-08-28T18:50:04.386Z,1503946204.386 [BPC1](ERROR): Communications Fault
2017-08-28T18:50:04.524Z,1503946204.524 [CBIT](ERROR): Communications Fault in component: BPC1
2017-08-28T18:50:05.754Z,1503946205.754 [CBIT](INFO): Clearing failed state for component BPC1
2017-08-28T18:50:05.754Z,1503946205.754 [BPC1] No Fault, FailCount= 1
2017-08-28T18:50:22.007Z,1503946222.007 [BPC1](ERROR): Failed to receive battery data
2017-08-28T18:50:22.007Z,1503946222.007 [BPC1] Communications Fault, FailCount= 2
2017-08-28T18:50:22.007Z,1503946222.007 [BPC1](ERROR): Communications Fault
2017-08-28T18:50:22.200Z,1503946222.200 [CBIT](ERROR): Communications Fault in component: BPC1
2017-08-28T18:50:23.333Z,1503946223.333 [CBIT](INFO): Clearing failed state for component BPC1
2017-08-28T18:50:23.333Z,1503946223.333 [BPC1] No Fault, FailCount= 2
2017-08-28T18:50:34.395Z,1503946234.395 [BPC1](ERROR): Failed to parse message.
2017-08-28T18:50:34.395Z,1503946234.395 [BPC1](ERROR): Failed to parse bank A battery data
2017-08-28T18:50:34.395Z,1503946234.395 [BPC1] Data Fault, FailCount= 3
2017-08-28T18:50:34.395Z,1503946234.395 [BPC1](ERROR): Data Fault
2017-08-28T18:50:34.569Z,1503946234.569 [CBIT](ERROR): Data Fault in component: BPC1
2017-08-28T18:50:35.737Z,1503946235.737 [CBIT](INFO): Clearing failed state for component BPC1
2017-08-28T18:50:35.737Z,1503946235.737 [BPC1] No Fault, FailCount= 3
2017-08-28T18:50:52.004Z,1503946252.004 [BPC1](ERROR): Failed to receive battery data
2017-08-28T18:50:52.004Z,1503946252.004 [BPC1] Communications Fault, FailCount= 4
2017-08-28T18:50:52.004Z,1503946252.004 [BPC1](ERROR): Communications Fault
2017-08-28T18:50:52.127Z,1503946252.127 [CBIT](ERROR): Communications Fault in component: BPC1
2017-08-28T18:50:53.374Z,1503946253.374 [CBIT](INFO): Clearing failed state for component BPC1
2017-08-28T18:50:53.375Z,1503946253.375 [BPC1] No Fault, FailCount= 4
2017-08-28T18:51:09.210Z,1503946269.210 [BPC1](ERROR): Failed to receive battery data
2017-08-28T18:51:09.210Z,1503946269.210 [BPC1] Communications Fault, FailCount= 5
2017-08-28T18:51:09.211Z,1503946269.211 [BPC1](ERROR): Communications Fault
2017-08-28T18:51:09.342Z,1503946269.342 [CBIT](ERROR): Communications Fault in component: BPC1
2017-08-28T18:51:10.544Z,1503946270.544 [CBIT](INFO): Clearing failed state for component BPC1
2017-08-28T18:51:10.544Z,1503946270.544 [BPC1] No Fault, FailCount= 5
2017-08-28T18:51:26.800Z,1503946286.800 [BPC1](ERROR): Failed to receive battery data
2017-08-28T18:51:26.800Z,1503946286.800 [BPC1] Communications Fault, FailCount= 6
2017-08-28T18:51:26.800Z,1503946286.800 [BPC1](ERROR): Communications Fault
2017-08-28T18:51:26.966Z,1503946286.966 [CBIT](ERROR): Communications Fault in component: BPC1
2017-08-28T18:51:28.128Z,1503946288.128 [CBIT](INFO): Clearing failed state for component BPC1
2017-08-28T18:51:28.128Z,1503946288.128 [BPC1] No Fault, FailCount= 6
2017-08-28T18:51:43.336Z,1503946303.336 [CBIT](DEBUG): EFC running - data check-sum false
2017-08-28T18:51:48.001Z,1503946308.001 [BPC1](ERROR): Failed to receive battery data
2017-08-28T18:51:48.001Z,1503946308.001 [BPC1] Communications Fault, FailCount= 7
2017-08-28T18:51:48.001Z,1503946308.001 [BPC1](ERROR): Communications Fault
2017-08-28T18:51:48.123Z,1503946308.123 [CBIT](ERROR): Communications Fault in component: BPC1
2017-08-28T18:51:49.353Z,1503946309.353 [CBIT](INFO): Clearing failed state for component BPC1
2017-08-28T18:51:49.353Z,1503946309.353 [BPC1] No Fault, FailCount= 7
2017-08-28T18:52:05.604Z,1503946325.604 [BPC1](ERROR): Failed to receive battery data
2017-08-28T18:52:05.604Z,1503946325.604 [BPC1] Communications Fault, FailCount= 8
2017-08-28T18:52:05.604Z,1503946325.604 [BPC1](ERROR): Communications Fault
2017-08-28T18:52:05.727Z,1503946325.727 [CBIT](ERROR): Communications Fault in component: BPC1
2017-08-28T18:52:06.929Z,1503946326.929 [CBIT](INFO): Clearing failed state for component BPC1
2017-08-28T18:52:06.929Z,1503946326.929 [BPC1] No Fault, FailCount= 8
2017-08-28T18:52:22.793Z,1503946342.793 [BPC1](ERROR): Failed to receive battery data
2017-08-28T18:52:22.794Z,1503946342.794 [BPC1] Communications Fault, FailCount= 9
2017-08-28T18:52:22.794Z,1503946342.794 [BPC1](ERROR): Communications Fault
2017-08-28T18:52:22.955Z,1503946342.955 [CBIT](ERROR): Communications Fault in component: BPC1
2017-08-28T18:52:24.160Z,1503946344.160 [CBIT](INFO): Clearing failed state for component BPC1
2017-08-28T18:52:24.161Z,1503946344.161 [BPC1] No Fault, FailCount= 9
2017-08-28T18:52:51.617Z,1503946371.617 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2017-08-28T18:52:51.617Z,1503946371.617 [Default:CheckIn:C.Wait] Stopped
2017-08-28T18:52:51.617Z,1503946371.617 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2017-08-28T18:52:51.617Z,1503946371.617 [Default:CheckIn:D] Running Loop=1
2017-08-28T18:52:52.009Z,1503946372.009 [Default:CheckIn:D] Stopped
2017-08-28T18:52:52.009Z,1503946372.009 [Default:CheckIn:E] Running Loop=1
2017-08-28T18:52:52.431Z,1503946372.431 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 7.414373 min 
2017-08-28T18:52:52.433Z,1503946372.433 [Default:CheckIn:E] Stopped
2017-08-28T18:52:52.433Z,1503946372.433 [Default:CheckIn](INFO): Completed Default:CheckIn
2017-08-28T18:52:52.433Z,1503946372.433 [Default:CheckIn] Stopped
2017-08-28T18:52:52.433Z,1503946372.433 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2017-08-28T18:52:52.434Z,1503946372.434 [Default:CheckIn](INFO): Running loop #2
2017-08-28T18:52:52.434Z,1503946372.434 [Default:CheckIn] Running Loop=2
2017-08-28T18:52:52.434Z,1503946372.434 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2017-08-28T18:52:52.434Z,1503946372.434 [Default:CheckIn:Read_GPS] Running Loop=1
2017-08-28T18:52:53.160Z,1503946373.160 [NAL9602](INFO): Powering up
2017-08-28T18:53:03.965Z,1503946383.965 [NAL9602](INFO): NAL9602 initialized
2017-08-28T18:53:12.008Z,1503946392.008 [BPC1](ERROR): Failed to parse message.
2017-08-28T18:53:12.008Z,1503946392.008 [BPC1](ERROR): Failed to parse bank B battery data
2017-08-28T18:53:12.008Z,1503946392.008 [BPC1] Data Fault, FailCount= 1
2017-08-28T18:53:12.009Z,1503946392.009 [BPC1](ERROR): Data Fault
2017-08-28T18:53:12.132Z,1503946392.132 [CBIT](ERROR): Data Fault in component: BPC1
2017-08-28T18:53:13.334Z,1503946393.334 [CBIT](INFO): Clearing failed state for component BPC1
2017-08-28T18:53:13.334Z,1503946393.334 [BPC1] No Fault, FailCount= 1
2017-08-28T18:53:46.768Z,1503946426.768 [NAL9602](INFO): SBD MO Status=2, MOMSN=109, MT Status=2, MTMSN=0
2017-08-28T18:53:46.768Z,1503946426.768 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2017-08-28T18:53:59.171Z,1503946439.171 [NAL9602](IMPORTANT): SBD MO Status=0, MOMSN=109, MT Status=1, MTMSN=902
2017-08-28T18:53:59.171Z,1503946439.171 [NAL9602](INFO): Data available in MT queue
2017-08-28T18:53:59.875Z,1503946439.875 [NAL9602](INFO): Received command:sched asap "load Science/profile_station.xml;set profile_station.MissionTimeout 2 hour;set profile_station.NeedCommsTime 30 minute;set profile_station.Lat 36.797 degree;set profile_station.Lon -121.850 degree" ck9x 1 2
2017-08-28T18:53:59.919Z,1503946439.919 [CommandLine](IMPORTANT): got command schedule asap "load Science/profile_station.xml;set profile_station.MissionTimeout 2 hour;set profile_station.NeedCommsTime 30 minute;set profile_station.Lat 36.797 degree;set profile_station.Lon -121.850 degree" ck9x 1 2.000000
2017-08-28T18:53:59.920Z,1503946439.920 [CommandLine](IMPORTANT): Scheduling command #1 of 2 with id=ck9x
2017-08-28T18:53:59.921Z,1503946439.921 [CommandLine](IMPORTANT): Scheduled #1 (#1 of 2 with id='ck9x'): "load Science/profile_station.xml;set profile_station.MissionTimeout 2 hour;set profile_station.NeedCommsTime 30 minute;set profile_station.Lat 36.797 degree;set profile_station.Lon -121.850 degree" ASAP
2017-08-28T18:54:00.868Z,1503946440.868 [NAL9602](INFO): GPS fix at 20170828T185358: (36.802323, -121.787139)
2017-08-28T18:54:00.938Z,1503946440.938 [Default:CheckIn:Read_GPS] Stopped
2017-08-28T18:54:00.938Z,1503946440.938 [Default:CheckIn:Read_Iridium] Running Loop=1
2017-08-28T18:54:17.465Z,1503946457.465 [NAL9602](IMPORTANT): SBD MO Status=1, MOMSN=110, MT Status=1, MTMSN=903
2017-08-28T18:54:17.514Z,1503946457.514 [NAL9602](INFO): Sent 65 bytes from file Logs/20170828T184133/Courier0008.lzma
2017-08-28T18:54:17.514Z,1503946457.514 [NAL9602](INFO): Packets left to send: 0
2017-08-28T18:54:17.516Z,1503946457.516 [NAL9602](DEBUG): Stored copy of sent data in Logs/20170828T184133/Courier0008.lzma.parts/0000.sbd
2017-08-28T18:54:17.516Z,1503946457.516 [NAL9602](DEBUG): Completed sending Logs/20170828T184133/Courier0008.lzma
2017-08-28T18:54:18.046Z,1503946458.046 [NAL9602](INFO): Received command:sched asap "set profile_station.YoYoMaxDepth 40 meter;set profile_station.MaxDepth 50 meter;run " ck9x 2 2
2017-08-28T18:54:18.080Z,1503946458.080 [CommandLine](IMPORTANT): got command schedule asap "set profile_station.YoYoMaxDepth 40 meter;set profile_station.MaxDepth 50 meter;run " ck9x 2 2.000000
2017-08-28T18:54:18.081Z,1503946458.081 [CommandLine](IMPORTANT): Scheduling command #2 of 2 with id=ck9x
2017-08-28T18:54:18.082Z,1503946458.082 [CommandLine](IMPORTANT): Scheduled #2 (#2 of 2 with id='ck9x'): "set profile_station.YoYoMaxDepth 40 meter;set profile_station.MaxDepth 50 meter;run " ASAP
2017-08-28T18:54:18.168Z,1503946458.168 [CommandLine](IMPORTANT): got command load ./Missions/Science/profile_station.xml
2017-08-28T18:54:18.168Z,1503946458.168 [MissionManager](INFO): Loading Mission: ./Missions/Science/profile_station.xml
2017-08-28T18:54:18.432Z,1503946458.432 [MissionManager](INFO): DefineArg profile_station.MissionTimeout = 4.000000 h
2017-08-28T18:54:18.435Z,1503946458.435 [MissionManager](INFO): DefineArg profile_station.NeedCommsTime = 1.000000 h
2017-08-28T18:54:18.450Z,1503946458.450 [MissionManager](INFO): DefineArg profile_station.Lat = 36.806966 arcdeg
2017-08-28T18:54:18.457Z,1503946458.457 [MissionManager](INFO): DefineArg profile_station.Lon = -121.824326 arcdeg
2017-08-28T18:54:18.472Z,1503946458.472 [MissionManager](INFO): DefineArg profile_station.Radius = 300.000000 m
2017-08-28T18:54:18.479Z,1503946458.479 [MissionManager](INFO): DefineArg profile_station.YoYoMinDepth = 2.000000 m
2017-08-28T18:54:18.482Z,1503946458.482 [MissionManager](INFO): DefineArg profile_station.YoYoMaxDepth = 200.000000 m
2017-08-28T18:54:18.494Z,1503946458.494 [MissionManager](INFO): DefineArg profile_station.YoYoMinAltitude = 7.000000 m
2017-08-28T18:54:18.501Z,1503946458.501 [MissionManager](INFO): DefineArg profile_station.YoYoPitch = 20.000000 arcdeg
2017-08-28T18:54:18.516Z,1503946458.516 [MissionManager](INFO): DefineArg profile_station.Speed = 1.000000 m/s
2017-08-28T18:54:18.527Z,1503946458.527 [MissionManager](INFO): DefineArg profile_station.CircleMaxError = 100.000000 m
2017-08-28T18:54:18.530Z,1503946458.530 [MissionManager](INFO): DefineArg profile_station.CircleTurnToPort = 0 bool
2017-08-28T18:54:18.550Z,1503946458.550 [MissionManager](INFO): DefineArg profile_station.KwpHeading = 0.010000 rad/m
2017-08-28T18:54:18.557Z,1503946458.557 [MissionManager](INFO): DefineArg profile_station.MinAltitude = 5.000000 m
2017-08-28T18:54:18.577Z,1503946458.577 [MissionManager](INFO): DefineArg profile_station.MaxDepth = 205.000000 m
2017-08-28T18:54:18.584Z,1503946458.584 [MissionManager](INFO): DefineArg profile_station.MinOffshore = 2.000000 km
2017-08-28T18:54:18.585Z,1503946458.585 [MissionManager](INFO): Inserting Stack: Missions/Insert/Science.xml
2017-08-28T18:54:18.783Z,1503946458.783 [MissionManager](INFO): DefineArg profile_station:Science.SampleISUS = 0 bool
2017-08-28T18:54:18.791Z,1503946458.791 [MissionManager](INFO): DefineArg profile_station:Science.SampleISUSmaxPitch = 60.000000 arcdeg
2017-08-28T18:54:18.794Z,1503946458.794 [MissionManager](INFO): DefineArg profile_station:Science.SampleISUSminPitch = -60.000000 arcdeg
2017-08-28T18:54:18.805Z,1503946458.805 [MissionManager](INFO): DefineArg profile_station:Science.PeakDetectChlActive = 0 bool
2017-08-28T18:54:18.812Z,1503946458.812 [MissionManager](INFO): DefineArg profile_station:Science.PeakDetectNO3Active = 0 bool
2017-08-28T18:54:18.815Z,1503946458.815 [MissionManager](INFO): DefineArg profile_station:Science.UpwardDerivativeOfTemperatureActive = 0 bool
2017-08-28T18:54:18.819Z,1503946458.819 [MissionManager](INFO): DefineArg profile_station:Science.EnabledAanderaaO2 = 1.000000 bool
2017-08-28T18:54:18.822Z,1503946458.822 [MissionManager](INFO): DefineArg profile_station:Science.EnabledNeilBrown = 1.000000 bool
2017-08-28T18:54:18.834Z,1503946458.834 [MissionManager](INFO): DefineArg profile_station:Science.EnabledSeabird = 1.000000 bool
2017-08-28T18:54:18.838Z,1503946458.838 [MissionManager](INFO): DefineArg profile_station:Science.EnabledTurbulence_NPS = 0.000000 bool
2017-08-28T18:54:18.847Z,1503946458.847 [MissionManager](INFO): DefineArg profile_station:Science.EnabledWetLabsBB2FL = 1.000000 bool
2017-08-28T18:54:18.854Z,1503946458.854 [MissionManager](INFO): DefineArg profile_station:Science.EnabledISUS = 0.000000 bool
2017-08-28T18:54:18.859Z,1503946458.859 [MissionManager](INFO): DefineArg profile_station:Science.LowPassWindowLength = 20.000000 count
2017-08-28T18:54:18.870Z,1503946458.870 [MissionManager](INFO): DefineArg profile_station:Science.PeakChlShallowBound = nan m
2017-08-28T18:54:18.878Z,1503946458.878 [MissionManager](INFO): DefineArg profile_station:Science.PeakChlDeepBound = nan m
2017-08-28T18:54:18.889Z,1503946458.889 [MissionManager](INFO): DefineOutput profile_station:Science.PeakChl = 0.000000 ug/l
2017-08-28T18:54:18.896Z,1503946458.896 [MissionManager](INFO): DefineOutput profile_station:Science.PeakChlDepth = 0.000000 m
2017-08-28T18:54:18.899Z,1503946458.899 [MissionManager](INFO): DefineOutput profile_station:Science.PeakChlLatitude = nan arcdeg
2017-08-28T18:54:18.907Z,1503946458.907 [MissionManager](INFO): DefineOutput profile_station:Science.PeakChlLongitude = nan arcdeg
2017-08-28T18:54:18.922Z,1503946458.922 [MissionManager](INFO): DefineOutput profile_station:Science.PeakNO3 = 0.000000 umol/l
2017-08-28T18:54:18.938Z,1503946458.938 [MissionManager](INFO): DefineOutput profile_station:Science.PeakNO3Depth = 0.000000 m
2017-08-28T18:54:18.953Z,1503946458.953 [MissionManager](INFO): DefineOutput profile_station:Science.PeakNO3Latitude = nan arcdeg
2017-08-28T18:54:18.957Z,1503946458.957 [MissionManager](INFO): DefineOutput profile_station:Science.PeakNO3Longitude = nan arcdeg
2017-08-28T18:54:18.979Z,1503946458.979 [profile_station:Science:PeakDetectChl:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2017-08-28T18:54:19.001Z,1503946459.001 [profile_station:Science:PeakDetectNO3:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2017-08-28T18:54:19.022Z,1503946459.022 [MissionManager](INFO): RedefineArg profile_station:Science.SampleISUS = value:1 bool
2017-08-28T18:54:19.032Z,1503946459.032 [MissionManager](INFO): RedefineArg profile_station:Science.PeakDetectChlActive = value:1 bool
2017-08-28T18:54:19.033Z,1503946459.033 [MissionManager](INFO): Inserting Stack: Missions/Insert/NeedComms.xml
2017-08-28T18:54:19.121Z,1503946459.121 [MissionManager](INFO): DefineArg profile_station:NeedComms.DiveInterval = 3.000000 h
2017-08-28T18:54:19.124Z,1503946459.124 [MissionManager](INFO): DefineArg profile_station:NeedComms.AcousticTimeout = 96.000000 h
2017-08-28T18:54:19.127Z,1503946459.127 [MissionManager](INFO): DefineArg profile_station:NeedComms.WaitForPitchUp = 10.000000 min
2017-08-28T18:54:19.160Z,1503946459.160 [MissionManager](INFO): DefineArg profile_station:NeedComms.SurfacePitch = 20.000000 arcdeg
2017-08-28T18:54:19.164Z,1503946459.164 [MissionManager](INFO): DefineArg profile_station:NeedComms.SurfaceSpeed = 1.000000 m/s
2017-08-28T18:54:19.167Z,1503946459.167 [MissionManager](INFO): DefineArg profile_station:NeedComms.GPSTimeout = 7.000000 min
2017-08-28T18:54:19.187Z,1503946459.187 [MissionManager](INFO): DefineArg profile_station:NeedComms.CommsTimeout = 30.000000 min
2017-08-28T18:54:19.207Z,1503946459.207 [profile_station:NeedComms:B.GoToSurface](DEBUG): Construct GoToSurface.
2017-08-28T18:54:19.233Z,1503946459.233 [MissionManager](INFO): Inserting Stack: Missions/Insert/StandardEnvelopes.xml
2017-08-28T18:54:19.269Z,1503946459.269 [MissionManager](INFO): DefineArg profile_station:StandardEnvelopes.MinAltitude = 5.000000 m
2017-08-28T18:54:19.272Z,1503946459.272 [MissionManager](INFO): DefineArg profile_station:StandardEnvelopes.MaxDepth = 200.000000 m
2017-08-28T18:54:19.282Z,1503946459.282 [MissionManager](INFO): DefineArg profile_station:StandardEnvelopes.MinOffshore = 2000.000000 m
2017-08-28T18:54:19.284Z,1503946459.284 [profile_station:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Construct AltitudeEnvelope.
2017-08-28T18:54:19.291Z,1503946459.291 [profile_station:StandardEnvelopes:B.DepthEnvelope](DEBUG): Construct DepthEnvelope.
2017-08-28T18:54:19.335Z,1503946459.335 [profile_station:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Construct OffshoreEnvelope.
2017-08-28T18:54:19.366Z,1503946459.366 [profile_station:I.Pitch](DEBUG): Construct.
2017-08-28T18:54:19.384Z,1503946459.384 [profile_station:J.Buoyancy](DEBUG): Construct Buoyancy.
2017-08-28T18:54:19.389Z,1503946459.389 [profile_station:K.SetSpeed](DEBUG): Construct.
2017-08-28T18:54:19.410Z,1503946459.410 [profile_station:L.DepthEnvelope](DEBUG): Construct DepthEnvelope.
2017-08-28T18:54:19.420Z,1503946459.420 [profile_station:M.AltitudeEnvelope](DEBUG): Construct AltitudeEnvelope.
2017-08-28T18:54:19.445Z,1503946459.445 [profile_station:N.YoYo](DEBUG): Construct YoYo.
2017-08-28T18:54:19.475Z,1503946459.475 [profile_station:CircleWrapper:B.Circle](DEBUG): Construct.
2017-08-28T18:54:19.574Z,1503946459.574 [MissionManager](DEBUG): 
<?xml version="1.0" encoding="UTF-8"?>
<Mission xmlns="Tethys"
       xmlns:Control="Tethys/Control"
       xmlns:Derivation="Tethys/Derivation"
       xmlns:Estimation="Tethys/Estimation"
       xmlns:Guidance="Tethys/Guidance"
       xmlns:Sensor="Tethys/Sensor"
       xmlns:Units="Tethys/Units"
       xmlns:Universal="Tethys/Universal"
       xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"
       xsi:schemaLocation="Tethys http://okeanids.mbari.org/tethys/Xml/Tethys.xsd
                           Tethys/Control http://okeanids.mbari.org/tethys/Xml/Control.xsd
                           Tethys/Derivation http://okeanids.mbari.org/tethys/Xml/Derivation.xsd
                           Tethys/Estimation http://okeanids.mbari.org/tethys/Xml/Estimation.xsd
                           Tethys/Guidance http://okeanids.mbari.org/tethys/Xml/Guidance.xsd
                           Tethys/Sensor http://okeanids.mbari.org/tethys/Xml/Sensor.xsd
                           Tethys/Units http://okeanids.mbari.org/tethys/Xml/Units.xsd
                           Tethys/Universal http://okeanids.mbari.org/tethys/Xml/Universal.xsd"
       Id="profile_station">

    <Description>
        This mission yoyos in a circle around a specified location.
    </Description>

<!-- Mission-wide settings -->

    <DefineArg Name="MissionTimeout"><Description>
        Maximum duration of mission
    </Description><Units:hour/><Value>4</Value></DefineArg>

    <DefineArg Name="NeedCommsTime"><Description>
        Elapsed time after previous surface communications when vehicle will
        begin to ascend for additional surface communications
    </Description><Units:hour/><Value>1</Value></DefineArg>

<!-- You probably need to change these. -->

    <DefineArg Name="Lat"><Description>
        The latitude of the center of the circle.
    </Description><Units:degree/><Value>36.806966</Value></DefineArg>

    <DefineArg Name="Lon"><Description>
        The longitude of the center of the circle.
    </Description><Units:degree/><Value>-121.824326</Value></DefineArg>

    <DefineArg Name="Radius"><Description>
        Radius to circle at
    </Description><Units:meter/><Value>300</Value></DefineArg>

<!-- You probably do not need to change these. -->

    <DefineArg Name="YoYoMinDepth"><Description>
        Minimum depth while performing the YoYo behavior.
    </Description><Units:meter/><Value>2</Value></DefineArg>

    <DefineArg Name="YoYoMaxDepth"><Description>
        Maximum depth while performing the YoYo behavior.
    </Description><Units:meter/><Value>200</Value></DefineArg>

    <DefineArg Name="YoYoMinAltitude"><Description>
        Minimum altitude while performing the YoYo behavior (for
        bottom-terminated YoYos).
    </Description><Units:meter/><Value>7</Value></DefineArg>

    <DefineArg Name="YoYoPitch"><Description>
        Pitch (plus and minus) for yo-yo behavior.
    </Description><Units:degree/><Value>20</Value></DefineArg>

    <DefineArg Name="Speed"><Description>
        Vehicle speed.
    </Description><Units:meter_per_second/><Value>1</Value></DefineArg>

<!-- You are even less likely to need to change these. -->

    <DefineArg Name="CircleMaxError"><Description>
        If this distance away from the circle, drive straight towards (or away
        from the center). Otherwise, try to reduce distance from the ideal
        circle.
    </Description><Units:meter/><Value>100</Value></DefineArg>

    <DefineArg Name="CircleTurnToPort"><Description>
        If true, vehicle turns to the left around the center point. If false,
        vehicle turns to the right.
    </Description><False/></DefineArg>

    <DefineArg Name="KwpHeading"><Description>
        Used to relax waypoint cross-track error constant that is adjusted for
        docking. (You can override this setting by passing an argument.)
    </Description><Units:radian_per_meter/><Value>0.010</Value></DefineArg>

    <DefineArg Name="MinAltitude"><Description>
        Minimum height above the sea floor for the entire mission.
    </Description><Units:meter/><Value>5</Value></DefineArg>

    <DefineArg Name="MaxDepth"><Description>
        Maximum depth for the entire mission.
    </Description><Units:meter/><Value>205</Value></DefineArg>

    <DefineArg Name="MinOffshore"><Description>
        Minimum offshore distance for the entire mission.
    </Description><Units:kilometer/><Value>2</Value></DefineArg>

<!-- Missions should almost always start with a timeout -->

    <Timeout Duration="MissionTimeout"/>

    <Insert Filename="Insert/Science.xml">
        <Description>
            Most missions will run the science sensors. If you don't place this
            aggregate above NeedComms, science instruments get turned off on the
            last upcast and while floating on the surface.
        </Description>
        <RedefineArg Name="SampleISUS"><True/></RedefineArg>
        <RedefineArg Name="PeakDetectChlActive"><True/></RedefineArg>
    </Insert>

<!-- Most missions should use the NeedComms aggregate. -->

    <Insert Filename="Insert/NeedComms.xml" Id="NeedComms"/>

    <Assign><Sequence/><Arg Name="NeedComms:DiveInterval"/><Arg Name="NeedCommsTime"/></Assign>

<!-- Missions should almost always start with standard safety envelopes; most missions should not expose the parameters of these envelopes. -->

    <Insert Filename="Insert/StandardEnvelopes.xml"/>

    <Assign><Sequence/><Arg Name="StandardEnvelopes:MinAltitude"/><Arg Name="MinAltitude"/></Assign>

    <Assign><Sequence/><Arg Name="StandardEnvelopes:MaxDepth"/><Arg Name="MaxDepth"/></Assign>

    <Assign><Sequence/><Arg Name="StandardEnvelopes:MinOffshore"/><Arg Name="MinOffshore"/></Assign>

<!-- Check for additional instructions first. -->

    <Call Id="StartingMission" RefId="NeedComms"/>

<!-- Many missions will keep mass position and buoyancy volume fixed at defaults. -->

    <Guidance:Pitch>
        <Parallel/>
        <Setting><Guidance:Pitch.massPosition/><Control:VerticalControl.massDefault/></Setting>
    </Guidance:Pitch>

    <Guidance:Buoyancy>
        <Parallel/>
        <Setting><Guidance:Buoyancy.position/><Control:VerticalControl.buoyancyNeutral/></Setting>
    </Guidance:Buoyancy>

    <Guidance:SetSpeed>
        <Parallel/>
        <Setting><Guidance:SetSpeed.speed/><Arg Name="Speed"/></Setting>
    </Guidance:SetSpeed>

    <Guidance:DepthEnvelope>
        <Description>
            Another depth envelope for the YoYo behavior. This envelope should
            fall within the limits of the standard safety envelopes in
            Insert/StandardEnvelopes.xml in order to avoid commanding high pitch
            angles for depth-terminated YoYos.
        </Description>
        <Parallel/>
        <Setting><Guidance:DepthEnvelope.minDepth/><Arg Name="YoYoMinDepth"/></Setting>
        <Setting><Guidance:DepthEnvelope.maxDepth/><Arg Name="YoYoMaxDepth"/></Setting>
        <Setting><Guidance:DepthEnvelope.pitch/><Arg Name="YoYoPitch"/></Setting>
    </Guidance:DepthEnvelope>

    <Guidance:AltitudeEnvelope>
        <Description>
            Another altitude envelope for the YoYo behavior. This envelope
            should fall within the limits of the standard safety envelopes in
            Insert/StandardEnvelopes.xml in order to avoid commanding high pitch
            angles for bottom-terminated YoYos.
        </Description>
        <Parallel/>
        <Setting><Guidance:AltitudeEnvelope.minAltitude/><Arg Name="YoYoMinAltitude"/></Setting>
        <Setting><Guidance:AltitudeEnvelope.pitch/><Arg Name="YoYoPitch"/></Setting>
    </Guidance:AltitudeEnvelope>

    <Guidance:YoYo>
        <Parallel/>
        <Setting><Guidance:YoYo.pitch/><Arg Name="YoYoPitch"/></Setting>
    </Guidance:YoYo>

    <Aggregate Id="CircleWrapper">

        <Sequence Repeat="4096"/>

        <Assign><Parallel/><Control:HorizontalControl.kwpHeading/><Arg Name="KwpHeading"/></Assign>

        <Guidance:Circle>
            <Sequence/>
            <Setting><Guidance:Circle.latitude/><Arg Name="Lat"/></Setting>
            <Setting><Guidance:Circle.longitude/><Arg Name="Lon"/></Setting>
            <Setting><Guidance:Circle.radius/><Arg Name="Radius"/></Setting>
            <Setting><Guidance:Circle.maxError/><Arg Name="CircleMaxError"/></Setting>
            <Setting><Guidance:Circle.turnToPort/><Arg Name="CircleTurnToPort"/></Setting>
        </Guidance:Circle>

    </Aggregate>

</Mission>


2017-08-28T18:54:19.574Z,1503946459.574 [CommandLine](IMPORTANT): Loaded ./Missions/Science/profile_station.xml
2017-08-28T18:54:28.809Z,1503946468.809 [CommandLine](IMPORTANT): got command set profile_station.MissionTimeout 2.000000 hour
2017-08-28T18:54:28.810Z,1503946468.810 [CommandLine](IMPORTANT): got command set profile_station.NeedCommsTime 30.000000 minute
2017-08-28T18:54:28.810Z,1503946468.810 [CommandLine](IMPORTANT): got command set profile_station.Lat 36.797001 degree
2017-08-28T18:54:28.811Z,1503946468.811 [CommandLine](IMPORTANT): got command set profile_station.Lon -121.849998 degree
2017-08-28T18:54:33.546Z,1503946473.546 [CommandLine](IMPORTANT): got command set profile_station.YoYoMaxDepth 40.000000 meter
2017-08-28T18:54:33.547Z,1503946473.547 [CommandLine](IMPORTANT): got command set profile_station.MaxDepth 50.000000 meter
2017-08-28T18:54:33.548Z,1503946473.548 [CommandLine](IMPORTANT): got command run 
2017-08-28T18:54:33.552Z,1503946473.552 [CommandLine](IMPORTANT): Running 
2017-08-28T18:54:33.839Z,1503946473.839 [Default] Stopped
2017-08-28T18:54:33.839Z,1503946473.839 [Default](DEBUG): Aggregate::uninitialize Default
2017-08-28T18:54:33.839Z,1503946473.839 [Default:B.GoToSurface] Stopped
2017-08-28T18:54:33.839Z,1503946473.839 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2017-08-28T18:54:33.839Z,1503946473.839 [Default:CheckIn] Stopped
2017-08-28T18:54:33.839Z,1503946473.839 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2017-08-28T18:54:33.839Z,1503946473.839 [Default:CheckIn:Read_Iridium] Stopped
2017-08-28T18:54:33.844Z,1503946473.844 [MissionManager](IMPORTANT): Started mission profile_station
2017-08-28T18:54:33.844Z,1503946473.844 [profile_station] Running Loop=1
2017-08-28T18:54:33.844Z,1503946473.844 [profile_station](DEBUG): Aggregate::initialize profile_station
2017-08-28T18:54:33.844Z,1503946473.844 [profile_station:Science] Running Loop=1
2017-08-28T18:54:33.844Z,1503946473.844 [profile_station:Science](DEBUG): Aggregate::initialize profile_station:Science
2017-08-28T18:54:33.845Z,1503946473.845 [profile_station:Science:A] Running Loop=1
2017-08-28T18:54:33.845Z,1503946473.845 [profile_station:Science:B] Running Loop=1
2017-08-28T18:54:33.845Z,1503946473.845 [profile_station:Science:C] Running Loop=1
2017-08-28T18:54:33.845Z,1503946473.845 [profile_station:Science:D] Running Loop=1
2017-08-28T18:54:33.845Z,1503946473.845 [profile_station:Science:E] Running Loop=1
2017-08-28T18:54:33.845Z,1503946473.845 [profile_station:Science:F] Running Loop=1
2017-08-28T18:54:33.845Z,1503946473.845 [profile_station:Science:PeakDetectChl] Running Loop=1
2017-08-28T18:54:33.845Z,1503946473.845 [profile_station:Science:PeakDetectChl](DEBUG): Aggregate::initialize profile_station:Science:PeakDetectChl
2017-08-28T18:54:33.845Z,1503946473.845 [profile_station:Science:PeakDetectChl:A.PeakDetectVsDepth] Running Loop=1
2017-08-28T18:54:33.845Z,1503946473.845 [profile_station:Science:PeakDetectChl:A.PeakDetectVsDepth](DEBUG): Initialize.
2017-08-28T18:54:33.847Z,1503946473.847 [profile_station:Science:PeakDetectNO3] Running Loop=1
2017-08-28T18:54:33.847Z,1503946473.847 [profile_station:Science:PeakDetectNO3](DEBUG): Aggregate::initialize profile_station:Science:PeakDetectNO3
2017-08-28T18:54:33.852Z,1503946473.852 [profile_station:Science:PeakDetectNO3:A.PeakDetectVsDepth] Running Loop=1
2017-08-28T18:54:33.852Z,1503946473.852 [profile_station:Science:PeakDetectNO3:A.PeakDetectVsDepth](DEBUG): Initialize.
2017-08-28T18:54:33.854Z,1503946473.854 [profile_station:StandardEnvelopes] Running Loop=1
2017-08-28T18:54:33.854Z,1503946473.854 [profile_station:StandardEnvelopes](DEBUG): Aggregate::initialize profile_station:StandardEnvelopes
2017-08-28T18:54:33.854Z,1503946473.854 [profile_station:StandardEnvelopes:A.AltitudeEnvelope] Running Loop=1
2017-08-28T18:54:33.854Z,1503946473.854 [profile_station:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Initialize AltitudeEnvelopeComponent.
2017-08-28T18:54:33.855Z,1503946473.855 [profile_station:StandardEnvelopes:B.DepthEnvelope] Running Loop=1
2017-08-28T18:54:33.855Z,1503946473.855 [profile_station:StandardEnvelopes:B.DepthEnvelope](DEBUG): Initialize DepthEnvelopeComponent.
2017-08-28T18:54:33.855Z,1503946473.855 [profile_station:StandardEnvelopes:C.OffshoreEnvelope] Running Loop=1
2017-08-28T18:54:33.855Z,1503946473.855 [profile_station:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Initialize OffshoreEnvelopeComponent.
2017-08-28T18:54:33.855Z,1503946473.855 [profile_station:I.Pitch] Running Loop=1
2017-08-28T18:54:33.855Z,1503946473.855 [profile_station:I.Pitch](DEBUG): Initialize.
2017-08-28T18:54:33.860Z,1503946473.860 [profile_station:J.Buoyancy] Running Loop=1
2017-08-28T18:54:33.860Z,1503946473.860 [profile_station:J.Buoyancy](DEBUG): Initialize Buoyancy Component.
2017-08-28T18:54:33.860Z,1503946473.860 [profile_station:K.SetSpeed] Running Loop=1
2017-08-28T18:54:33.860Z,1503946473.860 [profile_station:K.SetSpeed](DEBUG): Initialize.
2017-08-28T18:54:33.860Z,1503946473.860 [profile_station:L.DepthEnvelope] Running Loop=1
2017-08-28T18:54:33.860Z,1503946473.860 [profile_station:L.DepthEnvelope](DEBUG): Initialize DepthEnvelopeComponent.
2017-08-28T18:54:33.860Z,1503946473.860 [profile_station:M.AltitudeEnvelope] Running Loop=1
2017-08-28T18:54:33.861Z,1503946473.861 [profile_station:M.AltitudeEnvelope](DEBUG): Initialize AltitudeEnvelopeComponent.
2017-08-28T18:54:33.861Z,1503946473.861 [profile_station:N.YoYo] Running Loop=1
2017-08-28T18:54:33.861Z,1503946473.861 [profile_station:N.YoYo](DEBUG): Initialize YoYoComponent.
2017-08-28T18:54:33.861Z,1503946473.861 [profile_station:C] Running Loop=1
2017-08-28T18:54:33.862Z,1503946473.862 [profile_station:N.YoYo] Running Loop=1
2017-08-28T18:54:33.871Z,1503946473.871 [profile_station:M.AltitudeEnvelope] Running Loop=1
2017-08-28T18:54:33.881Z,1503946473.881 [profile_station:L.DepthEnvelope] Running Loop=1
2017-08-28T18:54:33.896Z,1503946473.896 [profile_station:K.SetSpeed] Running Loop=1
2017-08-28T18:54:33.900Z,1503946473.900 [profile_station:J.Buoyancy] Running Loop=1
2017-08-28T18:54:33.909Z,1503946473.909 [profile_station:I.Pitch] Running Loop=1
2017-08-28T18:54:33.918Z,1503946473.918 [profile_station:StandardEnvelopes] Running Loop=1
2017-08-28T18:54:33.918Z,1503946473.918 [profile_station:StandardEnvelopes:C.OffshoreEnvelope] Running Loop=1
2017-08-28T18:54:33.950Z,1503946473.950 [profile_station:StandardEnvelopes:B.DepthEnvelope] Running Loop=1
2017-08-28T18:54:33.958Z,1503946473.958 [profile_station:StandardEnvelopes:A.AltitudeEnvelope] Running Loop=1
2017-08-28T18:54:33.974Z,1503946473.974 [profile_station:C] Stopped
2017-08-28T18:54:33.974Z,1503946473.974 [profile_station:E] Running Loop=1
2017-08-28T18:54:33.974Z,1503946473.974 [profile_station:Science] Running Loop=1
2017-08-28T18:54:33.986Z,1503946473.986 [profile_station:Science:PeakDetectNO3] Stopped
2017-08-28T18:54:33.986Z,1503946473.986 [profile_station:Science:PeakDetectNO3](DEBUG): Aggregate::uninitialize profile_station:Science:PeakDetectNO3
2017-08-28T18:54:33.986Z,1503946473.986 [profile_station:Science:PeakDetectNO3:A.PeakDetectVsDepth] Stopped
2017-08-28T18:54:33.987Z,1503946473.987 [profile_station:Science:PeakDetectNO3:A.PeakDetectVsDepth](DEBUG): Uninitialize.
2017-08-28T18:54:33.987Z,1503946473.987 [profile_station:Science:PeakDetectChl] Running Loop=1
2017-08-28T18:54:34.007Z,1503946474.007 [profile_station:Science:F] Running Loop=1
2017-08-28T18:54:34.008Z,1503946474.008 [profile_station:Science:F](DEBUG): Initialize ReadDataComponent to sense mass_concentration_of_chlorophyll_in_sea_water
2017-08-28T18:54:34.009Z,1503946474.009 [profile_station:Science:E] Stopped
2017-08-28T18:54:34.009Z,1503946474.009 [profile_station:Science:D] Stopped
2017-08-28T18:54:34.010Z,1503946474.010 [profile_station:Science:C] Running Loop=1
2017-08-28T18:54:34.010Z,1503946474.010 [profile_station:Science:C](DEBUG): Initialize ReadDataComponent to sense sea_water_temperature
2017-08-28T18:54:34.011Z,1503946474.011 [profile_station:Science:C](DEBUG): Initialize ReadDataComponent to sense sea_water_salinity
2017-08-28T18:54:34.012Z,1503946474.012 [profile_station:Science:B] Stopped
2017-08-28T18:54:34.012Z,1503946474.012 [profile_station:Science:A] Running Loop=1
2017-08-28T18:54:34.013Z,1503946474.013 [profile_station:Science:A](DEBUG): Initialize ReadDataComponent to sense mass_concentration_of_oxygen_in_sea_water
2017-08-28T18:54:34.060Z,1503946474.060 [CTD_NeilBrown](DEBUG): Initializing CTD_NeilBrown.
2017-08-28T18:54:34.068Z,1503946474.068 [CTD_NeilBrown](INFO): Opening uart, block timeout 10ths=4
2017-08-28T18:54:34.204Z,1503946474.204 [CTD_NeilBrown](DEBUG): serial timeout
2017-08-28T18:54:34.250Z,1503946474.250 [profile_station:E] Stopped
2017-08-28T18:54:34.250Z,1503946474.250 [profile_station:F] Running Loop=1
2017-08-28T18:54:34.405Z,1503946474.405 [WetLabsBB2FL](INFO): Opening uart, block timeout 10ths=4
2017-08-28T18:54:34.405Z,1503946474.405 [WetLabsBB2FL](INFO): Powering up
2017-08-28T18:54:34.613Z,1503946474.613 [CTD_NeilBrown](DEBUG): serial timeout
2017-08-28T18:54:34.654Z,1503946474.654 [profile_station:F] Stopped
2017-08-28T18:54:34.654Z,1503946474.654 [profile_station:G] Running Loop=1
2017-08-28T18:54:35.025Z,1503946475.025 [CTD_NeilBrown](DEBUG): serial timeout
2017-08-28T18:54:35.098Z,1503946475.098 [ThrusterServo](FAULT): getVelocity uart error serial timeout
2017-08-28T18:54:35.098Z,1503946475.098 [ThrusterServo](FAULT): Thruster uart error: serial timeout
2017-08-28T18:54:35.098Z,1503946475.098 [ThrusterServo] Communications Fault, FailCount= 1
2017-08-28T18:54:35.098Z,1503946475.098 [ThrusterServo](ERROR): Communications Fault
2017-08-28T18:54:35.102Z,1503946475.102 [CBIT](ERROR): Communications Fault in component: ThrusterServo
2017-08-28T18:54:35.222Z,1503946475.222 [profile_station:G] Stopped
2017-08-28T18:54:35.222Z,1503946475.222 [profile_station:StartingMission] Running Loop=1
2017-08-28T18:54:35.222Z,1503946475.222 [profile_station:StartingMission](DEBUG): Aggregate::initialize profile_station:StartingMission
2017-08-28T18:54:35.438Z,1503946475.438 [CTD_NeilBrown](DEBUG): serial timeout
2017-08-28T18:54:35.516Z,1503946475.516 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2017-08-28T18:54:35.516Z,1503946475.516 [ThrusterServo](INFO): Powering down
2017-08-28T18:54:35.536Z,1503946475.536 [CTD_NeilBrown](ERROR): Salinity reading out of range: -0.071900 psu
2017-08-28T18:54:35.545Z,1503946475.545 [CTD_NeilBrown](INFO): some bad data, not updating bins
2017-08-28T18:54:35.668Z,1503946475.668 [profile_station:NeedComms] Running Loop=1
2017-08-28T18:54:35.668Z,1503946475.668 [profile_station:NeedComms](DEBUG): Aggregate::initialize profile_station:NeedComms
2017-08-28T18:54:35.668Z,1503946475.668 [profile_station:NeedComms:B.GoToSurface] Running Loop=1
2017-08-28T18:54:35.668Z,1503946475.668 [profile_station:NeedComms:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2017-08-28T18:54:35.668Z,1503946475.668 [profile_station:NeedComms:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2017-08-28T18:54:35.669Z,1503946475.669 [profile_station:NeedComms:B.GoToSurface](INFO): Received pitch setting 19.999999 degrees.
2017-08-28T18:54:35.669Z,1503946475.669 [profile_station:NeedComms:B.GoToSurface](INFO): Received speed setting 1.000000 m/s.
2017-08-28T18:54:35.669Z,1503946475.669 [profile_station:NeedComms:B.GoToSurface](DEBUG): No pitch timeout specified. Using default value of 20.000000 seconds.
2017-08-28T18:54:35.670Z,1503946475.670 [profile_station:NeedComms:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2017-08-28T18:54:35.670Z,1503946475.670 [profile_station:NeedComms:A] Running Loop=1
2017-08-28T18:54:35.684Z,1503946475.684 [profile_station:NeedComms:A](INFO): last time_fix was: 1503946438.000000 second since 1970/01/01T00:00:00Z 
2017-08-28T18:54:35.685Z,1503946475.685 [profile_station:NeedComms:A] Stopped
2017-08-28T18:54:35.740Z,1503946475.740 [CTD_NeilBrown](ERROR): Salinity reading out of range: -0.069500 psu
2017-08-28T18:54:35.746Z,1503946475.746 [CTD_NeilBrown](INFO): some bad data, not updating bins
2017-08-28T18:54:35.950Z,1503946475.950 [NAL9602](IMPORTANT): SBD MO Status=1, MOMSN=111, MT Status=1, MTMSN=904
2017-08-28T18:54:35.952Z,1503946475.952 [CTD_NeilBrown](ERROR): Salinity reading out of range: -0.081300 psu
2017-08-28T18:54:35.958Z,1503946475.958 [CTD_NeilBrown](INFO): some bad data, not updating bins
2017-08-28T18:54:36.003Z,1503946476.003 [NAL9602](INFO): Sent 332 bytes from file Logs/20170828T184133/Express0009.lzma
2017-08-28T18:54:36.004Z,1503946476.004 [NAL9602](INFO): Packets left to send: 1
2017-08-28T18:54:36.005Z,1503946476.005 [NAL9602](DEBUG): Stored copy of sent data in Logs/20170828T184133/Express0009.lzma.parts/0001.sbd
2017-08-28T18:54:36.089Z,1503946476.089 [profile_station:NeedComms:C] Running Loop=1
2017-08-28T18:54:36.145Z,1503946476.145 [CTD_NeilBrown](ERROR): Salinity reading out of range: -0.076500 psu
2017-08-28T18:54:36.155Z,1503946476.155 [CTD_NeilBrown](INFO): some bad data, not updating bins
2017-08-28T18:54:36.232Z,1503946476.232 [CTD_NeilBrown](DEBUG): serial timeout
2017-08-28T18:54:36.356Z,1503946476.356 [CTD_NeilBrown](ERROR): Salinity reading out of range: -0.076700 psu
2017-08-28T18:54:36.365Z,1503946476.365 [CTD_NeilBrown](INFO): some bad data, not updating bins
2017-08-28T18:54:36.500Z,1503946476.500 [CBIT](INFO): Clearing failed state for component ThrusterServo
2017-08-28T18:54:36.500Z,1503946476.500 [ThrusterServo] No Fault, FailCount= 1
2017-08-28T18:54:36.562Z,1503946476.562 [CTD_NeilBrown](ERROR): Salinity reading out of range: -0.084600 psu
2017-08-28T18:54:36.570Z,1503946476.570 [CTD_NeilBrown](INFO): some bad data, not updating bins
2017-08-28T18:54:36.608Z,1503946476.608 [NAL9602](INFO): Received command:stop
2017-08-28T18:54:36.673Z,1503946476.673 [profile_station:NeedComms:C](DEBUG): Initialize ReadDataComponent to sense time_fix
2017-08-28T18:54:36.680Z,1503946476.680 [CommandLine](IMPORTANT): got command stop
2017-08-28T18:54:36.681Z,1503946476.681 [CommandLine](IMPORTANT): Scheduling is paused
2017-08-28T18:54:36.681Z,1503946476.681 [Supervisor](INFO): Stop Mission called by CommandLine::commandStop
2017-08-28T18:54:36.697Z,1503946476.697 [MissionManager](INFO): MissionManager is completed.
2017-08-28T18:54:36.697Z,1503946476.697 [MissionManager](INFO): Uninitializing Mission profile_station
2017-08-28T18:54:36.697Z,1503946476.697 [profile_station] Stopped
2017-08-28T18:54:36.697Z,1503946476.697 [profile_station](DEBUG): Aggregate::uninitialize profile_station
2017-08-28T18:54:36.698Z,1503946476.698 [profile_station:Science] Stopped
2017-08-28T18:54:36.698Z,1503946476.698 [profile_station:Science](DEBUG): Aggregate::uninitialize profile_station:Science
2017-08-28T18:54:36.698Z,1503946476.698 [profile_station:Science:A] Stopped
2017-08-28T18:54:36.698Z,1503946476.698 [profile_station:Science:C] Stopped
2017-08-28T18:54:36.698Z,1503946476.698 [profile_station:Science:F] Stopped
2017-08-28T18:54:36.698Z,1503946476.698 [profile_station:Science:PeakDetectChl] Stopped
2017-08-28T18:54:36.698Z,1503946476.698 [profile_station:Science:PeakDetectChl](DEBUG): Aggregate::uninitialize profile_station:Science:PeakDetectChl
2017-08-28T18:54:36.698Z,1503946476.698 [profile_station:Science:PeakDetectChl:A.PeakDetectVsDepth] Stopped
2017-08-28T18:54:36.698Z,1503946476.698 [profile_station:Science:PeakDetectChl:A.PeakDetectVsDepth](DEBUG): Uninitialize.
2017-08-28T18:54:36.698Z,1503946476.698 [profile_station:NeedComms] Stopped
2017-08-28T18:54:36.698Z,1503946476.698 [profile_station:NeedComms](DEBUG): Aggregate::uninitialize profile_station:NeedComms
2017-08-28T18:54:36.698Z,1503946476.698 [profile_station:NeedComms:B.GoToSurface] Stopped
2017-08-28T18:54:36.698Z,1503946476.698 [profile_station:NeedComms:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2017-08-28T18:54:36.699Z,1503946476.699 [profile_station:NeedComms:C] Stopped
2017-08-28T18:54:36.699Z,1503946476.699 [profile_station:StandardEnvelopes] Stopped
2017-08-28T18:54:36.699Z,1503946476.699 [profile_station:StandardEnvelopes](DEBUG): Aggregate::uninitialize profile_station:StandardEnvelopes
2017-08-28T18:54:36.699Z,1503946476.699 [profile_station:StandardEnvelopes:A.AltitudeEnvelope] Stopped
2017-08-28T18:54:36.699Z,1503946476.699 [profile_station:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Uninitialize AltitudeEnvelopeComponent.
2017-08-28T18:54:36.699Z,1503946476.699 [profile_station:StandardEnvelopes:B.DepthEnvelope] Stopped
2017-08-28T18:54:36.699Z,1503946476.699 [profile_station:StandardEnvelopes:B.DepthEnvelope](DEBUG): Uninitialize.
2017-08-28T18:54:36.699Z,1503946476.699 [profile_station:StandardEnvelopes:C.OffshoreEnvelope] Stopped
2017-08-28T18:54:36.699Z,1503946476.699 [profile_station:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Uninitialize OffshoreEnvelopeComponent.
2017-08-28T18:54:36.699Z,1503946476.699 [profile_station:StartingMission] Stopped
2017-08-28T18:54:36.699Z,1503946476.699 [profile_station:StartingMission](DEBUG): Aggregate::uninitialize profile_station:StartingMission
2017-08-28T18:54:36.699Z,1503946476.699 [profile_station:I.Pitch] Stopped
2017-08-28T18:54:36.699Z,1503946476.699 [profile_station:J.Buoyancy] Stopped
2017-08-28T18:54:36.699Z,1503946476.699 [profile_station:J.Buoyancy](DEBUG): Uninitialize Buoyancy Component.
2017-08-28T18:54:36.700Z,1503946476.700 [profile_station:K.SetSpeed] Stopped
2017-08-28T18:54:36.700Z,1503946476.700 [profile_station:K.SetSpeed](DEBUG): Uninitialize.
2017-08-28T18:54:36.700Z,1503946476.700 [profile_station:L.DepthEnvelope] Stopped
2017-08-28T18:54:36.700Z,1503946476.700 [profile_station:L.DepthEnvelope](DEBUG): Uninitialize.
2017-08-28T18:54:36.700Z,1503946476.700 [profile_station:M.AltitudeEnvelope] Stopped
2017-08-28T18:54:36.700Z,1503946476.700 [profile_station:M.AltitudeEnvelope](DEBUG): Uninitialize AltitudeEnvelopeComponent.
2017-08-28T18:54:36.704Z,1503946476.704 [profile_station:N.YoYo] Stopped
2017-08-28T18:54:36.704Z,1503946476.704 [profile_station:N.YoYo](DEBUG): Uninitialize YoYoComponent.
2017-08-28T18:54:36.765Z,1503946476.765 [CTD_NeilBrown](ERROR): Salinity reading out of range: -0.075100 psu
2017-08-28T18:54:36.770Z,1503946476.770 [CTD_NeilBrown](INFO): some bad data, not updating bins
2017-08-28T18:54:36.921Z,1503946476.921 [WetLabsBB2FL](INFO): Powering down
2017-08-28T18:54:37.294Z,1503946477.294 [ThrusterServo](DEBUG): Initializing EZServoServo.
2017-08-28T18:54:37.295Z,1503946477.295 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2017-08-28T18:54:37.394Z,1503946477.394 [MissionManager](IMPORTANT): Started mission Default
2017-08-28T18:54:37.394Z,1503946477.394 [Default] Running Loop=1
2017-08-28T18:54:37.394Z,1503946477.394 [Default](DEBUG): Aggregate::initialize Default
2017-08-28T18:54:37.394Z,1503946477.394 [Default:B.GoToSurface] Running Loop=1
2017-08-28T18:54:37.394Z,1503946477.394 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2017-08-28T18:54:37.394Z,1503946477.394 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2017-08-28T18:54:37.395Z,1503946477.395 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2017-08-28T18:54:37.395Z,1503946477.395 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2017-08-28T18:54:37.395Z,1503946477.395 [Default:B.GoToSurface](DEBUG): No pitch timeout specified. Using default value of 20.000000 seconds.
2017-08-28T18:54:37.396Z,1503946477.396 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2017-08-28T18:54:37.396Z,1503946477.396 [Default:A.Wait] Running Loop=1
2017-08-28T18:54:37.396Z,1503946477.396 [Default:A.Wait](DEBUG): Initialize Wait Component.
2017-08-28T18:54:38.367Z,1503946478.367 [Aanderaa_O2](INFO): Powering down
2017-08-28T18:54:42.326Z,1503946482.326 [NAL9602](INFO): Powering down
2017-08-28T18:54:50.776Z,1503946490.776 [Default:A.Wait](INFO): Done Waiting.
2017-08-28T18:54:50.776Z,1503946490.776 [Default:A.Wait] Stopped
2017-08-28T18:54:50.776Z,1503946490.776 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2017-08-28T18:54:51.184Z,1503946491.184 [Default:CheckIn] Running Loop=1
2017-08-28T18:54:51.184Z,1503946491.184 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2017-08-28T18:54:51.184Z,1503946491.184 [Default:CheckIn:Read_GPS] Running Loop=1
2017-08-28T18:54:51.927Z,1503946491.927 [NAL9602](INFO): Powering up
2017-08-28T18:55:02.724Z,1503946502.724 [NAL9602](INFO): NAL9602 initialized
2017-08-28T18:55:17.529Z,1503946517.529 [NAL9602](INFO): SBD MO Status=0, MOMSN=112, MT Status=0, MTMSN=0
2017-08-28T18:55:17.529Z,1503946517.529 [NAL9602](INFO): No messages in MT queue
2017-08-28T18:55:51.528Z,1503946551.528 [NAL9602](INFO): GPS fix at 20170828T185549: (36.802359, -121.787120)
2017-08-28T18:55:51.589Z,1503946551.589 [Default:CheckIn:Read_GPS] Stopped
2017-08-28T18:55:51.589Z,1503946551.589 [Default:CheckIn:Read_Iridium] Running Loop=1
2017-08-28T18:56:15.004Z,1503946575.004 [PNI_TCM](ERROR): CRC does not match. Expected:0x51126 got:0x16912
2017-08-28T18:56:18.600Z,1503946578.600 [PNI_TCM](ERROR): CRC does not match. Expected:0x21969 got:0x6593
2017-08-28T18:56:20.560Z,1503946580.560 [NAL9602](INFO): SBD MO Status=1, MOMSN=113, MT Status=0, MTMSN=0
2017-08-28T18:56:20.609Z,1503946580.609 [NAL9602](INFO): Sent 64 bytes from file Logs/20170828T184133/Courier0012.lzma
2017-08-28T18:56:20.609Z,1503946580.609 [NAL9602](INFO): Packets left to send: 0
2017-08-28T18:56:20.611Z,1503946580.611 [NAL9602](DEBUG): Stored copy of sent data in Logs/20170828T184133/Courier0012.lzma.parts/0000.sbd
2017-08-28T18:56:20.611Z,1503946580.611 [NAL9602](DEBUG): Completed sending Logs/20170828T184133/Courier0012.lzma
2017-08-28T18:56:26.396Z,1503946586.396 [NAL9602](INFO): SBD MO Status=1, MOMSN=114, MT Status=0, MTMSN=0
2017-08-28T18:56:26.451Z,1503946586.451 [NAL9602](INFO): Sent 74 bytes from file Logs/20170828T184133/Express0009.lzma
2017-08-28T18:56:26.451Z,1503946586.451 [NAL9602](INFO): Packets left to send: 0
2017-08-28T18:56:26.452Z,1503946586.452 [NAL9602](DEBUG): Stored copy of sent data in Logs/20170828T184133/Express0009.lzma.parts/0000.sbd
2017-08-28T18:56:26.453Z,1503946586.453 [NAL9602](DEBUG): Completed sending Logs/20170828T184133/Express0009.lzma
2017-08-28T18:56:35.374Z,1503946595.374 [NAL9602](INFO): SBD MO Status=1, MOMSN=115, MT Status=0, MTMSN=0
2017-08-28T18:56:35.424Z,1503946595.424 [NAL9602](INFO): Sent 332 bytes from file Logs/20170828T184133/Express0013.lzma
2017-08-28T18:56:35.425Z,1503946595.425 [NAL9602](INFO): Packets left to send: 1
2017-08-28T18:56:35.426Z,1503946595.426 [NAL9602](DEBUG): Stored copy of sent data in Logs/20170828T184133/Express0013.lzma.parts/0001.sbd
2017-08-28T18:56:43.632Z,1503946603.632 [NAL9602](INFO): SBD MO Status=1, MOMSN=116, MT Status=0, MTMSN=0
2017-08-28T18:56:43.681Z,1503946603.681 [NAL9602](INFO): Sent 238 bytes from file Logs/20170828T184133/Express0013.lzma
2017-08-28T18:56:43.681Z,1503946603.681 [NAL9602](INFO): Packets left to send: 0
2017-08-28T18:56:43.683Z,1503946603.683 [NAL9602](DEBUG): Stored copy of sent data in Logs/20170828T184133/Express0013.lzma.parts/0000.sbd
2017-08-28T18:56:43.683Z,1503946603.683 [NAL9602](DEBUG): Completed sending Logs/20170828T184133/Express0013.lzma
2017-08-28T18:56:50.831Z,1503946610.831 [NAL9602](INFO): SBD MO Status=0, MOMSN=117, MT Status=0, MTMSN=0
2017-08-28T18:56:50.978Z,1503946610.978 [Default:CheckIn:Read_Iridium] Stopped
2017-08-28T18:56:50.978Z,1503946610.978 [Default:CheckIn:C.Wait] Running Loop=1
2017-08-28T18:56:50.978Z,1503946610.978 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2017-08-28T18:56:56.428Z,1503946616.428 [NAL9602](INFO): Powering down
2017-08-28T18:58:50.463Z,1503946730.463 [BPC1](ERROR): Failed to receive battery data
2017-08-28T18:58:50.463Z,1503946730.463 [BPC1] Communications Fault, FailCount= 1
2017-08-28T18:58:50.463Z,1503946730.463 [BPC1](ERROR): Communications Fault
2017-08-28T18:58:50.588Z,1503946730.588 [CBIT](ERROR): Communications Fault in component: BPC1
2017-08-28T18:58:51.787Z,1503946731.787 [CBIT](INFO): Clearing failed state for component BPC1
2017-08-28T18:58:51.787Z,1503946731.787 [BPC1] No Fault, FailCount= 1
2017-08-28T18:59:54.066Z,1503946794.066 [BPC1](ERROR): Failed to receive battery data
2017-08-28T18:59:54.067Z,1503946794.067 [BPC1] Communications Fault, FailCount= 1
2017-08-28T18:59:54.067Z,1503946794.067 [BPC1](ERROR): Communications Fault
2017-08-28T18:59:54.198Z,1503946794.198 [CBIT](ERROR): Communications Fault in component: BPC1
2017-08-28T18:59:55.382Z,1503946795.382 [CBIT](INFO): Clearing failed state for component BPC1
2017-08-28T18:59:55.382Z,1503946795.382 [BPC1] No Fault, FailCount= 1
2017-08-28T19:00:11.667Z,1503946811.667 [BPC1](ERROR): Failed to receive battery data
2017-08-28T19:00:11.667Z,1503946811.667 [BPC1] Communications Fault, FailCount= 2
2017-08-28T19:00:11.667Z,1503946811.667 [BPC1](ERROR): Communications Fault
2017-08-28T19:00:11.789Z,1503946811.789 [CBIT](ERROR): Communications Fault in component: BPC1
2017-08-28T19:00:12.989Z,1503946812.989 [CBIT](INFO): Clearing failed state for component BPC1
2017-08-28T19:00:12.989Z,1503946812.989 [BPC1] No Fault, FailCount= 2
2017-08-28T19:00:29.261Z,1503946829.261 [BPC1](ERROR): Failed to receive battery data
2017-08-28T19:00:29.261Z,1503946829.261 [BPC1] Communications Fault, FailCount= 3
2017-08-28T19:00:29.261Z,1503946829.261 [BPC1](ERROR): Communications Fault
2017-08-28T19:00:29.415Z,1503946829.415 [CBIT](ERROR): Communications Fault in component: BPC1
2017-08-28T19:00:30.581Z,1503946830.581 [CBIT](INFO): Clearing failed state for component BPC1
2017-08-28T19:00:30.582Z,1503946830.582 [BPC1] No Fault, FailCount= 3
2017-08-28T19:00:46.867Z,1503946846.867 [BPC1](ERROR): Failed to receive battery data
2017-08-28T19:00:46.867Z,1503946846.867 [BPC1] Communications Fault, FailCount= 4
2017-08-28T19:00:46.867Z,1503946846.867 [BPC1](ERROR): Communications Fault
2017-08-28T19:00:46.994Z,1503946846.994 [CBIT](ERROR): Communications Fault in component: BPC1
2017-08-28T19:00:48.189Z,1503946848.189 [CBIT](INFO): Clearing failed state for component BPC1
2017-08-28T19:00:48.190Z,1503946848.190 [BPC1] No Fault, FailCount= 4
2017-08-28T19:01:04.457Z,1503946864.457 [BPC1](ERROR): Failed to receive battery data
2017-08-28T19:01:04.457Z,1503946864.457 [BPC1] Communications Fault, FailCount= 5
2017-08-28T19:01:04.457Z,1503946864.457 [BPC1](ERROR): Communications Fault
2017-08-28T19:01:04.615Z,1503946864.615 [CBIT](ERROR): Communications Fault in component: BPC1
2017-08-28T19:01:05.797Z,1503946865.797 [CBIT](INFO): Clearing failed state for component BPC1
2017-08-28T19:01:05.797Z,1503946865.797 [BPC1] No Fault, FailCount= 5
2017-08-28T19:01:21.658Z,1503946881.658 [BPC1](ERROR): Failed to receive battery data
2017-08-28T19:01:21.658Z,1503946881.658 [BPC1] Communications Fault, FailCount= 6
2017-08-28T19:01:21.658Z,1503946881.658 [BPC1](ERROR): Communications Fault
2017-08-28T19:01:21.779Z,1503946881.779 [CBIT](ERROR): Communications Fault in component: BPC1
2017-08-28T19:01:22.989Z,1503946882.989 [CBIT](INFO): Clearing failed state for component BPC1
2017-08-28T19:01:22.989Z,1503946882.989 [BPC1] No Fault, FailCount= 6
2017-08-28T19:01:39.244Z,1503946899.244 [BPC1](ERROR): Failed to receive battery data
2017-08-28T19:01:39.244Z,1503946899.244 [BPC1] Communications Fault, FailCount= 7
2017-08-28T19:01:39.244Z,1503946899.244 [BPC1](ERROR): Communications Fault
2017-08-28T19:01:39.394Z,1503946899.394 [CBIT](ERROR): Communications Fault in component: BPC1
2017-08-28T19:01:40.592Z,1503946900.592 [CBIT](INFO): Clearing failed state for component BPC1
2017-08-28T19:01:40.592Z,1503946900.592 [BPC1] No Fault, FailCount= 7
2017-08-28T19:01:43.397Z,1503946903.397 [CBIT](DEBUG): EFC running - data check-sum false
2017-08-28T19:01:51.681Z,1503946911.681 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2017-08-28T19:01:51.682Z,1503946911.682 [Default:CheckIn:C.Wait] Stopped
2017-08-28T19:01:51.682Z,1503946911.682 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2017-08-28T19:01:51.682Z,1503946911.682 [Default:CheckIn:D] Running Loop=1
2017-08-28T19:01:52.077Z,1503946912.077 [Default:CheckIn:D] Stopped
2017-08-28T19:01:52.077Z,1503946912.077 [Default:CheckIn:E] Running Loop=1
2017-08-28T19:01:52.484Z,1503946912.484 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 7.244720 min 
2017-08-28T19:01:52.485Z,1503946912.485 [Default:CheckIn:E] Stopped
2017-08-28T19:01:52.485Z,1503946912.485 [Default:CheckIn](INFO): Completed Default:CheckIn
2017-08-28T19:01:52.485Z,1503946912.485 [Default:CheckIn] Stopped
2017-08-28T19:01:52.485Z,1503946912.485 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2017-08-28T19:01:52.485Z,1503946912.485 [Default:CheckIn](INFO): Running loop #2
2017-08-28T19:01:52.485Z,1503946912.485 [Default:CheckIn] Running Loop=2
2017-08-28T19:01:52.485Z,1503946912.485 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2017-08-28T19:01:52.486Z,1503946912.486 [Default:CheckIn:Read_GPS] Running Loop=1
2017-08-28T19:01:53.231Z,1503946913.231 [NAL9602](INFO): Powering up
2017-08-28T19:01:56.858Z,1503946916.858 [BPC1](ERROR): Failed to receive battery data
2017-08-28T19:01:56.858Z,1503946916.858 [BPC1] Communications Fault, FailCount= 8
2017-08-28T19:01:56.858Z,1503946916.858 [BPC1](ERROR): Communications Fault
2017-08-28T19:01:57.018Z,1503946917.018 [CBIT](ERROR): Communications Fault in component: BPC1
2017-08-28T19:01:58.220Z,1503946918.220 [CBIT](INFO): Clearing failed state for component BPC1
2017-08-28T19:01:58.220Z,1503946918.220 [BPC1] No Fault, FailCount= 8
2017-08-28T19:02:04.431Z,1503946924.431 [NAL9602](INFO): NAL9602 initialized
2017-08-28T19:02:29.239Z,1503946949.239 [NAL9602](INFO): SBD MO Status=2, MOMSN=118, MT Status=2, MTMSN=0
2017-08-28T19:02:29.239Z,1503946949.239 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2017-08-28T19:03:36.833Z,1503947016.833 [NAL9602](INFO): SBD MO Status=2, MOMSN=118, MT Status=2, MTMSN=0
2017-08-28T19:03:36.833Z,1503947016.833 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2017-08-28T19:03:58.872Z,1503947038.872 [BPC1](ERROR): Failed to parse bank A battery data
2017-08-28T19:03:58.872Z,1503947038.872 [BPC1] Data Fault, FailCount= 1
2017-08-28T19:03:58.872Z,1503947038.872 [BPC1](ERROR): Data Fault
2017-08-28T19:03:58.997Z,1503947038.997 [CBIT](ERROR): Data Fault in component: BPC1
2017-08-28T19:04:00.189Z,1503947040.189 [CBIT](INFO): Clearing failed state for component BPC1
2017-08-28T19:04:00.189Z,1503947040.189 [BPC1] No Fault, FailCount= 1
2017-08-28T19:04:24.432Z,1503947064.432 [NAL9602](INFO): SBD MO Status=2, MOMSN=118, MT Status=2, MTMSN=0
2017-08-28T19:04:24.432Z,1503947064.432 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2017-08-28T19:04:48.839Z,1503947088.839 [NAL9602](IMPORTANT): SBD MO Status=0, MOMSN=118, MT Status=1, MTMSN=905
2017-08-28T19:04:48.839Z,1503947088.839 [NAL9602](INFO): Data available in MT queue
2017-08-28T19:04:49.333Z,1503947089.333 [NAL9602](INFO): Received command:! ps -eaf | grep -i ppp
2017-08-28T19:04:49.375Z,1503947089.375 [CommandLine](IMPORTANT): got command ! ps -eaf | grep -i ppp
2017-08-28T19:04:49.880Z,1503947089.880 [CommandLine](IMPORTANT): root     1255  764  0 19:04 pts/0    00:00:00 sh -c ps -eaf | grep -i ppp
root     1257 1255  0 19:04 pts/0    00:00:00 grep -i ppp

2017-08-28T19:04:50.433Z,1503947090.433 [NAL9602](INFO): GPS fix at 20170828T190449: (36.802318, -121.787151)
2017-08-28T19:04:50.505Z,1503947090.505 [Default:CheckIn:Read_GPS] Stopped
2017-08-28T19:04:50.505Z,1503947090.505 [Default:CheckIn:Read_Iridium] Running Loop=1
2017-08-28T19:05:12.296Z,1503947112.296 [NAL9602](INFO): SBD MO Status=2, MOMSN=119, MT Status=2, MTMSN=0
2017-08-28T19:05:12.296Z,1503947112.296 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2017-08-28T19:05:22.884Z,1503947122.884 [NAL9602](INFO): SBD MO Status=1, MOMSN=119, MT Status=0, MTMSN=0
2017-08-28T19:05:22.934Z,1503947122.934 [NAL9602](INFO): Sent 65 bytes from file Logs/20170828T184133/Courier0016.lzma
2017-08-28T19:05:22.934Z,1503947122.934 [NAL9602](INFO): Packets left to send: 0
2017-08-28T19:05:22.936Z,1503947122.936 [NAL9602](DEBUG): Stored copy of sent data in Logs/20170828T184133/Courier0016.lzma.parts/0000.sbd
2017-08-28T19:05:22.936Z,1503947122.936 [NAL9602](DEBUG): Completed sending Logs/20170828T184133/Courier0016.lzma
2017-08-28T19:05:38.381Z,1503947138.381 [NAL9602](INFO): SBD MO Status=2, MOMSN=120, MT Status=2, MTMSN=0
2017-08-28T19:05:38.381Z,1503947138.381 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2017-08-28T19:06:00.175Z,1503947160.175 [NAL9602](INFO): SBD MO Status=1, MOMSN=120, MT Status=0, MTMSN=0
2017-08-28T19:06:00.229Z,1503947160.229 [NAL9602](INFO): Sent 258 bytes from file Logs/20170828T184133/Express0017.lzma
2017-08-28T19:06:00.229Z,1503947160.229 [NAL9602](INFO): Packets left to send: 0
2017-08-28T19:06:00.231Z,1503947160.231 [NAL9602](DEBUG): Stored copy of sent data in Logs/20170828T184133/Express0017.lzma.parts/0000.sbd
2017-08-28T19:06:00.231Z,1503947160.231 [NAL9602](DEBUG): Completed sending Logs/20170828T184133/Express0017.lzma
2017-08-28T19:06:02.216Z,1503947162.216 [PNI_TCM](ERROR): CRC does not match. Expected:0x19110 got:0x0
2017-08-28T19:06:07.014Z,1503947167.014 [PNI_TCM](ERROR): CRC does not match. Expected:0x31947 got:0x917
2017-08-28T19:06:08.608Z,1503947168.608 [PNI_TCM](ERROR): CRC does not match. Expected:0x37142 got:0x16917
2017-08-28T19:06:10.212Z,1503947170.212 [PNI_TCM](ERROR): CRC does not match. Expected:0x39859 got:0x64451
2017-08-28T19:06:10.574Z,1503947170.574 [NAL9602](INFO): SBD MO Status=0, MOMSN=121, MT Status=0, MTMSN=0
2017-08-28T19:06:20.452Z,1503947180.452 [NAL9602](INFO): SBD MO Status=1, MOMSN=122, MT Status=0, MTMSN=0
2017-08-28T19:06:20.501Z,1503947180.501 [NAL9602](INFO): Sent 25 bytes from file Logs/20170828T184133/Courier0020.lzma
2017-08-28T19:06:20.502Z,1503947180.502 [NAL9602](INFO): Packets left to send: 0
2017-08-28T19:06:20.503Z,1503947180.503 [NAL9602](DEBUG): Stored copy of sent data in Logs/20170828T184133/Courier0020.lzma.parts/0000.sbd
2017-08-28T19:06:20.504Z,1503947180.504 [NAL9602](DEBUG): Completed sending Logs/20170828T184133/Courier0020.lzma
2017-08-28T19:06:31.521Z,1503947191.521 [NAL9602](INFO): SBD MO Status=1, MOMSN=123, MT Status=0, MTMSN=0
2017-08-28T19:06:31.575Z,1503947191.575 [NAL9602](INFO): Sent 62 bytes from file Logs/20170828T184133/Express0021.lzma
2017-08-28T19:06:31.575Z,1503947191.575 [NAL9602](INFO): Packets left to send: 0
2017-08-28T19:06:31.589Z,1503947191.589 [NAL9602](DEBUG): Stored copy of sent data in Logs/20170828T184133/Express0021.lzma.parts/0000.sbd
2017-08-28T19:06:31.589Z,1503947191.589 [NAL9602](DEBUG): Completed sending Logs/20170828T184133/Express0021.lzma
2017-08-28T19:06:46.723Z,1503947206.723 [NAL9602](INFO): SBD MO Status=2, MOMSN=124, MT Status=2, MTMSN=0
2017-08-28T19:06:46.724Z,1503947206.724 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2017-08-28T19:07:03.129Z,1503947223.129 [NAL9602](INFO): SBD MO Status=2, MOMSN=124, MT Status=2, MTMSN=0
2017-08-28T19:07:03.130Z,1503947223.130 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2017-08-28T19:07:07.921Z,1503947227.921 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0
2017-08-28T19:07:29.116Z,1503947249.116 [NAL9602](INFO): SBD MO Status=0, MOMSN=124, MT Status=0, MTMSN=0
2017-08-28T19:07:29.221Z,1503947249.221 [Default:CheckIn:Read_Iridium] Stopped
2017-08-28T19:07:29.222Z,1503947249.222 [Default:CheckIn:C.Wait] Running Loop=1
2017-08-28T19:07:29.222Z,1503947249.222 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2017-08-28T19:07:34.717Z,1503947254.717 [NAL9602](INFO): Powering down
2017-08-28T19:08:36.754Z,1503947316.754 [BPC1](ERROR): Failed to receive battery data
2017-08-28T19:08:36.755Z,1503947316.755 [BPC1] Communications Fault, FailCount= 1
2017-08-28T19:08:36.755Z,1503947316.755 [BPC1](ERROR): Communications Fault
2017-08-28T19:08:36.878Z,1503947316.878 [CBIT](ERROR): Communications Fault in component: BPC1
2017-08-28T19:08:38.064Z,1503947318.064 [CBIT](INFO): Clearing failed state for component BPC1
2017-08-28T19:08:38.064Z,1503947318.064 [BPC1] No Fault, FailCount= 1
2017-08-28T19:08:56.756Z,1503947336.756 [BPC1](ERROR): Failed to receive battery data
2017-08-28T19:08:56.756Z,1503947336.756 [BPC1] Communications Fault, FailCount= 2
2017-08-28T19:08:56.756Z,1503947336.756 [BPC1](ERROR): Communications Fault
2017-08-28T19:08:56.878Z,1503947336.878 [CBIT](ERROR): Communications Fault in component: BPC1
2017-08-28T19:08:58.080Z,1503947338.080 [CBIT](INFO): Clearing failed state for component BPC1
2017-08-28T19:08:58.080Z,1503947338.080 [BPC1] No Fault, FailCount= 2
2017-08-28T19:09:27.545Z,1503947367.545 [BPC1](ERROR): Failed to receive battery data
2017-08-28T19:09:27.545Z,1503947367.545 [BPC1] Communications Fault, FailCount= 1
2017-08-28T19:09:27.545Z,1503947367.545 [BPC1](ERROR): Communications Fault
2017-08-28T19:09:27.711Z,1503947367.711 [CBIT](ERROR): Communications Fault in component: BPC1
2017-08-28T19:09:28.885Z,1503947368.885 [CBIT](INFO): Clearing failed state for component BPC1
2017-08-28T19:09:28.885Z,1503947368.885 [BPC1] No Fault, FailCount= 1
2017-08-28T19:09:44.753Z,1503947384.753 [BPC1](ERROR): Failed to receive battery data
2017-08-28T19:09:44.753Z,1503947384.753 [BPC1] Communications Fault, FailCount= 2
2017-08-28T19:09:44.753Z,1503947384.753 [BPC1](ERROR): Communications Fault
2017-08-28T19:09:44.874Z,1503947384.874 [CBIT](ERROR): Communications Fault in component: BPC1
2017-08-28T19:09:46.076Z,1503947386.076 [CBIT](INFO): Clearing failed state for component BPC1
2017-08-28T19:09:46.076Z,1503947386.076 [BPC1] No Fault, FailCount= 2
2017-08-28T19:10:02.350Z,1503947402.350 [BPC1](ERROR): Failed to receive battery data
2017-08-28T19:10:02.350Z,1503947402.350 [BPC1] Communications Fault, FailCount= 3
2017-08-28T19:10:02.350Z,1503947402.350 [BPC1](ERROR): Communications Fault
2017-08-28T19:10:02.502Z,1503947402.502 [CBIT](ERROR): Communications Fault in component: BPC1
2017-08-28T19:10:03.674Z,1503947403.674 [CBIT](INFO): Clearing failed state for component BPC1
2017-08-28T19:10:03.674Z,1503947403.674 [BPC1] No Fault, FailCount= 3
2017-08-28T19:10:19.949Z,1503947419.949 [BPC1](ERROR): Failed to receive battery data
2017-08-28T19:10:19.949Z,1503947419.949 [BPC1] Communications Fault, FailCount= 4
2017-08-28T19:10:19.949Z,1503947419.949 [BPC1](ERROR): Communications Fault
2017-08-28T19:10:20.074Z,1503947420.074 [CBIT](ERROR): Communications Fault in component: BPC1
2017-08-28T19:10:21.280Z,1503947421.280 [CBIT](INFO): Clearing failed state for component BPC1
2017-08-28T19:10:21.280Z,1503947421.280 [BPC1] No Fault, FailCount= 4
2017-08-28T19:10:37.549Z,1503947437.549 [BPC1](ERROR): Failed to receive battery data
2017-08-28T19:10:37.549Z,1503947437.549 [BPC1] Communications Fault, FailCount= 5
2017-08-28T19:10:37.549Z,1503947437.549 [BPC1](ERROR): Communications Fault
2017-08-28T19:10:37.669Z,1503947437.669 [CBIT](ERROR): Communications Fault in component: BPC1
2017-08-28T19:10:38.879Z,1503947438.879 [CBIT](INFO): Clearing failed state for component BPC1
2017-08-28T19:10:38.879Z,1503947438.879 [BPC1] No Fault, FailCount= 5
2017-08-28T19:10:54.755Z,1503947454.755 [BPC1](ERROR): Failed to receive battery data
2017-08-28T19:10:54.755Z,1503947454.755 [BPC1] Communications Fault, FailCount= 6
2017-08-28T19:10:54.755Z,1503947454.755 [BPC1](ERROR): Communications Fault
2017-08-28T19:10:54.877Z,1503947454.877 [CBIT](ERROR): Communications Fault in component: BPC1
2017-08-28T19:10:56.079Z,1503947456.079 [CBIT](INFO): Clearing failed state for component BPC1
2017-08-28T19:10:56.079Z,1503947456.079 [BPC1] No Fault, FailCount= 6
2017-08-28T19:11:12.346Z,1503947472.346 [BPC1](ERROR): Failed to receive battery data
2017-08-28T19:11:12.346Z,1503947472.346 [BPC1] Communications Fault, FailCount= 7
2017-08-28T19:11:12.346Z,1503947472.346 [BPC1](ERROR): Communications Fault
2017-08-28T19:11:12.501Z,1503947472.501 [CBIT](ERROR): Communications Fault in component: BPC1
2017-08-28T19:11:13.666Z,1503947473.666 [CBIT](INFO): Clearing failed state for component BPC1
2017-08-28T19:11:13.666Z,1503947473.666 [BPC1] No Fault, FailCount= 7
2017-08-28T19:11:29.951Z,1503947489.951 [BPC1](ERROR): Failed to receive battery data
2017-08-28T19:11:29.951Z,1503947489.951 [BPC1] Communications Fault, FailCount= 8
2017-08-28T19:11:29.951Z,1503947489.951 [BPC1](ERROR): Communications Fault
2017-08-28T19:11:30.072Z,1503947490.072 [CBIT](ERROR): Communications Fault in component: BPC1
2017-08-28T19:11:31.286Z,1503947491.286 [CBIT](INFO): Clearing failed state for component BPC1
2017-08-28T19:11:31.286Z,1503947491.286 [BPC1] No Fault, FailCount= 8
2017-08-28T19:11:43.681Z,1503947503.681 [CBIT](DEBUG): EFC running - data check-sum false
2017-08-28T19:11:47.151Z,1503947507.151 [BPC1](ERROR): Failed to receive battery data
2017-08-28T19:11:47.151Z,1503947507.151 [BPC1] Communications Fault, FailCount= 9
2017-08-28T19:11:47.151Z,1503947507.151 [BPC1](ERROR): Communications Fault
2017-08-28T19:11:47.272Z,1503947507.272 [CBIT](ERROR): Communications Fault in component: BPC1
2017-08-28T19:11:48.477Z,1503947508.477 [CBIT](INFO): Clearing failed state for component BPC1
2017-08-28T19:11:48.477Z,1503947508.477 [BPC1] No Fault, FailCount= 9
2017-08-28T19:12:29.571Z,1503947549.571 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2017-08-28T19:12:29.571Z,1503947549.571 [Default:CheckIn:C.Wait] Stopped
2017-08-28T19:12:29.571Z,1503947549.571 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2017-08-28T19:12:29.571Z,1503947549.571 [Default:CheckIn:D] Running Loop=1
2017-08-28T19:12:30.022Z,1503947550.022 [Default:CheckIn:D] Stopped
2017-08-28T19:12:30.022Z,1503947550.022 [Default:CheckIn:E] Running Loop=1
2017-08-28T19:12:30.371Z,1503947550.371 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 17.877126 min 
2017-08-28T19:12:30.372Z,1503947550.372 [Default:CheckIn:E] Stopped
2017-08-28T19:12:30.372Z,1503947550.372 [Default:CheckIn](INFO): Completed Default:CheckIn
2017-08-28T19:12:30.372Z,1503947550.372 [Default:CheckIn] Stopped
2017-08-28T19:12:30.372Z,1503947550.372 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2017-08-28T19:12:30.372Z,1503947550.372 [Default:CheckIn](INFO): Running loop #3
2017-08-28T19:12:30.372Z,1503947550.372 [Default:CheckIn] Running Loop=3
2017-08-28T19:12:30.372Z,1503947550.372 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2017-08-28T19:12:30.372Z,1503947550.372 [Default:CheckIn:Read_GPS] Running Loop=1
2017-08-28T19:12:31.116Z,1503947551.116 [NAL9602](INFO): Powering up
2017-08-28T19:12:41.928Z,1503947561.928 [NAL9602](INFO): NAL9602 initialized
2017-08-28T19:12:58.717Z,1503947578.717 [NAL9602](IMPORTANT): SBD MO Status=0, MOMSN=125, MT Status=1, MTMSN=906
2017-08-28T19:12:58.718Z,1503947578.718 [NAL9602](INFO): Data available in MT queue
2017-08-28T19:12:59.228Z,1503947579.228 [NAL9602](INFO): Received command:! echo 0 > /dev/loadB6
2017-08-28T19:12:59.288Z,1503947579.288 [CommandLine](IMPORTANT): got command ! echo 0 > /dev/loadB6
2017-08-28T19:13:03.127Z,1503947583.127 [NAL9602](INFO): GPS fix at 20170828T191300: (36.802516, -121.787005)
2017-08-28T19:13:03.185Z,1503947583.185 [Default:CheckIn:Read_GPS] Stopped
2017-08-28T19:13:03.185Z,1503947583.185 [Default:CheckIn:Read_Iridium] Running Loop=1
2017-08-28T19:13:13.388Z,1503947593.388 [BPC1](ERROR): Failed to parse bank A battery data
2017-08-28T19:13:13.388Z,1503947593.388 [BPC1] Data Fault, FailCount= 1
2017-08-28T19:13:13.389Z,1503947593.389 [BPC1](ERROR): Data Fault
2017-08-28T19:13:13.524Z,1503947593.524 [CBIT](ERROR): Data Fault in component: BPC1
2017-08-28T19:13:14.690Z,1503947594.690 [CBIT](INFO): Clearing failed state for component BPC1
2017-08-28T19:13:14.690Z,1503947594.690 [BPC1] No Fault, FailCount= 1
2017-08-28T19:13:20.135Z,1503947600.135 [NAL9602](INFO): SBD MO Status=1, MOMSN=126, MT Status=0, MTMSN=0
2017-08-28T19:13:20.205Z,1503947600.205 [NAL9602](INFO): Sent 63 bytes from file Logs/20170828T184133/Courier0024.lzma
2017-08-28T19:13:20.205Z,1503947600.205 [NAL9602](INFO): Packets left to send: 0
2017-08-28T19:13:20.207Z,1503947600.207 [NAL9602](DEBUG): Stored copy of sent data in Logs/20170828T184133/Courier0024.lzma.parts/0000.sbd
2017-08-28T19:13:20.207Z,1503947600.207 [NAL9602](DEBUG): Completed sending Logs/20170828T184133/Courier0024.lzma
2017-08-28T19:13:28.737Z,1503947608.737 [NAL9602](INFO): SBD MO Status=1, MOMSN=127, MT Status=0, MTMSN=0
2017-08-28T19:13:28.794Z,1503947608.794 [NAL9602](INFO): Sent 200 bytes from file Logs/20170828T184133/Express0025.lzma
2017-08-28T19:13:28.795Z,1503947608.795 [NAL9602](INFO): Packets left to send: 0
2017-08-28T19:13:28.796Z,1503947608.796 [NAL9602](DEBUG): Stored copy of sent data in Logs/20170828T184133/Express0025.lzma.parts/0000.sbd
2017-08-28T19:13:28.797Z,1503947608.797 [NAL9602](DEBUG): Completed sending Logs/20170828T184133/Express0025.lzma
2017-08-28T19:13:46.344Z,1503947626.344 [NAL9602](INFO): SBD MO Status=2, MOMSN=128, MT Status=2, MTMSN=0
2017-08-28T19:13:46.344Z,1503947626.344 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2017-08-28T19:13:56.332Z,1503947636.332 [NAL9602](INFO): SBD MO Status=0, MOMSN=128, MT Status=0, MTMSN=0
2017-08-28T19:14:15.019Z,1503947655.019 [NAL9602](INFO): SBD MO Status=1, MOMSN=129, MT Status=0, MTMSN=0
2017-08-28T19:14:15.072Z,1503947655.072 [NAL9602](INFO): Sent 25 bytes from file Logs/20170828T184133/Courier0028.lzma
2017-08-28T19:14:15.072Z,1503947655.072 [NAL9602](INFO): Packets left to send: 0
2017-08-28T19:14:15.073Z,1503947655.073 [NAL9602](DEBUG): Stored copy of sent data in Logs/20170828T184133/Courier0028.lzma.parts/0000.sbd
2017-08-28T19:14:15.074Z,1503947655.074 [NAL9602](DEBUG): Completed sending Logs/20170828T184133/Courier0028.lzma
2017-08-28T19:14:22.446Z,1503947662.446 [NAL9602](INFO): SBD MO Status=1, MOMSN=130, MT Status=0, MTMSN=0
2017-08-28T19:14:22.504Z,1503947662.504 [NAL9602](INFO): Sent 62 bytes from file Logs/20170828T184133/Express0029.lzma
2017-08-28T19:14:22.505Z,1503947662.505 [NAL9602](INFO): Packets left to send: 0
2017-08-28T19:14:22.506Z,1503947662.506 [NAL9602](DEBUG): Stored copy of sent data in Logs/20170828T184133/Express0029.lzma.parts/0000.sbd
2017-08-28T19:14:22.507Z,1503947662.507 [NAL9602](DEBUG): Completed sending Logs/20170828T184133/Express0029.lzma
2017-08-28T19:14:31.640Z,1503947671.640 [NAL9602](IMPORTANT): SBD MO Status=0, MOMSN=131, MT Status=1, MTMSN=907
2017-08-28T19:14:32.139Z,1503947672.139 [NAL9602](INFO): Received command:! echo 1 > /dev/loadB6
2017-08-28T19:14:32.158Z,1503947672.158 [CommandLine](IMPORTANT): got command ! echo 1 > /dev/loadB6
2017-08-28T19:14:45.242Z,1503947685.242 [NAL9602](INFO): SBD MO Status=0, MOMSN=132, MT Status=0, MTMSN=0
2017-08-28T19:15:02.289Z,1503947702.289 [NAL9602](INFO): SBD MO Status=1, MOMSN=133, MT Status=0, MTMSN=0
2017-08-28T19:15:02.338Z,1503947702.338 [NAL9602](INFO): Sent 25 bytes from file Logs/20170828T184133/Courier0032.lzma
2017-08-28T19:15:02.339Z,1503947702.339 [NAL9602](INFO): Packets left to send: 0
2017-08-28T19:15:02.340Z,1503947702.340 [NAL9602](DEBUG): Stored copy of sent data in Logs/20170828T184133/Courier0032.lzma.parts/0000.sbd
2017-08-28T19:15:02.340Z,1503947702.340 [NAL9602](DEBUG): Completed sending Logs/20170828T184133/Courier0032.lzma
2017-08-28T19:15:15.297Z,1503947715.297 [NAL9602](INFO): SBD MO Status=1, MOMSN=134, MT Status=0, MTMSN=0
2017-08-28T19:15:15.357Z,1503947715.357 [NAL9602](INFO): Sent 149 bytes from file Logs/20170828T184133/Express0033.lzma
2017-08-28T19:15:15.357Z,1503947715.357 [NAL9602](INFO): Packets left to send: 0
2017-08-28T19:15:15.359Z,1503947715.359 [NAL9602](DEBUG): Stored copy of sent data in Logs/20170828T184133/Express0033.lzma.parts/0000.sbd
2017-08-28T19:15:15.359Z,1503947715.359 [NAL9602](DEBUG): Completed sending Logs/20170828T184133/Express0033.lzma
2017-08-28T19:15:32.498Z,1503947732.498 [NAL9602](INFO): SBD MO Status=0, MOMSN=135, MT Status=0, MTMSN=0
2017-08-28T19:15:32.602Z,1503947732.602 [Default:CheckIn:Read_Iridium] Stopped
2017-08-28T19:15:32.603Z,1503947732.603 [Default:CheckIn:C.Wait] Running Loop=1
2017-08-28T19:15:32.603Z,1503947732.603 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2017-08-28T19:15:38.090Z,1503947738.090 [NAL9602](INFO): Powering down
2017-08-28T19:18:00.835Z,1503947880.835 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004107
2017-08-28T19:18:42.758Z,1503947922.758 [CommandLine](IMPORTANT): got command failComponent
2017-08-28T19:18:42.759Z,1503947922.759 [CommandLine](IMPORTANT): Failed components:
2017-08-28T19:18:42.759Z,1503947922.759 [CommandLine](IMPORTANT): No failed Components.
2017-08-28T19:18:46.638Z,1503947926.638 [CommandLine](IMPORTANT): got command get platform_battery_charge
2017-08-28T19:18:46.639Z,1503947926.639 [CommandLine](FAULT): Element has no value
2017-08-28T19:18:54.758Z,1503947934.758 [CommandLine](IMPORTANT): got command get BPC1.loadAtStartup
2017-08-28T19:18:54.758Z,1503947934.758 [CommandLine](IMPORTANT): BPC1.loadAtStartup 1 bool
2017-08-28T19:19:00.396Z,1503947940.396 [CommandLine](IMPORTANT): got command show variable bpc1
2017-08-28T19:19:00.448Z,1503947940.448 [CommandLine](IMPORTANT): BPC1.loadAtStartup (bool)
2017-08-28T19:19:00.448Z,1503947940.448 [CommandLine](IMPORTANT): BPC1.simulateHardware (bool)
2017-08-28T19:19:00.499Z,1503947940.499 [CommandLine](IMPORTANT): BPC1A.uart (none)
2017-08-28T19:19:00.500Z,1503947940.500 [CommandLine](IMPORTANT): BPC1A.baud (bit_per_second)
2017-08-28T19:19:00.500Z,1503947940.500 [CommandLine](IMPORTANT): BPC1B.uart (none)
2017-08-28T19:19:00.500Z,1503947940.500 [CommandLine](IMPORTANT): BPC1B.baud (bit_per_second)
2017-08-28T19:19:00.537Z,1503947940.537 [CommandLine](IMPORTANT): BPC1.BattTemp_0 (celsius)
2017-08-28T19:19:00.538Z,1503947940.538 [CommandLine](IMPORTANT): BPC1.BattVoltage_0 (volt)
2017-08-28T19:19:00.538Z,1503947940.538 [CommandLine](IMPORTANT): BPC1.BattCurrent_0 (ampere)
2017-08-28T19:19:00.538Z,1503947940.538 [CommandLine](IMPORTANT): BPC1.BattCapacity_0 (ampere_hour)
2017-08-28T19:19:00.559Z,1503947940.559 [CommandLine](IMPORTANT): BPC1.BattStatus_0 (enum)
2017-08-28T19:19:00.559Z,1503947940.559 [CommandLine](IMPORTANT): BPC1.BattSerial_0 (count)
2017-08-28T19:19:00.560Z,1503947940.560 [CommandLine](IMPORTANT): BPC1.BattTemp_1 (celsius)
2017-08-28T19:19:00.560Z,1503947940.560 [CommandLine](IMPORTANT): BPC1.BattVoltage_1 (volt)
2017-08-28T19:19:00.560Z,1503947940.560 [CommandLine](IMPORTANT): BPC1.BattCurrent_1 (ampere)
2017-08-28T19:19:00.561Z,1503947940.561 [CommandLine](IMPORTANT): BPC1.BattCapacity_1 (ampere_hour)
2017-08-28T19:19:00.561Z,1503947940.561 [CommandLine](IMPORTANT): BPC1.BattStatus_1 (enum)
2017-08-28T19:19:00.561Z,1503947940.561 [CommandLine](IMPORTANT): BPC1.BattSerial_1 (count)
2017-08-28T19:19:00.562Z,1503947940.562 [CommandLine](IMPORTANT): BPC1.BattTemp_2 (celsius)
2017-08-28T19:19:00.562Z,1503947940.562 [CommandLine](IMPORTANT): BPC1.BattVoltage_2 (volt)
2017-08-28T19:19:00.562Z,1503947940.562 [CommandLine](IMPORTANT): BPC1.BattCurrent_2 (ampere)
2017-08-28T19:19:00.563Z,1503947940.563 [CommandLine](IMPORTANT): BPC1.BattCapacity_2 (ampere_hour)
2017-08-28T19:19:00.563Z,1503947940.563 [CommandLine](IMPORTANT): BPC1.BattStatus_2 (enum)
2017-08-28T19:19:00.564Z,1503947940.564 [CommandLine](IMPORTANT): BPC1.BattSerial_2 (count)
2017-08-28T19:19:00.564Z,1503947940.564 [CommandLine](IMPORTANT): BPC1.BattTemp_3 (celsius)
2017-08-28T19:19:00.564Z,1503947940.564 [CommandLine](IMPORTANT): BPC1.BattVoltage_3 (volt)
2017-08-28T19:19:00.565Z,1503947940.565 [CommandLine](IMPORTANT): BPC1.BattCurrent_3 (ampere)
2017-08-28T19:19:00.565Z,1503947940.565 [CommandLine](IMPORTANT): BPC1.BattCapacity_3 (ampere_hour)
2017-08-28T19:19:00.565Z,1503947940.565 [CommandLine](IMPORTANT): BPC1.BattStatus_3 (enum)
2017-08-28T19:19:00.566Z,1503947940.566 [CommandLine](IMPORTANT): BPC1.BattSerial_3 (count)
2017-08-28T19:19:00.566Z,1503947940.566 [CommandLine](IMPORTANT): BPC1.BattTemp_4 (celsius)
2017-08-28T19:19:00.566Z,1503947940.566 [CommandLine](IMPORTANT): BPC1.BattVoltage_4 (volt)
2017-08-28T19:19:00.567Z,1503947940.567 [CommandLine](IMPORTANT): BPC1.BattCurrent_4 (ampere)
2017-08-28T19:19:00.567Z,1503947940.567 [CommandLine](IMPORTANT): BPC1.BattCapacity_4 (ampere_hour)
2017-08-28T19:19:00.567Z,1503947940.567 [CommandLine](IMPORTANT): BPC1.BattStatus_4 (enum)
2017-08-28T19:19:00.568Z,1503947940.568 [CommandLine](IMPORTANT): BPC1.BattSerial_4 (count)
2017-08-28T19:19:00.568Z,1503947940.568 [CommandLine](IMPORTANT): BPC1.BattTemp_5 (celsius)
2017-08-28T19:19:00.569Z,1503947940.569 [CommandLine](IMPORTANT): BPC1.BattVoltage_5 (volt)
2017-08-28T19:19:00.569Z,1503947940.569 [CommandLine](IMPORTANT): BPC1.BattCurrent_5 (ampere)
2017-08-28T19:19:00.569Z,1503947940.569 [CommandLine](IMPORTANT): BPC1.BattCapacity_5 (ampere_hour)
2017-08-28T19:19:00.570Z,1503947940.570 [CommandLine](IMPORTANT): BPC1.BattStatus_5 (enum)
2017-08-28T19:19:00.570Z,1503947940.570 [CommandLine](IMPORTANT): BPC1.BattSerial_5 (count)
2017-08-28T19:19:00.570Z,1503947940.570 [CommandLine](IMPORTANT): BPC1.BattTemp_6 (celsius)
2017-08-28T19:19:00.581Z,1503947940.581 [CommandLine](IMPORTANT): BPC1.BattVoltage_6 (volt)
2017-08-28T19:19:00.581Z,1503947940.581 [CommandLine](IMPORTANT): BPC1.BattCurrent_6 (ampere)
2017-08-28T19:19:00.582Z,1503947940.582 [CommandLine](IMPORTANT): BPC1.BattCapacity_6 (ampere_hour)
2017-08-28T19:19:00.582Z,1503947940.582 [CommandLine](IMPORTANT): BPC1.BattStatus_6 (enum)
2017-08-28T19:19:00.582Z,1503947940.582 [CommandLine](IMPORTANT): BPC1.BattSerial_6 (count)
2017-08-28T19:19:00.583Z,1503947940.583 [CommandLine](IMPORTANT): BPC1.BattTemp_7 (celsius)
2017-08-28T19:19:00.583Z,1503947940.583 [CommandLine](IMPORTANT): BPC1.BattVoltage_7 (volt)
2017-08-28T19:19:00.583Z,1503947940.583 [CommandLine](IMPORTANT): BPC1.BattCurrent_7 (ampere)
2017-08-28T19:19:00.584Z,1503947940.584 [CommandLine](IMPORTANT): BPC1.BattCapacity_7 (ampere_hour)
2017-08-28T19:19:00.584Z,1503947940.584 [CommandLine](IMPORTANT): BPC1.BattStatus_7 (enum)
2017-08-28T19:19:00.584Z,1503947940.584 [CommandLine](IMPORTANT): BPC1.BattSerial_7 (count)
2017-08-28T19:19:00.585Z,1503947940.585 [CommandLine](IMPORTANT): BPC1.BattTemp_8 (celsius)
2017-08-28T19:19:00.585Z,1503947940.585 [CommandLine](IMPORTANT): BPC1.BattVoltage_8 (volt)
2017-08-28T19:19:00.585Z,1503947940.585 [CommandLine](IMPORTANT): BPC1.BattCurrent_8 (ampere)
2017-08-28T19:19:00.586Z,1503947940.586 [CommandLine](IMPORTANT): BPC1.BattCapacity_8 (ampere_hour)
2017-08-28T19:19:00.586Z,1503947940.586 [CommandLine](IMPORTANT): BPC1.BattStatus_8 (enum)
2017-08-28T19:19:00.586Z,1503947940.586 [CommandLine](IMPORTANT): BPC1.BattSerial_8 (count)
2017-08-28T19:19:00.599Z,1503947940.599 [CommandLine](IMPORTANT): BPC1.BattTemp_9 (celsius)
2017-08-28T19:19:00.600Z,1503947940.600 [CommandLine](IMPORTANT): BPC1.BattVoltage_9 (volt)
2017-08-28T19:19:00.600Z,1503947940.600 [CommandLine](IMPORTANT): BPC1.BattCurrent_9 (ampere)
2017-08-28T19:19:00.601Z,1503947940.601 [CommandLine](IMPORTANT): BPC1.BattCapacity_9 (ampere_hour)
2017-08-28T19:19:00.601Z,1503947940.601 [CommandLine](IMPORTANT): BPC1.BattStatus_9 (enum)
2017-08-28T19:19:00.602Z,1503947940.602 [CommandLine](IMPORTANT): BPC1.BattSerial_9 (count)
2017-08-28T19:19:00.602Z,1503947940.602 [CommandLine](IMPORTANT): BPC1.BattTemp_10 (celsius)
2017-08-28T19:19:00.603Z,1503947940.603 [CommandLine](IMPORTANT): BPC1.BattVoltage_10 (volt)
2017-08-28T19:19:00.603Z,1503947940.603 [CommandLine](IMPORTANT): BPC1.BattCurrent_10 (ampere)
2017-08-28T19:19:00.604Z,1503947940.604 [CommandLine](IMPORTANT): BPC1.BattCapacity_10 (ampere_hour)
2017-08-28T19:19:00.604Z,1503947940.604 [CommandLine](IMPORTANT): BPC1.BattStatus_10 (enum)
2017-08-28T19:19:00.605Z,1503947940.605 [CommandLine](IMPORTANT): BPC1.BattSerial_10 (count)
2017-08-28T19:19:00.605Z,1503947940.605 [CommandLine](IMPORTANT): BPC1.BattTemp_11 (celsius)
2017-08-28T19:19:00.605Z,1503947940.605 [CommandLine](IMPORTANT): BPC1.BattVoltage_11 (volt)
2017-08-28T19:19:00.606Z,1503947940.606 [CommandLine](IMPORTANT): BPC1.BattCurrent_11 (ampere)
2017-08-28T19:19:00.606Z,1503947940.606 [CommandLine](IMPORTANT): BPC1.BattCapacity_11 (ampere_hour)
2017-08-28T19:19:00.607Z,1503947940.607 [CommandLine](IMPORTANT): BPC1.BattStatus_11 (enum)
2017-08-28T19:19:00.607Z,1503947940.607 [CommandLine](IMPORTANT): BPC1.BattSerial_11 (count)
2017-08-28T19:19:00.608Z,1503947940.608 [CommandLine](IMPORTANT): BPC1.BattTemp_12 (celsius)
2017-08-28T19:19:00.608Z,1503947940.608 [CommandLine](IMPORTANT): BPC1.BattVoltage_12 (volt)
2017-08-28T19:19:00.609Z,1503947940.609 [CommandLine](IMPORTANT): BPC1.BattCurrent_12 (ampere)
2017-08-28T19:19:00.609Z,1503947940.609 [CommandLine](IMPORTANT): BPC1.BattCapacity_12 (ampere_hour)
2017-08-28T19:19:00.610Z,1503947940.610 [CommandLine](IMPORTANT): BPC1.BattStatus_12 (enum)
2017-08-28T19:19:00.610Z,1503947940.610 [CommandLine](IMPORTANT): BPC1.BattSerial_12 (count)
2017-08-28T19:19:00.610Z,1503947940.610 [CommandLine](IMPORTANT): BPC1.BattTemp_13 (celsius)
2017-08-28T19:19:00.631Z,1503947940.631 [CommandLine](IMPORTANT): BPC1.BattVoltage_13 (volt)
2017-08-28T19:19:00.631Z,1503947940.631 [CommandLine](IMPORTANT): BPC1.BattCurrent_13 (ampere)
2017-08-28T19:19:00.632Z,1503947940.632 [CommandLine](IMPORTANT): BPC1.BattCapacity_13 (ampere_hour)
2017-08-28T19:19:00.632Z,1503947940.632 [CommandLine](IMPORTANT): BPC1.BattStatus_13 (enum)
2017-08-28T19:19:00.632Z,1503947940.632 [CommandLine](IMPORTANT): BPC1.BattSerial_13 (count)
2017-08-28T19:19:00.633Z,1503947940.633 [CommandLine](IMPORTANT): BPC1.BattTemp_14 (celsius)
2017-08-28T19:19:00.633Z,1503947940.633 [CommandLine](IMPORTANT): BPC1.BattVoltage_14 (volt)
2017-08-28T19:19:00.633Z,1503947940.633 [CommandLine](IMPORTANT): BPC1.BattCurrent_14 (ampere)
2017-08-28T19:19:00.634Z,1503947940.634 [CommandLine](IMPORTANT): BPC1.BattCapacity_14 (ampere_hour)
2017-08-28T19:19:00.634Z,1503947940.634 [CommandLine](IMPORTANT): BPC1.BattStatus_14 (enum)
2017-08-28T19:19:00.634Z,1503947940.634 [CommandLine](IMPORTANT): BPC1.BattSerial_14 (count)
2017-08-28T19:19:00.635Z,1503947940.635 [CommandLine](IMPORTANT): BPC1.BattTemp_15 (celsius)
2017-08-28T19:19:00.635Z,1503947940.635 [CommandLine](IMPORTANT): BPC1.BattVoltage_15 (volt)
2017-08-28T19:19:00.635Z,1503947940.635 [CommandLine](IMPORTANT): BPC1.BattCurrent_15 (ampere)
2017-08-28T19:19:00.636Z,1503947940.636 [CommandLine](IMPORTANT): BPC1.BattCapacity_15 (ampere_hour)
2017-08-28T19:19:00.636Z,1503947940.636 [CommandLine](IMPORTANT): BPC1.BattStatus_15 (enum)
2017-08-28T19:19:00.636Z,1503947940.636 [CommandLine](IMPORTANT): BPC1.BattSerial_15 (count)
2017-08-28T19:19:00.637Z,1503947940.637 [CommandLine](IMPORTANT): BPC1.BattTemp_16 (celsius)
2017-08-28T19:19:00.637Z,1503947940.637 [CommandLine](IMPORTANT): BPC1.BattVoltage_16 (volt)
2017-08-28T19:19:00.637Z,1503947940.637 [CommandLine](IMPORTANT): BPC1.BattCurrent_16 (ampere)
2017-08-28T19:19:00.638Z,1503947940.638 [CommandLine](IMPORTANT): BPC1.BattCapacity_16 (ampere_hour)
2017-08-28T19:19:00.638Z,1503947940.638 [CommandLine](IMPORTANT): BPC1.BattStatus_16 (enum)
2017-08-28T19:19:00.639Z,1503947940.639 [CommandLine](IMPORTANT): BPC1.BattSerial_16 (count)
2017-08-28T19:19:00.639Z,1503947940.639 [CommandLine](IMPORTANT): BPC1.BattTemp_17 (celsius)
2017-08-28T19:19:00.639Z,1503947940.639 [CommandLine](IMPORTANT): BPC1.BattVoltage_17 (volt)
2017-08-28T19:19:00.640Z,1503947940.640 [CommandLine](IMPORTANT): BPC1.BattCurrent_17 (ampere)
2017-08-28T19:19:00.640Z,1503947940.640 [CommandLine](IMPORTANT): BPC1.BattCapacity_17 (ampere_hour)
2017-08-28T19:19:00.640Z,1503947940.640 [CommandLine](IMPORTANT): BPC1.BattStatus_17 (enum)
2017-08-28T19:19:00.641Z,1503947940.641 [CommandLine](IMPORTANT): BPC1.BattSerial_17 (count)
2017-08-28T19:19:00.641Z,1503947940.641 [CommandLine](IMPORTANT): BPC1.BattTemp_18 (celsius)
2017-08-28T19:19:00.641Z,1503947940.641 [CommandLine](IMPORTANT): BPC1.BattVoltage_18 (volt)
2017-08-28T19:19:00.642Z,1503947940.642 [CommandLine](IMPORTANT): BPC1.BattCurrent_18 (ampere)
2017-08-28T19:19:00.642Z,1503947940.642 [CommandLine](IMPORTANT): BPC1.BattCapacity_18 (ampere_hour)
2017-08-28T19:19:00.642Z,1503947940.642 [CommandLine](IMPORTANT): BPC1.BattStatus_18 (enum)
2017-08-28T19:19:00.655Z,1503947940.655 [CommandLine](IMPORTANT): BPC1.BattSerial_18 (count)
2017-08-28T19:19:00.655Z,1503947940.655 [CommandLine](IMPORTANT): BPC1.BattTemp_19 (celsius)
2017-08-28T19:19:00.656Z,1503947940.656 [CommandLine](IMPORTANT): BPC1.BattVoltage_19 (volt)
2017-08-28T19:19:00.656Z,1503947940.656 [CommandLine](IMPORTANT): BPC1.BattCurrent_19 (ampere)
2017-08-28T19:19:00.656Z,1503947940.656 [CommandLine](IMPORTANT): BPC1.BattCapacity_19 (ampere_hour)
2017-08-28T19:19:00.657Z,1503947940.657 [CommandLine](IMPORTANT): BPC1.BattStatus_19 (enum)
2017-08-28T19:19:00.657Z,1503947940.657 [CommandLine](IMPORTANT): BPC1.BattSerial_19 (count)
2017-08-28T19:19:00.657Z,1503947940.657 [CommandLine](IMPORTANT): BPC1.BattTemp_20 (celsius)
2017-08-28T19:19:00.658Z,1503947940.658 [CommandLine](IMPORTANT): BPC1.BattVoltage_20 (volt)
2017-08-28T19:19:00.658Z,1503947940.658 [CommandLine](IMPORTANT): BPC1.BattCurrent_20 (ampere)
2017-08-28T19:19:00.658Z,1503947940.658 [CommandLine](IMPORTANT): BPC1.BattCapacity_20 (ampere_hour)
2017-08-28T19:19:00.659Z,1503947940.659 [CommandLine](IMPORTANT): BPC1.BattStatus_20 (enum)
2017-08-28T19:19:00.659Z,1503947940.659 [CommandLine](IMPORTANT): BPC1.BattSerial_20 (count)
2017-08-28T19:19:00.660Z,1503947940.660 [CommandLine](IMPORTANT): BPC1.BattTemp_21 (celsius)
2017-08-28T19:19:00.660Z,1503947940.660 [CommandLine](IMPORTANT): BPC1.BattVoltage_21 (volt)
2017-08-28T19:19:00.660Z,1503947940.660 [CommandLine](IMPORTANT): BPC1.BattCurrent_21 (ampere)
2017-08-28T19:19:00.661Z,1503947940.661 [CommandLine](IMPORTANT): BPC1.BattCapacity_21 (ampere_hour)
2017-08-28T19:19:00.661Z,1503947940.661 [CommandLine](IMPORTANT): BPC1.BattStatus_21 (enum)
2017-08-28T19:19:00.661Z,1503947940.661 [CommandLine](IMPORTANT): BPC1.BattSerial_21 (count)
2017-08-28T19:19:00.662Z,1503947940.662 [CommandLine](IMPORTANT): BPC1.BattTemp_22 (celsius)
2017-08-28T19:19:00.662Z,1503947940.662 [CommandLine](IMPORTANT): BPC1.BattVoltage_22 (volt)
2017-08-28T19:19:00.662Z,1503947940.662 [CommandLine](IMPORTANT): BPC1.BattCurrent_22 (ampere)
2017-08-28T19:19:00.663Z,1503947940.663 [CommandLine](IMPORTANT): BPC1.BattCapacity_22 (ampere_hour)
2017-08-28T19:19:00.663Z,1503947940.663 [CommandLine](IMPORTANT): BPC1.BattStatus_22 (enum)
2017-08-28T19:19:00.663Z,1503947940.663 [CommandLine](IMPORTANT): BPC1.BattSerial_22 (count)
2017-08-28T19:19:00.664Z,1503947940.664 [CommandLine](IMPORTANT): BPC1.BattTemp_23 (celsius)
2017-08-28T19:19:00.664Z,1503947940.664 [CommandLine](IMPORTANT): BPC1.BattVoltage_23 (volt)
2017-08-28T19:19:00.664Z,1503947940.664 [CommandLine](IMPORTANT): BPC1.BattCurrent_23 (ampere)
2017-08-28T19:19:00.665Z,1503947940.665 [CommandLine](IMPORTANT): BPC1.BattCapacity_23 (ampere_hour)
2017-08-28T19:19:00.665Z,1503947940.665 [CommandLine](IMPORTANT): BPC1.BattStatus_23 (enum)
2017-08-28T19:19:00.665Z,1503947940.665 [CommandLine](IMPORTANT): BPC1.BattSerial_23 (count)
2017-08-28T19:19:00.666Z,1503947940.666 [CommandLine](IMPORTANT): BPC1.BattTemp_24 (celsius)
2017-08-28T19:19:00.666Z,1503947940.666 [CommandLine](IMPORTANT): BPC1.BattVoltage_24 (volt)
2017-08-28T19:19:00.666Z,1503947940.666 [CommandLine](IMPORTANT): BPC1.BattCurrent_24 (ampere)
2017-08-28T19:19:00.679Z,1503947940.679 [CommandLine](IMPORTANT): BPC1.BattCapacity_24 (ampere_hour)
2017-08-28T19:19:00.679Z,1503947940.679 [CommandLine](IMPORTANT): BPC1.BattStatus_24 (enum)
2017-08-28T19:19:00.680Z,1503947940.680 [CommandLine](IMPORTANT): BPC1.BattSerial_24 (count)
2017-08-28T19:19:00.680Z,1503947940.680 [CommandLine](IMPORTANT): BPC1.BattTemp_25 (celsius)
2017-08-28T19:19:00.680Z,1503947940.680 [CommandLine](IMPORTANT): BPC1.BattVoltage_25 (volt)
2017-08-28T19:19:00.681Z,1503947940.681 [CommandLine](IMPORTANT): BPC1.BattCurrent_25 (ampere)
2017-08-28T19:19:00.681Z,1503947940.681 [CommandLine](IMPORTANT): BPC1.BattCapacity_25 (ampere_hour)
2017-08-28T19:19:00.682Z,1503947940.682 [CommandLine](IMPORTANT): BPC1.BattStatus_25 (enum)
2017-08-28T19:19:00.682Z,1503947940.682 [CommandLine](IMPORTANT): BPC1.BattSerial_25 (count)
2017-08-28T19:19:00.682Z,1503947940.682 [CommandLine](IMPORTANT): BPC1.BattTemp_26 (celsius)
2017-08-28T19:19:00.682Z,1503947940.682 [CommandLine](IMPORTANT): BPC1.BattVoltage_26 (volt)
2017-08-28T19:19:00.683Z,1503947940.683 [CommandLine](IMPORTANT): BPC1.BattCurrent_26 (ampere)
2017-08-28T19:19:00.683Z,1503947940.683 [CommandLine](IMPORTANT): BPC1.BattCapacity_26 (ampere_hour)
2017-08-28T19:19:00.684Z,1503947940.684 [CommandLine](IMPORTANT): BPC1.BattStatus_26 (enum)
2017-08-28T19:19:00.684Z,1503947940.684 [CommandLine](IMPORTANT): BPC1.BattSerial_26 (count)
2017-08-28T19:19:00.684Z,1503947940.684 [CommandLine](IMPORTANT): BPC1.BattTemp_27 (celsius)
2017-08-28T19:19:00.685Z,1503947940.685 [CommandLine](IMPORTANT): BPC1.BattVoltage_27 (volt)
2017-08-28T19:19:00.685Z,1503947940.685 [CommandLine](IMPORTANT): BPC1.BattCurrent_27 (ampere)
2017-08-28T19:19:00.685Z,1503947940.685 [CommandLine](IMPORTANT): BPC1.BattCapacity_27 (ampere_hour)
2017-08-28T19:19:00.686Z,1503947940.686 [CommandLine](IMPORTANT): BPC1.BattStatus_27 (enum)
2017-08-28T19:19:00.686Z,1503947940.686 [CommandLine](IMPORTANT): BPC1.BattSerial_27 (count)
2017-08-28T19:19:00.686Z,1503947940.686 [CommandLine](IMPORTANT): BPC1.BattTemp_28 (celsius)
2017-08-28T19:19:00.687Z,1503947940.687 [CommandLine](IMPORTANT): BPC1.BattVoltage_28 (volt)
2017-08-28T19:19:00.687Z,1503947940.687 [CommandLine](IMPORTANT): BPC1.BattCurrent_28 (ampere)
2017-08-28T19:19:00.688Z,1503947940.688 [CommandLine](IMPORTANT): BPC1.BattCapacity_28 (ampere_hour)
2017-08-28T19:19:00.688Z,1503947940.688 [CommandLine](IMPORTANT): BPC1.BattStatus_28 (enum)
2017-08-28T19:19:00.688Z,1503947940.688 [CommandLine](IMPORTANT): BPC1.BattSerial_28 (count)
2017-08-28T19:19:00.689Z,1503947940.689 [CommandLine](IMPORTANT): BPC1.BattTemp_29 (celsius)
2017-08-28T19:19:00.689Z,1503947940.689 [CommandLine](IMPORTANT): BPC1.BattVoltage_29 (volt)
2017-08-28T19:19:00.689Z,1503947940.689 [CommandLine](IMPORTANT): BPC1.BattCurrent_29 (ampere)
2017-08-28T19:19:00.690Z,1503947940.690 [CommandLine](IMPORTANT): BPC1.BattCapacity_29 (ampere_hour)
2017-08-28T19:19:00.690Z,1503947940.690 [CommandLine](IMPORTANT): BPC1.BattStatus_29 (enum)
2017-08-28T19:19:00.690Z,1503947940.690 [CommandLine](IMPORTANT): BPC1.BattSerial_29 (count)
2017-08-28T19:19:00.691Z,1503947940.691 [CommandLine](IMPORTANT): BPC1.BattTemp_30 (celsius)
2017-08-28T19:19:00.703Z,1503947940.703 [CommandLine](IMPORTANT): BPC1.BattVoltage_30 (volt)
2017-08-28T19:19:00.704Z,1503947940.704 [CommandLine](IMPORTANT): BPC1.BattCurrent_30 (ampere)
2017-08-28T19:19:00.704Z,1503947940.704 [CommandLine](IMPORTANT): BPC1.BattCapacity_30 (ampere_hour)
2017-08-28T19:19:00.704Z,1503947940.704 [CommandLine](IMPORTANT): BPC1.BattStatus_30 (enum)
2017-08-28T19:19:00.705Z,1503947940.705 [CommandLine](IMPORTANT): BPC1.BattSerial_30 (count)
2017-08-28T19:19:00.705Z,1503947940.705 [CommandLine](IMPORTANT): BPC1.BattTemp_31 (celsius)
2017-08-28T19:19:00.705Z,1503947940.705 [CommandLine](IMPORTANT): BPC1.BattVoltage_31 (volt)
2017-08-28T19:19:00.706Z,1503947940.706 [CommandLine](IMPORTANT): BPC1.BattCurrent_31 (ampere)
2017-08-28T19:19:00.706Z,1503947940.706 [CommandLine](IMPORTANT): BPC1.BattCapacity_31 (ampere_hour)
2017-08-28T19:19:00.706Z,1503947940.706 [CommandLine](IMPORTANT): BPC1.BattStatus_31 (enum)
2017-08-28T19:19:00.707Z,1503947940.707 [CommandLine](IMPORTANT): BPC1.BattSerial_31 (count)
2017-08-28T19:19:00.707Z,1503947940.707 [CommandLine](IMPORTANT): BPC1.BattTemp_32 (celsius)
2017-08-28T19:19:00.707Z,1503947940.707 [CommandLine](IMPORTANT): BPC1.BattVoltage_32 (volt)
2017-08-28T19:19:00.708Z,1503947940.708 [CommandLine](IMPORTANT): BPC1.BattCurrent_32 (ampere)
2017-08-28T19:19:00.708Z,1503947940.708 [CommandLine](IMPORTANT): BPC1.BattCapacity_32 (ampere_hour)
2017-08-28T19:19:00.708Z,1503947940.708 [CommandLine](IMPORTANT): BPC1.BattStatus_32 (enum)
2017-08-28T19:19:00.709Z,1503947940.709 [CommandLine](IMPORTANT): BPC1.BattSerial_32 (count)
2017-08-28T19:19:00.709Z,1503947940.709 [CommandLine](IMPORTANT): BPC1.BattTemp_33 (celsius)
2017-08-28T19:19:00.709Z,1503947940.709 [CommandLine](IMPORTANT): BPC1.BattVoltage_33 (volt)
2017-08-28T19:19:00.710Z,1503947940.710 [CommandLine](IMPORTANT): BPC1.BattCurrent_33 (ampere)
2017-08-28T19:19:00.710Z,1503947940.710 [CommandLine](IMPORTANT): BPC1.BattCapacity_33 (ampere_hour)
2017-08-28T19:19:00.711Z,1503947940.711 [CommandLine](IMPORTANT): BPC1.BattStatus_33 (enum)
2017-08-28T19:19:00.723Z,1503947940.723 [CommandLine](IMPORTANT): BPC1.BattSerial_33 (count)
2017-08-28T19:19:00.723Z,1503947940.723 [CommandLine](IMPORTANT): BPC1.BattTemp_34 (celsius)
2017-08-28T19:19:00.724Z,1503947940.724 [CommandLine](IMPORTANT): BPC1.BattVoltage_34 (volt)
2017-08-28T19:19:00.724Z,1503947940.724 [CommandLine](IMPORTANT): BPC1.BattCurrent_34 (ampere)
2017-08-28T19:19:00.724Z,1503947940.724 [CommandLine](IMPORTANT): BPC1.BattCapacity_34 (ampere_hour)
2017-08-28T19:19:00.725Z,1503947940.725 [CommandLine](IMPORTANT): BPC1.BattStatus_34 (enum)
2017-08-28T19:19:00.725Z,1503947940.725 [CommandLine](IMPORTANT): BPC1.BattSerial_34 (count)
2017-08-28T19:19:00.726Z,1503947940.726 [CommandLine](IMPORTANT): BPC1.BattTemp_35 (celsius)
2017-08-28T19:19:00.726Z,1503947940.726 [CommandLine](IMPORTANT): BPC1.BattVoltage_35 (volt)
2017-08-28T19:19:00.726Z,1503947940.726 [CommandLine](IMPORTANT): BPC1.BattCurrent_35 (ampere)
2017-08-28T19:19:00.727Z,1503947940.727 [CommandLine](IMPORTANT): BPC1.BattCapacity_35 (ampere_hour)
2017-08-28T19:19:00.727Z,1503947940.727 [CommandLine](IMPORTANT): BPC1.BattStatus_35 (enum)
2017-08-28T19:19:00.727Z,1503947940.727 [CommandLine](IMPORTANT): BPC1.BattSerial_35 (count)
2017-08-28T19:19:00.728Z,1503947940.728 [CommandLine](IMPORTANT): BPC1.BattTemp_36 (celsius)
2017-08-28T19:19:00.728Z,1503947940.728 [CommandLine](IMPORTANT): BPC1.BattVoltage_36 (volt)
2017-08-28T19:19:00.728Z,1503947940.728 [CommandLine](IMPORTANT): BPC1.BattCurrent_36 (ampere)
2017-08-28T19:19:00.729Z,1503947940.729 [CommandLine](IMPORTANT): BPC1.BattCapacity_36 (ampere_hour)
2017-08-28T19:19:00.729Z,1503947940.729 [CommandLine](IMPORTANT): BPC1.BattStatus_36 (enum)
2017-08-28T19:19:00.729Z,1503947940.729 [CommandLine](IMPORTANT): BPC1.BattSerial_36 (count)
2017-08-28T19:19:00.730Z,1503947940.730 [CommandLine](IMPORTANT): BPC1.BattTemp_37 (celsius)
2017-08-28T19:19:00.730Z,1503947940.730 [CommandLine](IMPORTANT): BPC1.BattVoltage_37 (volt)
2017-08-28T19:19:00.730Z,1503947940.730 [CommandLine](IMPORTANT): BPC1.BattCurrent_37 (ampere)
2017-08-28T19:19:00.731Z,1503947940.731 [CommandLine](IMPORTANT): BPC1.BattCapacity_37 (ampere_hour)
2017-08-28T19:19:00.731Z,1503947940.731 [CommandLine](IMPORTANT): BPC1.BattStatus_37 (enum)
2017-08-28T19:19:00.731Z,1503947940.731 [CommandLine](IMPORTANT): BPC1.BattSerial_37 (count)
2017-08-28T19:19:00.732Z,1503947940.732 [CommandLine](IMPORTANT): BPC1.BattTemp_38 (celsius)
2017-08-28T19:19:00.732Z,1503947940.732 [CommandLine](IMPORTANT): BPC1.BattVoltage_38 (volt)
2017-08-28T19:19:00.732Z,1503947940.732 [CommandLine](IMPORTANT): BPC1.BattCurrent_38 (ampere)
2017-08-28T19:19:00.733Z,1503947940.733 [CommandLine](IMPORTANT): BPC1.BattCapacity_38 (ampere_hour)
2017-08-28T19:19:00.733Z,1503947940.733 [CommandLine](IMPORTANT): BPC1.BattStatus_38 (enum)
2017-08-28T19:19:00.734Z,1503947940.734 [CommandLine](IMPORTANT): BPC1.BattSerial_38 (count)
2017-08-28T19:19:00.734Z,1503947940.734 [CommandLine](IMPORTANT): BPC1.BattTemp_39 (celsius)
2017-08-28T19:19:00.734Z,1503947940.734 [CommandLine](IMPORTANT): BPC1.BattVoltage_39 (volt)
2017-08-28T19:19:00.735Z,1503947940.735 [CommandLine](IMPORTANT): BPC1.BattCurrent_39 (ampere)
2017-08-28T19:19:00.746Z,1503947940.746 [CommandLine](IMPORTANT): BPC1.BattCapacity_39 (ampere_hour)
2017-08-28T19:19:00.761Z,1503947940.761 [CommandLine](IMPORTANT): BPC1.BattStatus_39 (enum)
2017-08-28T19:19:00.762Z,1503947940.762 [CommandLine](IMPORTANT): BPC1.BattSerial_39 (count)
2017-08-28T19:19:00.763Z,1503947940.763 [CommandLine](IMPORTANT): BPC1.BattTemp_40 (celsius)
2017-08-28T19:19:00.769Z,1503947940.769 [CommandLine](IMPORTANT): BPC1.BattVoltage_40 (volt)
2017-08-28T19:19:00.773Z,1503947940.773 [CommandLine](IMPORTANT): BPC1.BattCurrent_40 (ampere)
2017-08-28T19:19:00.791Z,1503947940.791 [CommandLine](IMPORTANT): BPC1.BattCapacity_40 (ampere_hour)
2017-08-28T19:19:00.792Z,1503947940.792 [CommandLine](IMPORTANT): BPC1.BattStatus_40 (enum)
2017-08-28T19:19:00.792Z,1503947940.792 [CommandLine](IMPORTANT): BPC1.BattSerial_40 (count)
2017-08-28T19:19:00.792Z,1503947940.792 [CommandLine](IMPORTANT): BPC1.BattTemp_41 (celsius)
2017-08-28T19:19:00.793Z,1503947940.793 [CommandLine](IMPORTANT): BPC1.BattVoltage_41 (volt)
2017-08-28T19:19:00.793Z,1503947940.793 [CommandLine](IMPORTANT): BPC1.BattCurrent_41 (ampere)
2017-08-28T19:19:00.794Z,1503947940.794 [CommandLine](IMPORTANT): BPC1.BattCapacity_41 (ampere_hour)
2017-08-28T19:19:00.794Z,1503947940.794 [CommandLine](IMPORTANT): BPC1.BattStatus_41 (enum)
2017-08-28T19:19:00.794Z,1503947940.794 [CommandLine](IMPORTANT): BPC1.BattSerial_41 (count)
2017-08-28T19:19:00.795Z,1503947940.795 [CommandLine](IMPORTANT): BPC1.BattTemp_42 (celsius)
2017-08-28T19:19:00.795Z,1503947940.795 [CommandLine](IMPORTANT): BPC1.BattVoltage_42 (volt)
2017-08-28T19:19:00.795Z,1503947940.795 [CommandLine](IMPORTANT): BPC1.BattCurrent_42 (ampere)
2017-08-28T19:19:00.796Z,1503947940.796 [CommandLine](IMPORTANT): BPC1.BattCapacity_42 (ampere_hour)
2017-08-28T19:19:00.796Z,1503947940.796 [CommandLine](IMPORTANT): BPC1.BattStatus_42 (enum)
2017-08-28T19:19:00.796Z,1503947940.796 [CommandLine](IMPORTANT): BPC1.BattSerial_42 (count)
2017-08-28T19:19:00.797Z,1503947940.797 [CommandLine](IMPORTANT): BPC1.BattTemp_43 (celsius)
2017-08-28T19:19:00.797Z,1503947940.797 [CommandLine](IMPORTANT): BPC1.BattVoltage_43 (volt)
2017-08-28T19:19:00.797Z,1503947940.797 [CommandLine](IMPORTANT): BPC1.BattCurrent_43 (ampere)
2017-08-28T19:19:00.798Z,1503947940.798 [CommandLine](IMPORTANT): BPC1.BattCapacity_43 (ampere_hour)
2017-08-28T19:19:00.798Z,1503947940.798 [CommandLine](IMPORTANT): BPC1.BattStatus_43 (enum)
2017-08-28T19:19:00.798Z,1503947940.798 [CommandLine](IMPORTANT): BPC1.BattSerial_43 (count)
2017-08-28T19:19:00.799Z,1503947940.799 [CommandLine](IMPORTANT): BPC1.BattTemp_44 (celsius)
2017-08-28T19:19:00.832Z,1503947940.832 [CommandLine](IMPORTANT): BPC1.BattVoltage_44 (volt)
2017-08-28T19:19:00.833Z,1503947940.833 [CommandLine](IMPORTANT): BPC1.BattCurrent_44 (ampere)
2017-08-28T19:19:00.833Z,1503947940.833 [CommandLine](IMPORTANT): BPC1.BattCapacity_44 (ampere_hour)
2017-08-28T19:19:00.833Z,1503947940.833 [CommandLine](IMPORTANT): BPC1.BattStatus_44 (enum)
2017-08-28T19:19:00.834Z,1503947940.834 [CommandLine](IMPORTANT): BPC1.BattSerial_44 (count)
2017-08-28T19:19:00.834Z,1503947940.834 [CommandLine](IMPORTANT): BPC1.BattTemp_45 (celsius)
2017-08-28T19:19:00.834Z,1503947940.834 [CommandLine](IMPORTANT): BPC1.BattVoltage_45 (volt)
2017-08-28T19:19:00.835Z,1503947940.835 [CommandLine](IMPORTANT): BPC1.BattCurrent_45 (ampere)
2017-08-28T19:19:00.835Z,1503947940.835 [CommandLine](IMPORTANT): BPC1.BattCapacity_45 (ampere_hour)
2017-08-28T19:19:00.835Z,1503947940.835 [CommandLine](IMPORTANT): BPC1.BattStatus_45 (enum)
2017-08-28T19:19:00.836Z,1503947940.836 [CommandLine](IMPORTANT): BPC1.BattSerial_45 (count)
2017-08-28T19:19:00.836Z,1503947940.836 [CommandLine](IMPORTANT): BPC1.BattTemp_46 (celsius)
2017-08-28T19:19:00.836Z,1503947940.836 [CommandLine](IMPORTANT): BPC1.BattVoltage_46 (volt)
2017-08-28T19:19:00.837Z,1503947940.837 [CommandLine](IMPORTANT): BPC1.BattCurrent_46 (ampere)
2017-08-28T19:19:00.837Z,1503947940.837 [CommandLine](IMPORTANT): BPC1.BattCapacity_46 (ampere_hour)
2017-08-28T19:19:00.838Z,1503947940.838 [CommandLine](IMPORTANT): BPC1.BattStatus_46 (enum)
2017-08-28T19:19:00.838Z,1503947940.838 [CommandLine](IMPORTANT): BPC1.BattSerial_46 (count)
2017-08-28T19:19:00.838Z,1503947940.838 [CommandLine](IMPORTANT): BPC1.BattTemp_47 (celsius)
2017-08-28T19:19:00.839Z,1503947940.839 [CommandLine](IMPORTANT): BPC1.BattVoltage_47 (volt)
2017-08-28T19:19:00.856Z,1503947940.856 [CommandLine](IMPORTANT): BPC1.BattCurrent_47 (ampere)
2017-08-28T19:19:00.857Z,1503947940.857 [CommandLine](IMPORTANT): BPC1.BattCapacity_47 (ampere_hour)
2017-08-28T19:19:00.857Z,1503947940.857 [CommandLine](IMPORTANT): BPC1.BattStatus_47 (enum)
2017-08-28T19:19:00.857Z,1503947940.857 [CommandLine](IMPORTANT): BPC1.BattSerial_47 (count)
2017-08-28T19:19:00.858Z,1503947940.858 [CommandLine](IMPORTANT): BPC1.BattTemp_48 (celsius)
2017-08-28T19:19:00.858Z,1503947940.858 [CommandLine](IMPORTANT): BPC1.BattVoltage_48 (volt)
2017-08-28T19:19:00.858Z,1503947940.858 [CommandLine](IMPORTANT): BPC1.BattCurrent_48 (ampere)
2017-08-28T19:19:00.859Z,1503947940.859 [CommandLine](IMPORTANT): BPC1.BattCapacity_48 (ampere_hour)
2017-08-28T19:19:00.859Z,1503947940.859 [CommandLine](IMPORTANT): BPC1.BattStatus_48 (enum)
2017-08-28T19:19:00.860Z,1503947940.860 [CommandLine](IMPORTANT): BPC1.BattSerial_48 (count)
2017-08-28T19:19:00.860Z,1503947940.860 [CommandLine](IMPORTANT): BPC1.BattTemp_49 (celsius)
2017-08-28T19:19:00.860Z,1503947940.860 [CommandLine](IMPORTANT): BPC1.BattVoltage_49 (volt)
2017-08-28T19:19:00.861Z,1503947940.861 [CommandLine](IMPORTANT): BPC1.BattCurrent_49 (ampere)
2017-08-28T19:19:00.861Z,1503947940.861 [CommandLine](IMPORTANT): BPC1.BattCapacity_49 (ampere_hour)
2017-08-28T19:19:00.861Z,1503947940.861 [CommandLine](IMPORTANT): BPC1.BattStatus_49 (enum)
2017-08-28T19:19:00.862Z,1503947940.862 [CommandLine](IMPORTANT): BPC1.BattSerial_49 (count)
2017-08-28T19:19:00.862Z,1503947940.862 [CommandLine](IMPORTANT): BPC1.BattTemp_50 (celsius)
2017-08-28T19:19:00.862Z,1503947940.862 [CommandLine](IMPORTANT): BPC1.BattVoltage_50 (volt)
2017-08-28T19:19:00.863Z,1503947940.863 [CommandLine](IMPORTANT): BPC1.BattCurrent_50 (ampere)
2017-08-28T19:19:00.875Z,1503947940.875 [CommandLine](IMPORTANT): BPC1.BattCapacity_50 (ampere_hour)
2017-08-28T19:19:00.876Z,1503947940.876 [CommandLine](IMPORTANT): BPC1.BattStatus_50 (enum)
2017-08-28T19:19:00.876Z,1503947940.876 [CommandLine](IMPORTANT): BPC1.BattSerial_50 (count)
2017-08-28T19:19:00.877Z,1503947940.877 [CommandLine](IMPORTANT): BPC1.BattTemp_51 (celsius)
2017-08-28T19:19:00.877Z,1503947940.877 [CommandLine](IMPORTANT): BPC1.BattVoltage_51 (volt)
2017-08-28T19:19:00.877Z,1503947940.877 [CommandLine](IMPORTANT): BPC1.BattCurrent_51 (ampere)
2017-08-28T19:19:00.878Z,1503947940.878 [CommandLine](IMPORTANT): BPC1.BattCapacity_51 (ampere_hour)
2017-08-28T19:19:00.878Z,1503947940.878 [CommandLine](IMPORTANT): BPC1.BattStatus_51 (enum)
2017-08-28T19:19:00.878Z,1503947940.878 [CommandLine](IMPORTANT): BPC1.BattSerial_51 (count)
2017-08-28T19:19:00.879Z,1503947940.879 [CommandLine](IMPORTANT): BPC1.BattTemp_52 (celsius)
2017-08-28T19:19:00.879Z,1503947940.879 [CommandLine](IMPORTANT): BPC1.BattVoltage_52 (volt)
2017-08-28T19:19:00.880Z,1503947940.880 [CommandLine](IMPORTANT): BPC1.BattCurrent_52 (ampere)
2017-08-28T19:19:00.880Z,1503947940.880 [CommandLine](IMPORTANT): BPC1.BattCapacity_52 (ampere_hour)
2017-08-28T19:19:00.880Z,1503947940.880 [CommandLine](IMPORTANT): BPC1.BattStatus_52 (enum)
2017-08-28T19:19:00.881Z,1503947940.881 [CommandLine](IMPORTANT): BPC1.BattSerial_52 (count)
2017-08-28T19:19:00.881Z,1503947940.881 [CommandLine](IMPORTANT): BPC1.BattTemp_53 (celsius)
2017-08-28T19:19:00.881Z,1503947940.881 [CommandLine](IMPORTANT): BPC1.BattVoltage_53 (volt)
2017-08-28T19:19:00.882Z,1503947940.882 [CommandLine](IMPORTANT): BPC1.BattCurrent_53 (ampere)
2017-08-28T19:19:00.882Z,1503947940.882 [CommandLine](IMPORTANT): BPC1.BattCapacity_53 (ampere_hour)
2017-08-28T19:19:00.882Z,1503947940.882 [CommandLine](IMPORTANT): BPC1.BattStatus_53 (enum)
2017-08-28T19:19:00.883Z,1503947940.883 [CommandLine](IMPORTANT): BPC1.BattSerial_53 (count)
2017-08-28T19:19:00.883Z,1503947940.883 [CommandLine](IMPORTANT): BPC1.BattTemp_54 (celsius)
2017-08-28T19:19:00.883Z,1503947940.883 [CommandLine](IMPORTANT): BPC1.BattVoltage_54 (volt)
2017-08-28T19:19:00.884Z,1503947940.884 [CommandLine](IMPORTANT): BPC1.BattCurrent_54 (ampere)
2017-08-28T19:19:00.884Z,1503947940.884 [CommandLine](IMPORTANT): BPC1.BattCapacity_54 (ampere_hour)
2017-08-28T19:19:00.884Z,1503947940.884 [CommandLine](IMPORTANT): BPC1.BattStatus_54 (enum)
2017-08-28T19:19:00.885Z,1503947940.885 [CommandLine](IMPORTANT): BPC1.BattSerial_54 (count)
2017-08-28T19:19:00.885Z,1503947940.885 [CommandLine](IMPORTANT): BPC1.BattTemp_55 (celsius)
2017-08-28T19:19:00.885Z,1503947940.885 [CommandLine](IMPORTANT): BPC1.BattVoltage_55 (volt)
2017-08-28T19:19:00.886Z,1503947940.886 [CommandLine](IMPORTANT): BPC1.BattCurrent_55 (ampere)
2017-08-28T19:19:00.886Z,1503947940.886 [CommandLine](IMPORTANT): BPC1.BattCapacity_55 (ampere_hour)
2017-08-28T19:19:00.886Z,1503947940.886 [CommandLine](IMPORTANT): BPC1.BattStatus_55 (enum)
2017-08-28T19:19:00.887Z,1503947940.887 [CommandLine](IMPORTANT): BPC1.BattSerial_55 (count)
2017-08-28T19:19:00.896Z,1503947940.896 [CommandLine](IMPORTANT): BPC1.BattTemp_56 (celsius)
2017-08-28T19:19:00.897Z,1503947940.897 [CommandLine](IMPORTANT): BPC1.BattVoltage_56 (volt)
2017-08-28T19:19:00.897Z,1503947940.897 [CommandLine](IMPORTANT): BPC1.BattCurrent_56 (ampere)
2017-08-28T19:19:00.897Z,1503947940.897 [CommandLine](IMPORTANT): BPC1.BattCapacity_56 (ampere_hour)
2017-08-28T19:19:00.898Z,1503947940.898 [CommandLine](IMPORTANT): BPC1.BattStatus_56 (enum)
2017-08-28T19:19:00.898Z,1503947940.898 [CommandLine](IMPORTANT): BPC1.BattSerial_56 (count)
2017-08-28T19:19:00.898Z,1503947940.898 [CommandLine](IMPORTANT): BPC1.BattTemp_57 (celsius)
2017-08-28T19:19:00.899Z,1503947940.899 [CommandLine](IMPORTANT): BPC1.BattVoltage_57 (volt)
2017-08-28T19:19:00.899Z,1503947940.899 [CommandLine](IMPORTANT): BPC1.BattCurrent_57 (ampere)
2017-08-28T19:19:00.899Z,1503947940.899 [CommandLine](IMPORTANT): BPC1.BattCapacity_57 (ampere_hour)
2017-08-28T19:19:00.900Z,1503947940.900 [CommandLine](IMPORTANT): BPC1.BattStatus_57 (enum)
2017-08-28T19:19:00.900Z,1503947940.900 [CommandLine](IMPORTANT): BPC1.BattSerial_57 (count)
2017-08-28T19:19:00.900Z,1503947940.900 [CommandLine](IMPORTANT): BPC1.BattTemp_58 (celsius)
2017-08-28T19:19:00.901Z,1503947940.901 [CommandLine](IMPORTANT): BPC1.BattVoltage_58 (volt)
2017-08-28T19:19:00.901Z,1503947940.901 [CommandLine](IMPORTANT): BPC1.BattCurrent_58 (ampere)
2017-08-28T19:19:00.901Z,1503947940.901 [CommandLine](IMPORTANT): BPC1.BattCapacity_58 (ampere_hour)
2017-08-28T19:19:00.902Z,1503947940.902 [CommandLine](IMPORTANT): BPC1.BattStatus_58 (enum)
2017-08-28T19:19:00.902Z,1503947940.902 [CommandLine](IMPORTANT): BPC1.BattSerial_58 (count)
2017-08-28T19:19:00.903Z,1503947940.903 [CommandLine](IMPORTANT): BPC1.BattTemp_59 (celsius)
2017-08-28T19:19:00.903Z,1503947940.903 [CommandLine](IMPORTANT): BPC1.BattVoltage_59 (volt)
2017-08-28T19:19:00.903Z,1503947940.903 [CommandLine](IMPORTANT): BPC1.BattCurrent_59 (ampere)
2017-08-28T19:19:00.904Z,1503947940.904 [CommandLine](IMPORTANT): BPC1.BattCapacity_59 (ampere_hour)
2017-08-28T19:19:00.904Z,1503947940.904 [CommandLine](IMPORTANT): BPC1.BattStatus_59 (enum)
2017-08-28T19:19:00.904Z,1503947940.904 [CommandLine](IMPORTANT): BPC1.BattSerial_59 (count)
2017-08-28T19:19:00.905Z,1503947940.905 [CommandLine](IMPORTANT): BPC1.BattTemp_60 (celsius)
2017-08-28T19:19:00.905Z,1503947940.905 [CommandLine](IMPORTANT): BPC1.BattVoltage_60 (volt)
2017-08-28T19:19:00.905Z,1503947940.905 [CommandLine](IMPORTANT): BPC1.BattCurrent_60 (ampere)
2017-08-28T19:19:00.906Z,1503947940.906 [CommandLine](IMPORTANT): BPC1.BattCapacity_60 (ampere_hour)
2017-08-28T19:19:00.906Z,1503947940.906 [CommandLine](IMPORTANT): BPC1.BattStatus_60 (enum)
2017-08-28T19:19:00.906Z,1503947940.906 [CommandLine](IMPORTANT): BPC1.BattSerial_60 (count)
2017-08-28T19:19:00.907Z,1503947940.907 [CommandLine](IMPORTANT): BPC1.BattTemp_61 (celsius)
2017-08-28T19:19:00.907Z,1503947940.907 [CommandLine](IMPORTANT): BPC1.BattVoltage_61 (volt)
2017-08-28T19:19:00.929Z,1503947940.929 [CommandLine](IMPORTANT): BPC1.BattCurrent_61 (ampere)
2017-08-28T19:19:00.929Z,1503947940.929 [CommandLine](IMPORTANT): BPC1.BattCapacity_61 (ampere_hour)
2017-08-28T19:19:00.930Z,1503947940.930 [CommandLine](IMPORTANT): BPC1.BattStatus_61 (enum)
2017-08-28T19:19:00.930Z,1503947940.930 [CommandLine](IMPORTANT): BPC1.BattSerial_61 (count)
2017-08-28T19:19:00.930Z,1503947940.930 [CommandLine](IMPORTANT): BPC1.platform_battery_charge (ampere_hour)
2017-08-28T19:19:00.931Z,1503947940.931 [CommandLine](IMPORTANT): BPC1.platform_battery_voltage (unspecified)
2017-08-28T19:19:00.931Z,1503947940.931 [CommandLine](IMPORTANT): BPC1.platform_battery_discharging (bool)
2017-08-28T19:19:00.931Z,1503947940.931 [CommandLine](IMPORTANT): BPC1.platform_battery_fully_charged (bool)
2017-08-28T19:19:00.933Z,1503947940.933 [CommandLine](IMPORTANT): BPC1.durationOfLastRun (second)
2017-08-28T19:19:02.389Z,1503947942.389 [BPC1](ERROR): Failed to receive battery data
2017-08-28T19:19:02.389Z,1503947942.389 [BPC1] Communications Fault, FailCount= 1
2017-08-28T19:19:02.389Z,1503947942.389 [BPC1](ERROR): Communications Fault
2017-08-28T19:19:02.576Z,1503947942.576 [CBIT](ERROR): Communications Fault in component: BPC1
2017-08-28T19:19:03.774Z,1503947943.774 [CBIT](INFO): Clearing failed state for component BPC1
2017-08-28T19:19:03.774Z,1503947943.774 [BPC1] No Fault, FailCount= 1
2017-08-28T19:19:18.134Z,1503947958.134 [CommandLine](IMPORTANT): got command get BPC1.BattCapacity_60
2017-08-28T19:19:18.135Z,1503947958.135 [CommandLine](IMPORTANT): BPC1.BattCapacity_60 6.470000 Ah
2017-08-28T19:19:19.609Z,1503947959.609 [BPC1](ERROR): Failed to receive battery data
2017-08-28T19:19:19.609Z,1503947959.609 [BPC1] Communications Fault, FailCount= 2
2017-08-28T19:19:19.610Z,1503947959.610 [BPC1](ERROR): Communications Fault
2017-08-28T19:19:19.779Z,1503947959.779 [CBIT](ERROR): Communications Fault in component: BPC1
2017-08-28T19:19:20.949Z,1503947960.949 [CBIT](INFO): Clearing failed state for component BPC1
2017-08-28T19:19:20.949Z,1503947960.949 [BPC1] No Fault, FailCount= 2
2017-08-28T19:19:22.876Z,1503947962.876 [CommandLine](IMPORTANT): got command get BPC1.BattCapacity_50
2017-08-28T19:19:22.877Z,1503947962.877 [CommandLine](IMPORTANT): BPC1.BattCapacity_50 nan Ah
2017-08-28T19:19:26.293Z,1503947966.293 [CommandLine](IMPORTANT): got command get BPC1.BattCapacity_40
2017-08-28T19:19:26.293Z,1503947966.293 [CommandLine](IMPORTANT): BPC1.BattCapacity_40 6.557000 Ah
2017-08-28T19:19:29.647Z,1503947969.647 [CommandLine](IMPORTANT): got command get BPC1.BattCapacity_30
2017-08-28T19:19:29.648Z,1503947969.648 [CommandLine](IMPORTANT): BPC1.BattCapacity_30 6.434000 Ah
2017-08-28T19:19:32.728Z,1503947972.728 [CommandLine](IMPORTANT): got command get BPC1.BattCapacity_20
2017-08-28T19:19:32.728Z,1503947972.728 [CommandLine](IMPORTANT): BPC1.BattCapacity_20 6.678000 Ah
2017-08-28T19:19:35.834Z,1503947975.834 [CommandLine](IMPORTANT): got command get BPC1.BattCapacity_10
2017-08-28T19:19:35.835Z,1503947975.835 [CommandLine](IMPORTANT): BPC1.BattCapacity_10 6.447000 Ah
2017-08-28T19:19:36.800Z,1503947976.800 [BPC1](ERROR): Failed to receive battery data
2017-08-28T19:19:36.800Z,1503947976.800 [BPC1] Communications Fault, FailCount= 3
2017-08-28T19:19:36.800Z,1503947976.800 [BPC1](ERROR): Communications Fault
2017-08-28T19:19:36.942Z,1503947976.942 [CBIT](ERROR): Communications Fault in component: BPC1
2017-08-28T19:19:38.120Z,1503947978.120 [CBIT](INFO): Clearing failed state for component BPC1
2017-08-28T19:19:38.120Z,1503947978.120 [BPC1] No Fault, FailCount= 3
2017-08-28T19:19:43.487Z,1503947983.487 [CommandLine](IMPORTANT): got command get platform_battery_charge
2017-08-28T19:19:43.488Z,1503947983.488 [CommandLine](FAULT): Element has no value
2017-08-28T19:19:49.855Z,1503947989.855 [CommandLine](IMPORTANT): got command get BPC1.BattCapacity_50
2017-08-28T19:19:49.856Z,1503947989.856 [CommandLine](IMPORTANT): BPC1.BattCapacity_50 nan Ah
2017-08-28T19:19:54.411Z,1503947994.411 [BPC1](ERROR): Failed to receive battery data
2017-08-28T19:19:54.411Z,1503947994.411 [BPC1] Communications Fault, FailCount= 4
2017-08-28T19:19:54.412Z,1503947994.412 [BPC1](ERROR): Communications Fault
2017-08-28T19:19:54.566Z,1503947994.566 [CBIT](ERROR): Communications Fault in component: BPC1
2017-08-28T19:19:58.468Z,1503947998.468 [CBIT](INFO): Clearing failed state for component BPC1
2017-08-28T19:19:58.468Z,1503947998.468 [BPC1] No Fault, FailCount= 4
2017-08-28T19:20:05.720Z,1503948005.720 [CommandLine](IMPORTANT): got command get BPC1.BattCapacity_50
2017-08-28T19:20:05.720Z,1503948005.720 [CommandLine](IMPORTANT): BPC1.BattCapacity_50 nan Ah
2017-08-28T19:20:14.329Z,1503948014.329 [BPC1](ERROR): Failed to receive battery data
2017-08-28T19:20:14.329Z,1503948014.329 [BPC1] Communications Fault, FailCount= 5
2017-08-28T19:20:14.329Z,1503948014.329 [BPC1](ERROR): Communications Fault
2017-08-28T19:20:14.454Z,1503948014.454 [CBIT](ERROR): Communications Fault in component: BPC1
2017-08-28T19:20:15.680Z,1503948015.680 [CBIT](INFO): Clearing failed state for component BPC1
2017-08-28T19:20:15.680Z,1503948015.680 [BPC1] No Fault, FailCount= 5
2017-08-28T19:20:27.713Z,1503948027.713 [CommandLine](IMPORTANT): got command get BPC1.BattCapacity_50
2017-08-28T19:20:27.713Z,1503948027.713 [CommandLine](IMPORTANT): BPC1.BattCapacity_50 nan Ah
2017-08-28T19:20:31.517Z,1503948031.517 [BPC1](ERROR): Failed to receive battery data
2017-08-28T19:20:31.517Z,1503948031.517 [BPC1] Communications Fault, FailCount= 6
2017-08-28T19:20:31.517Z,1503948031.517 [BPC1](ERROR): Communications Fault
2017-08-28T19:20:31.661Z,1503948031.661 [CBIT](ERROR): Communications Fault in component: BPC1
2017-08-28T19:20:32.843Z,1503948032.843 [CBIT](INFO): Clearing failed state for component BPC1
2017-08-28T19:20:32.843Z,1503948032.843 [BPC1] No Fault, FailCount= 6
2017-08-28T19:20:33.187Z,1503948033.187 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2017-08-28T19:20:33.187Z,1503948033.187 [Default:CheckIn:C.Wait] Stopped
2017-08-28T19:20:33.187Z,1503948033.187 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2017-08-28T19:20:33.187Z,1503948033.187 [Default:CheckIn:D] Running Loop=1
2017-08-28T19:20:33.547Z,1503948033.547 [Default:CheckIn:D] Stopped
2017-08-28T19:20:33.547Z,1503948033.547 [Default:CheckIn:E] Running Loop=1
2017-08-28T19:20:33.976Z,1503948033.976 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 25.935883 min 
2017-08-28T19:20:33.976Z,1503948033.976 [Default:CheckIn:E] Stopped
2017-08-28T19:20:33.976Z,1503948033.976 [Default:CheckIn](INFO): Completed Default:CheckIn
2017-08-28T19:20:33.976Z,1503948033.976 [Default:CheckIn] Stopped
2017-08-28T19:20:33.976Z,1503948033.976 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2017-08-28T19:20:33.976Z,1503948033.976 [Default:CheckIn](INFO): Running loop #4
2017-08-28T19:20:33.977Z,1503948033.977 [Default:CheckIn] Running Loop=4
2017-08-28T19:20:33.977Z,1503948033.977 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2017-08-28T19:20:33.977Z,1503948033.977 [Default:CheckIn:Read_GPS] Running Loop=1
2017-08-28T19:20:34.697Z,1503948034.697 [NAL9602](INFO): Powering up
2017-08-28T19:20:37.554Z,1503948037.554 [CommandLine](IMPORTANT): got command get BPC1.BattCapacity_50
2017-08-28T19:20:37.555Z,1503948037.555 [CommandLine](IMPORTANT): BPC1.BattCapacity_50 nan Ah
2017-08-28T19:20:42.441Z,1503948042.441 [CommandLine](IMPORTANT): got command get BPC1.BattCapacity_51
2017-08-28T19:20:42.442Z,1503948042.442 [CommandLine](IMPORTANT): BPC1.BattCapacity_51 nan Ah
2017-08-28T19:20:45.192Z,1503948045.192 [CommandLine](IMPORTANT): got command get BPC1.BattCapacity_52
2017-08-28T19:20:45.192Z,1503948045.192 [CommandLine](IMPORTANT): BPC1.BattCapacity_52 nan Ah
2017-08-28T19:20:45.891Z,1503948045.891 [NAL9602](INFO): NAL9602 initialized
2017-08-28T19:20:46.916Z,1503948046.916 [CommandLine](IMPORTANT): got command get BPC1.BattCapacity_53
2017-08-28T19:20:46.917Z,1503948046.917 [CommandLine](IMPORTANT): BPC1.BattCapacity_53 6.431000 Ah
2017-08-28T19:20:49.156Z,1503948049.156 [BPC1](ERROR): Failed to receive battery data
2017-08-28T19:20:49.156Z,1503948049.156 [BPC1] Communications Fault, FailCount= 7
2017-08-28T19:20:49.156Z,1503948049.156 [BPC1](ERROR): Communications Fault
2017-08-28T19:20:49.365Z,1503948049.365 [CBIT](ERROR): Communications Fault in component: BPC1
2017-08-28T19:20:50.446Z,1503948050.446 [CBIT](INFO): Clearing failed state for component BPC1
2017-08-28T19:20:50.447Z,1503948050.447 [BPC1] No Fault, FailCount= 7
2017-08-28T19:20:52.352Z,1503948052.352 [CommandLine](IMPORTANT): got command get BPC1.BattCapacity_51
2017-08-28T19:20:52.352Z,1503948052.352 [CommandLine](IMPORTANT): BPC1.BattCapacity_51 nan Ah
2017-08-28T19:20:55.410Z,1503948055.410 [CommandLine](IMPORTANT): got command get BPC1.BattCapacity_50
2017-08-28T19:20:55.411Z,1503948055.411 [CommandLine](IMPORTANT): BPC1.BattCapacity_50 nan Ah
2017-08-28T19:20:58.099Z,1503948058.099 [CommandLine](IMPORTANT): got command get BPC1.BattCapacity_49
2017-08-28T19:20:58.099Z,1503948058.099 [CommandLine](IMPORTANT): BPC1.BattCapacity_49 nan Ah
2017-08-28T19:21:01.956Z,1503948061.956 [CommandLine](IMPORTANT): got command get BPC1.BattCapacity_48
2017-08-28T19:21:01.957Z,1503948061.957 [CommandLine](IMPORTANT): BPC1.BattCapacity_48 nan Ah
2017-08-28T19:21:05.667Z,1503948065.667 [CommandLine](IMPORTANT): got command get BPC1.BattCapacity_47
2017-08-28T19:21:05.667Z,1503948065.667 [CommandLine](IMPORTANT): BPC1.BattCapacity_47 nan Ah
2017-08-28T19:21:08.670Z,1503948068.670 [CommandLine](IMPORTANT): got command get BPC1.BattCapacity_46
2017-08-28T19:21:08.671Z,1503948068.671 [CommandLine](IMPORTANT): BPC1.BattCapacity_46 6.467000 Ah
2017-08-28T19:21:14.355Z,1503948074.355 [BPC1](ERROR): Failed to receive battery data
2017-08-28T19:21:14.355Z,1503948074.355 [BPC1] Communications Fault, FailCount= 8
2017-08-28T19:21:14.355Z,1503948074.355 [BPC1](ERROR): Communications Fault
2017-08-28T19:21:14.504Z,1503948074.504 [CBIT](ERROR): Communications Fault in component: BPC1
2017-08-28T19:21:15.718Z,1503948075.718 [CBIT](INFO): Clearing failed state for component BPC1
2017-08-28T19:21:15.718Z,1503948075.718 [BPC1] No Fault, FailCount= 8
2017-08-28T19:21:17.943Z,1503948077.943 [NAL9602](INFO): SBD MO Status=2, MOMSN=136, MT Status=2, MTMSN=0
2017-08-28T19:21:17.943Z,1503948077.943 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2017-08-28T19:21:31.980Z,1503948091.980 [BPC1](ERROR): Failed to receive battery data
2017-08-28T19:21:31.980Z,1503948091.980 [BPC1] Communications Fault, FailCount= 9
2017-08-28T19:21:31.980Z,1503948091.980 [BPC1](ERROR): Communications Fault
2017-08-28T19:21:32.108Z,1503948092.108 [CBIT](ERROR): Communications Fault in component: BPC1
2017-08-28T19:21:33.330Z,1503948093.330 [CBIT](INFO): Clearing failed state for component BPC1
2017-08-28T19:21:33.330Z,1503948093.330 [BPC1] No Fault, FailCount= 9
2017-08-28T19:21:41.806Z,1503948101.806 [CommandLine](IMPORTANT): got command get BPC1.BattCapacity_46
2017-08-28T19:21:41.806Z,1503948101.806 [CommandLine](IMPORTANT): BPC1.BattCapacity_46 6.467000 Ah
2017-08-28T19:21:43.727Z,1503948103.727 [CBIT](DEBUG): EFC running - data check-sum false
2017-08-28T19:21:44.366Z,1503948104.366 [CommandLine](IMPORTANT): got command get BPC1.BattCapacity_47
2017-08-28T19:21:44.367Z,1503948104.367 [CommandLine](IMPORTANT): BPC1.BattCapacity_47 nan Ah
2017-08-28T19:21:49.232Z,1503948109.232 [CommandLine](IMPORTANT): got command get BPC1.BattCapacity_48
2017-08-28T19:21:49.233Z,1503948109.233 [CommandLine](IMPORTANT): BPC1.BattCapacity_48 nan Ah
2017-08-28T19:21:51.491Z,1503948111.491 [CommandLine](IMPORTANT): got command get BPC1.BattCapacity_49
2017-08-28T19:21:51.491Z,1503948111.491 [CommandLine](IMPORTANT): BPC1.BattCapacity_49 nan Ah
2017-08-28T19:21:53.943Z,1503948113.943 [CommandLine](IMPORTANT): got command get BPC1.BattCapacity_50
2017-08-28T19:21:53.944Z,1503948113.944 [CommandLine](IMPORTANT): BPC1.BattCapacity_50 nan Ah
2017-08-28T19:21:56.882Z,1503948116.882 [CommandLine](IMPORTANT): got command get BPC1.BattCapacity_51
2017-08-28T19:21:56.882Z,1503948116.882 [CommandLine](IMPORTANT): BPC1.BattCapacity_51 nan Ah
2017-08-28T19:21:59.023Z,1503948119.023 [NAL9602](INFO): SBD MO Status=2, MOMSN=136, MT Status=2, MTMSN=0
2017-08-28T19:21:59.023Z,1503948119.023 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2017-08-28T19:21:59.529Z,1503948119.529 [CommandLine](IMPORTANT): got command get BPC1.BattCapacity_52
2017-08-28T19:21:59.530Z,1503948119.530 [CommandLine](IMPORTANT): BPC1.BattCapacity_52 nan Ah
2017-08-28T19:22:03.241Z,1503948123.241 [CommandLine](IMPORTANT): got command get BPC1.BattCapacity_53
2017-08-28T19:22:03.242Z,1503948123.242 [CommandLine](IMPORTANT): BPC1.BattCapacity_53 6.431000 Ah
2017-08-28T19:22:28.875Z,1503948148.875 [NAL9602](INFO): SBD MO Status=2, MOMSN=136, MT Status=2, MTMSN=0
2017-08-28T19:22:28.875Z,1503948148.875 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2017-08-28T19:23:26.095Z,1503948206.095 [BPC1](ERROR): Failed to parse bank A battery data
2017-08-28T19:23:26.095Z,1503948206.095 [BPC1] Data Fault, FailCount= 1
2017-08-28T19:23:26.095Z,1503948206.095 [BPC1](ERROR): Data Fault
2017-08-28T19:23:26.218Z,1503948206.218 [CBIT](ERROR): Data Fault in component: BPC1
2017-08-28T19:23:27.420Z,1503948207.420 [CBIT](INFO): Clearing failed state for component BPC1
2017-08-28T19:23:27.420Z,1503948207.420 [BPC1] No Fault, FailCount= 1
2017-08-28T19:23:44.078Z,1503948224.078 [CommandLine](IMPORTANT): got command get BPC1.BattCapacity_53
2017-08-28T19:23:44.089Z,1503948224.089 [CommandLine](IMPORTANT): BPC1.BattCapacity_53 6.431000 Ah
2017-08-28T19:23:45.863Z,1503948225.863 [CommandLine](IMPORTANT): got command get BPC1.BattCapacity_52
2017-08-28T19:23:45.863Z,1503948225.863 [CommandLine](IMPORTANT): BPC1.BattCapacity_52 nan Ah
2017-08-28T19:23:58.525Z,1503948238.525 [NAL9602](INFO): SBD MO Status=2, MOMSN=136, MT Status=2, MTMSN=0
2017-08-28T19:23:58.525Z,1503948238.525 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2017-08-28T19:23:58.567Z,1503948238.567 [BPC1](ERROR): Failed to receive battery data
2017-08-28T19:23:58.567Z,1503948238.567 [BPC1] Communications Fault, FailCount= 1
2017-08-28T19:23:58.568Z,1503948238.568 [BPC1](ERROR): Communications Fault
2017-08-28T19:23:58.732Z,1503948238.732 [CBIT](ERROR): Communications Fault in component: BPC1
2017-08-28T19:23:59.738Z,1503948239.738 [CBIT](INFO): Clearing failed state for component BPC1
2017-08-28T19:23:59.738Z,1503948239.738 [BPC1] No Fault, FailCount= 1
2017-08-28T19:24:21.556Z,1503948261.556 [NAL9602](INFO): SBD MO Status=2, MOMSN=136, MT Status=2, MTMSN=0
2017-08-28T19:24:21.556Z,1503948261.556 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2017-08-28T19:24:59.813Z,1503948299.813 [DataOverHttps](IMPORTANT): SBD MTMSN=20170828T192458
2017-08-28T19:25:04.106Z,1503948304.106 [DataOverHttps](INFO): Received command:failc
2017-08-28T19:25:04.123Z,1503948304.123 [CommandLine](IMPORTANT): got command failComponent
2017-08-28T19:25:04.123Z,1503948304.123 [CommandLine](IMPORTANT): Failed components:
2017-08-28T19:25:04.124Z,1503948304.124 [CommandLine](IMPORTANT): No failed Components.
2017-08-28T19:25:14.108Z,1503948314.108 [NAL9602](INFO): SBD MO Status=2, MOMSN=136, MT Status=2, MTMSN=0
2017-08-28T19:25:14.108Z,1503948314.108 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2017-08-28T19:25:34.161Z,1503948334.161 [Default:CheckIn:Read_GPS](INFO): Timed out from 2017-08-28T19:20:33.0Z
2017-08-28T19:25:34.161Z,1503948334.161 [Default:CheckIn:Read_GPS] Stopped
2017-08-28T19:25:34.161Z,1503948334.161 [Default:CheckIn:Read_Iridium] Running Loop=1
2017-08-28T19:25:39.158Z,1503948339.158 [DataOverHttps](INFO): Sending 25 bytes from file Logs/20170828T184133/Courier0036.lzma
2017-08-28T19:25:39.941Z,1503948339.941 [DataOverHttps](INFO): Moved sent file to Logs/20170828T184133/Courier0036.lzma.bak
2017-08-28T19:25:39.941Z,1503948339.941 [DataOverHttps](INFO): SBD MOMSN=5069070
2017-08-28T19:25:44.140Z,1503948344.140 [NAL9602](IMPORTANT): SBD MO Status=0, MOMSN=136, MT Status=1, MTMSN=908
2017-08-28T19:25:44.140Z,1503948344.140 [NAL9602](INFO): Data available in MT queue
2017-08-28T19:25:44.466Z,1503948344.466 [NAL9602](INFO): Received command:failc;get platform_battery_charge
2017-08-28T19:25:45.189Z,1503948345.189 [CommandLine](IMPORTANT): got command failComponent
2017-08-28T19:25:45.189Z,1503948345.189 [CommandLine](IMPORTANT): Failed components:
2017-08-28T19:25:45.189Z,1503948345.189 [CommandLine](IMPORTANT): No failed Components.
2017-08-28T19:25:45.190Z,1503948345.190 [CommandLine](IMPORTANT): got command get platform_battery_charge
2017-08-28T19:25:45.190Z,1503948345.190 [CommandLine](FAULT): Element has no value
2017-08-28T19:25:50.137Z,1503948350.137 [DataOverHttps](INFO): Sending 25 bytes from file Logs/20170828T184133/Courier0040.lzma
2017-08-28T19:25:50.520Z,1503948350.520 [NAL9602](INFO): Powering down
2017-08-28T19:25:50.918Z,1503948350.918 [DataOverHttps](INFO): Moved sent file to Logs/20170828T184133/Courier0040.lzma.bak
2017-08-28T19:25:50.918Z,1503948350.918 [DataOverHttps](INFO): SBD MOMSN=5069072
2017-08-28T19:26:00.355Z,1503948360.355 [DataOverHttps](INFO): Sending 1873 bytes from file Logs/20170828T184133/Express0037.lzma
2017-08-28T19:26:01.151Z,1503948361.151 [DataOverHttps](INFO): Moved sent file to Logs/20170828T184133/Express0037.lzma.bak
2017-08-28T19:26:01.151Z,1503948361.151 [DataOverHttps](INFO): SBD MOMSN=5069074
2017-08-28T19:26:10.539Z,1503948370.539 [DataOverHttps](INFO): Sending 25 bytes from file Logs/20170828T184133/Express0041.lzma
2017-08-28T19:26:11.342Z,1503948371.342 [DataOverHttps](INFO): Moved sent file to Logs/20170828T184133/Express0041.lzma.bak
2017-08-28T19:26:11.342Z,1503948371.342 [DataOverHttps](INFO): SBD MOMSN=5069532
2017-08-28T19:26:11.806Z,1503948371.806 [Default:CheckIn:Read_Iridium] Stopped
2017-08-28T19:26:11.807Z,1503948371.807 [Default:CheckIn:C.Wait] Running Loop=1
2017-08-28T19:26:11.807Z,1503948371.807 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2017-08-28T19:28:35.313Z,1503948515.313 [BPC1](ERROR): Failed to receive battery data
2017-08-28T19:28:35.314Z,1503948515.314 [BPC1] Communications Fault, FailCount= 1
2017-08-28T19:28:35.314Z,1503948515.314 [BPC1](ERROR): Communications Fault
2017-08-28T19:28:35.456Z,1503948515.456 [CBIT](ERROR): Communications Fault in component: BPC1
2017-08-28T19:28:36.631Z,1503948516.631 [CBIT](INFO): Clearing failed state for component BPC1
2017-08-28T19:28:36.632Z,1503948516.632 [BPC1] No Fault, FailCount= 1
2017-08-28T19:28:42.075Z,1503948522.075 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2017-08-28T19:29:06.104Z,1503948546.104 [BPC1](ERROR): Failed to receive battery data
2017-08-28T19:29:06.104Z,1503948546.104 [BPC1] Communications Fault, FailCount= 1
2017-08-28T19:29:06.104Z,1503948546.104 [BPC1](ERROR): Communications Fault
2017-08-28T19:29:06.239Z,1503948546.239 [CBIT](ERROR): Communications Fault in component: BPC1
2017-08-28T19:29:07.426Z,1503948547.426 [CBIT](INFO): Clearing failed state for component BPC1
2017-08-28T19:29:07.426Z,1503948547.426 [BPC1] No Fault, FailCount= 1
2017-08-28T19:29:23.710Z,1503948563.710 [BPC1](ERROR): Failed to receive battery data
2017-08-28T19:29:23.710Z,1503948563.710 [BPC1] Communications Fault, FailCount= 2
2017-08-28T19:29:23.710Z,1503948563.710 [BPC1](ERROR): Communications Fault
2017-08-28T19:29:23.866Z,1503948563.866 [CBIT](ERROR): Communications Fault in component: BPC1
2017-08-28T19:29:25.032Z,1503948565.032 [CBIT](INFO): Clearing failed state for component BPC1
2017-08-28T19:29:25.032Z,1503948565.032 [BPC1] No Fault, FailCount= 2
2017-08-28T19:29:41.303Z,1503948581.303 [BPC1](ERROR): Failed to receive battery data
2017-08-28T19:29:41.303Z,1503948581.303 [BPC1] Communications Fault, FailCount= 3
2017-08-28T19:29:41.303Z,1503948581.303 [BPC1](ERROR): Communications Fault
2017-08-28T19:29:41.482Z,1503948581.482 [CBIT](ERROR): Communications Fault in component: BPC1
2017-08-28T19:29:42.648Z,1503948582.648 [CBIT](INFO): Clearing failed state for component BPC1
2017-08-28T19:29:42.648Z,1503948582.648 [BPC1] No Fault, FailCount= 3
2017-08-28T19:29:42.876Z,1503948582.876 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2017-08-28T19:29:58.918Z,1503948598.918 [BPC1](ERROR): Failed to receive battery data
2017-08-28T19:29:58.918Z,1503948598.918 [BPC1] Communications Fault, FailCount= 4
2017-08-28T19:29:58.918Z,1503948598.918 [BPC1](ERROR): Communications Fault
2017-08-28T19:29:59.043Z,1503948599.043 [CBIT](ERROR): Communications Fault in component: BPC1
2017-08-28T19:30:00.265Z,1503948600.265 [CBIT](INFO): Clearing failed state for component BPC1
2017-08-28T19:30:00.265Z,1503948600.265 [BPC1] No Fault, FailCount= 4
2017-08-28T19:30:16.512Z,1503948616.512 [BPC1](ERROR): Failed to receive battery data
2017-08-28T19:30:16.512Z,1503948616.512 [BPC1] Communications Fault, FailCount= 5
2017-08-28T19:30:16.512Z,1503948616.512 [BPC1](ERROR): Communications Fault
2017-08-28T19:30:16.634Z,1503948616.634 [CBIT](ERROR): Communications Fault in component: BPC1
2017-08-28T19:30:17.831Z,1503948617.831 [CBIT](INFO): Clearing failed state for component BPC1
2017-08-28T19:30:17.832Z,1503948617.832 [BPC1] No Fault, FailCount= 5
2017-08-28T19:30:18.873Z,1503948618.873 [DataOverHttps](INFO): setting unavailable, lastComms_.elapsed()=180.000305
2017-08-28T19:30:34.113Z,1503948634.113 [BPC1](ERROR): Failed to receive battery data
2017-08-28T19:30:34.113Z,1503948634.113 [BPC1] Communications Fault, FailCount= 6
2017-08-28T19:30:34.113Z,1503948634.113 [BPC1](ERROR): Communications Fault
2017-08-28T19:30:34.233Z,1503948634.233 [CBIT](ERROR): Communications Fault in component: BPC1
2017-08-28T19:30:35.435Z,1503948635.435 [CBIT](INFO): Clearing failed state for component BPC1
2017-08-28T19:30:35.435Z,1503948635.435 [BPC1] No Fault, FailCount= 6
2017-08-28T19:30:54.912Z,1503948654.912 [BPC1](ERROR): Failed to receive battery data
2017-08-28T19:30:54.912Z,1503948654.912 [BPC1] Communications Fault, FailCount= 7
2017-08-28T19:30:54.913Z,1503948654.913 [BPC1](ERROR): Communications Fault
2017-08-28T19:30:55.034Z,1503948655.034 [CBIT](ERROR): Communications Fault in component: BPC1
2017-08-28T19:30:56.248Z,1503948656.248 [CBIT](INFO): Clearing failed state for component BPC1
2017-08-28T19:30:56.248Z,1503948656.248 [BPC1] No Fault, FailCount= 7
2017-08-28T19:31:12.590Z,1503948672.590 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2017-08-28T19:31:12.591Z,1503948672.591 [Default:CheckIn:C.Wait] Stopped
2017-08-28T19:31:12.591Z,1503948672.591 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2017-08-28T19:31:12.591Z,1503948672.591 [Default:CheckIn:D] Running Loop=1
2017-08-28T19:31:12.963Z,1503948672.963 [Default:CheckIn:D] Stopped
2017-08-28T19:31:12.963Z,1503948672.963 [Default:CheckIn:E] Running Loop=1
2017-08-28T19:31:13.332Z,1503948673.332 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 36.592822 min 
2017-08-28T19:31:13.332Z,1503948673.332 [Default:CheckIn:E] Stopped
2017-08-28T19:31:13.332Z,1503948673.332 [Default:CheckIn](INFO): Completed Default:CheckIn
2017-08-28T19:31:13.332Z,1503948673.332 [Default:CheckIn] Stopped
2017-08-28T19:31:13.332Z,1503948673.332 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2017-08-28T19:31:13.332Z,1503948673.332 [Default:CheckIn](INFO): Running loop #5
2017-08-28T19:31:13.332Z,1503948673.332 [Default:CheckIn] Running Loop=5
2017-08-28T19:31:13.333Z,1503948673.333 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2017-08-28T19:31:13.333Z,1503948673.333 [Default:CheckIn:Read_GPS] Running Loop=1
2017-08-28T19:31:14.077Z,1503948674.077 [NAL9602](INFO): Powering up
2017-08-28T19:31:20.846Z,1503948680.846 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.002606
2017-08-28T19:31:25.247Z,1503948685.247 [NAL9602](INFO): NAL9602 initialized
2017-08-28T19:31:26.051Z,1503948686.051 [NAL9602](FAULT): GPS failed to acquire within timeout.
2017-08-28T19:31:26.052Z,1503948686.052 [NAL9602] Data Fault, FailCount= 1
2017-08-28T19:31:26.052Z,1503948686.052 [NAL9602](ERROR): Data Fault
2017-08-28T19:31:26.230Z,1503948686.230 [CBIT](ERROR): Data Fault in component: NAL9602
2017-08-28T19:31:26.443Z,1503948686.443 [NAL9602](INFO): Powering down
2017-08-28T19:31:27.429Z,1503948687.429 [CBIT](INFO): Clearing failed state for component NAL9602
2017-08-28T19:31:27.430Z,1503948687.430 [NAL9602] No Fault, FailCount= 1
2017-08-28T19:31:31.649Z,1503948691.649 [NAL9602](INFO): Powering up NAL9602
2017-08-28T19:31:33.293Z,1503948693.293 [BPC1](ERROR): Failed to parse bank A battery data
2017-08-28T19:31:33.293Z,1503948693.293 [BPC1] Data Fault, FailCount= 1
2017-08-28T19:31:33.293Z,1503948693.293 [BPC1](ERROR): Data Fault
2017-08-28T19:31:33.415Z,1503948693.415 [CBIT](ERROR): Data Fault in component: BPC1
2017-08-28T19:31:34.673Z,1503948694.673 [CBIT](INFO): Clearing failed state for component BPC1
2017-08-28T19:31:34.673Z,1503948694.673 [BPC1] No Fault, FailCount= 1
2017-08-28T19:31:42.460Z,1503948702.460 [NAL9602](INFO): NAL9602 initialized
2017-08-28T19:31:43.820Z,1503948703.820 [CBIT](DEBUG): EFC running - data check-sum false
2017-08-28T19:32:12.454Z,1503948732.454 [NAL9602](INFO): SBD MO Status=0, MOMSN=137, MT Status=0, MTMSN=0
2017-08-28T19:32:12.454Z,1503948732.454 [NAL9602](INFO): No messages in MT queue
2017-08-28T19:33:43.308Z,1503948823.308 [DataOverHttps](INFO): Exceeded connection timeout, disconnecting.
2017-08-28T19:34:18.965Z,1503948858.965 [DataOverHttps](IMPORTANT): SBD MTMSN=20170828T193417
2017-08-28T19:34:24.913Z,1503948864.913 [DataOverHttps](INFO): Received command:restart logs