2017-12-06T18:11:08.389Z,1512583868.389 [Supervisor](DEBUG): Initializing supervisor. 2017-12-06T18:11:08.392Z,1512583868.392 [SyncHandler](DEBUG): Created PCaller Thread at 4051A4E0 2017-12-06T18:11:08.393Z,1512583868.393 [SyncHandler](INFO): Protected caller Thread ID is 768 2017-12-06T18:11:08.393Z,1512583868.393 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2017-12-06T18:11:08.396Z,1512583868.396 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 4054A4E0 2017-12-06T18:11:08.397Z,1512583868.397 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 769 2017-12-06T18:11:08.399Z,1512583868.399 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2017-12-06T18:11:08.411Z,1512583868.411 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2017-12-06T18:11:08.412Z,1512583868.412 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 4057A4E0 2017-12-06T18:11:08.413Z,1512583868.413 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 770 2017-12-06T18:11:08.413Z,1512583868.413 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2017-12-06T18:11:08.416Z,1512583868.416 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405AA4E0 2017-12-06T18:11:08.417Z,1512583868.417 [logger ThreadHandler](INFO): Protected caller Thread ID is 771 2017-12-06T18:11:08.419Z,1512583868.419 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2017-12-06T18:11:08.419Z,1512583868.419 [Supervisor](INFO): Looking for Config files in directory: Config/ 2017-12-06T18:11:08.425Z,1512583868.425 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2017-12-06T18:11:08.636Z,1512583868.636 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2017-12-06T18:11:08.637Z,1512583868.637 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2017-12-06T18:11:08.794Z,1512583868.794 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2017-12-06T18:11:08.795Z,1512583868.795 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2017-12-06T18:11:09.175Z,1512583869.175 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2017-12-06T18:11:09.176Z,1512583869.176 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2017-12-06T18:11:09.330Z,1512583869.330 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2017-12-06T18:11:09.331Z,1512583869.331 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2017-12-06T18:11:09.430Z,1512583869.430 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2017-12-06T18:11:09.655Z,1512583869.655 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2017-12-06T18:11:09.656Z,1512583869.656 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2017-12-06T18:11:09.775Z,1512583869.775 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample 2017-12-06T18:11:09.776Z,1512583869.776 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2017-12-06T18:11:10.146Z,1512583870.146 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2017-12-06T18:11:10.148Z,1512583870.148 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2017-12-06T18:11:10.553Z,1512583870.553 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2017-12-06T18:11:10.554Z,1512583870.554 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2017-12-06T18:11:10.892Z,1512583870.892 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2017-12-06T18:11:10.892Z,1512583870.892 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2017-12-06T18:11:11.467Z,1512583871.467 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2017-12-06T18:11:11.467Z,1512583871.467 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2017-12-06T18:11:16.010Z,1512583876.010 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2017-12-06T18:11:16.010Z,1512583876.010 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2017-12-06T18:11:16.125Z,1512583876.125 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2017-12-06T18:11:16.126Z,1512583876.126 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2017-12-06T18:11:16.648Z,1512583876.648 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2017-12-06T18:11:16.649Z,1512583876.649 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2017-12-06T18:11:18.585Z,1512583878.585 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2017-12-06T18:11:18.587Z,1512583878.587 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-aku/ 2017-12-06T18:11:18.610Z,1512583878.610 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/Battery.cfg 2017-12-06T18:11:18.877Z,1512583878.877 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2017-12-06T18:11:18.878Z,1512583878.878 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/BIT.cfg 2017-12-06T18:11:18.994Z,1512583878.994 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/Navigation.cfg 2017-12-06T18:11:19.118Z,1512583879.118 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/Control.cfg 2017-12-06T18:11:19.230Z,1512583879.230 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/Simulator.cfg 2017-12-06T18:11:19.330Z,1512583879.330 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/Science.cfg 2017-12-06T18:11:19.514Z,1512583879.514 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/Sensor.cfg 2017-12-06T18:11:19.719Z,1512583879.719 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/Servo.cfg 2017-12-06T18:11:19.846Z,1512583879.846 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/logger.cfg 2017-12-06T18:11:19.959Z,1512583879.959 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/secure.cfg 2017-12-06T18:11:20.059Z,1512583880.059 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/vehicle.cfg 2017-12-06T18:11:20.255Z,1512583880.255 [Supervisor](FAULT): Ignoring configuration overrides from Data/persisted.cfg 2017-12-06T18:11:20.259Z,1512583880.259 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2017-12-06T18:11:20.426Z,1512583880.426 [SBIT](DEBUG): Construct Startup Built In Test. 2017-12-06T18:11:20.457Z,1512583880.457 [SBIT] Loaded 2017-12-06T18:11:20.457Z,1512583880.457 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2017-12-06T18:11:20.458Z,1512583880.458 [IBIT](DEBUG): Construct Initiated Built In Test. 2017-12-06T18:11:20.491Z,1512583880.491 [IBIT] Loaded 2017-12-06T18:11:20.491Z,1512583880.491 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2017-12-06T18:11:20.495Z,1512583880.495 [CBIT](DEBUG): Construct Continuous Built In Test. 2017-12-06T18:11:20.675Z,1512583880.675 [CBIT] Loaded 2017-12-06T18:11:20.676Z,1512583880.676 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2017-12-06T18:11:20.676Z,1512583880.676 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2017-12-06T18:11:20.677Z,1512583880.677 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2017-12-06T18:11:20.775Z,1512583880.775 [VerticalControl](DEBUG): Construct VerticalControl. 2017-12-06T18:11:20.888Z,1512583880.888 [VerticalControl] Loaded 2017-12-06T18:11:20.888Z,1512583880.888 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2017-12-06T18:11:20.889Z,1512583880.889 [HorizontalControl](DEBUG): Construct HorizontalControl. 2017-12-06T18:11:20.961Z,1512583880.961 [HorizontalControl] Loaded 2017-12-06T18:11:20.961Z,1512583880.961 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2017-12-06T18:11:20.962Z,1512583880.962 [SpeedControl](DEBUG): Construct SpeedControl. 2017-12-06T18:11:20.967Z,1512583880.967 [SpeedControl] Loaded 2017-12-06T18:11:20.968Z,1512583880.968 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2017-12-06T18:11:20.968Z,1512583880.968 [LoopControl](DEBUG): Construct LoopControl. 2017-12-06T18:11:20.969Z,1512583880.969 [LoopControl] Loaded 2017-12-06T18:11:20.969Z,1512583880.969 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2017-12-06T18:11:20.970Z,1512583880.970 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2017-12-06T18:11:20.970Z,1512583880.970 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2017-12-06T18:11:21.029Z,1512583881.029 [DepthRateCalculator] Loaded 2017-12-06T18:11:21.030Z,1512583881.030 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2017-12-06T18:11:21.035Z,1512583881.035 [PitchRateCalculator] Loaded 2017-12-06T18:11:21.035Z,1512583881.035 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2017-12-06T18:11:21.056Z,1512583881.056 [SpeedCalculator] Loaded 2017-12-06T18:11:21.056Z,1512583881.056 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2017-12-06T18:11:21.078Z,1512583881.078 [TempGradientCalculator] Loaded 2017-12-06T18:11:21.078Z,1512583881.078 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread. 2017-12-06T18:11:21.094Z,1512583881.094 [VerticalTemperatureHomogeneityIndexCalculator] Loaded 2017-12-06T18:11:21.095Z,1512583881.095 [ComponentRegistry](DEBUG): SyncComponent "VerticalTemperatureHomogeneityIndexCalculator" handled in the control thread. 2017-12-06T18:11:21.104Z,1512583881.104 [YawRateCalculator] Loaded 2017-12-06T18:11:21.104Z,1512583881.104 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2017-12-06T18:11:21.105Z,1512583881.105 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2017-12-06T18:11:21.105Z,1512583881.105 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2017-12-06T18:11:21.243Z,1512583881.243 [StratificationFrontDetector](INFO): threshold set to: 0.399988 degC 2017-12-06T18:11:21.243Z,1512583881.243 [StratificationFrontDetector](DEBUG): (re)initializing 2017-12-06T18:11:21.243Z,1512583881.243 [StratificationFrontDetector] Loaded 2017-12-06T18:11:21.244Z,1512583881.244 [ComponentRegistry](DEBUG): SyncComponent "StratificationFrontDetector" handled in the control thread. 2017-12-06T18:11:21.244Z,1512583881.244 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2017-12-06T18:11:21.245Z,1512583881.245 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2017-12-06T18:11:21.541Z,1512583881.541 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2017-12-06T18:11:21.542Z,1512583881.542 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2017-12-06T18:11:21.670Z,1512583881.670 [DeadReckonUsingMultipleVelocitySources] Loaded 2017-12-06T18:11:21.670Z,1512583881.670 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2017-12-06T18:11:21.734Z,1512583881.734 [DeadReckonUsingSpeedCalculator] Loaded 2017-12-06T18:11:21.735Z,1512583881.735 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread. 2017-12-06T18:11:21.799Z,1512583881.799 [DeadReckonWithRespectToSeafloor] Loaded 2017-12-06T18:11:21.799Z,1512583881.799 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonWithRespectToSeafloor" handled in the control thread. 2017-12-06T18:11:21.820Z,1512583881.820 [NavChart] Loaded 2017-12-06T18:11:21.821Z,1512583881.821 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2017-12-06T18:11:21.829Z,1512583881.829 [UniversalFixResidualReporter] Loaded 2017-12-06T18:11:21.829Z,1512583881.829 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2017-12-06T18:11:21.830Z,1512583881.830 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2017-12-06T18:11:21.830Z,1512583881.830 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2017-12-06T18:11:23.931Z,1512583883.931 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2017-12-06T18:11:23.936Z,1512583883.936 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2017-12-06T18:11:24.152Z,1512583884.152 [Aanderaa_O2] Loaded 2017-12-06T18:11:24.153Z,1512583884.153 [ComponentRegistry](DEBUG): SyncComponent "Aanderaa_O2" handled in the control thread. 2017-12-06T18:11:24.193Z,1512583884.193 [CTD_Seabird] Loaded 2017-12-06T18:11:24.193Z,1512583884.193 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread. 2017-12-06T18:11:24.197Z,1512583884.197 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 407984E0 2017-12-06T18:11:24.197Z,1512583884.197 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 850 2017-12-06T18:11:24.214Z,1512583884.214 [ESPComponent] Loaded 2017-12-06T18:11:24.215Z,1512583884.215 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread. 2017-12-06T18:11:24.234Z,1512583884.234 [PAR_Licor] Loaded 2017-12-06T18:11:24.234Z,1512583884.234 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread. 2017-12-06T18:11:24.290Z,1512583884.290 [WetLabsBB2FL] Loaded 2017-12-06T18:11:24.290Z,1512583884.290 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread. 2017-12-06T18:11:24.293Z,1512583884.293 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 407C84E0 2017-12-06T18:11:24.293Z,1512583884.293 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 851 2017-12-06T18:11:24.343Z,1512583884.343 [WetLabsSeaOWL_UV_A] Loaded 2017-12-06T18:11:24.344Z,1512583884.344 [ComponentRegistry](DEBUG): Component "WetLabsSeaOWL_UV_A" handled in its own thread. 2017-12-06T18:11:24.345Z,1512583884.345 [WetLabsSeaOWL_UV_A ThreadHandler](DEBUG): Created PCaller Thread at 407F84E0 2017-12-06T18:11:24.345Z,1512583884.345 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Protected caller Thread ID is 852 2017-12-06T18:11:24.346Z,1512583884.346 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2017-12-06T18:11:24.347Z,1512583884.347 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2017-12-06T18:11:25.043Z,1512583885.043 [DataOverHttps] Loaded 2017-12-06T18:11:25.044Z,1512583885.044 [ComponentRegistry](DEBUG): SyncComponent "DataOverHttps" handled in the control thread. 2017-12-06T18:11:25.057Z,1512583885.057 [Depth_Keller] Loaded 2017-12-06T18:11:25.058Z,1512583885.058 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2017-12-06T18:11:25.063Z,1512583885.063 [DropWeight] Loaded 2017-12-06T18:11:25.063Z,1512583885.063 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread. 2017-12-06T18:11:25.166Z,1512583885.166 [NAL9602] Loaded 2017-12-06T18:11:25.167Z,1512583885.167 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2017-12-06T18:11:25.176Z,1512583885.176 [Onboard] Loaded 2017-12-06T18:11:25.176Z,1512583885.176 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread. 2017-12-06T18:11:25.184Z,1512583885.184 [Radio_Surface] Loaded 2017-12-06T18:11:25.184Z,1512583885.184 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2017-12-06T18:11:25.186Z,1512583885.186 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 40A3C4E0 2017-12-06T18:11:25.187Z,1512583885.187 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 853 2017-12-06T18:11:25.405Z,1512583885.405 [PNI_TCM] Loaded 2017-12-06T18:11:25.405Z,1512583885.405 [ComponentRegistry](DEBUG): SyncComponent "PNI_TCM" handled in the control thread. 2017-12-06T18:11:25.475Z,1512583885.475 [Rowe_600LCM] Loaded 2017-12-06T18:11:25.476Z,1512583885.476 [ComponentRegistry](DEBUG): Component "Rowe_600LCM" handled in its own thread. 2017-12-06T18:11:25.479Z,1512583885.479 [Rowe_600LCM ThreadHandler](DEBUG): Created PCaller Thread at 40A6C4E0 2017-12-06T18:11:25.479Z,1512583885.479 [Rowe_600LCM ThreadHandler](INFO): Protected caller Thread ID is 854 2017-12-06T18:11:27.530Z,1512583887.530 [BPC1] Loaded 2017-12-06T18:11:27.530Z,1512583887.530 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2017-12-06T18:11:27.531Z,1512583887.531 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2017-12-06T18:11:27.531Z,1512583887.531 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2017-12-06T18:11:27.666Z,1512583887.666 [BuoyancyServo] Loaded 2017-12-06T18:11:27.666Z,1512583887.666 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2017-12-06T18:11:27.678Z,1512583887.678 [ElevatorServo] Loaded 2017-12-06T18:11:27.678Z,1512583887.678 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2017-12-06T18:11:27.689Z,1512583887.689 [MassServo] Loaded 2017-12-06T18:11:27.690Z,1512583887.690 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2017-12-06T18:11:27.706Z,1512583887.706 [RudderServo] Loaded 2017-12-06T18:11:27.706Z,1512583887.706 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2017-12-06T18:11:27.718Z,1512583887.718 [ThrusterServo] Loaded 2017-12-06T18:11:27.718Z,1512583887.718 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread. 2017-12-06T18:11:27.718Z,1512583887.718 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2017-12-06T18:11:27.719Z,1512583887.719 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2017-12-06T18:11:27.859Z,1512583887.859 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2017-12-06T18:11:27.859Z,1512583887.859 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2017-12-06T18:11:27.903Z,1512583887.903 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2017-12-06T18:11:27.906Z,1512583887.906 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2017-12-06T18:11:27.907Z,1512583887.907 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2017-12-06T18:11:27.915Z,1512583887.915 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2017-12-06T18:11:27.918Z,1512583887.918 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40B134E0 2017-12-06T18:11:27.919Z,1512583887.919 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 855 2017-12-06T18:11:27.924Z,1512583887.924 [Supervisor](INFO): Main Thread ID is 767 2017-12-06T18:11:27.924Z,1512583887.924 [Supervisor](DEBUG): Running supervisor. 2017-12-06T18:11:27.924Z,1512583887.924 [CommandLine ThreadHandler](INFO): Handler Thread ID is 856 2017-12-06T18:11:27.931Z,1512583887.931 [controlThread ThreadHandler](INFO): Handler Thread ID is 857 2017-12-06T18:11:27.931Z,1512583887.931 [controlThread](DEBUG): Initializing ControlThread 2017-12-06T18:11:27.932Z,1512583887.932 [SBIT](INFO): Initialize SBIT Component. 2017-12-06T18:11:27.933Z,1512583887.933 [SBIT](IMPORTANT): git: 2017-11-20-3-gb0389ee 2017-12-06T18:11:27.933Z,1512583887.933 [SBIT](INFO): git hash: b0389eed17bddc8251b1231910f9148d930dbf7d 2017-12-06T18:11:27.935Z,1512583887.935 [SBIT](INFO): Kernel Reporting Different Release From Configuration. Kernel Expected: 2.6.27.8 Kernel Reported: 2.6.27.8-00011-g2bc81df-dirty 2017-12-06T18:11:27.935Z,1512583887.935 [SBIT](INFO): Kernel Reporting Different Version From Configuration. Kernel Expected: #639 PREEMPT Wed Mar 12 12:53:33 PDT 2014 Kernel Reported: #646 PREEMPT Thu Feb 11 17:01:12 PST 2016 2017-12-06T18:11:27.936Z,1512583887.936 [SBIT](INFO): Beginning SBIT in 79.000000 seconds. 2017-12-06T18:11:27.937Z,1512583887.937 [IBIT](INFO): Initialize IBIT Component. 2017-12-06T18:11:27.938Z,1512583887.938 [CBIT](DEBUG): Initialize CBIT Component. 2017-12-06T18:11:27.938Z,1512583887.938 [CBIT](FAULT): LAST RESTART WAS UNINTENTIONAL. 2017-12-06T18:11:27.938Z,1512583887.938 [CBIT](INFO): Last reboot was NOT due to watchdog timer. 2017-12-06T18:11:27.943Z,1512583887.943 [logger ThreadHandler](INFO): Handler Thread ID is 858 2017-12-06T18:11:27.987Z,1512583887.987 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 859 2017-12-06T18:11:27.988Z,1512583887.988 [CTD_Seabird](INFO): Initializing 2017-12-06T18:11:28.019Z,1512583888.019 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2017-12-06T18:11:28.022Z,1512583888.022 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2017-12-06T18:11:28.022Z,1512583888.022 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2017-12-06T18:11:28.023Z,1512583888.023 [LoopControl](DEBUG): Initialize LoopControlComponent. 2017-12-06T18:11:28.023Z,1512583888.023 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2017-12-06T18:11:28.024Z,1512583888.024 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2017-12-06T18:11:28.024Z,1512583888.024 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2017-12-06T18:11:28.025Z,1512583888.025 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator. 2017-12-06T18:11:28.025Z,1512583888.025 [VerticalTemperatureHomogeneityIndexCalculator](DEBUG): (re)initializing 2017-12-06T18:11:28.026Z,1512583888.026 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2017-12-06T18:11:28.027Z,1512583888.027 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component. 2017-12-06T18:11:28.028Z,1512583888.028 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s. 2017-12-06T18:11:28.029Z,1512583888.029 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s. 2017-12-06T18:11:28.029Z,1512583888.029 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2017-12-06T18:11:28.030Z,1512583888.030 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s. 2017-12-06T18:11:28.030Z,1512583888.030 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s. 2017-12-06T18:11:28.030Z,1512583888.030 [DeadReckonWithRespectToSeafloor](DEBUG): Initializing DeadReckonWithRespectToSeafloor component. 2017-12-06T18:11:28.031Z,1512583888.031 [DeadReckonWithRespectToSeafloor](INFO): Will consider orientation measurement stale after 120s. 2017-12-06T18:11:28.031Z,1512583888.031 [DeadReckonWithRespectToSeafloor](INFO): Will consider velocity measurement stale after 20s. 2017-12-06T18:11:28.032Z,1512583888.032 [NavChart](DEBUG): Initialize NavChart Navigation. 2017-12-06T18:11:28.032Z,1512583888.032 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2017-12-06T18:11:28.043Z,1512583888.043 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 861 2017-12-06T18:11:28.045Z,1512583888.045 [WetLabsBB2FL](INFO): Powering down 2017-12-06T18:11:28.083Z,1512583888.083 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Handler Thread ID is 862 2017-12-06T18:11:28.092Z,1512583888.092 [MissionManager](INFO): Loading Mission: Missions/Startup.xml 2017-12-06T18:11:28.104Z,1512583888.104 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 863 2017-12-06T18:11:28.111Z,1512583888.111 [Radio_Surface](INFO): Powering up 2017-12-06T18:11:28.113Z,1512583888.113 [Rowe_600LCM ThreadHandler](INFO): Handler Thread ID is 864 2017-12-06T18:11:28.114Z,1512583888.114 [Rowe_600LCM](INFO): Initializing 2017-12-06T18:11:28.115Z,1512583888.115 [Rowe_600LCM](INFO): Checking LCM 2017-12-06T18:11:28.206Z,1512583888.206 [CTD_Seabird](INFO): Stopping potential previous instance(s) of CTD_Seabird LCM interface 2017-12-06T18:11:28.206Z,1512583888.206 [CTD_Seabird](INFO): Powering down 2017-12-06T18:11:28.228Z,1512583888.228 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 865 2017-12-06T18:11:28.236Z,1512583888.236 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000 2017-12-06T18:11:28.237Z,1512583888.237 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000 2017-12-06T18:11:28.237Z,1512583888.237 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000 2017-12-06T18:11:28.237Z,1512583888.237 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000 2017-12-06T18:11:28.237Z,1512583888.237 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000 2017-12-06T18:11:28.238Z,1512583888.238 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000 2017-12-06T18:11:28.238Z,1512583888.238 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000 2017-12-06T18:11:28.238Z,1512583888.238 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000 2017-12-06T18:11:28.238Z,1512583888.238 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000 2017-12-06T18:11:28.238Z,1512583888.238 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000 2017-12-06T18:11:28.239Z,1512583888.239 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000 2017-12-06T18:11:28.239Z,1512583888.239 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000 2017-12-06T18:11:28.239Z,1512583888.239 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000 2017-12-06T18:11:28.239Z,1512583888.239 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000 2017-12-06T18:11:28.240Z,1512583888.240 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000 2017-12-06T18:11:28.240Z,1512583888.240 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000 2017-12-06T18:11:28.287Z,1512583888.287 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2017-12-06T18:11:28.400Z,1512583888.401 [MissionManager](DEBUG): 2017-12-06T18:11:28.401Z,1512583888.401 [MissionManager](INFO): Loading Mission: Missions/Default.xml 2017-12-06T18:11:28.633Z,1512583888.633 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min 2017-12-06T18:11:28.634Z,1512583888.634 [Default:A.Wait](DEBUG): Construct Wait. 2017-12-06T18:11:28.650Z,1512583888.650 [Default:B.GoToSurface](DEBUG): Construct GoToSurface. 2017-12-06T18:11:28.700Z,1512583888.700 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2017-12-06T18:11:28.703Z,1512583888.703 [Default:CheckIn:C.Wait](DEBUG): Construct Wait. 2017-12-06T18:11:28.729Z,1512583888.729 [Default:E.Execute](DEBUG): Construct Execute. 2017-12-06T18:11:28.873Z,1512583888.873 [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 2017-12-06T18:11:28.886Z,1512583888.886 [controlThread](DEBUG): Component order: CycleStarter,Aanderaa_O2,ESPComponent,PAR_Licor,DataOverHttps,Depth_Keller,DropWeight,NAL9602,Onboard,PNI_TCM,BPC1,PAR_Licor,Depth_Keller,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, 2017-12-06T18:11:28.932Z,1512583888.932 [ESPComponent](INFO): powering down ESP 2017-12-06T18:11:29.135Z,1512583889.135 [Rowe_600LCM](INFO): LCM OK 2017-12-06T18:11:29.135Z,1512583889.135 [Rowe_600LCM](INFO): Powering up 2017-12-06T18:11:29.336Z,1512583889.336 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2017-12-06T18:11:29.807Z,1512583889.807 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2017-12-06T18:11:29.808Z,1512583889.808 [DeadReckonUsingMultipleVelocitySources](DEBUG): All data for platform velocity is invalid. 2017-12-06T18:11:29.990Z,1512583889.990 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-12-06T18:11:30.016Z,1512583890.016 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2017-12-06T18:11:30.030Z,1512583890.030 [DeadReckonWithRespectToSeafloor](DEBUG): Starting up and don't have orientation data yet. 2017-12-06T18:11:30.157Z,1512583890.157 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2017-12-06T18:11:30.162Z,1512583890.162 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2017-12-06T18:11:30.186Z,1512583890.186 [ElevatorServo](DEBUG): Initializing EZServoServo. 2017-12-06T18:11:30.198Z,1512583890.198 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2017-12-06T18:11:30.221Z,1512583890.221 [MassServo](DEBUG): Initializing EZServoServo. 2017-12-06T18:11:30.231Z,1512583890.231 [MassServo](DEBUG): Initializing MassServo. 2017-12-06T18:11:30.242Z,1512583890.242 [RudderServo](DEBUG): Initializing EZServoServo. 2017-12-06T18:11:30.251Z,1512583890.251 [RudderServo](DEBUG): Initializing RudderServo. 2017-12-06T18:11:30.277Z,1512583890.277 [ThrusterServo](DEBUG): Initializing EZServoServo. 2017-12-06T18:11:30.282Z,1512583890.282 [ThrusterServo](DEBUG): Initializing ThrusterServo. 2017-12-06T18:11:30.668Z,1512583890.668 [DropWeight](CRITICAL): DROP WEIGHT MISSING. 2017-12-06T18:11:30.668Z,1512583890.668 [DropWeight] Hardware Fault, FailCount= 1 2017-12-06T18:11:30.668Z,1512583890.668 [DropWeight](ERROR): Hardware Fault 2017-12-06T18:11:30.712Z,1512583890.712 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2017-12-06T18:11:30.712Z,1512583890.712 [DeadReckonUsingMultipleVelocitySources](DEBUG): All data for platform velocity is invalid. 2017-12-06T18:11:30.713Z,1512583890.713 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-12-06T18:11:30.714Z,1512583890.714 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2017-12-06T18:11:30.719Z,1512583890.719 [DeadReckonWithRespectToSeafloor](DEBUG): Starting up and don't have orientation data yet. 2017-12-06T18:11:31.059Z,1512583891.059 [BuoyancyServo](ERROR): Buoyancy initialization uart error serial timeout 2017-12-06T18:11:31.060Z,1512583891.060 [BuoyancyServo](FAULT): Buoyancy failed to initialize 2017-12-06T18:11:31.060Z,1512583891.060 [BuoyancyServo] Communications Fault, FailCount= 1 2017-12-06T18:11:31.060Z,1512583891.060 [BuoyancyServo](ERROR): Communications Fault 2017-12-06T18:11:31.285Z,1512583891.285 [CommandLine](FAULT): Scheduling is paused 2017-12-06T18:11:31.286Z,1512583891.286 [CBIT](INFO): Critical error at 20171206T181130 2017-12-06T18:11:31.286Z,1512583891.286 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals 2017-12-06T18:11:31.288Z,1512583891.288 [CBIT](ERROR): Hardware Fault in component: DropWeight 2017-12-06T18:11:31.289Z,1512583891.289 [CBIT](CRITICAL): Hardware Fault in component: DropWeight 2017-12-06T18:11:31.289Z,1512583891.289 [CBIT](ERROR): Communications Fault in component: BuoyancyServo 2017-12-06T18:11:32.638Z,1512583892.638 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of Rowe LCM interface 2017-12-06T18:11:32.777Z,1512583892.777 [Rowe_600LCM](INFO): Started Rowe LCM interface with command:nohup ./lrauv-framework/onboard/bin/roweadcp -ldir /mnt/mmc/LRAUV/Logs/latest/ -dev /dev/ttyB4 -b 38400 >& /dev/null & 2017-12-06T18:11:34.306Z,1512583894.306 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.bottom_track 2017-12-06T18:11:34.307Z,1512583894.307 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.vehicle_water_velocity 2017-12-06T18:11:34.307Z,1512583894.307 [Rowe_600LCM](INFO): LCM subscribed to channel:rowe_dvl.rowe 2017-12-06T18:11:41.701Z,1512583901.701 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2017-12-06T18:11:41.701Z,1512583901.701 [DeadReckonUsingMultipleVelocitySources](DEBUG): All data for platform velocity is invalid. 2017-12-06T18:11:41.702Z,1512583901.702 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-12-06T18:11:41.703Z,1512583901.703 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2017-12-06T18:11:41.716Z,1512583901.716 [DeadReckonWithRespectToSeafloor](DEBUG): Starting up and don't have orientation data yet. 2017-12-06T18:11:41.731Z,1512583901.731 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2017-12-06T18:11:41.741Z,1512583901.741 [BuoyancyServo](INFO): Powering down 2017-12-06T18:11:41.855Z,1512583901.855 [CBIT](INFO): Critical error at 20171206T181131 2017-12-06T18:11:41.929Z,1512583901.929 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2017-12-06T18:11:41.929Z,1512583901.929 [DeadReckonUsingMultipleVelocitySources](DEBUG): All data for platform velocity is invalid. 2017-12-06T18:11:41.930Z,1512583901.930 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-12-06T18:11:41.931Z,1512583901.931 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2017-12-06T18:11:41.931Z,1512583901.931 [DeadReckonWithRespectToSeafloor](DEBUG): Starting up and don't have orientation data yet. 2017-12-06T18:11:42.277Z,1512583902.277 [Aanderaa_O2](INFO): Powering down 2017-12-06T18:11:42.449Z,1512583902.449 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2017-12-06T18:11:42.461Z,1512583902.461 [DeadReckonUsingMultipleVelocitySources](DEBUG): All data for platform velocity is invalid. 2017-12-06T18:11:42.462Z,1512583902.462 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-12-06T18:11:42.463Z,1512583902.463 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2017-12-06T18:11:42.464Z,1512583902.464 [DeadReckonWithRespectToSeafloor](DEBUG): Starting up and don't have orientation data yet. 2017-12-06T18:11:42.679Z,1512583902.679 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.003806 2017-12-06T18:11:42.730Z,1512583902.730 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2017-12-06T18:11:42.732Z,1512583902.732 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-12-06T18:11:42.732Z,1512583902.732 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2017-12-06T18:11:42.733Z,1512583902.733 [DeadReckonWithRespectToSeafloor](DEBUG): Starting up and don't have orientation data yet. 2017-12-06T18:11:43.139Z,1512583903.139 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2017-12-06T18:11:43.140Z,1512583903.140 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-12-06T18:11:43.141Z,1512583903.141 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2017-12-06T18:11:43.141Z,1512583903.141 [DeadReckonWithRespectToSeafloor](DEBUG): Starting up and don't have orientation data yet. 2017-12-06T18:11:43.538Z,1512583903.538 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2017-12-06T18:11:43.551Z,1512583903.551 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-12-06T18:11:43.552Z,1512583903.552 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2017-12-06T18:11:43.555Z,1512583903.555 [DeadReckonWithRespectToSeafloor](DEBUG): Starting up and don't have orientation data yet. 2017-12-06T18:11:44.024Z,1512583904.024 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-12-06T18:11:44.081Z,1512583904.081 [CBIT](INFO): Clearing failed state for component BuoyancyServo 2017-12-06T18:11:44.081Z,1512583904.081 [BuoyancyServo] No Fault, FailCount= 1 2017-12-06T18:11:44.399Z,1512583904.399 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-12-06T18:11:44.434Z,1512583904.434 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2017-12-06T18:11:44.434Z,1512583904.434 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2017-12-06T18:11:44.782Z,1512583904.782 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-12-06T18:11:45.139Z,1512583905.139 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-12-06T18:11:45.567Z,1512583905.567 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-12-06T18:11:45.961Z,1512583905.961 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-12-06T18:11:46.346Z,1512583906.346 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-12-06T18:11:46.742Z,1512583906.742 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-12-06T18:11:47.131Z,1512583907.131 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-12-06T18:11:47.516Z,1512583907.516 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-12-06T18:11:47.934Z,1512583907.934 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-12-06T18:11:48.349Z,1512583908.349 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-12-06T18:11:48.726Z,1512583908.726 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-12-06T18:11:49.150Z,1512583909.150 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-12-06T18:11:49.554Z,1512583909.554 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-12-06T18:11:49.969Z,1512583909.969 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-12-06T18:11:50.479Z,1512583910.479 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-12-06T18:11:50.749Z,1512583910.749 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-12-06T18:11:51.176Z,1512583911.176 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-12-06T18:11:51.550Z,1512583911.550 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-12-06T18:11:51.935Z,1512583911.935 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-12-06T18:11:52.414Z,1512583912.414 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-12-06T18:11:52.805Z,1512583912.805 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-12-06T18:11:53.152Z,1512583913.152 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-12-06T18:11:53.577Z,1512583913.577 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-12-06T18:11:53.926Z,1512583913.926 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-12-06T18:11:54.350Z,1512583914.350 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-12-06T18:11:54.760Z,1512583914.760 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-12-06T18:11:55.154Z,1512583915.154 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-12-06T18:11:55.475Z,1512583915.475 [NAL9602](INFO): Powering up NAL9602 2017-12-06T18:11:55.518Z,1512583915.518 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-12-06T18:11:55.925Z,1512583915.925 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-12-06T18:11:56.332Z,1512583916.332 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-12-06T18:11:56.718Z,1512583916.718 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-12-06T18:11:57.147Z,1512583917.147 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-12-06T18:11:57.538Z,1512583917.538 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-12-06T18:11:57.924Z,1512583917.924 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-12-06T18:11:58.391Z,1512583918.391 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-12-06T18:11:58.709Z,1512583918.709 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-12-06T18:11:59.129Z,1512583919.129 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-12-06T18:11:59.517Z,1512583919.517 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-12-06T18:11:59.925Z,1512583919.925 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-12-06T18:12:00.351Z,1512583920.351 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-12-06T18:12:00.728Z,1512583920.728 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-12-06T18:12:01.170Z,1512583921.170 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-12-06T18:12:01.522Z,1512583921.522 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-12-06T18:12:01.925Z,1512583921.925 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-12-06T18:12:02.359Z,1512583922.359 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-12-06T18:12:02.719Z,1512583922.719 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-12-06T18:12:03.143Z,1512583923.143 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-12-06T18:12:03.556Z,1512583923.556 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-12-06T18:12:03.925Z,1512583923.925 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-12-06T18:12:04.416Z,1512583924.416 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-12-06T18:12:04.738Z,1512583924.738 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-12-06T18:12:05.164Z,1512583925.164 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-12-06T18:12:05.573Z,1512583925.573 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-12-06T18:12:05.947Z,1512583925.947 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-12-06T18:12:06.275Z,1512583926.275 [NAL9602](INFO): NAL9602 initialized 2017-12-06T18:12:06.402Z,1512583926.402 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-12-06T18:12:06.814Z,1512583926.814 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-12-06T18:12:07.171Z,1512583927.171 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-12-06T18:12:07.580Z,1512583927.580 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-12-06T18:12:08.023Z,1512583928.023 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-12-06T18:12:08.396Z,1512583928.396 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-12-06T18:12:08.795Z,1512583928.795 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-12-06T18:12:09.166Z,1512583929.166 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-12-06T18:12:09.562Z,1512583929.562 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-12-06T18:12:09.932Z,1512583929.932 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-12-06T18:12:10.386Z,1512583930.386 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-12-06T18:12:10.741Z,1512583930.741 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-12-06T18:12:11.131Z,1512583931.131 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-12-06T18:12:11.621Z,1512583931.621 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-12-06T18:12:11.918Z,1512583931.918 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-12-06T18:12:12.383Z,1512583932.383 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-12-06T18:12:12.774Z,1512583932.774 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-12-06T18:12:13.131Z,1512583933.131 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-12-06T18:12:13.539Z,1512583933.539 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-12-06T18:12:13.942Z,1512583933.942 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-12-06T18:12:14.386Z,1512583934.386 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-12-06T18:12:14.793Z,1512583934.793 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-12-06T18:12:15.140Z,1512583935.140 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-12-06T18:12:15.593Z,1512583935.593 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-12-06T18:12:15.956Z,1512583935.956 [DeadReckonUsingMultipleVelocitySources]