2018-03-14T22:01:00.269Z,1521064860.269 [Supervisor](DEBUG): Initializing supervisor.
2018-03-14T22:01:00.273Z,1521064860.273 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2018-03-14T22:01:00.273Z,1521064860.273 [SyncHandler](INFO): Protected caller Thread ID is 9838
2018-03-14T22:01:00.274Z,1521064860.274 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2018-03-14T22:01:00.275Z,1521064860.275 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2018-03-14T22:01:00.275Z,1521064860.275 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 9839
2018-03-14T22:01:00.278Z,1521064860.278 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2018-03-14T22:01:00.290Z,1521064860.290 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2018-03-14T22:01:00.291Z,1521064860.291 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2018-03-14T22:01:00.291Z,1521064860.291 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 9840
2018-03-14T22:01:00.292Z,1521064860.292 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2018-03-14T22:01:00.293Z,1521064860.293 [logger ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2018-03-14T22:01:00.293Z,1521064860.293 [logger ThreadHandler](INFO): Protected caller Thread ID is 9841
2018-03-14T22:01:00.295Z,1521064860.295 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2018-03-14T22:01:00.296Z,1521064860.296 [Supervisor](INFO): Looking for Config files in directory: Config/
2018-03-14T22:01:00.298Z,1521064860.298 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2018-03-14T22:01:00.616Z,1521064860.616 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2018-03-14T22:01:00.616Z,1521064860.616 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2018-03-14T22:01:00.798Z,1521064860.798 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2018-03-14T22:01:00.799Z,1521064860.799 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2018-03-14T22:01:01.055Z,1521064861.055 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2018-03-14T22:01:01.055Z,1521064861.055 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2018-03-14T22:01:01.189Z,1521064861.189 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2018-03-14T22:01:01.190Z,1521064861.190 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2018-03-14T22:01:01.284Z,1521064861.284 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample
2018-03-14T22:01:01.285Z,1521064861.285 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2018-03-14T22:01:01.701Z,1521064861.701 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2018-03-14T22:01:01.702Z,1521064861.702 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2018-03-14T22:01:02.015Z,1521064862.015 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2018-03-14T22:01:02.016Z,1521064862.016 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2018-03-14T22:01:02.415Z,1521064862.415 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2018-03-14T22:01:02.416Z,1521064862.416 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2018-03-14T22:01:02.515Z,1521064862.515 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2018-03-14T22:01:02.516Z,1521064862.516 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2018-03-14T22:01:02.609Z,1521064862.609 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2018-03-14T22:01:02.609Z,1521064862.609 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2018-03-14T22:01:02.802Z,1521064862.802 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2018-03-14T22:01:02.802Z,1521064862.802 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2018-03-14T22:01:02.995Z,1521064862.995 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2018-03-14T22:01:02.995Z,1521064862.995 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2018-03-14T22:01:03.305Z,1521064863.305 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2018-03-14T22:01:03.306Z,1521064863.306 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2018-03-14T22:01:03.439Z,1521064863.439 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2018-03-14T22:01:03.439Z,1521064863.439 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2018-03-14T22:01:03.519Z,1521064863.519 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-daphne/
2018-03-14T22:01:03.520Z,1521064863.520 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Control.cfg
2018-03-14T22:01:03.617Z,1521064863.617 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/logger.cfg
2018-03-14T22:01:03.705Z,1521064863.705 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Servo.cfg
2018-03-14T22:01:03.795Z,1521064863.795 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Simulator.cfg
2018-03-14T22:01:03.878Z,1521064863.878 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Sensor.cfg
2018-03-14T22:01:04.017Z,1521064864.017 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/vehicle.cfg
2018-03-14T22:01:04.177Z,1521064864.177 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/workSite.cfg
2018-03-14T22:01:04.252Z,1521064864.252 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Battery.cfg
2018-03-14T22:01:04.467Z,1521064864.467 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2018-03-14T22:01:04.468Z,1521064864.468 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/secure.cfg
2018-03-14T22:01:04.549Z,1521064864.549 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Navigation.cfg
2018-03-14T22:01:04.636Z,1521064864.636 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/BIT.cfg
2018-03-14T22:01:04.732Z,1521064864.732 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Science.cfg
2018-03-14T22:01:04.852Z,1521064864.852 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-daphne/root/
2018-03-14T22:01:04.853Z,1521064864.853 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg
2018-03-14T22:01:04.857Z,1521064864.857 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2018-03-14T22:01:05.089Z,1521064865.089 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2018-03-14T22:01:05.090Z,1521064865.090 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2018-03-14T22:01:05.131Z,1521064865.131 [DepthRateCalculator] Loaded
2018-03-14T22:01:05.132Z,1521064865.132 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2018-03-14T22:01:05.137Z,1521064865.137 [PitchRateCalculator] Loaded
2018-03-14T22:01:05.137Z,1521064865.137 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2018-03-14T22:01:05.153Z,1521064865.153 [SpeedCalculator] Loaded
2018-03-14T22:01:05.153Z,1521064865.153 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2018-03-14T22:01:05.173Z,1521064865.173 [TempGradientCalculator] Loaded
2018-03-14T22:01:05.173Z,1521064865.173 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread.
2018-03-14T22:01:05.188Z,1521064865.188 [VerticalTemperatureHomogeneityIndexCalculator] Loaded
2018-03-14T22:01:05.188Z,1521064865.188 [ComponentRegistry](DEBUG): SyncComponent "VerticalTemperatureHomogeneityIndexCalculator" handled in the control thread.
2018-03-14T22:01:05.194Z,1521064865.194 [YawRateCalculator] Loaded
2018-03-14T22:01:05.194Z,1521064865.194 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2018-03-14T22:01:05.194Z,1521064865.194 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2018-03-14T22:01:05.195Z,1521064865.195 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2018-03-14T22:01:05.279Z,1521064865.279 [StratificationFrontDetector](INFO): threshold set to: 0.399988 degC
2018-03-14T22:01:05.279Z,1521064865.279 [StratificationFrontDetector](DEBUG): (re)initializing
2018-03-14T22:01:05.279Z,1521064865.279 [StratificationFrontDetector] Loaded
2018-03-14T22:01:05.279Z,1521064865.279 [ComponentRegistry](DEBUG): SyncComponent "StratificationFrontDetector" handled in the control thread.
2018-03-14T22:01:05.280Z,1521064865.280 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2018-03-14T22:01:05.280Z,1521064865.280 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2018-03-14T22:01:05.391Z,1521064865.391 [BuoyancyServo] Loaded
2018-03-14T22:01:05.391Z,1521064865.391 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2018-03-14T22:01:05.406Z,1521064865.406 [ElevatorServo] Loaded
2018-03-14T22:01:05.406Z,1521064865.406 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2018-03-14T22:01:05.420Z,1521064865.420 [MassServo] Loaded
2018-03-14T22:01:05.420Z,1521064865.420 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2018-03-14T22:01:05.434Z,1521064865.434 [RudderServo] Loaded
2018-03-14T22:01:05.435Z,1521064865.435 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2018-03-14T22:01:05.448Z,1521064865.448 [ThrusterServo] Loaded
2018-03-14T22:01:05.449Z,1521064865.449 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread.
2018-03-14T22:01:05.449Z,1521064865.449 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2018-03-14T22:01:05.450Z,1521064865.450 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2018-03-14T22:01:05.463Z,1521064865.463 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2018-03-14T22:01:05.464Z,1521064865.464 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2018-03-14T22:01:05.558Z,1521064865.558 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2018-03-14T22:01:05.559Z,1521064865.559 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2018-03-14T22:01:05.818Z,1521064865.818 [DataOverHttps] Loaded
2018-03-14T22:01:05.818Z,1521064865.818 [ComponentRegistry](DEBUG): SyncComponent "DataOverHttps" handled in the control thread.
2018-03-14T22:01:05.831Z,1521064865.831 [Depth_Keller] Loaded
2018-03-14T22:01:05.831Z,1521064865.831 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2018-03-14T22:01:05.836Z,1521064865.836 [DropWeight] Loaded
2018-03-14T22:01:05.836Z,1521064865.836 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2018-03-14T22:01:05.930Z,1521064865.930 [NAL9602] Loaded
2018-03-14T22:01:05.930Z,1521064865.930 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2018-03-14T22:01:05.945Z,1521064865.945 [Onboard] Loaded
2018-03-14T22:01:05.945Z,1521064865.945 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread.
2018-03-14T22:01:05.955Z,1521064865.955 [Radio_Surface] Loaded
2018-03-14T22:01:05.955Z,1521064865.955 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2018-03-14T22:01:05.956Z,1521064865.956 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 408714E0
2018-03-14T22:01:05.956Z,1521064865.956 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 9923
2018-03-14T22:01:06.002Z,1521064866.002 [PNI_TCM] Loaded
2018-03-14T22:01:06.002Z,1521064866.002 [ComponentRegistry](DEBUG): SyncComponent "PNI_TCM" handled in the control thread.
2018-03-14T22:01:07.664Z,1521064867.664 [BPC1] Loaded
2018-03-14T22:01:07.665Z,1521064867.665 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2018-03-14T22:01:07.665Z,1521064867.665 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2018-03-14T22:01:07.666Z,1521064867.666 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2018-03-14T22:01:07.930Z,1521064867.930 [SBIT](DEBUG): Construct Startup Built In Test.
2018-03-14T22:01:08.008Z,1521064868.008 [SBIT] Loaded
2018-03-14T22:01:08.008Z,1521064868.008 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2018-03-14T22:01:08.009Z,1521064868.009 [IBIT](DEBUG): Construct Initiated Built In Test.
2018-03-14T22:01:08.031Z,1521064868.031 [IBIT] Loaded
2018-03-14T22:01:08.031Z,1521064868.031 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2018-03-14T22:01:08.034Z,1521064868.034 [CBIT](DEBUG): Construct Continuous Built In Test.
2018-03-14T22:01:08.442Z,1521064868.442 [CBIT] Loaded
2018-03-14T22:01:08.442Z,1521064868.442 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2018-03-14T22:01:08.450Z,1521064868.450 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2018-03-14T22:01:08.451Z,1521064868.451 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2018-03-14T22:01:09.216Z,1521064869.216 [Aanderaa_O2] Loaded
2018-03-14T22:01:09.216Z,1521064869.216 [ComponentRegistry](DEBUG): SyncComponent "Aanderaa_O2" handled in the control thread.
2018-03-14T22:01:09.279Z,1521064869.279 [CANONSampler] Loaded
2018-03-14T22:01:09.279Z,1521064869.279 [ComponentRegistry](DEBUG): SyncComponent "CANONSampler" handled in the control thread.
2018-03-14T22:01:09.339Z,1521064869.339 [PAR_Licor] Loaded
2018-03-14T22:01:09.339Z,1521064869.339 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2018-03-14T22:01:09.487Z,1521064869.487 [WetLabsBB2FL] Loaded
2018-03-14T22:01:09.487Z,1521064869.487 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2018-03-14T22:01:09.515Z,1521064869.515 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 409314E0
2018-03-14T22:01:09.515Z,1521064869.515 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 9924
2018-03-14T22:01:09.516Z,1521064869.516 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2018-03-14T22:01:09.516Z,1521064869.516 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2018-03-14T22:01:09.627Z,1521064869.627 [VerticalControl](DEBUG): Construct VerticalControl.
2018-03-14T22:01:09.711Z,1521064869.711 [VerticalControl] Loaded
2018-03-14T22:01:09.711Z,1521064869.711 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2018-03-14T22:01:09.712Z,1521064869.712 [HorizontalControl](DEBUG): Construct HorizontalControl.
2018-03-14T22:01:09.766Z,1521064869.766 [HorizontalControl] Loaded
2018-03-14T22:01:09.767Z,1521064869.767 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2018-03-14T22:01:09.767Z,1521064869.767 [SpeedControl](DEBUG): Construct SpeedControl.
2018-03-14T22:01:09.769Z,1521064869.769 [SpeedControl] Loaded
2018-03-14T22:01:09.769Z,1521064869.769 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2018-03-14T22:01:09.770Z,1521064869.770 [LoopControl](DEBUG): Construct LoopControl.
2018-03-14T22:01:09.770Z,1521064869.770 [LoopControl] Loaded
2018-03-14T22:01:09.770Z,1521064869.770 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2018-03-14T22:01:09.771Z,1521064869.771 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2018-03-14T22:01:09.771Z,1521064869.771 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2018-03-14T22:01:09.796Z,1521064869.796 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2018-03-14T22:01:09.796Z,1521064869.796 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2018-03-14T22:01:09.885Z,1521064869.885 [DeadReckonUsingSpeedCalculator] Loaded
2018-03-14T22:01:09.885Z,1521064869.885 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread.
2018-03-14T22:01:09.937Z,1521064869.937 [DeadReckonWithRespectToSeafloor] Loaded
2018-03-14T22:01:09.938Z,1521064869.938 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonWithRespectToSeafloor" handled in the control thread.
2018-03-14T22:01:09.954Z,1521064869.954 [NavChart] Loaded
2018-03-14T22:01:09.954Z,1521064869.954 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2018-03-14T22:01:09.958Z,1521064869.958 [UniversalFixResidualReporter] Loaded
2018-03-14T22:01:09.958Z,1521064869.958 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2018-03-14T22:01:09.958Z,1521064869.958 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2018-03-14T22:01:09.962Z,1521064869.962 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2018-03-14T22:01:09.963Z,1521064869.963 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2018-03-14T22:01:09.969Z,1521064869.969 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2018-03-14T22:01:09.970Z,1521064869.970 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 409BD4E0
2018-03-14T22:01:09.971Z,1521064869.971 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 9925
2018-03-14T22:01:09.975Z,1521064869.975 [Supervisor](INFO): Main Thread ID is 9710
2018-03-14T22:01:09.975Z,1521064869.975 [Supervisor](DEBUG): Running supervisor.
2018-03-14T22:01:09.976Z,1521064869.976 [CommandLine ThreadHandler](INFO): Handler Thread ID is 9926
2018-03-14T22:01:09.979Z,1521064869.979 [controlThread ThreadHandler](INFO): Handler Thread ID is 9927
2018-03-14T22:01:09.980Z,1521064869.980 [controlThread](DEBUG): Initializing ControlThread
2018-03-14T22:01:09.980Z,1521064869.980 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2018-03-14T22:01:09.981Z,1521064869.981 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2018-03-14T22:01:09.981Z,1521064869.981 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2018-03-14T22:01:09.981Z,1521064869.981 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator.
2018-03-14T22:01:09.982Z,1521064869.982 [VerticalTemperatureHomogeneityIndexCalculator](DEBUG): (re)initializing
2018-03-14T22:01:09.983Z,1521064869.983 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2018-03-14T22:01:09.989Z,1521064869.989 [SBIT](INFO): Initialize SBIT Component.
2018-03-14T22:01:09.989Z,1521064869.989 [SBIT](IMPORTANT): git: 2018-03-10-3-g1088291
2018-03-14T22:01:09.989Z,1521064869.989 [SBIT](INFO): git hash: 10882917f95cfba58cc6008bb2c6cc253db9d857
2018-03-14T22:01:09.990Z,1521064869.990 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2018-03-14T22:01:09.991Z,1521064869.991 [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-14T22:01:09.992Z,1521064869.992 [SBIT](INFO): Beginning SBIT in 23.000000 seconds.
2018-03-14T22:01:09.992Z,1521064869.992 [IBIT](INFO): Initialize IBIT Component.
2018-03-14T22:01:09.993Z,1521064869.993 [CBIT](DEBUG): Initialize CBIT Component.
2018-03-14T22:01:09.993Z,1521064869.993 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2018-03-14T22:01:09.994Z,1521064869.994 [logger ThreadHandler](INFO): Handler Thread ID is 9928
2018-03-14T22:01:10.011Z,1521064870.011 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 9929
2018-03-14T22:01:10.017Z,1521064870.017 [Radio_Surface](INFO): Powering up
2018-03-14T22:01:10.023Z,1521064870.023 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 9930
2018-03-14T22:01:10.024Z,1521064870.024 [WetLabsBB2FL](INFO): Powering down
2018-03-14T22:01:10.047Z,1521064870.047 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 9931
2018-03-14T22:01:10.050Z,1521064870.050 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2018-03-14T22:01:10.050Z,1521064870.050 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2018-03-14T22:01:10.051Z,1521064870.051 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2018-03-14T22:01:10.051Z,1521064870.051 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2018-03-14T22:01:10.051Z,1521064870.051 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2018-03-14T22:01:10.051Z,1521064870.051 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2018-03-14T22:01:10.051Z,1521064870.051 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000
2018-03-14T22:01:10.051Z,1521064870.051 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000
2018-03-14T22:01:10.052Z,1521064870.052 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2018-03-14T22:01:10.052Z,1521064870.052 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2018-03-14T22:01:10.052Z,1521064870.052 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000
2018-03-14T22:01:10.052Z,1521064870.052 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000
2018-03-14T22:01:10.052Z,1521064870.052 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000
2018-03-14T22:01:10.053Z,1521064870.053 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000
2018-03-14T22:01:10.053Z,1521064870.053 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000
2018-03-14T22:01:10.053Z,1521064870.053 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000
2018-03-14T22:01:10.103Z,1521064870.103 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2018-03-14T22:01:10.104Z,1521064870.104 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2018-03-14T22:01:10.105Z,1521064870.105 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2018-03-14T22:01:10.106Z,1521064870.106 [LoopControl](DEBUG): Initialize LoopControlComponent.
2018-03-14T22:01:10.106Z,1521064870.106 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2018-03-14T22:01:10.107Z,1521064870.107 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2018-03-14T22:01:10.107Z,1521064870.107 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2018-03-14T22:01:10.108Z,1521064870.108 [DeadReckonWithRespectToSeafloor](DEBUG): Initializing DeadReckonWithRespectToSeafloor component.
2018-03-14T22:01:10.108Z,1521064870.108 [DeadReckonWithRespectToSeafloor](INFO): Will consider orientation measurement stale after 120s.
2018-03-14T22:01:10.108Z,1521064870.108 [DeadReckonWithRespectToSeafloor](INFO): Will consider velocity measurement stale after 20s.
2018-03-14T22:01:10.109Z,1521064870.109 [NavChart](DEBUG): Initialize NavChart Navigation.
2018-03-14T22:01:10.109Z,1521064870.109 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2018-03-14T22:01:10.110Z,1521064870.110 [MissionManager](INFO): Loading Mission: Missions/Startup.xml
2018-03-14T22:01:10.137Z,1521064870.137 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2018-03-14T22:01:10.164Z,1521064870.164 [MissionManager](DEBUG):
2018-03-14T22:01:10.165Z,1521064870.165 [MissionManager](INFO): Loading Mission: Missions/Default.xml
2018-03-14T22:01:10.246Z,1521064870.246 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2018-03-14T22:01:10.263Z,1521064870.263 [Default:A.Wait](DEBUG): Construct Wait.
2018-03-14T22:01:10.265Z,1521064870.265 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2018-03-14T22:01:10.307Z,1521064870.307 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2018-03-14T22:01:10.310Z,1521064870.310 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2018-03-14T22:01:10.332Z,1521064870.332 [Default:E.Execute](DEBUG): Construct Execute.
2018-03-14T22:01:10.335Z,1521064870.335 [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-14T22:01:10.340Z,1521064870.340 [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-14T22:01:10.359Z,1521064870.359 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2018-03-14T22:01:10.367Z,1521064870.367 [Depth_Keller](ERROR): Pressure reading out of range: 1831.023193 decibar
2018-03-14T22:01:10.484Z,1521064870.484 [BPC1](INFO): Start
2018-03-14T22:01:10.584Z,1521064870.584 [CANONSampler](INFO): Powering down
2018-03-14T22:01:10.708Z,1521064870.708 [DepthRateCalculator](ERROR): Depth measurement is not active
2018-03-14T22:01:10.795Z,1521064870.795 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-03-14T22:01:10.802Z,1521064870.802 [DeadReckonWithRespectToSeafloor](DEBUG): Starting up and don't have orientation data yet.
2018-03-14T22:01:10.922Z,1521064870.922 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2018-03-14T22:01:10.935Z,1521064870.935 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2018-03-14T22:01:10.957Z,1521064870.957 [ElevatorServo](DEBUG): Initializing EZServoServo.
2018-03-14T22:01:10.963Z,1521064870.963 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2018-03-14T22:01:10.977Z,1521064870.977 [MassServo](DEBUG): Initializing EZServoServo.
2018-03-14T22:01:10.983Z,1521064870.983 [MassServo](DEBUG): Initializing MassServo.
2018-03-14T22:01:10.996Z,1521064870.996 [RudderServo](DEBUG): Initializing EZServoServo.
2018-03-14T22:01:11.003Z,1521064871.003 [RudderServo](DEBUG): Initializing RudderServo.
2018-03-14T22:01:11.024Z,1521064871.024 [ThrusterServo](DEBUG): Initializing EZServoServo.
2018-03-14T22:01:11.031Z,1521064871.031 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2018-03-14T22:01:11.267Z,1521064871.267 [BPC1](INFO): Starting
2018-03-14T22:01:11.295Z,1521064871.295 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-03-14T22:01:11.296Z,1521064871.296 [DeadReckonWithRespectToSeafloor](DEBUG): Starting up and don't have orientation data yet.
2018-03-14T22:01:11.524Z,1521064871.524 [BPC1](INFO): Starting
2018-03-14T22:01:11.570Z,1521064871.570 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-03-14T22:01:11.571Z,1521064871.571 [DeadReckonWithRespectToSeafloor](DEBUG): Starting up and don't have orientation data yet.
2018-03-14T22:01:12.024Z,1521064872.024 [BPC1](INFO): Starting
2018-03-14T22:01:12.049Z,1521064872.049 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-03-14T22:01:12.050Z,1521064872.050 [DeadReckonWithRespectToSeafloor](DEBUG): Starting up and don't have orientation data yet.
2018-03-14T22:01:12.439Z,1521064872.439 [BPC1](INFO): Starting
2018-03-14T22:01:12.467Z,1521064872.467 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-03-14T22:01:12.467Z,1521064872.467 [DeadReckonWithRespectToSeafloor](DEBUG): Starting up and don't have orientation data yet.
2018-03-14T22:01:12.826Z,1521064872.826 [BPC1](INFO): Starting
2018-03-14T22:01:12.851Z,1521064872.851 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-03-14T22:01:12.852Z,1521064872.852 [DeadReckonWithRespectToSeafloor](DEBUG): Starting up and don't have orientation data yet.
2018-03-14T22:01:13.229Z,1521064873.229 [BPC1](INFO): Starting
2018-03-14T22:01:13.258Z,1521064873.258 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-03-14T22:01:13.270Z,1521064873.270 [DeadReckonWithRespectToSeafloor](DEBUG): Starting up and don't have orientation data yet.
2018-03-14T22:01:13.639Z,1521064873.639 [BPC1](INFO): Starting
2018-03-14T22:01:13.759Z,1521064873.759 [Aanderaa_O2](INFO): Powering down
2018-03-14T22:01:13.805Z,1521064873.805 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-03-14T22:01:13.806Z,1521064873.806 [DeadReckonWithRespectToSeafloor](DEBUG): Starting up and don't have orientation data yet.
2018-03-14T22:01:14.040Z,1521064874.040 [BPC1](INFO): Starting
2018-03-14T22:01:14.437Z,1521064874.437 [BPC1](INFO): Starting
2018-03-14T22:01:14.975Z,1521064874.975 [BPC1](INFO): Starting
2018-03-14T22:01:15.315Z,1521064875.315 [BPC1](INFO): Starting
2018-03-14T22:01:15.714Z,1521064875.714 [BPC1](INFO): Starting
2018-03-14T22:01:16.140Z,1521064876.140 [BPC1](INFO): Starting
2018-03-14T22:01:16.527Z,1521064876.527 [BPC1](INFO): Starting
2018-03-14T22:01:16.916Z,1521064876.916 [BPC1](INFO): Starting
2018-03-14T22:01:17.313Z,1521064877.313 [BPC1](INFO): Starting
2018-03-14T22:01:17.712Z,1521064877.712 [BPC1](INFO): Starting
2018-03-14T22:01:18.116Z,1521064878.116 [BPC1](INFO): Starting
2018-03-14T22:01:18.516Z,1521064878.516 [BPC1](INFO): Starting
2018-03-14T22:01:18.918Z,1521064878.918 [BPC1](INFO): Starting
2018-03-14T22:01:19.316Z,1521064879.316 [BPC1](INFO): Starting
2018-03-14T22:01:19.715Z,1521064879.715 [BPC1](INFO): Starting
2018-03-14T22:01:20.115Z,1521064880.115 [BPC1](INFO): Starting
2018-03-14T22:01:20.513Z,1521064880.513 [BPC1](INFO): Starting
2018-03-14T22:01:20.933Z,1521064880.933 [BPC1](INFO): Starting
2018-03-14T22:01:21.315Z,1521064881.315 [BPC1](INFO): Starting
2018-03-14T22:01:21.715Z,1521064881.715 [BPC1](INFO): Starting
2018-03-14T22:01:22.113Z,1521064882.113 [BPC1](INFO): Starting
2018-03-14T22:01:22.512Z,1521064882.512 [BPC1](INFO): Starting
2018-03-14T22:01:22.916Z,1521064882.916 [BPC1](INFO): Starting
2018-03-14T22:01:23.315Z,1521064883.315 [BPC1](INFO): Starting
2018-03-14T22:01:23.713Z,1521064883.713 [BPC1](INFO): Starting
2018-03-14T22:01:24.112Z,1521064884.112 [BPC1](INFO): Starting
2018-03-14T22:01:24.516Z,1521064884.516 [BPC1](INFO): Starting
2018-03-14T22:01:24.924Z,1521064884.924 [BPC1](INFO): Starting
2018-03-14T22:01:25.313Z,1521064885.313 [BPC1](INFO): Starting
2018-03-14T22:01:25.712Z,1521064885.712 [BPC1](INFO): Starting
2018-03-14T22:01:26.115Z,1521064886.115 [BPC1](INFO): Starting
2018-03-14T22:01:26.515Z,1521064886.515 [BPC1](INFO): Starting
2018-03-14T22:01:26.913Z,1521064886.913 [BPC1](INFO): Starting
2018-03-14T22:01:27.312Z,1521064887.312 [BPC1](INFO): Starting
2018-03-14T22:01:27.716Z,1521064887.716 [BPC1](INFO): Starting
2018-03-14T22:01:28.115Z,1521064888.115 [BPC1](INFO): Starting
2018-03-14T22:01:28.513Z,1521064888.513 [BPC1](INFO): Starting
2018-03-14T22:01:28.912Z,1521064888.912 [BPC1](INFO): Starting
2018-03-14T22:01:29.315Z,1521064889.315 [BPC1](INFO): Starting
2018-03-14T22:01:29.716Z,1521064889.716 [BPC1](INFO): Starting
2018-03-14T22:01:30.114Z,1521064890.114 [BPC1](INFO): Starting
2018-03-14T22:01:30.509Z,1521064890.509 [BPC1](INFO): Starting
2018-03-14T22:01:30.914Z,1521064890.914 [BPC1](INFO): Starting
2018-03-14T22:01:31.315Z,1521064891.315 [BPC1](INFO): Starting
2018-03-14T22:01:31.713Z,1521064891.713 [BPC1](INFO): Starting
2018-03-14T22:01:32.112Z,1521064892.112 [BPC1](INFO): Starting
2018-03-14T22:01:32.515Z,1521064892.515 [BPC1](INFO): Starting
2018-03-14T22:01:32.915Z,1521064892.915 [BPC1](INFO): Starting
2018-03-14T22:01:33.313Z,1521064893.313 [BPC1](INFO): Starting
2018-03-14T22:01:33.341Z,1521064893.341 [SBIT](IMPORTANT): Beginning Startup BIT
2018-03-14T22:01:33.357Z,1521064893.357 [CBIT](IMPORTANT): Beginning ground fault scan
2018-03-14T22:01:33.712Z,1521064893.712 [BPC1](INFO): Starting
2018-03-14T22:01:34.115Z,1521064894.115 [BPC1](INFO): Starting
2018-03-14T22:01:34.517Z,1521064894.517 [BPC1](INFO): Starting
2018-03-14T22:01:34.916Z,1521064894.916 [BPC1](INFO): Starting
2018-03-14T22:01:35.313Z,1521064895.313 [BPC1](INFO): Starting
2018-03-14T22:01:35.832Z,1521064895.832 [BPC1](INFO): Starting
2018-03-14T22:01:36.204Z,1521064896.204 [NAL9602](INFO): Powering up NAL9602
2018-03-14T22:01:36.230Z,1521064896.230 [BPC1](INFO): Starting
2018-03-14T22:01:36.629Z,1521064896.629 [BPC1](INFO): Starting
2018-03-14T22:01:37.029Z,1521064897.029 [BPC1](INFO): Starting
2018-03-14T22:01:37.429Z,1521064897.429 [BPC1](INFO): Starting
2018-03-14T22:01:37.828Z,1521064897.828 [BPC1](INFO): Starting
2018-03-14T22:01:38.228Z,1521064898.228 [BPC1](INFO): Starting
2018-03-14T22:01:38.628Z,1521064898.628 [BPC1](INFO): Starting
2018-03-14T22:01:39.032Z,1521064899.032 [BPC1](INFO): Starting
2018-03-14T22:01:39.435Z,1521064899.435 [BPC1](INFO): Starting
2018-03-14T22:01:39.841Z,1521064899.841 [BPC1](INFO): Starting
2018-03-14T22:01:40.227Z,1521064900.227 [BPC1](INFO): Starting
2018-03-14T22:01:40.628Z,1521064900.628 [BPC1](INFO): Starting
2018-03-14T22:01:41.037Z,1521064901.037 [BPC1](INFO): Starting
2018-03-14T22:01:41.437Z,1521064901.437 [BPC1](INFO): Starting
2018-03-14T22:01:41.831Z,1521064901.831 [BPC1](INFO): Starting
2018-03-14T22:01:42.229Z,1521064902.229 [BPC1](INFO): Starting
2018-03-14T22:01:42.630Z,1521064902.630 [BPC1](INFO): Starting
2018-03-14T22:01:43.025Z,1521064903.025 [BPC1](INFO): Starting
2018-03-14T22:01:43.432Z,1521064903.432 [BPC1](INFO): Starting
2018-03-14T22:01:43.835Z,1521064903.835 [BPC1](INFO): Starting
2018-03-14T22:01:44.232Z,1521064904.232 [BPC1](INFO): Starting
2018-03-14T22:01:44.633Z,1521064904.633 [BPC1](INFO): Starting
2018-03-14T22:01:44.743Z,1521064904.743 [CBIT](IMPORTANT): Ground fault detected
mA:
CHAN A0 (Batt): -0.001699
CHAN A1 (24V): 4.657929
CHAN A2 (12V): -0.002438
CHAN A3 (5V): -0.001539
CHAN B0 (3.3V): 0.000091
CHAN B1 (3.15aV): -0.000572
CHAN B2 (3.15bV): 0.000293
CHAN B3 (GND): 0.000053
OPEN: -0.000604
Full Scale Calc: 4.765 mA, -1.589 mA
2018-03-14T22:01:45.034Z,1521064905.034 [BPC1](INFO): Starting
2018-03-14T22:01:45.433Z,1521064905.433 [BPC1](INFO): Starting
2018-03-14T22:01:45.824Z,1521064905.824 [BPC1](INFO): Starting
2018-03-14T22:01:46.228Z,1521064906.228 [BPC1](INFO): Starting
2018-03-14T22:01:46.625Z,1521064906.625 [BPC1](INFO): Starting
2018-03-14T22:01:47.040Z,1521064907.040 [BPC1](INFO): Starting
2018-03-14T22:01:47.404Z,1521064907.404 [NAL9602](INFO): NAL9602 initialized
2018-03-14T22:01:47.429Z,1521064907.429 [BPC1](INFO): Starting
2018-03-14T22:01:47.866Z,1521064907.866 [BPC1](INFO): Starting
2018-03-14T22:01:48.247Z,1521064908.247 [BPC1](INFO): Starting
2018-03-14T22:01:48.661Z,1521064908.661 [BPC1](INFO): Starting
2018-03-14T22:01:49.396Z,1521064909.396 [BPC1](INFO): Starting
2018-03-14T22:01:49.723Z,1521064909.723 [BPC1](INFO): Starting
2018-03-14T22:01:50.125Z,1521064910.125 [BPC1](INFO): Starting
2018-03-14T22:01:50.527Z,1521064910.527 [BPC1](INFO): Starting
2018-03-14T22:01:50.943Z,1521064910.943 [BPC1](INFO): Starting
2018-03-14T22:01:51.324Z,1521064911.324 [BPC1](INFO): Starting
2018-03-14T22:01:51.725Z,1521064911.725 [BPC1](INFO): Starting
2018-03-14T22:01:52.124Z,1521064912.124 [BPC1](INFO): Starting
2018-03-14T22:01:52.517Z,1521064912.517 [BPC1](INFO): Starting
2018-03-14T22:01:52.925Z,1521064912.925 [BPC1](INFO): Starting
2018-03-14T22:01:53.328Z,1521064913.328 [BPC1](INFO): Starting
2018-03-14T22:01:53.739Z,1521064913.739 [BPC1](INFO): Starting
2018-03-14T22:01:54.117Z,1521064914.117 [BPC1](INFO): Starting
2018-03-14T22:01:54.529Z,1521064914.529 [BPC1](INFO): Starting
2018-03-14T22:01:54.924Z,1521064914.924 [BPC1](INFO): Starting
2018-03-14T22:01:55.331Z,1521064915.331 [BPC1](INFO): Starting
2018-03-14T22:01:55.736Z,1521064915.736 [BPC1](INFO): Starting
2018-03-14T22:01:56.137Z,1521064916.137 [BPC1](INFO): Starting
2018-03-14T22:01:56.536Z,1521064916.536 [BPC1](INFO): Starting
2018-03-14T22:01:56.937Z,1521064916.937 [BPC1](INFO): Starting
2018-03-14T22:01:57.313Z,1521064917.313 [BPC1](INFO): Starting
2018-03-14T22:01:57.723Z,1521064917.723 [BPC1](INFO): Starting
2018-03-14T22:01:58.124Z,1521064918.124 [BPC1](INFO): Starting
2018-03-14T22:01:58.523Z,1521064918.523 [BPC1](INFO): Starting
2018-03-14T22:01:58.923Z,1521064918.923 [BPC1](INFO): Starting
2018-03-14T22:01:59.312Z,1521064919.312 [BPC1](INFO): Starting
2018-03-14T22:01:59.731Z,1521064919.731 [BPC1](INFO): Starting
2018-03-14T22:02:00.115Z,1521064920.115 [BPC1](INFO): Starting
2018-03-14T22:02:00.547Z,1521064920.547 [BPC1](INFO): Starting
2018-03-14T22:02:00.927Z,1521064920.927 [BPC1](INFO): Starting
2018-03-14T22:02:01.324Z,1521064921.324 [BPC1](INFO): Starting
2018-03-14T22:02:01.748Z,1521064921.748 [BPC1](INFO): Starting
2018-03-14T22:02:02.119Z,1521064922.119 [BPC1](INFO): Starting
2018-03-14T22:02:02.520Z,1521064922.520 [BPC1](INFO): Starting
2018-03-14T22:02:02.923Z,1521064922.923 [BPC1](INFO): Starting
2018-03-14T22:02:03.325Z,1521064923.325 [BPC1](INFO): Starting
2018-03-14T22:02:03.723Z,1521064923.723 [BPC1](INFO): Starting
2018-03-14T22:02:04.132Z,1521064924.132 [BPC1](INFO): Starting
2018-03-14T22:02:04.511Z,1521064924.511 [BPC1](INFO): Starting
2018-03-14T22:02:04.915Z,1521064924.915 [BPC1](INFO): Starting
2018-03-14T22:02:05.325Z,1521064925.325 [BPC1](INFO): Starting
2018-03-14T22:02:05.727Z,1521064925.727 [BPC1](INFO): Starting
2018-03-14T22:02:06.124Z,1521064926.124 [BPC1](INFO): Starting
2018-03-14T22:02:06.530Z,1521064926.530 [BPC1](INFO): Starting
2018-03-14T22:02:06.934Z,1521064926.934 [BPC1](INFO): Starting
2018-03-14T22:02:07.325Z,1521064927.325 [BPC1](INFO): Starting
2018-03-14T22:02:07.725Z,1521064927.725 [BPC1](INFO): Starting
2018-03-14T22:02:08.114Z,1521064928.114 [BPC1](INFO): Starting
2018-03-14T22:02:08.513Z,1521064928.513 [BPC1](INFO): Starting
2018-03-14T22:02:08.908Z,1521064928.908 [BPC1](INFO): Starting
2018-03-14T22:02:09.311Z,1521064929.311 [BPC1](INFO): Starting
2018-03-14T22:02:09.719Z,1521064929.719 [BPC1](INFO): Starting
2018-03-14T22:02:10.120Z,1521064930.120 [BPC1](INFO): Starting
2018-03-14T22:02:10.520Z,1521064930.520 [BPC1](INFO): Starting
2018-03-14T22:02:10.924Z,1521064930.924 [BPC1](INFO): Starting
2018-03-14T22:02:10.924Z,1521064930.924 [BPC1](INFO): Initialized.
2018-03-14T22:02:11.322Z,1521064931.322 [BPC1](INFO): Runnable
2018-03-14T22:02:11.335Z,1521064931.335 [BPC1](INFO): Bank A: initialized.
2018-03-14T22:02:11.348Z,1521064931.348 [BPC1](INFO): Bank B: initialized.
2018-03-14T22:02:11.735Z,1521064931.735 [BPC1](INFO): Runnable
2018-03-14T22:02:12.133Z,1521064932.133 [BPC1](INFO): Runnable
2018-03-14T22:02:12.511Z,1521064932.511 [BPC1](INFO): Runnable
2018-03-14T22:02:12.914Z,1521064932.914 [BPC1](INFO): Runnable
2018-03-14T22:02:13.313Z,1521064933.313 [BPC1](INFO): Runnable
2018-03-14T22:02:13.313Z,1521064933.313 [BPC1](INFO): Bank A: sending IBPS break.
2018-03-14T22:02:13.313Z,1521064933.313 [BPC1](INFO): Bank B: sending IBPS break.
2018-03-14T22:02:13.709Z,1521064933.709 [BPC1](INFO): Runnable
2018-03-14T22:02:14.118Z,1521064934.118 [BPC1](INFO): Runnable
2018-03-14T22:02:14.525Z,1521064934.525 [BPC1](INFO): Runnable
2018-03-14T22:02:14.927Z,1521064934.927 [BPC1](INFO): Runnable
2018-03-14T22:02:15.320Z,1521064935.320 [BPC1](INFO): Runnable
2018-03-14T22:02:15.713Z,1521064935.713 [BPC1](INFO): Runnable
2018-03-14T22:02:16.259Z,1521064936.259 [BPC1](INFO): Runnable
2018-03-14T22:02:16.654Z,1521064936.654 [BPC1](INFO): Runnable
2018-03-14T22:02:17.057Z,1521064937.057 [BPC1](INFO): Runnable
2018-03-14T22:02:17.057Z,1521064937.057 [BPC1](INFO): Bank A valid message: 1824 bytes.
2018-03-14T22:02:17.065Z,1521064937.065 [BPC1](INFO): Bank A: data parsed.
2018-03-14T22:02:17.065Z,1521064937.065 [BPC1](INFO): Bank B valid message: 1824 bytes.
2018-03-14T22:02:17.072Z,1521064937.072 [BPC1](INFO): Bank B: data parsed.
2018-03-14T22:02:17.455Z,1521064937.455 [BPC1](INFO): Runnable
2018-03-14T22:02:17.468Z,1521064937.468 [BPC1](INFO): Bank A: initialized.
2018-03-14T22:02:17.483Z,1521064937.483 [BPC1](INFO): Bank B: initialized.
2018-03-14T22:02:17.836Z,1521064937.836 [BPC1](INFO): Runnable
2018-03-14T22:02:18.232Z,1521064938.232 [BPC1](INFO): Runnable
2018-03-14T22:02:18.641Z,1521064938.641 [BPC1](INFO): Runnable
2018-03-14T22:02:19.044Z,1521064939.044 [BPC1](INFO): Runnable
2018-03-14T22:02:19.441Z,1521064939.441 [BPC1](INFO): Runnable
2018-03-14T22:02:19.837Z,1521064939.837 [BPC1](INFO): Runnable
2018-03-14T22:02:20.244Z,1521064940.244 [BPC1](INFO): Runnable
2018-03-14T22:02:20.641Z,1521064940.641 [BPC1](INFO): Runnable
2018-03-14T22:02:21.043Z,1521064941.043 [BPC1](INFO): Runnable
2018-03-14T22:02:21.454Z,1521064941.454 [BPC1](INFO): Runnable
2018-03-14T22:02:21.851Z,1521064941.851 [BPC1](INFO): Runnable
2018-03-14T22:02:22.255Z,1521064942.255 [BPC1](INFO): Runnable
2018-03-14T22:02:22.654Z,1521064942.654 [BPC1](INFO): Runnable
2018-03-14T22:02:23.052Z,1521064943.052 [BPC1](INFO): Runnable
2018-03-14T22:02:23.437Z,1521064943.437 [BPC1](INFO): Runnable
2018-03-14T22:02:23.836Z,1521064943.836 [BPC1](INFO): Runnable
2018-03-14T22:02:24.236Z,1521064944.236 [BPC1](INFO): Runnable
2018-03-14T22:02:24.640Z,1521064944.640 [BPC1](INFO): Runnable
2018-03-14T22:02:24.640Z,1521064944.640 [BPC1](INFO): Bank A: sending IBPS break.
2018-03-14T22:02:25.040Z,1521064945.040 [BPC1](INFO): Runnable
2018-03-14T22:02:25.040Z,1521064945.040 [BPC1](INFO): Bank B: sending IBPS break.
2018-03-14T22:02:25.441Z,1521064945.441 [BPC1](INFO): Runnable
2018-03-14T22:02:25.847Z,1521064945.847 [BPC1](INFO): Runnable
2018-03-14T22:02:26.246Z,1521064946.246 [BPC1](INFO): Runnable
2018-03-14T22:02:26.646Z,1521064946.646 [BPC1](INFO): Runnable
2018-03-14T22:02:27.059Z,1521064947.059 [BPC1](INFO): Runnable
2018-03-14T22:02:27.457Z,1521064947.457 [BPC1](INFO): Runnable
2018-03-14T22:02:27.477Z,1521064947.477 [SBIT](IMPORTANT): SBIT PASSED
2018-03-14T22:02:27.860Z,1521064947.860 [BPC1](INFO): Runnable
2018-03-14T22:02:27.870Z,1521064947.870 [MissionManager](IMPORTANT): Started mission Startup
2018-03-14T22:02:27.871Z,1521064947.871 [Startup] Running Loop=1
2018-03-14T22:02:27.871Z,1521064947.871 [Startup](DEBUG): Aggregate::initialize Startup
2018-03-14T22:02:27.871Z,1521064947.871 [Startup:A.GoToSurface] Running Loop=1
2018-03-14T22:02:27.871Z,1521064947.871 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2018-03-14T22:02:27.872Z,1521064947.872 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2018-03-14T22:02:27.872Z,1521064947.872 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2018-03-14T22:02:27.872Z,1521064947.872 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2018-03-14T22:02:27.873Z,1521064947.873 [Startup:A.GoToSurface](DEBUG): No pitch timeout specified. Using default value of 30.000000 seconds.
2018-03-14T22:02:27.873Z,1521064947.873 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2018-03-14T22:02:27.879Z,1521064947.879 [Startup:StartupSatComms] Running Loop=1
2018-03-14T22:02:27.879Z,1521064947.879 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2018-03-14T22:02:27.879Z,1521064947.879 [Startup:StartupSatComms:A] Running Loop=1
2018-03-14T22:02:28.233Z,1521064948.233 [BPC1](INFO): Runnable
2018-03-14T22:02:28.279Z,1521064948.279 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2018-03-14T22:02:28.636Z,1521064948.636 [BPC1](INFO): Runnable
2018-03-14T22:02:29.040Z,1521064949.040 [BPC1](INFO): Runnable
2018-03-14T22:02:29.441Z,1521064949.441 [BPC1](INFO): Runnable
2018-03-14T22:02:29.442Z,1521064949.442 [BPC1](INFO): Bank A valid message: 1824 bytes.
2018-03-14T22:02:29.449Z,1521064949.449 [BPC1](INFO): Bank A: data parsed.
2018-03-14T22:02:29.449Z,1521064949.449 [BPC1](INFO): Bank B valid message: 1824 bytes.
2018-03-14T22:02:29.489Z,1521064949.489 [BPC1](INFO): Bank B: data parsed.
2018-03-14T22:02:29.844Z,1521064949.844 [BPC1](INFO): Runnable
2018-03-14T22:02:29.862Z,1521064949.862 [BPC1](INFO): Bank A: initialized.
2018-03-14T22:02:29.875Z,1521064949.875 [BPC1](INFO): Bank B: initialized.
2018-03-14T22:02:30.240Z,1521064950.240 [BPC1](INFO): Runnable
2018-03-14T22:02:30.640Z,1521064950.640 [BPC1](INFO): Runnable
2018-03-14T22:02:31.036Z,1521064951.036 [BPC1](INFO): Runnable
2018-03-14T22:02:31.435Z,1521064951.435 [BPC1](INFO): Runnable
2018-03-14T22:02:31.851Z,1521064951.851 [BPC1](INFO): Runnable
2018-03-14T22:02:32.251Z,1521064952.251 [BPC1](INFO): Runnable
2018-03-14T22:02:32.655Z,1521064952.655 [BPC1](INFO): Runnable
2018-03-14T22:02:33.058Z,1521064953.058 [BPC1](INFO): Runnable
2018-03-14T22:02:33.440Z,1521064953.440 [BPC1](INFO): Runnable
2018-03-14T22:02:33.845Z,1521064953.845 [BPC1](INFO): Runnable
2018-03-14T22:02:34.232Z,1521064954.232 [BPC1](INFO): Runnable
2018-03-14T22:02:34.632Z,1521064954.632 [BPC1](INFO): Runnable
2018-03-14T22:02:35.037Z,1521064955.037 [BPC1](INFO): Runnable
2018-03-14T22:02:35.435Z,1521064955.435 [BPC1](INFO): Runnable
2018-03-14T22:02:35.836Z,1521064955.836 [BPC1](INFO): Runnable
2018-03-14T22:02:36.236Z,1521064956.236 [BPC1](INFO): Runnable
2018-03-14T22:02:36.636Z,1521064956.636 [BPC1](INFO): Runnable
2018-03-14T22:02:37.056Z,1521064957.056 [BPC1](INFO): Runnable
2018-03-14T22:02:37.056Z,1521064957.056 [BPC1](INFO): Bank A: sending IBPS break.
2018-03-14T22:02:37.454Z,1521064957.454 [BPC1](INFO): Runnable
2018-03-14T22:02:37.454Z,1521064957.454 [BPC1](INFO): Bank B: sending IBPS break.
2018-03-14T22:02:37.867Z,1521064957.867 [BPC1](INFO): Runnable
2018-03-14T22:02:38.251Z,1521064958.251 [BPC1](INFO): Runnable
2018-03-14T22:02:38.639Z,1521064958.639 [BPC1](INFO): Runnable
2018-03-14T22:02:39.039Z,1521064959.039 [BPC1](INFO): Runnable
2018-03-14T22:02:39.443Z,1521064959.443 [BPC1](INFO): Runnable
2018-03-14T22:02:39.841Z,1521064959.841 [BPC1](INFO): Runnable
2018-03-14T22:02:40.241Z,1521064960.241 [BPC1](INFO): Runnable
2018-03-14T22:02:40.647Z,1521064960.647 [BPC1](INFO): Runnable
2018-03-14T22:02:41.035Z,1521064961.035 [BPC1](INFO): Runnable
2018-03-14T22:02:41.434Z,1521064961.434 [BPC1](INFO): Runnable
2018-03-14T22:02:41.836Z,1521064961.836 [BPC1](INFO): Runnable
2018-03-14T22:02:41.837Z,1521064961.837 [BPC1](INFO): Bank A valid message: 1824 bytes.
2018-03-14T22:02:41.856Z,1521064961.856 [BPC1](INFO): Bank A: data parsed.
2018-03-14T22:02:42.259Z,1521064962.259 [BPC1](INFO): Runnable
2018-03-14T22:02:42.271Z,1521064962.271 [BPC1](INFO): Bank A: initialized.
2018-03-14T22:02:42.271Z,1521064962.271 [BPC1](INFO): Bank B valid message: 1824 bytes.
2018-03-14T22:02:42.278Z,1521064962.278 [BPC1](INFO): Bank B: data parsed.
2018-03-14T22:02:42.668Z,1521064962.668 [BPC1](INFO): Runnable
2018-03-14T22:02:42.682Z,1521064962.682 [BPC1](INFO): Bank B: initialized.
2018-03-14T22:02:43.047Z,1521064963.047 [BPC1](INFO): Runnable
2018-03-14T22:02:43.450Z,1521064963.450 [BPC1](INFO): Runnable
2018-03-14T22:02:43.841Z,1521064963.841 [BPC1](INFO): Runnable
2018-03-14T22:02:44.243Z,1521064964.243 [BPC1](INFO): Runnable
2018-03-14T22:02:44.639Z,1521064964.639 [BPC1](INFO): Runnable
2018-03-14T22:02:45.048Z,1521064965.048 [BPC1](INFO): Runnable
2018-03-14T22:02:45.433Z,1521064965.433 [BPC1](INFO): Runnable
2018-03-14T22:02:45.832Z,1521064965.832 [BPC1](INFO): Runnable
2018-03-14T22:02:46.232Z,1521064966.232 [BPC1](INFO): Runnable
2018-03-14T22:02:46.632Z,1521064966.632 [BPC1](INFO): Runnable
2018-03-14T22:02:47.032Z,1521064967.032 [BPC1](INFO): Runnable
2018-03-14T22:02:47.462Z,1521064967.462 [BPC1](INFO): Runnable
2018-03-14T22:02:47.851Z,1521064967.851 [BPC1](INFO): Runnable
2018-03-14T22:02:48.246Z,1521064968.246 [BPC1](INFO): Runnable
2018-03-14T22:02:48.643Z,1521064968.643 [BPC1](INFO): Runnable
2018-03-14T22:02:49.032Z,1521064969.032 [BPC1](INFO): Runnable
2018-03-14T22:02:49.441Z,1521064969.441 [BPC1](INFO): Runnable
2018-03-14T22:02:49.840Z,1521064969.840 [BPC1](INFO): Runnable
2018-03-14T22:02:49.840Z,1521064969.840 [BPC1](INFO): Bank A: sending IBPS break.
2018-03-14T22:02:50.239Z,1521064970.239 [BPC1](INFO): Runnable
2018-03-14T22:02:50.239Z,1521064970.239 [BPC1](INFO): Bank B: sending IBPS break.
2018-03-14T22:02:50.641Z,1521064970.641 [BPC1](INFO): Runnable
2018-03-14T22:02:51.039Z,1521064971.039 [BPC1](INFO): Runnable
2018-03-14T22:02:51.443Z,1521064971.443 [BPC1](INFO): Runnable
2018-03-14T22:02:51.842Z,1521064971.842 [BPC1](INFO): Runnable
2018-03-14T22:02:52.241Z,1521064972.241 [BPC1](INFO): Runnable
2018-03-14T22:02:52.655Z,1521064972.655 [BPC1](INFO): Runnable
2018-03-14T22:02:53.055Z,1521064973.055 [BPC1](INFO): Runnable
2018-03-14T22:02:53.459Z,1521064973.459 [BPC1](INFO): Runnable
2018-03-14T22:02:53.843Z,1521064973.843 [BPC1](INFO): Runnable
2018-03-14T22:02:54.253Z,1521064974.253 [BPC1](INFO): Runnable
2018-03-14T22:02:54.253Z,1521064974.253 [BPC1](INFO): Bank A valid message: 1596 bytes.
2018-03-14T22:02:54.259Z,1521064974.259 [BPC1](INFO): Bank A: data parsed.
2018-03-14T22:02:54.259Z,1521064974.259 [BPC1](INFO): Bank B valid message: 1596 bytes.
2018-03-14T22:02:54.296Z,1521064974.296 [BPC1](INFO): Bank B: data parsed.
2018-03-14T22:02:54.636Z,1521064974.636 [BPC1](INFO): Runnable
2018-03-14T22:02:54.647Z,1521064974.647 [BPC1](INFO): Bank A: initialized.
2018-03-14T22:02:54.660Z,1521064974.660 [BPC1](INFO): Bank B: initialized.
2018-03-14T22:02:55.039Z,1521064975.039 [BPC1](INFO): Runnable
2018-03-14T22:02:55.446Z,1521064975.446 [BPC1](INFO): Runnable
2018-03-14T22:02:55.843Z,1521064975.843 [BPC1](INFO): Runnable
2018-03-14T22:02:56.240Z,1521064976.240 [BPC1](INFO): Runnable
2018-03-14T22:02:56.240Z,1521064976.240 [BPC1](INFO): Bank A: sending IBPS break.
2018-03-14T22:02:56.632Z,1521064976.632 [BPC1](INFO): Runnable
2018-03-14T22:02:56.633Z,1521064976.633 [BPC1](INFO): Bank B: sending IBPS break.
2018-03-14T22:02:57.032Z,1521064977.032 [BPC1](INFO): Runnable
2018-03-14T22:02:57.432Z,1521064977.432 [BPC1](INFO): Runnable
2018-03-14T22:02:57.846Z,1521064977.846 [BPC1](INFO): Runnable
2018-03-14T22:02:58.243Z,1521064978.243 [BPC1](INFO): Runnable
2018-03-14T22:02:58.651Z,1521064978.651 [BPC1](INFO): Runnable
2018-03-14T22:02:59.055Z,1521064979.055 [BPC1](INFO): Runnable
2018-03-14T22:02:59.441Z,1521064979.441 [BPC1](INFO): Runnable
2018-03-14T22:02:59.839Z,1521064979.839 [BPC1](INFO): Runnable
2018-03-14T22:02:59.840Z,1521064979.840 [BPC1](INFO): Bank A valid message: 1596 bytes.
2018-03-14T22:02:59.846Z,1521064979.846 [BPC1](INFO): Bank A: data parsed.
2018-03-14T22:02:59.846Z,1521064979.846 [BPC1](INFO): Bank B valid message: 1596 bytes.
2018-03-14T22:02:59.852Z,1521064979.852 [BPC1](INFO): Bank B: data parsed.
2018-03-14T22:02:59.852Z,1521064979.852 [BPC1](DEBUG): Received data from all battery sticks
2018-03-14T22:03:00.245Z,1521064980.245 [BPC1](INFO): Stop
2018-03-14T22:03:00.245Z,1521064980.245 [BPC1](INFO): uninitialize
2018-03-14T22:03:00.639Z,1521064980.639 [BPC1](INFO): Stopping
2018-03-14T22:03:01.040Z,1521064981.040 [BPC1](INFO): Stopped
2018-03-14T22:03:01.444Z,1521064981.444 [BPC1](INFO): Stopped
2018-03-14T22:03:01.832Z,1521064981.832 [BPC1](INFO): Stopped
2018-03-14T22:03:02.232Z,1521064982.232 [BPC1](INFO): Stopped
2018-03-14T22:03:02.632Z,1521064982.632 [BPC1](INFO): Stopped
2018-03-14T22:03:03.052Z,1521064983.052 [BPC1](INFO): Stopped
2018-03-14T22:03:03.450Z,1521064983.450 [BPC1](INFO): Stopped
2018-03-14T22:03:03.867Z,1521064983.867 [BPC1](INFO): Stopped
2018-03-14T22:03:04.247Z,1521064984.247 [BPC1](INFO): Stopped
2018-03-14T22:03:04.640Z,1521064984.640 [BPC1](INFO): Stopped
2018-03-14T22:03:05.032Z,1521064985.032 [BPC1](INFO): Stopped
2018-03-14T22:03:05.442Z,1521064985.442 [BPC1](INFO): Stopped
2018-03-14T22:03:05.840Z,1521064985.840 [BPC1](INFO): Stopped
2018-03-14T22:03:06.246Z,1521064986.246 [BPC1](INFO): Stopped
2018-03-14T22:03:06.643Z,1521064986.643 [BPC1](INFO): Stopped
2018-03-14T22:03:07.040Z,1521064987.040 [BPC1](INFO): Stopped
2018-03-14T22:03:07.451Z,1521064987.451 [BPC1](INFO): Stopped
2018-03-14T22:03:07.840Z,1521064987.840 [BPC1](INFO): Stopped
2018-03-14T22:03:08.254Z,1521064988.254 [BPC1](INFO): Stopped
2018-03-14T22:03:08.668Z,1521064988.668 [BPC1](INFO): Stopped
2018-03-14T22:03:09.055Z,1521064989.055 [BPC1](INFO): Stopped
2018-03-14T22:03:09.443Z,1521064989.443 [BPC1](INFO): Stopped
2018-03-14T22:03:09.840Z,1521064989.840 [BPC1](INFO): Stopped
2018-03-14T22:03:10.241Z,1521064990.241 [BPC1](INFO): Stopped
2018-03-14T22:03:10.646Z,1521064990.646 [BPC1](INFO): Stopped
2018-03-14T22:03:11.039Z,1521064991.039 [BPC1](INFO): Stopped
2018-03-14T22:03:11.439Z,1521064991.439 [BPC1](INFO): Stopped
2018-03-14T22:03:11.840Z,1521064991.840 [BPC1](INFO): Stopped
2018-03-14T22:03:12.241Z,1521064992.241 [BPC1](INFO): Stopped
2018-03-14T22:03:12.641Z,1521064992.641 [BPC1](INFO): Stopped
2018-03-14T22:03:13.045Z,1521064993.045 [BPC1](INFO): Stopped
2018-03-14T22:03:13.459Z,1521064993.459 [BPC1](INFO): Stopped
2018-03-14T22:03:13.854Z,1521064993.854 [BPC1](INFO): Stopped
2018-03-14T22:03:14.258Z,1521064994.258 [BPC1](INFO): Stopped
2018-03-14T22:03:14.656Z,1521064994.656 [BPC1](INFO): Stopped
2018-03-14T22:03:15.032Z,1521064995.032 [BPC1](INFO): Stopped
2018-03-14T22:03:15.437Z,1521064995.437 [BPC1](INFO): Stopped
2018-03-14T22:03:15.836Z,1521064995.836 [BPC1](INFO): Stopped
2018-03-14T22:03:16.236Z,1521064996.236 [BPC1](INFO): Stopped
2018-03-14T22:03:16.636Z,1521064996.636 [BPC1](INFO): Stopped
2018-03-14T22:03:17.037Z,1521064997.037 [BPC1](INFO): Stopped
2018-03-14T22:03:17.439Z,1521064997.439 [BPC1](INFO): Stopped
2018-03-14T22:03:17.842Z,1521064997.842 [BPC1](INFO): Stopped
2018-03-14T22:03:18.251Z,1521064998.251 [BPC1](INFO): Stopped
2018-03-14T22:03:18.663Z,1521064998.663 [BPC1](INFO): Stopped
2018-03-14T22:03:19.051Z,1521064999.051 [BPC1](INFO): Stopped
2018-03-14T22:03:19.455Z,1521064999.455 [BPC1](INFO): Stopped
2018-03-14T22:03:19.855Z,1521064999.855 [BPC1](INFO): Stopped
2018-03-14T22:03:20.237Z,1521065000.237 [BPC1](INFO): Stopped
2018-03-14T22:03:20.645Z,1521065000.645 [BPC1](INFO): Stopped
2018-03-14T22:03:21.041Z,1521065001.041 [BPC1](INFO): Stopped
2018-03-14T22:03:21.447Z,1521065001.447 [BPC1](INFO): Stopped
2018-03-14T22:03:21.840Z,1521065001.840 [BPC1](INFO): Stopped
2018-03-14T22:03:22.232Z,1521065002.232 [BPC1](INFO): Stopped
2018-03-14T22:03:22.651Z,1521065002.651 [BPC1](INFO): Stopped
2018-03-14T22:03:23.037Z,1521065003.037 [BPC1](INFO): Stopped
2018-03-14T22:03:23.436Z,1521065003.436 [BPC1](INFO): Stopped
2018-03-14T22:03:23.871Z,1521065003.871 [BPC1](INFO): Stopped
2018-03-14T22:03:24.247Z,1521065004.247 [BPC1](INFO): Stopped
2018-03-14T22:03:24.647Z,1521065004.647 [BPC1](INFO): Stopped
2018-03-14T22:03:25.048Z,1521065005.048 [BPC1](INFO): Stopped
2018-03-14T22:03:25.459Z,1521065005.459 [BPC1](INFO): Stopped
2018-03-14T22:03:25.848Z,1521065005.848 [BPC1](INFO): Stopped
2018-03-14T22:03:26.247Z,1521065006.247 [BPC1](INFO): Stopped
2018-03-14T22:03:26.647Z,1521065006.647 [BPC1](INFO): Stopped
2018-03-14T22:03:27.032Z,1521065007.032 [BPC1](INFO): Stopped
2018-03-14T22:03:27.432Z,1521065007.432 [BPC1](INFO): Stopped
2018-03-14T22:03:27.832Z,1521065007.832 [BPC1](INFO): Stopped
2018-03-14T22:03:28.241Z,1521065008.241 [BPC1](INFO): Stopped
2018-03-14T22:03:28.279Z,1521065008.279 [Startup:StartupSatComms:A](INFO): Timed out from 2018-03-14T22:02:27.9Z
2018-03-14T22:03:28.279Z,1521065008.279 [Startup:StartupSatComms:A] Stopped
2018-03-14T22:03:28.279Z,1521065008.279 [Startup:StartupSatComms:B] Running Loop=1
2018-03-14T22:03:28.644Z,1521065008.644 [BPC1](INFO): Stopped
2018-03-14T22:03:28.696Z,1521065008.696 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2018-03-14T22:03:29.056Z,1521065009.056 [BPC1](INFO): Stopped
2018-03-14T22:03:29.300Z,1521065009.300 [CommandLine](IMPORTANT): got command report touch BPC1.platform_battery_voltage volt
2018-03-14T22:03:29.463Z,1521065009.463 [BPC1](INFO): Stopped
2018-03-14T22:03:29.860Z,1521065009.860 [BPC1](INFO): Stopped
2018-03-14T22:03:30.242Z,1521065010.242 [BPC1](INFO): Stopped
2018-03-14T22:03:30.632Z,1521065010.632 [BPC1](INFO): Stopped
2018-03-14T22:03:31.032Z,1521065011.032 [BPC1](INFO): Stopped
2018-03-14T22:03:31.436Z,1521065011.436 [BPC1](INFO): Stopped
2018-03-14T22:03:31.852Z,1521065011.852 [BPC1](INFO): Stopped
2018-03-14T22:03:32.238Z,1521065012.238 [BPC1](INFO): Stopped
2018-03-14T22:03:32.641Z,1521065012.641 [BPC1](INFO): Stopped
2018-03-14T22:03:33.039Z,1521065013.039 [BPC1](INFO): Stopped
2018-03-14T22:03:33.440Z,1521065013.440 [BPC1](INFO): Stopped
2018-03-14T22:03:33.840Z,1521065013.840 [BPC1](INFO): Stopped
2018-03-14T22:03:34.258Z,1521065014.258 [BPC1](INFO): Stopped
2018-03-14T22:03:34.652Z,1521065014.652 [BPC1](INFO): Stopped
2018-03-14T22:03:35.055Z,1521065015.055 [BPC1](INFO): Stopped
2018-03-14T22:03:35.455Z,1521065015.455 [BPC1](INFO): Stopped
2018-03-14T22:03:35.836Z,1521065015.836 [BPC1](INFO): Stopped
2018-03-14T22:03:36.232Z,1521065016.232 [BPC1](INFO): Stopped
2018-03-14T22:03:36.637Z,1521065016.637 [BPC1](INFO): Stopped
2018-03-14T22:03:37.032Z,1521065017.032 [BPC1](INFO): Stopped
2018-03-14T22:03:37.432Z,1521065017.432 [BPC1](INFO): Stopped
2018-03-14T22:03:37.836Z,1521065017.836 [BPC1](INFO): Stopped
2018-03-14T22:03:38.242Z,1521065018.242 [BPC1](INFO): Stopped
2018-03-14T22:03:38.643Z,1521065018.643 [BPC1](INFO): Stopped
2018-03-14T22:03:39.043Z,1521065019.043 [BPC1](INFO): Stopped
2018-03-14T22:03:39.450Z,1521065019.450 [BPC1](INFO): Stopped
2018-03-14T22:03:39.854Z,1521065019.854 [BPC1](INFO): Stopped
2018-03-14T22:03:40.253Z,1521065020.253 [BPC1](INFO): Stopped
2018-03-14T22:03:40.654Z,1521065020.654 [BPC1](INFO): Stopped
2018-03-14T22:03:41.043Z,1521065021.043 [BPC1](INFO): Stopped
2018-03-14T22:03:41.445Z,1521065021.445 [BPC1](INFO): Stopped
2018-03-14T22:03:41.845Z,1521065021.845 [BPC1](INFO): Stopped
2018-03-14T22:03:42.247Z,1521065022.247 [BPC1](INFO): Stopped
2018-03-14T22:03:42.640Z,1521065022.640 [BPC1](INFO): Stopped
2018-03-14T22:03:43.045Z,1521065023.045 [BPC1](INFO): Stopped
2018-03-14T22:03:43.454Z,1521065023.454 [BPC1](INFO): Stopped
2018-03-14T22:03:43.833Z,1521065023.833 [BPC1](INFO): Stopped
2018-03-14T22:03:44.232Z,1521065024.232 [BPC1](INFO): Stopped
2018-03-14T22:03:44.655Z,1521065024.655 [BPC1](INFO): Stopped
2018-03-14T22:03:45.059Z,1521065025.059 [BPC1](INFO): Stopped
2018-03-14T22:03:45.454Z,1521065025.454 [BPC1](INFO): Stopped
2018-03-14T22:03:45.846Z,1521065025.846 [BPC1](INFO): Stopped
2018-03-14T22:03:46.238Z,1521065026.238 [BPC1](INFO): Stopped
2018-03-14T22:03:46.640Z,1521065026.640 [BPC1](INFO): Stopped
2018-03-14T22:03:47.040Z,1521065027.040 [BPC1](INFO): Stopped
2018-03-14T22:03:47.440Z,1521065027.440 [BPC1](INFO): Stopped
2018-03-14T22:03:47.839Z,1521065027.839 [BPC1](INFO): Stopped
2018-03-14T22:03:48.241Z,1521065028.241 [BPC1](INFO): Stopped
2018-03-14T22:03:48.639Z,1521065028.639 [BPC1](INFO): Stopped
2018-03-14T22:03:49.040Z,1521065029.040 [BPC1](INFO): Stopped
2018-03-14T22:03:49.445Z,1521065029.445 [BPC1](INFO): Stopped
2018-03-14T22:03:49.854Z,1521065029.854 [BPC1](INFO): Stopped
2018-03-14T22:03:50.255Z,1521065030.255 [BPC1](INFO): Stopped
2018-03-14T22:03:50.655Z,1521065030.655 [BPC1](INFO): Stopped
2018-03-14T22:03:51.055Z,1521065031.055 [BPC1](INFO): Stopped
2018-03-14T22:03:51.438Z,1521065031.438 [BPC1](INFO): Stopped
2018-03-14T22:03:51.840Z,1521065031.840 [BPC1](INFO): Stopped
2018-03-14T22:03:52.246Z,1521065032.246 [BPC1](INFO): Stopped
2018-03-14T22:03:52.640Z,1521065032.640 [BPC1](INFO): Stopped
2018-03-14T22:03:53.043Z,1521065033.043 [BPC1](INFO): Stopped
2018-03-14T22:03:53.441Z,1521065033.441 [BPC1](INFO): Stopped
2018-03-14T22:03:53.840Z,1521065033.840 [BPC1](INFO): Stopped
2018-03-14T22:03:54.232Z,1521065034.232 [BPC1](INFO): Stopped
2018-03-14T22:03:54.637Z,1521065034.637 [BPC1](INFO): Stopped
2018-03-14T22:03:55.056Z,1521065035.056 [BPC1](INFO): Stopped
2018-03-14T22:03:55.454Z,1521065035.454 [BPC1](INFO): Stopped
2018-03-14T22:03:55.855Z,1521065035.855 [BPC1](INFO): Stopped
2018-03-14T22:03:56.251Z,1521065036.251 [BPC1](INFO): Stopped
2018-03-14T22:03:56.641Z,1521065036.641 [BPC1](INFO): Stopped
2018-03-14T22:03:57.043Z,1521065037.043 [BPC1](INFO): Stopped
2018-03-14T22:03:57.443Z,1521065037.443 [BPC1](INFO): Stopped
2018-03-14T22:03:57.847Z,1521065037.847 [BPC1](INFO): Stopped
2018-03-14T22:03:58.243Z,1521065038.243 [BPC1](INFO): Stopped
2018-03-14T22:03:58.642Z,1521065038.642 [BPC1](INFO): Stopped
2018-03-14T22:03:59.045Z,1521065039.045 [BPC1](INFO): Stopped
2018-03-14T22:03:59.445Z,1521065039.445 [BPC1](INFO): Stopped
2018-03-14T22:03:59.832Z,1521065039.832 [BPC1](INFO): Stopped
2018-03-14T22:04:00.255Z,1521065040.255 [BPC1](INFO): Stopped
2018-03-14T22:04:00.667Z,1521065040.667 [BPC1](INFO): Stopped
2018-03-14T22:04:01.054Z,1521065041.054 [BPC1](INFO): Stopped
2018-03-14T22:04:01.447Z,1521065041.447 [BPC1](INFO): Stopped
2018-03-14T22:04:01.844Z,1521065041.844 [BPC1](INFO): Stopped
2018-03-14T22:04:02.244Z,1521065042.244 [BPC1](INFO): Stopped
2018-03-14T22:04:02.648Z,1521065042.648 [BPC1](INFO): Stopped
2018-03-14T22:04:03.043Z,1521065043.043 [BPC1](INFO): Stopped
2018-03-14T22:04:03.441Z,1521065043.441 [BPC1](INFO): Stopped
2018-03-14T22:04:03.844Z,1521065043.844 [BPC1](INFO): Stopped
2018-03-14T22:04:04.240Z,1521065044.240 [BPC1](INFO): Stopped
2018-03-14T22:04:04.642Z,1521065044.642 [BPC1](INFO): Stopped
2018-03-14T22:04:05.054Z,1521065045.054 [BPC1](INFO): Stopped
2018-03-14T22:04:05.459Z,1521065045.459 [BPC1](INFO): Stopped
2018-03-14T22:04:05.843Z,1521065045.843 [BPC1](INFO): Stopped
2018-03-14T22:04:06.265Z,1521065046.265 [BPC1](INFO): Stopped
2018-03-14T22:04:06.647Z,1521065046.647 [BPC1](INFO): Stopped
2018-03-14T22:04:07.038Z,1521065047.038 [BPC1](INFO): Stopped
2018-03-14T22:04:07.440Z,1521065047.440 [BPC1](INFO): Stopped
2018-03-14T22:04:07.839Z,1521065047.839 [BPC1](INFO): Stopped
2018-03-14T22:04:08.241Z,1521065048.241 [BPC1](INFO): Stopped
2018-03-14T22:04:08.645Z,1521065048.645 [BPC1](INFO): Stopped
2018-03-14T22:04:09.040Z,1521065049.040 [BPC1](INFO): Stopped
2018-03-14T22:04:09.440Z,1521065049.440 [BPC1](INFO): Stopped
2018-03-14T22:04:09.832Z,1521065049.832 [BPC1](INFO): Stopped
2018-03-14T22:04:10.245Z,1521065050.245 [BPC1](INFO): Stopped
2018-03-14T22:04:10.257Z,1521065050.257 [DeadReckonUsingSpeedCalculator](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2018-03-14T22:04:10.257Z,1521065050.257 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 1
2018-03-14T22:04:10.257Z,1521065050.257 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2018-03-14T22:04:10.263Z,1521065050.263 [DeadReckonWithRespectToSeafloor](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2018-03-14T22:04:10.263Z,1521065050.263 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1
2018-03-14T22:04:10.264Z,1521065050.264 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2018-03-14T22:04:10.292Z,1521065050.292 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2018-03-14T22:04:10.292Z,1521065050.292 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2018-03-14T22:04:10.651Z,1521065050.651 [BPC1](INFO): Stopped
2018-03-14T22:04:10.720Z,1521065050.720 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2018-03-14T22:04:10.720Z,1521065050.720 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 1
2018-03-14T22:04:10.720Z,1521065050.720 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2018-03-14T22:04:10.720Z,1521065050.720 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1
2018-03-14T22:04:11.063Z,1521065051.063 [BPC1](INFO): Stopped
2018-03-14T22:04:11.104Z,1521065051.104 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2018-03-14T22:04:11.105Z,1521065051.105 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2018-03-14T22:04:11.105Z,1521065051.105 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2018-03-14T22:04:11.105Z,1521065051.105 [DeadReckonWithRespectToSeafloor](DEBUG): Initializing DeadReckonWithRespectToSeafloor component.
2018-03-14T22:04:11.106Z,1521065051.106 [DeadReckonWithRespectToSeafloor](INFO): Will consider orientation measurement stale after 120s.
2018-03-14T22:04:11.106Z,1521065051.106 [DeadReckonWithRespectToSeafloor](INFO): Will consider velocity measurement stale after 20s.
2018-03-14T22:04:14.152Z,1521065054.152 [BPC1](INFO): Stopped
2018-03-14T22:04:14.303Z,1521065054.303 [BPC1](INFO): Stopped
2018-03-14T22:04:14.620Z,1521065054.620 [BPC1](INFO): Stopped
2018-03-14T22:04:14.994Z,1521065054.994 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.003721
2018-03-14T22:04:15.022Z,1521065055.022 [BPC1](INFO): Stopped
2018-03-14T22:04:15.554Z,1521065055.554 [BPC1](INFO): Stopped
2018-03-14T22:04:15.852Z,1521065055.852 [BPC1](INFO): Stopped
2018-03-14T22:04:18.923Z,1521065058.923 [BPC1](INFO): Stopped
2018-03-14T22:04:18.988Z,1521065058.988 [DataOverHttps](INFO): Sending 25 bytes from file Logs/20180314T215042/Courier0008.lzma
2018-03-14T22:04:19.083Z,1521065059.083 [BPC1](INFO): Stopped
2018-03-14T22:04:19.437Z,1521065059.437 [BPC1](INFO): Stopped
2018-03-14T22:04:19.779Z,1521065059.779 [DataOverHttps](INFO): Moved sent file to Logs/20180314T215042/Courier0008.lzma.bak
2018-03-14T22:04:19.779Z,1521065059.779 [DataOverHttps](INFO): SBD MOMSN=8061562
2018-03-14T22:04:19.831Z,1521065059.831 [BPC1](INFO): Stopped
2018-03-14T22:04:20.336Z,1521065060.336 [BPC1](INFO): Stopped
2018-03-14T22:04:20.622Z,1521065060.622 [BPC1](INFO): Stopped
2018-03-14T22:04:23.893Z,1521065063.893 [BPC1](INFO): Stopped
2018-03-14T22:04:24.039Z,1521065064.039 [BPC1](INFO): Stopped
2018-03-14T22:04:24.407Z,1521065064.407 [BPC1](INFO): Stopped
2018-03-14T22:04:24.802Z,1521065064.802 [BPC1](INFO): Stopped
2018-03-14T22:04:25.195Z,1521065065.195 [BPC1](INFO): Stopped
2018-03-14T22:04:25.591Z,1521065065.591 [BPC1](INFO): Stopped
2018-03-14T22:04:28.699Z,1521065068.699 [BPC1](INFO): Stopped
2018-03-14T22:04:28.715Z,1521065068.715 [Startup:StartupSatComms:B](INFO): Timed out from 2018-03-14T22:03:28.3Z
2018-03-14T22:04:28.715Z,1521065068.715 [Startup:StartupSatComms:B] Stopped
2018-03-14T22:04:28.715Z,1521065068.715 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2018-03-14T22:04:28.715Z,1521065068.715 [Startup:StartupSatComms] Stopped
2018-03-14T22:04:28.715Z,1521065068.715 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2018-03-14T22:04:28.716Z,1521065068.716 [Startup](INFO): Completed Startup
2018-03-14T22:04:28.716Z,1521065068.716 [MissionManager](INFO): Startup is completed.
2018-03-14T22:04:28.716Z,1521065068.716 [MissionManager](INFO): Uninitializing Mission Startup
2018-03-14T22:04:28.716Z,1521065068.716 [Startup] Stopped
2018-03-14T22:04:28.716Z,1521065068.716 [Startup](DEBUG): Aggregate::uninitialize Startup
2018-03-14T22:04:28.716Z,1521065068.716 [Startup:A.GoToSurface] Stopped
2018-03-14T22:04:28.716Z,1521065068.716 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2018-03-14T22:04:28.778Z,1521065068.778 [DataOverHttps](INFO): Sending 195 bytes from file Logs/20180314T220100/Courier0000.lzma
2018-03-14T22:04:28.847Z,1521065068.847 [BPC1](INFO): Stopped
2018-03-14T22:04:28.893Z,1521065068.893 [MissionManager](IMPORTANT): Started mission Default
2018-03-14T22:04:28.893Z,1521065068.893 [Default] Running Loop=1
2018-03-14T22:04:28.894Z,1521065068.894 [Default](DEBUG): Aggregate::initialize Default
2018-03-14T22:04:28.894Z,1521065068.894 [Default:B.GoToSurface] Running Loop=1
2018-03-14T22:04:28.894Z,1521065068.894 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2018-03-14T22:04:28.897Z,1521065068.897 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2018-03-14T22:04:28.898Z,1521065068.898 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2018-03-14T22:04:28.898Z,1521065068.898 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2018-03-14T22:04:28.911Z,1521065068.911 [Default:B.GoToSurface](DEBUG): No pitch timeout specified. Using default value of 30.000000 seconds.
2018-03-14T22:04:28.911Z,1521065068.911 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2018-03-14T22:04:28.911Z,1521065068.911 [Default:A.Wait] Running Loop=1
2018-03-14T22:04:28.911Z,1521065068.911 [Default:A.Wait](DEBUG): Initialize Wait Component.
2018-03-14T22:04:29.186Z,1521065069.186 [BPC1](INFO): Stopped
2018-03-14T22:04:29.535Z,1521065069.535 [DataOverHttps](INFO): Moved sent file to Logs/20180314T220100/Courier0000.lzma.bak
2018-03-14T22:04:29.535Z,1521065069.535 [DataOverHttps](INFO): SBD MOMSN=8061564
2018-03-14T22:04:29.601Z,1521065069.601 [BPC1](INFO): Stopped
2018-03-14T22:04:29.964Z,1521065069.964 [BPC1](INFO): Stopped
2018-03-14T22:04:30.369Z,1521065070.369 [BPC1](INFO): Stopped
2018-03-14T22:04:33.753Z,1521065073.753 [BPC1](INFO): Stopped
2018-03-14T22:04:33.907Z,1521065073.907 [BPC1](INFO): Stopped
2018-03-14T22:04:34.230Z,1521065074.230 [BPC1](INFO): Stopped
2018-03-14T22:04:34.623Z,1521065074.623 [BPC1](INFO): Stopped
2018-03-14T22:04:35.011Z,1521065075.011 [BPC1](INFO): Stopped
2018-03-14T22:04:35.404Z,1521065075.404 [BPC1](INFO): Stopped
2018-03-14T22:04:35.817Z,1521065075.817 [BPC1](INFO): Stopped
2018-03-14T22:04:36.205Z,1521065076.205 [BPC1](INFO): Stopped
2018-03-14T22:04:36.604Z,1521065076.604 [BPC1](INFO): Stopped
2018-03-14T22:04:37.009Z,1521065077.009 [BPC1](INFO): Stopped
2018-03-14T22:04:37.413Z,1521065077.413 [BPC1](INFO): Stopped
2018-03-14T22:04:37.861Z,1521065077.861 [BPC1](INFO): Stopped
2018-03-14T22:04:38.214Z,1521065078.214 [BPC1](INFO): Stopped
2018-03-14T22:04:38.619Z,1521065078.619 [BPC1](INFO): Stopped
2018-03-14T22:04:39.015Z,1521065079.015 [BPC1](INFO): Stopped
2018-03-14T22:04:39.429Z,1521065079.429 [BPC1](INFO): Stopped
2018-03-14T22:04:39.824Z,1521065079.824 [BPC1](INFO): Stopped
2018-03-14T22:04:40.204Z,1521065080.204 [BPC1](INFO): Stopped
2018-03-14T22:04:40.611Z,1521065080.611 [BPC1](INFO): Stopped
2018-03-14T22:04:41.009Z,1521065081.009 [BPC1](INFO): Stopped
2018-03-14T22:04:41.410Z,1521065081.410 [BPC1](INFO): Stopped
2018-03-14T22:04:41.812Z,1521065081.812 [BPC1](INFO): Stopped
2018-03-14T22:04:42.215Z,1521065082.215 [BPC1](INFO): Stopped
2018-03-14T22:04:42.263Z,1521065082.263 [Default:A.Wait](INFO): Done Waiting.
2018-03-14T22:04:42.263Z,1521065082.263 [Default:A.Wait] Stopped
2018-03-14T22:04:42.263Z,1521065082.263 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2018-03-14T22:04:42.608Z,1521065082.608 [BPC1](INFO): Stopped
2018-03-14T22:04:42.672Z,1521065082.672 [Default:CheckIn] Running Loop=1
2018-03-14T22:04:42.672Z,1521065082.672 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2018-03-14T22:04:42.672Z,1521065082.672 [Default:CheckIn:Read_GPS] Running Loop=1
2018-03-14T22:04:43.005Z,1521065083.005 [BPC1](INFO): Stopped
2018-03-14T22:04:43.051Z,1521065083.051 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2018-03-14T22:04:43.404Z,1521065083.404 [BPC1](INFO): Stopped
2018-03-14T22:04:43.818Z,1521065083.818 [BPC1](INFO): Stopped
2018-03-14T22:04:44.234Z,1521065084.234 [BPC1](INFO): Stopped
2018-03-14T22:04:44.623Z,1521065084.623 [BPC1](INFO): Stopped
2018-03-14T22:04:45.022Z,1521065085.022 [BPC1](INFO): Stopped
2018-03-14T22:04:45.413Z,1521065085.413 [BPC1](INFO): Stopped
2018-03-14T22:04:45.815Z,1521065085.815 [BPC1](INFO): Stopped
2018-03-14T22:04:46.215Z,1521065086.215 [BPC1](INFO): Stopped
2018-03-14T22:04:46.616Z,1521065086.616 [BPC1](INFO): Stopped
2018-03-14T22:04:47.012Z,1521065087.012 [BPC1](INFO): Stopped
2018-03-14T22:04:47.404Z,1521065087.404 [BPC1](INFO): Stopped
2018-03-14T22:04:47.815Z,1521065087.815 [BPC1](INFO): Stopped
2018-03-14T22:04:48.204Z,1521065088.204 [BPC1](INFO): Stopped
2018-03-14T22:04:48.604Z,1521065088.604 [BPC1](INFO): Stopped
2018-03-14T22:04:49.031Z,1521065089.031 [BPC1](INFO): Stopped
2018-03-14T22:04:49.423Z,1521065089.423 [BPC1](INFO): Stopped
2018-03-14T22:04:49.827Z,1521065089.827 [BPC1](INFO): Stopped
2018-03-14T22:04:50.230Z,1521065090.230 [BPC1](INFO): Stopped
2018-03-14T22:04:50.605Z,1521065090.605 [BPC1](INFO): Stopped
2018-03-14T22:04:51.011Z,1521065091.011 [BPC1](INFO): Stopped
2018-03-14T22:04:51.412Z,1521065091.412 [BPC1](INFO): Stopped
2018-03-14T22:04:51.811Z,1521065091.811 [BPC1](INFO): Stopped
2018-03-14T22:04:52.207Z,1521065092.207 [BPC1](INFO): Stopped
2018-03-14T22:04:52.604Z,1521065092.604 [BPC1](INFO): Stopped
2018-03-14T22:04:53.004Z,1521065093.004 [BPC1](INFO): Stopped
2018-03-14T22:04:53.408Z,1521065093.408 [BPC1](INFO): Stopped
2018-03-14T22:04:53.806Z,1521065093.806 [BPC1](INFO): Stopped
2018-03-14T22:04:54.217Z,1521065094.217 [BPC1](INFO): Stopped
2018-03-14T22:04:54.618Z,1521065094.618 [BPC1](INFO): Stopped
2018-03-14T22:04:55.022Z,1521065095.022 [BPC1](INFO): Stopped
2018-03-14T22:04:55.419Z,1521065095.419 [BPC1](INFO): Stopped
2018-03-14T22:04:55.811Z,1521065095.811 [BPC1](INFO): Stopped
2018-03-14T22:04:56.213Z,1521065096.213 [BPC1](INFO): Stopped
2018-03-14T22:04:56.615Z,1521065096.615 [BPC1](INFO): Stopped
2018-03-14T22:04:57.015Z,1521065097.015 [BPC1](INFO): Stopped
2018-03-14T22:04:57.415Z,1521065097.415 [BPC1](INFO): Stopped
2018-03-14T22:04:57.808Z,1521065097.808 [BPC1](INFO): Stopped
2018-03-14T22:04:58.204Z,1521065098.204 [BPC1](INFO): Stopped
2018-03-14T22:04:58.612Z,1521065098.612 [BPC1](INFO): Stopped
2018-03-14T22:04:59.008Z,1521065099.008 [BPC1](INFO): Stopped
2018-03-14T22:04:59.429Z,1521065099.429 [BPC1](INFO): Stopped
2018-03-14T22:04:59.620Z,1521065099.620 [CommandLine](IMPORTANT): got command configSet IBIT.batteryHibernationTimeout 3.000000 minute persist
2018-03-14T22:04:59.826Z,1521065099.826 [BPC1](INFO): Stopped
2018-03-14T22:05:00.235Z,1521065100.235 [BPC1](INFO): Stopped
2018-03-14T22:05:00.623Z,1521065100.623 [BPC1](INFO): Stopped
2018-03-14T22:05:01.004Z,1521065101.004 [BPC1](INFO): Stopped
2018-03-14T22:05:01.404Z,1521065101.404 [BPC1](INFO): Stopped
2018-03-14T22:05:01.804Z,1521065101.804 [BPC1](INFO): Stopped
2018-03-14T22:05:02.215Z,1521065102.215 [BPC1](INFO): Stopped
2018-03-14T22:05:02.612Z,1521065102.612 [BPC1](INFO): Stopped
2018-03-14T22:05:03.013Z,1521065103.013 [BPC1](INFO): Stopped
2018-03-14T22:05:03.413Z,1521065103.413 [BPC1](INFO): Stopped
2018-03-14T22:05:03.815Z,1521065103.815 [BPC1](INFO): Stopped
2018-03-14T22:05:04.212Z,1521065104.212 [BPC1](INFO): Stopped
2018-03-14T22:05:04.628Z,1521065104.628 [BPC1](INFO): Stopped
2018-03-14T22:05:05.023Z,1521065105.023 [BPC1](INFO): Stopped
2018-03-14T22:05:05.428Z,1521065105.428 [BPC1](INFO): Stopped
2018-03-14T22:05:05.828Z,1521065105.828 [BPC1](INFO): Stopped
2018-03-14T22:05:06.205Z,1521065106.205 [BPC1](INFO): Stopped
2018-03-14T22:05:06.605Z,1521065106.605 [BPC1](INFO): Stopped
2018-03-14T22:05:07.004Z,1521065107.004 [BPC1](INFO): Stopped
2018-03-14T22:05:07.409Z,1521065107.409 [BPC1](INFO): Stopped
2018-03-14T22:05:07.809Z,1521065107.809 [BPC1](INFO): Stopped
2018-03-14T22:05:08.208Z,1521065108.208 [BPC1](INFO): Stopped
2018-03-14T22:05:08.617Z,1521065108.617 [BPC1](INFO): Stopped
2018-03-14T22:05:09.012Z,1521065109.012 [BPC1](INFO): Stopped
2018-03-14T22:05:09.411Z,1521065109.411 [BPC1](INFO): Stopped
2018-03-14T22:05:09.820Z,1521065109.820 [BPC1](INFO): Stopped
2018-03-14T22:05:10.223Z,1521065110.223 [BPC1](INFO): Stopped
2018-03-14T22:05:10.627Z,1521065110.627 [BPC1](INFO): Stopped
2018-03-14T22:05:11.023Z,1521065111.023 [BPC1](INFO): Stopped
2018-03-14T22:05:11.420Z,1521065111.420 [BPC1](INFO): Stopped
2018-03-14T22:05:11.804Z,1521065111.804 [BPC1](INFO): Stopped
2018-03-14T22:05:12.204Z,1521065112.204 [BPC1](INFO): Stopped
2018-03-14T22:05:12.616Z,1521065112.616 [BPC1](INFO): Stopped
2018-03-14T22:05:13.012Z,1521065113.012 [BPC1](INFO): Stopped
2018-03-14T22:05:13.420Z,1521065113.420 [BPC1](INFO): Stopped
2018-03-14T22:05:13.823Z,1521065113.823 [BPC1](INFO): Stopped
2018-03-14T22:05:14.223Z,1521065114.223 [BPC1](INFO): Stopped
2018-03-14T22:05:14.618Z,1521065114.618 [BPC1](INFO): Stopped
2018-03-14T22:05:15.040Z,1521065115.040 [BPC1](INFO): Stopped
2018-03-14T22:05:15.450Z,1521065115.450 [BPC1](INFO): Stopped
2018-03-14T22:05:15.827Z,1521065115.827 [BPC1](INFO): Stopped
2018-03-14T22:05:16.215Z,1521065116.215 [BPC1](INFO): Stopped
2018-03-14T22:05:16.611Z,1521065116.611 [BPC1](INFO): Stopped
2018-03-14T22:05:17.023Z,1521065117.023 [BPC1](INFO): Stopped
2018-03-14T22:05:17.435Z,1521065117.435 [BPC1](INFO): Stopped
2018-03-14T22:05:17.812Z,1521065117.812 [BPC1](INFO): Stopped
2018-03-14T22:05:18.213Z,1521065118.213 [BPC1](INFO): Stopped
2018-03-14T22:05:18.617Z,1521065118.617 [BPC1](INFO): Stopped
2018-03-14T22:05:19.013Z,1521065119.013 [BPC1](INFO): Stopped
2018-03-14T22:05:19.411Z,1521065119.411 [BPC1](INFO): Stopped
2018-03-14T22:05:19.815Z,1521065119.815 [BPC1](INFO): Stopped
2018-03-14T22:05:19.891Z,1521065119.891 [CommandLine](IMPORTANT): got command get BPC1.platform_battery_voltage
2018-03-14T22:05:19.892Z,1521065119.892 [CommandLine](IMPORTANT): BPC1.platform_battery_voltage 15.048387 _
2018-03-14T22:05:20.228Z,1521065120.228 [BPC1](INFO): Stopped
2018-03-14T22:05:20.623Z,1521065120.623 [BPC1](INFO): Stopped
2018-03-14T22:05:21.028Z,1521065121.028 [BPC1](INFO): Stopped
2018-03-14T22:05:21.432Z,1521065121.432 [BPC1](INFO): Stopped
2018-03-14T22:05:21.804Z,1521065121.804 [BPC1](INFO): Stopped
2018-03-14T22:05:22.205Z,1521065122.205 [BPC1](INFO): Stopped
2018-03-14T22:05:22.604Z,1521065122.604 [BPC1](INFO): Stopped
2018-03-14T22:05:23.008Z,1521065123.008 [BPC1](INFO): Stopped
2018-03-14T22:05:23.412Z,1521065123.412 [BPC1](INFO): Stopped
2018-03-14T22:05:23.811Z,1521065123.811 [BPC1](INFO): Stopped
2018-03-14T22:05:24.211Z,1521065124.211 [BPC1](INFO): Stopped
2018-03-14T22:05:24.611Z,1521065124.611 [BPC1](INFO): Stopped
2018-03-14T22:05:25.015Z,1521065125.015 [BPC1](INFO): Stopped
2018-03-14T22:05:25.435Z,1521065125.435 [BPC1](INFO): Stopped
2018-03-14T22:05:25.827Z,1521065125.827 [BPC1](INFO): Stopped
2018-03-14T22:05:26.237Z,1521065126.237 [BPC1](INFO): Stopped
2018-03-14T22:05:26.615Z,1521065126.615 [BPC1](INFO): Stopped
2018-03-14T22:05:27.005Z,1521065127.005 [BPC1](INFO): Stopped
2018-03-14T22:05:27.411Z,1521065127.411 [BPC1](INFO): Stopped
2018-03-14T22:05:27.611Z,1521065127.611 [CommandLine](IMPORTANT): got command restart application
2018-03-14T22:05:27.811Z,1521065127.811 [BPC1](INFO): Stopped
2018-03-14T22:05:28.212Z,1521065128.212 [BPC1](INFO): Stopped
2018-03-14T22:05:28.613Z,1521065128.613 [BPC1](INFO): Stopped
2018-03-14T22:05:28.614Z,1521065128.614 [Supervisor](INFO): Stop Mission called by Supervisor::terminate
2018-03-14T22:05:28.617Z,1521065128.617 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2018-03-14T22:05:28.618Z,1521065128.618 [CommandLine ThreadHandler](INFO): Thread cancelled.
2018-03-14T22:05:28.794Z,1521065128.794 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye!
2018-03-14T22:05:28.795Z,1521065128.795 [CommandLine ThreadHandler](INFO): Thread cancelled.
2018-03-14T22:05:28.795Z,1521065128.795 [CommandLine](INFO): Join timeout helper Thread ID is 9947
2018-03-14T22:05:28.796Z,1521065128.796 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2018-03-14T22:05:28.796Z,1521065128.796 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2018-03-14T22:05:28.796Z,1521065128.796 [NavChartDb](INFO): Join timeout helper Thread ID is 9948
2018-03-14T22:05:28.867Z,1521065128.867 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2018-03-14T22:05:28.867Z,1521065128.867 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2018-03-14T22:05:28.875Z,1521065128.875 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2018-03-14T22:05:28.875Z,1521065128.875 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2018-03-14T22:05:28.875Z,1521065128.875 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 9949
2018-03-14T22:05:29.007Z,1521065129.007 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread.
2018-03-14T22:05:29.007Z,1521065129.007 [WetLabsBB2FL](INFO): Powering down
2018-03-14T22:05:29.008Z,1521065129.008 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2018-03-14T22:05:29.013Z,1521065129.013 [BPC1](INFO): Stopped
2018-03-14T22:05:29.019Z,1521065129.019 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2018-03-14T22:05:29.019Z,1521065129.019 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2018-03-14T22:05:29.019Z,1521065129.019 [Radio_Surface](INFO): Join timeout helper Thread ID is 9950
2018-03-14T22:05:29.119Z,1521065129.119 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2018-03-14T22:05:29.119Z,1521065129.119 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2018-03-14T22:05:29.122Z,1521065129.122 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2018-03-14T22:05:29.123Z,1521065129.123 [logger ThreadHandler](INFO): Thread cancelled.
2018-03-14T22:05:29.123Z,1521065129.123 [logger](INFO): Join timeout helper Thread ID is 9951
2018-03-14T22:05:29.147Z,1521065129.147 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2018-03-14T22:05:29.147Z,1521065129.147 [logger ThreadHandler](INFO): Thread cancelled.
2018-03-14T22:05:29.163Z,1521065129.163 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2018-03-14T22:05:29.163Z,1521065129.163 [CommandLine ThreadHandler](INFO): Thread cancelled.
2018-03-14T22:05:29.164Z,1521065129.164 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2018-03-14T22:05:29.164Z,1521065129.164 [controlThread ThreadHandler](INFO): Thread cancelled.
2018-03-14T22:05:29.164Z,1521065129.164 [controlThread](INFO): Join timeout helper Thread ID is 9952
2018-03-14T22:05:29.375Z,1521065129.375 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2018-03-14T22:05:29.375Z,1521065129.375 [controlThread](DEBUG): Uninitializing ControlThread
2018-03-14T22:05:29.376Z,1521065129.376 [NAL9602](INFO): Powering down
2018-03-14T22:05:29.377Z,1521065129.377 [PNI_TCM](INFO): Powering down
2018-03-14T22:05:29.463Z,1521065129.463 [BPC1](INFO): uninitialize
2018-03-14T22:05:29.463Z,1521065129.463 [Aanderaa_O2](INFO): Powering down
2018-03-14T22:05:29.465Z,1521065129.465 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2018-03-14T22:05:29.467Z,1521065129.467 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2018-03-14T22:05:29.467Z,1521065129.467 [MissionManager](INFO): Uninitializing Mission Default
2018-03-14T22:05:29.467Z,1521065129.467 [Default] Stopped
2018-03-14T22:05:29.467Z,1521065129.467 [Default](DEBUG): Aggregate::uninitialize Default
2018-03-14T22:05:29.467Z,1521065129.467 [Default:B.GoToSurface] Stopped
2018-03-14T22:05:29.468Z,1521065129.468 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2018-03-14T22:05:29.468Z,1521065129.468 [Default:CheckIn] Stopped
2018-03-14T22:05:29.468Z,1521065129.468 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2018-03-14T22:05:29.468Z,1521065129.468 [Default:CheckIn:Read_GPS] Stopped
2018-03-14T22:05:29.470Z,1521065129.470 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2018-03-14T22:05:29.471Z,1521065129.471 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2018-03-14T22:05:29.471Z,1521065129.471 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2018-03-14T22:05:29.471Z,1521065129.471 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2018-03-14T22:05:29.471Z,1521065129.471 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2018-03-14T22:05:29.472Z,1521065129.472 [BuoyancyServo](INFO): Powering down
2018-03-14T22:05:29.487Z,1521065129.487 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2018-03-14T22:05:29.487Z,1521065129.487 [ElevatorServo](INFO): Powering down
2018-03-14T22:05:29.488Z,1521065129.488 [MassServo](DEBUG): Uninitialize Mass Servo.
2018-03-14T22:05:29.488Z,1521065129.488 [MassServo](INFO): Powering down
2018-03-14T22:05:29.488Z,1521065129.488 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2018-03-14T22:05:29.488Z,1521065129.488 [RudderServo](INFO): Powering down
2018-03-14T22:05:29.489Z,1521065129.489 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2018-03-14T22:05:29.489Z,1521065129.489 [ThrusterServo](INFO): Powering down
2018-03-14T22:05:29.490Z,1521065129.490 [SBIT](DEBUG): Uninitialize SBIT Component.
2018-03-14T22:05:29.490Z,1521065129.490 [IBIT](DEBUG): Uninitialize IBIT Component.
2018-03-14T22:05:29.491Z,1521065129.491 [CBIT](DEBUG): Uninitialize CBIT Component.
2018-03-14T22:05:29.492Z,1521065129.492 [controlThread ThreadHandler](INFO): Thread cancelled.
2018-03-14T22:05:29.535Z,1521065129.535 [BPC1](INFO): uninitialize
2018-03-14T22:05:29.582Z,1521065129.582 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2018-03-14T22:05:29.616Z,1521065129.616 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2018-03-14T22:05:29.642Z,1521065129.642 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2018-03-14T22:05:29.691Z,1521065129.691 [logger ThreadHandler](INFO): Thread cancelled.