2018-03-14T22:24:56.893Z,1521066296.893 [Supervisor](DEBUG): Initializing supervisor. 2018-03-14T22:24:56.896Z,1521066296.896 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2018-03-14T22:24:56.896Z,1521066296.896 [SyncHandler](INFO): Protected caller Thread ID is 524 2018-03-14T22:24:56.897Z,1521066296.897 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2018-03-14T22:24:56.898Z,1521066296.898 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2018-03-14T22:24:56.898Z,1521066296.898 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 525 2018-03-14T22:24:56.901Z,1521066296.901 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2018-03-14T22:24:56.913Z,1521066296.913 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2018-03-14T22:24:56.914Z,1521066296.914 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2018-03-14T22:24:56.914Z,1521066296.914 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 526 2018-03-14T22:24:56.915Z,1521066296.915 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2018-03-14T22:24:56.916Z,1521066296.916 [logger ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2018-03-14T22:24:56.916Z,1521066296.916 [logger ThreadHandler](INFO): Protected caller Thread ID is 527 2018-03-14T22:24:56.918Z,1521066296.918 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2018-03-14T22:24:56.918Z,1521066296.918 [Supervisor](INFO): Looking for Config files in directory: Config/ 2018-03-14T22:24:56.920Z,1521066296.920 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2018-03-14T22:24:57.215Z,1521066297.215 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2018-03-14T22:24:57.216Z,1521066297.216 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2018-03-14T22:24:57.398Z,1521066297.398 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2018-03-14T22:24:57.399Z,1521066297.399 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2018-03-14T22:24:57.656Z,1521066297.656 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2018-03-14T22:24:57.657Z,1521066297.657 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2018-03-14T22:24:57.793Z,1521066297.793 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2018-03-14T22:24:57.794Z,1521066297.794 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2018-03-14T22:24:57.888Z,1521066297.888 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample 2018-03-14T22:24:57.888Z,1521066297.888 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2018-03-14T22:24:58.308Z,1521066298.308 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2018-03-14T22:24:58.308Z,1521066298.308 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2018-03-14T22:24:58.779Z,1521066298.779 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2018-03-14T22:24:58.780Z,1521066298.780 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2018-03-14T22:24:59.182Z,1521066299.182 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2018-03-14T22:24:59.182Z,1521066299.182 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2018-03-14T22:24:59.282Z,1521066299.282 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2018-03-14T22:24:59.283Z,1521066299.283 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2018-03-14T22:24:59.376Z,1521066299.376 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2018-03-14T22:24:59.377Z,1521066299.377 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2018-03-14T22:24:59.570Z,1521066299.570 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2018-03-14T22:24:59.571Z,1521066299.571 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2018-03-14T22:24:59.764Z,1521066299.764 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2018-03-14T22:24:59.765Z,1521066299.765 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2018-03-14T22:25:00.077Z,1521066300.077 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2018-03-14T22:25:00.077Z,1521066300.077 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2018-03-14T22:25:00.211Z,1521066300.211 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2018-03-14T22:25:00.212Z,1521066300.212 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2018-03-14T22:25:00.292Z,1521066300.292 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-daphne/ 2018-03-14T22:25:00.293Z,1521066300.293 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Control.cfg 2018-03-14T22:25:00.390Z,1521066300.390 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/logger.cfg 2018-03-14T22:25:00.478Z,1521066300.478 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Servo.cfg 2018-03-14T22:25:00.568Z,1521066300.568 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Simulator.cfg 2018-03-14T22:25:00.650Z,1521066300.650 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Sensor.cfg 2018-03-14T22:25:00.790Z,1521066300.790 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/vehicle.cfg 2018-03-14T22:25:00.951Z,1521066300.951 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/workSite.cfg 2018-03-14T22:25:01.026Z,1521066301.026 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Battery.cfg 2018-03-14T22:25:01.242Z,1521066301.242 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2018-03-14T22:25:01.243Z,1521066301.243 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/secure.cfg 2018-03-14T22:25:01.324Z,1521066301.324 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Navigation.cfg 2018-03-14T22:25:01.411Z,1521066301.411 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/BIT.cfg 2018-03-14T22:25:01.508Z,1521066301.508 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Science.cfg 2018-03-14T22:25:01.628Z,1521066301.628 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-daphne/root/ 2018-03-14T22:25:01.628Z,1521066301.628 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg 2018-03-14T22:25:01.634Z,1521066301.634 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2018-03-14T22:25:01.868Z,1521066301.868 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2018-03-14T22:25:01.868Z,1521066301.868 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2018-03-14T22:25:01.909Z,1521066301.909 [DepthRateCalculator] Loaded 2018-03-14T22:25:01.909Z,1521066301.909 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2018-03-14T22:25:01.915Z,1521066301.915 [PitchRateCalculator] Loaded 2018-03-14T22:25:01.915Z,1521066301.915 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2018-03-14T22:25:01.931Z,1521066301.931 [SpeedCalculator] Loaded 2018-03-14T22:25:01.931Z,1521066301.931 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2018-03-14T22:25:01.951Z,1521066301.951 [TempGradientCalculator] Loaded 2018-03-14T22:25:01.951Z,1521066301.951 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread. 2018-03-14T22:25:01.966Z,1521066301.966 [VerticalTemperatureHomogeneityIndexCalculator] Loaded 2018-03-14T22:25:01.966Z,1521066301.966 [ComponentRegistry](DEBUG): SyncComponent "VerticalTemperatureHomogeneityIndexCalculator" handled in the control thread. 2018-03-14T22:25:01.972Z,1521066301.972 [YawRateCalculator] Loaded 2018-03-14T22:25:01.972Z,1521066301.972 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2018-03-14T22:25:01.973Z,1521066301.973 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2018-03-14T22:25:01.973Z,1521066301.973 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2018-03-14T22:25:02.054Z,1521066302.054 [StratificationFrontDetector](INFO): threshold set to: 0.399988 degC 2018-03-14T22:25:02.054Z,1521066302.054 [StratificationFrontDetector](DEBUG): (re)initializing 2018-03-14T22:25:02.054Z,1521066302.054 [StratificationFrontDetector] Loaded 2018-03-14T22:25:02.055Z,1521066302.055 [ComponentRegistry](DEBUG): SyncComponent "StratificationFrontDetector" handled in the control thread. 2018-03-14T22:25:02.055Z,1521066302.055 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2018-03-14T22:25:02.056Z,1521066302.056 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2018-03-14T22:25:02.167Z,1521066302.167 [BuoyancyServo] Loaded 2018-03-14T22:25:02.167Z,1521066302.167 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2018-03-14T22:25:02.182Z,1521066302.182 [ElevatorServo] Loaded 2018-03-14T22:25:02.182Z,1521066302.182 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2018-03-14T22:25:02.196Z,1521066302.196 [MassServo] Loaded 2018-03-14T22:25:02.196Z,1521066302.196 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2018-03-14T22:25:02.211Z,1521066302.211 [RudderServo] Loaded 2018-03-14T22:25:02.211Z,1521066302.211 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2018-03-14T22:25:02.225Z,1521066302.225 [ThrusterServo] Loaded 2018-03-14T22:25:02.225Z,1521066302.225 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread. 2018-03-14T22:25:02.225Z,1521066302.225 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2018-03-14T22:25:02.226Z,1521066302.226 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2018-03-14T22:25:02.239Z,1521066302.239 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2018-03-14T22:25:02.239Z,1521066302.239 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2018-03-14T22:25:02.333Z,1521066302.333 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2018-03-14T22:25:02.334Z,1521066302.334 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2018-03-14T22:25:02.589Z,1521066302.589 [DataOverHttps] Loaded 2018-03-14T22:25:02.590Z,1521066302.590 [ComponentRegistry](DEBUG): SyncComponent "DataOverHttps" handled in the control thread. 2018-03-14T22:25:02.603Z,1521066302.603 [Depth_Keller] Loaded 2018-03-14T22:25:02.603Z,1521066302.603 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2018-03-14T22:25:02.608Z,1521066302.608 [DropWeight] Loaded 2018-03-14T22:25:02.608Z,1521066302.608 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread. 2018-03-14T22:25:02.703Z,1521066302.703 [NAL9602] Loaded 2018-03-14T22:25:02.703Z,1521066302.703 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2018-03-14T22:25:02.718Z,1521066302.718 [Onboard] Loaded 2018-03-14T22:25:02.719Z,1521066302.719 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread. 2018-03-14T22:25:02.728Z,1521066302.728 [Radio_Surface] Loaded 2018-03-14T22:25:02.729Z,1521066302.729 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2018-03-14T22:25:02.730Z,1521066302.730 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 408714E0 2018-03-14T22:25:02.730Z,1521066302.730 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 609 2018-03-14T22:25:02.776Z,1521066302.776 [PNI_TCM] Loaded 2018-03-14T22:25:02.776Z,1521066302.776 [ComponentRegistry](DEBUG): SyncComponent "PNI_TCM" handled in the control thread. 2018-03-14T22:25:04.528Z,1521066304.528 [BPC1] Loaded 2018-03-14T22:25:04.528Z,1521066304.528 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2018-03-14T22:25:04.529Z,1521066304.529 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2018-03-14T22:25:04.529Z,1521066304.529 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2018-03-14T22:25:04.788Z,1521066304.788 [SBIT](DEBUG): Construct Startup Built In Test. 2018-03-14T22:25:04.812Z,1521066304.812 [SBIT] Loaded 2018-03-14T22:25:04.812Z,1521066304.812 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2018-03-14T22:25:04.813Z,1521066304.813 [IBIT](DEBUG): Construct Initiated Built In Test. 2018-03-14T22:25:04.824Z,1521066304.824 [IBIT] Loaded 2018-03-14T22:25:04.825Z,1521066304.825 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2018-03-14T22:25:04.828Z,1521066304.828 [CBIT](DEBUG): Construct Continuous Built In Test. 2018-03-14T22:25:05.146Z,1521066305.146 [CBIT] Loaded 2018-03-14T22:25:05.170Z,1521066305.170 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2018-03-14T22:25:05.171Z,1521066305.171 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2018-03-14T22:25:05.171Z,1521066305.171 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2018-03-14T22:25:05.430Z,1521066305.430 [Aanderaa_O2] Loaded 2018-03-14T22:25:05.430Z,1521066305.430 [ComponentRegistry](DEBUG): SyncComponent "Aanderaa_O2" handled in the control thread. 2018-03-14T22:25:05.442Z,1521066305.442 [CANONSampler] Loaded 2018-03-14T22:25:05.442Z,1521066305.442 [ComponentRegistry](DEBUG): SyncComponent "CANONSampler" handled in the control thread. 2018-03-14T22:25:05.456Z,1521066305.456 [PAR_Licor] Loaded 2018-03-14T22:25:05.456Z,1521066305.456 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread. 2018-03-14T22:25:05.504Z,1521066305.504 [WetLabsBB2FL] Loaded 2018-03-14T22:25:05.504Z,1521066305.504 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread. 2018-03-14T22:25:05.505Z,1521066305.505 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 409314E0 2018-03-14T22:25:05.505Z,1521066305.505 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 610 2018-03-14T22:25:05.506Z,1521066305.506 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2018-03-14T22:25:05.506Z,1521066305.506 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2018-03-14T22:25:05.572Z,1521066305.572 [VerticalControl](DEBUG): Construct VerticalControl. 2018-03-14T22:25:05.657Z,1521066305.657 [VerticalControl] Loaded 2018-03-14T22:25:05.657Z,1521066305.657 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2018-03-14T22:25:05.658Z,1521066305.658 [HorizontalControl](DEBUG): Construct HorizontalControl. 2018-03-14T22:25:05.713Z,1521066305.713 [HorizontalControl] Loaded 2018-03-14T22:25:05.713Z,1521066305.713 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2018-03-14T22:25:05.714Z,1521066305.714 [SpeedControl](DEBUG): Construct SpeedControl. 2018-03-14T22:25:05.715Z,1521066305.715 [SpeedControl] Loaded 2018-03-14T22:25:05.716Z,1521066305.716 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2018-03-14T22:25:05.716Z,1521066305.716 [LoopControl](DEBUG): Construct LoopControl. 2018-03-14T22:25:05.717Z,1521066305.717 [LoopControl] Loaded 2018-03-14T22:25:05.717Z,1521066305.717 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2018-03-14T22:25:05.718Z,1521066305.718 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2018-03-14T22:25:05.718Z,1521066305.718 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2018-03-14T22:25:05.742Z,1521066305.742 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2018-03-14T22:25:05.743Z,1521066305.743 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2018-03-14T22:25:05.831Z,1521066305.831 [DeadReckonUsingSpeedCalculator] Loaded 2018-03-14T22:25:05.832Z,1521066305.832 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread. 2018-03-14T22:25:05.884Z,1521066305.884 [DeadReckonWithRespectToSeafloor] Loaded 2018-03-14T22:25:05.885Z,1521066305.885 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonWithRespectToSeafloor" handled in the control thread. 2018-03-14T22:25:05.901Z,1521066305.901 [NavChart] Loaded 2018-03-14T22:25:05.901Z,1521066305.901 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2018-03-14T22:25:05.905Z,1521066305.905 [UniversalFixResidualReporter] Loaded 2018-03-14T22:25:05.906Z,1521066305.906 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2018-03-14T22:25:05.906Z,1521066305.906 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2018-03-14T22:25:05.909Z,1521066305.909 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2018-03-14T22:25:05.910Z,1521066305.910 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2018-03-14T22:25:05.916Z,1521066305.916 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2018-03-14T22:25:05.917Z,1521066305.917 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 409BD4E0 2018-03-14T22:25:05.918Z,1521066305.918 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 611 2018-03-14T22:25:05.922Z,1521066305.922 [Supervisor](INFO): Main Thread ID is 9710 2018-03-14T22:25:05.923Z,1521066305.923 [Supervisor](DEBUG): Running supervisor. 2018-03-14T22:25:05.923Z,1521066305.923 [CommandLine ThreadHandler](INFO): Handler Thread ID is 612 2018-03-14T22:25:05.926Z,1521066305.926 [controlThread ThreadHandler](INFO): Handler Thread ID is 613 2018-03-14T22:25:05.926Z,1521066305.926 [controlThread](DEBUG): Initializing ControlThread 2018-03-14T22:25:05.927Z,1521066305.927 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2018-03-14T22:25:05.927Z,1521066305.927 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2018-03-14T22:25:05.928Z,1521066305.928 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2018-03-14T22:25:05.928Z,1521066305.928 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator. 2018-03-14T22:25:05.929Z,1521066305.929 [VerticalTemperatureHomogeneityIndexCalculator](DEBUG): (re)initializing 2018-03-14T22:25:05.929Z,1521066305.929 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2018-03-14T22:25:05.937Z,1521066305.937 [SBIT](INFO): Initialize SBIT Component. 2018-03-14T22:25:05.938Z,1521066305.938 [SBIT](IMPORTANT): git: 2018-03-10-3-g1088291 2018-03-14T22:25:05.938Z,1521066305.938 [SBIT](INFO): git hash: 10882917f95cfba58cc6008bb2c6cc253db9d857 2018-03-14T22:25:05.938Z,1521066305.938 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2018-03-14T22:25:05.939Z,1521066305.939 [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:25:05.940Z,1521066305.940 [SBIT](INFO): Beginning SBIT in 23.000000 seconds. 2018-03-14T22:25:05.941Z,1521066305.941 [IBIT](INFO): Initialize IBIT Component. 2018-03-14T22:25:05.942Z,1521066305.942 [CBIT](DEBUG): Initialize CBIT Component. 2018-03-14T22:25:05.942Z,1521066305.942 [CBIT](INFO): Last reboot was NOT due to watchdog timer. 2018-03-14T22:25:05.943Z,1521066305.943 [logger ThreadHandler](INFO): Handler Thread ID is 614 2018-03-14T22:25:05.963Z,1521066305.963 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 615 2018-03-14T22:25:05.969Z,1521066305.969 [Radio_Surface](INFO): Powering up 2018-03-14T22:25:05.975Z,1521066305.975 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 616 2018-03-14T22:25:05.976Z,1521066305.976 [WetLabsBB2FL](INFO): Powering down 2018-03-14T22:25:05.000Z,1521066306.000 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 617 2018-03-14T22:25:06.005Z,1521066306.005 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000 2018-03-14T22:25:06.006Z,1521066306.006 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000 2018-03-14T22:25:06.006Z,1521066306.006 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000 2018-03-14T22:25:06.006Z,1521066306.006 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000 2018-03-14T22:25:06.006Z,1521066306.006 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000 2018-03-14T22:25:06.006Z,1521066306.006 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000 2018-03-14T22:25:06.007Z,1521066306.007 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000 2018-03-14T22:25:06.007Z,1521066306.007 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000 2018-03-14T22:25:06.007Z,1521066306.007 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000 2018-03-14T22:25:06.007Z,1521066306.007 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000 2018-03-14T22:25:06.007Z,1521066306.007 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000 2018-03-14T22:25:06.007Z,1521066306.007 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000 2018-03-14T22:25:06.008Z,1521066306.008 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000 2018-03-14T22:25:06.008Z,1521066306.008 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000 2018-03-14T22:25:06.008Z,1521066306.008 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000 2018-03-14T22:25:06.008Z,1521066306.008 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000 2018-03-14T22:25:06.051Z,1521066306.051 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2018-03-14T22:25:06.052Z,1521066306.052 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2018-03-14T22:25:06.053Z,1521066306.053 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2018-03-14T22:25:06.054Z,1521066306.054 [LoopControl](DEBUG): Initialize LoopControlComponent. 2018-03-14T22:25:06.054Z,1521066306.054 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2018-03-14T22:25:06.055Z,1521066306.055 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s. 2018-03-14T22:25:06.055Z,1521066306.055 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s. 2018-03-14T22:25:06.056Z,1521066306.056 [DeadReckonWithRespectToSeafloor](DEBUG): Initializing DeadReckonWithRespectToSeafloor component. 2018-03-14T22:25:06.056Z,1521066306.056 [DeadReckonWithRespectToSeafloor](INFO): Will consider orientation measurement stale after 120s. 2018-03-14T22:25:06.056Z,1521066306.056 [DeadReckonWithRespectToSeafloor](INFO): Will consider velocity measurement stale after 20s. 2018-03-14T22:25:06.057Z,1521066306.057 [NavChart](DEBUG): Initialize NavChart Navigation. 2018-03-14T22:25:06.057Z,1521066306.057 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2018-03-14T22:25:06.058Z,1521066306.058 [MissionManager](INFO): Loading Mission: Missions/Startup.xml 2018-03-14T22:25:06.088Z,1521066306.088 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2018-03-14T22:25:06.123Z,1521066306.123 [MissionManager](DEBUG): 2018-03-14T22:25:06.124Z,1521066306.124 [MissionManager](INFO): Loading Mission: Missions/Default.xml 2018-03-14T22:25:06.197Z,1521066306.197 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min 2018-03-14T22:25:06.198Z,1521066306.198 [Default:A.Wait](DEBUG): Construct Wait. 2018-03-14T22:25:06.200Z,1521066306.200 [Default:B.GoToSurface](DEBUG): Construct GoToSurface. 2018-03-14T22:25:06.243Z,1521066306.243 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2018-03-14T22:25:06.245Z,1521066306.245 [Default:CheckIn:C.Wait](DEBUG): Construct Wait. 2018-03-14T22:25:06.275Z,1521066306.275 [Default:E.Execute](DEBUG): Construct Execute. 2018-03-14T22:25:06.278Z,1521066306.278 [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:25:06.295Z,1521066306.295 [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:25:06.307Z,1521066306.307 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2018-03-14T22:25:06.320Z,1521066306.320 [Depth_Keller](ERROR): Pressure reading out of range: 1831.023193 decibar 2018-03-14T22:25:06.420Z,1521066306.420 [BPC1](INFO): Start 2018-03-14T22:25:06.553Z,1521066306.553 [CANONSampler](INFO): Powering down 2018-03-14T22:25:06.791Z,1521066306.791 [DepthRateCalculator](ERROR): Depth measurement is not active 2018-03-14T22:25:06.875Z,1521066306.875 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-03-14T22:25:06.882Z,1521066306.882 [DeadReckonWithRespectToSeafloor](DEBUG): Starting up and don't have orientation data yet. 2018-03-14T22:25:06.995Z,1521066306.995 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2018-03-14T22:25:07.003Z,1521066307.003 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2018-03-14T22:25:07.025Z,1521066307.025 [ElevatorServo](DEBUG): Initializing EZServoServo. 2018-03-14T22:25:07.031Z,1521066307.031 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2018-03-14T22:25:07.037Z,1521066307.037 [MassServo](DEBUG): Initializing EZServoServo. 2018-03-14T22:25:07.043Z,1521066307.043 [MassServo](DEBUG): Initializing MassServo. 2018-03-14T22:25:07.048Z,1521066307.048 [RudderServo](DEBUG): Initializing EZServoServo. 2018-03-14T22:25:07.055Z,1521066307.055 [RudderServo](DEBUG): Initializing RudderServo. 2018-03-14T22:25:07.060Z,1521066307.060 [ThrusterServo](DEBUG): Initializing EZServoServo. 2018-03-14T22:25:07.067Z,1521066307.067 [ThrusterServo](DEBUG): Initializing ThrusterServo. 2018-03-14T22:25:07.336Z,1521066307.336 [BPC1](INFO): Starting 2018-03-14T22:25:07.363Z,1521066307.363 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-03-14T22:25:07.363Z,1521066307.363 [DeadReckonWithRespectToSeafloor](DEBUG): Starting up and don't have orientation data yet. 2018-03-14T22:25:07.573Z,1521066307.573 [BPC1](INFO): Starting 2018-03-14T22:25:07.592Z,1521066307.592 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-03-14T22:25:07.593Z,1521066307.593 [DeadReckonWithRespectToSeafloor](DEBUG): Starting up and don't have orientation data yet. 2018-03-14T22:25:07.939Z,1521066307.939 [BuoyancyServo](ERROR): Buoyancy initialization uart error serial timeout 2018-03-14T22:25:07.939Z,1521066307.939 [BuoyancyServo](FAULT): Buoyancy failed to initialize 2018-03-14T22:25:07.939Z,1521066307.939 [BuoyancyServo] Communications Fault, FailCount= 1 2018-03-14T22:25:07.939Z,1521066307.939 [BuoyancyServo](ERROR): Communications Fault 2018-03-14T22:25:08.154Z,1521066308.154 [CBIT](ERROR): Communications Fault in component: BuoyancyServo 2018-03-14T22:25:08.186Z,1521066308.186 [BPC1](INFO): Starting 2018-03-14T22:25:08.211Z,1521066308.211 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-03-14T22:25:08.212Z,1521066308.212 [DeadReckonWithRespectToSeafloor](DEBUG): Starting up and don't have orientation data yet. 2018-03-14T22:25:08.224Z,1521066308.224 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2018-03-14T22:25:08.225Z,1521066308.225 [BuoyancyServo](INFO): Powering down 2018-03-14T22:25:08.595Z,1521066308.595 [BPC1](INFO): Starting 2018-03-14T22:25:08.606Z,1521066308.606 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-03-14T22:25:08.607Z,1521066308.607 [DeadReckonWithRespectToSeafloor](DEBUG): Starting up and don't have orientation data yet. 2018-03-14T22:25:08.983Z,1521066308.983 [BPC1](INFO): Starting 2018-03-14T22:25:09.014Z,1521066309.014 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-03-14T22:25:09.014Z,1521066309.014 [DeadReckonWithRespectToSeafloor](DEBUG): Starting up and don't have orientation data yet. 2018-03-14T22:25:09.385Z,1521066309.385 [BPC1](INFO): Starting 2018-03-14T22:25:09.410Z,1521066309.410 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-03-14T22:25:09.419Z,1521066309.419 [DeadReckonWithRespectToSeafloor](DEBUG): Starting up and don't have orientation data yet. 2018-03-14T22:25:09.799Z,1521066309.799 [BPC1](INFO): Starting 2018-03-14T22:25:09.919Z,1521066309.919 [Aanderaa_O2](INFO): Powering down 2018-03-14T22:25:09.987Z,1521066309.987 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-03-14T22:25:09.988Z,1521066309.988 [DeadReckonWithRespectToSeafloor](DEBUG): Starting up and don't have orientation data yet. 2018-03-14T22:25:10.204Z,1521066310.204 [BPC1](INFO): Starting 2018-03-14T22:25:10.328Z,1521066310.328 [CBIT](INFO): Clearing failed state for component BuoyancyServo 2018-03-14T22:25:10.328Z,1521066310.328 [BuoyancyServo] No Fault, FailCount= 1 2018-03-14T22:25:10.592Z,1521066310.592 [BPC1](INFO): Starting 2018-03-14T22:25:10.664Z,1521066310.664 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2018-03-14T22:25:10.783Z,1521066310.783 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2018-03-14T22:25:11.026Z,1521066311.026 [BPC1](INFO): Starting 2018-03-14T22:25:11.389Z,1521066311.389 [BPC1](INFO): Starting 2018-03-14T22:25:11.801Z,1521066311.801 [BPC1](INFO): Starting 2018-03-14T22:25:12.217Z,1521066312.217 [BPC1](INFO): Starting 2018-03-14T22:25:12.592Z,1521066312.592 [BPC1](INFO): Starting 2018-03-14T22:25:13.007Z,1521066313.007 [BPC1](INFO): Starting 2018-03-14T22:25:13.393Z,1521066313.393 [BPC1](INFO): Starting 2018-03-14T22:25:13.796Z,1521066313.796 [BPC1](INFO): Starting 2018-03-14T22:25:14.210Z,1521066314.210 [BPC1](INFO): Starting 2018-03-14T22:25:14.595Z,1521066314.595 [BPC1](INFO): Starting 2018-03-14T22:25:14.993Z,1521066314.993 [BPC1](INFO): Starting 2018-03-14T22:25:15.404Z,1521066315.404 [BPC1](INFO): Starting 2018-03-14T22:25:15.792Z,1521066315.792 [BPC1](INFO): Starting 2018-03-14T22:25:16.192Z,1521066316.192 [BPC1](INFO): Starting 2018-03-14T22:25:16.593Z,1521066316.593 [BPC1](INFO): Starting 2018-03-14T22:25:16.992Z,1521066316.992 [BPC1](INFO): Starting 2018-03-14T22:25:17.393Z,1521066317.393 [BPC1](INFO): Starting 2018-03-14T22:25:17.817Z,1521066317.817 [BPC1](INFO): Starting 2018-03-14T22:25:18.192Z,1521066318.192 [BPC1](INFO): Starting 2018-03-14T22:25:18.593Z,1521066318.593 [BPC1](INFO): Starting 2018-03-14T22:25:18.993Z,1521066318.993 [BPC1](INFO): Starting 2018-03-14T22:25:19.392Z,1521066319.392 [BPC1](INFO): Starting 2018-03-14T22:25:19.792Z,1521066319.792 [BPC1](INFO): Starting 2018-03-14T22:25:20.226Z,1521066320.226 [BPC1](INFO): Starting 2018-03-14T22:25:20.593Z,1521066320.593 [BPC1](INFO): Starting 2018-03-14T22:25:20.993Z,1521066320.993 [BPC1](INFO): Starting 2018-03-14T22:25:21.393Z,1521066321.393 [BPC1](INFO): Starting 2018-03-14T22:25:21.793Z,1521066321.793 [BPC1](INFO): Starting 2018-03-14T22:25:22.192Z,1521066322.192 [BPC1](INFO): Starting 2018-03-14T22:25:22.609Z,1521066322.609 [BPC1](INFO): Starting 2018-03-14T22:25:22.993Z,1521066322.993 [BPC1](INFO): Starting 2018-03-14T22:25:23.393Z,1521066323.393 [BPC1](INFO): Starting 2018-03-14T22:25:23.793Z,1521066323.793 [BPC1](INFO): Starting 2018-03-14T22:25:24.193Z,1521066324.193 [BPC1](INFO): Starting 2018-03-14T22:25:24.593Z,1521066324.593 [BPC1](INFO): Starting 2018-03-14T22:25:24.993Z,1521066324.993 [BPC1](INFO): Starting 2018-03-14T22:25:25.393Z,1521066325.393 [BPC1](INFO): Starting 2018-03-14T22:25:25.792Z,1521066325.792 [BPC1](INFO): Starting 2018-03-14T22:25:26.193Z,1521066326.193 [BPC1](INFO): Starting 2018-03-14T22:25:26.593Z,1521066326.593 [BPC1](INFO): Starting 2018-03-14T22:25:26.992Z,1521066326.992 [BPC1](INFO): Starting 2018-03-14T22:25:27.393Z,1521066327.393 [BPC1](INFO): Starting 2018-03-14T22:25:27.793Z,1521066327.793 [BPC1](INFO): Starting 2018-03-14T22:25:28.198Z,1521066328.198 [BPC1](INFO): Starting 2018-03-14T22:25:28.594Z,1521066328.594 [BPC1](INFO): Starting 2018-03-14T22:25:28.993Z,1521066328.993 [BPC1](INFO): Starting 2018-03-14T22:25:29.392Z,1521066329.392 [BPC1](INFO): Starting 2018-03-14T22:25:29.437Z,1521066329.437 [SBIT](IMPORTANT): Beginning Startup BIT 2018-03-14T22:25:29.459Z,1521066329.459 [CBIT](IMPORTANT): Beginning ground fault scan 2018-03-14T22:25:29.792Z,1521066329.792 [BPC1](INFO): Starting 2018-03-14T22:25:30.205Z,1521066330.205 [BPC1](INFO): Starting 2018-03-14T22:25:30.592Z,1521066330.592 [BPC1](INFO): Starting 2018-03-14T22:25:30.992Z,1521066330.992 [BPC1](INFO): Starting 2018-03-14T22:25:31.393Z,1521066331.393 [BPC1](INFO): Starting 2018-03-14T22:25:31.924Z,1521066331.924 [BPC1](INFO): Starting 2018-03-14T22:25:32.324Z,1521066332.324 [BPC1](INFO): Starting 2018-03-14T22:25:32.713Z,1521066332.713 [BPC1](INFO): Starting 2018-03-14T22:25:33.088Z,1521066333.088 [NAL9602](INFO): Powering up NAL9602 2018-03-14T22:25:33.114Z,1521066333.114 [BPC1](INFO): Starting 2018-03-14T22:25:33.512Z,1521066333.512 [BPC1](INFO): Starting 2018-03-14T22:25:33.914Z,1521066333.914 [BPC1](INFO): Starting 2018-03-14T22:25:34.309Z,1521066334.309 [BPC1](INFO): Starting 2018-03-14T22:25:34.721Z,1521066334.721 [BPC1](INFO): Starting 2018-03-14T22:25:35.113Z,1521066335.113 [BPC1](INFO): Starting 2018-03-14T22:25:35.514Z,1521066335.514 [BPC1](INFO): Starting 2018-03-14T22:25:35.913Z,1521066335.913 [BPC1](INFO): Starting 2018-03-14T22:25:36.313Z,1521066336.313 [BPC1](INFO): Starting 2018-03-14T22:25:36.712Z,1521066336.712 [BPC1](INFO): Starting 2018-03-14T22:25:37.112Z,1521066337.112 [BPC1](INFO): Starting 2018-03-14T22:25:37.512Z,1521066337.512 [BPC1](INFO): Starting 2018-03-14T22:25:37.912Z,1521066337.912 [BPC1](INFO): Starting 2018-03-14T22:25:38.312Z,1521066338.312 [BPC1](INFO): Starting 2018-03-14T22:25:38.712Z,1521066338.712 [BPC1](INFO): Starting 2018-03-14T22:25:39.112Z,1521066339.112 [BPC1](INFO): Starting 2018-03-14T22:25:39.512Z,1521066339.512 [BPC1](INFO): Starting 2018-03-14T22:25:39.912Z,1521066339.912 [BPC1](INFO): Starting 2018-03-14T22:25:40.313Z,1521066340.313 [BPC1](INFO): Starting 2018-03-14T22:25:40.395Z,1521066340.395 [CBIT](IMPORTANT): Ground fault detected mA: CHAN A0 (Batt): -0.001744 CHAN A1 (24V): 4.657929 CHAN A2 (12V): -0.002215 CHAN A3 (5V): -0.001619 CHAN B0 (3.3V): 0.000214 CHAN B1 (3.15aV): -0.000588 CHAN B2 (3.15bV): -0.000099 CHAN B3 (GND): 0.000118 OPEN: -0.000254 Full Scale Calc: 4.765 mA, -1.589 mA 2018-03-14T22:25:40.709Z,1521066340.709 [BPC1](INFO): Starting 2018-03-14T22:25:41.114Z,1521066341.114 [BPC1](INFO): Starting 2018-03-14T22:25:41.512Z,1521066341.512 [BPC1](INFO): Starting 2018-03-14T22:25:41.914Z,1521066341.914 [BPC1](INFO): Starting 2018-03-14T22:25:42.316Z,1521066342.316 [BPC1](INFO): Starting 2018-03-14T22:25:42.715Z,1521066342.715 [BPC1](INFO): Starting 2018-03-14T22:25:43.116Z,1521066343.116 [BPC1](INFO): Starting 2018-03-14T22:25:43.518Z,1521066343.518 [BPC1](INFO): Starting 2018-03-14T22:25:43.935Z,1521066343.935 [BPC1](INFO): Starting 2018-03-14T22:25:44.284Z,1521066344.284 [NAL9602](INFO): NAL9602 initialized 2018-03-14T22:25:44.308Z,1521066344.308 [BPC1](INFO): Starting 2018-03-14T22:25:44.747Z,1521066344.747 [BPC1](INFO): Starting 2018-03-14T22:25:45.349Z,1521066345.349 [BPC1](INFO): Starting 2018-03-14T22:25:45.731Z,1521066345.731 [BPC1](INFO): Starting 2018-03-14T22:25:46.183Z,1521066346.183 [BPC1](INFO): Starting 2018-03-14T22:25:46.522Z,1521066346.522 [BPC1](INFO): Starting 2018-03-14T22:25:46.926Z,1521066346.926 [BPC1](INFO): Starting 2018-03-14T22:25:47.345Z,1521066347.345 [BPC1](INFO): Starting 2018-03-14T22:25:47.727Z,1521066347.727 [BPC1](INFO): Starting 2018-03-14T22:25:48.151Z,1521066348.151 [BPC1](INFO): Starting 2018-03-14T22:25:48.539Z,1521066348.539 [BPC1](INFO): Starting 2018-03-14T22:25:48.920Z,1521066348.920 [BPC1](INFO): Starting 2018-03-14T22:25:49.326Z,1521066349.326 [BPC1](INFO): Starting 2018-03-14T22:25:49.729Z,1521066349.729 [BPC1](INFO): Starting 2018-03-14T22:25:50.113Z,1521066350.113 [BPC1](INFO): Starting 2018-03-14T22:25:50.516Z,1521066350.516 [BPC1](INFO): Starting 2018-03-14T22:25:50.925Z,1521066350.925 [BPC1](INFO): Starting 2018-03-14T22:25:51.320Z,1521066351.320 [BPC1](INFO): Starting 2018-03-14T22:25:51.723Z,1521066351.723 [BPC1](INFO): Starting 2018-03-14T22:25:52.123Z,1521066352.123 [BPC1](INFO): Starting 2018-03-14T22:25:52.537Z,1521066352.537 [BPC1](INFO): Starting 2018-03-14T22:25:52.944Z,1521066352.944 [BPC1](INFO): Starting 2018-03-14T22:25:53.352Z,1521066353.352 [BPC1](INFO): Starting 2018-03-14T22:25:53.724Z,1521066353.724 [BPC1](INFO): Starting 2018-03-14T22:25:54.121Z,1521066354.121 [BPC1](INFO): Starting 2018-03-14T22:25:54.526Z,1521066354.526 [BPC1](INFO): Starting 2018-03-14T22:25:54.921Z,1521066354.921 [BPC1](INFO): Starting 2018-03-14T22:25:55.327Z,1521066355.327 [BPC1](INFO): Starting 2018-03-14T22:25:55.728Z,1521066355.728 [BPC1](INFO): Starting 2018-03-14T22:25:56.113Z,1521066356.113 [BPC1](INFO): Starting 2018-03-14T22:25:56.512Z,1521066356.512 [BPC1](INFO): Starting 2018-03-14T22:25:56.917Z,1521066356.917 [BPC1](INFO): Starting 2018-03-14T22:25:57.313Z,1521066357.313 [BPC1](INFO): Starting 2018-03-14T22:25:57.730Z,1521066357.730 [BPC1](INFO): Starting 2018-03-14T22:25:58.127Z,1521066358.127 [BPC1](INFO): Starting 2018-03-14T22:25:58.541Z,1521066358.541 [BPC1](INFO): Starting 2018-03-14T22:25:58.952Z,1521066358.952 [BPC1](INFO): Starting 2018-03-14T22:25:59.325Z,1521066359.325 [BPC1](INFO): Starting 2018-03-14T22:25:59.723Z,1521066359.723 [BPC1](INFO): Starting 2018-03-14T22:26:00.125Z,1521066360.125 [BPC1](INFO): Starting 2018-03-14T22:26:00.517Z,1521066360.517 [BPC1](INFO): Starting 2018-03-14T22:26:00.913Z,1521066360.913 [BPC1](INFO): Starting 2018-03-14T22:26:01.312Z,1521066361.312 [BPC1](INFO): Starting 2018-03-14T22:26:01.716Z,1521066361.716 [BPC1](INFO): Starting 2018-03-14T22:26:02.120Z,1521066362.120 [BPC1](INFO): Starting 2018-03-14T22:26:02.523Z,1521066362.523 [BPC1](INFO): Starting 2018-03-14T22:26:02.930Z,1521066362.930 [BPC1](INFO): Starting 2018-03-14T22:26:03.329Z,1521066363.329 [BPC1](INFO): Starting 2018-03-14T22:26:03.733Z,1521066363.733 [BPC1](INFO): Starting 2018-03-14T22:26:04.135Z,1521066364.135 [BPC1](INFO): Starting 2018-03-14T22:26:04.523Z,1521066364.523 [BPC1](INFO): Starting 2018-03-14T22:26:04.923Z,1521066364.923 [BPC1](INFO): Starting 2018-03-14T22:26:05.316Z,1521066365.316 [BPC1](INFO): Starting 2018-03-14T22:26:05.712Z,1521066365.712 [BPC1](INFO): Starting 2018-03-14T22:26:06.112Z,1521066366.112 [BPC1](INFO): Starting 2018-03-14T22:26:06.517Z,1521066366.517 [BPC1](INFO): Starting 2018-03-14T22:26:06.919Z,1521066366.919 [BPC1](INFO): Starting 2018-03-14T22:26:07.323Z,1521066367.323 [BPC1](INFO): Starting 2018-03-14T22:26:07.725Z,1521066367.725 [BPC1](INFO): Starting 2018-03-14T22:26:08.131Z,1521066368.131 [BPC1](INFO): Starting 2018-03-14T22:26:08.534Z,1521066368.534 [BPC1](INFO): Starting 2018-03-14T22:26:08.930Z,1521066368.930 [BPC1](INFO): Starting 2018-03-14T22:26:09.331Z,1521066369.331 [BPC1](INFO): Starting 2018-03-14T22:26:09.720Z,1521066369.720 [BPC1](INFO): Starting 2018-03-14T22:26:10.120Z,1521066370.120 [BPC1](INFO): Starting 2018-03-14T22:26:10.519Z,1521066370.519 [BPC1](INFO): Starting 2018-03-14T22:26:10.923Z,1521066370.923 [BPC1](INFO): Starting 2018-03-14T22:26:11.322Z,1521066371.322 [BPC1](INFO): Starting 2018-03-14T22:26:11.724Z,1521066371.724 [BPC1](INFO): Starting 2018-03-14T22:26:12.243Z,1521066372.243 [BPC1](INFO): Starting 2018-03-14T22:26:12.631Z,1521066372.631 [BPC1](INFO): Starting 2018-03-14T22:26:13.046Z,1521066373.046 [BPC1](INFO): Starting 2018-03-14T22:26:13.455Z,1521066373.455 [BPC1](INFO): Starting 2018-03-14T22:26:13.844Z,1521066373.844 [BPC1](INFO): Starting 2018-03-14T22:26:14.251Z,1521066374.251 [BPC1](INFO): Starting 2018-03-14T22:26:14.647Z,1521066374.647 [BPC1](INFO): Starting 2018-03-14T22:26:15.043Z,1521066375.043 [BPC1](INFO): Starting 2018-03-14T22:26:15.435Z,1521066375.435 [BPC1](INFO): Starting 2018-03-14T22:26:15.837Z,1521066375.837 [BPC1](INFO): Starting 2018-03-14T22:26:16.233Z,1521066376.233 [BPC1](INFO): Starting 2018-03-14T22:26:16.639Z,1521066376.639 [BPC1](INFO): Starting 2018-03-14T22:26:17.024Z,1521066377.024 [BPC1](INFO): Starting 2018-03-14T22:26:17.424Z,1521066377.424 [BPC1](INFO): Starting 2018-03-14T22:26:17.829Z,1521066377.829 [BPC1](INFO): Starting 2018-03-14T22:26:18.251Z,1521066378.251 [BPC1](INFO): Starting 2018-03-14T22:26:18.651Z,1521066378.651 [BPC1](INFO): Starting 2018-03-14T22:26:19.053Z,1521066379.053 [BPC1](INFO): Starting 2018-03-14T22:26:19.461Z,1521066379.461 [BPC1](INFO): Starting 2018-03-14T22:26:19.843Z,1521066379.843 [BPC1](INFO): Starting 2018-03-14T22:26:20.232Z,1521066380.232 [BPC1](INFO): Starting 2018-03-14T22:26:20.631Z,1521066380.631 [BPC1](INFO): Starting 2018-03-14T22:26:21.032Z,1521066381.032 [BPC1](INFO): Starting 2018-03-14T22:26:21.435Z,1521066381.435 [BPC1](INFO): Starting 2018-03-14T22:26:21.839Z,1521066381.839 [BPC1](INFO): Starting 2018-03-14T22:26:22.238Z,1521066382.238 [BPC1](INFO): Starting 2018-03-14T22:26:22.629Z,1521066382.629 [BPC1](INFO): Starting 2018-03-14T22:26:23.025Z,1521066383.025 [BPC1](INFO): Starting 2018-03-14T22:26:23.461Z,1521066383.461 [BPC1](INFO): Starting 2018-03-14T22:26:23.477Z,1521066383.477 [SBIT](IMPORTANT): SBIT PASSED 2018-03-14T22:26:23.851Z,1521066383.851 [BPC1](INFO): Starting 2018-03-14T22:26:23.875Z,1521066383.875 [MissionManager](IMPORTANT): Started mission Startup 2018-03-14T22:26:23.875Z,1521066383.875 [Startup] Running Loop=1 2018-03-14T22:26:23.875Z,1521066383.875 [Startup](DEBUG): Aggregate::initialize Startup 2018-03-14T22:26:23.875Z,1521066383.875 [Startup:A.GoToSurface] Running Loop=1 2018-03-14T22:26:23.875Z,1521066383.875 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2018-03-14T22:26:23.876Z,1521066383.876 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2018-03-14T22:26:23.877Z,1521066383.877 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2018-03-14T22:26:23.877Z,1521066383.877 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2018-03-14T22:26:23.877Z,1521066383.877 [Startup:A.GoToSurface](DEBUG): No pitch timeout specified. Using default value of 30.000000 seconds. 2018-03-14T22:26:23.878Z,1521066383.878 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2018-03-14T22:26:23.883Z,1521066383.883 [Startup:StartupSatComms] Running Loop=1 2018-03-14T22:26:23.884Z,1521066383.884 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms 2018-03-14T22:26:23.884Z,1521066383.884 [Startup:StartupSatComms:A] Running Loop=1 2018-03-14T22:26:24.271Z,1521066384.271 [BPC1](INFO): Starting 2018-03-14T22:26:24.287Z,1521066384.287 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix 2018-03-14T22:26:24.655Z,1521066384.655 [BPC1](INFO): Starting 2018-03-14T22:26:25.036Z,1521066385.036 [BPC1](INFO): Starting 2018-03-14T22:26:25.432Z,1521066385.432 [BPC1](INFO): Starting 2018-03-14T22:26:25.839Z,1521066385.839 [BPC1](INFO): Starting 2018-03-14T22:26:26.232Z,1521066386.232 [BPC1](INFO): Starting 2018-03-14T22:26:26.635Z,1521066386.635 [BPC1](INFO): Starting 2018-03-14T22:26:27.038Z,1521066387.038 [BPC1](INFO): Starting 2018-03-14T22:26:27.424Z,1521066387.424 [BPC1](INFO): Starting 2018-03-14T22:26:27.829Z,1521066387.829 [BPC1](INFO): Starting 2018-03-14T22:26:28.229Z,1521066388.229 [BPC1](INFO): Starting 2018-03-14T22:26:28.654Z,1521066388.654 [BPC1](INFO): Starting 2018-03-14T22:26:29.061Z,1521066389.061 [BPC1](INFO): Starting 2018-03-14T22:26:29.455Z,1521066389.455 [BPC1](INFO): Starting 2018-03-14T22:26:29.860Z,1521066389.860 [BPC1](INFO): Starting 2018-03-14T22:26:30.237Z,1521066390.237 [BPC1](INFO): Starting 2018-03-14T22:26:30.636Z,1521066390.636 [BPC1](INFO): Starting 2018-03-14T22:26:31.036Z,1521066391.036 [BPC1](INFO): Starting 2018-03-14T22:26:31.433Z,1521066391.433 [BPC1](INFO): Starting 2018-03-14T22:26:31.836Z,1521066391.836 [BPC1](INFO): Starting 2018-03-14T22:26:32.229Z,1521066392.229 [BPC1](INFO): Starting 2018-03-14T22:26:32.625Z,1521066392.625 [BPC1](INFO): Starting 2018-03-14T22:26:33.029Z,1521066393.029 [BPC1](INFO): Starting 2018-03-14T22:26:33.428Z,1521066393.428 [BPC1](INFO): Starting 2018-03-14T22:26:33.859Z,1521066393.859 [BPC1](INFO): Starting 2018-03-14T22:26:34.259Z,1521066394.259 [BPC1](INFO): Starting 2018-03-14T22:26:34.643Z,1521066394.643 [BPC1](INFO): Starting 2018-03-14T22:26:35.047Z,1521066395.047 [BPC1](INFO): Starting 2018-03-14T22:26:35.434Z,1521066395.434 [BPC1](INFO): Starting 2018-03-14T22:26:35.836Z,1521066395.836 [BPC1](INFO): Starting 2018-03-14T22:26:36.232Z,1521066396.232 [BPC1](INFO): Starting 2018-03-14T22:26:36.635Z,1521066396.635 [BPC1](INFO): Starting 2018-03-14T22:26:37.033Z,1521066397.033 [BPC1](INFO): Starting 2018-03-14T22:26:37.425Z,1521066397.425 [BPC1](INFO): Starting 2018-03-14T22:26:37.824Z,1521066397.824 [BPC1](INFO): Starting 2018-03-14T22:26:38.224Z,1521066398.224 [BPC1](INFO): Starting 2018-03-14T22:26:38.625Z,1521066398.625 [BPC1](INFO): Starting 2018-03-14T22:26:39.043Z,1521066399.043 [BPC1](INFO): Starting 2018-03-14T22:26:39.435Z,1521066399.435 [BPC1](INFO): Starting 2018-03-14T22:26:39.856Z,1521066399.856 [BPC1](INFO): Starting 2018-03-14T22:26:40.260Z,1521066400.260 [BPC1](INFO): Starting 2018-03-14T22:26:40.639Z,1521066400.639 [BPC1](INFO): Starting 2018-03-14T22:26:41.031Z,1521066401.031 [BPC1](INFO): Starting 2018-03-14T22:26:41.443Z,1521066401.443 [BPC1](INFO): Starting 2018-03-14T22:26:41.833Z,1521066401.833 [BPC1](INFO): Starting 2018-03-14T22:26:42.237Z,1521066402.237 [BPC1](INFO): Starting 2018-03-14T22:26:42.629Z,1521066402.629 [BPC1](INFO): Starting 2018-03-14T22:26:43.029Z,1521066403.029 [BPC1](INFO): Starting 2018-03-14T22:26:43.425Z,1521066403.425 [BPC1](INFO): Starting 2018-03-14T22:26:43.825Z,1521066403.825 [BPC1](INFO): Starting 2018-03-14T22:26:44.240Z,1521066404.240 [BPC1](INFO): Starting 2018-03-14T22:26:44.654Z,1521066404.654 [BPC1](INFO): Starting 2018-03-14T22:26:45.046Z,1521066405.046 [BPC1](INFO): Starting 2018-03-14T22:26:45.467Z,1521066405.467 [BPC1](INFO): Starting 2018-03-14T22:26:45.832Z,1521066405.832 [BPC1](INFO): Starting 2018-03-14T22:26:46.228Z,1521066406.228 [BPC1](INFO): Starting 2018-03-14T22:26:46.635Z,1521066406.635 [BPC1](INFO): Starting 2018-03-14T22:26:47.035Z,1521066407.035 [BPC1](INFO): Starting 2018-03-14T22:26:47.424Z,1521066407.424 [BPC1](INFO): Starting 2018-03-14T22:26:47.824Z,1521066407.824 [BPC1](INFO): Starting 2018-03-14T22:26:48.225Z,1521066408.225 [BPC1](INFO): Starting 2018-03-14T22:26:48.624Z,1521066408.624 [BPC1](INFO): Starting 2018-03-14T22:26:49.024Z,1521066409.024 [BPC1](INFO): Starting 2018-03-14T22:26:49.461Z,1521066409.461 [BPC1](INFO): Starting 2018-03-14T22:26:49.845Z,1521066409.845 [BPC1](INFO): Starting 2018-03-14T22:26:50.255Z,1521066410.255 [BPC1](INFO): Starting 2018-03-14T22:26:50.639Z,1521066410.639 [BPC1](INFO): Starting 2018-03-14T22:26:51.032Z,1521066411.032 [BPC1](INFO): Starting 2018-03-14T22:26:51.432Z,1521066411.432 [BPC1](INFO): Starting 2018-03-14T22:26:51.835Z,1521066411.835 [BPC1](INFO): Starting 2018-03-14T22:26:52.238Z,1521066412.238 [BPC1](INFO): Starting 2018-03-14T22:26:52.628Z,1521066412.628 [BPC1](INFO): Starting 2018-03-14T22:26:53.024Z,1521066413.024 [BPC1](INFO): Starting 2018-03-14T22:26:53.432Z,1521066413.432 [BPC1](INFO): Starting 2018-03-14T22:26:53.824Z,1521066413.824 [BPC1](INFO): Starting 2018-03-14T22:26:54.229Z,1521066414.229 [BPC1](INFO): Starting 2018-03-14T22:26:54.660Z,1521066414.660 [BPC1](INFO): Starting 2018-03-14T22:26:55.067Z,1521066415.067 [BPC1](INFO): Starting 2018-03-14T22:26:55.459Z,1521066415.459 [BPC1](INFO): Starting 2018-03-14T22:26:55.841Z,1521066415.841 [BPC1](INFO): Starting 2018-03-14T22:26:56.235Z,1521066416.235 [BPC1](INFO): Starting 2018-03-14T22:26:56.632Z,1521066416.632 [BPC1](INFO): Starting 2018-03-14T22:26:57.032Z,1521066417.032 [BPC1](INFO): Starting 2018-03-14T22:26:57.424Z,1521066417.424 [BPC1](INFO): Starting 2018-03-14T22:26:57.825Z,1521066417.825 [BPC1](INFO): Starting 2018-03-14T22:26:58.224Z,1521066418.224 [BPC1](INFO): Starting 2018-03-14T22:26:58.624Z,1521066418.624 [BPC1](INFO): Starting 2018-03-14T22:26:59.032Z,1521066419.032 [BPC1](INFO): Starting 2018-03-14T22:26:59.434Z,1521066419.434 [BPC1](INFO): Starting 2018-03-14T22:26:59.842Z,1521066419.842 [BPC1](INFO): Starting 2018-03-14T22:27:00.239Z,1521066420.239 [BPC1](INFO): Starting 2018-03-14T22:27:00.640Z,1521066420.640 [BPC1](INFO): Starting 2018-03-14T22:27:01.041Z,1521066421.041 [BPC1](INFO): Starting 2018-03-14T22:27:01.451Z,1521066421.451 [BPC1](INFO): Starting 2018-03-14T22:27:01.837Z,1521066421.837 [BPC1](INFO): Starting 2018-03-14T22:27:02.236Z,1521066422.236 [BPC1](INFO): Starting 2018-03-14T22:27:02.630Z,1521066422.630 [BPC1](INFO): Starting 2018-03-14T22:27:03.024Z,1521066423.024 [BPC1](INFO): Starting 2018-03-14T22:27:03.424Z,1521066423.424 [BPC1](INFO): Starting 2018-03-14T22:27:03.825Z,1521066423.825 [BPC1](INFO): Starting 2018-03-14T22:27:04.234Z,1521066424.234 [BPC1](INFO): Starting 2018-03-14T22:27:04.632Z,1521066424.632 [BPC1](INFO): Starting 2018-03-14T22:27:05.039Z,1521066425.039 [BPC1](INFO): Starting 2018-03-14T22:27:05.454Z,1521066425.454 [BPC1](INFO): Starting 2018-03-14T22:27:05.845Z,1521066425.845 [BPC1](INFO): Starting 2018-03-14T22:27:06.255Z,1521066426.255 [BPC1](INFO): Starting 2018-03-14T22:27:06.641Z,1521066426.641 [BPC1](INFO): Starting 2018-03-14T22:27:07.040Z,1521066427.040 [BPC1](INFO): Starting 2018-03-14T22:27:07.433Z,1521066427.433 [BPC1](INFO): Starting 2018-03-14T22:27:07.825Z,1521066427.825 [BPC1](INFO): Starting 2018-03-14T22:27:08.228Z,1521066428.228 [BPC1](INFO): Starting 2018-03-14T22:27:08.629Z,1521066428.629 [BPC1](INFO): Starting 2018-03-14T22:27:09.024Z,1521066429.024 [BPC1](INFO): Starting 2018-03-14T22:27:09.428Z,1521066429.428 [BPC1](INFO): Starting 2018-03-14T22:27:09.833Z,1521066429.833 [BPC1](INFO): Starting 2018-03-14T22:27:10.246Z,1521066430.246 [BPC1](INFO): Starting 2018-03-14T22:27:10.649Z,1521066430.649 [BPC1](INFO): Starting 2018-03-14T22:27:11.051Z,1521066431.051 [BPC1](INFO): Starting 2018-03-14T22:27:11.437Z,1521066431.437 [BPC1](INFO): Starting 2018-03-14T22:27:11.835Z,1521066431.835 [BPC1](INFO): Starting 2018-03-14T22:27:12.235Z,1521066432.235 [BPC1](INFO): Starting 2018-03-14T22:27:12.625Z,1521066432.625 [BPC1](INFO): Starting 2018-03-14T22:27:13.028Z,1521066433.028 [BPC1](INFO): Starting 2018-03-14T22:27:13.425Z,1521066433.425 [BPC1](INFO): Starting 2018-03-14T22:27:13.824Z,1521066433.824 [BPC1](INFO): Starting 2018-03-14T22:27:14.228Z,1521066434.228 [BPC1](INFO): Starting 2018-03-14T22:27:14.629Z,1521066434.629 [BPC1](INFO): Starting 2018-03-14T22:27:15.032Z,1521066435.032 [BPC1](INFO): Starting 2018-03-14T22:27:15.452Z,1521066435.452 [BPC1](INFO): Starting 2018-03-14T22:27:15.863Z,1521066435.863 [BPC1](INFO): Starting 2018-03-14T22:27:16.248Z,1521066436.248 [BPC1](INFO): Starting 2018-03-14T22:27:16.641Z,1521066436.641 [BPC1](INFO): Starting 2018-03-14T22:27:17.038Z,1521066437.038 [BPC1](INFO): Starting 2018-03-14T22:27:17.440Z,1521066437.440 [BPC1](INFO): Starting 2018-03-14T22:27:17.842Z,1521066437.842 [BPC1](INFO): Starting 2018-03-14T22:27:18.233Z,1521066438.233 [BPC1](INFO): Starting 2018-03-14T22:27:18.624Z,1521066438.624 [BPC1](INFO): Starting 2018-03-14T22:27:19.028Z,1521066439.028 [BPC1](INFO): Starting 2018-03-14T22:27:19.425Z,1521066439.425 [BPC1](INFO): Starting 2018-03-14T22:27:19.824Z,1521066439.824 [BPC1](INFO): Starting 2018-03-14T22:27:20.229Z,1521066440.229 [BPC1](INFO): Starting 2018-03-14T22:27:20.655Z,1521066440.655 [BPC1](INFO): Starting 2018-03-14T22:27:21.048Z,1521066441.048 [BPC1](INFO): Starting 2018-03-14T22:27:21.454Z,1521066441.454 [BPC1](INFO): Starting 2018-03-14T22:27:21.849Z,1521066441.849 [BPC1](INFO): Starting 2018-03-14T22:27:22.247Z,1521066442.247 [BPC1](INFO): Starting 2018-03-14T22:27:22.632Z,1521066442.632 [BPC1](INFO): Starting 2018-03-14T22:27:23.034Z,1521066443.034 [BPC1](INFO): Starting 2018-03-14T22:27:23.425Z,1521066443.425 [BPC1](INFO): Starting 2018-03-14T22:27:23.829Z,1521066443.829 [BPC1](INFO): Starting 2018-03-14T22:27:24.226Z,1521066444.226 [BPC1](INFO): Starting 2018-03-14T22:27:24.249Z,1521066444.249 [Startup:StartupSatComms:A](INFO): Timed out from 2018-03-14T22:26:23.9Z 2018-03-14T22:27:24.250Z,1521066444.250 [Startup:StartupSatComms:A] Stopped 2018-03-14T22:27:24.250Z,1521066444.250 [Startup:StartupSatComms:B] Running Loop=1 2018-03-14T22:27:24.624Z,1521066444.624 [BPC1](INFO): Starting 2018-03-14T22:27:24.669Z,1521066444.669 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications 2018-03-14T22:27:25.034Z,1521066445.034 [BPC1](INFO): Starting 2018-03-14T22:27:25.432Z,1521066445.432 [BPC1](INFO): Starting 2018-03-14T22:27:25.839Z,1521066445.839 [BPC1](INFO): Starting 2018-03-14T22:27:26.237Z,1521066446.237 [BPC1](INFO): Starting 2018-03-14T22:27:26.642Z,1521066446.642 [BPC1](INFO): Starting 2018-03-14T22:27:27.055Z,1521066447.055 [BPC1](INFO): Starting 2018-03-14T22:27:27.435Z,1521066447.435 [BPC1](INFO): Starting 2018-03-14T22:27:27.833Z,1521066447.833 [BPC1](INFO): Starting 2018-03-14T22:27:28.224Z,1521066448.224 [BPC1](INFO): Starting 2018-03-14T22:27:28.628Z,1521066448.628 [BPC1](INFO): Starting 2018-03-14T22:27:29.026Z,1521066449.026 [BPC1](INFO): Starting 2018-03-14T22:27:29.428Z,1521066449.428 [BPC1](INFO): Starting 2018-03-14T22:27:29.834Z,1521066449.834 [BPC1](INFO): Starting 2018-03-14T22:27:30.232Z,1521066450.232 [BPC1](INFO): Starting 2018-03-14T22:27:30.628Z,1521066450.628 [BPC1](INFO): Starting 2018-03-14T22:27:31.047Z,1521066451.047 [BPC1](INFO): Starting 2018-03-14T22:27:31.445Z,1521066451.445 [BPC1](INFO): Starting 2018-03-14T22:27:31.863Z,1521066451.863 [BPC1](INFO): Starting 2018-03-14T22:27:32.242Z,1521066452.242 [BPC1](INFO): Starting 2018-03-14T22:27:32.633Z,1521066452.633 [BPC1](INFO): Starting 2018-03-14T22:27:33.024Z,1521066453.024 [BPC1](INFO): Starting 2018-03-14T22:27:33.428Z,1521066453.428 [BPC1](INFO): Starting 2018-03-14T22:27:33.826Z,1521066453.826 [BPC1](INFO): Starting 2018-03-14T22:27:34.237Z,1521066454.237 [BPC1](INFO): Starting 2018-03-14T22:27:34.634Z,1521066454.634 [BPC1](INFO): Starting 2018-03-14T22:27:35.032Z,1521066455.032 [BPC1](INFO): Starting 2018-03-14T22:27:35.431Z,1521066455.431 [BPC1](INFO): Starting 2018-03-14T22:27:35.836Z,1521066455.836 [BPC1](INFO): Starting 2018-03-14T22:27:36.251Z,1521066456.251 [BPC1](INFO): Starting 2018-03-14T22:27:36.659Z,1521066456.659 [BPC1](INFO): Starting 2018-03-14T22:27:37.051Z,1521066457.051 [BPC1](INFO): Starting 2018-03-14T22:27:37.451Z,1521066457.451 [BPC1](INFO): Starting 2018-03-14T22:27:37.848Z,1521066457.848 [BPC1](INFO): Starting 2018-03-14T22:27:38.251Z,1521066458.251 [BPC1](INFO): Starting 2018-03-14T22:27:38.646Z,1521066458.646 [BPC1](INFO): Starting 2018-03-14T22:27:39.041Z,1521066459.041 [BPC1](INFO): Starting 2018-03-14T22:27:39.445Z,1521066459.445 [BPC1](INFO): Starting 2018-03-14T22:27:39.847Z,1521066459.847 [BPC1](INFO): Starting 2018-03-14T22:27:40.230Z,1521066460.230 [BPC1](INFO): Starting 2018-03-14T22:27:40.640Z,1521066460.640 [BPC1](INFO): Starting 2018-03-14T22:27:41.041Z,1521066461.041 [BPC1](INFO): Starting 2018-03-14T22:27:41.475Z,1521066461.475 [BPC1](INFO): Starting 2018-03-14T22:27:41.863Z,1521066461.863 [BPC1](INFO): Starting 2018-03-14T22:27:42.277Z,1521066462.277 [BPC1](INFO): Starting 2018-03-14T22:27:42.652Z,1521066462.652 [BPC1](INFO): Starting 2018-03-14T22:27:43.045Z,1521066463.045 [BPC1](INFO): Starting 2018-03-14T22:27:43.440Z,1521066463.440 [BPC1](INFO): Starting 2018-03-14T22:27:43.846Z,1521066463.846 [BPC1](INFO): Starting 2018-03-14T22:27:44.241Z,1521066464.241 [BPC1](INFO): Starting 2018-03-14T22:27:44.659Z,1521066464.659 [BPC1](INFO): Starting 2018-03-14T22:27:45.041Z,1521066465.041 [BPC1](INFO): Starting 2018-03-14T22:27:45.444Z,1521066465.444 [BPC1](INFO): Starting 2018-03-14T22:27:45.851Z,1521066465.851 [BPC1](INFO): Starting 2018-03-14T22:27:46.259Z,1521066466.259 [BPC1](INFO): Starting 2018-03-14T22:27:46.641Z,1521066466.641 [BPC1](INFO): Starting 2018-03-14T22:27:47.055Z,1521066467.055 [BPC1](INFO): Starting 2018-03-14T22:27:47.459Z,1521066467.459 [BPC1](INFO): Starting 2018-03-14T22:27:47.859Z,1521066467.859 [BPC1](INFO): Starting 2018-03-14T22:27:48.226Z,1521066468.226 [BPC1](INFO): Starting 2018-03-14T22:27:48.624Z,1521066468.624 [BPC1](INFO): Starting 2018-03-14T22:27:49.034Z,1521066469.034 [BPC1](INFO): Starting 2018-03-14T22:27:49.433Z,1521066469.433 [BPC1](INFO): Starting 2018-03-14T22:27:49.833Z,1521066469.833 [BPC1](INFO): Starting 2018-03-14T22:27:50.232Z,1521066470.232 [BPC1](INFO): Starting 2018-03-14T22:27:50.625Z,1521066470.625 [BPC1](INFO): Starting 2018-03-14T22:27:51.029Z,1521066471.029 [BPC1](INFO): Starting 2018-03-14T22:27:51.424Z,1521066471.424 [BPC1](INFO): Starting 2018-03-14T22:27:51.851Z,1521066471.851 [BPC1](INFO): Starting 2018-03-14T22:27:52.245Z,1521066472.245 [BPC1](INFO): Starting 2018-03-14T22:27:52.655Z,1521066472.655 [BPC1](INFO): Starting 2018-03-14T22:27:53.061Z,1521066473.061 [BPC1](INFO): Starting 2018-03-14T22:27:53.447Z,1521066473.447 [BPC1](INFO): Starting 2018-03-14T22:27:53.834Z,1521066473.834 [BPC1](INFO): Starting 2018-03-14T22:27:54.228Z,1521066474.228 [BPC1](INFO): Starting 2018-03-14T22:27:54.631Z,1521066474.631 [BPC1](INFO): Starting 2018-03-14T22:27:55.035Z,1521066475.035 [BPC1](INFO): Starting 2018-03-14T22:27:55.434Z,1521066475.434 [BPC1](INFO): Starting 2018-03-14T22:27:55.824Z,1521066475.824 [BPC1](INFO): Starting 2018-03-14T22:27:56.224Z,1521066476.224 [BPC1](INFO): Starting 2018-03-14T22:27:56.625Z,1521066476.625 [BPC1](INFO): Starting 2018-03-14T22:27:57.052Z,1521066477.052 [BPC1](INFO): Starting 2018-03-14T22:27:57.447Z,1521066477.447 [BPC1](INFO): Starting 2018-03-14T22:27:57.851Z,1521066477.851 [BPC1](INFO): Starting 2018-03-14T22:27:58.253Z,1521066478.253 [BPC1](INFO): Starting 2018-03-14T22:27:58.647Z,1521066478.647 [BPC1](INFO): Starting 2018-03-14T22:27:59.039Z,1521066479.039 [BPC1](INFO): Starting 2018-03-14T22:27:59.433Z,1521066479.433 [BPC1](INFO): Starting 2018-03-14T22:27:59.835Z,1521066479.835 [BPC1](INFO): Starting 2018-03-14T22:28:00.225Z,1521066480.225 [BPC1](INFO): Starting 2018-03-14T22:28:00.624Z,1521066480.624 [BPC1](INFO): Starting 2018-03-14T22:28:01.029Z,1521066481.029 [BPC1](INFO): Starting 2018-03-14T22:28:01.433Z,1521066481.433 [BPC1](INFO): Starting 2018-03-14T22:28:01.835Z,1521066481.835 [BPC1](INFO): Starting 2018-03-14T22:28:02.259Z,1521066482.259 [BPC1](INFO): Starting 2018-03-14T22:28:02.649Z,1521066482.649 [BPC1](INFO): Starting 2018-03-14T22:28:03.042Z,1521066483.042 [BPC1](INFO): Starting 2018-03-14T22:28:03.439Z,1521066483.439 [BPC1](INFO): Starting 2018-03-14T22:28:03.843Z,1521066483.843 [BPC1](INFO): Starting 2018-03-14T22:28:04.231Z,1521066484.231 [BPC1](INFO): Starting 2018-03-14T22:28:04.635Z,1521066484.635 [BPC1](INFO): Starting 2018-03-14T22:28:05.035Z,1521066485.035 [BPC1](INFO): Starting 2018-03-14T22:28:05.424Z,1521066485.424 [BPC1](INFO): Starting 2018-03-14T22:28:05.824Z,1521066485.824 [BPC1](INFO): Starting 2018-03-14T22:28:06.224Z,1521066486.224 [BPC1](INFO): Starting 2018-03-14T22:28:06.253Z,1521066486.253 [DeadReckonUsingSpeedCalculator](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-03-14T22:28:06.253Z,1521066486.253 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 1 2018-03-14T22:28:06.253Z,1521066486.253 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2018-03-14T22:28:06.259Z,1521066486.259 [DeadReckonWithRespectToSeafloor](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-03-14T22:28:06.259Z,1521066486.259 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1 2018-03-14T22:28:06.259Z,1521066486.259 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2018-03-14T22:28:06.292Z,1521066486.292 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2018-03-14T22:28:06.292Z,1521066486.292 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2018-03-14T22:28:06.630Z,1521066486.630 [BPC1](INFO): Starting 2018-03-14T22:28:06.682Z,1521066486.682 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2018-03-14T22:28:06.682Z,1521066486.682 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 1 2018-03-14T22:28:06.690Z,1521066486.690 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2018-03-14T22:28:06.690Z,1521066486.690 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1 2018-03-14T22:28:07.041Z,1521066487.041 [BPC1](INFO): Starting 2018-03-14T22:28:07.074Z,1521066487.074 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2018-03-14T22:28:07.074Z,1521066487.074 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s. 2018-03-14T22:28:07.079Z,1521066487.079 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s. 2018-03-14T22:28:07.079Z,1521066487.079 [DeadReckonWithRespectToSeafloor](DEBUG): Initializing DeadReckonWithRespectToSeafloor component. 2018-03-14T22:28:07.079Z,1521066487.079 [DeadReckonWithRespectToSeafloor](INFO): Will consider orientation measurement stale after 120s. 2018-03-14T22:28:07.080Z,1521066487.080 [DeadReckonWithRespectToSeafloor](INFO): Will consider velocity measurement stale after 20s. 2018-03-14T22:28:10.180Z,1521066490.180 [BPC1](INFO): Starting 2018-03-14T22:28:10.323Z,1521066490.323 [BPC1](INFO): Starting 2018-03-14T22:28:10.684Z,1521066490.684 [BPC1](INFO): Starting 2018-03-14T22:28:11.034Z,1521066491.034 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.003722 2018-03-14T22:28:11.099Z,1521066491.099 [BPC1](INFO): Starting 2018-03-14T22:28:11.599Z,1521066491.599 [BPC1](INFO): Starting 2018-03-14T22:28:11.875Z,1521066491.875 [BPC1](INFO): Starting 2018-03-14T22:28:15.207Z,1521066495.207 [BPC1](INFO): Starting 2018-03-14T22:28:15.261Z,1521066495.261 [DataOverHttps](INFO): Sending 25 bytes from file Logs/20180314T220936/Courier0008.lzma 2018-03-14T22:28:15.379Z,1521066495.379 [BPC1](INFO): Starting 2018-03-14T22:28:15.711Z,1521066495.711 [BPC1](INFO): Starting 2018-03-14T22:28:16.059Z,1521066496.059 [DataOverHttps](INFO): Moved sent file to Logs/20180314T220936/Courier0008.lzma.bak 2018-03-14T22:28:16.060Z,1521066496.059 [DataOverHttps](INFO): SBD MOMSN=8061781 2018-03-14T22:28:16.113Z,1521066496.113 [BPC1](INFO): Starting 2018-03-14T22:28:16.757Z,1521066496.757 [BPC1](INFO): Starting 2018-03-14T22:28:16.915Z,1521066496.915 [BPC1](INFO): Starting 2018-03-14T22:28:20.231Z,1521066500.231 [BPC1](INFO): Starting 2018-03-14T22:28:20.353Z,1521066500.353 [BPC1](INFO): Starting 2018-03-14T22:28:20.759Z,1521066500.759 [BPC1](INFO): Starting 2018-03-14T22:28:21.151Z,1521066501.151 [BPC1](INFO): Starting 2018-03-14T22:28:21.539Z,1521066501.539 [BPC1](INFO): Starting 2018-03-14T22:28:21.941Z,1521066501.941 [BPC1](INFO): Starting 2018-03-14T22:28:25.085Z,1521066505.085 [BPC1](INFO): Starting 2018-03-14T22:28:25.095Z,1521066505.095 [Startup:StartupSatComms:B](INFO): Timed out from 2018-03-14T22:27:24.2Z 2018-03-14T22:28:25.095Z,1521066505.095 [Startup:StartupSatComms:B] Stopped 2018-03-14T22:28:25.095Z,1521066505.095 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms 2018-03-14T22:28:25.095Z,1521066505.095 [Startup:StartupSatComms] Stopped 2018-03-14T22:28:25.095Z,1521066505.095 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms 2018-03-14T22:28:25.096Z,1521066505.096 [Startup](INFO): Completed Startup 2018-03-14T22:28:25.096Z,1521066505.096 [MissionManager](INFO): Startup is completed. 2018-03-14T22:28:25.097Z,1521066505.097 [MissionManager](INFO): Uninitializing Mission Startup 2018-03-14T22:28:25.097Z,1521066505.097 [Startup] Stopped 2018-03-14T22:28:25.097Z,1521066505.097 [Startup](DEBUG): Aggregate::uninitialize Startup 2018-03-14T22:28:25.097Z,1521066505.097 [Startup:A.GoToSurface] Stopped 2018-03-14T22:28:25.097Z,1521066505.097 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2018-03-14T22:28:25.140Z,1521066505.140 [DataOverHttps](INFO): Sending 241 bytes from file Logs/20180314T220936/Express0009.lzma 2018-03-14T22:28:25.250Z,1521066505.250 [BPC1](INFO): Starting 2018-03-14T22:28:25.278Z,1521066505.278 [MissionManager](IMPORTANT): Started mission Default 2018-03-14T22:28:25.278Z,1521066505.278 [Default] Running Loop=1 2018-03-14T22:28:25.278Z,1521066505.278 [Default](DEBUG): Aggregate::initialize Default 2018-03-14T22:28:25.282Z,1521066505.282 [Default:B.GoToSurface] Running Loop=1 2018-03-14T22:28:25.283Z,1521066505.283 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2018-03-14T22:28:25.283Z,1521066505.283 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2018-03-14T22:28:25.283Z,1521066505.283 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2018-03-14T22:28:25.283Z,1521066505.283 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2018-03-14T22:28:25.284Z,1521066505.284 [Default:B.GoToSurface](DEBUG): No pitch timeout specified. Using default value of 30.000000 seconds. 2018-03-14T22:28:25.284Z,1521066505.284 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2018-03-14T22:28:25.284Z,1521066505.284 [Default:A.Wait] Running Loop=1 2018-03-14T22:28:25.284Z,1521066505.284 [Default:A.Wait](DEBUG): Initialize Wait Component. 2018-03-14T22:28:25.567Z,1521066505.567 [BPC1](INFO): Starting 2018-03-14T22:28:25.915Z,1521066505.915 [DataOverHttps](INFO): Moved sent file to Logs/20180314T220936/Express0009.lzma.bak 2018-03-14T22:28:25.915Z,1521066505.915 [DataOverHttps](INFO): SBD MOMSN=8061783 2018-03-14T22:28:25.983Z,1521066505.983 [BPC1](INFO): Starting 2018-03-14T22:28:26.353Z,1521066506.353 [BPC1](INFO): Starting 2018-03-14T22:28:26.745Z,1521066506.745 [BPC1](INFO): Starting 2018-03-14T22:28:29.895Z,1521066509.895 [BPC1](INFO): Starting 2018-03-14T22:28:30.035Z,1521066510.035 [BPC1](INFO): Starting 2018-03-14T22:28:30.424Z,1521066510.424 [BPC1](INFO): Starting 2018-03-14T22:28:30.807Z,1521066510.807 [BPC1](INFO): Starting 2018-03-14T22:28:31.192Z,1521066511.192 [BPC1](INFO): Starting 2018-03-14T22:28:31.591Z,1521066511.591 [BPC1](INFO): Starting 2018-03-14T22:28:31.995Z,1521066511.995 [BPC1](INFO): Starting 2018-03-14T22:28:32.397Z,1521066512.397 [BPC1](INFO): Starting 2018-03-14T22:28:32.806Z,1521066512.806 [BPC1](INFO): Starting 2018-03-14T22:28:33.196Z,1521066513.196 [BPC1](INFO): Starting 2018-03-14T22:28:33.588Z,1521066513.588 [BPC1](INFO): Starting 2018-03-14T22:28:33.988Z,1521066513.988 [BPC1](INFO): Starting 2018-03-14T22:28:34.389Z,1521066514.389 [BPC1](INFO): Starting 2018-03-14T22:28:34.807Z,1521066514.807 [BPC1](INFO): Starting 2018-03-14T22:28:35.198Z,1521066515.198 [BPC1](INFO): Starting 2018-03-14T22:28:35.614Z,1521066515.614 [BPC1](INFO): Starting 2018-03-14T22:28:35.999Z,1521066515.999 [BPC1](INFO): Starting 2018-03-14T22:28:36.392Z,1521066516.392 [BPC1](INFO): Starting 2018-03-14T22:28:36.792Z,1521066516.792 [BPC1](INFO): Starting 2018-03-14T22:28:37.191Z,1521066517.191 [BPC1](INFO): Starting 2018-03-14T22:28:37.591Z,1521066517.591 [BPC1](INFO): Starting 2018-03-14T22:28:37.995Z,1521066517.995 [BPC1](INFO): Starting 2018-03-14T22:28:38.392Z,1521066518.392 [BPC1](INFO): Starting 2018-03-14T22:28:38.426Z,1521066518.426 [Default:A.Wait](INFO): Done Waiting. 2018-03-14T22:28:38.426Z,1521066518.426 [Default:A.Wait] Stopped 2018-03-14T22:28:38.426Z,1521066518.426 [Default:A.Wait](DEBUG): Uninitialize Wait Component. 2018-03-14T22:28:38.797Z,1521066518.797 [BPC1](INFO): Starting 2018-03-14T22:28:38.808Z,1521066518.808 [Default:CheckIn] Running Loop=1 2018-03-14T22:28:38.808Z,1521066518.808 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2018-03-14T22:28:38.808Z,1521066518.808 [Default:CheckIn:Read_GPS] Running Loop=1 2018-03-14T22:28:39.207Z,1521066519.207 [BPC1](INFO): Starting 2018-03-14T22:28:39.218Z,1521066519.218 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix 2018-03-14T22:28:39.584Z,1521066519.584 [BPC1](INFO): Starting 2018-03-14T22:28:40.006Z,1521066520.006 [BPC1](INFO): Starting 2018-03-14T22:28:40.419Z,1521066520.419 [BPC1](INFO): Starting 2018-03-14T22:28:40.807Z,1521066520.807 [BPC1](INFO): Starting 2018-03-14T22:28:41.203Z,1521066521.203 [BPC1](INFO): Starting 2018-03-14T22:28:41.592Z,1521066521.592 [BPC1](INFO): Starting 2018-03-14T22:28:41.988Z,1521066521.988 [BPC1](INFO): Starting 2018-03-14T22:28:42.395Z,1521066522.395 [BPC1](INFO): Starting 2018-03-14T22:28:42.793Z,1521066522.793 [BPC1](INFO): Starting 2018-03-14T22:28:43.184Z,1521066523.184 [BPC1](INFO): Starting 2018-03-14T22:28:43.584Z,1521066523.584 [BPC1](INFO): Starting 2018-03-14T22:28:43.990Z,1521066523.990 [BPC1](INFO): Starting 2018-03-14T22:28:44.384Z,1521066524.384 [BPC1](INFO): Starting 2018-03-14T22:28:44.784Z,1521066524.784 [BPC1](INFO): Starting 2018-03-14T22:28:45.219Z,1521066525.219 [BPC1](INFO): Starting 2018-03-14T22:28:45.595Z,1521066525.595 [BPC1](INFO): Starting 2018-03-14T22:28:45.999Z,1521066525.999 [BPC1](INFO): Starting 2018-03-14T22:28:46.399Z,1521066526.399 [BPC1](INFO): Starting 2018-03-14T22:28:46.796Z,1521066526.796 [BPC1](INFO): Starting 2018-03-14T22:28:47.195Z,1521066527.195 [BPC1](INFO): Starting 2018-03-14T22:28:47.595Z,1521066527.595 [BPC1](INFO): Starting 2018-03-14T22:28:47.984Z,1521066527.984 [BPC1](INFO): Starting 2018-03-14T22:28:48.384Z,1521066528.384 [BPC1](INFO): Starting 2018-03-14T22:28:48.784Z,1521066528.784 [BPC1](INFO): Starting 2018-03-14T22:28:49.184Z,1521066529.184 [BPC1](INFO): Starting 2018-03-14T22:28:49.584Z,1521066529.584 [BPC1](INFO): Starting 2018-03-14T22:28:49.985Z,1521066529.985 [BPC1](INFO): Starting 2018-03-14T22:28:50.406Z,1521066530.406 [BPC1](INFO): Starting 2018-03-14T22:28:50.819Z,1521066530.819 [BPC1](INFO): Starting 2018-03-14T22:28:51.219Z,1521066531.219 [BPC1](INFO): Starting 2018-03-14T22:28:51.607Z,1521066531.607 [BPC1](INFO): Starting 2018-03-14T22:28:51.987Z,1521066531.987 [BPC1](INFO): Starting 2018-03-14T22:28:52.387Z,1521066532.387 [BPC1](INFO): Starting 2018-03-14T22:28:52.798Z,1521066532.798 [BPC1](INFO): Starting 2018-03-14T22:28:53.203Z,1521066533.203 [BPC1](INFO): Starting 2018-03-14T22:28:53.643Z,1521066533.643 [BPC1](INFO): Starting 2018-03-14T22:28:53.998Z,1521066533.998 [BPC1](INFO): Starting 2018-03-14T22:28:54.389Z,1521066534.389 [BPC1](INFO): Starting 2018-03-14T22:28:54.804Z,1521066534.804 [BPC1](INFO): Starting 2018-03-14T22:28:55.207Z,1521066535.207 [BPC1](INFO): Starting 2018-03-14T22:28:55.625Z,1521066535.625 [BPC1](INFO): Starting 2018-03-14T22:28:56.025Z,1521066536.025 [BPC1](INFO): Starting 2018-03-14T22:28:56.413Z,1521066536.413 [BPC1](INFO): Starting 2018-03-14T22:28:56.819Z,1521066536.819 [BPC1](INFO): Starting 2018-03-14T22:28:57.212Z,1521066537.212 [BPC1](INFO): Starting 2018-03-14T22:28:57.596Z,1521066537.596 [BPC1](INFO): Starting 2018-03-14T22:28:58.003Z,1521066538.003 [BPC1](INFO): Starting 2018-03-14T22:28:58.390Z,1521066538.390 [BPC1](INFO): Starting 2018-03-14T22:28:58.790Z,1521066538.790 [BPC1](INFO): Starting 2018-03-14T22:28:59.227Z,1521066539.227 [BPC1](INFO): Starting 2018-03-14T22:28:59.590Z,1521066539.590 [BPC1](INFO): Starting 2018-03-14T22:29:00.002Z,1521066540.002 [BPC1](INFO): Starting 2018-03-14T22:29:00.399Z,1521066540.399 [BPC1](INFO): Starting 2018-03-14T22:29:00.804Z,1521066540.804 [BPC1](INFO): Starting 2018-03-14T22:29:01.211Z,1521066541.211 [BPC1](INFO): Starting 2018-03-14T22:29:01.602Z,1521066541.602 [BPC1](INFO): Starting 2018-03-14T22:29:02.015Z,1521066542.015 [BPC1](INFO): Starting 2018-03-14T22:29:02.392Z,1521066542.392 [BPC1](INFO): Starting 2018-03-14T22:29:02.792Z,1521066542.792 [BPC1](INFO): Starting 2018-03-14T22:29:03.192Z,1521066543.192 [BPC1](INFO): Starting 2018-03-14T22:29:03.588Z,1521066543.588 [BPC1](INFO): Starting 2018-03-14T22:29:03.992Z,1521066543.992 [BPC1](INFO): Starting 2018-03-14T22:29:04.384Z,1521066544.384 [BPC1](INFO): Starting 2018-03-14T22:29:04.784Z,1521066544.784 [BPC1](INFO): Starting 2018-03-14T22:29:05.189Z,1521066545.189 [BPC1](INFO): Starting 2018-03-14T22:29:05.588Z,1521066545.588 [BPC1](INFO): Starting 2018-03-14T22:29:06.001Z,1521066546.001 [BPC1](INFO): Starting 2018-03-14T22:29:06.393Z,1521066546.393 [BPC1](INFO): Starting 2018-03-14T22:29:06.799Z,1521066546.799 [BPC1](INFO): Starting 2018-03-14T22:29:07.200Z,1521066547.200 [BPC1](INFO): Starting 2018-03-14T22:29:07.591Z,1521066547.591 [BPC1](INFO): Starting 2018-03-14T22:29:08.001Z,1521066548.001 [BPC1](INFO): Starting 2018-03-14T22:29:08.389Z,1521066548.389 [BPC1](INFO): Starting 2018-03-14T22:29:08.817Z,1521066548.817 [BPC1](INFO): Starting 2018-03-14T22:29:09.216Z,1521066549.216 [BPC1](INFO): Starting 2018-03-14T22:29:09.615Z,1521066549.615 [BPC1](INFO): Starting 2018-03-14T22:29:10.017Z,1521066550.017 [BPC1](INFO): Starting 2018-03-14T22:29:10.419Z,1521066550.419 [BPC1](INFO): Starting 2018-03-14T22:29:10.818Z,1521066550.818 [BPC1](INFO): Starting 2018-03-14T22:29:11.219Z,1521066551.219 [BPC1](INFO): Starting 2018-03-14T22:29:11.634Z,1521066551.634 [BPC1](INFO): Starting 2018-03-14T22:29:12.036Z,1521066552.036 [BPC1](INFO): Starting 2018-03-14T22:29:12.409Z,1521066552.409 [BPC1](INFO): Starting 2018-03-14T22:29:12.841Z,1521066552.841 [BPC1](INFO): Starting 2018-03-14T22:29:13.208Z,1521066553.208 [BPC1](INFO): Starting 2018-03-14T22:29:13.616Z,1521066553.616 [BPC1](INFO): Starting 2018-03-14T22:29:14.021Z,1521066554.021 [BPC1](INFO): Starting 2018-03-14T22:29:14.417Z,1521066554.417 [BPC1](INFO): Starting 2018-03-14T22:29:14.821Z,1521066554.821 [BPC1](INFO): Starting 2018-03-14T22:29:15.229Z,1521066555.229 [BPC1](INFO): Starting 2018-03-14T22:29:15.623Z,1521066555.623 [BPC1](INFO): Starting 2018-03-14T22:29:16.001Z,1521066556.001 [BPC1](INFO): Starting 2018-03-14T22:29:16.405Z,1521066556.405 [BPC1](INFO): Starting 2018-03-14T22:29:16.800Z,1521066556.800 [BPC1](INFO): Starting 2018-03-14T22:29:17.215Z,1521066557.215 [BPC1](INFO): Starting 2018-03-14T22:29:17.619Z,1521066557.619 [BPC1](INFO): Starting 2018-03-14T22:29:17.996Z,1521066557.996 [BPC1](INFO): Starting 2018-03-14T22:29:18.398Z,1521066558.398 [BPC1](INFO): Starting 2018-03-14T22:29:18.809Z,1521066558.809 [BPC1](INFO): Starting 2018-03-14T22:29:19.199Z,1521066559.199 [BPC1](INFO): Starting 2018-03-14T22:29:19.603Z,1521066559.603 [BPC1](INFO): Starting 2018-03-14T22:29:19.989Z,1521066559.989 [BPC1](INFO): Starting 2018-03-14T22:29:20.396Z,1521066560.396 [BPC1](INFO): Starting 2018-03-14T22:29:20.798Z,1521066560.798 [BPC1](INFO): Starting 2018-03-14T22:29:21.205Z,1521066561.205 [BPC1](INFO): Starting 2018-03-14T22:29:21.617Z,1521066561.617 [BPC1](INFO): Starting 2018-03-14T22:29:22.038Z,1521066562.038 [BPC1](INFO): Starting 2018-03-14T22:29:22.418Z,1521066562.418 [BPC1](INFO): Starting 2018-03-14T22:29:22.820Z,1521066562.820 [BPC1](INFO): Starting 2018-03-14T22:29:23.189Z,1521066563.189 [BPC1](INFO): Starting 2018-03-14T22:29:23.594Z,1521066563.594 [BPC1](INFO): Starting 2018-03-14T22:29:23.992Z,1521066563.992 [BPC1](INFO): Starting 2018-03-14T22:29:24.393Z,1521066564.393 [BPC1](INFO): Starting 2018-03-14T22:29:24.796Z,1521066564.796 [BPC1](INFO): Starting 2018-03-14T22:29:25.193Z,1521066565.193 [BPC1](INFO): Starting 2018-03-14T22:29:25.592Z,1521066565.592 [BPC1](INFO): Starting 2018-03-14T22:29:25.995Z,1521066565.995 [BPC1](INFO): Starting 2018-03-14T22:29:26.393Z,1521066566.393 [BPC1](INFO): Starting 2018-03-14T22:29:26.823Z,1521066566.823 [BPC1](INFO): Starting 2018-03-14T22:29:29.932Z,1521066569.932 [BPC1](INFO): Starting 2018-03-14T22:29:30.083Z,1521066570.083 [BPC1](INFO): Starting 2018-03-14T22:29:30.438Z,1521066570.438 [BPC1](INFO): Starting 2018-03-14T22:29:30.829Z,1521066570.829 [BPC1](INFO): Starting 2018-03-14T22:29:31.230Z,1521066571.230 [BPC1](INFO): Starting 2018-03-14T22:29:31.639Z,1521066571.639 [BPC1](INFO): Starting 2018-03-14T22:29:32.016Z,1521066572.016 [BPC1](INFO): Starting 2018-03-14T22:29:32.417Z,1521066572.417 [BPC1](INFO): Starting 2018-03-14T22:29:32.816Z,1521066572.816 [BPC1](INFO): Starting 2018-03-14T22:29:33.216Z,1521066573.216 [BPC1](INFO): Starting 2018-03-14T22:29:33.620Z,1521066573.620 [BPC1](INFO): Starting 2018-03-14T22:29:34.025Z,1521066574.025 [BPC1](INFO): Starting 2018-03-14T22:29:34.419Z,1521066574.419 [BPC1](INFO): Starting 2018-03-14T22:29:34.839Z,1521066574.839 [BPC1](INFO): Starting 2018-03-14T22:29:35.239Z,1521066575.239 [BPC1](INFO): Starting 2018-03-14T22:29:35.639Z,1521066575.639 [BPC1](INFO): Starting 2018-03-14T22:29:36.047Z,1521066576.047 [BPC1](INFO): Starting 2018-03-14T22:29:36.422Z,1521066576.422 [BPC1](INFO): Starting 2018-03-14T22:29:36.820Z,1521066576.820 [BPC1](INFO): Starting 2018-03-14T22:29:37.224Z,1521066577.224 [BPC1](INFO): Starting 2018-03-14T22:29:37.624Z,1521066577.624 [BPC1](INFO): Starting 2018-03-14T22:29:38.025Z,1521066578.025 [BPC1](INFO): Starting 2018-03-14T22:29:38.420Z,1521066578.420 [BPC1](INFO): Starting 2018-03-14T22:29:38.824Z,1521066578.824 [BPC1](INFO): Starting 2018-03-14T22:29:39.225Z,1521066579.225 [BPC1](INFO): Starting 2018-03-14T22:29:39.620Z,1521066579.620 [BPC1](INFO): Starting 2018-03-14T22:29:40.045Z,1521066580.045 [BPC1](INFO): Starting 2018-03-14T22:29:40.439Z,1521066580.439 [BPC1](INFO): Starting 2018-03-14T22:29:40.845Z,1521066580.845 [BPC1](INFO): Starting 2018-03-14T22:29:41.235Z,1521066581.235 [BPC1](INFO): Starting 2018-03-14T22:29:41.616Z,1521066581.616 [BPC1](INFO): Starting 2018-03-14T22:29:42.016Z,1521066582.016 [BPC1](INFO): Starting 2018-03-14T22:29:42.425Z,1521066582.425 [BPC1](INFO): Starting 2018-03-14T22:29:42.824Z,1521066582.824 [BPC1](INFO): Starting 2018-03-14T22:29:43.220Z,1521066583.220 [BPC1](INFO): Starting 2018-03-14T22:29:43.624Z,1521066583.624 [BPC1](INFO): Starting 2018-03-14T22:29:44.032Z,1521066584.032 [BPC1](INFO): Starting 2018-03-14T22:29:44.431Z,1521066584.431 [BPC1](INFO): Starting 2018-03-14T22:29:44.829Z,1521066584.829 [BPC1](INFO): Starting 2018-03-14T22:29:45.239Z,1521066585.239 [BPC1](INFO): Starting 2018-03-14T22:29:45.639Z,1521066585.639 [BPC1](INFO): Starting 2018-03-14T22:29:46.043Z,1521066586.043 [BPC1](INFO): Starting 2018-03-14T22:29:46.439Z,1521066586.439 [BPC1](INFO): Starting 2018-03-14T22:29:46.824Z,1521066586.824 [BPC1](INFO): Starting 2018-03-14T22:29:47.224Z,1521066587.224 [BPC1](INFO): Starting 2018-03-14T22:29:47.625Z,1521066587.625 [BPC1](INFO): Starting 2018-03-14T22:29:48.020Z,1521066588.020 [BPC1](INFO): Starting 2018-03-14T22:29:48.427Z,1521066588.427 [BPC1](INFO): Starting 2018-03-14T22:29:48.824Z,1521066588.824 [BPC1](INFO): Starting 2018-03-14T22:29:49.216Z,1521066589.216 [BPC1](INFO): Starting 2018-03-14T22:29:49.617Z,1521066589.617 [BPC1](INFO): Starting 2018-03-14T22:29:50.016Z,1521066590.016 [BPC1](INFO): Starting 2018-03-14T22:29:50.443Z,1521066590.443 [BPC1](INFO): Starting 2018-03-14T22:29:50.843Z,1521066590.843 [BPC1](INFO): Starting 2018-03-14T22:29:51.239Z,1521066591.239 [BPC1](INFO): Starting 2018-03-14T22:29:51.627Z,1521066591.627 [BPC1](INFO): Starting 2018-03-14T22:29:52.024Z,1521066592.024 [BPC1](INFO): Starting 2018-03-14T22:29:52.425Z,1521066592.425 [BPC1](INFO): Starting 2018-03-14T22:29:52.820Z,1521066592.820 [BPC1](INFO): Starting 2018-03-14T22:29:53.224Z,1521066593.224 [BPC1](INFO): Starting 2018-03-14T22:29:53.632Z,1521066593.632 [BPC1](INFO): Starting 2018-03-14T22:29:54.031Z,1521066594.031 [BPC1](INFO): Starting 2018-03-14T22:29:54.429Z,1521066594.429 [BPC1](INFO): Starting 2018-03-14T22:29:54.816Z,1521066594.816 [BPC1](INFO): Starting 2018-03-14T22:29:55.216Z,1521066595.216 [BPC1](INFO): Starting 2018-03-14T22:29:55.639Z,1521066595.639 [BPC1](INFO): Starting 2018-03-14T22:29:56.051Z,1521066596.051 [BPC1](INFO): Starting 2018-03-14T22:29:56.447Z,1521066596.447 [BPC1](INFO): Starting 2018-03-14T22:29:56.839Z,1521066596.839 [BPC1](INFO): Starting 2018-03-14T22:29:57.217Z,1521066597.217 [BPC1](INFO): Starting 2018-03-14T22:29:57.624Z,1521066597.624 [BPC1](INFO): Starting 2018-03-14T22:29:58.024Z,1521066598.024 [BPC1](INFO): Starting 2018-03-14T22:29:58.420Z,1521066598.420 [BPC1](INFO): Starting 2018-03-14T22:29:58.823Z,1521066598.823 [BPC1](INFO): Starting 2018-03-14T22:29:59.227Z,1521066599.227 [BPC1](INFO): Starting 2018-03-14T22:29:59.627Z,1521066599.627 [BPC1](INFO): Starting 2018-03-14T22:30:00.024Z,1521066600.024 [BPC1](INFO): Starting 2018-03-14T22:30:00.424Z,1521066600.424 [BPC1](INFO): Starting 2018-03-14T22:30:00.838Z,1521066600.838 [BPC1](INFO): Starting 2018-03-14T22:30:01.236Z,1521066601.236 [BPC1](INFO): Starting 2018-03-14T22:30:01.639Z,1521066601.639 [BPC1](INFO): Starting 2018-03-14T22:30:02.047Z,1521066602.047 [BPC1](INFO): Starting 2018-03-14T22:30:02.420Z,1521066602.420 [BPC1](INFO): Starting 2018-03-14T22:30:02.823Z,1521066602.823 [BPC1](INFO): Starting 2018-03-14T22:30:03.227Z,1521066603.227 [BPC1](INFO): Starting 2018-03-14T22:30:03.629Z,1521066603.629 [BPC1](INFO): Starting 2018-03-14T22:30:04.033Z,1521066604.033 [BPC1](INFO): Starting 2018-03-14T22:30:04.424Z,1521066604.424 [BPC1](INFO): Starting 2018-03-14T22:30:04.816Z,1521066604.816 [BPC1](INFO): Starting 2018-03-14T22:30:05.216Z,1521066605.216 [BPC1](INFO): Starting 2018-03-14T22:30:05.616Z,1521066605.616 [BPC1](INFO): Starting 2018-03-14T22:30:06.035Z,1521066606.035 [BPC1](INFO): Starting 2018-03-14T22:30:06.431Z,1521066606.431 [BPC1](INFO): Starting 2018-03-14T22:30:06.835Z,1521066606.835 [BPC1](INFO): Starting 2018-03-14T22:30:06.835Z,1521066606.835 [BPC1](FAULT): Failed to initialize 2018-03-14T22:30:06.835Z,1521066606.835 [BPC1] Communications Fault, FailCount= 1 2018-03-14T22:30:06.835Z,1521066606.835 [BPC1](ERROR): Communications Fault 2018-03-14T22:30:06.907Z,1521066606.907 [CBIT](ERROR): Communications Fault in component: BPC1 2018-03-14T22:30:07.227Z,1521066607.227 [BPC1](INFO): Stop 2018-03-14T22:30:07.227Z,1521066607.227 [BPC1](INFO): uninitialize 2018-03-14T22:30:07.619Z,1521066607.619 [BPC1](INFO): Stopping 2018-03-14T22:30:08.025Z,1521066608.025 [BPC1](INFO): Stopped 2018-03-14T22:30:08.025Z,1521066608.025 [BPC1](INFO): Data requested. Hibernation time: 431531.164444 hours. 2018-03-14T22:30:08.052Z,1521066608.052 [CBIT](INFO): Clearing failed state for component BPC1 2018-03-14T22:30:08.052Z,1521066608.052 [BPC1] No Fault, FailCount= 1 2018-03-14T22:30:08.427Z,1521066608.427 [BPC1](INFO): Start 2018-03-14T22:30:08.827Z,1521066608.827 [BPC1](INFO): Starting 2018-03-14T22:30:09.227Z,1521066609.227 [BPC1](INFO): Starting 2018-03-14T22:30:09.623Z,1521066609.623 [BPC1](INFO): Starting 2018-03-14T22:30:10.016Z,1521066610.016 [BPC1](INFO): Starting 2018-03-14T22:30:10.419Z,1521066610.419 [BPC1](INFO): Starting 2018-03-14T22:30:10.816Z,1521066610.816 [BPC1](INFO): Starting 2018-03-14T22:30:11.239Z,1521066611.239 [BPC1](INFO): Starting 2018-03-14T22:30:11.634Z,1521066611.634 [BPC1](INFO): Starting 2018-03-14T22:30:12.039Z,1521066612.039 [BPC1](INFO): Starting 2018-03-14T22:30:12.456Z,1521066612.456 [BPC1](INFO): Starting 2018-03-14T22:30:12.828Z,1521066612.828 [BPC1](INFO): Starting 2018-03-14T22:30:13.226Z,1521066613.226 [BPC1](INFO): Starting 2018-03-14T22:30:13.623Z,1521066613.623 [BPC1](INFO): Starting 2018-03-14T22:30:14.033Z,1521066614.033 [BPC1](INFO): Starting 2018-03-14T22:30:14.427Z,1521066614.427 [BPC1](INFO): Starting 2018-03-14T22:30:14.824Z,1521066614.824 [BPC1](INFO): Starting 2018-03-14T22:30:15.216Z,1521066615.216 [BPC1](INFO): Starting 2018-03-14T22:30:15.616Z,1521066615.616 [BPC1](INFO): Starting 2018-03-14T22:30:16.034Z,1521066616.034 [BPC1](INFO): Starting 2018-03-14T22:30:16.449Z,1521066616.449 [BPC1](INFO): Starting 2018-03-14T22:30:16.835Z,1521066616.835 [BPC1](INFO): Starting 2018-03-14T22:30:17.251Z,1521066617.251 [BPC1](INFO): Starting 2018-03-14T22:30:17.642Z,1521066617.642 [BPC1](INFO): Starting 2018-03-14T22:30:18.017Z,1521066618.017 [BPC1](INFO): Starting 2018-03-14T22:30:18.417Z,1521066618.417 [BPC1](INFO): Starting 2018-03-14T22:30:18.821Z,1521066618.821 [BPC1](INFO): Starting 2018-03-14T22:30:19.222Z,1521066619.222 [BPC1](INFO): Starting 2018-03-14T22:30:19.619Z,1521066619.619 [BPC1](INFO): Starting 2018-03-14T22:30:20.025Z,1521066620.025 [BPC1](INFO): Starting 2018-03-14T22:30:20.423Z,1521066620.423 [BPC1](INFO): Starting 2018-03-14T22:30:20.827Z,1521066620.827 [BPC1](INFO): Starting 2018-03-14T22:30:21.216Z,1521066621.216 [BPC1](INFO): Starting 2018-03-14T22:30:21.639Z,1521066621.639 [BPC1](INFO): Starting 2018-03-14T22:30:22.034Z,1521066622.034 [BPC1](INFO): Starting 2018-03-14T22:30:22.430Z,1521066622.430 [BPC1](INFO): Starting 2018-03-14T22:30:22.835Z,1521066622.835 [BPC1](INFO): Starting 2018-03-14T22:30:23.222Z,1521066623.222 [BPC1](INFO): Starting 2018-03-14T22:30:23.625Z,1521066623.625 [BPC1](INFO): Starting 2018-03-14T22:30:24.028Z,1521066624.028 [BPC1](INFO): Starting 2018-03-14T22:30:24.424Z,1521066624.424 [BPC1](INFO): Starting 2018-03-14T22:30:24.827Z,1521066624.827 [BPC1](INFO): Starting 2018-03-14T22:30:25.224Z,1521066625.224 [BPC1](INFO): Starting 2018-03-14T22:30:25.627Z,1521066625.627 [BPC1](INFO): Starting 2018-03-14T22:30:26.027Z,1521066626.027 [BPC1](INFO): Starting 2018-03-14T22:30:26.431Z,1521066626.431 [BPC1](INFO): Starting 2018-03-14T22:30:26.843Z,1521066626.843 [BPC1](INFO): Starting 2018-03-14T22:30:29.931Z,1521066629.931 [BPC1](INFO): Starting 2018-03-14T22:30:30.080Z,1521066630.080 [BPC1](INFO): Starting 2018-03-14T22:30:30.405Z,1521066630.405 [BPC1](INFO): Starting 2018-03-14T22:30:30.797Z,1521066630.797 [BPC1](INFO): Starting 2018-03-14T22:30:31.192Z,1521066631.192 [BPC1](INFO): Starting 2018-03-14T22:30:31.593Z,1521066631.593 [BPC1](INFO): Starting 2018-03-14T22:30:31.990Z,1521066631.990 [BPC1](INFO): Starting 2018-03-14T22:30:32.386Z,1521066632.386 [BPC1](INFO): Starting 2018-03-14T22:30:32.784Z,1521066632.784 [BPC1](INFO): Starting 2018-03-14T22:30:33.184Z,1521066633.184 [BPC1](INFO): Starting 2018-03-14T22:30:33.589Z,1521066633.589 [BPC1](INFO): Starting 2018-03-14T22:30:33.994Z,1521066633.994 [BPC1](INFO): Starting 2018-03-14T22:30:34.393Z,1521066634.393 [BPC1](INFO): Starting 2018-03-14T22:30:34.799Z,1521066634.799 [BPC1](INFO): Starting 2018-03-14T22:30:35.195Z,1521066635.195 [BPC1](INFO): Starting 2018-03-14T22:30:35.606Z,1521066635.606 [BPC1](INFO): Starting 2018-03-14T22:30:36.002Z,1521066636.002 [BPC1](INFO): Starting 2018-03-14T22:30:36.399Z,1521066636.399 [BPC1](INFO): Starting 2018-03-14T22:30:36.800Z,1521066636.800 [BPC1](INFO): Starting 2018-03-14T22:30:37.184Z,1521066637.184 [BPC1](INFO): Starting 2018-03-14T22:30:37.585Z,1521066637.585 [BPC1](INFO): Starting 2018-03-14T22:30:37.989Z,1521066637.989 [BPC1](INFO): Starting 2018-03-14T22:30:38.384Z,1521066638.384 [BPC1](INFO): Starting 2018-03-14T22:30:38.784Z,1521066638.784 [BPC1](INFO): Starting 2018-03-14T22:30:39.189Z,1521066639.189 [BPC1](INFO): Starting 2018-03-14T22:30:39.588Z,1521066639.588 [BPC1](INFO): Starting 2018-03-14T22:30:40.006Z,1521066640.006 [BPC1](INFO): Starting 2018-03-14T22:30:40.399Z,1521066640.399 [BPC1](INFO): Starting 2018-03-14T22:30:40.800Z,1521066640.800 [BPC1](INFO): Starting 2018-03-14T22:30:41.195Z,1521066641.195 [BPC1](INFO): Starting 2018-03-14T22:30:41.592Z,1521066641.592 [BPC1](INFO): Starting 2018-03-14T22:30:41.667Z,1521066641.667 [CommandLine](IMPORTANT): got command show variable bankA 2018-03-14T22:30:41.984Z,1521066641.984 [BPC1](INFO): Starting 2018-03-14T22:30:42.384Z,1521066642.384 [BPC1](INFO): Starting 2018-03-14T22:30:42.785Z,1521066642.785 [BPC1](INFO): Starting 2018-03-14T22:30:43.184Z,1521066643.184 [BPC1](INFO): Starting 2018-03-14T22:30:43.588Z,1521066643.588 [BPC1](INFO): Starting 2018-03-14T22:30:43.993Z,1521066643.993 [BPC1](INFO): Starting 2018-03-14T22:30:44.388Z,1521066644.388 [BPC1](INFO): Starting 2018-03-14T22:30:44.792Z,1521066644.792 [BPC1](INFO): Starting 2018-03-14T22:30:45.203Z,1521066645.203 [BPC1](INFO): Starting 2018-03-14T22:30:45.596Z,1521066645.596 [BPC1](INFO): Starting 2018-03-14T22:30:46.008Z,1521066646.008 [BPC1](INFO): Starting 2018-03-14T22:30:46.409Z,1521066646.409 [BPC1](INFO): Starting 2018-03-14T22:30:46.792Z,1521066646.792 [BPC1](INFO): Starting 2018-03-14T22:30:47.195Z,1521066647.195 [BPC1](INFO): Starting 2018-03-14T22:30:47.594Z,1521066647.594 [BPC1](INFO): Starting 2018-03-14T22:30:47.960Z,1521066647.960 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2018-03-14T22:30:47.984Z,1521066647.984 [BPC1](INFO): Starting 2018-03-14T22:30:48.384Z,1521066648.384 [BPC1](INFO): Starting 2018-03-14T22:30:48.815Z,1521066648.815 [BPC1](INFO): Starting 2018-03-14T22:30:49.140Z,1521066649.140 [CommandLine](IMPORTANT): got command show variable bank 2018-03-14T22:30:49.215Z,1521066649.215 [BPC1](INFO): Starting 2018-03-14T22:30:49.588Z,1521066649.588 [BPC1](INFO): Starting 2018-03-14T22:30:50.000Z,1521066650.000 [BPC1](INFO): Starting 2018-03-14T22:30:50.402Z,1521066650.402 [BPC1](INFO): Starting 2018-03-14T22:30:50.802Z,1521066650.802 [BPC1](INFO): Starting 2018-03-14T22:30:51.193Z,1521066651.193 [BPC1](INFO): Starting 2018-03-14T22:30:51.584Z,1521066651.584 [BPC1](INFO): Starting 2018-03-14T22:30:51.985Z,1521066651.985 [BPC1](INFO): Starting 2018-03-14T22:30:52.385Z,1521066652.385 [BPC1](INFO): Starting 2018-03-14T22:30:52.817Z,1521066652.817 [BPC1](INFO): Starting 2018-03-14T22:30:53.217Z,1521066653.217 [BPC1](INFO): Starting 2018-03-14T22:30:53.615Z,1521066653.615 [BPC1](INFO): Starting 2018-03-14T22:30:53.988Z,1521066653.988 [BPC1](INFO): Starting 2018-03-14T22:30:54.395Z,1521066654.395 [BPC1](INFO): Starting 2018-03-14T22:30:54.793Z,1521066654.793 [BPC1](INFO): Starting 2018-03-14T22:30:55.186Z,1521066655.186 [BPC1](INFO): Starting 2018-03-14T22:30:55.585Z,1521066655.585 [BPC1](INFO): Starting 2018-03-14T22:30:56.011Z,1521066656.011 [BPC1](INFO): Starting 2018-03-14T22:30:56.408Z,1521066656.408 [BPC1](INFO): Starting 2018-03-14T22:30:56.803Z,1521066656.803 [BPC1](INFO): Starting 2018-03-14T22:30:57.185Z,1521066657.185 [BPC1](INFO): Starting 2018-03-14T22:30:57.584Z,1521066657.584 [BPC1](INFO): Starting 2018-03-14T22:30:57.993Z,1521066657.993 [BPC1](INFO): Starting 2018-03-14T22:30:58.389Z,1521066658.389 [BPC1](INFO): Starting 2018-03-14T22:30:58.808Z,1521066658.808 [BPC1](INFO): Starting 2018-03-14T22:30:59.210Z,1521066659.210 [BPC1](INFO): Starting 2018-03-14T22:30:59.608Z,1521066659.608 [BPC1](INFO): Starting 2018-03-14T22:30:59.984Z,1521066659.984 [BPC1](INFO): Starting 2018-03-14T22:31:00.388Z,1521066660.388 [BPC1](INFO): Starting 2018-03-14T22:31:00.784Z,1521066660.784 [BPC1](INFO): Starting 2018-03-14T22:31:01.189Z,1521066661.189 [BPC1](INFO): Starting 2018-03-14T22:31:01.595Z,1521066661.595 [BPC1](INFO): Starting 2018-03-14T22:31:01.999Z,1521066661.999 [BPC1](INFO): Starting 2018-03-14T22:31:02.400Z,1521066662.400 [BPC1](INFO): Starting 2018-03-14T22:31:02.795Z,1521066662.795 [BPC1](INFO): Starting 2018-03-14T22:31:03.197Z,1521066663.197 [BPC1](INFO): Starting 2018-03-14T22:31:03.591Z,1521066663.591 [BPC1](INFO): Starting 2018-03-14T22:31:03.992Z,1521066663.992 [BPC1](INFO): Starting 2018-03-14T22:31:04.393Z,1521066664.393 [BPC1](INFO): Starting 2018-03-14T22:31:04.803Z,1521066664.803 [BPC1](INFO): Starting 2018-03-14T22:31:05.207Z,1521066665.207 [BPC1](INFO): Starting 2018-03-14T22:31:05.610Z,1521066665.610 [BPC1](INFO): Starting 2018-03-14T22:31:05.984Z,1521066665.984 [BPC1](INFO): Starting 2018-03-14T22:31:06.384Z,1521066666.384 [BPC1](INFO): Starting 2018-03-14T22:31:06.788Z,1521066666.788 [BPC1](INFO): Starting 2018-03-14T22:31:07.194Z,1521066667.194 [BPC1](INFO): Starting 2018-03-14T22:31:07.202Z,1521066667.202 [DeadReckonUsingSpeedCalculator](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-03-14T22:31:07.202Z,1521066667.202 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 2 2018-03-14T22:31:07.202Z,1521066667.202 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2018-03-14T22:31:07.204Z,1521066667.204 [DeadReckonWithRespectToSeafloor](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-03-14T22:31:07.204Z,1521066667.204 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 2 2018-03-14T22:31:07.204Z,1521066667.204 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2018-03-14T22:31:07.244Z,1521066667.244 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2018-03-14T22:31:07.244Z,1521066667.244 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2018-03-14T22:31:07.599Z,1521066667.599 [BPC1](INFO): Starting 2018-03-14T22:31:07.655Z,1521066667.655 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2018-03-14T22:31:07.655Z,1521066667.655 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 2 2018-03-14T22:31:07.655Z,1521066667.655 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2018-03-14T22:31:07.655Z,1521066667.655 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 2 2018-03-14T22:31:08.007Z,1521066668.007 [BPC1](INFO): Starting 2018-03-14T22:31:08.035Z,1521066668.035 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2018-03-14T22:31:08.036Z,1521066668.036 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s. 2018-03-14T22:31:08.036Z,1521066668.036 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s. 2018-03-14T22:31:08.036Z,1521066668.036 [DeadReckonWithRespectToSeafloor](DEBUG): Initializing DeadReckonWithRespectToSeafloor component. 2018-03-14T22:31:08.037Z,1521066668.037 [DeadReckonWithRespectToSeafloor](INFO): Will consider orientation measurement stale after 120s. 2018-03-14T22:31:08.037Z,1521066668.037 [DeadReckonWithRespectToSeafloor](INFO): Will consider velocity measurement stale after 20s. 2018-03-14T22:31:08.406Z,1521066668.406 [BPC1](INFO): Starting 2018-03-14T22:31:08.807Z,1521066668.807 [BPC1](INFO): Starting 2018-03-14T22:31:09.184Z,1521066669.184 [BPC1](INFO): Starting 2018-03-14T22:31:09.584Z,1521066669.584 [BPC1](INFO): Starting 2018-03-14T22:31:09.989Z,1521066669.989 [BPC1](INFO): Starting 2018-03-14T22:31:10.389Z,1521066670.389 [BPC1](INFO): Starting 2018-03-14T22:31:10.799Z,1521066670.799 [BPC1](INFO): Starting 2018-03-14T22:31:11.202Z,1521066671.202 [BPC1](INFO): Starting 2018-03-14T22:31:11.598Z,1521066671.598 [BPC1](INFO): Starting 2018-03-14T22:31:11.997Z,1521066671.997 [BPC1](INFO): Starting 2018-03-14T22:31:12.384Z,1521066672.384 [BPC1](INFO): Starting 2018-03-14T22:31:12.784Z,1521066672.784 [BPC1](INFO): Starting 2018-03-14T22:31:13.185Z,1521066673.185 [BPC1](INFO): Starting 2018-03-14T22:31:13.584Z,1521066673.584 [BPC1](INFO): Starting 2018-03-14T22:31:14.011Z,1521066674.011 [BPC1](INFO): Starting 2018-03-14T22:31:14.414Z,1521066674.414 [BPC1](INFO): Starting 2018-03-14T22:31:14.817Z,1521066674.817 [BPC1](INFO): Starting 2018-03-14T22:31:15.192Z,1521066675.192 [BPC1](INFO): Starting 2018-03-14T22:31:15.588Z,1521066675.588 [BPC1](INFO): Starting 2018-03-14T22:31:15.995Z,1521066675.995 [BPC1](INFO): Starting 2018-03-14T22:31:16.395Z,1521066676.395 [BPC1](INFO): Starting 2018-03-14T22:31:16.805Z,1521066676.805 [BPC1](INFO): Starting 2018-03-14T22:31:17.205Z,1521066677.205 [BPC1](INFO): Starting 2018-03-14T22:31:17.610Z,1521066677.610 [BPC1](INFO): Starting 2018-03-14T22:31:17.984Z,1521066677.984 [BPC1](INFO): Starting 2018-03-14T22:31:18.348Z,1521066678.348 [CommandLine](IMPORTANT): got command show variable BPC1A.uart 2018-03-14T22:31:18.388Z,1521066678.388 [BPC1](INFO): Starting 2018-03-14T22:31:18.442Z,1521066678.442 [CommandLine](IMPORTANT): BPC1A.uart (none) 2018-03-14T22:31:18.796Z,1521066678.796 [BPC1](INFO): Starting 2018-03-14T22:31:19.191Z,1521066679.191 [BPC1](INFO): Starting 2018-03-14T22:31:19.592Z,1521066679.592 [BPC1](INFO): Starting 2018-03-14T22:31:20.015Z,1521066680.015 [BPC1](INFO): Starting 2018-03-14T22:31:20.414Z,1521066680.414 [BPC1](INFO): Starting 2018-03-14T22:31:20.804Z,1521066680.804 [BPC1](INFO): Starting 2018-03-14T22:31:21.184Z,1521066681.184 [BPC1](INFO): Starting 2018-03-14T22:31:21.592Z,1521066681.592 [BPC1](INFO): Starting 2018-03-14T22:31:21.993Z,1521066681.993 [BPC1](INFO): Starting 2018-03-14T22:31:22.392Z,1521066682.392 [BPC1](INFO): Starting 2018-03-14T22:31:22.795Z,1521066682.795 [BPC1](INFO): Starting 2018-03-14T22:31:23.199Z,1521066683.199 [BPC1](INFO): Starting 2018-03-14T22:31:23.603Z,1521066683.603 [BPC1](INFO): Starting 2018-03-14T22:31:23.995Z,1521066683.995 [BPC1](INFO): Starting 2018-03-14T22:31:24.393Z,1521066684.393 [BPC1](INFO): Starting 2018-03-14T22:31:24.808Z,1521066684.808 [BPC1](INFO): Starting 2018-03-14T22:31:25.189Z,1521066685.189 [BPC1](INFO): Starting 2018-03-14T22:31:25.600Z,1521066685.600 [BPC1](INFO): Starting 2018-03-14T22:31:26.028Z,1521066686.028 [BPC1](INFO): Starting 2018-03-14T22:31:26.131Z,1521066686.131 [CommandLine](IMPORTANT): got command get BPC1A.uart 2018-03-14T22:31:26.132Z,1521066686.132 [CommandLine](IMPORTANT): BPC1A.uart /dev/ttyTX1 2018-03-14T22:31:26.399Z,1521066686.399 [BPC1](INFO): Starting 2018-03-14T22:31:26.803Z,1521066686.803 [BPC1](INFO): Starting 2018-03-14T22:31:27.204Z,1521066687.204 [BPC1](INFO): Starting 2018-03-14T22:31:30.722Z,1521066690.722 [BPC1](INFO): Starting 2018-03-14T22:31:30.851Z,1521066690.851 [BPC1](INFO): Starting 2018-03-14T22:31:31.238Z,1521066691.238 [BPC1](INFO): Starting 2018-03-14T22:31:31.647Z,1521066691.647 [BPC1](INFO): Starting 2018-03-14T22:31:32.027Z,1521066692.027 [BPC1](INFO): Starting 2018-03-14T22:31:32.035Z,1521066692.035 [CommandLine](IMPORTANT): got command get BPC1B.uart 2018-03-14T22:31:32.036Z,1521066692.036 [CommandLine](IMPORTANT): BPC1B.uart /dev/ttyTX0 2018-03-14T22:31:32.420Z,1521066692.420 [BPC1](INFO): Starting 2018-03-14T22:31:32.820Z,1521066692.820 [BPC1](INFO): Starting 2018-03-14T22:31:33.215Z,1521066693.215 [BPC1](INFO): Starting 2018-03-14T22:31:33.619Z,1521066693.619 [BPC1](INFO): Starting 2018-03-14T22:31:34.030Z,1521066694.030 [BPC1](INFO): Starting 2018-03-14T22:31:34.431Z,1521066694.431 [BPC1](INFO): Starting 2018-03-14T22:31:34.823Z,1521066694.823 [BPC1](INFO): Starting 2018-03-14T22:31:35.217Z,1521066695.217 [BPC1](INFO): Starting 2018-03-14T22:31:35.621Z,1521066695.621 [BPC1](INFO): Starting 2018-03-14T22:31:36.017Z,1521066696.017 [BPC1](INFO): Starting 2018-03-14T22:31:36.420Z,1521066696.420 [BPC1](INFO): Starting 2018-03-14T22:31:36.826Z,1521066696.826 [BPC1](INFO): Starting 2018-03-14T22:31:37.236Z,1521066697.236 [BPC1](INFO): Starting 2018-03-14T22:31:37.634Z,1521066697.634 [BPC1](INFO): Starting 2018-03-14T22:31:38.028Z,1521066698.028 [BPC1](INFO): Starting 2018-03-14T22:31:38.412Z,1521066698.412 [BPC1](INFO): Starting 2018-03-14T22:31:38.812Z,1521066698.812 [BPC1](INFO): Starting 2018-03-14T22:31:39.213Z,1521066699.213 [BPC1](INFO): Starting 2018-03-14T22:31:39.616Z,1521066699.616 [BPC1](INFO): Starting 2018-03-14T22:31:40.027Z,1521066700.027 [BPC1](INFO): Starting 2018-03-14T22:31:40.447Z,1521066700.447 [BPC1](INFO): Starting 2018-03-14T22:31:40.847Z,1521066700.847 [BPC1](INFO): Starting 2018-03-14T22:31:41.220Z,1521066701.220 [BPC1](INFO): Starting 2018-03-14T22:31:41.620Z,1521066701.620 [BPC1](INFO): Starting 2018-03-14T22:31:42.015Z,1521066702.015 [BPC1](INFO): Starting 2018-03-14T22:31:42.423Z,1521066702.423 [BPC1](INFO): Starting 2018-03-14T22:31:42.835Z,1521066702.835 [BPC1](INFO): Starting 2018-03-14T22:31:43.231Z,1521066703.231 [BPC1](INFO): Starting 2018-03-14T22:31:43.643Z,1521066703.643 [BPC1](INFO): Starting 2018-03-14T22:31:44.012Z,1521066704.012 [BPC1](INFO): Starting 2018-03-14T22:31:44.412Z,1521066704.412 [BPC1](INFO): Starting 2018-03-14T22:31:44.820Z,1521066704.820 [BPC1](INFO): Starting 2018-03-14T22:31:45.221Z,1521066705.221 [BPC1](INFO): Starting 2018-03-14T22:31:45.620Z,1521066705.620 [BPC1](INFO): Starting 2018-03-14T22:31:46.027Z,1521066706.027 [BPC1](INFO): Starting 2018-03-14T22:31:46.427Z,1521066706.427 [BPC1](INFO): Starting 2018-03-14T22:31:46.830Z,1521066706.830 [BPC1](INFO): Starting 2018-03-14T22:31:47.220Z,1521066707.220 [BPC1](INFO): Starting 2018-03-14T22:31:47.613Z,1521066707.613 [BPC1](INFO): Starting 2018-03-14T22:31:48.013Z,1521066708.013 [BPC1](INFO): Starting 2018-03-14T22:31:48.412Z,1521066708.412 [BPC1](INFO): Starting 2018-03-14T22:31:48.823Z,1521066708.823 [BPC1](INFO): Starting 2018-03-14T22:31:49.235Z,1521066709.235 [BPC1](INFO): Starting 2018-03-14T22:31:49.632Z,1521066709.632 [BPC1](INFO): Starting 2018-03-14T22:31:50.016Z,1521066710.016 [BPC1](INFO): Starting 2018-03-14T22:31:50.423Z,1521066710.423 [BPC1](INFO): Starting 2018-03-14T22:31:50.821Z,1521066710.821 [BPC1](INFO): Starting 2018-03-14T22:31:51.221Z,1521066711.221 [BPC1](INFO): Starting 2018-03-14T22:31:51.620Z,1521066711.620 [BPC1](INFO): Starting 2018-03-14T22:31:52.034Z,1521066712.034 [BPC1](INFO): Starting 2018-03-14T22:31:52.435Z,1521066712.435 [BPC1](INFO): Starting 2018-03-14T22:31:52.835Z,1521066712.835 [BPC1](INFO): Starting 2018-03-14T22:31:53.212Z,1521066713.212 [BPC1](INFO): Starting 2018-03-14T22:31:53.612Z,1521066713.612 [BPC1](INFO): Starting 2018-03-14T22:31:54.013Z,1521066714.013 [BPC1](INFO): Starting 2018-03-14T22:31:54.412Z,1521066714.412 [BPC1](INFO): Starting 2018-03-14T22:31:54.823Z,1521066714.823 [BPC1](INFO): Starting 2018-03-14T22:31:55.247Z,1521066715.247 [BPC1](INFO): Starting 2018-03-14T22:31:55.627Z,1521066715.627 [BPC1](INFO): Starting 2018-03-14T22:31:56.015Z,1521066716.015 [BPC1](INFO): Starting 2018-03-14T22:31:56.420Z,1521066716.420 [BPC1](INFO): Starting 2018-03-14T22:31:56.823Z,1521066716.823 [BPC1](INFO): Starting 2018-03-14T22:31:57.213Z,1521066717.213 [BPC1](INFO): Starting 2018-03-14T22:31:57.612Z,1521066717.612 [BPC1](INFO): Starting 2018-03-14T22:31:58.035Z,1521066718.035 [BPC1](INFO): Starting 2018-03-14T22:31:58.439Z,1521066718.439 [BPC1](INFO): Starting 2018-03-14T22:31:58.823Z,1521066718.823 [BPC1](INFO): Starting 2018-03-14T22:31:59.220Z,1521066719.220 [BPC1](INFO): Starting 2018-03-14T22:31:59.620Z,1521066719.620 [BPC1](INFO): Starting 2018-03-14T22:32:00.026Z,1521066720.026 [BPC1](INFO): Starting 2018-03-14T22:32:00.421Z,1521066720.421 [BPC1](INFO): Starting 2018-03-14T22:32:00.830Z,1521066720.830 [BPC1](INFO): Starting 2018-03-14T22:32:01.234Z,1521066721.234 [BPC1](INFO): Starting 2018-03-14T22:32:01.634Z,1521066721.634 [BPC1](INFO): Starting 2018-03-14T22:32:02.012Z,1521066722.012 [BPC1](INFO): Starting 2018-03-14T22:32:02.412Z,1521066722.412 [BPC1](INFO): Starting 2018-03-14T22:32:02.817Z,1521066722.817 [BPC1](INFO): Starting 2018-03-14T22:32:03.213Z,1521066723.213 [BPC1](INFO): Starting 2018-03-14T22:32:03.612Z,1521066723.612 [BPC1](INFO): Starting 2018-03-14T22:32:04.047Z,1521066724.047 [BPC1](INFO): Starting 2018-03-14T22:32:04.427Z,1521066724.427 [BPC1](INFO): Starting 2018-03-14T22:32:04.823Z,1521066724.823 [BPC1](INFO): Starting 2018-03-14T22:32:05.219Z,1521066725.219 [BPC1](INFO): Starting 2018-03-14T22:32:05.619Z,1521066725.619 [BPC1](INFO): Starting 2018-03-14T22:32:06.023Z,1521066726.023 [BPC1](INFO): Starting 2018-03-14T22:32:06.423Z,1521066726.423 [BPC1](INFO): Starting 2018-03-14T22:32:06.835Z,1521066726.835 [BPC1](INFO): Starting 2018-03-14T22:32:07.237Z,1521066727.237 [BPC1](INFO): Starting 2018-03-14T22:32:07.639Z,1521066727.639 [BPC1](INFO): Starting 2018-03-14T22:32:08.012Z,1521066728.012 [BPC1](INFO): Starting 2018-03-14T22:32:08.416Z,1521066728.416 [BPC1](INFO): Starting 2018-03-14T22:32:08.821Z,1521066728.821 [BPC1](INFO): Starting 2018-03-14T22:32:09.221Z,1521066729.221 [BPC1](INFO): Starting 2018-03-14T22:32:09.616Z,1521066729.616 [BPC1](INFO): Starting 2018-03-14T22:32:10.027Z,1521066730.027 [BPC1](INFO): Starting 2018-03-14T22:32:10.427Z,1521066730.427 [BPC1](INFO): Starting 2018-03-14T22:32:10.830Z,1521066730.830 [BPC1](INFO): Starting 2018-03-14T22:32:11.223Z,1521066731.223 [BPC1](INFO): Starting 2018-03-14T22:32:11.612Z,1521066731.612 [BPC1](INFO): Starting 2018-03-14T22:32:12.013Z,1521066732.013 [BPC1](INFO): Starting 2018-03-14T22:32:12.413Z,1521066732.413 [BPC1](INFO): Starting 2018-03-14T22:32:12.823Z,1521066732.823 [BPC1](INFO): Starting 2018-03-14T22:32:13.240Z,1521066733.240 [BPC1](INFO): Starting 2018-03-14T22:32:13.649Z,1521066733.649 [BPC1](INFO): Starting 2018-03-14T22:32:14.015Z,1521066734.015 [BPC1](INFO): Starting 2018-03-14T22:32:14.419Z,1521066734.419 [BPC1](INFO): Starting 2018-03-14T22:32:14.824Z,1521066734.824 [BPC1](INFO): Starting 2018-03-14T22:32:15.222Z,1521066735.222 [BPC1](INFO): Starting 2018-03-14T22:32:15.613Z,1521066735.613 [BPC1](INFO): Starting 2018-03-14T22:32:16.039Z,1521066736.039 [BPC1](INFO): Starting 2018-03-14T22:32:16.439Z,1521066736.439 [BPC1](INFO): Starting 2018-03-14T22:32:16.831Z,1521066736.831 [BPC1](INFO): Starting 2018-03-14T22:32:17.212Z,1521066737.212 [BPC1](INFO): Starting 2018-03-14T22:32:17.612Z,1521066737.612 [BPC1](INFO): Starting 2018-03-14T22:32:18.013Z,1521066738.013 [BPC1](INFO): Starting 2018-03-14T22:32:18.420Z,1521066738.420 [BPC1](INFO): Starting 2018-03-14T22:32:18.831Z,1521066738.831 [BPC1](INFO): Starting 2018-03-14T22:32:19.235Z,1521066739.235 [BPC1](INFO): Starting 2018-03-14T22:32:19.627Z,1521066739.627 [BPC1](INFO): Starting 2018-03-14T22:32:20.019Z,1521066740.019 [BPC1](INFO): Starting 2018-03-14T22:32:20.420Z,1521066740.420 [BPC1](INFO): Starting 2018-03-14T22:32:20.812Z,1521066740.812 [BPC1](INFO): Starting 2018-03-14T22:32:21.213Z,1521066741.213 [BPC1](INFO): Starting 2018-03-14T22:32:21.612Z,1521066741.612 [BPC1](INFO): Starting 2018-03-14T22:32:22.027Z,1521066742.027 [BPC1](INFO): Starting 2018-03-14T22:32:22.447Z,1521066742.447 [BPC1](INFO): Starting 2018-03-14T22:32:22.827Z,1521066742.827 [BPC1](INFO): Starting 2018-03-14T22:32:23.220Z,1521066743.220 [BPC1](INFO): Starting 2018-03-14T22:32:23.615Z,1521066743.615 [BPC1](INFO): Starting 2018-03-14T22:32:24.027Z,1521066744.027 [BPC1](INFO): Starting 2018-03-14T22:32:24.421Z,1521066744.421 [BPC1](INFO): Starting 2018-03-14T22:32:24.842Z,1521066744.842 [BPC1](INFO): Starting 2018-03-14T22:32:25.235Z,1521066745.235 [BPC1](INFO): Starting 2018-03-14T22:32:25.639Z,1521066745.639 [BPC1](INFO): Starting 2018-03-14T22:32:26.020Z,1521066746.020 [BPC1](INFO): Starting 2018-03-14T22:32:26.416Z,1521066746.416 [BPC1](INFO): Starting 2018-03-14T22:32:26.821Z,1521066746.821 [BPC1](INFO): Starting 2018-03-14T22:32:27.226Z,1521066747.226 [BPC1](INFO): Starting 2018-03-14T22:32:30.369Z,1521066750.369 [BPC1](INFO): Starting 2018-03-14T22:32:30.503Z,1521066750.503 [BPC1](INFO): Starting 2018-03-14T22:32:30.855Z,1521066750.855 [BPC1](INFO): Starting 2018-03-14T22:32:31.243Z,1521066751.243 [BPC1](INFO): Starting 2018-03-14T22:32:31.631Z,1521066751.631 [BPC1](INFO): Starting 2018-03-14T22:32:32.027Z,1521066752.027 [BPC1](INFO): Starting 2018-03-14T22:32:32.431Z,1521066752.431 [BPC1](INFO): Starting 2018-03-14T22:32:32.840Z,1521066752.840 [BPC1](INFO): Starting 2018-03-14T22:32:33.243Z,1521066753.243 [BPC1](INFO): Starting 2018-03-14T22:32:33.646Z,1521066753.646 [BPC1](INFO): Starting 2018-03-14T22:32:34.020Z,1521066754.020 [BPC1](INFO): Starting 2018-03-14T22:32:34.420Z,1521066754.420 [BPC1](INFO): Starting 2018-03-14T22:32:34.820Z,1521066754.820 [BPC1](INFO): Starting 2018-03-14T22:32:35.228Z,1521066755.228 [BPC1](INFO): Starting 2018-03-14T22:32:35.629Z,1521066755.629 [BPC1](INFO): Starting 2018-03-14T22:32:36.035Z,1521066756.035 [BPC1](INFO): Starting 2018-03-14T22:32:36.435Z,1521066756.435 [BPC1](INFO): Starting 2018-03-14T22:32:36.833Z,1521066756.833 [BPC1](INFO): Starting 2018-03-14T22:32:37.220Z,1521066757.220 [BPC1](INFO): Starting 2018-03-14T22:32:37.621Z,1521066757.621 [BPC1](INFO): Starting 2018-03-14T22:32:38.021Z,1521066758.021 [BPC1](INFO): Starting 2018-03-14T22:32:38.420Z,1521066758.420 [BPC1](INFO): Starting 2018-03-14T22:32:38.839Z,1521066758.839 [BPC1](INFO): Starting 2018-03-14T22:32:39.243Z,1521066759.243 [BPC1](INFO): Starting 2018-03-14T22:32:39.643Z,1521066759.643 [BPC1](INFO): Starting 2018-03-14T22:32:40.024Z,1521066760.024 [BPC1](INFO): Starting 2018-03-14T22:32:40.435Z,1521066760.435 [BPC1](INFO): Starting 2018-03-14T22:32:40.835Z,1521066760.835 [BPC1](INFO): Starting 2018-03-14T22:32:41.221Z,1521066761.221 [BPC1](INFO): Starting 2018-03-14T22:32:41.620Z,1521066761.620 [BPC1](INFO): Starting 2018-03-14T22:32:42.045Z,1521066762.045 [BPC1](INFO): Starting 2018-03-14T22:32:42.444Z,1521066762.444 [BPC1](INFO): Starting 2018-03-14T22:32:42.852Z,1521066762.852 [BPC1](INFO): Starting 2018-03-14T22:32:43.228Z,1521066763.228 [BPC1](INFO): Starting 2018-03-14T22:32:43.628Z,1521066763.628 [BPC1](INFO): Starting 2018-03-14T22:32:44.029Z,1521066764.029 [BPC1](INFO): Starting 2018-03-14T22:32:44.423Z,1521066764.423 [BPC1](INFO): Starting 2018-03-14T22:32:44.839Z,1521066764.839 [BPC1](INFO): Starting 2018-03-14T22:32:45.247Z,1521066765.247 [BPC1](INFO): Starting 2018-03-14T22:32:45.650Z,1521066765.650 [BPC1](INFO): Starting 2018-03-14T22:32:46.024Z,1521066766.024 [BPC1](INFO): Starting 2018-03-14T22:32:46.428Z,1521066766.428 [BPC1](INFO): Starting 2018-03-14T22:32:46.828Z,1521066766.828 [BPC1](INFO): Starting 2018-03-14T22:32:47.230Z,1521066767.230 [BPC1](INFO): Starting 2018-03-14T22:32:47.623Z,1521066767.623 [BPC1](INFO): Starting 2018-03-14T22:32:48.042Z,1521066768.042 [BPC1](INFO): Starting 2018-03-14T22:32:48.443Z,1521066768.443 [BPC1](INFO): Starting 2018-03-14T22:32:48.831Z,1521066768.831 [BPC1](INFO): Starting 2018-03-14T22:32:49.225Z,1521066769.225 [BPC1](INFO): Starting 2018-03-14T22:32:49.628Z,1521066769.628 [BPC1](INFO): Starting 2018-03-14T22:32:50.029Z,1521066770.029 [BPC1](INFO): Starting 2018-03-14T22:32:50.424Z,1521066770.424 [BPC1](INFO): Starting 2018-03-14T22:32:50.832Z,1521066770.832 [BPC1](INFO): Starting 2018-03-14T22:32:51.242Z,1521066771.242 [BPC1](INFO): Starting 2018-03-14T22:32:51.645Z,1521066771.645 [BPC1](INFO): Starting 2018-03-14T22:32:52.021Z,1521066772.021 [BPC1](INFO): Starting 2018-03-14T22:32:52.433Z,1521066772.433 [BPC1](INFO): Starting 2018-03-14T22:32:52.820Z,1521066772.820 [BPC1](INFO): Starting 2018-03-14T22:32:53.221Z,1521066773.221 [BPC1](INFO): Starting 2018-03-14T22:32:53.620Z,1521066773.620 [BPC1](INFO): Starting 2018-03-14T22:32:54.035Z,1521066774.035 [BPC1](INFO): Starting 2018-03-14T22:32:54.455Z,1521066774.455 [BPC1](INFO): Starting 2018-03-14T22:32:54.854Z,1521066774.854 [BPC1](INFO): Starting 2018-03-14T22:32:55.224Z,1521066775.224 [BPC1](INFO): Starting 2018-03-14T22:32:55.628Z,1521066775.628 [BPC1](INFO): Starting 2018-03-14T22:32:56.029Z,1521066776.029 [BPC1](INFO): Starting 2018-03-14T22:32:56.420Z,1521066776.420 [BPC1](INFO): Starting 2018-03-14T22:32:56.851Z,1521066776.851 [BPC1](INFO): Starting 2018-03-14T22:32:57.249Z,1521066777.249 [BPC1](INFO): Starting 2018-03-14T22:32:57.643Z,1521066777.643 [BPC1](INFO): Starting 2018-03-14T22:32:58.020Z,1521066778.020 [BPC1](INFO): Starting 2018-03-14T22:32:58.422Z,1521066778.422 [BPC1](INFO): Starting 2018-03-14T22:32:58.828Z,1521066778.828 [BPC1](INFO): Starting 2018-03-14T22:32:59.229Z,1521066779.229 [BPC1](INFO): Starting 2018-03-14T22:32:59.623Z,1521066779.623 [BPC1](INFO): Starting 2018-03-14T22:33:00.047Z,1521066780.047 [BPC1](INFO): Starting 2018-03-14T22:33:00.443Z,1521066780.443 [BPC1](INFO): Starting 2018-03-14T22:33:00.843Z,1521066780.843 [BPC1](INFO): Starting 2018-03-14T22:33:01.220Z,1521066781.220 [BPC1](INFO): Starting 2018-03-14T22:33:01.620Z,1521066781.620 [BPC1](INFO): Starting 2018-03-14T22:33:02.025Z,1521066782.025 [BPC1](INFO): Starting 2018-03-14T22:33:02.427Z,1521066782.427 [BPC1](INFO): Starting 2018-03-14T22:33:02.839Z,1521066782.839 [BPC1](INFO): Starting 2018-03-14T22:33:03.233Z,1521066783.233 [BPC1](INFO): Starting 2018-03-14T22:33:03.635Z,1521066783.635 [BPC1](INFO): Starting 2018-03-14T22:33:04.027Z,1521066784.027 [BPC1](INFO): Starting 2018-03-14T22:33:04.431Z,1521066784.431 [BPC1](INFO): Starting 2018-03-14T22:33:04.828Z,1521066784.828 [BPC1](INFO): Starting 2018-03-14T22:33:05.221Z,1521066785.221 [BPC1](INFO): Starting 2018-03-14T22:33:05.620Z,1521066785.620 [BPC1](INFO): Starting 2018-03-14T22:33:06.043Z,1521066786.043 [BPC1](INFO): Starting 2018-03-14T22:33:06.454Z,1521066786.454 [BPC1](INFO): Starting 2018-03-14T22:33:06.838Z,1521066786.838 [BPC1](INFO): Starting 2018-03-14T22:33:07.221Z,1521066787.221 [BPC1](INFO): Starting 2018-03-14T22:33:07.620Z,1521066787.620 [BPC1](INFO): Starting 2018-03-14T22:33:08.021Z,1521066788.021 [BPC1](INFO): Starting 2018-03-14T22:33:08.433Z,1521066788.433 [BPC1](INFO): Starting 2018-03-14T22:33:08.839Z,1521066788.839 [BPC1](INFO): Starting 2018-03-14T22:33:09.242Z,1521066789.242 [BPC1](INFO): Starting 2018-03-14T22:33:09.631Z,1521066789.631 [BPC1](INFO): Starting 2018-03-14T22:33:10.027Z,1521066790.027 [BPC1](INFO): Starting 2018-03-14T22:33:10.427Z,1521066790.427 [BPC1](INFO): Starting 2018-03-14T22:33:10.832Z,1521066790.832 [BPC1](INFO): Starting 2018-03-14T22:33:11.229Z,1521066791.229 [BPC1](INFO): Starting 2018-03-14T22:33:11.620Z,1521066791.620 [BPC1](INFO): Starting 2018-03-14T22:33:12.043Z,1521066792.043 [BPC1](INFO): Starting 2018-03-14T22:33:12.447Z,1521066792.447 [BPC1](INFO): Starting 2018-03-14T22:33:12.830Z,1521066792.830 [BPC1](INFO): Starting 2018-03-14T22:33:13.228Z,1521066793.228 [BPC1](INFO): Starting 2018-03-14T22:33:13.628Z,1521066793.628 [BPC1](INFO): Starting 2018-03-14T22:33:14.023Z,1521066794.023 [BPC1](INFO): Starting 2018-03-14T22:33:14.435Z,1521066794.435 [BPC1](INFO): Starting 2018-03-14T22:33:14.840Z,1521066794.840 [BPC1](INFO): Starting 2018-03-14T22:33:15.242Z,1521066795.242 [BPC1](INFO): Starting 2018-03-14T22:33:15.646Z,1521066795.646 [BPC1](INFO): Starting 2018-03-14T22:33:16.020Z,1521066796.020 [BPC1](INFO): Starting 2018-03-14T22:33:16.420Z,1521066796.420 [BPC1](INFO): Starting 2018-03-14T22:33:16.821Z,1521066796.821 [BPC1](INFO): Starting 2018-03-14T22:33:17.221Z,1521066797.221 [BPC1](INFO): Starting 2018-03-14T22:33:17.620Z,1521066797.620 [BPC1](INFO): Starting 2018-03-14T22:33:18.055Z,1521066798.055 [BPC1](INFO): Starting 2018-03-14T22:33:18.454Z,1521066798.454 [BPC1](INFO): Starting 2018-03-14T22:33:18.850Z,1521066798.850 [BPC1](INFO): Starting 2018-03-14T22:33:19.228Z,1521066799.228 [BPC1](INFO): Starting 2018-03-14T22:33:19.624Z,1521066799.624 [BPC1](INFO): Starting 2018-03-14T22:33:20.031Z,1521066800.031 [BPC1](INFO): Starting 2018-03-14T22:33:20.431Z,1521066800.431 [BPC1](INFO): Starting 2018-03-14T22:33:20.839Z,1521066800.839 [BPC1](INFO): Starting 2018-03-14T22:33:21.242Z,1521066801.242 [BPC1](INFO): Starting 2018-03-14T22:33:21.643Z,1521066801.643 [BPC1](INFO): Starting 2018-03-14T22:33:22.021Z,1521066802.021 [BPC1](INFO): Starting 2018-03-14T22:33:22.428Z,1521066802.428 [BPC1](INFO): Starting 2018-03-14T22:33:22.829Z,1521066802.829 [BPC1](INFO): Starting 2018-03-14T22:33:23.224Z,1521066803.224 [BPC1](INFO): Starting 2018-03-14T22:33:23.631Z,1521066803.631 [BPC1](INFO): Starting 2018-03-14T22:33:24.048Z,1521066804.048 [BPC1](INFO): Starting 2018-03-14T22:33:24.442Z,1521066804.442 [BPC1](INFO): Starting 2018-03-14T22:33:24.845Z,1521066804.845 [BPC1](INFO): Starting 2018-03-14T22:33:25.221Z,1521066805.221 [BPC1](INFO): Starting 2018-03-14T22:33:25.620Z,1521066805.620 [BPC1](INFO): Starting 2018-03-14T22:33:26.021Z,1521066806.021 [BPC1](INFO): Starting 2018-03-14T22:33:26.421Z,1521066806.421 [BPC1](INFO): Starting 2018-03-14T22:33:26.849Z,1521066806.849 [BPC1](INFO): Starting 2018-03-14T22:33:27.247Z,1521066807.247 [BPC1](INFO): Starting 2018-03-14T22:33:30.375Z,1521066810.375 [BPC1](INFO): Starting 2018-03-14T22:33:30.507Z,1521066810.507 [BPC1](INFO): Starting 2018-03-14T22:33:30.881Z,1521066810.881 [BPC1](INFO): Starting 2018-03-14T22:33:31.282Z,1521066811.282 [BPC1](INFO): Starting 2018-03-14T22:33:31.675Z,1521066811.675 [BPC1](INFO): Starting 2018-03-14T22:33:32.086Z,1521066812.086 [BPC1](INFO): Starting 2018-03-14T22:33:32.486Z,1521066812.486 [BPC1](INFO): Starting 2018-03-14T22:33:32.888Z,1521066812.888 [BPC1](INFO): Starting 2018-03-14T22:33:33.276Z,1521066813.276 [BPC1](INFO): Starting 2018-03-14T22:33:33.669Z,1521066813.669 [BPC1](INFO): Starting 2018-03-14T22:33:34.069Z,1521066814.069 [BPC1](INFO): Starting 2018-03-14T22:33:34.468Z,1521066814.468 [BPC1](INFO): Starting 2018-03-14T22:33:34.895Z,1521066814.895 [BPC1](INFO): Starting 2018-03-14T22:33:35.298Z,1521066815.298 [BPC1](INFO): Starting 2018-03-14T22:33:35.699Z,1521066815.699 [BPC1](INFO): Starting 2018-03-14T22:33:36.077Z,1521066816.077 [BPC1](INFO): Starting 2018-03-14T22:33:36.471Z,1521066816.471 [BPC1](INFO): Starting 2018-03-14T22:33:36.879Z,1521066816.879 [BPC1](INFO): Starting 2018-03-14T22:33:37.277Z,1521066817.277 [BPC1](INFO): Starting 2018-03-14T22:33:37.676Z,1521066817.676 [BPC1](INFO): Starting 2018-03-14T22:33:38.089Z,1521066818.089 [BPC1](INFO): Starting 2018-03-14T22:33:38.500Z,1521066818.500 [BPC1](INFO): Starting 2018-03-14T22:33:38.891Z,1521066818.891 [BPC1](INFO): Starting 2018-03-14T22:33:38.919Z,1521066818.919 [Default:CheckIn:Read_GPS](INFO): Timed out from 2018-03-14T22:28:38.8Z 2018-03-14T22:33:38.919Z,1521066818.919 [Default:CheckIn:Read_GPS] Stopped 2018-03-14T22:33:38.919Z,1521066818.919 [Default:CheckIn:Read_Iridium] Running Loop=1 2018-03-14T22:33:39.269Z,1521066819.269 [BPC1](INFO): Starting 2018-03-14T22:33:39.295Z,1521066819.295 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications 2018-03-14T22:33:39.813Z,1521066819.813 [BPC1](INFO): Starting 2018-03-14T22:33:40.094Z,1521066820.094 [BPC1](INFO): Starting 2018-03-14T22:33:43.272Z,1521066823.272 [BPC1](INFO): Starting 2018-03-14T22:33:43.340Z,1521066823.340 [DataOverHttps](INFO): Sending 25 bytes from file Logs/20180314T222456/Courier0004.lzma 2018-03-14T22:33:43.419Z,1521066823.419 [BPC1](INFO): Starting 2018-03-14T22:33:43.775Z,1521066823.775 [BPC1](INFO): Starting 2018-03-14T22:33:44.131Z,1521066824.131 [DataOverHttps](INFO): Moved sent file to Logs/20180314T222456/Courier0004.lzma.bak 2018-03-14T22:33:44.131Z,1521066824.131 [DataOverHttps](INFO): SBD MOMSN=8061794 2018-03-14T22:33:44.188Z,1521066824.188 [BPC1](INFO): Starting 2018-03-14T22:33:44.836Z,1521066824.836 [BPC1](INFO): Starting 2018-03-14T22:33:44.987Z,1521066824.987 [BPC1](INFO): Starting 2018-03-14T22:33:48.113Z,1521066828.113 [BPC1](INFO): Starting 2018-03-14T22:33:48.255Z,1521066828.255 [BPC1](INFO): Starting 2018-03-14T22:33:48.607Z,1521066828.607 [BPC1](INFO): Starting 2018-03-14T22:33:48.987Z,1521066828.987 [BPC1](INFO): Starting 2018-03-14T22:33:49.377Z,1521066829.377 [BPC1](INFO): Starting 2018-03-14T22:33:49.779Z,1521066829.779 [BPC1](INFO): Starting 2018-03-14T22:33:52.903Z,1521066832.903 [BPC1](INFO): Starting 2018-03-14T22:33:52.969Z,1521066832.969 [DataOverHttps](INFO): Sending 573 bytes from file Logs/20180314T222456/Express0001.lzma 2018-03-14T22:33:53.032Z,1521066833.032 [BPC1](INFO): Starting 2018-03-14T22:33:53.410Z,1521066833.410 [BPC1](INFO): Starting 2018-03-14T22:33:53.759Z,1521066833.759 [DataOverHttps](INFO): Moved sent file to Logs/20180314T222456/Express0001.lzma.bak 2018-03-14T22:33:53.759Z,1521066833.759 [DataOverHttps](INFO): SBD MOMSN=8061797 2018-03-14T22:33:53.826Z,1521066833.826 [BPC1](INFO): Starting 2018-03-14T22:33:54.479Z,1521066834.479 [BPC1](INFO): Starting 2018-03-14T22:33:54.607Z,1521066834.607 [BPC1](INFO): Starting 2018-03-14T22:33:57.732Z,1521066837.732 [BPC1](INFO): Starting 2018-03-14T22:33:57.859Z,1521066837.859 [BPC1](INFO): Starting 2018-03-14T22:33:58.211Z,1521066838.211 [BPC1](INFO): Starting 2018-03-14T22:33:58.611Z,1521066838.611 [BPC1](INFO): Starting 2018-03-14T22:33:59.010Z,1521066839.010 [BPC1](INFO): Starting 2018-03-14T22:33:59.402Z,1521066839.402 [BPC1](INFO): Starting 2018-03-14T22:34:02.524Z,1521066842.524 [BPC1](INFO): Starting 2018-03-14T22:34:02.589Z,1521066842.589 [DataOverHttps](INFO): Sending 332 bytes from file Logs/20180314T222456/Express0005.lzma 2018-03-14T22:34:02.659Z,1521066842.659 [BPC1](INFO): Starting 2018-03-14T22:34:03.040Z,1521066843.040 [BPC1](INFO): Starting 2018-03-14T22:34:03.444Z,1521066843.444 [BPC1](INFO): Starting 2018-03-14T22:34:03.843Z,1521066843.843 [BPC1](INFO): Starting 2018-03-14T22:34:04.179Z,1521066844.179 [DataOverHttps](INFO): Moved sent file to Logs/20180314T222456/Express0005.lzma.bak 2018-03-14T22:34:04.179Z,1521066844.179 [DataOverHttps](INFO): SBD MOMSN=8061828 2018-03-14T22:34:04.234Z,1521066844.234 [BPC1](INFO): Starting 2018-03-14T22:34:04.893Z,1521066844.893 [BPC1](INFO): Starting 2018-03-14T22:34:04.903Z,1521066844.903 [Default:CheckIn:Read_Iridium] Stopped 2018-03-14T22:34:04.903Z,1521066844.903 [Default:CheckIn:C.Wait] Running Loop=1 2018-03-14T22:34:04.903Z,1521066844.903 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2018-03-14T22:34:05.023Z,1521066845.023 [BPC1](INFO): Starting 2018-03-14T22:34:08.151Z,1521066848.151 [BPC1](INFO): Starting 2018-03-14T22:34:08.159Z,1521066848.159 [DeadReckonUsingSpeedCalculator](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-03-14T22:34:08.159Z,1521066848.159 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 3 2018-03-14T22:34:08.159Z,1521066848.159 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2018-03-14T22:34:08.160Z,1521066848.160 [DeadReckonWithRespectToSeafloor](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-03-14T22:34:08.161Z,1521066848.161 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 3 2018-03-14T22:34:08.161Z,1521066848.161 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2018-03-14T22:34:08.172Z,1521066848.172 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2018-03-14T22:34:08.172Z,1521066848.172 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2018-03-14T22:34:08.314Z,1521066848.314 [BPC1](INFO): Starting 2018-03-14T22:34:08.355Z,1521066848.355 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2018-03-14T22:34:08.355Z,1521066848.355 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 3 2018-03-14T22:34:08.356Z,1521066848.356 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2018-03-14T22:34:08.356Z,1521066848.356 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 3 2018-03-14T22:34:08.635Z,1521066848.635 [BPC1](INFO): Starting 2018-03-14T22:34:08.665Z,1521066848.665 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2018-03-14T22:34:08.666Z,1521066848.666 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s. 2018-03-14T22:34:08.666Z,1521066848.666 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s. 2018-03-14T22:34:08.667Z,1521066848.667 [DeadReckonWithRespectToSeafloor](DEBUG): Initializing DeadReckonWithRespectToSeafloor component. 2018-03-14T22:34:08.667Z,1521066848.667 [DeadReckonWithRespectToSeafloor](INFO): Will consider orientation measurement stale after 120s. 2018-03-14T22:34:08.667Z,1521066848.667 [DeadReckonWithRespectToSeafloor](INFO): Will consider velocity measurement stale after 20s. 2018-03-14T22:34:09.031Z,1521066849.031 [BPC1](INFO): Starting 2018-03-14T22:34:09.422Z,1521066849.422 [BPC1](INFO): Starting 2018-03-14T22:34:09.804Z,1521066849.804 [BPC1](INFO): Starting 2018-03-14T22:34:10.205Z,1521066850.205 [BPC1](INFO): Starting 2018-03-14T22:34:10.604Z,1521066850.604 [BPC1](INFO): Starting 2018-03-14T22:34:11.033Z,1521066851.033 [BPC1](INFO): Starting 2018-03-14T22:34:11.419Z,1521066851.419 [BPC1](INFO): Starting 2018-03-14T22:34:11.823Z,1521066851.823 [BPC1](INFO): Starting 2018-03-14T22:34:12.212Z,1521066852.212 [BPC1](INFO): Starting 2018-03-14T22:34:12.611Z,1521066852.611 [BPC1](INFO): Starting 2018-03-14T22:34:13.013Z,1521066853.013 [BPC1](INFO): Starting 2018-03-14T22:34:13.415Z,1521066853.415 [BPC1](INFO): Starting 2018-03-14T22:34:13.831Z,1521066853.831 [BPC1](INFO): Starting 2018-03-14T22:34:14.226Z,1521066854.226 [BPC1](INFO): Starting 2018-03-14T22:34:14.624Z,1521066854.624 [BPC1](INFO): Starting 2018-03-14T22:34:15.004Z,1521066855.004 [BPC1](INFO): Starting 2018-03-14T22:34:15.404Z,1521066855.404 [BPC1](INFO): Starting 2018-03-14T22:34:15.809Z,1521066855.809 [BPC1](INFO): Starting 2018-03-14T22:34:16.205Z,1521066856.205 [BPC1](INFO): Starting 2018-03-14T22:34:16.608Z,1521066856.608 [BPC1](INFO): Starting 2018-03-14T22:34:17.023Z,1521066857.023 [BPC1](INFO): Starting 2018-03-14T22:34:17.419Z,1521066857.419 [BPC1](INFO): Starting 2018-03-14T22:34:17.816Z,1521066857.816 [BPC1](INFO): Starting 2018-03-14T22:34:18.215Z,1521066858.215 [BPC1](INFO): Starting 2018-03-14T22:34:18.611Z,1521066858.611 [BPC1](INFO): Starting 2018-03-14T22:34:19.005Z,1521066859.005 [BPC1](INFO): Starting 2018-03-14T22:34:19.404Z,1521066859.404 [BPC1](INFO): Starting 2018-03-14T22:34:19.832Z,1521066859.832 [BPC1](INFO): Starting 2018-03-14T22:34:20.233Z,1521066860.233 [BPC1](INFO): Starting 2018-03-14T22:34:20.623Z,1521066860.623 [BPC1](INFO): Starting 2018-03-14T22:34:21.009Z,1521066861.009 [BPC1](INFO): Starting 2018-03-14T22:34:21.404Z,1521066861.404 [BPC1](INFO): Starting 2018-03-14T22:34:21.804Z,1521066861.804 [BPC1](INFO): Starting 2018-03-14T22:34:22.213Z,1521066862.213 [BPC1](INFO): Starting 2018-03-14T22:34:22.613Z,1521066862.613 [BPC1](INFO): Starting 2018-03-14T22:34:23.015Z,1521066863.015 [BPC1](INFO): Starting 2018-03-14T22:34:23.419Z,1521066863.419 [BPC1](INFO): Starting 2018-03-14T22:34:23.815Z,1521066863.815 [BPC1](INFO): Starting 2018-03-14T22:34:24.204Z,1521066864.204 [BPC1](INFO): Starting 2018-03-14T22:34:24.605Z,1521066864.605 [BPC1](INFO): Starting 2018-03-14T22:34:25.005Z,1521066865.005 [BPC1](INFO): Starting 2018-03-14T22:34:25.404Z,1521066865.404 [BPC1](INFO): Starting 2018-03-14T22:34:25.819Z,1521066865.819 [BPC1](INFO): Starting 2018-03-14T22:34:26.239Z,1521066866.239 [BPC1](INFO): Starting 2018-03-14T22:34:26.634Z,1521066866.634 [BPC1](INFO): Starting 2018-03-14T22:34:27.017Z,1521066867.017 [BPC1](INFO): Starting 2018-03-14T22:34:27.414Z,1521066867.414 [BPC1](INFO): Starting 2018-03-14T22:34:27.817Z,1521066867.817 [BPC1](INFO): Starting 2018-03-14T22:34:28.212Z,1521066868.212 [BPC1](INFO): Starting 2018-03-14T22:34:28.604Z,1521066868.604 [BPC1](INFO): Starting 2018-03-14T22:34:29.023Z,1521066869.023 [BPC1](INFO): Starting 2018-03-14T22:34:29.428Z,1521066869.428 [BPC1](INFO): Starting 2018-03-14T22:34:29.831Z,1521066869.831 [BPC1](INFO): Starting 2018-03-14T22:34:30.204Z,1521066870.204 [BPC1](INFO): Starting 2018-03-14T22:34:30.617Z,1521066870.617 [BPC1](INFO): Starting 2018-03-14T22:34:31.013Z,1521066871.013 [BPC1](INFO): Starting 2018-03-14T22:34:31.499Z,1521066871.499 [BPC1](INFO): Starting 2018-03-14T22:34:31.831Z,1521066871.831 [BPC1](INFO): Starting 2018-03-14T22:34:32.224Z,1521066872.224 [BPC1](INFO): Starting 2018-03-14T22:34:32.617Z,1521066872.617 [BPC1](INFO): Starting 2018-03-14T22:34:33.008Z,1521066873.008 [BPC1](INFO): Starting 2018-03-14T22:34:33.415Z,1521066873.415 [BPC1](INFO): Starting 2018-03-14T22:34:33.819Z,1521066873.819 [BPC1](INFO): Starting 2018-03-14T22:34:34.214Z,1521066874.214 [BPC1](INFO): Starting 2018-03-14T22:34:34.604Z,1521066874.604 [BPC1](INFO): Starting 2018-03-14T22:34:35.023Z,1521066875.023 [BPC1](INFO): Starting 2018-03-14T22:34:35.432Z,1521066875.432 [BPC1](INFO): Starting 2018-03-14T22:34:35.832Z,1521066875.832 [BPC1](INFO): Starting 2018-03-14T22:34:36.212Z,1521066876.212 [BPC1](INFO): Starting 2018-03-14T22:34:36.612Z,1521066876.612 [BPC1](INFO): Starting 2018-03-14T22:34:37.008Z,1521066877.008 [BPC1](INFO): Starting 2018-03-14T22:34:37.415Z,1521066877.415 [BPC1](INFO): Starting 2018-03-14T22:34:37.928Z,1521066877.928 [BPC1](INFO): Starting 2018-03-14T22:34:38.240Z,1521066878.240 [BPC1](INFO): Starting 2018-03-14T22:34:38.629Z,1521066878.629 [BPC1](INFO): Starting 2018-03-14T22:34:39.005Z,1521066879.005 [BPC1](INFO): Starting 2018-03-14T22:34:39.404Z,1521066879.404 [BPC1](INFO): Starting 2018-03-14T22:34:39.804Z,1521066879.804 [BPC1](INFO): Starting 2018-03-14T22:34:40.205Z,1521066880.205 [BPC1](INFO): Starting 2018-03-14T22:34:40.612Z,1521066880.612 [BPC1](INFO): Starting 2018-03-14T22:34:41.023Z,1521066881.023 [BPC1](INFO): Starting 2018-03-14T22:34:41.427Z,1521066881.427 [BPC1](INFO): Starting 2018-03-14T22:34:41.864Z,1521066881.864 [BPC1](INFO): Starting 2018-03-14T22:34:42.227Z,1521066882.227 [BPC1](INFO): Starting 2018-03-14T22:34:42.609Z,1521066882.609 [BPC1](INFO): Starting 2018-03-14T22:34:43.012Z,1521066883.012 [BPC1](INFO): Starting 2018-03-14T22:34:43.410Z,1521066883.410 [BPC1](INFO): Starting 2018-03-14T22:34:43.847Z,1521066883.847 [BPC1](INFO): Starting 2018-03-14T22:34:44.225Z,1521066884.225 [BPC1](INFO): Starting 2018-03-14T22:34:44.643Z,1521066884.643 [BPC1](INFO): Starting 2018-03-14T22:34:45.051Z,1521066885.051 [BPC1](INFO): Starting 2018-03-14T22:34:45.431Z,1521066885.431 [BPC1](INFO): Starting 2018-03-14T22:34:45.817Z,1521066885.817 [BPC1](INFO): Starting 2018-03-14T22:34:46.210Z,1521066886.210 [BPC1](INFO): Starting 2018-03-14T22:34:46.620Z,1521066886.620 [BPC1](INFO): Starting 2018-03-14T22:34:47.047Z,1521066887.047 [BPC1](INFO): Starting 2018-03-14T22:34:47.442Z,1521066887.442 [BPC1](INFO): Starting 2018-03-14T22:34:47.820Z,1521066887.820 [BPC1](INFO): Starting 2018-03-14T22:34:48.217Z,1521066888.217 [BPC1](INFO): Starting 2018-03-14T22:34:48.638Z,1521066888.638 [BPC1](INFO): Starting 2018-03-14T22:34:49.041Z,1521066889.041 [BPC1](INFO): Starting 2018-03-14T22:34:49.446Z,1521066889.446 [BPC1](INFO): Starting 2018-03-14T22:34:49.854Z,1521066889.854 [BPC1](INFO): Starting 2018-03-14T22:34:50.240Z,1521066890.240 [BPC1](INFO): Starting 2018-03-14T22:34:50.622Z,1521066890.622 [BPC1](INFO): Starting 2018-03-14T22:34:51.015Z,1521066891.015 [BPC1](INFO): Starting 2018-03-14T22:34:51.404Z,1521066891.404 [BPC1](INFO): Starting 2018-03-14T22:34:51.804Z,1521066891.804 [BPC1](INFO): Starting 2018-03-14T22:34:52.205Z,1521066892.205 [BPC1](INFO): Starting 2018-03-14T22:34:52.604Z,1521066892.604 [BPC1](INFO): Starting 2018-03-14T22:34:53.040Z,1521066893.040 [BPC1](INFO): Starting 2018-03-14T22:34:53.430Z,1521066893.430 [BPC1](INFO): Starting 2018-03-14T22:34:53.824Z,1521066893.824 [BPC1](INFO): Starting 2018-03-14T22:34:54.211Z,1521066894.211 [BPC1](INFO): Starting 2018-03-14T22:34:54.615Z,1521066894.615 [BPC1](INFO): Starting 2018-03-14T22:34:54.800Z,1521066894.800 [CommandLine](IMPORTANT): got command restart application 2018-03-14T22:34:55.005Z,1521066895.005 [BPC1](INFO): Starting 2018-03-14T22:34:55.405Z,1521066895.405 [BPC1](INFO): Starting 2018-03-14T22:34:55.807Z,1521066895.807 [Supervisor](INFO): Stop Mission called by Supervisor::terminate 2018-03-14T22:34:55.812Z,1521066895.812 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2018-03-14T22:34:55.813Z,1521066895.813 [CommandLine ThreadHandler](INFO): Thread cancelled. 2018-03-14T22:34:55.841Z,1521066895.841 [BPC1](INFO): Starting 2018-03-14T22:34:55.986Z,1521066895.986 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2018-03-14T22:34:55.987Z,1521066895.987 [CommandLine ThreadHandler](INFO): Thread cancelled. 2018-03-14T22:34:55.987Z,1521066895.987 [CommandLine](INFO): Join timeout helper Thread ID is 656 2018-03-14T22:34:55.988Z,1521066895.988 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2018-03-14T22:34:55.988Z,1521066895.988 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2018-03-14T22:34:55.988Z,1521066895.988 [NavChartDb](INFO): Join timeout helper Thread ID is 657 2018-03-14T22:34:56.239Z,1521066896.239 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2018-03-14T22:34:56.239Z,1521066896.239 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2018-03-14T22:34:56.244Z,1521066896.244 [BPC1](INFO): Starting 2018-03-14T22:34:56.255Z,1521066896.255 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler 2018-03-14T22:34:56.255Z,1521066896.255 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2018-03-14T22:34:56.255Z,1521066896.255 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 658 2018-03-14T22:34:56.411Z,1521066896.411 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread. 2018-03-14T22:34:56.411Z,1521066896.411 [WetLabsBB2FL](INFO): Powering down 2018-03-14T22:34:56.412Z,1521066896.412 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2018-03-14T22:34:56.435Z,1521066896.435 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2018-03-14T22:34:56.435Z,1521066896.435 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2018-03-14T22:34:56.435Z,1521066896.435 [Radio_Surface](INFO): Join timeout helper Thread ID is 659 2018-03-14T22:34:56.447Z,1521066896.447 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2018-03-14T22:34:56.447Z,1521066896.447 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2018-03-14T22:34:56.458Z,1521066896.458 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2018-03-14T22:34:56.459Z,1521066896.459 [logger ThreadHandler](INFO): Thread cancelled. 2018-03-14T22:34:56.459Z,1521066896.459 [logger](INFO): Join timeout helper Thread ID is 660 2018-03-14T22:34:56.479Z,1521066896.479 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2018-03-14T22:34:56.479Z,1521066896.479 [logger ThreadHandler](INFO): Thread cancelled. 2018-03-14T22:34:56.499Z,1521066896.499 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2018-03-14T22:34:56.499Z,1521066896.499 [CommandLine ThreadHandler](INFO): Thread cancelled. 2018-03-14T22:34:56.500Z,1521066896.500 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2018-03-14T22:34:56.500Z,1521066896.500 [controlThread ThreadHandler](INFO): Thread cancelled. 2018-03-14T22:34:56.500Z,1521066896.500 [controlThread](INFO): Join timeout helper Thread ID is 661 2018-03-14T22:34:56.575Z,1521066896.575 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2018-03-14T22:34:56.575Z,1521066896.575 [controlThread](DEBUG): Uninitializing ControlThread 2018-03-14T22:34:56.576Z,1521066896.576 [NAL9602](INFO): Powering down 2018-03-14T22:34:56.577Z,1521066896.577 [PNI_TCM](INFO): Powering down 2018-03-14T22:34:56.663Z,1521066896.663 [BPC1](INFO): uninitialize 2018-03-14T22:34:56.664Z,1521066896.664 [Aanderaa_O2](INFO): Powering down 2018-03-14T22:34:56.666Z,1521066896.666 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2018-03-14T22:34:56.667Z,1521066896.667 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2018-03-14T22:34:56.668Z,1521066896.668 [MissionManager](INFO): Uninitializing Mission Default 2018-03-14T22:34:56.668Z,1521066896.668 [Default] Stopped 2018-03-14T22:34:56.668Z,1521066896.668 [Default](DEBUG): Aggregate::uninitialize Default 2018-03-14T22:34:56.668Z,1521066896.668 [Default:B.GoToSurface] Stopped 2018-03-14T22:34:56.668Z,1521066896.668 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2018-03-14T22:34:56.668Z,1521066896.668 [Default:CheckIn] Stopped 2018-03-14T22:34:56.668Z,1521066896.668 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2018-03-14T22:34:56.669Z,1521066896.669 [Default:CheckIn:C.Wait] Stopped 2018-03-14T22:34:56.669Z,1521066896.669 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2018-03-14T22:34:56.671Z,1521066896.671 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2018-03-14T22:34:56.672Z,1521066896.672 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2018-03-14T22:34:56.672Z,1521066896.672 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2018-03-14T22:34:56.672Z,1521066896.672 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2018-03-14T22:34:56.672Z,1521066896.672 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2018-03-14T22:34:56.673Z,1521066896.673 [BuoyancyServo](INFO): Powering down 2018-03-14T22:34:56.687Z,1521066896.687 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2018-03-14T22:34:56.687Z,1521066896.687 [ElevatorServo](INFO): Powering down 2018-03-14T22:34:56.687Z,1521066896.687 [MassServo](DEBUG): Uninitialize Mass Servo. 2018-03-14T22:34:56.688Z,1521066896.688 [MassServo](INFO): Powering down 2018-03-14T22:34:56.688Z,1521066896.688 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2018-03-14T22:34:56.688Z,1521066896.688 [RudderServo](INFO): Powering down 2018-03-14T22:34:56.689Z,1521066896.689 [ThrusterServo](DEBUG): Uninitialize Thruster Servo. 2018-03-14T22:34:56.689Z,1521066896.689 [ThrusterServo](INFO): Powering down 2018-03-14T22:34:56.690Z,1521066896.690 [SBIT](DEBUG): Uninitialize SBIT Component. 2018-03-14T22:34:56.690Z,1521066896.690 [IBIT](DEBUG): Uninitialize IBIT Component. 2018-03-14T22:34:56.691Z,1521066896.691 [CBIT](DEBUG): Uninitialize CBIT Component. 2018-03-14T22:34:56.691Z,1521066896.691 [controlThread ThreadHandler](INFO): Thread cancelled. 2018-03-14T22:34:56.731Z,1521066896.731 [BPC1](INFO): uninitialize 2018-03-14T22:34:56.778Z,1521066896.778 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2018-03-14T22:34:56.815Z,1521066896.815 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2018-03-14T22:34:56.841Z,1521066896.841 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2018-03-14T22:34:56.888Z,1521066896.888 [logger ThreadHandler](INFO): Thread cancelled.