2018-01-22T21:49:54.108Z,1516657794.108 [Supervisor](DEBUG): Initializing supervisor. 2018-01-22T21:49:54.111Z,1516657794.111 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2018-01-22T21:49:54.111Z,1516657794.111 [SyncHandler](INFO): Protected caller Thread ID is 1522 2018-01-22T21:49:54.112Z,1516657794.112 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2018-01-22T21:49:54.113Z,1516657794.113 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2018-01-22T21:49:54.113Z,1516657794.113 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 1523 2018-01-22T21:49:54.116Z,1516657794.116 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2018-01-22T21:49:54.137Z,1516657794.137 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2018-01-22T21:49:54.138Z,1516657794.138 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2018-01-22T21:49:54.139Z,1516657794.139 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 1524 2018-01-22T21:49:54.140Z,1516657794.140 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2018-01-22T21:49:54.140Z,1516657794.140 [logger ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2018-01-22T21:49:54.141Z,1516657794.141 [logger ThreadHandler](INFO): Protected caller Thread ID is 1525 2018-01-22T21:49:54.143Z,1516657794.143 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2018-01-22T21:49:54.143Z,1516657794.143 [Supervisor](INFO): Looking for Config files in directory: Config/ 2018-01-22T21:49:54.145Z,1516657794.145 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2018-01-22T21:49:54.338Z,1516657794.338 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2018-01-22T21:49:54.339Z,1516657794.339 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2018-01-22T21:49:54.470Z,1516657794.470 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2018-01-22T21:49:54.471Z,1516657794.471 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2018-01-22T21:49:54.767Z,1516657794.767 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2018-01-22T21:49:54.768Z,1516657794.768 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2018-01-22T21:49:54.896Z,1516657794.896 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2018-01-22T21:49:54.896Z,1516657794.896 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2018-01-22T21:49:54.976Z,1516657794.976 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2018-01-22T21:49:55.164Z,1516657795.164 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2018-01-22T21:49:55.164Z,1516657795.164 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2018-01-22T21:49:55.260Z,1516657795.260 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample 2018-01-22T21:49:55.260Z,1516657795.260 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2018-01-22T21:49:55.564Z,1516657795.564 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2018-01-22T21:49:55.565Z,1516657795.565 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2018-01-22T21:49:55.883Z,1516657795.883 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2018-01-22T21:49:55.883Z,1516657795.883 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2018-01-22T21:49:56.322Z,1516657796.322 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2018-01-22T21:49:56.323Z,1516657796.323 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2018-01-22T21:49:56.779Z,1516657796.779 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2018-01-22T21:49:56.780Z,1516657796.780 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2018-01-22T21:49:56.966Z,1516657796.966 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2018-01-22T21:49:56.967Z,1516657796.967 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2018-01-22T21:49:57.113Z,1516657797.113 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2018-01-22T21:49:57.113Z,1516657797.113 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2018-01-22T21:49:57.539Z,1516657797.539 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2018-01-22T21:49:57.539Z,1516657797.539 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2018-01-22T21:49:57.642Z,1516657797.642 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2018-01-22T21:49:57.644Z,1516657797.644 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-aku/ 2018-01-22T21:49:57.645Z,1516657797.645 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/Battery.cfg 2018-01-22T21:49:57.921Z,1516657797.921 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2018-01-22T21:49:57.921Z,1516657797.921 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/BIT.cfg 2018-01-22T21:49:58.016Z,1516657798.016 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/Navigation.cfg 2018-01-22T21:49:58.115Z,1516657798.115 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/Control.cfg 2018-01-22T21:49:58.208Z,1516657798.208 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/Simulator.cfg 2018-01-22T21:49:58.292Z,1516657798.292 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/Science.cfg 2018-01-22T21:49:58.434Z,1516657798.434 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/Sensor.cfg 2018-01-22T21:49:58.590Z,1516657798.590 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/Servo.cfg 2018-01-22T21:49:58.692Z,1516657798.692 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/logger.cfg 2018-01-22T21:49:58.854Z,1516657798.854 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/secure.cfg 2018-01-22T21:49:58.936Z,1516657798.936 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/vehicle.cfg 2018-01-22T21:49:59.092Z,1516657799.092 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-aku/root/ 2018-01-22T21:49:59.092Z,1516657799.092 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg 2018-01-22T21:49:59.095Z,1516657799.095 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2018-01-22T21:49:59.247Z,1516657799.247 [SBIT](DEBUG): Construct Startup Built In Test. 2018-01-22T21:49:59.276Z,1516657799.276 [SBIT] Loaded 2018-01-22T21:49:59.277Z,1516657799.277 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2018-01-22T21:49:59.277Z,1516657799.277 [IBIT](DEBUG): Construct Initiated Built In Test. 2018-01-22T21:49:59.303Z,1516657799.303 [IBIT] Loaded 2018-01-22T21:49:59.304Z,1516657799.304 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2018-01-22T21:49:59.307Z,1516657799.307 [CBIT](DEBUG): Construct Continuous Built In Test. 2018-01-22T21:49:59.453Z,1516657799.453 [CBIT] Loaded 2018-01-22T21:49:59.454Z,1516657799.454 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2018-01-22T21:49:59.454Z,1516657799.454 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2018-01-22T21:49:59.455Z,1516657799.455 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2018-01-22T21:49:59.519Z,1516657799.519 [VerticalControl](DEBUG): Construct VerticalControl. 2018-01-22T21:49:59.613Z,1516657799.613 [VerticalControl] Loaded 2018-01-22T21:49:59.613Z,1516657799.613 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2018-01-22T21:49:59.614Z,1516657799.614 [HorizontalControl](DEBUG): Construct HorizontalControl. 2018-01-22T21:49:59.671Z,1516657799.671 [HorizontalControl] Loaded 2018-01-22T21:49:59.672Z,1516657799.672 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2018-01-22T21:49:59.672Z,1516657799.672 [SpeedControl](DEBUG): Construct SpeedControl. 2018-01-22T21:49:59.677Z,1516657799.677 [SpeedControl] Loaded 2018-01-22T21:49:59.678Z,1516657799.678 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2018-01-22T21:49:59.678Z,1516657799.678 [LoopControl](DEBUG): Construct LoopControl. 2018-01-22T21:49:59.679Z,1516657799.679 [LoopControl] Loaded 2018-01-22T21:49:59.679Z,1516657799.679 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2018-01-22T21:49:59.679Z,1516657799.679 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2018-01-22T21:49:59.680Z,1516657799.680 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2018-01-22T21:50:00.721Z,1516657800.721 [DepthRateCalculator] Loaded 2018-01-22T21:50:00.722Z,1516657800.722 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2018-01-22T21:50:00.727Z,1516657800.727 [PitchRateCalculator] Loaded 2018-01-22T21:50:00.727Z,1516657800.727 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2018-01-22T21:50:00.742Z,1516657800.742 [SpeedCalculator] Loaded 2018-01-22T21:50:00.743Z,1516657800.743 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2018-01-22T21:50:00.763Z,1516657800.763 [TempGradientCalculator] Loaded 2018-01-22T21:50:00.763Z,1516657800.763 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread. 2018-01-22T21:50:00.777Z,1516657800.777 [VerticalTemperatureHomogeneityIndexCalculator] Loaded 2018-01-22T21:50:00.778Z,1516657800.778 [ComponentRegistry](DEBUG): SyncComponent "VerticalTemperatureHomogeneityIndexCalculator" handled in the control thread. 2018-01-22T21:50:00.782Z,1516657800.782 [YawRateCalculator] Loaded 2018-01-22T21:50:00.783Z,1516657800.783 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2018-01-22T21:50:00.783Z,1516657800.783 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2018-01-22T21:50:00.784Z,1516657800.784 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2018-01-22T21:50:00.867Z,1516657800.867 [StratificationFrontDetector](INFO): threshold set to: 0.399988 degC 2018-01-22T21:50:00.867Z,1516657800.867 [StratificationFrontDetector](DEBUG): (re)initializing 2018-01-22T21:50:00.867Z,1516657800.867 [StratificationFrontDetector] Loaded 2018-01-22T21:50:00.868Z,1516657800.868 [ComponentRegistry](DEBUG): SyncComponent "StratificationFrontDetector" handled in the control thread. 2018-01-22T21:50:00.868Z,1516657800.868 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2018-01-22T21:50:00.869Z,1516657800.869 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2018-01-22T21:50:01.096Z,1516657801.096 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2018-01-22T21:50:01.097Z,1516657801.097 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2018-01-22T21:50:01.190Z,1516657801.190 [DeadReckonUsingMultipleVelocitySources] Loaded 2018-01-22T21:50:01.190Z,1516657801.190 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2018-01-22T21:50:01.241Z,1516657801.241 [DeadReckonUsingSpeedCalculator] Loaded 2018-01-22T21:50:01.241Z,1516657801.241 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread. 2018-01-22T21:50:01.293Z,1516657801.293 [DeadReckonWithRespectToSeafloor] Loaded 2018-01-22T21:50:01.293Z,1516657801.293 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonWithRespectToSeafloor" handled in the control thread. 2018-01-22T21:50:01.309Z,1516657801.309 [NavChart] Loaded 2018-01-22T21:50:01.309Z,1516657801.309 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2018-01-22T21:50:01.313Z,1516657801.313 [UniversalFixResidualReporter] Loaded 2018-01-22T21:50:01.313Z,1516657801.313 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2018-01-22T21:50:01.314Z,1516657801.314 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2018-01-22T21:50:01.314Z,1516657801.314 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2018-01-22T21:50:01.327Z,1516657801.327 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2018-01-22T21:50:01.328Z,1516657801.328 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2018-01-22T21:50:01.477Z,1516657801.477 [Aanderaa_O2] Loaded 2018-01-22T21:50:01.477Z,1516657801.477 [ComponentRegistry](DEBUG): SyncComponent "Aanderaa_O2" handled in the control thread. 2018-01-22T21:50:01.523Z,1516657801.523 [CTD_Seabird] Loaded 2018-01-22T21:50:01.523Z,1516657801.523 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread. 2018-01-22T21:50:01.524Z,1516657801.524 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 406D54E0 2018-01-22T21:50:01.525Z,1516657801.525 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 1604 2018-01-22T21:50:01.540Z,1516657801.540 [ESPComponent] Loaded 2018-01-22T21:50:01.541Z,1516657801.541 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread. 2018-01-22T21:50:01.603Z,1516657801.603 [PAR_Licor] Loaded 2018-01-22T21:50:01.603Z,1516657801.603 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread. 2018-01-22T21:50:01.803Z,1516657801.803 [WetLabsBB2FL] Loaded 2018-01-22T21:50:01.804Z,1516657801.804 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread. 2018-01-22T21:50:01.804Z,1516657801.804 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 407054E0 2018-01-22T21:50:01.805Z,1516657801.805 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 1605 2018-01-22T21:50:01.805Z,1516657801.805 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2018-01-22T21:50:01.806Z,1516657801.806 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2018-01-22T21:50:02.069Z,1516657802.069 [DataOverHttps] Loaded 2018-01-22T21:50:02.069Z,1516657802.069 [ComponentRegistry](DEBUG): SyncComponent "DataOverHttps" handled in the control thread. 2018-01-22T21:50:02.074Z,1516657802.074 [DropWeight] Loaded 2018-01-22T21:50:02.074Z,1516657802.074 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread. 2018-01-22T21:50:02.160Z,1516657802.160 [NAL9602] Loaded 2018-01-22T21:50:02.160Z,1516657802.160 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2018-01-22T21:50:02.165Z,1516657802.165 [Onboard] Loaded 2018-01-22T21:50:02.165Z,1516657802.165 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread. 2018-01-22T21:50:02.172Z,1516657802.172 [Radio_Surface] Loaded 2018-01-22T21:50:02.172Z,1516657802.172 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2018-01-22T21:50:02.173Z,1516657802.173 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 409494E0 2018-01-22T21:50:02.173Z,1516657802.173 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 1606 2018-01-22T21:50:02.296Z,1516657802.296 [DAT] Loaded 2018-01-22T21:50:02.297Z,1516657802.297 [ComponentRegistry](DEBUG): SyncComponent "DAT" handled in the control thread. 2018-01-22T21:50:02.342Z,1516657802.342 [PNI_TCM] Loaded 2018-01-22T21:50:02.342Z,1516657802.342 [ComponentRegistry](DEBUG): SyncComponent "PNI_TCM" handled in the control thread. 2018-01-22T21:50:04.076Z,1516657804.076 [BPC1] Loaded 2018-01-22T21:50:04.076Z,1516657804.076 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2018-01-22T21:50:04.077Z,1516657804.077 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2018-01-22T21:50:04.077Z,1516657804.077 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2018-01-22T21:50:04.171Z,1516657804.171 [BuoyancyServo] Loaded 2018-01-22T21:50:04.171Z,1516657804.171 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2018-01-22T21:50:04.182Z,1516657804.182 [ElevatorServo] Loaded 2018-01-22T21:50:04.183Z,1516657804.183 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2018-01-22T21:50:04.193Z,1516657804.193 [MassServo] Loaded 2018-01-22T21:50:04.193Z,1516657804.193 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2018-01-22T21:50:04.204Z,1516657804.204 [RudderServo] Loaded 2018-01-22T21:50:04.204Z,1516657804.204 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2018-01-22T21:50:04.215Z,1516657804.215 [ThrusterServo] Loaded 2018-01-22T21:50:04.215Z,1516657804.215 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread. 2018-01-22T21:50:04.215Z,1516657804.215 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2018-01-22T21:50:04.216Z,1516657804.216 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2018-01-22T21:50:04.322Z,1516657804.322 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2018-01-22T21:50:04.339Z,1516657804.339 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2018-01-22T21:50:04.387Z,1516657804.387 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2018-01-22T21:50:04.390Z,1516657804.390 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2018-01-22T21:50:04.391Z,1516657804.391 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2018-01-22T21:50:04.398Z,1516657804.398 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2018-01-22T21:50:04.399Z,1516657804.399 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 409F04E0 2018-01-22T21:50:04.399Z,1516657804.399 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 1607 2018-01-22T21:50:04.404Z,1516657804.404 [Supervisor](INFO): Main Thread ID is 796 2018-01-22T21:50:04.404Z,1516657804.404 [Supervisor](DEBUG): Running supervisor. 2018-01-22T21:50:04.405Z,1516657804.405 [CommandLine ThreadHandler](INFO): Handler Thread ID is 1608 2018-01-22T21:50:04.408Z,1516657804.408 [controlThread ThreadHandler](INFO): Handler Thread ID is 1609 2018-01-22T21:50:04.408Z,1516657804.408 [controlThread](DEBUG): Initializing ControlThread 2018-01-22T21:50:04.409Z,1516657804.409 [SBIT](INFO): Initialize SBIT Component. 2018-01-22T21:50:04.409Z,1516657804.409 [SBIT](IMPORTANT): git: 2017-12-12-45-gad4d7da 2018-01-22T21:50:04.410Z,1516657804.410 [SBIT](INFO): git hash: ad4d7da944cc2b4b9cb3d42bd51580e7a7943521 2018-01-22T21:50:04.410Z,1516657804.410 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2018-01-22T21:50:04.411Z,1516657804.411 [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-01-22T21:50:04.412Z,1516657804.412 [SBIT](INFO): Beginning SBIT in 79.000000 seconds. 2018-01-22T21:50:04.413Z,1516657804.413 [IBIT](INFO): Initialize IBIT Component. 2018-01-22T21:50:04.414Z,1516657804.414 [CBIT](DEBUG): Initialize CBIT Component. 2018-01-22T21:50:04.414Z,1516657804.414 [CBIT](CRITICAL): LAST REBOOT DUE TO WATCHDOG TIMER RESET. 2018-01-22T21:50:04.415Z,1516657804.415 [logger ThreadHandler](INFO): Handler Thread ID is 1610 2018-01-22T21:50:04.443Z,1516657804.443 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 1611 2018-01-22T21:50:04.444Z,1516657804.444 [CTD_Seabird](INFO): Initializing 2018-01-22T21:50:04.475Z,1516657804.475 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 1613 2018-01-22T21:50:04.477Z,1516657804.477 [WetLabsBB2FL](INFO): Powering down 2018-01-22T21:50:04.515Z,1516657804.515 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 1614 2018-01-22T21:50:04.519Z,1516657804.519 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2018-01-22T21:50:04.521Z,1516657804.521 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2018-01-22T21:50:04.522Z,1516657804.522 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2018-01-22T21:50:04.522Z,1516657804.522 [LoopControl](DEBUG): Initialize LoopControlComponent. 2018-01-22T21:50:04.523Z,1516657804.523 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2018-01-22T21:50:04.523Z,1516657804.523 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2018-01-22T21:50:04.523Z,1516657804.523 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2018-01-22T21:50:04.524Z,1516657804.524 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator. 2018-01-22T21:50:04.524Z,1516657804.524 [VerticalTemperatureHomogeneityIndexCalculator](DEBUG): (re)initializing 2018-01-22T21:50:04.525Z,1516657804.525 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2018-01-22T21:50:04.526Z,1516657804.526 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component. 2018-01-22T21:50:04.529Z,1516657804.529 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s. 2018-01-22T21:50:04.529Z,1516657804.529 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s. 2018-01-22T21:50:04.529Z,1516657804.529 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2018-01-22T21:50:04.530Z,1516657804.530 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s. 2018-01-22T21:50:04.530Z,1516657804.530 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s. 2018-01-22T21:50:04.531Z,1516657804.531 [DeadReckonWithRespectToSeafloor](DEBUG): Initializing DeadReckonWithRespectToSeafloor component. 2018-01-22T21:50:04.531Z,1516657804.531 [DeadReckonWithRespectToSeafloor](INFO): Will consider orientation measurement stale after 120s. 2018-01-22T21:50:04.532Z,1516657804.532 [DeadReckonWithRespectToSeafloor](INFO): Will consider velocity measurement stale after 20s. 2018-01-22T21:50:04.532Z,1516657804.532 [NavChart](DEBUG): Initialize NavChart Navigation. 2018-01-22T21:50:04.532Z,1516657804.532 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2018-01-22T21:50:04.540Z,1516657804.540 [MissionManager](INFO): Loading Mission: Missions/Startup.xml 2018-01-22T21:50:04.543Z,1516657804.543 [Radio_Surface](INFO): Powering up 2018-01-22T21:50:04.563Z,1516657804.563 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 1615 2018-01-22T21:50:04.571Z,1516657804.571 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2018-01-22T21:50:04.606Z,1516657804.606 [MissionManager](DEBUG): 2018-01-22T21:50:04.607Z,1516657804.607 [MissionManager](INFO): Loading Mission: Missions/Default.xml 2018-01-22T21:50:04.679Z,1516657804.679 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min 2018-01-22T21:50:04.680Z,1516657804.680 [Default:A.Wait](DEBUG): Construct Wait. 2018-01-22T21:50:04.682Z,1516657804.682 [Default:B.GoToSurface](DEBUG): Construct GoToSurface. 2018-01-22T21:50:04.692Z,1516657804.692 [CTD_Seabird](INFO): Stopping potential previous instance(s) of CTD_Seabird LCM interface 2018-01-22T21:50:04.692Z,1516657804.692 [CTD_Seabird](INFO): Powering down 2018-01-22T21:50:04.719Z,1516657804.719 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2018-01-22T21:50:04.722Z,1516657804.722 [Default:CheckIn:C.Wait](DEBUG): Construct Wait. 2018-01-22T21:50:04.744Z,1516657804.744 [Default:E.Execute](DEBUG): Construct Execute. 2018-01-22T21:50:04.747Z,1516657804.747 [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-01-22T21:50:04.764Z,1516657804.764 [controlThread](DEBUG): Component order: CycleStarter,Aanderaa_O2,ESPComponent,PAR_Licor,DataOverHttps,DropWeight,NAL9602,Onboard,DAT,PNI_TCM,BPC1,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,VerticalTemperatureHomogeneityIndexCalculator,YawRateCalculator,StratificationFrontDetector,DeadReckonUsingMultipleVelocitySources,DeadReckonUsingSpeedCalculator,DeadReckonWithRespectToSeafloor,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter, 2018-01-22T21:50:04.809Z,1516657804.809 [ESPComponent](INFO): powering down ESP 2018-01-22T21:50:05.052Z,1516657805.052 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2018-01-22T21:50:05.112Z,1516657805.112 [DAT](INFO): Powering up 2018-01-22T21:50:05.112Z,1516657805.112 [DAT](DEBUG): Initializing DAT. 2018-01-22T21:50:05.227Z,1516657805.227 [DepthRateCalculator](ERROR): Depth measurement is not active 2018-01-22T21:50:05.299Z,1516657805.299 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2018-01-22T21:50:05.299Z,1516657805.299 [DeadReckonUsingMultipleVelocitySources](DEBUG): All data for platform velocity is invalid. 2018-01-22T21:50:05.303Z,1516657805.303 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-22T21:50:05.309Z,1516657805.309 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-01-22T21:50:05.327Z,1516657805.327 [DeadReckonWithRespectToSeafloor](DEBUG): Starting up and don't have orientation data yet. 2018-01-22T21:50:05.400Z,1516657805.400 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2018-01-22T21:50:05.407Z,1516657805.407 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2018-01-22T21:50:05.413Z,1516657805.413 [ElevatorServo](DEBUG): Initializing EZServoServo. 2018-01-22T21:50:05.419Z,1516657805.419 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2018-01-22T21:50:05.424Z,1516657805.424 [MassServo](DEBUG): Initializing EZServoServo. 2018-01-22T21:50:05.431Z,1516657805.431 [MassServo](DEBUG): Initializing MassServo. 2018-01-22T21:50:05.437Z,1516657805.437 [RudderServo](DEBUG): Initializing EZServoServo. 2018-01-22T21:50:05.443Z,1516657805.443 [RudderServo](DEBUG): Initializing RudderServo. 2018-01-22T21:50:05.449Z,1516657805.449 [ThrusterServo](DEBUG): Initializing EZServoServo. 2018-01-22T21:50:05.455Z,1516657805.455 [ThrusterServo](DEBUG): Initializing ThrusterServo. 2018-01-22T21:50:05.479Z,1516657805.479 [CommandLine](FAULT): Scheduling is paused 2018-01-22T21:50:05.480Z,1516657805.480 [CBIT](INFO): Critical error at 20180122T215004 2018-01-22T21:50:05.480Z,1516657805.480 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals 2018-01-22T21:50:05.636Z,1516657805.636 [DropWeight](CRITICAL): DROP WEIGHT MISSING. 2018-01-22T21:50:05.637Z,1516657805.637 [DropWeight] Hardware Fault, FailCount= 1 2018-01-22T21:50:05.637Z,1516657805.637 [DropWeight](ERROR): Hardware Fault 2018-01-22T21:50:05.680Z,1516657805.680 [DepthRateCalculator](ERROR): Depth measurement is not active 2018-01-22T21:50:05.683Z,1516657805.683 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2018-01-22T21:50:05.684Z,1516657805.684 [DeadReckonUsingMultipleVelocitySources](DEBUG): All data for platform velocity is invalid. 2018-01-22T21:50:05.687Z,1516657805.687 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-22T21:50:05.688Z,1516657805.688 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-01-22T21:50:05.688Z,1516657805.688 [DeadReckonWithRespectToSeafloor](DEBUG): Starting up and don't have orientation data yet. 2018-01-22T21:50:05.709Z,1516657805.709 [CBIT](INFO): Critical error at 20180122T215005 2018-01-22T21:50:05.712Z,1516657805.712 [CBIT](ERROR): Hardware Fault in component: DropWeight 2018-01-22T21:50:05.713Z,1516657805.713 [CBIT](CRITICAL): Hardware Fault in component: DropWeight 2018-01-22T21:50:05.937Z,1516657805.937 [DepthRateCalculator](ERROR): Depth measurement is not active 2018-01-22T21:50:05.940Z,1516657805.940 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2018-01-22T21:50:05.940Z,1516657805.940 [DeadReckonUsingMultipleVelocitySources](DEBUG): All data for platform velocity is invalid. 2018-01-22T21:50:05.941Z,1516657805.941 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-22T21:50:05.941Z,1516657805.941 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-01-22T21:50:05.942Z,1516657805.942 [DeadReckonWithRespectToSeafloor](DEBUG): Starting up and don't have orientation data yet. 2018-01-22T21:50:06.275Z,1516657806.275 [BuoyancyServo](ERROR): Buoyancy initialization uart error serial timeout 2018-01-22T21:50:06.275Z,1516657806.275 [BuoyancyServo](FAULT): Buoyancy failed to initialize 2018-01-22T21:50:06.275Z,1516657806.275 [BuoyancyServo] Communications Fault, FailCount= 1 2018-01-22T21:50:06.275Z,1516657806.275 [BuoyancyServo](ERROR): Communications Fault 2018-01-22T21:50:06.484Z,1516657806.484 [CBIT](INFO): Critical error at 20180122T215005 2018-01-22T21:50:06.487Z,1516657806.487 [CBIT](ERROR): Communications Fault in component: BuoyancyServo 2018-01-22T21:50:06.531Z,1516657806.531 [DepthRateCalculator](ERROR): Depth measurement is not active 2018-01-22T21:50:06.533Z,1516657806.533 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2018-01-22T21:50:06.534Z,1516657806.534 [DeadReckonUsingMultipleVelocitySources](DEBUG): All data for platform velocity is invalid. 2018-01-22T21:50:06.535Z,1516657806.535 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-22T21:50:06.535Z,1516657806.535 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-01-22T21:50:06.536Z,1516657806.536 [DeadReckonWithRespectToSeafloor](DEBUG): Starting up and don't have orientation data yet. 2018-01-22T21:50:06.552Z,1516657806.552 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2018-01-22T21:50:06.553Z,1516657806.553 [BuoyancyServo](INFO): Powering down 2018-01-22T21:50:06.937Z,1516657806.937 [DepthRateCalculator](ERROR): Depth measurement is not active 2018-01-22T21:50:06.943Z,1516657806.943 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2018-01-22T21:50:06.943Z,1516657806.943 [DeadReckonUsingMultipleVelocitySources](DEBUG): All data for platform velocity is invalid. 2018-01-22T21:50:06.944Z,1516657806.944 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-22T21:50:06.947Z,1516657806.947 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-01-22T21:50:06.948Z,1516657806.948 [DeadReckonWithRespectToSeafloor](DEBUG): Starting up and don't have orientation data yet. 2018-01-22T21:50:07.319Z,1516657807.319 [DepthRateCalculator](ERROR): Depth measurement is not active 2018-01-22T21:50:07.321Z,1516657807.321 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2018-01-22T21:50:07.322Z,1516657807.322 [DeadReckonUsingMultipleVelocitySources](DEBUG): All data for platform velocity is invalid. 2018-01-22T21:50:07.323Z,1516657807.323 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-22T21:50:07.323Z,1516657807.323 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-01-22T21:50:07.324Z,1516657807.324 [DeadReckonWithRespectToSeafloor](DEBUG): Starting up and don't have orientation data yet. 2018-01-22T21:50:07.719Z,1516657807.719 [DepthRateCalculator](ERROR): Depth measurement is not active 2018-01-22T21:50:07.722Z,1516657807.722 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2018-01-22T21:50:07.722Z,1516657807.722 [DeadReckonUsingMultipleVelocitySources](DEBUG): All data for platform velocity is invalid. 2018-01-22T21:50:07.723Z,1516657807.723 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-22T21:50:07.723Z,1516657807.723 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-01-22T21:50:07.724Z,1516657807.724 [DeadReckonWithRespectToSeafloor](DEBUG): Starting up and don't have orientation data yet. 2018-01-22T21:50:08.215Z,1516657808.215 [Aanderaa_O2](INFO): Powering down 2018-01-22T21:50:08.300Z,1516657808.300 [DepthRateCalculator](ERROR): Depth measurement is not active 2018-01-22T21:50:08.304Z,1516657808.304 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2018-01-22T21:50:08.304Z,1516657808.304 [DeadReckonUsingMultipleVelocitySources](DEBUG): All data for platform velocity is invalid. 2018-01-22T21:50:08.305Z,1516657808.305 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-22T21:50:08.306Z,1516657808.306 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-01-22T21:50:08.307Z,1516657808.307 [DeadReckonWithRespectToSeafloor](DEBUG): Starting up and don't have orientation data yet. 2018-01-22T21:50:08.529Z,1516657808.529 [DepthRateCalculator](ERROR): Depth measurement is not active 2018-01-22T21:50:08.537Z,1516657808.537 [DeadReckonUsingMultipleVelocitySources](DEBUG): All data for platform velocity is invalid. 2018-01-22T21:50:08.538Z,1516657808.538 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-22T21:50:08.700Z,1516657808.700 [CBIT](INFO): Clearing failed state for component BuoyancyServo 2018-01-22T21:50:08.700Z,1516657808.700 [BuoyancyServo] No Fault, FailCount= 1 2018-01-22T21:50:08.927Z,1516657808.927 [DepthRateCalculator](ERROR): Depth measurement is not active 2018-01-22T21:50:08.951Z,1516657808.951 [DeadReckonUsingMultipleVelocitySources](DEBUG): All data for platform velocity is invalid. 2018-01-22T21:50:08.962Z,1516657808.962 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-22T21:50:08.982Z,1516657808.982 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2018-01-22T21:50:08.998Z,1516657808.998 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2018-01-22T21:50:09.348Z,1516657809.348 [DepthRateCalculator](ERROR): Depth measurement is not active 2018-01-22T21:50:09.356Z,1516657809.356 [DeadReckonUsingMultipleVelocitySources](DEBUG): All data for platform velocity is invalid. 2018-01-22T21:50:09.357Z,1516657809.357 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-22T21:50:09.726Z,1516657809.726 [DepthRateCalculator](ERROR): Depth measurement is not active 2018-01-22T21:50:09.740Z,1516657809.740 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-22T21:50:09.955Z,1516657809.955 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000 2018-01-22T21:50:09.956Z,1516657809.956 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000 2018-01-22T21:50:09.956Z,1516657809.956 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000 2018-01-22T21:50:09.956Z,1516657809.956 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000 2018-01-22T21:50:09.956Z,1516657809.956 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000 2018-01-22T21:50:09.956Z,1516657809.956 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000 2018-01-22T21:50:09.956Z,1516657809.956 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000 2018-01-22T21:50:09.957Z,1516657809.957 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000 2018-01-22T21:50:09.957Z,1516657809.957 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000 2018-01-22T21:50:09.957Z,1516657809.957 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000 2018-01-22T21:50:09.957Z,1516657809.957 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000 2018-01-22T21:50:09.957Z,1516657809.957 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000 2018-01-22T21:50:09.957Z,1516657809.957 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000 2018-01-22T21:50:09.958Z,1516657809.958 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000 2018-01-22T21:50:09.958Z,1516657809.958 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000 2018-01-22T21:50:09.958Z,1516657809.958 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000 2018-01-22T21:50:10.127Z,1516657810.127 [DepthRateCalculator](ERROR): Depth measurement is not active 2018-01-22T21:50:10.140Z,1516657810.140 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-22T21:50:10.556Z,1516657810.556 [DepthRateCalculator](ERROR): Depth measurement is not active 2018-01-22T21:50:10.562Z,1516657810.562 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-22T21:50:10.948Z,1516657810.948 [DepthRateCalculator](ERROR): Depth measurement is not active 2018-01-22T21:50:10.953Z,1516657810.953 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-22T21:50:11.327Z,1516657811.327 [DepthRateCalculator](ERROR): Depth measurement is not active 2018-01-22T21:50:11.348Z,1516657811.348 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-22T21:50:11.727Z,1516657811.727 [DepthRateCalculator](ERROR): Depth measurement is not active 2018-01-22T21:50:11.732Z,1516657811.732 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-22T21:50:12.135Z,1516657812.135 [DepthRateCalculator](ERROR): Depth measurement is not active 2018-01-22T21:50:12.140Z,1516657812.140 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-22T21:50:12.527Z,1516657812.527 [DepthRateCalculator](ERROR): Depth measurement is not active 2018-01-22T21:50:12.536Z,1516657812.536 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-22T21:50:12.927Z,1516657812.927 [DepthRateCalculator](ERROR): Depth measurement is not active 2018-01-22T21:50:12.944Z,1516657812.944 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-22T21:50:13.328Z,1516657813.328 [DepthRateCalculator](ERROR): Depth measurement is not active 2018-01-22T21:50:13.341Z,1516657813.341 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-22T21:50:13.727Z,1516657813.727 [DepthRateCalculator](ERROR): Depth measurement is not active 2018-01-22T21:50:13.748Z,1516657813.748 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-22T21:50:14.127Z,1516657814.127 [DepthRateCalculator](ERROR): Depth measurement is not active 2018-01-22T21:50:14.148Z,1516657814.148 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-22T21:50:14.535Z,1516657814.535 [DepthRateCalculator](ERROR): Depth measurement is not active 2018-01-22T21:50:14.548Z,1516657814.548 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-22T21:50:14.927Z,1516657814.927 [DepthRateCalculator](ERROR): Depth measurement is not active 2018-01-22T21:50:14.948Z,1516657814.948 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-22T21:50:15.327Z,1516657815.327 [DepthRateCalculator](ERROR): Depth measurement is not active 2018-01-22T21:50:15.340Z,1516657815.340 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-22T21:50:15.731Z,1516657815.731 [DepthRateCalculator](ERROR): Depth measurement is not active 2018-01-22T21:50:15.748Z,1516657815.748 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-22T21:50:16.127Z,1516657816.127 [DepthRateCalculator](ERROR): Depth measurement is not active 2018-01-22T21:50:16.148Z,1516657816.148 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-22T21:50:16.527Z,1516657816.527 [DepthRateCalculator](ERROR): Depth measurement is not active 2018-01-22T21:50:16.540Z,1516657816.540 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-22T21:50:16.921Z,1516657816.921 [DAT](DEBUG): Teledyne Benthos DAT-900 Series MF Frequency Band Directional Acoustic Transponder version 8.10.9 Jan 13 2000 18:15:49 WARNING: battery low Features enabled [Bearing] CONNECT 2018-01-22T21:50:16.921Z,1516657816.921 [DAT](INFO): Got CONNECT 2018-01-22T21:50:16.935Z,1516657816.935 [DAT](INFO): entering command mode 2018-01-22T21:50:16.955Z,1516657816.955 [DepthRateCalculator](ERROR): Depth measurement is not active 2018-01-22T21:50:16.968Z,1516657816.968 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-22T21:50:17.317Z,1516657817.317 [DAT](DEBUG): checking for command mode acknowledgment 2018-01-22T21:50:17.327Z,1516657817.327 [DepthRateCalculator](ERROR): Depth measurement is not active 2018-01-22T21:50:17.348Z,1516657817.348 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-22T21:50:17.716Z,1516657817.716 [DAT](DEBUG): checking for command mode acknowledgment 2018-01-22T21:50:17.727Z,1516657817.727 [DepthRateCalculator](ERROR): Depth measurement is not active 2018-01-22T21:50:17.744Z,1516657817.744 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-22T21:50:18.118Z,1516657818.118 [DAT](DEBUG): checking for command mode acknowledgment 2018-01-22T21:50:18.138Z,1516657818.138 [DepthRateCalculator](ERROR): Depth measurement is not active 2018-01-22T21:50:18.159Z,1516657818.159 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-22T21:50:18.525Z,1516657818.525 [DAT](DEBUG): checking for command mode acknowledgment 2018-01-22T21:50:18.526Z,1516657818.526 [DAT](DEBUG): read user prompt 1: user:1> 2018-01-22T21:50:18.526Z,1516657818.526 [DAT](INFO): command mode acknowledged 2018-01-22T21:50:18.555Z,1516657818.555 [DepthRateCalculator](ERROR): Depth measurement is not active 2018-01-22T21:50:18.568Z,1516657818.568 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-22T21:50:18.932Z,1516657818.932 [DAT](INFO): setting local address to 2 2018-01-22T21:50:18.980Z,1516657818.980 [DepthRateCalculator](ERROR): Depth measurement is not active 2018-01-22T21:50:18.997Z,1516657818.997 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-22T21:50:19.317Z,1516657819.317 [DAT](DEBUG): checking for local address setting acknowledgment 2018-01-22T21:50:19.319Z,1516657819.319 [DAT](INFO): set local address to 2 2018-01-22T21:50:19.329Z,1516657819.329 [DepthRateCalculator](ERROR): Depth measurement is not active 2018-01-22T21:50:19.355Z,1516657819.355 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-22T21:50:19.717Z,1516657819.717 [DAT](DEBUG): read user prompt 2: user:2> 2018-01-22T21:50:19.729Z,1516657819.729 [DepthRateCalculator](ERROR): Depth measurement is not active 2018-01-22T21:50:19.751Z,1516657819.751 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-22T21:50:20.140Z,1516657820.140 [DepthRateCalculator](ERROR): Depth measurement is not active 2018-01-22T21:50:20.157Z,1516657820.157 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-22T21:50:20.555Z,1516657820.555 [DepthRateCalculator](ERROR): Depth measurement is not active 2018-01-22T21:50:20.560Z,1516657820.560 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-22T21:50:20.931Z,1516657820.931 [DepthRateCalculator](ERROR): Depth measurement is not active 2018-01-22T21:50:20.944Z,1516657820.944 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-22T21:50:21.347Z,1516657821.347 [DepthRateCalculator](ERROR): Depth measurement is not active 2018-01-22T21:50:21.364Z,1516657821.364 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-22T21:50:21.767Z,1516657821.767 [DepthRateCalculator](ERROR): Depth measurement is not active 2018-01-22T21:50:21.781Z,1516657821.781 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-22T21:50:22.127Z,1516657822.127 [DepthRateCalculator](ERROR): Depth measurement is not active 2018-01-22T21:50:22.139Z,1516657822.139 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-22T21:50:22.543Z,1516657822.543 [DepthRateCalculator](ERROR): Depth measurement is not active 2018-01-22T21:50:22.548Z,1516657822.548 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-22T21:50:22.959Z,1516657822.959 [DepthRateCalculator](ERROR): Depth measurement is not active 2018-01-22T21:50:22.972Z,1516657822.972 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-22T21:50:23.343Z,1516657823.343 [DepthRateCalculator](ERROR): Depth measurement is not active 2018-01-22T21:50:23.356Z,1516657823.356 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-22T21:50:23.735Z,1516657823.735 [DepthRateCalculator](ERROR): Depth measurement is not active 2018-01-22T21:50:23.748Z,1516657823.748 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-22T21:50:24.139Z,1516657824.139 [DepthRateCalculator](ERROR): Depth measurement is not active 2018-01-22T21:50:24.152Z,1516657824.152 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-22T21:50:24.539Z,1516657824.539 [DepthRateCalculator](ERROR): Depth measurement is not active 2018-01-22T21:50:24.552Z,1516657824.552 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-22T21:50:24.935Z,1516657824.935 [DepthRateCalculator](ERROR): Depth measurement is not active 2018-01-22T21:50:24.948Z,1516657824.948 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-22T21:50:25.335Z,1516657825.335 [DepthRateCalculator](ERROR): Depth measurement is not active 2018-01-22T21:50:25.348Z,1516657825.348 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-22T21:50:25.724Z,1516657825.724 [BPC1](ERROR): Failed to receive battery data 2018-01-22T21:50:25.725Z,1516657825.725 [BPC1] Communications Fault, FailCount= 1 2018-01-22T21:50:25.725Z,1516657825.725 [BPC1](ERROR): Communications Fault 2018-01-22T21:50:25.731Z,1516657825.731 [DepthRateCalculator](ERROR): Depth measurement is not active 2018-01-22T21:50:25.772Z,1516657825.772 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-22T21:50:25.827Z,1516657825.827 [CBIT](ERROR): Communications Fault in component: BPC1 2018-01-22T21:50:26.131Z,1516657826.131 [DepthRateCalculator](ERROR): Depth measurement is not active 2018-01-22T21:50:26.136Z,1516657826.136 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-22T21:50:26.532Z,1516657826.532 [DepthRateCalculator](ERROR): Depth measurement is not active 2018-01-22T21:50:26.541Z,1516657826.541 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-22T21:50:26.929Z,1516657826.929 [DepthRateCalculator](ERROR): Depth measurement is not active 2018-01-22T21:50:26.938Z,1516657826.938 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-22T21:50:26.999Z,1516657826.999 [CBIT](INFO): Clearing failed state for component BPC1 2018-01-22T21:50:26.999Z,1516657826.999 [BPC1] No Fault, FailCount= 1 2018-01-22T21:50:27.399Z,1516657827.399 [DepthRateCalculator](ERROR): Depth measurement is not active 2018-01-22T21:50:27.404Z,1516657827.404 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-22T21:50:27.739Z,1516657827.739 [DepthRateCalculator](ERROR): Depth measurement is not active 2018-01-22T21:50:27.748Z,1516657827.748 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-22T21:50:28.139Z,1516657828.139 [DepthRateCalculator](ERROR): Depth measurement is not active 2018-01-22T21:50:28.144Z,1516657828.144 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-22T21:50:28.545Z,1516657828.545 [DepthRateCalculator](ERROR): Depth measurement is not active 2018-01-22T21:50:28.549Z,1516657828.549 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-22T21:50:28.948Z,1516657828.948 [DepthRateCalculator](ERROR): Depth measurement is not active 2018-01-22T21:50:28.957Z,1516657828.957 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-22T21:50:29.322Z,1516657829.322 [DepthRateCalculator](ERROR): Depth measurement is not active 2018-01-22T21:50:29.365Z,1516657829.365 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-22T21:50:29.753Z,1516657829.753 [DepthRateCalculator](ERROR): Depth measurement is not active 2018-01-22T21:50:29.761Z,1516657829.761 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-22T21:50:29.875Z,1516657829.875 [CommandLine](IMPORTANT): got command configSet list 2018-01-22T21:50:29.876Z,1516657829.876 [CommandLine](IMPORTANT): Listing configuration overrides from Data/persisted.cfg 2018-01-22T21:50:29.876Z,1516657829.876 [CommandLine](IMPORTANT): Depth_Keller.loadAtStartup=0 bool; 2018-01-22T21:50:30.127Z,1516657830.127 [DepthRateCalculator](ERROR): Depth measurement is not active 2018-01-22T21:50:30.136Z,1516657830.136 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-22T21:50:30.539Z,1516657830.539 [DepthRateCalculator](ERROR): Depth measurement is not active 2018-01-22T21:50:30.548Z,1516657830.548 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-22T21:50:30.936Z,1516657830.936 [DepthRateCalculator](ERROR): Depth measurement is not active 2018-01-22T21:50:30.941Z,1516657830.941 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-22T21:50:31.335Z,1516657831.335 [DepthRateCalculator](ERROR): Depth measurement is not active 2018-01-22T21:50:31.340Z,1516657831.340 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-22T21:50:31.739Z,1516657831.739 [DepthRateCalculator](ERROR): Depth measurement is not active 2018-01-22T21:50:31.748Z,1516657831.748 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-22T21:50:32.143Z,1516657832.143 [DepthRateCalculator](ERROR): Depth measurement is not active 2018-01-22T21:50:32.148Z,1516657832.148 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-22T21:50:32.496Z,1516657832.496 [NAL9602](INFO): Powering up NAL9602 2018-01-22T21:50:32.559Z,1516657832.559 [DepthRateCalculator](ERROR): Depth measurement is not active 2018-01-22T21:50:32.564Z,1516657832.564 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-22T21:50:32.939Z,1516657832.939 [DepthRateCalculator](ERROR): Depth measurement is not active 2018-01-22T21:50:32.948Z,1516657832.948 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-22T21:50:33.343Z,1516657833.343 [DepthRateCalculator](ERROR): Depth measurement is not active 2018-01-22T21:50:33.352Z,1516657833.352 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-22T21:50:33.743Z,1516657833.743 [DepthRateCalculator](ERROR): Depth measurement is not active 2018-01-22T21:50:33.756Z,1516657833.756 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-22T21:50:34.143Z,1516657834.143 [DepthRateCalculator](ERROR): Depth measurement is not active 2018-01-22T21:50:34.152Z,1516657834.152 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-22T21:50:34.540Z,1516657834.540 [DepthRateCalculator](ERROR): Depth measurement is not active 2018-01-22T21:50:34.545Z,1516657834.545 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-22T21:50:34.925Z,1516657834.925 [DepthRateCalculator](ERROR): Depth measurement is not active 2018-01-22T21:50:34.950Z,1516657834.950 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-22T21:50:35.343Z,1516657835.343 [DepthRateCalculator](ERROR): Depth measurement is not active 2018-01-22T21:50:35.352Z,1516657835.352 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-22T21:50:35.743Z,1516657835.743 [DepthRateCalculator](ERROR): Depth measurement is not active 2018-01-22T21:50:35.752Z,1516657835.752 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-22T21:50:36.140Z,1516657836.140 [DepthRateCalculator](ERROR): Depth measurement is not active 2018-01-22T21:50:36.149Z,1516657836.149 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-22T21:50:36.543Z,1516657836.543 [DepthRateCalculator](ERROR): Depth measurement is not active 2018-01-22T21:50:36.556Z,1516657836.556 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-22T21:50:36.943Z,1516657836.943 [DepthRateCalculator](ERROR): Depth measurement is not active 2018-01-22T21:50:36.953Z,1516657836.953 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-22T21:50:37.343Z,1516657837.343 [DepthRateCalculator](ERROR): Depth measurement is not active 2018-01-22T21:50:37.352Z,1516657837.352 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-22T21:50:37.743Z,1516657837.743 [DepthRateCalculator](ERROR): Depth measurement is not active 2018-01-22T21:50:37.752Z,1516657837.752 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-22T21:50:38.147Z,1516657838.147 [DepthRateCalculator](ERROR): Depth measurement is not active 2018-01-22T21:50:38.156Z,1516657838.156 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-22T21:50:38.549Z,1516657838.549 [DepthRateCalculator](ERROR): Depth measurement is not active 2018-01-22T21:50:38.558Z,1516657838.558 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-22T21:50:38.925Z,1516657838.925 [DepthRateCalculator](ERROR): Depth measurement is not active 2018-01-22T21:50:38.930Z,1516657838.930 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-22T21:50:39.331Z,1516657839.331 [DepthRateCalculator](ERROR): Depth measurement is not active 2018-01-22T21:50:39.340Z,1516657839.340 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-22T21:50:39.731Z,1516657839.731 [DepthRateCalculator](ERROR): Depth measurement is not active 2018-01-22T21:50:39.740Z,1516657839.740 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-22T21:50:40.131Z,1516657840.131 [DepthRateCalculator](ERROR): Depth measurement is not active 2018-01-22T21:50:40.136Z,1516657840.136 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-22T21:50:40.533Z,1516657840.533 [DepthRateCalculator](ERROR): Depth measurement is not active 2018-01-22T21:50:40.538Z,1516657840.538 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-22T21:50:40.943Z,1516657840.943 [DepthRateCalculator](ERROR): Depth measurement is not active 2018-01-22T21:50:40.948Z,1516657840.948 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-22T21:50:41.342Z,1516657841.342 [DepthRateCalculator](ERROR): Depth measurement is not active 2018-01-22T21:50:41.347Z,1516657841.347 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-22T21:50:41.736Z,1516657841.736 [DepthRateCalculator](ERROR): Depth measurement is not active 2018-01-22T21:50:41.741Z,1516657841.741 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-22T21:50:42.155Z,1516657842.155 [DepthRateCalculator](ERROR): Depth measurement is not active 2018-01-22T21:50:42.160Z,1516657842.160 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-22T21:50:42.533Z,1516657842.533 [DepthRateCalculator](ERROR): Depth measurement is not active 2018-01-22T21:50:42.538Z,1516657842.538 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-22T21:50:42.947Z,1516657842.947 [DepthRateCalculator](ERROR): Depth measurement is not active 2018-01-22T21:50:42.954Z,1516657842.954 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-22T21:50:43.300Z,1516657843.300 [NAL9602](INFO): NAL9602 initialized 2018-01-22T21:50:43.343Z,1516657843.343 [DepthRateCalculator](ERROR): Depth measurement is not active 2018-01-22T21:50:43.352Z,1516657843.352 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-22T21:50:43.756Z,1516657843.756 [DepthRateCalculator](ERROR): Depth measurement is not active 2018-01-22T21:50:43.766Z,1516657843.766 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-22T21:50:44.151Z,1516657844.151 [DepthRateCalculator](ERROR): Depth measurement is not active 2018-01-22T21:50:44.156Z,1516657844.156 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-22T21:50:44.552Z,1516657844.552 [DepthRateCalculator](ERROR): Depth measurement is not active 2018-01-22T21:50:44.561Z,1516657844.561 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-22T21:50:44.979Z,1516657844.979 [DepthRateCalculator](ERROR): Depth measurement is not active 2018-01-22T21:50:45.004Z,1516657845.004 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-22T21:50:45.328Z,1516657845.328 [DepthRateCalculator](ERROR): Depth measurement is not active 2018-01-22T21:50:45.337Z,1516657845.337 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-22T21:50:45.735Z,1516657845.735 [DepthRateCalculator](ERROR): Depth measurement is not active 2018-01-22T21:50:45.768Z,1516657845.768 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-22T21:50:46.139Z,1516657846.139 [DepthRateCalculator](ERROR): Depth measurement is not active 2018-01-22T21:50:46.144Z,1516657846.144 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-22T21:50:46.543Z,1516657846.543 [DepthRateCalculator](ERROR): Depth measurement is not active 2018-01-22T21:50:46.580Z,1516657846.580 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-22T21:50:46.943Z,1516657846.943 [DepthRateCalculator](ERROR): Depth measurement is not active 2018-01-22T21:50:46.976Z,1516657846.976 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-22T21:50:47.336Z,1516657847.336 [DepthRateCalculator](ERROR): Depth measurement is not active 2018-01-22T21:50:47.341Z,1516657847.341 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-22T21:50:47.732Z,1516657847.732 [BPC1](ERROR): Failed to receive battery data 2018-01-22T21:50:47.732Z,1516657847.732 [BPC1] Communications Fault, FailCount= 2 2018-01-22T21:50:47.732Z,1516657847.732 [BPC1](ERROR): Communications Fault 2018-01-22T21:50:47.735Z,1516657847.735 [DepthRateCalculator](ERROR): Depth measurement is not active 2018-01-22T21:50:47.739Z,1516657847.739 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-22T21:50:47.772Z,1516657847.772 [CBIT](ERROR): Communications Fault in component: BPC1 2018-01-22T21:50:48.023Z,1516657848.023 [CommandLine](IMPORTANT): got command restart application 2018-01-22T21:50:48.147Z,1516657848.147 [DepthRateCalculator](ERROR): Depth measurement is not active 2018-01-22T21:50:48.160Z,1516657848.160 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-22T21:50:48.535Z,1516657848.535 [DepthRateCalculator](ERROR): Depth measurement is not active 2018-01-22T21:50:48.540Z,1516657848.540 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-22T21:50:48.929Z,1516657848.929 [DepthRateCalculator](ERROR): Depth measurement is not active 2018-01-22T21:50:48.937Z,1516657848.937 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-22T21:50:48.973Z,1516657848.973 [CBIT](INFO): Clearing failed state for component BPC1 2018-01-22T21:50:48.973Z,1516657848.973 [BPC1] No Fault, FailCount= 2 2018-01-22T21:50:49.029Z,1516657849.029 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2018-01-22T21:50:49.030Z,1516657849.030 [CommandLine ThreadHandler](INFO): Thread cancelled. 2018-01-22T21:50:49.123Z,1516657849.123 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2018-01-22T21:50:49.123Z,1516657849.123 [CommandLine ThreadHandler](INFO): Thread cancelled. 2018-01-22T21:50:49.124Z,1516657849.124 [CommandLine](INFO): Join timeout helper Thread ID is 1629 2018-01-22T21:50:49.131Z,1516657849.131 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2018-01-22T21:50:49.131Z,1516657849.131 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2018-01-22T21:50:49.131Z,1516657849.131 [NavChartDb](INFO): Join timeout helper Thread ID is 1630 2018-01-22T21:50:49.383Z,1516657849.383 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2018-01-22T21:50:49.383Z,1516657849.383 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2018-01-22T21:50:49.387Z,1516657849.387 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2018-01-22T21:50:49.387Z,1516657849.387 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2018-01-22T21:50:49.387Z,1516657849.387 [Radio_Surface](INFO): Join timeout helper Thread ID is 1631 2018-01-22T21:50:49.407Z,1516657849.407 [DepthRateCalculator](ERROR): Depth measurement is not active 2018-01-22T21:50:49.419Z,1516657849.419 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2018-01-22T21:50:49.419Z,1516657849.419 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2018-01-22T21:50:49.427Z,1516657849.427 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler 2018-01-22T21:50:49.427Z,1516657849.427 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2018-01-22T21:50:49.427Z,1516657849.427 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 1632 2018-01-22T21:50:49.429Z,1516657849.429 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-22T21:50:49.739Z,1516657849.739 [DepthRateCalculator](ERROR): Depth measurement is not active 2018-01-22T21:50:49.744Z,1516657849.744 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-22T21:50:49.783Z,1516657849.783 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread. 2018-01-22T21:50:49.783Z,1516657849.783 [WetLabsBB2FL](INFO): Powering down 2018-01-22T21:50:49.784Z,1516657849.784 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2018-01-22T21:50:49.787Z,1516657849.787 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler 2018-01-22T21:50:49.787Z,1516657849.787 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2018-01-22T21:50:49.787Z,1516657849.787 [CTD_Seabird](INFO): Join timeout helper Thread ID is 1633 2018-01-22T21:50:49.995Z,1516657849.995 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread. 2018-01-22T21:50:50.084Z,1516657850.084 [CTD_Seabird](INFO): Stopping potential previous instance(s) of CTD_Seabird LCM interface 2018-01-22T21:50:50.084Z,1516657850.084 [CTD_Seabird](INFO): Powering down 2018-01-22T21:50:50.086Z,1516657850.086 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2018-01-22T21:50:50.096Z,1516657850.096 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2018-01-22T21:50:50.096Z,1516657850.096 [logger ThreadHandler](INFO): Thread cancelled. 2018-01-22T21:50:50.096Z,1516657850.096 [logger](INFO): Join timeout helper Thread ID is 1635 2018-01-22T21:50:50.115Z,1516657850.115 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2018-01-22T21:50:50.115Z,1516657850.115 [logger ThreadHandler](INFO): Thread cancelled. 2018-01-22T21:50:50.119Z,1516657850.119 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2018-01-22T21:50:50.119Z,1516657850.119 [CommandLine ThreadHandler](INFO): Thread cancelled. 2018-01-22T21:50:50.120Z,1516657850.120 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2018-01-22T21:50:50.120Z,1516657850.120 [controlThread ThreadHandler](INFO): Thread cancelled. 2018-01-22T21:50:50.120Z,1516657850.120 [controlThread](INFO): Join timeout helper Thread ID is 1636 2018-01-22T21:50:50.132Z,1516657850.132 [DepthRateCalculator](ERROR): Depth measurement is not active 2018-01-22T21:50:50.138Z,1516657850.138 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-22T21:50:50.153Z,1516657850.153 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2018-01-22T21:50:50.154Z,1516657850.154 [controlThread](DEBUG): Uninitializing ControlThread 2018-01-22T21:50:50.154Z,1516657850.154 [Aanderaa_O2](INFO): Powering down 2018-01-22T21:50:50.157Z,1516657850.157 [NAL9602](INFO): Powering down 2018-01-22T21:50:50.158Z,1516657850.158 [DAT](INFO): Powering down 2018-01-22T21:50:50.279Z,1516657850.279 [PNI_TCM](INFO): Powering down 2018-01-22T21:50:50.368Z,1516657850.368 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2018-01-22T21:50:50.369Z,1516657850.369 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2018-01-22T21:50:50.370Z,1516657850.370 [MissionManager](INFO): Uninitializing Mission Default 2018-01-22T21:50:50.372Z,1516657850.372 [MissionManager](INFO): Uninitializing Mission Startup 2018-01-22T21:50:50.374Z,1516657850.374 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2018-01-22T21:50:50.374Z,1516657850.374 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2018-01-22T21:50:50.374Z,1516657850.374 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2018-01-22T21:50:50.375Z,1516657850.375 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2018-01-22T21:50:50.375Z,1516657850.375 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2018-01-22T21:50:50.375Z,1516657850.375 [BuoyancyServo](INFO): Powering down 2018-01-22T21:50:50.387Z,1516657850.387 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2018-01-22T21:50:50.387Z,1516657850.387 [ElevatorServo](INFO): Powering down 2018-01-22T21:50:50.405Z,1516657850.405 [MassServo](DEBUG): Uninitialize Mass Servo. 2018-01-22T21:50:50.405Z,1516657850.405 [MassServo](INFO): Powering down 2018-01-22T21:50:50.406Z,1516657850.406 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2018-01-22T21:50:50.406Z,1516657850.406 [RudderServo](INFO): Powering down 2018-01-22T21:50:50.407Z,1516657850.407 [ThrusterServo](DEBUG): Uninitialize Thruster Servo. 2018-01-22T21:50:50.407Z,1516657850.407 [ThrusterServo](INFO): Powering down 2018-01-22T21:50:50.408Z,1516657850.408 [SBIT](DEBUG): Uninitialize SBIT Component. 2018-01-22T21:50:50.408Z,1516657850.408 [IBIT](DEBUG): Uninitialize IBIT Component. 2018-01-22T21:50:50.408Z,1516657850.408 [CBIT](DEBUG): Uninitialize CBIT Component. 2018-01-22T21:50:50.409Z,1516657850.409 [controlThread ThreadHandler](INFO): Thread cancelled. 2018-01-22T21:50:50.477Z,1516657850.477 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2018-01-22T21:50:50.482Z,1516657850.482 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2018-01-22T21:50:50.547Z,1516657850.547 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2018-01-22T21:50:50.702Z,1516657850.702 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2018-01-22T21:50:50.753Z,1516657850.753 [logger ThreadHandler](INFO): Thread cancelled.