2018-03-14T23:02:49.775Z,1521068569.775 [Supervisor](DEBUG): Initializing supervisor.
2018-03-14T23:02:49.778Z,1521068569.778 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2018-03-14T23:02:49.778Z,1521068569.778 [SyncHandler](INFO): Protected caller Thread ID is 1048
2018-03-14T23:02:49.779Z,1521068569.779 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2018-03-14T23:02:49.780Z,1521068569.780 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2018-03-14T23:02:49.780Z,1521068569.780 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 1049
2018-03-14T23:02:49.783Z,1521068569.783 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2018-03-14T23:02:49.794Z,1521068569.794 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2018-03-14T23:02:49.795Z,1521068569.795 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2018-03-14T23:02:49.796Z,1521068569.796 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 1050
2018-03-14T23:02:49.796Z,1521068569.796 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2018-03-14T23:02:49.797Z,1521068569.797 [logger ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2018-03-14T23:02:49.798Z,1521068569.798 [logger ThreadHandler](INFO): Protected caller Thread ID is 1051
2018-03-14T23:02:49.800Z,1521068569.800 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2018-03-14T23:02:49.800Z,1521068569.800 [Supervisor](INFO): Looking for Config files in directory: Config/
2018-03-14T23:02:49.802Z,1521068569.802 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2018-03-14T23:02:50.096Z,1521068570.096 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2018-03-14T23:02:50.097Z,1521068570.097 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2018-03-14T23:02:50.279Z,1521068570.279 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2018-03-14T23:02:50.279Z,1521068570.279 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2018-03-14T23:02:50.537Z,1521068570.537 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2018-03-14T23:02:50.537Z,1521068570.537 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2018-03-14T23:02:50.672Z,1521068570.672 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2018-03-14T23:02:50.672Z,1521068570.672 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2018-03-14T23:02:50.767Z,1521068570.767 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample
2018-03-14T23:02:50.767Z,1521068570.767 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2018-03-14T23:02:51.185Z,1521068571.185 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2018-03-14T23:02:51.186Z,1521068571.186 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2018-03-14T23:02:51.501Z,1521068571.501 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2018-03-14T23:02:51.502Z,1521068571.502 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2018-03-14T23:02:51.902Z,1521068571.902 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2018-03-14T23:02:51.903Z,1521068571.903 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2018-03-14T23:02:52.003Z,1521068572.003 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2018-03-14T23:02:52.004Z,1521068572.004 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2018-03-14T23:02:52.097Z,1521068572.097 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2018-03-14T23:02:52.098Z,1521068572.098 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2018-03-14T23:02:52.291Z,1521068572.291 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2018-03-14T23:02:52.291Z,1521068572.291 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2018-03-14T23:02:52.485Z,1521068572.485 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2018-03-14T23:02:52.485Z,1521068572.485 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2018-03-14T23:02:52.796Z,1521068572.796 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2018-03-14T23:02:52.797Z,1521068572.797 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2018-03-14T23:02:52.931Z,1521068572.931 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2018-03-14T23:02:52.932Z,1521068572.932 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2018-03-14T23:02:53.012Z,1521068573.012 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-daphne/
2018-03-14T23:02:53.013Z,1521068573.013 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Control.cfg
2018-03-14T23:02:53.110Z,1521068573.110 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/logger.cfg
2018-03-14T23:02:53.198Z,1521068573.198 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Servo.cfg
2018-03-14T23:02:53.288Z,1521068573.288 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Simulator.cfg
2018-03-14T23:02:53.371Z,1521068573.371 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Sensor.cfg
2018-03-14T23:02:53.510Z,1521068573.510 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/vehicle.cfg
2018-03-14T23:02:53.672Z,1521068573.672 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/workSite.cfg
2018-03-14T23:02:53.747Z,1521068573.747 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Battery.cfg
2018-03-14T23:02:53.963Z,1521068573.963 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2018-03-14T23:02:53.963Z,1521068573.963 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/secure.cfg
2018-03-14T23:02:54.045Z,1521068574.045 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Navigation.cfg
2018-03-14T23:02:54.132Z,1521068574.132 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/BIT.cfg
2018-03-14T23:02:54.241Z,1521068574.241 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Science.cfg
2018-03-14T23:02:54.530Z,1521068574.530 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-daphne/root/
2018-03-14T23:02:54.531Z,1521068574.531 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg
2018-03-14T23:02:54.536Z,1521068574.536 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2018-03-14T23:02:54.954Z,1521068574.954 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2018-03-14T23:02:54.955Z,1521068574.955 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2018-03-14T23:02:54.995Z,1521068574.995 [DepthRateCalculator] Loaded
2018-03-14T23:02:54.996Z,1521068574.996 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2018-03-14T23:02:55.001Z,1521068575.001 [PitchRateCalculator] Loaded
2018-03-14T23:02:55.002Z,1521068575.002 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2018-03-14T23:02:55.017Z,1521068575.017 [SpeedCalculator] Loaded
2018-03-14T23:02:55.017Z,1521068575.017 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2018-03-14T23:02:55.037Z,1521068575.037 [TempGradientCalculator] Loaded
2018-03-14T23:02:55.037Z,1521068575.037 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread.
2018-03-14T23:02:55.052Z,1521068575.052 [VerticalTemperatureHomogeneityIndexCalculator] Loaded
2018-03-14T23:02:55.052Z,1521068575.052 [ComponentRegistry](DEBUG): SyncComponent "VerticalTemperatureHomogeneityIndexCalculator" handled in the control thread.
2018-03-14T23:02:55.058Z,1521068575.058 [YawRateCalculator] Loaded
2018-03-14T23:02:55.058Z,1521068575.058 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2018-03-14T23:02:55.058Z,1521068575.058 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2018-03-14T23:02:55.059Z,1521068575.059 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2018-03-14T23:02:55.138Z,1521068575.138 [StratificationFrontDetector](INFO): threshold set to: 0.399988 degC
2018-03-14T23:02:55.139Z,1521068575.139 [StratificationFrontDetector](DEBUG): (re)initializing
2018-03-14T23:02:55.139Z,1521068575.139 [StratificationFrontDetector] Loaded
2018-03-14T23:02:55.139Z,1521068575.139 [ComponentRegistry](DEBUG): SyncComponent "StratificationFrontDetector" handled in the control thread.
2018-03-14T23:02:55.140Z,1521068575.140 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2018-03-14T23:02:55.140Z,1521068575.140 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2018-03-14T23:02:55.251Z,1521068575.251 [BuoyancyServo] Loaded
2018-03-14T23:02:55.251Z,1521068575.251 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2018-03-14T23:02:55.265Z,1521068575.265 [ElevatorServo] Loaded
2018-03-14T23:02:55.266Z,1521068575.266 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2018-03-14T23:02:55.280Z,1521068575.280 [MassServo] Loaded
2018-03-14T23:02:55.280Z,1521068575.280 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2018-03-14T23:02:55.294Z,1521068575.294 [RudderServo] Loaded
2018-03-14T23:02:55.294Z,1521068575.294 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2018-03-14T23:02:55.308Z,1521068575.308 [ThrusterServo] Loaded
2018-03-14T23:02:55.308Z,1521068575.308 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread.
2018-03-14T23:02:55.308Z,1521068575.308 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2018-03-14T23:02:55.309Z,1521068575.309 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2018-03-14T23:02:55.322Z,1521068575.322 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2018-03-14T23:02:55.323Z,1521068575.323 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2018-03-14T23:02:55.415Z,1521068575.415 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2018-03-14T23:02:55.416Z,1521068575.416 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2018-03-14T23:02:55.680Z,1521068575.680 [DataOverHttps] Loaded
2018-03-14T23:02:55.680Z,1521068575.680 [ComponentRegistry](DEBUG): SyncComponent "DataOverHttps" handled in the control thread.
2018-03-14T23:02:55.693Z,1521068575.693 [Depth_Keller] Loaded
2018-03-14T23:02:55.693Z,1521068575.693 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2018-03-14T23:02:55.697Z,1521068575.697 [DropWeight] Loaded
2018-03-14T23:02:55.698Z,1521068575.698 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2018-03-14T23:02:55.791Z,1521068575.791 [NAL9602] Loaded
2018-03-14T23:02:55.791Z,1521068575.791 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2018-03-14T23:02:55.806Z,1521068575.806 [Onboard] Loaded
2018-03-14T23:02:55.807Z,1521068575.807 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread.
2018-03-14T23:02:55.816Z,1521068575.816 [Radio_Surface] Loaded
2018-03-14T23:02:55.816Z,1521068575.816 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2018-03-14T23:02:55.817Z,1521068575.817 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 408714E0
2018-03-14T23:02:55.818Z,1521068575.818 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 1133
2018-03-14T23:02:55.863Z,1521068575.863 [PNI_TCM] Loaded
2018-03-14T23:02:55.864Z,1521068575.864 [ComponentRegistry](DEBUG): SyncComponent "PNI_TCM" handled in the control thread.
2018-03-14T23:02:57.532Z,1521068577.532 [BPC1] Loaded
2018-03-14T23:02:57.532Z,1521068577.532 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2018-03-14T23:02:57.532Z,1521068577.532 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2018-03-14T23:02:57.533Z,1521068577.533 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2018-03-14T23:02:57.657Z,1521068577.657 [SBIT](DEBUG): Construct Startup Built In Test.
2018-03-14T23:02:57.681Z,1521068577.681 [SBIT] Loaded
2018-03-14T23:02:57.681Z,1521068577.681 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2018-03-14T23:02:57.682Z,1521068577.682 [IBIT](DEBUG): Construct Initiated Built In Test.
2018-03-14T23:02:57.693Z,1521068577.693 [IBIT] Loaded
2018-03-14T23:02:57.693Z,1521068577.693 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2018-03-14T23:02:57.696Z,1521068577.696 [CBIT](DEBUG): Construct Continuous Built In Test.
2018-03-14T23:02:57.841Z,1521068577.841 [CBIT] Loaded
2018-03-14T23:02:57.842Z,1521068577.842 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2018-03-14T23:02:57.842Z,1521068577.842 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2018-03-14T23:02:57.843Z,1521068577.843 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2018-03-14T23:02:57.978Z,1521068577.978 [Aanderaa_O2] Loaded
2018-03-14T23:02:57.979Z,1521068577.979 [ComponentRegistry](DEBUG): SyncComponent "Aanderaa_O2" handled in the control thread.
2018-03-14T23:02:57.990Z,1521068577.990 [CANONSampler] Loaded
2018-03-14T23:02:57.990Z,1521068577.990 [ComponentRegistry](DEBUG): SyncComponent "CANONSampler" handled in the control thread.
2018-03-14T23:02:58.004Z,1521068578.004 [PAR_Licor] Loaded
2018-03-14T23:02:58.004Z,1521068578.004 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2018-03-14T23:02:58.051Z,1521068578.051 [WetLabsBB2FL] Loaded
2018-03-14T23:02:58.051Z,1521068578.051 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2018-03-14T23:02:58.052Z,1521068578.052 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 409314E0
2018-03-14T23:02:58.053Z,1521068578.053 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 1134
2018-03-14T23:02:58.053Z,1521068578.053 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2018-03-14T23:02:58.054Z,1521068578.054 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2018-03-14T23:02:58.119Z,1521068578.119 [VerticalControl](DEBUG): Construct VerticalControl.
2018-03-14T23:02:58.202Z,1521068578.202 [VerticalControl] Loaded
2018-03-14T23:02:58.202Z,1521068578.202 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2018-03-14T23:02:58.203Z,1521068578.203 [HorizontalControl](DEBUG): Construct HorizontalControl.
2018-03-14T23:02:58.257Z,1521068578.257 [HorizontalControl] Loaded
2018-03-14T23:02:58.258Z,1521068578.258 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2018-03-14T23:02:58.258Z,1521068578.258 [SpeedControl](DEBUG): Construct SpeedControl.
2018-03-14T23:02:58.260Z,1521068578.260 [SpeedControl] Loaded
2018-03-14T23:02:58.260Z,1521068578.260 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2018-03-14T23:02:58.261Z,1521068578.261 [LoopControl](DEBUG): Construct LoopControl.
2018-03-14T23:02:58.261Z,1521068578.261 [LoopControl] Loaded
2018-03-14T23:02:58.261Z,1521068578.261 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2018-03-14T23:02:58.262Z,1521068578.262 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2018-03-14T23:02:58.262Z,1521068578.262 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2018-03-14T23:02:58.286Z,1521068578.286 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2018-03-14T23:02:58.287Z,1521068578.287 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2018-03-14T23:02:58.374Z,1521068578.374 [DeadReckonUsingSpeedCalculator] Loaded
2018-03-14T23:02:58.374Z,1521068578.374 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread.
2018-03-14T23:02:58.427Z,1521068578.427 [DeadReckonWithRespectToSeafloor] Loaded
2018-03-14T23:02:58.427Z,1521068578.427 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonWithRespectToSeafloor" handled in the control thread.
2018-03-14T23:02:58.443Z,1521068578.443 [NavChart] Loaded
2018-03-14T23:02:58.443Z,1521068578.443 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2018-03-14T23:02:58.447Z,1521068578.447 [UniversalFixResidualReporter] Loaded
2018-03-14T23:02:58.448Z,1521068578.448 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2018-03-14T23:02:58.448Z,1521068578.448 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2018-03-14T23:02:58.451Z,1521068578.451 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2018-03-14T23:02:58.452Z,1521068578.452 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2018-03-14T23:02:58.458Z,1521068578.458 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2018-03-14T23:02:58.459Z,1521068578.459 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 409BD4E0
2018-03-14T23:02:58.460Z,1521068578.460 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 1135
2018-03-14T23:02:58.464Z,1521068578.464 [Supervisor](INFO): Main Thread ID is 9710
2018-03-14T23:02:58.464Z,1521068578.464 [Supervisor](DEBUG): Running supervisor.
2018-03-14T23:02:58.465Z,1521068578.465 [CommandLine ThreadHandler](INFO): Handler Thread ID is 1136
2018-03-14T23:02:58.468Z,1521068578.468 [controlThread ThreadHandler](INFO): Handler Thread ID is 1137
2018-03-14T23:02:58.468Z,1521068578.468 [controlThread](DEBUG): Initializing ControlThread
2018-03-14T23:02:58.469Z,1521068578.469 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2018-03-14T23:02:58.469Z,1521068578.469 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2018-03-14T23:02:58.469Z,1521068578.469 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2018-03-14T23:02:58.470Z,1521068578.470 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator.
2018-03-14T23:02:58.470Z,1521068578.470 [VerticalTemperatureHomogeneityIndexCalculator](DEBUG): (re)initializing
2018-03-14T23:02:58.471Z,1521068578.471 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2018-03-14T23:02:58.477Z,1521068578.477 [SBIT](INFO): Initialize SBIT Component.
2018-03-14T23:02:58.478Z,1521068578.478 [SBIT](IMPORTANT): git: 2018-03-10-3-g1088291
2018-03-14T23:02:58.478Z,1521068578.478 [SBIT](INFO): git hash: 10882917f95cfba58cc6008bb2c6cc253db9d857
2018-03-14T23:02:58.478Z,1521068578.478 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2018-03-14T23:02:58.479Z,1521068578.479 [SBIT](INFO): Kernel Reporting Different Version From Configuration.
Kernel Expected: #639 PREEMPT Wed Mar 12 12:53:33 PDT 2014
Kernel Reported: #2 PREEMPT Thu Jan 11 20:13:48 PST 2018
2018-03-14T23:02:58.480Z,1521068578.480 [SBIT](INFO): Beginning SBIT in 23.000000 seconds.
2018-03-14T23:02:58.481Z,1521068578.481 [IBIT](INFO): Initialize IBIT Component.
2018-03-14T23:02:58.481Z,1521068578.481 [CBIT](DEBUG): Initialize CBIT Component.
2018-03-14T23:02:58.482Z,1521068578.482 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2018-03-14T23:02:58.483Z,1521068578.483 [logger ThreadHandler](INFO): Handler Thread ID is 1138
2018-03-14T23:02:58.503Z,1521068578.503 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 1139
2018-03-14T23:02:58.509Z,1521068578.509 [Radio_Surface](INFO): Powering up
2018-03-14T23:02:58.515Z,1521068578.515 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 1140
2018-03-14T23:02:58.516Z,1521068578.516 [WetLabsBB2FL](INFO): Powering down
2018-03-14T23:02:58.543Z,1521068578.543 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 1141
2018-03-14T23:02:58.546Z,1521068578.546 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2018-03-14T23:02:58.546Z,1521068578.546 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2018-03-14T23:02:58.547Z,1521068578.547 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2018-03-14T23:02:58.547Z,1521068578.547 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2018-03-14T23:02:58.547Z,1521068578.547 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2018-03-14T23:02:58.547Z,1521068578.547 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2018-03-14T23:02:58.547Z,1521068578.547 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000
2018-03-14T23:02:58.547Z,1521068578.547 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000
2018-03-14T23:02:58.548Z,1521068578.548 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2018-03-14T23:02:58.548Z,1521068578.548 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2018-03-14T23:02:58.548Z,1521068578.548 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000
2018-03-14T23:02:58.548Z,1521068578.548 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000
2018-03-14T23:02:58.548Z,1521068578.548 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000
2018-03-14T23:02:58.548Z,1521068578.548 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000
2018-03-14T23:02:58.549Z,1521068578.549 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000
2018-03-14T23:02:58.549Z,1521068578.549 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000
2018-03-14T23:02:58.591Z,1521068578.591 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2018-03-14T23:02:58.592Z,1521068578.592 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2018-03-14T23:02:58.593Z,1521068578.593 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2018-03-14T23:02:58.594Z,1521068578.594 [LoopControl](DEBUG): Initialize LoopControlComponent.
2018-03-14T23:02:58.594Z,1521068578.594 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2018-03-14T23:02:58.595Z,1521068578.595 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2018-03-14T23:02:58.595Z,1521068578.595 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2018-03-14T23:02:58.596Z,1521068578.596 [DeadReckonWithRespectToSeafloor](DEBUG): Initializing DeadReckonWithRespectToSeafloor component.
2018-03-14T23:02:58.596Z,1521068578.596 [DeadReckonWithRespectToSeafloor](INFO): Will consider orientation measurement stale after 120s.
2018-03-14T23:02:58.596Z,1521068578.596 [DeadReckonWithRespectToSeafloor](INFO): Will consider velocity measurement stale after 20s.
2018-03-14T23:02:58.597Z,1521068578.597 [NavChart](DEBUG): Initialize NavChart Navigation.
2018-03-14T23:02:58.597Z,1521068578.597 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2018-03-14T23:02:58.598Z,1521068578.598 [MissionManager](INFO): Loading Mission: Missions/Startup.xml
2018-03-14T23:02:58.632Z,1521068578.632 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2018-03-14T23:02:58.667Z,1521068578.667 [MissionManager](DEBUG):
2018-03-14T23:02:58.668Z,1521068578.668 [MissionManager](INFO): Loading Mission: Missions/Default.xml
2018-03-14T23:02:58.740Z,1521068578.740 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2018-03-14T23:02:58.742Z,1521068578.742 [Default:A.Wait](DEBUG): Construct Wait.
2018-03-14T23:02:58.743Z,1521068578.743 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2018-03-14T23:02:58.766Z,1521068578.766 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2018-03-14T23:02:58.796Z,1521068578.796 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2018-03-14T23:02:58.802Z,1521068578.802 [Default:E.Execute](DEBUG): Construct Execute.
2018-03-14T23:02:58.826Z,1521068578.826 [MissionManager](DEBUG):
0
Wait a moment to see if the scheduler starts a new mission before
starting to actually run Default.
13
Burn 300
Dropped weight due to communications timeout.
5
Default mission has been running for
Restarting logs and Default mission.
restart logs
2018-03-14T23:02:58.839Z,1521068578.839 [controlThread](DEBUG): Component order: CycleStarter,DataOverHttps,Depth_Keller,DropWeight,NAL9602,Onboard,PNI_TCM,BPC1,Aanderaa_O2,CANONSampler,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,VerticalTemperatureHomogeneityIndexCalculator,YawRateCalculator,StratificationFrontDetector,DeadReckonUsingSpeedCalculator,DeadReckonWithRespectToSeafloor,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter,
2018-03-14T23:02:58.851Z,1521068578.851 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2018-03-14T23:02:58.881Z,1521068578.881 [Depth_Keller](ERROR): Pressure reading out of range: 1831.023193 decibar
2018-03-14T23:02:58.972Z,1521068578.972 [BPC1](INFO): Start
2018-03-14T23:02:59.127Z,1521068579.127 [CANONSampler](INFO): Powering down
2018-03-14T23:02:59.255Z,1521068579.255 [DepthRateCalculator](ERROR): Depth measurement is not active
2018-03-14T23:02:59.335Z,1521068579.335 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-03-14T23:02:59.347Z,1521068579.347 [DeadReckonWithRespectToSeafloor](DEBUG): Starting up and don't have orientation data yet.
2018-03-14T23:02:59.477Z,1521068579.477 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2018-03-14T23:02:59.495Z,1521068579.495 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2018-03-14T23:02:59.531Z,1521068579.531 [ElevatorServo](DEBUG): Initializing EZServoServo.
2018-03-14T23:02:59.539Z,1521068579.539 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2018-03-14T23:02:59.561Z,1521068579.561 [MassServo](DEBUG): Initializing EZServoServo.
2018-03-14T23:02:59.571Z,1521068579.571 [MassServo](DEBUG): Initializing MassServo.
2018-03-14T23:02:59.576Z,1521068579.576 [RudderServo](DEBUG): Initializing EZServoServo.
2018-03-14T23:02:59.583Z,1521068579.583 [RudderServo](DEBUG): Initializing RudderServo.
2018-03-14T23:02:59.612Z,1521068579.612 [ThrusterServo](DEBUG): Initializing EZServoServo.
2018-03-14T23:02:59.619Z,1521068579.619 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2018-03-14T23:02:59.880Z,1521068579.880 [BPC1](INFO): Starting
2018-03-14T23:02:59.903Z,1521068579.903 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-03-14T23:02:59.904Z,1521068579.904 [DeadReckonWithRespectToSeafloor](DEBUG): Starting up and don't have orientation data yet.
2018-03-14T23:03:00.121Z,1521068580.121 [BPC1](INFO): Starting
2018-03-14T23:03:00.160Z,1521068580.160 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-03-14T23:03:00.161Z,1521068580.161 [DeadReckonWithRespectToSeafloor](DEBUG): Starting up and don't have orientation data yet.
2018-03-14T23:03:00.625Z,1521068580.625 [BPC1](INFO): Starting
2018-03-14T23:03:00.686Z,1521068580.686 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-03-14T23:03:00.686Z,1521068580.686 [DeadReckonWithRespectToSeafloor](DEBUG): Starting up and don't have orientation data yet.
2018-03-14T23:03:01.019Z,1521068581.019 [BPC1](INFO): Starting
2018-03-14T23:03:01.029Z,1521068581.029 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-03-14T23:03:01.029Z,1521068581.029 [DeadReckonWithRespectToSeafloor](DEBUG): Starting up and don't have orientation data yet.
2018-03-14T23:03:01.405Z,1521068581.405 [BPC1](INFO): Starting
2018-03-14T23:03:01.450Z,1521068581.450 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-03-14T23:03:01.458Z,1521068581.458 [DeadReckonWithRespectToSeafloor](DEBUG): Starting up and don't have orientation data yet.
2018-03-14T23:03:01.805Z,1521068581.805 [BPC1](INFO): Starting
2018-03-14T23:03:01.831Z,1521068581.831 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-03-14T23:03:01.832Z,1521068581.832 [DeadReckonWithRespectToSeafloor](DEBUG): Starting up and don't have orientation data yet.
2018-03-14T23:03:02.219Z,1521068582.219 [BPC1](INFO): Starting
2018-03-14T23:03:02.339Z,1521068582.339 [Aanderaa_O2](INFO): Powering down
2018-03-14T23:03:02.462Z,1521068582.462 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-03-14T23:03:02.475Z,1521068582.475 [DeadReckonWithRespectToSeafloor](DEBUG): Starting up and don't have orientation data yet.
2018-03-14T23:03:02.613Z,1521068582.613 [BPC1](INFO): Starting
2018-03-14T23:03:03.025Z,1521068583.025 [BPC1](INFO): Starting
2018-03-14T23:03:03.535Z,1521068583.535 [BPC1](INFO): Starting
2018-03-14T23:03:03.891Z,1521068583.891 [BPC1](INFO): Starting
2018-03-14T23:03:04.291Z,1521068584.291 [BPC1](INFO): Starting
2018-03-14T23:03:04.712Z,1521068584.712 [BPC1](INFO): Starting
2018-03-14T23:03:05.077Z,1521068585.077 [BPC1](INFO): Starting
2018-03-14T23:03:05.491Z,1521068585.491 [BPC1](INFO): Starting
2018-03-14T23:03:05.895Z,1521068585.895 [BPC1](INFO): Starting
2018-03-14T23:03:06.280Z,1521068586.280 [BPC1](INFO): Starting
2018-03-14T23:03:06.679Z,1521068586.679 [BPC1](INFO): Starting
2018-03-14T23:03:07.093Z,1521068587.093 [BPC1](INFO): Starting
2018-03-14T23:03:07.491Z,1521068587.491 [BPC1](INFO): Starting
2018-03-14T23:03:07.879Z,1521068587.879 [BPC1](INFO): Starting
2018-03-14T23:03:08.281Z,1521068588.281 [BPC1](INFO): Starting
2018-03-14T23:03:08.686Z,1521068588.686 [BPC1](INFO): Starting
2018-03-14T23:03:09.079Z,1521068589.079 [BPC1](INFO): Starting
2018-03-14T23:03:09.480Z,1521068589.480 [BPC1](INFO): Starting
2018-03-14T23:03:09.877Z,1521068589.877 [BPC1](INFO): Starting
2018-03-14T23:03:10.291Z,1521068590.291 [BPC1](INFO): Starting
2018-03-14T23:03:10.687Z,1521068590.687 [BPC1](INFO): Starting
2018-03-14T23:03:11.086Z,1521068591.086 [BPC1](INFO): Starting
2018-03-14T23:03:11.477Z,1521068591.477 [BPC1](INFO): Starting
2018-03-14T23:03:11.891Z,1521068591.891 [BPC1](INFO): Starting
2018-03-14T23:03:12.291Z,1521068592.291 [BPC1](INFO): Starting
2018-03-14T23:03:12.680Z,1521068592.680 [BPC1](INFO): Starting
2018-03-14T23:03:13.077Z,1521068593.077 [BPC1](INFO): Starting
2018-03-14T23:03:13.487Z,1521068593.487 [BPC1](INFO): Starting
2018-03-14T23:03:13.891Z,1521068593.891 [BPC1](INFO): Starting
2018-03-14T23:03:14.279Z,1521068594.279 [BPC1](INFO): Starting
2018-03-14T23:03:14.677Z,1521068594.677 [BPC1](INFO): Starting
2018-03-14T23:03:15.091Z,1521068595.091 [BPC1](INFO): Starting
2018-03-14T23:03:15.491Z,1521068595.491 [BPC1](INFO): Starting
2018-03-14T23:03:15.880Z,1521068595.880 [BPC1](INFO): Starting
2018-03-14T23:03:16.277Z,1521068596.277 [BPC1](INFO): Starting
2018-03-14T23:03:16.691Z,1521068596.691 [BPC1](INFO): Starting
2018-03-14T23:03:17.091Z,1521068597.091 [BPC1](INFO): Starting
2018-03-14T23:03:17.484Z,1521068597.484 [BPC1](INFO): Starting
2018-03-14T23:03:17.877Z,1521068597.877 [BPC1](INFO): Starting
2018-03-14T23:03:18.291Z,1521068598.291 [BPC1](INFO): Starting
2018-03-14T23:03:18.691Z,1521068598.691 [BPC1](INFO): Starting
2018-03-14T23:03:19.080Z,1521068599.080 [BPC1](INFO): Starting
2018-03-14T23:03:19.477Z,1521068599.477 [BPC1](INFO): Starting
2018-03-14T23:03:19.891Z,1521068599.891 [BPC1](INFO): Starting
2018-03-14T23:03:20.291Z,1521068600.291 [BPC1](INFO): Starting
2018-03-14T23:03:20.679Z,1521068600.679 [BPC1](INFO): Starting
2018-03-14T23:03:21.076Z,1521068601.076 [BPC1](INFO): Starting
2018-03-14T23:03:21.491Z,1521068601.491 [BPC1](INFO): Starting
2018-03-14T23:03:21.891Z,1521068601.891 [BPC1](INFO): Starting
2018-03-14T23:03:21.968Z,1521068601.968 [SBIT](IMPORTANT): Beginning Startup BIT
2018-03-14T23:03:21.980Z,1521068601.980 [CBIT](IMPORTANT): Beginning ground fault scan
2018-03-14T23:03:22.279Z,1521068602.279 [BPC1](INFO): Starting
2018-03-14T23:03:22.677Z,1521068602.677 [BPC1](INFO): Starting
2018-03-14T23:03:23.101Z,1521068603.101 [BPC1](INFO): Starting
2018-03-14T23:03:23.487Z,1521068603.487 [BPC1](INFO): Starting
2018-03-14T23:03:23.889Z,1521068603.889 [BPC1](INFO): Starting
2018-03-14T23:03:24.426Z,1521068604.426 [BPC1](INFO): Starting
2018-03-14T23:03:24.826Z,1521068604.826 [BPC1](INFO): Starting
2018-03-14T23:03:25.226Z,1521068605.226 [BPC1](INFO): Starting
2018-03-14T23:03:25.614Z,1521068605.614 [BPC1](INFO): Starting
2018-03-14T23:03:25.988Z,1521068605.988 [NAL9602](INFO): Powering up NAL9602
2018-03-14T23:03:26.015Z,1521068606.015 [BPC1](INFO): Starting
2018-03-14T23:03:26.413Z,1521068606.413 [BPC1](INFO): Starting
2018-03-14T23:03:26.814Z,1521068606.814 [BPC1](INFO): Starting
2018-03-14T23:03:27.212Z,1521068607.212 [BPC1](INFO): Starting
2018-03-14T23:03:27.613Z,1521068607.613 [BPC1](INFO): Starting
2018-03-14T23:03:28.012Z,1521068608.012 [BPC1](INFO): Starting
2018-03-14T23:03:28.413Z,1521068608.413 [BPC1](INFO): Starting
2018-03-14T23:03:28.812Z,1521068608.812 [BPC1](INFO): Starting
2018-03-14T23:03:29.212Z,1521068609.212 [BPC1](INFO): Starting
2018-03-14T23:03:29.612Z,1521068609.612 [BPC1](INFO): Starting
2018-03-14T23:03:30.012Z,1521068610.012 [BPC1](INFO): Starting
2018-03-14T23:03:30.413Z,1521068610.413 [BPC1](INFO): Starting
2018-03-14T23:03:30.812Z,1521068610.812 [BPC1](INFO): Starting
2018-03-14T23:03:31.216Z,1521068611.216 [BPC1](INFO): Starting
2018-03-14T23:03:31.613Z,1521068611.613 [BPC1](INFO): Starting
2018-03-14T23:03:32.012Z,1521068612.012 [BPC1](INFO): Starting
2018-03-14T23:03:32.412Z,1521068612.412 [BPC1](INFO): Starting
2018-03-14T23:03:32.816Z,1521068612.816 [BPC1](INFO): Starting
2018-03-14T23:03:32.897Z,1521068612.897 [CBIT](IMPORTANT): Ground fault detected
mA:
CHAN A0 (Batt): 4.657929
CHAN A1 (24V): -0.004934
CHAN A2 (12V): -0.002568
CHAN A3 (5V): -0.001012
CHAN B0 (3.3V): -0.000714
CHAN B1 (3.15aV): -0.000775
CHAN B2 (3.15bV): -0.000228
CHAN B3 (GND): 0.000203
OPEN: -0.000535
Full Scale Calc: 4.765 mA, -1.589 mA
2018-03-14T23:03:33.222Z,1521068613.222 [BPC1](INFO): Starting
2018-03-14T23:03:33.618Z,1521068613.618 [BPC1](INFO): Starting
2018-03-14T23:03:34.016Z,1521068614.016 [BPC1](INFO): Starting
2018-03-14T23:03:34.416Z,1521068614.416 [BPC1](INFO): Starting
2018-03-14T23:03:34.818Z,1521068614.818 [BPC1](INFO): Starting
2018-03-14T23:03:35.219Z,1521068615.219 [BPC1](INFO): Starting
2018-03-14T23:03:35.617Z,1521068615.617 [BPC1](INFO): Starting
2018-03-14T23:03:36.008Z,1521068616.008 [BPC1](INFO): Starting
2018-03-14T23:03:36.420Z,1521068616.420 [BPC1](INFO): Starting
2018-03-14T23:03:36.823Z,1521068616.823 [BPC1](INFO): Starting
2018-03-14T23:03:37.184Z,1521068617.184 [NAL9602](INFO): NAL9602 initialized
2018-03-14T23:03:37.224Z,1521068617.224 [BPC1](INFO): Starting
2018-03-14T23:03:37.879Z,1521068617.879 [BPC1](INFO): Starting
2018-03-14T23:03:38.271Z,1521068618.271 [BPC1](INFO): Starting
2018-03-14T23:03:38.681Z,1521068618.681 [BPC1](INFO): Starting
2018-03-14T23:03:39.071Z,1521068619.071 [BPC1](INFO): Starting
2018-03-14T23:03:39.449Z,1521068619.449 [BPC1](INFO): Starting
2018-03-14T23:03:39.850Z,1521068619.850 [BPC1](INFO): Starting
2018-03-14T23:03:40.269Z,1521068620.269 [BPC1](INFO): Starting
2018-03-14T23:03:40.676Z,1521068620.676 [BPC1](INFO): Starting
2018-03-14T23:03:41.074Z,1521068621.074 [BPC1](INFO): Starting
2018-03-14T23:03:41.441Z,1521068621.441 [BPC1](INFO): Starting
2018-03-14T23:03:41.852Z,1521068621.852 [BPC1](INFO): Starting
2018-03-14T23:03:42.245Z,1521068622.245 [BPC1](INFO): Starting
2018-03-14T23:03:42.638Z,1521068622.638 [BPC1](INFO): Starting
2018-03-14T23:03:43.040Z,1521068623.040 [BPC1](INFO): Starting
2018-03-14T23:03:43.451Z,1521068623.451 [BPC1](INFO): Starting
2018-03-14T23:03:43.832Z,1521068623.832 [BPC1](INFO): Starting
2018-03-14T23:03:44.232Z,1521068624.232 [BPC1](INFO): Starting
2018-03-14T23:03:44.659Z,1521068624.659 [BPC1](INFO): Starting
2018-03-14T23:03:45.059Z,1521068625.059 [BPC1](INFO): Starting
2018-03-14T23:03:45.455Z,1521068625.455 [BPC1](INFO): Starting
2018-03-14T23:03:45.859Z,1521068625.859 [BPC1](INFO): Starting
2018-03-14T23:03:46.293Z,1521068626.293 [BPC1](INFO): Starting
2018-03-14T23:03:46.651Z,1521068626.651 [BPC1](INFO): Starting
2018-03-14T23:03:47.042Z,1521068627.042 [BPC1](INFO): Starting
2018-03-14T23:03:47.443Z,1521068627.443 [BPC1](INFO): Starting
2018-03-14T23:03:47.848Z,1521068627.848 [BPC1](INFO): Starting
2018-03-14T23:03:48.248Z,1521068628.248 [BPC1](INFO): Starting
2018-03-14T23:03:48.645Z,1521068628.645 [BPC1](INFO): Starting
2018-03-14T23:03:49.029Z,1521068629.029 [BPC1](INFO): Starting
2018-03-14T23:03:49.433Z,1521068629.433 [BPC1](INFO): Starting
2018-03-14T23:03:49.854Z,1521068629.854 [BPC1](INFO): Starting
2018-03-14T23:03:50.251Z,1521068630.251 [BPC1](INFO): Starting
2018-03-14T23:03:50.638Z,1521068630.638 [BPC1](INFO): Starting
2018-03-14T23:03:51.048Z,1521068631.048 [BPC1](INFO): Starting
2018-03-14T23:03:51.429Z,1521068631.429 [BPC1](INFO): Starting
2018-03-14T23:03:51.845Z,1521068631.845 [BPC1](INFO): Starting
2018-03-14T23:03:52.233Z,1521068632.233 [BPC1](INFO): Starting
2018-03-14T23:03:52.636Z,1521068632.636 [BPC1](INFO): Starting
2018-03-14T23:03:53.043Z,1521068633.043 [BPC1](INFO): Starting
2018-03-14T23:03:53.437Z,1521068633.437 [BPC1](INFO): Starting
2018-03-14T23:03:53.837Z,1521068633.837 [BPC1](INFO): Starting
2018-03-14T23:03:54.245Z,1521068634.245 [BPC1](INFO): Starting
2018-03-14T23:03:54.629Z,1521068634.629 [BPC1](INFO): Starting
2018-03-14T23:03:55.029Z,1521068635.029 [BPC1](INFO): Starting
2018-03-14T23:03:55.438Z,1521068635.438 [BPC1](INFO): Starting
2018-03-14T23:03:55.832Z,1521068635.832 [BPC1](INFO): Starting
2018-03-14T23:03:56.235Z,1521068636.235 [BPC1](INFO): Starting
2018-03-14T23:03:56.636Z,1521068636.636 [BPC1](INFO): Starting
2018-03-14T23:03:57.037Z,1521068637.037 [BPC1](INFO): Starting
2018-03-14T23:03:57.436Z,1521068637.436 [BPC1](INFO): Starting
2018-03-14T23:03:57.828Z,1521068637.828 [BPC1](INFO): Starting
2018-03-14T23:03:58.228Z,1521068638.228 [BPC1](INFO): Starting
2018-03-14T23:03:58.651Z,1521068638.651 [BPC1](INFO): Starting
2018-03-14T23:03:59.055Z,1521068639.055 [BPC1](INFO): Starting
2018-03-14T23:03:59.429Z,1521068639.429 [BPC1](INFO): Starting
2018-03-14T23:03:59.429Z,1521068639.429 [BPC1](INFO): Initialized.
2018-03-14T23:03:59.842Z,1521068639.842 [BPC1](INFO): Bank B: initialized.
2018-03-14T23:04:07.562Z,1521068647.562 [BPC1](INFO): Bank B: sending IBPS break.
2018-03-14T23:04:11.548Z,1521068651.548 [BPC1](INFO): Bank B valid message: 1596 bytes.
2018-03-14T23:04:11.555Z,1521068651.555 [BPC1](INFO): Bank B: data parsed.
2018-03-14T23:04:11.555Z,1521068651.555 [BPC1](INFO): A OR B has been parsed ******
2018-03-14T23:04:11.958Z,1521068651.958 [BPC1](INFO): Bank B: initialized.
2018-03-14T23:04:13.563Z,1521068653.563 [BPC1](INFO): Bank B: sending IBPS break.
2018-03-14T23:04:15.991Z,1521068655.991 [SBIT](IMPORTANT): SBIT PASSED
2018-03-14T23:04:16.377Z,1521068656.377 [MissionManager](IMPORTANT): Started mission Startup
2018-03-14T23:04:16.377Z,1521068656.377 [Startup] Running Loop=1
2018-03-14T23:04:16.378Z,1521068656.378 [Startup](DEBUG): Aggregate::initialize Startup
2018-03-14T23:04:16.378Z,1521068656.378 [Startup:A.GoToSurface] Running Loop=1
2018-03-14T23:04:16.378Z,1521068656.378 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2018-03-14T23:04:16.379Z,1521068656.379 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2018-03-14T23:04:16.379Z,1521068656.379 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2018-03-14T23:04:16.379Z,1521068656.379 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2018-03-14T23:04:16.380Z,1521068656.380 [Startup:A.GoToSurface](DEBUG): No pitch timeout specified. Using default value of 30.000000 seconds.
2018-03-14T23:04:16.380Z,1521068656.380 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2018-03-14T23:04:16.385Z,1521068656.385 [Startup:StartupSatComms] Running Loop=1
2018-03-14T23:04:16.386Z,1521068656.386 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2018-03-14T23:04:16.386Z,1521068656.386 [Startup:StartupSatComms:A] Running Loop=1
2018-03-14T23:04:16.773Z,1521068656.773 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2018-03-14T23:04:17.149Z,1521068657.149 [BPC1](INFO): Bank B valid message: 1596 bytes.
2018-03-14T23:04:17.163Z,1521068657.163 [BPC1](INFO): Bank B: data parsed.
2018-03-14T23:04:17.163Z,1521068657.163 [BPC1](INFO): A OR B has been parsed ******
2018-03-14T23:04:17.578Z,1521068657.578 [BPC1](INFO): Bank B: initialized.
2018-03-14T23:04:24.743Z,1521068664.743 [BPC1](INFO): Bank B: sending IBPS break.
2018-03-14T23:04:28.755Z,1521068668.755 [BPC1](INFO): Bank B valid message: 1596 bytes.
2018-03-14T23:04:28.761Z,1521068668.761 [BPC1](INFO): Bank B: data parsed.
2018-03-14T23:04:28.761Z,1521068668.761 [BPC1](INFO): A OR B has been parsed ******
2018-03-14T23:04:29.179Z,1521068669.179 [BPC1](INFO): Bank B: initialized.
2018-03-14T23:04:31.151Z,1521068671.151 [BPC1](INFO): Bank B: sending IBPS break.
2018-03-14T23:04:35.141Z,1521068675.141 [BPC1](INFO): Bank B valid message: 1824 bytes.
2018-03-14T23:04:35.161Z,1521068675.161 [BPC1](INFO): Bank B: data parsed.
2018-03-14T23:04:35.161Z,1521068675.161 [BPC1](INFO): A OR B has been parsed ******
2018-03-14T23:04:35.555Z,1521068675.555 [BPC1](INFO): Bank B: initialized.
2018-03-14T23:04:42.754Z,1521068682.754 [BPC1](INFO): Bank B: sending IBPS break.
2018-03-14T23:04:47.549Z,1521068687.549 [BPC1](INFO): Bank B valid message: 1824 bytes.
2018-03-14T23:04:47.556Z,1521068687.556 [BPC1](INFO): Bank B: data parsed.
2018-03-14T23:04:47.556Z,1521068687.556 [BPC1](INFO): A OR B has been parsed ******
2018-03-14T23:04:47.958Z,1521068687.958 [BPC1](INFO): Bank B: initialized.
2018-03-14T23:04:55.540Z,1521068695.540 [BPC1](INFO): Bank B: sending IBPS break.
2018-03-14T23:05:00.358Z,1521068700.358 [BPC1](INFO): Bank B valid message: 1824 bytes.
2018-03-14T23:05:00.365Z,1521068700.365 [BPC1](INFO): Bank B: data parsed.
2018-03-14T23:05:00.365Z,1521068700.365 [BPC1](INFO): A OR B has been parsed ******
2018-03-14T23:05:00.775Z,1521068700.775 [BPC1](INFO): Bank B: initialized.
2018-03-14T23:05:08.367Z,1521068708.367 [BPC1](INFO): Bank B: sending IBPS break.
2018-03-14T23:05:12.755Z,1521068712.755 [BPC1](INFO): Bank B valid message: 1596 bytes.
2018-03-14T23:05:12.765Z,1521068712.765 [BPC1](INFO): Bank B: data parsed.
2018-03-14T23:05:12.765Z,1521068712.765 [BPC1](INFO): A OR B has been parsed ******
2018-03-14T23:05:13.162Z,1521068713.162 [BPC1](INFO): Bank B: initialized.
2018-03-14T23:05:14.741Z,1521068714.741 [BPC1](INFO): Bank B: sending IBPS break.
2018-03-14T23:05:16.787Z,1521068716.787 [Startup:StartupSatComms:A](INFO): Timed out from 2018-03-14T23:04:16.4Z
2018-03-14T23:05:16.787Z,1521068716.787 [Startup:StartupSatComms:A] Stopped
2018-03-14T23:05:16.787Z,1521068716.787 [Startup:StartupSatComms:B] Running Loop=1
2018-03-14T23:05:17.187Z,1521068717.187 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2018-03-14T23:05:18.348Z,1521068718.348 [BPC1](INFO): Bank B valid message: 1596 bytes.
2018-03-14T23:05:18.355Z,1521068718.355 [BPC1](INFO): Bank B: data parsed.
2018-03-14T23:05:18.355Z,1521068718.355 [BPC1](INFO): A OR B has been parsed ******
2018-03-14T23:05:18.767Z,1521068718.767 [BPC1](INFO): Bank B: initialized.
2018-03-14T23:05:25.561Z,1521068725.561 [BPC1](INFO): Bank B: sending IBPS break.
2018-03-14T23:05:29.949Z,1521068729.949 [BPC1](INFO): Bank B valid message: 1824 bytes.
2018-03-14T23:05:29.964Z,1521068729.964 [BPC1](INFO): Bank B: data parsed.
2018-03-14T23:05:29.964Z,1521068729.964 [BPC1](INFO): A OR B has been parsed ******
2018-03-14T23:05:30.379Z,1521068730.379 [BPC1](INFO): Bank B: initialized.
2018-03-14T23:05:37.949Z,1521068737.949 [BPC1](INFO): Bank B: sending IBPS break.
2018-03-14T23:05:42.348Z,1521068742.348 [BPC1](INFO): Bank B valid message: 1824 bytes.
2018-03-14T23:05:42.355Z,1521068742.355 [BPC1](INFO): Bank B: data parsed.
2018-03-14T23:05:42.355Z,1521068742.355 [BPC1](INFO): A OR B has been parsed ******
2018-03-14T23:05:42.766Z,1521068742.766 [BPC1](INFO): Bank B: initialized.
2018-03-14T23:05:49.672Z,1521068749.672 [CommandLine](IMPORTANT): got command report mod platform_battery_charge
2018-03-14T23:05:49.986Z,1521068749.986 [Reporter](INFO): platform_battery_charge no_value
2018-03-14T23:05:50.341Z,1521068750.341 [BPC1](INFO): Bank B: sending IBPS break.
2018-03-14T23:05:55.148Z,1521068755.148 [BPC1](INFO): Bank B valid message: 1824 bytes.
2018-03-14T23:05:55.160Z,1521068755.160 [BPC1](INFO): Bank B: data parsed.
2018-03-14T23:05:55.160Z,1521068755.160 [BPC1](INFO): A OR B has been parsed ******
2018-03-14T23:05:55.559Z,1521068755.559 [BPC1](INFO): Bank B: initialized.
2018-03-14T23:05:58.777Z,1521068758.777 [DeadReckonUsingSpeedCalculator](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2018-03-14T23:05:58.777Z,1521068758.777 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 1
2018-03-14T23:05:58.777Z,1521068758.777 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2018-03-14T23:05:58.783Z,1521068758.783 [DeadReckonWithRespectToSeafloor](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2018-03-14T23:05:58.783Z,1521068758.783 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1
2018-03-14T23:05:58.783Z,1521068758.783 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2018-03-14T23:05:58.816Z,1521068758.816 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2018-03-14T23:05:58.816Z,1521068758.816 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2018-03-14T23:05:59.192Z,1521068759.192 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2018-03-14T23:05:59.192Z,1521068759.192 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 1
2018-03-14T23:05:59.193Z,1521068759.193 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2018-03-14T23:05:59.193Z,1521068759.193 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1
2018-03-14T23:05:59.584Z,1521068759.584 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2018-03-14T23:05:59.584Z,1521068759.584 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2018-03-14T23:05:59.584Z,1521068759.584 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2018-03-14T23:05:59.585Z,1521068759.585 [DeadReckonWithRespectToSeafloor](DEBUG): Initializing DeadReckonWithRespectToSeafloor component.
2018-03-14T23:05:59.585Z,1521068759.585 [DeadReckonWithRespectToSeafloor](INFO): Will consider orientation measurement stale after 120s.
2018-03-14T23:05:59.585Z,1521068759.585 [DeadReckonWithRespectToSeafloor](INFO): Will consider velocity measurement stale after 20s.
2018-03-14T23:06:03.068Z,1521068763.068 [BPC1](INFO): Bank B: sending IBPS break.
2018-03-14T23:06:03.902Z,1521068763.902 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.003497
2018-03-14T23:06:07.841Z,1521068767.841 [BPC1](INFO): Bank B valid message: 1596 bytes.
2018-03-14T23:06:07.847Z,1521068767.847 [BPC1](INFO): Bank B: data parsed.
2018-03-14T23:06:07.847Z,1521068767.847 [BPC1](INFO): A OR B has been parsed ******
2018-03-14T23:06:07.877Z,1521068767.877 [DataOverHttps](INFO): Sending 25 bytes from file Logs/20180314T224635/Courier0008.lzma
2018-03-14T23:06:07.991Z,1521068767.991 [BPC1](INFO): Bank B: initialized.
2018-03-14T23:06:08.675Z,1521068768.675 [DataOverHttps](INFO): Moved sent file to Logs/20180314T224635/Courier0008.lzma.bak
2018-03-14T23:06:08.675Z,1521068768.675 [DataOverHttps](INFO): SBD MOMSN=8062064
2018-03-14T23:06:09.519Z,1521068769.519 [BPC1](INFO): Bank B: sending IBPS break.
2018-03-14T23:06:13.134Z,1521068773.134 [BPC1](INFO): Bank B valid message: 1596 bytes.
2018-03-14T23:06:13.140Z,1521068773.140 [BPC1](INFO): Bank B: data parsed.
2018-03-14T23:06:13.140Z,1521068773.140 [BPC1](INFO): A OR B has been parsed ******
2018-03-14T23:06:13.554Z,1521068773.554 [BPC1](INFO): Bank B: initialized.
2018-03-14T23:06:17.439Z,1521068777.439 [Startup:StartupSatComms:B](INFO): Timed out from 2018-03-14T23:05:16.8Z
2018-03-14T23:06:17.440Z,1521068777.440 [Startup:StartupSatComms:B] Stopped
2018-03-14T23:06:17.440Z,1521068777.440 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2018-03-14T23:06:17.440Z,1521068777.440 [Startup:StartupSatComms] Stopped
2018-03-14T23:06:17.440Z,1521068777.440 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2018-03-14T23:06:17.441Z,1521068777.441 [Startup](INFO): Completed Startup
2018-03-14T23:06:17.441Z,1521068777.441 [MissionManager](INFO): Startup is completed.
2018-03-14T23:06:17.441Z,1521068777.441 [MissionManager](INFO): Uninitializing Mission Startup
2018-03-14T23:06:17.441Z,1521068777.441 [Startup] Stopped
2018-03-14T23:06:17.441Z,1521068777.441 [Startup](DEBUG): Aggregate::uninitialize Startup
2018-03-14T23:06:17.441Z,1521068777.441 [Startup:A.GoToSurface] Stopped
2018-03-14T23:06:17.441Z,1521068777.441 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2018-03-14T23:06:17.479Z,1521068777.479 [DataOverHttps](INFO): Sending 251 bytes from file Logs/20180314T224635/Express0009.lzma
2018-03-14T23:06:17.590Z,1521068777.590 [MissionManager](IMPORTANT): Started mission Default
2018-03-14T23:06:17.590Z,1521068777.590 [Default] Running Loop=1
2018-03-14T23:06:17.590Z,1521068777.590 [Default](DEBUG): Aggregate::initialize Default
2018-03-14T23:06:17.590Z,1521068777.590 [Default:B.GoToSurface] Running Loop=1
2018-03-14T23:06:17.590Z,1521068777.590 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2018-03-14T23:06:17.595Z,1521068777.595 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2018-03-14T23:06:17.595Z,1521068777.595 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2018-03-14T23:06:17.595Z,1521068777.595 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2018-03-14T23:06:17.596Z,1521068777.596 [Default:B.GoToSurface](DEBUG): No pitch timeout specified. Using default value of 30.000000 seconds.
2018-03-14T23:06:17.596Z,1521068777.596 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2018-03-14T23:06:17.596Z,1521068777.596 [Default:A.Wait] Running Loop=1
2018-03-14T23:06:17.596Z,1521068777.596 [Default:A.Wait](DEBUG): Initialize Wait Component.
2018-03-14T23:06:18.260Z,1521068778.260 [DataOverHttps](INFO): Moved sent file to Logs/20180314T224635/Express0009.lzma.bak
2018-03-14T23:06:18.261Z,1521068778.261 [DataOverHttps](INFO): SBD MOMSN=8062066
2018-03-14T23:06:22.216Z,1521068782.216 [BPC1](INFO): Bank B: sending IBPS break.
2018-03-14T23:06:24.311Z,1521068784.311 [BPC1](INFO): Bank B valid message: 1596 bytes.
2018-03-14T23:06:24.321Z,1521068784.321 [BPC1](INFO): Bank B: data parsed.
2018-03-14T23:06:24.321Z,1521068784.321 [BPC1](INFO): A OR B has been parsed ******
2018-03-14T23:06:24.723Z,1521068784.723 [BPC1](INFO): Bank B: initialized.
2018-03-14T23:06:26.705Z,1521068786.705 [BPC1](INFO): Bank B: sending IBPS break.
2018-03-14T23:06:30.712Z,1521068790.712 [BPC1](INFO): Bank B valid message: 1824 bytes.
2018-03-14T23:06:30.730Z,1521068790.730 [BPC1](INFO): Bank B: data parsed.
2018-03-14T23:06:30.731Z,1521068790.731 [BPC1](INFO): A OR B has been parsed ******
2018-03-14T23:06:30.759Z,1521068790.759 [Default:A.Wait](INFO): Done Waiting.
2018-03-14T23:06:30.759Z,1521068790.759 [Default:A.Wait] Stopped
2018-03-14T23:06:30.759Z,1521068790.759 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2018-03-14T23:06:31.115Z,1521068791.115 [BPC1](INFO): Bank B: initialized.
2018-03-14T23:06:31.145Z,1521068791.145 [Default:CheckIn] Running Loop=1
2018-03-14T23:06:31.145Z,1521068791.145 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2018-03-14T23:06:31.146Z,1521068791.146 [Default:CheckIn:Read_GPS] Running Loop=1
2018-03-14T23:06:31.524Z,1521068791.524 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2018-03-14T23:06:38.330Z,1521068798.330 [BPC1](INFO): Bank B: sending IBPS break.
2018-03-14T23:06:43.131Z,1521068803.131 [BPC1](INFO): Bank B valid message: 1824 bytes.
2018-03-14T23:06:43.137Z,1521068803.137 [BPC1](INFO): Bank B: data parsed.
2018-03-14T23:06:43.138Z,1521068803.138 [BPC1](INFO): A OR B has been parsed ******
2018-03-14T23:06:43.538Z,1521068803.538 [BPC1](INFO): Bank B: initialized.
2018-03-14T23:06:51.113Z,1521068811.113 [BPC1](INFO): Bank B: sending IBPS break.
2018-03-14T23:06:55.500Z,1521068815.500 [BPC1](INFO): Bank B valid message: 1824 bytes.
2018-03-14T23:06:55.519Z,1521068815.519 [BPC1](INFO): Bank B: data parsed.
2018-03-14T23:06:55.519Z,1521068815.519 [BPC1](INFO): A OR B has been parsed ******
2018-03-14T23:06:55.934Z,1521068815.934 [BPC1](INFO): Bank B: initialized.
2018-03-14T23:06:58.424Z,1521068818.424 [CommandLine](IMPORTANT): got command failComponent
2018-03-14T23:06:58.425Z,1521068818.425 [CommandLine](IMPORTANT): Failed components:
2018-03-14T23:06:58.425Z,1521068818.425 [CommandLine](IMPORTANT): No failed Components.
2018-03-14T23:07:03.527Z,1521068823.527 [BPC1](INFO): Bank B: sending IBPS break.
2018-03-14T23:07:07.507Z,1521068827.507 [BPC1](INFO): Bank B valid message: 1596 bytes.
2018-03-14T23:07:07.513Z,1521068827.513 [BPC1](INFO): Bank B: data parsed.
2018-03-14T23:07:07.513Z,1521068827.513 [BPC1](INFO): A OR B has been parsed ******
2018-03-14T23:07:07.935Z,1521068827.935 [BPC1](INFO): Bank B: initialized.
2018-03-14T23:07:09.535Z,1521068829.535 [BPC1](INFO): Bank B: sending IBPS break.
2018-03-14T23:07:13.135Z,1521068833.135 [BPC1](INFO): Bank B valid message: 1596 bytes.
2018-03-14T23:07:13.145Z,1521068833.145 [BPC1](INFO): Bank B: data parsed.
2018-03-14T23:07:13.145Z,1521068833.145 [BPC1](INFO): A OR B has been parsed ******
2018-03-14T23:07:13.530Z,1521068833.530 [BPC1](INFO): Bank B: initialized.
2018-03-14T23:07:22.224Z,1521068842.224 [BPC1](INFO): Bank B: sending IBPS break.
2018-03-14T23:07:25.493Z,1521068845.493 [BPC1](INFO): Bank B valid message: 1824 bytes.
2018-03-14T23:07:25.500Z,1521068845.500 [BPC1](INFO): Bank B: data parsed.
2018-03-14T23:07:25.500Z,1521068845.500 [BPC1](INFO): A OR B has been parsed ******
2018-03-14T23:07:25.895Z,1521068845.895 [BPC1](INFO): Bank B: initialized.
2018-03-14T23:07:33.103Z,1521068853.103 [BPC1](INFO): Bank B: sending IBPS break.
2018-03-14T23:07:37.900Z,1521068857.900 [BPC1](INFO): Bank B valid message: 1824 bytes.
2018-03-14T23:07:37.916Z,1521068857.916 [BPC1](INFO): Bank B: data parsed.
2018-03-14T23:07:37.916Z,1521068857.916 [BPC1](INFO): A OR B has been parsed ******
2018-03-14T23:07:38.315Z,1521068858.315 [BPC1](INFO): Bank B: initialized.
2018-03-14T23:07:45.492Z,1521068865.492 [BPC1](INFO): Bank B: sending IBPS break.
2018-03-14T23:07:49.888Z,1521068869.888 [BPC1](INFO): Bank B valid message: 1824 bytes.
2018-03-14T23:07:49.903Z,1521068869.903 [BPC1](INFO): Bank B: data parsed.
2018-03-14T23:07:49.903Z,1521068869.903 [BPC1](INFO): A OR B has been parsed ******
2018-03-14T23:07:50.302Z,1521068870.302 [BPC1](INFO): Bank B: initialized.
2018-03-14T23:07:57.881Z,1521068877.881 [BPC1](INFO): Bank B: sending IBPS break.
2018-03-14T23:08:01.889Z,1521068881.889 [BPC1](INFO): Bank B valid message: 1596 bytes.
2018-03-14T23:08:01.903Z,1521068881.903 [BPC1](INFO): Bank B: data parsed.
2018-03-14T23:08:01.903Z,1521068881.903 [BPC1](INFO): A OR B has been parsed ******
2018-03-14T23:08:02.306Z,1521068882.306 [BPC1](INFO): Bank B: initialized.
2018-03-14T23:08:04.304Z,1521068884.304 [BPC1](INFO): Bank B: sending IBPS break.
2018-03-14T23:08:07.883Z,1521068887.883 [BPC1](INFO): Bank B valid message: 1596 bytes.
2018-03-14T23:08:07.889Z,1521068887.889 [BPC1](INFO): Bank B: data parsed.
2018-03-14T23:08:07.889Z,1521068887.889 [BPC1](INFO): A OR B has been parsed ******
2018-03-14T23:08:08.294Z,1521068888.294 [BPC1](INFO): Bank B: initialized.
2018-03-14T23:08:15.104Z,1521068895.104 [BPC1](INFO): Bank B: sending IBPS break.
2018-03-14T23:08:19.106Z,1521068899.106 [BPC1](INFO): Bank B valid message: 1596 bytes.
2018-03-14T23:08:19.144Z,1521068899.144 [BPC1](INFO): Bank B: data parsed.
2018-03-14T23:08:19.145Z,1521068899.145 [BPC1](INFO): A OR B has been parsed ******
2018-03-14T23:08:19.511Z,1521068899.511 [BPC1](INFO): Bank B: initialized.
2018-03-14T23:08:22.601Z,1521068902.601 [BPC1](INFO): Bank B: sending IBPS break.
2018-03-14T23:08:25.105Z,1521068905.105 [BPC1](INFO): Bank B valid message: 1824 bytes.
2018-03-14T23:08:25.112Z,1521068905.112 [BPC1](INFO): Bank B: data parsed.
2018-03-14T23:08:25.112Z,1521068905.112 [BPC1](INFO): A OR B has been parsed ******
2018-03-14T23:08:25.519Z,1521068905.519 [BPC1](INFO): Bank B: initialized.
2018-03-14T23:08:33.085Z,1521068913.085 [BPC1](INFO): Bank B: sending IBPS break.
2018-03-14T23:08:37.493Z,1521068917.493 [BPC1](INFO): Bank B valid message: 1824 bytes.
2018-03-14T23:08:37.500Z,1521068917.500 [BPC1](INFO): Bank B: data parsed.
2018-03-14T23:08:37.501Z,1521068917.501 [BPC1](INFO): A OR B has been parsed ******
2018-03-14T23:08:37.906Z,1521068917.906 [BPC1](INFO): Bank B: initialized.
2018-03-14T23:08:40.261Z,1521068920.261 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2018-03-14T23:08:45.492Z,1521068925.492 [BPC1](INFO): Bank B: sending IBPS break.
2018-03-14T23:08:50.303Z,1521068930.303 [BPC1](INFO): Bank B valid message: 1824 bytes.
2018-03-14T23:08:50.310Z,1521068930.310 [BPC1](INFO): Bank B: data parsed.
2018-03-14T23:08:50.310Z,1521068930.310 [BPC1](INFO): A OR B has been parsed ******
2018-03-14T23:08:50.710Z,1521068930.710 [BPC1](INFO): Bank B: initialized.
2018-03-14T23:08:58.691Z,1521068938.691 [BPC1](INFO): Bank B: sending IBPS break.
2018-03-14T23:08:59.892Z,1521068939.892 [DeadReckonUsingSpeedCalculator](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2018-03-14T23:08:59.892Z,1521068939.892 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 2
2018-03-14T23:08:59.892Z,1521068939.892 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2018-03-14T23:08:59.894Z,1521068939.894 [DeadReckonWithRespectToSeafloor](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2018-03-14T23:08:59.894Z,1521068939.894 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 2
2018-03-14T23:08:59.894Z,1521068939.894 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2018-03-14T23:08:59.922Z,1521068939.922 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2018-03-14T23:08:59.927Z,1521068939.927 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2018-03-14T23:09:00.343Z,1521068940.343 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2018-03-14T23:09:00.343Z,1521068940.343 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 2
2018-03-14T23:09:00.343Z,1521068940.343 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2018-03-14T23:09:00.343Z,1521068940.343 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 2
2018-03-14T23:09:00.712Z,1521068940.712 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2018-03-14T23:09:00.713Z,1521068940.713 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2018-03-14T23:09:00.713Z,1521068940.713 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2018-03-14T23:09:00.713Z,1521068940.713 [DeadReckonWithRespectToSeafloor](DEBUG): Initializing DeadReckonWithRespectToSeafloor component.
2018-03-14T23:09:00.714Z,1521068940.714 [DeadReckonWithRespectToSeafloor](INFO): Will consider orientation measurement stale after 120s.
2018-03-14T23:09:00.714Z,1521068940.714 [DeadReckonWithRespectToSeafloor](INFO): Will consider velocity measurement stale after 20s.
2018-03-14T23:09:02.305Z,1521068942.305 [BPC1](INFO): Bank B valid message: 1596 bytes.
2018-03-14T23:09:02.311Z,1521068942.311 [BPC1](INFO): Bank B: data parsed.
2018-03-14T23:09:02.311Z,1521068942.311 [BPC1](INFO): A OR B has been parsed ******
2018-03-14T23:09:02.714Z,1521068942.714 [BPC1](INFO): Bank B: initialized.
2018-03-14T23:09:04.699Z,1521068944.699 [BPC1](INFO): Bank B: sending IBPS break.
2018-03-14T23:09:07.896Z,1521068947.896 [BPC1](INFO): Bank B valid message: 1596 bytes.
2018-03-14T23:09:07.906Z,1521068947.906 [BPC1](INFO): Bank B: data parsed.
2018-03-14T23:09:07.906Z,1521068947.906 [BPC1](INFO): A OR B has been parsed ******
2018-03-14T23:09:08.318Z,1521068948.318 [BPC1](INFO): Bank B: initialized.
2018-03-14T23:09:15.489Z,1521068955.489 [BPC1](INFO): Bank B: sending IBPS break.
2018-03-14T23:09:22.588Z,1521068962.588 [BPC1](INFO): Bank B valid message: 1824 bytes.
2018-03-14T23:09:22.595Z,1521068962.595 [BPC1](INFO): Bank B: data parsed.
2018-03-14T23:09:22.595Z,1521068962.595 [BPC1](INFO): A OR B has been parsed ******
2018-03-14T23:09:22.743Z,1521068962.743 [BPC1](INFO): Bank B: initialized.
2018-03-14T23:09:29.907Z,1521068969.907 [BPC1](INFO): Bank B: sending IBPS break.
2018-03-14T23:09:34.707Z,1521068974.707 [BPC1](INFO): Bank B valid message: 1824 bytes.
2018-03-14T23:09:34.714Z,1521068974.714 [BPC1](INFO): Bank B: data parsed.
2018-03-14T23:09:34.714Z,1521068974.714 [BPC1](INFO): A OR B has been parsed ******
2018-03-14T23:09:35.110Z,1521068975.110 [BPC1](INFO): Bank B: initialized.
2018-03-14T23:09:42.720Z,1521068982.720 [BPC1](INFO): Bank B: sending IBPS break.
2018-03-14T23:09:47.507Z,1521068987.507 [BPC1](INFO): Bank B valid message: 1824 bytes.
2018-03-14T23:09:47.518Z,1521068987.518 [BPC1](INFO): Bank B: data parsed.
2018-03-14T23:09:47.518Z,1521068987.518 [BPC1](INFO): A OR B has been parsed ******
2018-03-14T23:09:47.918Z,1521068987.918 [BPC1](INFO): Bank B: initialized.
2018-03-14T23:09:55.511Z,1521068995.511 [BPC1](INFO): Bank B: sending IBPS break.
2018-03-14T23:09:59.895Z,1521068999.895 [BPC1](INFO): Bank B valid message: 1596 bytes.
2018-03-14T23:09:59.909Z,1521068999.909 [BPC1](INFO): Bank B: data parsed.
2018-03-14T23:09:59.909Z,1521068999.909 [BPC1](INFO): A OR B has been parsed ******
2018-03-14T23:10:00.326Z,1521069000.326 [BPC1](INFO): Bank B: initialized.
2018-03-14T23:10:02.297Z,1521069002.297 [BPC1](INFO): Bank B: sending IBPS break.
2018-03-14T23:10:05.901Z,1521069005.901 [BPC1](INFO): Bank B valid message: 1596 bytes.
2018-03-14T23:10:05.907Z,1521069005.907 [BPC1](INFO): Bank B: data parsed.
2018-03-14T23:10:05.907Z,1521069005.907 [BPC1](INFO): A OR B has been parsed ******
2018-03-14T23:10:06.319Z,1521069006.319 [BPC1](INFO): Bank B: initialized.
2018-03-14T23:10:13.111Z,1521069013.111 [BPC1](INFO): Bank B: sending IBPS break.
2018-03-14T23:10:17.897Z,1521069017.897 [BPC1](INFO): Bank B valid message: 1824 bytes.
2018-03-14T23:10:17.904Z,1521069017.904 [BPC1](INFO): Bank B: data parsed.
2018-03-14T23:10:17.904Z,1521069017.904 [BPC1](INFO): A OR B has been parsed ******
2018-03-14T23:10:18.330Z,1521069018.330 [BPC1](INFO): Bank B: initialized.
2018-03-14T23:10:25.463Z,1521069025.463 [BPC1](INFO): Bank B: sending IBPS break.
2018-03-14T23:10:29.852Z,1521069029.852 [BPC1](INFO): Bank B valid message: 1824 bytes.
2018-03-14T23:10:29.871Z,1521069029.871 [BPC1](INFO): Bank B: data parsed.
2018-03-14T23:10:29.871Z,1521069029.871 [BPC1](INFO): A OR B has been parsed ******
2018-03-14T23:10:30.286Z,1521069030.286 [BPC1](INFO): Bank B: initialized.
2018-03-14T23:10:37.468Z,1521069037.468 [BPC1](INFO): Bank B: sending IBPS break.
2018-03-14T23:10:42.249Z,1521069042.249 [BPC1](INFO): Bank B valid message: 1824 bytes.
2018-03-14T23:10:42.264Z,1521069042.264 [BPC1](INFO): Bank B: data parsed.
2018-03-14T23:10:42.264Z,1521069042.264 [BPC1](INFO): A OR B has been parsed ******
2018-03-14T23:10:42.687Z,1521069042.687 [BPC1](INFO): Bank B: initialized.
2018-03-14T23:10:50.668Z,1521069050.668 [BPC1](INFO): Bank B: sending IBPS break.
2018-03-14T23:10:54.677Z,1521069054.677 [BPC1](INFO): Bank B valid message: 1596 bytes.
2018-03-14T23:10:54.684Z,1521069054.684 [BPC1](INFO): Bank B: data parsed.
2018-03-14T23:10:54.684Z,1521069054.684 [BPC1](INFO): A OR B has been parsed ******
2018-03-14T23:10:55.087Z,1521069055.087 [BPC1](INFO): Bank B: initialized.
2018-03-14T23:10:56.669Z,1521069056.669 [BPC1](INFO): Bank B: sending IBPS break.
2018-03-14T23:11:00.263Z,1521069060.263 [BPC1](INFO): Bank B valid message: 1596 bytes.
2018-03-14T23:11:00.269Z,1521069060.269 [BPC1](INFO): Bank B: data parsed.
2018-03-14T23:11:00.269Z,1521069060.269 [BPC1](INFO): A OR B has been parsed ******
2018-03-14T23:11:00.695Z,1521069060.695 [BPC1](INFO): Bank B: initialized.
2018-03-14T23:11:07.460Z,1521069067.460 [BPC1](INFO): Bank B: sending IBPS break.
2018-03-14T23:11:11.464Z,1521069071.464 [BPC1](INFO): Bank B valid message: 1596 bytes.
2018-03-14T23:11:11.470Z,1521069071.470 [BPC1](INFO): Bank B: data parsed.
2018-03-14T23:11:11.470Z,1521069071.470 [BPC1](INFO): A OR B has been parsed ******
2018-03-14T23:11:11.879Z,1521069071.879 [BPC1](INFO): Bank B: initialized.
2018-03-14T23:11:13.859Z,1521069073.859 [BPC1](INFO): Bank B: sending IBPS break.
2018-03-14T23:11:17.474Z,1521069077.474 [BPC1](INFO): Bank B valid message: 1824 bytes.
2018-03-14T23:11:17.480Z,1521069077.480 [BPC1](INFO): Bank B: data parsed.
2018-03-14T23:11:17.480Z,1521069077.480 [BPC1](INFO): A OR B has been parsed ******
2018-03-14T23:11:17.867Z,1521069077.867 [BPC1](INFO): Bank B: initialized.
2018-03-14T23:11:25.123Z,1521069085.123 [BPC1](INFO): Bank B: sending IBPS break.
2018-03-14T23:11:29.923Z,1521069089.923 [BPC1](INFO): Bank B valid message: 1824 bytes.
2018-03-14T23:11:29.934Z,1521069089.934 [BPC1](INFO): Bank B: data parsed.
2018-03-14T23:11:29.934Z,1521069089.934 [BPC1](INFO): A OR B has been parsed ******
2018-03-14T23:11:30.323Z,1521069090.323 [BPC1](INFO): Bank B: initialized.
2018-03-14T23:11:31.525Z,1521069091.525 [Default:CheckIn:Read_GPS](INFO): Timed out from 2018-03-14T23:06:31.1Z
2018-03-14T23:11:31.526Z,1521069091.526 [Default:CheckIn:Read_GPS] Stopped
2018-03-14T23:11:31.526Z,1521069091.526 [Default:CheckIn:Read_Iridium] Running Loop=1
2018-03-14T23:11:31.951Z,1521069091.951 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications
2018-03-14T23:11:36.021Z,1521069096.021 [DataOverHttps](INFO): Sending 25 bytes from file Logs/20180314T230249/Courier0004.lzma
2018-03-14T23:11:36.803Z,1521069096.803 [DataOverHttps](INFO): Moved sent file to Logs/20180314T230249/Courier0004.lzma.bak
2018-03-14T23:11:36.803Z,1521069096.803 [DataOverHttps](INFO): SBD MOMSN=8062122
2018-03-14T23:11:37.538Z,1521069097.538 [BPC1](INFO): Bank B: sending IBPS break.
2018-03-14T23:11:42.012Z,1521069102.012 [BPC1](INFO): Bank B valid message: 1824 bytes.
2018-03-14T23:11:42.019Z,1521069102.019 [BPC1](INFO): Bank B: data parsed.
2018-03-14T23:11:42.020Z,1521069102.020 [BPC1](INFO): A OR B has been parsed ******
2018-03-14T23:11:42.419Z,1521069102.419 [BPC1](INFO): Bank B: initialized.
2018-03-14T23:11:45.532Z,1521069105.532 [DataOverHttps](INFO): Sending 527 bytes from file Logs/20180314T230249/Express0001.lzma
2018-03-14T23:11:46.331Z,1521069106.331 [DataOverHttps](INFO): Moved sent file to Logs/20180314T230249/Express0001.lzma.bak
2018-03-14T23:11:46.331Z,1521069106.331 [DataOverHttps](INFO): SBD MOMSN=8062125
2018-03-14T23:11:50.253Z,1521069110.253 [BPC1](INFO): Bank B: sending IBPS break.
2018-03-14T23:11:55.053Z,1521069115.053 [BPC1](INFO): Bank B valid message: 1596 bytes.
2018-03-14T23:11:55.059Z,1521069115.059 [BPC1](INFO): Bank B: data parsed.
2018-03-14T23:11:55.059Z,1521069115.059 [BPC1](INFO): A OR B has been parsed ******
2018-03-14T23:11:55.143Z,1521069115.143 [DataOverHttps](INFO): Sending 275 bytes from file Logs/20180314T230249/Express0005.lzma
2018-03-14T23:11:55.218Z,1521069115.218 [BPC1](INFO): Bank B: initialized.
2018-03-14T23:11:55.935Z,1521069115.935 [DataOverHttps](INFO): Moved sent file to Logs/20180314T230249/Express0005.lzma.bak
2018-03-14T23:11:55.935Z,1521069115.935 [DataOverHttps](INFO): SBD MOMSN=8062135
2018-03-14T23:11:56.689Z,1521069116.689 [Default:CheckIn:Read_Iridium] Stopped
2018-03-14T23:11:56.689Z,1521069116.689 [Default:CheckIn:C.Wait] Running Loop=1
2018-03-14T23:11:56.689Z,1521069116.689 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2018-03-14T23:11:59.868Z,1521069119.868 [BPC1](INFO): Bank B: sending IBPS break.
2018-03-14T23:11:59.869Z,1521069119.869 [BPC1](FAULT): Failed to receive data from all sticks prior to timeout. Missing data from 1F sticks.
2018-03-14T23:11:59.869Z,1521069119.869 [BPC1] Data Fault, FailCount= 1
2018-03-14T23:11:59.869Z,1521069119.869 [BPC1](ERROR): Data Fault
2018-03-14T23:11:59.963Z,1521069119.963 [CBIT](ERROR): Data Fault in component: BPC1
2018-03-14T23:12:00.020Z,1521069120.020 [BPC1](INFO): Stop
2018-03-14T23:12:00.021Z,1521069120.021 [BPC1](INFO): uninitialize
2018-03-14T23:12:00.420Z,1521069120.420 [BPC1](INFO): Stopping
2018-03-14T23:12:00.818Z,1521069120.818 [BPC1](INFO): Stopped
2018-03-14T23:12:00.819Z,1521069120.819 [BPC1](INFO): Data requested. Hibernation time: 431531.840000 hours.
2018-03-14T23:12:00.829Z,1521069120.829 [DeadReckonUsingSpeedCalculator](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2018-03-14T23:12:00.829Z,1521069120.829 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 3
2018-03-14T23:12:00.829Z,1521069120.829 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2018-03-14T23:12:00.831Z,1521069120.831 [DeadReckonWithRespectToSeafloor](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2018-03-14T23:12:00.831Z,1521069120.831 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 3
2018-03-14T23:12:00.831Z,1521069120.831 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2018-03-14T23:12:00.871Z,1521069120.871 [CBIT](INFO): Clearing failed state for component BPC1
2018-03-14T23:12:00.871Z,1521069120.871 [BPC1] No Fault, FailCount= 1
2018-03-14T23:12:00.872Z,1521069120.872 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2018-03-14T23:12:00.872Z,1521069120.872 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2018-03-14T23:12:01.219Z,1521069121.219 [BPC1](INFO): Start
2018-03-14T23:12:01.295Z,1521069121.295 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2018-03-14T23:12:01.295Z,1521069121.295 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 3
2018-03-14T23:12:01.295Z,1521069121.295 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2018-03-14T23:12:01.295Z,1521069121.295 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 3
2018-03-14T23:12:01.596Z,1521069121.596 [BPC1](INFO): Starting
2018-03-14T23:12:01.624Z,1521069121.624 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2018-03-14T23:12:01.625Z,1521069121.625 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2018-03-14T23:12:01.625Z,1521069121.625 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2018-03-14T23:12:01.625Z,1521069121.625 [DeadReckonWithRespectToSeafloor](DEBUG): Initializing DeadReckonWithRespectToSeafloor component.
2018-03-14T23:12:01.626Z,1521069121.626 [DeadReckonWithRespectToSeafloor](INFO): Will consider orientation measurement stale after 120s.
2018-03-14T23:12:01.626Z,1521069121.626 [DeadReckonWithRespectToSeafloor](INFO): Will consider velocity measurement stale after 20s.
2018-03-14T23:12:01.997Z,1521069121.997 [BPC1](INFO): Starting
2018-03-14T23:12:02.400Z,1521069122.400 [BPC1](INFO): Starting
2018-03-14T23:12:02.819Z,1521069122.819 [BPC1](INFO): Starting
2018-03-14T23:12:03.210Z,1521069123.210 [BPC1](INFO): Starting
2018-03-14T23:12:03.607Z,1521069123.607 [BPC1](INFO): Starting
2018-03-14T23:12:04.003Z,1521069124.003 [BPC1](INFO): Starting
2018-03-14T23:12:04.405Z,1521069124.405 [BPC1](INFO): Starting
2018-03-14T23:12:04.803Z,1521069124.803 [BPC1](INFO): Starting
2018-03-14T23:12:05.206Z,1521069125.206 [BPC1](INFO): Starting
2018-03-14T23:12:05.596Z,1521069125.596 [BPC1](INFO): Starting
2018-03-14T23:12:06.021Z,1521069126.021 [BPC1](INFO): Starting
2018-03-14T23:12:06.420Z,1521069126.420 [BPC1](INFO): Starting
2018-03-14T23:12:06.816Z,1521069126.816 [BPC1](INFO): Starting
2018-03-14T23:12:07.196Z,1521069127.196 [BPC1](INFO): Starting
2018-03-14T23:12:07.600Z,1521069127.600 [BPC1](INFO): Starting
2018-03-14T23:12:07.999Z,1521069127.999 [BPC1](INFO): Starting
2018-03-14T23:12:08.401Z,1521069128.401 [BPC1](INFO): Starting
2018-03-14T23:12:08.805Z,1521069128.805 [BPC1](INFO): Starting
2018-03-14T23:12:09.232Z,1521069129.232 [BPC1](INFO): Starting
2018-03-14T23:12:09.611Z,1521069129.611 [BPC1](INFO): Starting
2018-03-14T23:12:10.005Z,1521069130.005 [BPC1](INFO): Starting
2018-03-14T23:12:10.404Z,1521069130.404 [BPC1](INFO): Starting
2018-03-14T23:12:10.805Z,1521069130.805 [BPC1](INFO): Starting
2018-03-14T23:12:11.199Z,1521069131.199 [BPC1](INFO): Starting
2018-03-14T23:12:11.605Z,1521069131.605 [BPC1](INFO): Starting
2018-03-14T23:12:12.010Z,1521069132.010 [BPC1](INFO): Starting
2018-03-14T23:12:12.419Z,1521069132.419 [BPC1](INFO): Starting
2018-03-14T23:12:12.826Z,1521069132.826 [BPC1](INFO): Starting
2018-03-14T23:12:13.196Z,1521069133.196 [BPC1](INFO): Starting
2018-03-14T23:12:13.596Z,1521069133.596 [BPC1](INFO): Starting
2018-03-14T23:12:14.001Z,1521069134.001 [BPC1](INFO): Starting
2018-03-14T23:12:14.400Z,1521069134.400 [BPC1](INFO): Starting
2018-03-14T23:12:14.807Z,1521069134.807 [BPC1](INFO): Starting
2018-03-14T23:12:15.209Z,1521069135.209 [BPC1](INFO): Starting
2018-03-14T23:12:15.613Z,1521069135.613 [BPC1](INFO): Starting
2018-03-14T23:12:16.003Z,1521069136.003 [BPC1](INFO): Starting
2018-03-14T23:12:16.405Z,1521069136.405 [BPC1](INFO): Starting
2018-03-14T23:12:16.807Z,1521069136.807 [BPC1](INFO): Starting
2018-03-14T23:12:17.208Z,1521069137.208 [BPC1](INFO): Starting
2018-03-14T23:12:17.609Z,1521069137.609 [BPC1](INFO): Starting
2018-03-14T23:12:18.014Z,1521069138.014 [BPC1](INFO): Starting
2018-03-14T23:12:18.421Z,1521069138.421 [BPC1](INFO): Starting
2018-03-14T23:12:18.820Z,1521069138.820 [BPC1](INFO): Starting
2018-03-14T23:12:19.203Z,1521069139.203 [BPC1](INFO): Starting
2018-03-14T23:12:19.604Z,1521069139.604 [BPC1](INFO): Starting
2018-03-14T23:12:19.997Z,1521069139.997 [BPC1](INFO): Starting
2018-03-14T23:12:20.395Z,1521069140.395 [BPC1](INFO): Starting
2018-03-14T23:12:20.815Z,1521069140.815 [BPC1](INFO): Starting
2018-03-14T23:12:21.223Z,1521069141.223 [BPC1](INFO): Starting
2018-03-14T23:12:21.611Z,1521069141.611 [BPC1](INFO): Starting
2018-03-14T23:12:22.004Z,1521069142.004 [BPC1](INFO): Starting
2018-03-14T23:12:22.405Z,1521069142.405 [BPC1](INFO): Starting
2018-03-14T23:12:22.804Z,1521069142.804 [BPC1](INFO): Starting
2018-03-14T23:12:23.199Z,1521069143.199 [BPC1](INFO): Starting
2018-03-14T23:12:23.605Z,1521069143.605 [BPC1](INFO): Starting
2018-03-14T23:12:24.014Z,1521069144.014 [BPC1](INFO): Starting
2018-03-14T23:12:24.421Z,1521069144.421 [BPC1](INFO): Starting
2018-03-14T23:12:24.819Z,1521069144.819 [BPC1](INFO): Starting
2018-03-14T23:12:25.203Z,1521069145.203 [BPC1](INFO): Starting
2018-03-14T23:12:25.609Z,1521069145.609 [BPC1](INFO): Starting
2018-03-14T23:12:26.001Z,1521069146.001 [BPC1](INFO): Starting
2018-03-14T23:12:26.396Z,1521069146.396 [BPC1](INFO): Starting
2018-03-14T23:12:26.819Z,1521069146.819 [BPC1](INFO): Starting
2018-03-14T23:12:27.223Z,1521069147.223 [BPC1](INFO): Starting
2018-03-14T23:12:27.623Z,1521069147.623 [BPC1](INFO): Starting
2018-03-14T23:12:28.000Z,1521069148.000 [BPC1](INFO): Starting
2018-03-14T23:12:28.405Z,1521069148.405 [BPC1](INFO): Starting
2018-03-14T23:12:28.801Z,1521069148.801 [BPC1](INFO): Starting
2018-03-14T23:12:29.211Z,1521069149.211 [BPC1](INFO): Starting
2018-03-14T23:12:29.604Z,1521069149.604 [BPC1](INFO): Starting
2018-03-14T23:12:30.010Z,1521069150.010 [BPC1](INFO): Starting
2018-03-14T23:12:30.412Z,1521069150.412 [BPC1](INFO): Starting
2018-03-14T23:12:30.819Z,1521069150.819 [BPC1](INFO): Starting
2018-03-14T23:12:31.205Z,1521069151.205 [BPC1](INFO): Starting
2018-03-14T23:12:31.608Z,1521069151.608 [BPC1](INFO): Starting
2018-03-14T23:12:32.009Z,1521069152.009 [BPC1](INFO): Starting
2018-03-14T23:12:32.405Z,1521069152.405 [BPC1](INFO): Starting
2018-03-14T23:12:32.813Z,1521069152.813 [BPC1](INFO): Starting
2018-03-14T23:12:33.224Z,1521069153.224 [BPC1](INFO): Starting
2018-03-14T23:12:33.619Z,1521069153.619 [BPC1](INFO): Starting
2018-03-14T23:12:34.010Z,1521069154.010 [BPC1](INFO): Starting
2018-03-14T23:12:34.412Z,1521069154.412 [BPC1](INFO): Starting
2018-03-14T23:12:34.796Z,1521069154.796 [BPC1](INFO): Starting
2018-03-14T23:12:35.197Z,1521069155.197 [BPC1](INFO): Starting
2018-03-14T23:12:35.596Z,1521069155.596 [BPC1](INFO): Starting
2018-03-14T23:12:36.019Z,1521069156.019 [BPC1](INFO): Starting
2018-03-14T23:12:36.419Z,1521069156.419 [BPC1](INFO): Starting
2018-03-14T23:12:36.823Z,1521069156.823 [BPC1](INFO): Starting
2018-03-14T23:12:37.196Z,1521069157.196 [BPC1](INFO): Starting
2018-03-14T23:12:37.596Z,1521069157.596 [BPC1](INFO): Starting
2018-03-14T23:12:37.997Z,1521069157.997 [BPC1](INFO): Starting
2018-03-14T23:12:38.396Z,1521069158.396 [BPC1](INFO): Starting
2018-03-14T23:12:38.810Z,1521069158.810 [BPC1](INFO): Starting
2018-03-14T23:12:39.214Z,1521069159.214 [BPC1](INFO): Starting
2018-03-14T23:12:39.611Z,1521069159.611 [BPC1](INFO): Starting
2018-03-14T23:12:40.004Z,1521069160.004 [BPC1](INFO): Starting
2018-03-14T23:12:40.404Z,1521069160.404 [BPC1](INFO): Starting
2018-03-14T23:12:40.805Z,1521069160.805 [BPC1](INFO): Starting
2018-03-14T23:12:41.208Z,1521069161.208 [BPC1](INFO): Starting
2018-03-14T23:12:41.605Z,1521069161.605 [BPC1](INFO): Starting
2018-03-14T23:12:42.014Z,1521069162.014 [BPC1](INFO): Starting
2018-03-14T23:12:42.417Z,1521069162.417 [BPC1](INFO): Starting
2018-03-14T23:12:42.820Z,1521069162.820 [BPC1](INFO): Starting
2018-03-14T23:12:43.204Z,1521069163.204 [BPC1](INFO): Starting
2018-03-14T23:12:43.611Z,1521069163.611 [BPC1](INFO): Starting
2018-03-14T23:12:43.997Z,1521069163.997 [BPC1](INFO): Starting
2018-03-14T23:12:44.396Z,1521069164.396 [BPC1](INFO): Starting
2018-03-14T23:12:44.806Z,1521069164.806 [BPC1](INFO): Starting
2018-03-14T23:12:45.210Z,1521069165.210 [BPC1](INFO): Starting
2018-03-14T23:12:45.607Z,1521069165.607 [BPC1](INFO): Starting
2018-03-14T23:12:45.000Z,1521069166.000 [BPC1](INFO): Starting
2018-03-14T23:12:46.409Z,1521069166.409 [BPC1](INFO): Starting
2018-03-14T23:12:46.804Z,1521069166.804 [BPC1](INFO): Starting
2018-03-14T23:12:47.204Z,1521069167.204 [BPC1](INFO): Starting
2018-03-14T23:12:47.608Z,1521069167.608 [BPC1](INFO): Starting
2018-03-14T23:12:48.009Z,1521069168.009 [BPC1](INFO): Starting
2018-03-14T23:12:48.412Z,1521069168.412 [BPC1](INFO): Starting
2018-03-14T23:12:48.823Z,1521069168.823 [BPC1](INFO): Starting
2018-03-14T23:12:49.196Z,1521069169.196 [BPC1](INFO): Starting
2018-03-14T23:12:49.596Z,1521069169.596 [BPC1](INFO): Starting
2018-03-14T23:12:50.005Z,1521069170.005 [BPC1](INFO): Starting
2018-03-14T23:12:50.401Z,1521069170.401 [BPC1](INFO): Starting
2018-03-14T23:12:50.807Z,1521069170.807 [BPC1](INFO): Starting
2018-03-14T23:12:51.210Z,1521069171.210 [BPC1](INFO): Starting
2018-03-14T23:12:51.609Z,1521069171.609 [BPC1](INFO): Starting
2018-03-14T23:12:51.996Z,1521069171.996 [BPC1](INFO): Starting
2018-03-14T23:12:52.397Z,1521069172.397 [BPC1](INFO): Starting
2018-03-14T23:12:52.798Z,1521069172.798 [BPC1](INFO): Starting
2018-03-14T23:12:53.196Z,1521069173.196 [BPC1](INFO): Starting
2018-03-14T23:12:53.601Z,1521069173.601 [BPC1](INFO): Starting
2018-03-14T23:12:54.007Z,1521069174.007 [BPC1](INFO): Starting
2018-03-14T23:12:54.415Z,1521069174.415 [BPC1](INFO): Starting
2018-03-14T23:12:54.815Z,1521069174.815 [BPC1](INFO): Starting
2018-03-14T23:12:55.205Z,1521069175.205 [BPC1](INFO): Starting
2018-03-14T23:12:55.599Z,1521069175.599 [BPC1](INFO): Starting
2018-03-14T23:12:56.005Z,1521069176.005 [BPC1](INFO): Starting
2018-03-14T23:12:56.403Z,1521069176.403 [BPC1](INFO): Starting
2018-03-14T23:12:56.818Z,1521069176.818 [BPC1](INFO): Starting
2018-03-14T23:12:57.228Z,1521069177.228 [BPC1](INFO): Starting
2018-03-14T23:13:00.320Z,1521069180.320 [BPC1](INFO): Starting
2018-03-14T23:13:00.345Z,1521069180.345 [CBIT](DEBUG): EFC running - data check-sum false
2018-03-14T23:13:00.461Z,1521069180.461 [BPC1](INFO): Starting
2018-03-14T23:13:00.792Z,1521069180.792 [BPC1](INFO): Starting
2018-03-14T23:13:01.189Z,1521069181.189 [BPC1](INFO): Starting
2018-03-14T23:13:01.588Z,1521069181.588 [BPC1](INFO): Starting
2018-03-14T23:13:01.588Z,1521069181.588 [BPC1](INFO): Initialized.
2018-03-14T23:13:02.003Z,1521069182.003 [BPC1](INFO): Bank B: initialized.
2018-03-14T23:13:09.593Z,1521069189.593 [BPC1](INFO): Bank B: sending IBPS break.
2018-03-14T23:13:13.000Z,1521069194.000 [BPC1](INFO): Bank B valid message: 1824 bytes.
2018-03-14T23:13:14.006Z,1521069194.006 [BPC1](INFO): Bank B: data parsed.
2018-03-14T23:13:14.006Z,1521069194.006 [BPC1](INFO): A OR B has been parsed ******
2018-03-14T23:13:14.414Z,1521069194.414 [BPC1](INFO): Bank B: initialized.
2018-03-14T23:13:21.989Z,1521069201.989 [BPC1](INFO): Bank B: sending IBPS break.
2018-03-14T23:13:26.403Z,1521069206.403 [BPC1](INFO): Bank B valid message: 1824 bytes.
2018-03-14T23:13:26.410Z,1521069206.410 [BPC1](INFO): Bank B: data parsed.
2018-03-14T23:13:26.410Z,1521069206.410 [BPC1](INFO): A OR B has been parsed ******
2018-03-14T23:13:26.802Z,1521069206.802 [BPC1](INFO): Bank B: initialized.
2018-03-14T23:13:34.391Z,1521069214.391 [BPC1](INFO): Bank B: sending IBPS break.
2018-03-14T23:13:38.361Z,1521069218.361 [NAL9602](FAULT): GPS failed to acquire within timeout.
2018-03-14T23:13:38.361Z,1521069218.361 [NAL9602] Data Fault, FailCount= 1
2018-03-14T23:13:38.361Z,1521069218.361 [NAL9602](ERROR): Data Fault
2018-03-14T23:13:38.433Z,1521069218.433 [CBIT](ERROR): Data Fault in component: NAL9602
2018-03-14T23:13:38.767Z,1521069218.767 [NAL9602](INFO): Powering down
2018-03-14T23:13:38.793Z,1521069218.793 [BPC1](INFO): Bank B valid message: 1824 bytes.
2018-03-14T23:13:38.799Z,1521069218.799 [BPC1](INFO): Bank B: data parsed.
2018-03-14T23:13:38.800Z,1521069218.800 [BPC1](INFO): A OR B has been parsed ******
2018-03-14T23:13:39.202Z,1521069219.202 [BPC1](INFO): Bank B: initialized.
2018-03-14T23:13:39.626Z,1521069219.626 [CBIT](INFO): Clearing failed state for component NAL9602
2018-03-14T23:13:39.626Z,1521069219.626 [NAL9602] No Fault, FailCount= 1
2018-03-14T23:13:46.788Z,1521069226.788 [BPC1](INFO): Bank B: sending IBPS break.
2018-03-14T23:13:50.788Z,1521069230.788 [BPC1](INFO): Bank B valid message: 1596 bytes.
2018-03-14T23:13:50.795Z,1521069230.795 [BPC1](INFO): Bank B: data parsed.
2018-03-14T23:13:50.795Z,1521069230.795 [BPC1](INFO): A OR B has been parsed ******
2018-03-14T23:13:51.202Z,1521069231.202 [BPC1](INFO): Bank B: initialized.
2018-03-14T23:13:53.180Z,1521069233.180 [BPC1](INFO): Bank B: sending IBPS break.
2018-03-14T23:13:56.380Z,1521069236.380 [BPC1](INFO): Bank B valid message: 1596 bytes.
2018-03-14T23:13:56.386Z,1521069236.386 [BPC1](INFO): Bank B: data parsed.
2018-03-14T23:13:56.386Z,1521069236.386 [BPC1](INFO): A OR B has been parsed ******
2018-03-14T23:13:56.802Z,1521069236.802 [BPC1](INFO): Bank B: initialized.
2018-03-14T23:14:03.939Z,1521069243.939 [BPC1](INFO): Bank B: sending IBPS break.
2018-03-14T23:14:08.345Z,1521069248.345 [BPC1](INFO): Bank B valid message: 1824 bytes.
2018-03-14T23:14:08.352Z,1521069248.352 [BPC1](INFO): Bank B: data parsed.
2018-03-14T23:14:08.352Z,1521069248.352 [BPC1](INFO): A OR B has been parsed ******
2018-03-14T23:14:08.762Z,1521069248.762 [BPC1](INFO): Bank B: initialized.
2018-03-14T23:14:09.112Z,1521069249.112 [NAL9602](INFO): Powering up NAL9602
2018-03-14T23:14:16.344Z,1521069256.344 [BPC1](INFO): Bank B: sending IBPS break.
2018-03-14T23:14:20.312Z,1521069260.312 [NAL9602](INFO): NAL9602 initialized
2018-03-14T23:14:20.737Z,1521069260.737 [BPC1](INFO): Bank B valid message: 1824 bytes.
2018-03-14T23:14:20.749Z,1521069260.749 [BPC1](ERROR): Bank B: No match for stick 3 serial number:1717 in the onboard configuration file.
2018-03-14T23:14:20.749Z,1521069260.749 [BPC1](ERROR): Failed to parse Bank B battery data
2018-03-14T23:14:21.178Z,1521069261.178 [BPC1](INFO): Bank B: initialized.
2018-03-14T23:14:28.743Z,1521069268.743 [BPC1](INFO): Bank B: sending IBPS break.
2018-03-14T23:14:33.145Z,1521069273.145 [BPC1](INFO): Bank B valid message: 1824 bytes.
2018-03-14T23:14:33.160Z,1521069273.160 [BPC1](INFO): Bank B: data parsed.
2018-03-14T23:14:33.160Z,1521069273.160 [BPC1](INFO): A OR B has been parsed ******
2018-03-14T23:14:33.550Z,1521069273.550 [BPC1](INFO): Bank B: initialized.
2018-03-14T23:14:41.151Z,1521069281.151 [BPC1](INFO): Bank B: sending IBPS break.
2018-03-14T23:14:45.145Z,1521069285.145 [BPC1](INFO): Bank B valid message: 1596 bytes.
2018-03-14T23:14:45.159Z,1521069285.159 [BPC1](INFO): Bank B: data parsed.
2018-03-14T23:14:45.160Z,1521069285.160 [BPC1](INFO): A OR B has been parsed ******
2018-03-14T23:14:45.554Z,1521069285.554 [BPC1](INFO): Bank B: initialized.
2018-03-14T23:14:47.151Z,1521069287.151 [BPC1](INFO): Bank B: sending IBPS break.
2018-03-14T23:14:50.758Z,1521069290.758 [BPC1](INFO): Bank B valid message: 1596 bytes.
2018-03-14T23:14:50.764Z,1521069290.764 [BPC1](INFO): Bank B: data parsed.
2018-03-14T23:14:50.764Z,1521069290.764 [BPC1](INFO): A OR B has been parsed ******
2018-03-14T23:14:51.151Z,1521069291.151 [BPC1](INFO): Bank B: initialized.
2018-03-14T23:14:57.956Z,1521069297.956 [BPC1](INFO): Bank B: sending IBPS break.
2018-03-14T23:15:01.960Z,1521069301.960 [DeadReckonUsingSpeedCalculator](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2018-03-14T23:15:01.960Z,1521069301.960 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 4
2018-03-14T23:15:01.960Z,1521069301.960 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2018-03-14T23:15:01.961Z,1521069301.961 [DeadReckonWithRespectToSeafloor](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2018-03-14T23:15:01.962Z,1521069301.962 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 4
2018-03-14T23:15:01.962Z,1521069301.962 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2018-03-14T23:15:01.982Z,1521069301.982 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2018-03-14T23:15:01.982Z,1521069301.982 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2018-03-14T23:15:02.315Z,1521069302.315 [BPC1](INFO): Bank B valid message: 1596 bytes.
2018-03-14T23:15:02.321Z,1521069302.321 [BPC1](INFO): Bank B: data parsed.
2018-03-14T23:15:02.321Z,1521069302.321 [BPC1](INFO): A OR B has been parsed ******
2018-03-14T23:15:02.368Z,1521069302.368 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2018-03-14T23:15:02.368Z,1521069302.368 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 4
2018-03-14T23:15:02.368Z,1521069302.368 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2018-03-14T23:15:02.368Z,1521069302.368 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 4
2018-03-14T23:15:02.730Z,1521069302.730 [BPC1](INFO): Bank B: initialized.
2018-03-14T23:15:02.737Z,1521069302.737 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2018-03-14T23:15:02.738Z,1521069302.738 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2018-03-14T23:15:02.738Z,1521069302.738 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2018-03-14T23:15:02.739Z,1521069302.739 [DeadReckonWithRespectToSeafloor](DEBUG): Initializing DeadReckonWithRespectToSeafloor component.
2018-03-14T23:15:02.739Z,1521069302.739 [DeadReckonWithRespectToSeafloor](INFO): Will consider orientation measurement stale after 120s.
2018-03-14T23:15:02.739Z,1521069302.739 [DeadReckonWithRespectToSeafloor](INFO): Will consider velocity measurement stale after 20s.
2018-03-14T23:15:04.331Z,1521069304.331 [BPC1](INFO): Bank B: sending IBPS break.
2018-03-14T23:15:08.309Z,1521069308.309 [BPC1](INFO): Bank B valid message: 1824 bytes.
2018-03-14T23:15:08.324Z,1521069308.324 [BPC1](INFO): Bank B: data parsed.
2018-03-14T23:15:08.324Z,1521069308.324 [BPC1](INFO): A OR B has been parsed ******
2018-03-14T23:15:08.733Z,1521069308.733 [BPC1](INFO): Bank B: initialized.
2018-03-14T23:15:15.926Z,1521069315.926 [BPC1](INFO): Bank B: sending IBPS break.
2018-03-14T23:15:20.708Z,1521069320.708 [BPC1](INFO): Bank B valid message: 1824 bytes.
2018-03-14T23:15:20.727Z,1521069320.727 [BPC1](INFO): Bank B: data parsed.
2018-03-14T23:15:20.727Z,1521069320.727 [BPC1](INFO): A OR B has been parsed ******
2018-03-14T23:15:21.130Z,1521069321.130 [BPC1](INFO): Bank B: initialized.
2018-03-14T23:15:28.731Z,1521069328.731 [BPC1](INFO): Bank B: sending IBPS break.
2018-03-14T23:15:33.118Z,1521069333.118 [BPC1](INFO): Bank B valid message: 1824 bytes.
2018-03-14T23:15:33.124Z,1521069333.124 [BPC1](INFO): Bank B: data parsed.
2018-03-14T23:15:33.124Z,1521069333.124 [BPC1](INFO): A OR B has been parsed ******
2018-03-14T23:15:33.531Z,1521069333.531 [BPC1](INFO): Bank B: initialized.
2018-03-14T23:15:41.119Z,1521069341.119 [BPC1](INFO): Bank B: sending IBPS break.
2018-03-14T23:15:45.122Z,1521069345.122 [BPC1](INFO): Bank B valid message: 1596 bytes.
2018-03-14T23:15:45.128Z,1521069345.128 [BPC1](INFO): Bank B: data parsed.
2018-03-14T23:15:45.128Z,1521069345.128 [BPC1](INFO): A OR B has been parsed ******
2018-03-14T23:15:45.523Z,1521069345.523 [BPC1](INFO): Bank B: initialized.
2018-03-14T23:15:47.516Z,1521069347.516 [BPC1](INFO): Bank B: sending IBPS break.
2018-03-14T23:15:50.716Z,1521069350.716 [BPC1](INFO): Bank B valid message: 1596 bytes.
2018-03-14T23:15:50.731Z,1521069350.731 [BPC1](INFO): Bank B: data parsed.
2018-03-14T23:15:50.731Z,1521069350.731 [BPC1](INFO): A OR B has been parsed ******
2018-03-14T23:15:51.126Z,1521069351.126 [BPC1](INFO): Bank B: initialized.
2018-03-14T23:15:57.931Z,1521069357.931 [BPC1](INFO): Bank B: sending IBPS break.
2018-03-14T23:16:02.339Z,1521069362.339 [BPC1](INFO): Bank B valid message: 1824 bytes.
2018-03-14T23:16:02.349Z,1521069362.349 [BPC1](INFO): Bank B: data parsed.
2018-03-14T23:16:02.350Z,1521069362.350 [BPC1](INFO): A OR B has been parsed ******
2018-03-14T23:16:02.739Z,1521069362.739 [BPC1](INFO): Bank B: initialized.
2018-03-14T23:16:10.329Z,1521069370.329 [BPC1](INFO): Bank B: sending IBPS break.
2018-03-14T23:16:15.148Z,1521069375.148 [BPC1](INFO): Bank B valid message: 1824 bytes.
2018-03-14T23:16:15.155Z,1521069375.155 [BPC1](INFO): Bank B: data parsed.
2018-03-14T23:16:15.155Z,1521069375.155 [BPC1](INFO): A OR B has been parsed ******
2018-03-14T23:16:15.554Z,1521069375.555 [BPC1](INFO): Bank B: initialized.
2018-03-14T23:16:23.129Z,1521069383.129 [BPC1](INFO): Bank B: sending IBPS break.
2018-03-14T23:16:27.939Z,1521069387.939 [BPC1](INFO): Bank B valid message: 1824 bytes.
2018-03-14T23:16:27.946Z,1521069387.946 [BPC1](INFO): Bank B: data parsed.
2018-03-14T23:16:27.946Z,1521069387.946 [BPC1](INFO): A OR B has been parsed ******
2018-03-14T23:16:28.338Z,1521069388.338 [BPC1](INFO): Bank B: initialized.
2018-03-14T23:16:35.940Z,1521069395.940 [BPC1](INFO): Bank B: sending IBPS break.
2018-03-14T23:16:39.935Z,1521069399.935 [BPC1](INFO): Bank B valid message: 1596 bytes.
2018-03-14T23:16:39.945Z,1521069399.945 [BPC1](INFO): Bank B: data parsed.
2018-03-14T23:16:39.946Z,1521069399.946 [BPC1](INFO): A OR B has been parsed ******
2018-03-14T23:16:40.342Z,1521069400.342 [BPC1](INFO): Bank B: initialized.
2018-03-14T23:16:42.343Z,1521069402.343 [BPC1](INFO): Bank B: sending IBPS break.
2018-03-14T23:16:45.936Z,1521069405.936 [BPC1](INFO): Bank B valid message: 1596 bytes.
2018-03-14T23:16:45.946Z,1521069405.946 [BPC1](INFO): Bank B: data parsed.
2018-03-14T23:16:45.946Z,1521069405.946 [BPC1](INFO): A OR B has been parsed ******
2018-03-14T23:16:46.346Z,1521069406.346 [BPC1](INFO): Bank B: initialized.
2018-03-14T23:16:53.132Z,1521069413.132 [BPC1](INFO): Bank B: sending IBPS break.
2018-03-14T23:16:57.151Z,1521069417.151 [BPC1](INFO): Bank B valid message: 1596 bytes.
2018-03-14T23:16:57.161Z,1521069417.161 [BPC1](INFO): Bank B: data parsed.
2018-03-14T23:16:57.161Z,1521069417.161 [BPC1](INFO): A OR B has been parsed ******
2018-03-14T23:16:57.179Z,1521069417.179 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2018-03-14T23:16:57.180Z,1521069417.180 [Default:CheckIn:C.Wait] Stopped
2018-03-14T23:16:57.180Z,1521069417.180 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2018-03-14T23:16:57.180Z,1521069417.180 [Default:CheckIn:D] Running Loop=1
2018-03-14T23:16:57.551Z,1521069417.551 [BPC1](INFO): Bank B: initialized.
2018-03-14T23:16:57.565Z,1521069417.565 [Default:CheckIn:D] Stopped
2018-03-14T23:16:57.565Z,1521069417.565 [Default:CheckIn:E] Running Loop=1
2018-03-14T23:16:57.971Z,1521069417.971 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 10.666218 min
2018-03-14T23:16:57.973Z,1521069417.973 [Default:CheckIn:E] Stopped
2018-03-14T23:16:57.973Z,1521069417.973 [Default:CheckIn](INFO): Completed Default:CheckIn
2018-03-14T23:16:57.973Z,1521069417.973 [Default:CheckIn] Stopped
2018-03-14T23:16:57.973Z,1521069417.973 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2018-03-14T23:16:57.973Z,1521069417.973 [Default:CheckIn](INFO): Running loop #2
2018-03-14T23:16:57.973Z,1521069417.973 [Default:CheckIn] Running Loop=2
2018-03-14T23:16:57.973Z,1521069417.973 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2018-03-14T23:16:57.974Z,1521069417.974 [Default:CheckIn:Read_GPS] Running Loop=1
2018-03-14T23:17:01.441Z,1521069421.441 [BPC1](INFO): Bank B: sending IBPS break.
2018-03-14T23:17:03.540Z,1521069423.540 [BPC1](INFO): Bank B valid message: 1824 bytes.
2018-03-14T23:17:03.555Z,1521069423.555 [BPC1](INFO): Bank B: data parsed.
2018-03-14T23:17:03.555Z,1521069423.555 [BPC1](INFO): A OR B has been parsed ******
2018-03-14T23:17:03.954Z,1521069423.954 [BPC1](INFO): Bank B: initialized.
2018-03-14T23:17:11.147Z,1521069431.147 [BPC1](INFO): Bank B: sending IBPS break.
2018-03-14T23:17:15.936Z,1521069435.936 [BPC1](INFO): Bank B valid message: 1824 bytes.
2018-03-14T23:17:15.951Z,1521069435.951 [BPC1](INFO): Bank B: data parsed.
2018-03-14T23:17:15.951Z,1521069435.951 [BPC1](INFO): A OR B has been parsed ******
2018-03-14T23:17:16.358Z,1521069436.358 [BPC1](INFO): Bank B: initialized.
2018-03-14T23:17:23.556Z,1521069443.556 [BPC1](INFO): Bank B: sending IBPS break.
2018-03-14T23:17:28.346Z,1521069448.346 [BPC1](INFO): Bank B valid message: 1824 bytes.
2018-03-14T23:17:28.353Z,1521069448.353 [BPC1](INFO): Bank B: data parsed.
2018-03-14T23:17:28.353Z,1521069448.353 [BPC1](INFO): A OR B has been parsed ******
2018-03-14T23:17:28.755Z,1521069448.755 [BPC1](INFO): Bank B: initialized.
2018-03-14T23:17:35.951Z,1521069455.951 [BPC1](INFO): Bank B: sending IBPS break.
2018-03-14T23:17:39.941Z,1521069459.941 [BPC1](INFO): Bank B valid message: 1596 bytes.
2018-03-14T23:17:39.948Z,1521069459.948 [BPC1](INFO): Bank B: data parsed.
2018-03-14T23:17:39.948Z,1521069459.948 [BPC1](INFO): A OR B has been parsed ******
2018-03-14T23:17:40.358Z,1521069460.358 [BPC1](INFO): Bank B: initialized.
2018-03-14T23:17:41.952Z,1521069461.952 [BPC1](INFO): Bank B: sending IBPS break.
2018-03-14T23:17:45.540Z,1521069465.540 [BPC1](INFO): Bank B valid message: 1596 bytes.
2018-03-14T23:17:45.550Z,1521069465.550 [BPC1](INFO): Bank B: data parsed.
2018-03-14T23:17:45.550Z,1521069465.550 [BPC1](INFO): A OR B has been parsed ******
2018-03-14T23:17:45.954Z,1521069465.954 [BPC1](INFO): Bank B: initialized.
2018-03-14T23:17:53.151Z,1521069473.151 [BPC1](INFO): Bank B: sending IBPS break.
2018-03-14T23:17:57.541Z,1521069477.541 [BPC1](INFO): Bank B valid message: 1824 bytes.
2018-03-14T23:17:57.556Z,1521069477.556 [BPC1](INFO): Bank B: data parsed.
2018-03-14T23:17:57.556Z,1521069477.556 [BPC1](INFO): A OR B has been parsed ******
2018-03-14T23:17:57.958Z,1521069477.958 [BPC1](INFO): Bank B: initialized.
2018-03-14T23:18:03.127Z,1521069483.127 [DeadReckonUsingSpeedCalculator](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2018-03-14T23:18:03.127Z,1521069483.127 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 5
2018-03-14T23:18:03.127Z,1521069483.127 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2018-03-14T23:18:03.129Z,1521069483.129 [DeadReckonWithRespectToSeafloor](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2018-03-14T23:18:03.129Z,1521069483.129 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 5
2018-03-14T23:18:03.129Z,1521069483.129 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2018-03-14T23:18:03.185Z,1521069483.185 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2018-03-14T23:18:03.185Z,1521069483.185 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2018-03-14T23:18:03.539Z,1521069483.539 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2018-03-14T23:18:03.539Z,1521069483.539 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 5
2018-03-14T23:18:03.540Z,1521069483.540 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2018-03-14T23:18:03.540Z,1521069483.540 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 5
2018-03-14T23:18:03.937Z,1521069483.937 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2018-03-14T23:18:03.937Z,1521069483.937 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2018-03-14T23:18:03.938Z,1521069483.938 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2018-03-14T23:18:03.938Z,1521069483.938 [DeadReckonWithRespectToSeafloor](DEBUG): Initializing DeadReckonWithRespectToSeafloor component.
2018-03-14T23:18:03.939Z,1521069483.939 [DeadReckonWithRespectToSeafloor](INFO): Will consider orientation measurement stale after 120s.
2018-03-14T23:18:03.939Z,1521069483.939 [DeadReckonWithRespectToSeafloor](INFO): Will consider velocity measurement stale after 20s.
2018-03-14T23:18:05.504Z,1521069485.504 [BPC1](INFO): Bank B: sending IBPS break.
2018-03-14T23:18:10.319Z,1521069490.319 [BPC1](INFO): Bank B valid message: 1824 bytes.
2018-03-14T23:18:10.326Z,1521069490.326 [BPC1](INFO): Bank B: data parsed.
2018-03-14T23:18:10.334Z,1521069490.334 [BPC1](INFO): A OR B has been parsed ******
2018-03-14T23:18:10.742Z,1521069490.742 [BPC1](INFO): Bank B: initialized.
2018-03-14T23:18:18.314Z,1521069498.314 [BPC1](INFO): Bank B: sending IBPS break.
2018-03-14T23:18:22.735Z,1521069502.735 [BPC1](INFO): Bank B valid message: 1824 bytes.
2018-03-14T23:18:22.742Z,1521069502.742 [BPC1](INFO): Bank B: data parsed.
2018-03-14T23:18:22.742Z,1521069502.742 [BPC1](INFO): A OR B has been parsed ******
2018-03-14T23:18:23.138Z,1521069503.138 [BPC1](INFO): Bank B: initialized.
2018-03-14T23:18:30.315Z,1521069510.315 [BPC1](INFO): Bank B: sending IBPS break.
2018-03-14T23:18:34.325Z,1521069514.325 [BPC1](INFO): Bank B valid message: 1596 bytes.
2018-03-14T23:18:34.332Z,1521069514.332 [BPC1](INFO): Bank B: data parsed.
2018-03-14T23:18:34.332Z,1521069514.332 [BPC1](INFO): A OR B has been parsed ******
2018-03-14T23:18:34.750Z,1521069514.750 [BPC1](INFO): Bank B: initialized.
2018-03-14T23:18:36.713Z,1521069516.713 [BPC1](INFO): Bank B: sending IBPS break.
2018-03-14T23:18:39.922Z,1521069519.922 [BPC1](INFO): Bank B valid message: 1596 bytes.
2018-03-14T23:18:39.928Z,1521069519.928 [BPC1](INFO): Bank B: data parsed.
2018-03-14T23:18:39.929Z,1521069519.929 [BPC1](INFO): A OR B has been parsed ******
2018-03-14T23:18:40.338Z,1521069520.338 [BPC1](INFO): Bank B: initialized.
2018-03-14T23:18:47.508Z,1521069527.508 [BPC1](INFO): Bank B: sending IBPS break.
2018-03-14T23:18:51.513Z,1521069531.513 [BPC1](INFO): Bank B valid message: 1596 bytes.
2018-03-14T23:18:51.519Z,1521069531.519 [BPC1](INFO): Bank B: data parsed.
2018-03-14T23:18:51.520Z,1521069531.520 [BPC1](INFO): A OR B has been parsed ******
2018-03-14T23:18:51.938Z,1521069531.938 [BPC1](INFO): Bank B: initialized.
2018-03-14T23:18:53.920Z,1521069533.920 [BPC1](INFO): Bank B: sending IBPS break.
2018-03-14T23:18:57.508Z,1521069537.508 [BPC1](INFO): Bank B valid message: 1824 bytes.
2018-03-14T23:18:57.515Z,1521069537.515 [BPC1](INFO): Bank B: data parsed.
2018-03-14T23:18:57.515Z,1521069537.515 [BPC1](INFO): A OR B has been parsed ******
2018-03-14T23:18:57.938Z,1521069537.938 [BPC1](INFO): Bank B: initialized.
2018-03-14T23:19:05.495Z,1521069545.495 [BPC1](INFO): Bank B: sending IBPS break.
2018-03-14T23:19:10.283Z,1521069550.283 [BPC1](INFO): Bank B valid message: 1824 bytes.
2018-03-14T23:19:10.293Z,1521069550.293 [BPC1](INFO): Bank B: data parsed.
2018-03-14T23:19:10.293Z,1521069550.293 [BPC1](INFO): A OR B has been parsed ******
2018-03-14T23:19:10.698Z,1521069550.698 [BPC1](INFO): Bank B: initialized.
2018-03-14T23:19:18.681Z,1521069558.681 [BPC1](INFO): Bank B: sending IBPS break.
2018-03-14T23:19:23.091Z,1521069563.091 [BPC1](INFO): Bank B valid message: 1824 bytes.
2018-03-14T23:19:23.098Z,1521069563.098 [BPC1](INFO): Bank B: data parsed.
2018-03-14T23:19:23.098Z,1521069563.098 [BPC1](INFO): A OR B has been parsed ******
2018-03-14T23:19:23.498Z,1521069563.498 [BPC1](INFO): Bank B: initialized.
2018-03-14T23:19:31.076Z,1521069571.076 [BPC1](INFO): Bank B: sending IBPS break.
2018-03-14T23:19:35.091Z,1521069575.091 [BPC1](INFO): Bank B valid message: 1596 bytes.
2018-03-14T23:19:35.098Z,1521069575.098 [BPC1](INFO): Bank B: data parsed.
2018-03-14T23:19:35.098Z,1521069575.098 [BPC1](INFO): A OR B has been parsed ******
2018-03-14T23:19:35.506Z,1521069575.506 [BPC1](INFO): Bank B: initialized.
2018-03-14T23:19:37.487Z,1521069577.487 [BPC1](INFO): Bank B: sending IBPS break.
2018-03-14T23:19:41.086Z,1521069581.086 [BPC1](INFO): Bank B valid message: 1596 bytes.
2018-03-14T23:19:41.125Z,1521069581.125 [BPC1](INFO): Bank B: data parsed.
2018-03-14T23:19:41.125Z,1521069581.125 [BPC1](INFO): A OR B has been parsed ******
2018-03-14T23:19:41.518Z,1521069581.518 [BPC1](INFO): Bank B: initialized.
2018-03-14T23:19:49.074Z,1521069589.074 [BPC1](INFO): Bank B: sending IBPS break.
2018-03-14T23:19:53.492Z,1521069593.492 [BPC1](INFO): Bank B valid message: 1824 bytes.
2018-03-14T23:19:53.499Z,1521069593.499 [BPC1](INFO): Bank B: data parsed.
2018-03-14T23:19:53.499Z,1521069593.499 [BPC1](INFO): A OR B has been parsed ******
2018-03-14T23:19:53.910Z,1521069593.910 [BPC1](INFO): Bank B: initialized.
2018-03-14T23:20:02.190Z,1521069602.190 [BPC1](INFO): Bank B: sending IBPS break.
2018-03-14T23:20:05.872Z,1521069605.872 [BPC1](INFO): Bank B valid message: 1824 bytes.
2018-03-14T23:20:05.880Z,1521069605.880 [BPC1](INFO): Bank B: data parsed.
2018-03-14T23:20:05.880Z,1521069605.880 [BPC1](INFO): A OR B has been parsed ******
2018-03-14T23:20:06.299Z,1521069606.299 [BPC1](INFO): Bank B: initialized.
2018-03-14T23:20:14.283Z,1521069614.283 [BPC1](INFO): Bank B: sending IBPS break.
2018-03-14T23:20:18.681Z,1521069618.681 [BPC1](INFO): Bank B valid message: 1824 bytes.
2018-03-14T23:20:18.696Z,1521069618.696 [BPC1](INFO): Bank B: data parsed.
2018-03-14T23:20:18.696Z,1521069618.696 [BPC1](INFO): A OR B has been parsed ******
2018-03-14T23:20:19.103Z,1521069619.103 [BPC1](INFO): Bank B: initialized.
2018-03-14T23:20:27.083Z,1521069627.083 [BPC1](INFO): Bank B: sending IBPS break.
2018-03-14T23:20:31.093Z,1521069631.093 [BPC1](INFO): Bank B valid message: 1596 bytes.
2018-03-14T23:20:31.100Z,1521069631.100 [BPC1](INFO): Bank B: data parsed.
2018-03-14T23:20:31.100Z,1521069631.100 [BPC1](INFO): A OR B has been parsed ******
2018-03-14T23:20:31.506Z,1521069631.506 [BPC1](INFO): Bank B: initialized.
2018-03-14T23:20:33.483Z,1521069633.483 [BPC1](INFO): Bank B: sending IBPS break.
2018-03-14T23:20:36.686Z,1521069636.686 [BPC1](INFO): Bank B valid message: 1596 bytes.
2018-03-14T23:20:36.692Z,1521069636.692 [BPC1](INFO): Bank B: data parsed.
2018-03-14T23:20:36.692Z,1521069636.692 [BPC1](INFO): A OR B has been parsed ******
2018-03-14T23:20:37.107Z,1521069637.107 [BPC1](INFO): Bank B: initialized.
2018-03-14T23:20:44.280Z,1521069644.280 [BPC1](INFO): Bank B: sending IBPS break.
2018-03-14T23:20:48.674Z,1521069648.674 [BPC1](INFO): Bank B valid message: 1824 bytes.
2018-03-14T23:20:48.697Z,1521069648.697 [BPC1](INFO): Bank B: data parsed.
2018-03-14T23:20:48.697Z,1521069648.697 [BPC1](INFO): A OR B has been parsed ******
2018-03-14T23:20:49.107Z,1521069649.107 [BPC1](INFO): Bank B: initialized.
2018-03-14T23:20:57.074Z,1521069657.074 [BPC1](INFO): Bank B: sending IBPS break.
2018-03-14T23:21:02.579Z,1521069662.579 [BPC1](INFO): Bank B valid message: 1824 bytes.
2018-03-14T23:21:02.602Z,1521069662.602 [BPC1](INFO): Bank B: data parsed.
2018-03-14T23:21:02.602Z,1521069662.602 [BPC1](INFO): A OR B has been parsed ******
2018-03-14T23:21:02.602Z,1521069662.602 [BPC1](FAULT): Failed to receive data from all sticks prior to timeout. Missing data from 1F sticks.
2018-03-14T23:21:02.602Z,1521069662.602 [BPC1] Data Fault, FailCount= 2
2018-03-14T23:21:02.602Z,1521069662.602 [BPC1](ERROR): Data Fault
2018-03-14T23:21:02.648Z,1521069662.648 [CBIT](ERROR): Data Fault in component: BPC1
2018-03-14T23:21:02.738Z,1521069662.738 [BPC1](INFO): Stop
2018-03-14T23:21:02.738Z,1521069662.738 [BPC1](INFO): uninitialize
2018-03-14T23:21:03.095Z,1521069663.095 [BPC1](INFO): Stopping
2018-03-14T23:21:03.515Z,1521069663.515 [BPC1](INFO): Stopped
2018-03-14T23:21:03.515Z,1521069663.515 [BPC1](INFO): Data requested. Hibernation time: 431532.017778 hours.
2018-03-14T23:21:03.567Z,1521069663.567 [CBIT](INFO): Clearing failed state for component BPC1
2018-03-14T23:21:03.567Z,1521069663.567 [BPC1] No Fault, FailCount= 2
2018-03-14T23:21:03.892Z,1521069663.892 [BPC1](INFO): Start
2018-03-14T23:21:03.968Z,1521069663.968 [DeadReckonUsingSpeedCalculator](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2018-03-14T23:21:03.968Z,1521069663.968 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 6
2018-03-14T23:21:03.968Z,1521069663.968 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2018-03-14T23:21:03.970Z,1521069663.970 [DeadReckonWithRespectToSeafloor](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2018-03-14T23:21:03.970Z,1521069663.970 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 6
2018-03-14T23:21:03.970Z,1521069663.970 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2018-03-14T23:21:03.983Z,1521069663.983 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2018-03-14T23:21:03.983Z,1521069663.983 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2018-03-14T23:21:04.294Z,1521069664.294 [BPC1](INFO): Starting
2018-03-14T23:21:04.336Z,1521069664.336 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2018-03-14T23:21:04.336Z,1521069664.336 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 6
2018-03-14T23:21:04.337Z,1521069664.337 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2018-03-14T23:21:04.337Z,1521069664.337 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 6
2018-03-14T23:21:04.689Z,1521069664.689 [BPC1](INFO): Starting
2018-03-14T23:21:04.696Z,1521069664.696 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2018-03-14T23:21:04.696Z,1521069664.696 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2018-03-14T23:21:04.697Z,1521069664.697 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2018-03-14T23:21:04.697Z,1521069664.697 [DeadReckonWithRespectToSeafloor](DEBUG): Initializing DeadReckonWithRespectToSeafloor component.
2018-03-14T23:21:04.698Z,1521069664.698 [DeadReckonWithRespectToSeafloor](INFO): Will consider orientation measurement stale after 120s.
2018-03-14T23:21:04.698Z,1521069664.698 [DeadReckonWithRespectToSeafloor](INFO): Will consider velocity measurement stale after 20s.
2018-03-14T23:21:05.095Z,1521069665.095 [BPC1](INFO): Starting
2018-03-14T23:21:05.491Z,1521069665.491 [BPC1](INFO): Starting
2018-03-14T23:21:05.909Z,1521069665.909 [BPC1](INFO): Starting
2018-03-14T23:21:06.307Z,1521069666.307 [BPC1](INFO): Starting
2018-03-14T23:21:06.711Z,1521069666.711 [BPC1](INFO): Starting
2018-03-14T23:21:07.090Z,1521069667.090 [BPC1](INFO): Starting
2018-03-14T23:21:07.489Z,1521069667.489 [BPC1](INFO): Starting
2018-03-14T23:21:07.888Z,1521069667.888 [BPC1](INFO): Starting
2018-03-14T23:21:08.289Z,1521069668.289 [BPC1](INFO): Starting
2018-03-14T23:21:08.699Z,1521069668.699 [BPC1](INFO): Starting
2018-03-14T23:21:09.106Z,1521069669.106 [BPC1](INFO): Starting
2018-03-14T23:21:09.505Z,1521069669.505 [BPC1](INFO): Starting
2018-03-14T23:21:09.899Z,1521069669.899 [BPC1](INFO): Starting
2018-03-14T23:21:10.282Z,1521069670.282 [BPC1](INFO): Starting
2018-03-14T23:21:10.685Z,1521069670.685 [BPC1](INFO): Starting
2018-03-14T23:21:11.081Z,1521069671.081 [BPC1](INFO): Starting
2018-03-14T23:21:11.480Z,1521069671.480 [BPC1](INFO): Starting
2018-03-14T23:21:11.895Z,1521069671.895 [BPC1](INFO): Starting
2018-03-14T23:21:12.307Z,1521069672.307 [BPC1](INFO): Starting
2018-03-14T23:21:12.691Z,1521069672.691 [BPC1](INFO): Starting
2018-03-14T23:21:13.088Z,1521069673.088 [BPC1](INFO): Starting
2018-03-14T23:21:13.489Z,1521069673.489 [BPC1](INFO): Starting
2018-03-14T23:21:13.891Z,1521069673.891 [BPC1](INFO): Starting
2018-03-14T23:21:14.287Z,1521069674.287 [BPC1](INFO): Starting
2018-03-14T23:21:14.691Z,1521069674.691 [BPC1](INFO): Starting
2018-03-14T23:21:15.099Z,1521069675.099 [BPC1](INFO): Starting
2018-03-14T23:21:15.507Z,1521069675.507 [BPC1](INFO): Starting
2018-03-14T23:21:15.898Z,1521069675.898 [BPC1](INFO): Starting
2018-03-14T23:21:16.299Z,1521069676.299 [BPC1](INFO): Starting
2018-03-14T23:21:16.695Z,1521069676.695 [BPC1](INFO): Starting
2018-03-14T23:21:17.093Z,1521069677.093 [BPC1](INFO): Starting
2018-03-14T23:21:17.480Z,1521069677.480 [BPC1](INFO): Starting
2018-03-14T23:21:17.909Z,1521069677.909 [BPC1](INFO): Starting
2018-03-14T23:21:18.307Z,1521069678.307 [BPC1](INFO): Starting
2018-03-14T23:21:18.707Z,1521069678.707 [BPC1](INFO): Starting
2018-03-14T23:21:19.085Z,1521069679.085 [BPC1](INFO): Starting
2018-03-14T23:21:19.480Z,1521069679.480 [BPC1](INFO): Starting
2018-03-14T23:21:19.882Z,1521069679.882 [BPC1](INFO): Starting
2018-03-14T23:21:20.296Z,1521069680.296 [BPC1](INFO): Starting
2018-03-14T23:21:20.691Z,1521069680.691 [BPC1](INFO): Starting
2018-03-14T23:21:21.105Z,1521069681.105 [BPC1](INFO): Starting
2018-03-14T23:21:21.506Z,1521069681.506 [BPC1](INFO): Starting
2018-03-14T23:21:21.906Z,1521069681.906 [BPC1](INFO): Starting
2018-03-14T23:21:22.280Z,1521069682.280 [BPC1](INFO): Starting
2018-03-14T23:21:22.685Z,1521069682.685 [BPC1](INFO): Starting
2018-03-14T23:21:23.082Z,1521069683.082 [BPC1](INFO): Starting
2018-03-14T23:21:23.484Z,1521069683.484 [BPC1](INFO): Starting
2018-03-14T23:21:23.915Z,1521069683.915 [BPC1](INFO): Starting
2018-03-14T23:21:24.295Z,1521069684.295 [BPC1](INFO): Starting
2018-03-14T23:21:24.696Z,1521069684.696 [BPC1](INFO): Starting
2018-03-14T23:21:25.090Z,1521069685.090 [BPC1](INFO): Starting
2018-03-14T23:21:25.488Z,1521069685.488 [BPC1](INFO): Starting
2018-03-14T23:21:25.894Z,1521069685.894 [BPC1](INFO): Starting
2018-03-14T23:21:26.295Z,1521069686.295 [BPC1](INFO): Starting
2018-03-14T23:21:26.693Z,1521069686.693 [BPC1](INFO): Starting
2018-03-14T23:21:27.095Z,1521069687.095 [BPC1](INFO): Starting
2018-03-14T23:21:27.509Z,1521069687.509 [BPC1](INFO): Starting
2018-03-14T23:21:27.911Z,1521069687.911 [BPC1](INFO): Starting
2018-03-14T23:21:28.285Z,1521069688.285 [BPC1](INFO): Starting
2018-03-14T23:21:28.681Z,1521069688.681 [BPC1](INFO): Starting
2018-03-14T23:21:29.082Z,1521069689.082 [BPC1](INFO): Starting
2018-03-14T23:21:29.493Z,1521069689.493 [BPC1](INFO): Starting
2018-03-14T23:21:29.905Z,1521069689.905 [BPC1](INFO): Starting
2018-03-14T23:21:30.295Z,1521069690.295 [BPC1](INFO): Starting
2018-03-14T23:21:30.699Z,1521069690.699 [BPC1](INFO): Starting
2018-03-14T23:21:31.091Z,1521069691.091 [BPC1](INFO): Starting
2018-03-14T23:21:31.499Z,1521069691.499 [BPC1](INFO): Starting
2018-03-14T23:21:31.890Z,1521069691.890 [BPC1](INFO): Starting
2018-03-14T23:21:32.289Z,1521069692.289 [BPC1](INFO): Starting
2018-03-14T23:21:32.690Z,1521069692.690 [BPC1](INFO): Starting
2018-03-14T23:21:33.107Z,1521069693.107 [BPC1](INFO): Starting
2018-03-14T23:21:33.499Z,1521069693.499 [BPC1](INFO): Starting
2018-03-14T23:21:33.907Z,1521069693.907 [BPC1](INFO): Starting
2018-03-14T23:21:34.282Z,1521069694.282 [BPC1](INFO): Starting
2018-03-14T23:21:34.692Z,1521069694.692 [BPC1](INFO): Starting
2018-03-14T23:21:35.083Z,1521069695.083 [BPC1](INFO): Starting
2018-03-14T23:21:35.492Z,1521069695.492 [BPC1](INFO): Starting
2018-03-14T23:21:35.903Z,1521069695.903 [BPC1](INFO): Starting
2018-03-14T23:21:36.305Z,1521069696.305 [BPC1](INFO): Starting
2018-03-14T23:21:36.694Z,1521069696.694 [BPC1](INFO): Starting
2018-03-14T23:21:37.080Z,1521069697.080 [BPC1](INFO): Starting
2018-03-14T23:21:37.483Z,1521069697.483 [BPC1](INFO): Starting
2018-03-14T23:21:37.884Z,1521069697.884 [BPC1](INFO): Starting
2018-03-14T23:21:38.281Z,1521069698.281 [BPC1](INFO): Starting
2018-03-14T23:21:38.684Z,1521069698.684 [BPC1](INFO): Starting
2018-03-14T23:21:39.091Z,1521069699.091 [BPC1](INFO): Starting
2018-03-14T23:21:39.511Z,1521069699.511 [BPC1](INFO): Starting
2018-03-14T23:21:39.903Z,1521069699.903 [BPC1](INFO): Starting
2018-03-14T23:21:40.289Z,1521069700.289 [BPC1](INFO): Starting
2018-03-14T23:21:40.694Z,1521069700.694 [BPC1](INFO): Starting
2018-03-14T23:21:41.097Z,1521069701.097 [BPC1](INFO): Starting
2018-03-14T23:21:41.495Z,1521069701.495 [BPC1](INFO): Starting
2018-03-14T23:21:41.903Z,1521069701.903 [BPC1](INFO): Starting
2018-03-14T23:21:42.300Z,1521069702.300 [BPC1](INFO): Starting
2018-03-14T23:21:42.705Z,1521069702.705 [BPC1](INFO): Starting
2018-03-14T23:21:43.087Z,1521069703.087 [BPC1](INFO): Starting
2018-03-14T23:21:43.480Z,1521069703.480 [BPC1](INFO): Starting
2018-03-14T23:21:43.882Z,1521069703.882 [BPC1](INFO): Starting
2018-03-14T23:21:44.285Z,1521069704.285 [BPC1](INFO): Starting
2018-03-14T23:21:44.680Z,1521069704.680 [BPC1](INFO): Starting
2018-03-14T23:21:45.107Z,1521069705.107 [BPC1](INFO): Starting
2018-03-14T23:21:45.499Z,1521069705.499 [BPC1](INFO): Starting
2018-03-14T23:21:45.903Z,1521069705.903 [BPC1](INFO): Starting
2018-03-14T23:21:46.287Z,1521069706.287 [BPC1](INFO): Starting
2018-03-14T23:21:46.689Z,1521069706.689 [BPC1](INFO): Starting
2018-03-14T23:21:47.095Z,1521069707.095 [BPC1](INFO): Starting
2018-03-14T23:21:47.492Z,1521069707.492 [BPC1](INFO): Starting
2018-03-14T23:21:47.904Z,1521069707.904 [BPC1](INFO): Starting
2018-03-14T23:21:48.302Z,1521069708.302 [BPC1](INFO): Starting
2018-03-14T23:21:48.694Z,1521069708.694 [BPC1](INFO): Starting
2018-03-14T23:21:49.091Z,1521069709.091 [BPC1](INFO): Starting
2018-03-14T23:21:49.480Z,1521069709.480 [BPC1](INFO): Starting
2018-03-14T23:21:49.884Z,1521069709.884 [BPC1](INFO): Starting
2018-03-14T23:21:50.283Z,1521069710.283 [BPC1](INFO): Starting
2018-03-14T23:21:50.688Z,1521069710.688 [BPC1](INFO): Starting
2018-03-14T23:21:51.091Z,1521069711.091 [BPC1](INFO): Starting
2018-03-14T23:21:51.495Z,1521069711.495 [BPC1](INFO): Starting
2018-03-14T23:21:51.911Z,1521069711.911 [BPC1](INFO): Starting
2018-03-14T23:21:52.290Z,1521069712.290 [BPC1](INFO): Starting
2018-03-14T23:21:52.688Z,1521069712.688 [BPC1](INFO): Starting
2018-03-14T23:21:53.083Z,1521069713.083 [BPC1](INFO): Starting
2018-03-14T23:21:53.487Z,1521069713.487 [BPC1](INFO): Starting
2018-03-14T23:21:53.907Z,1521069713.907 [BPC1](INFO): Starting
2018-03-14T23:21:54.306Z,1521069714.306 [BPC1](INFO): Starting
2018-03-14T23:21:54.717Z,1521069714.717 [BPC1](INFO): Starting
2018-03-14T23:21:55.088Z,1521069715.088 [BPC1](INFO): Starting
2018-03-14T23:21:55.503Z,1521069715.503 [BPC1](INFO): Starting
2018-03-14T23:21:55.890Z,1521069715.890 [BPC1](INFO): Starting
2018-03-14T23:21:56.314Z,1521069716.314 [BPC1](INFO): Starting
2018-03-14T23:21:56.692Z,1521069716.692 [BPC1](INFO): Starting
2018-03-14T23:21:57.101Z,1521069717.101 [BPC1](INFO): Starting
2018-03-14T23:21:57.507Z,1521069717.507 [BPC1](INFO): Starting
2018-03-14T23:21:57.916Z,1521069717.916 [BPC1](INFO): Starting
2018-03-14T23:21:57.979Z,1521069717.979 [Default:CheckIn:Read_GPS](INFO): Timed out from 2018-03-14T23:16:57.0Z
2018-03-14T23:21:57.979Z,1521069717.979 [Default:CheckIn:Read_GPS] Stopped
2018-03-14T23:21:57.979Z,1521069717.979 [Default:CheckIn:Read_Iridium] Running Loop=1
2018-03-14T23:21:58.297Z,1521069718.297 [BPC1](INFO): Starting
2018-03-14T23:21:59.727Z,1521069719.727 [BPC1](INFO): Starting
2018-03-14T23:21:59.939Z,1521069719.939 [BPC1](INFO): Starting
2018-03-14T23:22:06.231Z,1521069726.231 [BPC1](INFO): Starting
2018-03-14T23:22:06.232Z,1521069726.232 [BPC1](INFO): Initialized.
2018-03-14T23:22:06.289Z,1521069726.289 [DataOverHttps](INFO): Sending 25 bytes from file Logs/20180314T230249/Courier0008.lzma
2018-03-14T23:22:06.387Z,1521069726.387 [BPC1](INFO): Bank B: initialized.
2018-03-14T23:22:07.059Z,1521069727.059 [DataOverHttps](INFO): Moved sent file to Logs/20180314T230249/Courier0008.lzma.bak
2018-03-14T23:22:07.059Z,1521069727.059 [DataOverHttps](INFO): SBD MOMSN=8062204
2018-03-14T23:22:08.424Z,1521069728.424 [CommandLine](IMPORTANT): got command restart application
2018-03-14T23:22:09.431Z,1521069729.431 [Supervisor](INFO): Stop Mission called by Supervisor::terminate
2018-03-14T23:22:09.434Z,1521069729.434 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2018-03-14T23:22:09.434Z,1521069729.434 [CommandLine ThreadHandler](INFO): Thread cancelled.
2018-03-14T23:22:09.450Z,1521069729.450 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye!
2018-03-14T23:22:09.451Z,1521069729.451 [CommandLine ThreadHandler](INFO): Thread cancelled.
2018-03-14T23:22:09.451Z,1521069729.451 [CommandLine](INFO): Join timeout helper Thread ID is 1180
2018-03-14T23:22:09.455Z,1521069729.455 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2018-03-14T23:22:09.455Z,1521069729.455 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2018-03-14T23:22:09.455Z,1521069729.455 [NavChartDb](INFO): Join timeout helper Thread ID is 1181
2018-03-14T23:22:09.748Z,1521069729.748 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2018-03-14T23:22:09.748Z,1521069729.748 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2018-03-14T23:22:09.759Z,1521069729.759 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2018-03-14T23:22:09.759Z,1521069729.759 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2018-03-14T23:22:09.759Z,1521069729.759 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 1182
2018-03-14T23:22:09.763Z,1521069729.763 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread.
2018-03-14T23:22:09.763Z,1521069729.763 [WetLabsBB2FL](INFO): Powering down
2018-03-14T23:22:09.764Z,1521069729.764 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2018-03-14T23:22:09.764Z,1521069729.764 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2018-03-14T23:22:09.765Z,1521069729.765 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2018-03-14T23:22:09.765Z,1521069729.765 [Radio_Surface](INFO): Join timeout helper Thread ID is 1183
2018-03-14T23:22:09.900Z,1521069729.900 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2018-03-14T23:22:09.900Z,1521069729.900 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2018-03-14T23:22:09.911Z,1521069729.911 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2018-03-14T23:22:09.911Z,1521069729.911 [logger ThreadHandler](INFO): Thread cancelled.
2018-03-14T23:22:09.911Z,1521069729.911 [logger](INFO): Join timeout helper Thread ID is 1184
2018-03-14T23:22:09.947Z,1521069729.947 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2018-03-14T23:22:09.947Z,1521069729.947 [logger ThreadHandler](INFO): Thread cancelled.
2018-03-14T23:22:09.963Z,1521069729.963 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2018-03-14T23:22:09.963Z,1521069729.963 [CommandLine ThreadHandler](INFO): Thread cancelled.
2018-03-14T23:22:09.964Z,1521069729.964 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2018-03-14T23:22:09.964Z,1521069729.964 [controlThread ThreadHandler](INFO): Thread cancelled.
2018-03-14T23:22:09.964Z,1521069729.964 [controlThread](INFO): Join timeout helper Thread ID is 1185
2018-03-14T23:22:11.116Z,1521069731.116 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2018-03-14T23:22:11.117Z,1521069731.117 [controlThread](DEBUG): Uninitializing ControlThread
2018-03-14T23:22:11.120Z,1521069731.120 [NAL9602](INFO): Powering down
2018-03-14T23:22:11.121Z,1521069731.121 [PNI_TCM](INFO): Powering down
2018-03-14T23:22:11.207Z,1521069731.207 [BPC1](INFO): uninitialize
2018-03-14T23:22:11.207Z,1521069731.207 [Aanderaa_O2](INFO): Powering down
2018-03-14T23:22:11.209Z,1521069731.209 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2018-03-14T23:22:11.211Z,1521069731.211 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2018-03-14T23:22:11.212Z,1521069731.212 [MissionManager](INFO): Uninitializing Mission Default
2018-03-14T23:22:11.212Z,1521069731.212 [Default] Stopped
2018-03-14T23:22:11.212Z,1521069731.212 [Default](DEBUG): Aggregate::uninitialize Default
2018-03-14T23:22:11.212Z,1521069731.212 [Default:B.GoToSurface] Stopped
2018-03-14T23:22:11.212Z,1521069731.212 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2018-03-14T23:22:11.212Z,1521069731.212 [Default:CheckIn] Stopped
2018-03-14T23:22:11.212Z,1521069731.212 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2018-03-14T23:22:11.212Z,1521069731.212 [Default:CheckIn:Read_Iridium] Stopped
2018-03-14T23:22:11.215Z,1521069731.215 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2018-03-14T23:22:11.215Z,1521069731.215 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2018-03-14T23:22:11.216Z,1521069731.216 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2018-03-14T23:22:11.216Z,1521069731.216 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2018-03-14T23:22:11.216Z,1521069731.216 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2018-03-14T23:22:11.216Z,1521069731.216 [BuoyancyServo](INFO): Powering down
2018-03-14T23:22:11.231Z,1521069731.231 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2018-03-14T23:22:11.231Z,1521069731.231 [ElevatorServo](INFO): Powering down
2018-03-14T23:22:11.232Z,1521069731.232 [MassServo](DEBUG): Uninitialize Mass Servo.
2018-03-14T23:22:11.232Z,1521069731.232 [MassServo](INFO): Powering down
2018-03-14T23:22:11.232Z,1521069731.232 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2018-03-14T23:22:11.232Z,1521069731.232 [RudderServo](INFO): Powering down
2018-03-14T23:22:11.233Z,1521069731.233 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2018-03-14T23:22:11.233Z,1521069731.233 [ThrusterServo](INFO): Powering down
2018-03-14T23:22:11.234Z,1521069731.234 [SBIT](DEBUG): Uninitialize SBIT Component.
2018-03-14T23:22:11.234Z,1521069731.234 [IBIT](DEBUG): Uninitialize IBIT Component.
2018-03-14T23:22:11.235Z,1521069731.235 [CBIT](DEBUG): Uninitialize CBIT Component.
2018-03-14T23:22:11.236Z,1521069731.236 [controlThread ThreadHandler](INFO): Thread cancelled.
2018-03-14T23:22:11.288Z,1521069731.288 [BPC1](INFO): uninitialize
2018-03-14T23:22:11.333Z,1521069731.333 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2018-03-14T23:22:11.370Z,1521069731.370 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2018-03-14T23:22:11.399Z,1521069731.399 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2018-03-14T23:22:11.447Z,1521069731.447 [logger ThreadHandler](INFO): Thread cancelled.