2017-09-25T14:48:27.505Z,1506350907.505 [Supervisor](DEBUG): Initializing supervisor. 2017-09-25T14:48:27.508Z,1506350907.508 [SyncHandler](DEBUG): Created PCaller Thread at 4051A4E0 2017-09-25T14:48:27.508Z,1506350907.508 [SyncHandler](INFO): Protected caller Thread ID is 769 2017-09-25T14:48:27.509Z,1506350907.509 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2017-09-25T14:48:27.510Z,1506350907.510 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 4054A4E0 2017-09-25T14:48:27.510Z,1506350907.510 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 770 2017-09-25T14:48:27.513Z,1506350907.513 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2017-09-25T14:48:27.525Z,1506350907.525 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2017-09-25T14:48:27.526Z,1506350907.526 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 4057A4E0 2017-09-25T14:48:27.527Z,1506350907.527 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 771 2017-09-25T14:48:27.527Z,1506350907.527 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2017-09-25T14:48:27.528Z,1506350907.528 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405AA4E0 2017-09-25T14:48:27.529Z,1506350907.529 [logger ThreadHandler](INFO): Protected caller Thread ID is 772 2017-09-25T14:48:27.531Z,1506350907.531 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2017-09-25T14:48:27.531Z,1506350907.531 [Supervisor](INFO): Looking for Config files in directory: Config/ 2017-09-25T14:48:27.534Z,1506350907.534 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2017-09-25T14:48:27.726Z,1506350907.726 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2017-09-25T14:48:27.727Z,1506350907.727 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2017-09-25T14:48:27.863Z,1506350907.863 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2017-09-25T14:48:27.864Z,1506350907.864 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2017-09-25T14:48:28.209Z,1506350908.209 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2017-09-25T14:48:28.211Z,1506350908.211 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2017-09-25T14:48:28.354Z,1506350908.354 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2017-09-25T14:48:28.355Z,1506350908.355 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2017-09-25T14:48:28.441Z,1506350908.441 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2017-09-25T14:48:28.646Z,1506350908.646 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2017-09-25T14:48:28.646Z,1506350908.646 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2017-09-25T14:48:28.733Z,1506350908.733 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample 2017-09-25T14:48:28.734Z,1506350908.734 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2017-09-25T14:48:29.027Z,1506350909.027 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2017-09-25T14:48:29.028Z,1506350909.028 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2017-09-25T14:48:29.392Z,1506350909.392 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2017-09-25T14:48:29.392Z,1506350909.392 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2017-09-25T14:48:29.702Z,1506350909.702 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2017-09-25T14:48:29.703Z,1506350909.703 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2017-09-25T14:48:30.217Z,1506350910.217 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2017-09-25T14:48:33.734Z,1506350913.734 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2017-09-25T14:48:34.094Z,1506350914.094 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2017-09-25T14:48:34.095Z,1506350914.095 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2017-09-25T14:48:34.200Z,1506350914.200 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2017-09-25T14:48:34.201Z,1506350914.201 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2017-09-25T14:48:34.667Z,1506350914.667 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2017-09-25T14:48:34.668Z,1506350914.668 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2017-09-25T14:48:34.781Z,1506350914.781 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2017-09-25T14:48:34.783Z,1506350914.783 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-ahi/ 2017-09-25T14:48:34.786Z,1506350914.786 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Battery.cfg 2017-09-25T14:48:35.018Z,1506350915.018 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2017-09-25T14:48:35.019Z,1506350915.019 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/BIT.cfg 2017-09-25T14:48:35.123Z,1506350915.123 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Navigation.cfg 2017-09-25T14:48:35.234Z,1506350915.234 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Control.cfg 2017-09-25T14:48:38.877Z,1506350918.877 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Simulator.cfg 2017-09-25T14:48:38.968Z,1506350918.968 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Science.cfg 2017-09-25T14:48:39.120Z,1506350919.120 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Sensor.cfg 2017-09-25T14:48:39.297Z,1506350919.297 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Servo.cfg 2017-09-25T14:48:39.411Z,1506350919.411 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/logger.cfg 2017-09-25T14:48:39.512Z,1506350919.512 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/secure.cfg 2017-09-25T14:48:39.601Z,1506350919.601 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/vehicle.cfg 2017-09-25T14:48:39.773Z,1506350919.773 [Supervisor](FAULT): Ignoring configuration overrides from Data/persisted.cfg 2017-09-25T14:48:39.777Z,1506350919.777 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2017-09-25T14:48:39.929Z,1506350919.929 [SBIT](DEBUG): Construct Startup Built In Test. 2017-09-25T14:48:39.959Z,1506350919.959 [SBIT] Loaded 2017-09-25T14:48:39.960Z,1506350919.960 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2017-09-25T14:48:39.960Z,1506350919.960 [IBIT](DEBUG): Construct Initiated Built In Test. 2017-09-25T14:48:39.988Z,1506350919.988 [IBIT] Loaded 2017-09-25T14:48:39.989Z,1506350919.989 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2017-09-25T14:48:39.992Z,1506350919.992 [CBIT](DEBUG): Construct Continuous Built In Test. 2017-09-25T14:48:40.142Z,1506350920.142 [CBIT] Loaded 2017-09-25T14:48:40.143Z,1506350920.143 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2017-09-25T14:48:40.143Z,1506350920.143 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2017-09-25T14:48:40.144Z,1506350920.144 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2017-09-25T14:48:40.233Z,1506350920.233 [VerticalControl](DEBUG): Construct VerticalControl. 2017-09-25T14:48:40.392Z,1506350920.392 [VerticalControl] Loaded 2017-09-25T14:48:40.393Z,1506350920.393 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2017-09-25T14:48:40.393Z,1506350920.393 [HorizontalControl](DEBUG): Construct HorizontalControl. 2017-09-25T14:48:40.456Z,1506350920.456 [HorizontalControl] Loaded 2017-09-25T14:48:40.456Z,1506350920.456 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2017-09-25T14:48:40.457Z,1506350920.457 [SpeedControl](DEBUG): Construct SpeedControl. 2017-09-25T14:48:40.463Z,1506350920.463 [SpeedControl] Loaded 2017-09-25T14:48:40.463Z,1506350920.463 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2017-09-25T14:48:40.464Z,1506350920.464 [BackSeatDriver](DEBUG): Construct BackSeatDriver. 2017-09-25T14:48:40.466Z,1506350920.466 [BackSeatDriver] Loaded 2017-09-25T14:48:40.466Z,1506350920.466 [ComponentRegistry](DEBUG): SyncComponent "BackSeatDriver" handled in the control thread. 2017-09-25T14:48:40.467Z,1506350920.467 [LoopControl](DEBUG): Construct LoopControl. 2017-09-25T14:48:40.468Z,1506350920.468 [LoopControl] Loaded 2017-09-25T14:48:40.468Z,1506350920.468 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2017-09-25T14:48:40.468Z,1506350920.468 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2017-09-25T14:48:40.469Z,1506350920.469 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2017-09-25T14:48:40.509Z,1506350920.509 [DepthRateCalculator] Loaded 2017-09-25T14:48:40.509Z,1506350920.509 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2017-09-25T14:48:40.514Z,1506350920.514 [PitchRateCalculator] Loaded 2017-09-25T14:48:40.514Z,1506350920.514 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2017-09-25T14:48:40.530Z,1506350920.530 [SpeedCalculator] Loaded 2017-09-25T14:48:40.530Z,1506350920.530 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2017-09-25T14:48:40.552Z,1506350920.552 [TempGradientCalculator] Loaded 2017-09-25T14:48:40.552Z,1506350920.552 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread. 2017-09-25T14:48:40.568Z,1506350920.568 [VerticalTemperatureHomogeneityIndexCalculator] Loaded 2017-09-25T14:48:40.568Z,1506350920.568 [ComponentRegistry](DEBUG): SyncComponent "VerticalTemperatureHomogeneityIndexCalculator" handled in the control thread. 2017-09-25T14:48:40.573Z,1506350920.573 [YawRateCalculator] Loaded 2017-09-25T14:48:40.574Z,1506350920.574 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2017-09-25T14:48:40.574Z,1506350920.574 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2017-09-25T14:48:40.575Z,1506350920.575 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2017-09-25T14:48:40.695Z,1506350920.695 [StratificationFrontDetector](INFO): threshold set to: 0.399988 degC 2017-09-25T14:48:40.695Z,1506350920.695 [StratificationFrontDetector](DEBUG): (re)initializing 2017-09-25T14:48:40.696Z,1506350920.696 [StratificationFrontDetector] Loaded 2017-09-25T14:48:40.696Z,1506350920.696 [ComponentRegistry](DEBUG): SyncComponent "StratificationFrontDetector" handled in the control thread. 2017-09-25T14:48:40.697Z,1506350920.697 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2017-09-25T14:48:40.697Z,1506350920.697 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2017-09-25T14:48:40.965Z,1506350920.965 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2017-09-25T14:48:40.966Z,1506350920.966 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2017-09-25T14:48:41.084Z,1506350921.084 [DeadReckonUsingMultipleVelocitySources] Loaded 2017-09-25T14:48:41.085Z,1506350921.085 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2017-09-25T14:48:41.138Z,1506350921.138 [DeadReckonUsingSpeedCalculator] Loaded 2017-09-25T14:48:41.138Z,1506350921.138 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread. 2017-09-25T14:48:41.193Z,1506350921.193 [DeadReckonWithRespectToSeafloor] Loaded 2017-09-25T14:48:41.193Z,1506350921.193 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonWithRespectToSeafloor" handled in the control thread. 2017-09-25T14:48:41.210Z,1506350921.210 [NavChart] Loaded 2017-09-25T14:48:41.210Z,1506350921.210 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2017-09-25T14:48:41.214Z,1506350921.214 [UniversalFixResidualReporter] Loaded 2017-09-25T14:48:41.215Z,1506350921.215 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2017-09-25T14:48:41.215Z,1506350921.215 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2017-09-25T14:48:41.216Z,1506350921.216 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2017-09-25T14:48:41.225Z,1506350921.225 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2017-09-25T14:48:41.225Z,1506350921.225 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2017-09-25T14:48:41.409Z,1506350921.409 [Aanderaa_O2] Loaded 2017-09-25T14:48:41.409Z,1506350921.409 [ComponentRegistry](DEBUG): SyncComponent "Aanderaa_O2" handled in the control thread. 2017-09-25T14:48:41.443Z,1506350921.443 [CTD_Seabird] Loaded 2017-09-25T14:48:41.444Z,1506350921.444 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread. 2017-09-25T14:48:41.445Z,1506350921.445 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 4077A4E0 2017-09-25T14:48:41.445Z,1506350921.445 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 851 2017-09-25T14:48:41.460Z,1506350921.460 [PAR_Licor] Loaded 2017-09-25T14:48:41.461Z,1506350921.461 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread. 2017-09-25T14:48:41.509Z,1506350921.509 [WetLabsBB2FL] Loaded 2017-09-25T14:48:41.510Z,1506350921.510 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread. 2017-09-25T14:48:41.511Z,1506350921.511 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 407AA4E0 2017-09-25T14:48:41.511Z,1506350921.511 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 852 2017-09-25T14:48:41.512Z,1506350921.512 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2017-09-25T14:48:41.512Z,1506350921.512 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2017-09-25T14:48:42.170Z,1506350922.170 [DataOverHttps] Loaded 2017-09-25T14:48:42.170Z,1506350922.170 [ComponentRegistry](DEBUG): SyncComponent "DataOverHttps" handled in the control thread. 2017-09-25T14:48:42.184Z,1506350922.184 [Depth_Keller] Loaded 2017-09-25T14:48:42.184Z,1506350922.184 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2017-09-25T14:48:42.189Z,1506350922.189 [DropWeight] Loaded 2017-09-25T14:48:42.189Z,1506350922.189 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread. 2017-09-25T14:48:42.279Z,1506350922.279 [NAL9602] Loaded 2017-09-25T14:48:42.279Z,1506350922.279 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2017-09-25T14:48:42.289Z,1506350922.289 [Onboard] Loaded 2017-09-25T14:48:42.289Z,1506350922.289 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread. 2017-09-25T14:48:42.296Z,1506350922.296 [Radio_Surface] Loaded 2017-09-25T14:48:42.296Z,1506350922.296 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2017-09-25T14:48:42.297Z,1506350922.297 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 409F54E0 2017-09-25T14:48:42.298Z,1506350922.298 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 854 2017-09-25T14:48:42.490Z,1506350922.490 [PNI_TCM] Loaded 2017-09-25T14:48:42.490Z,1506350922.490 [ComponentRegistry](DEBUG): SyncComponent "PNI_TCM" handled in the control thread. 2017-09-25T14:48:42.551Z,1506350922.551 [Rowe_600LCM] Loaded 2017-09-25T14:48:42.551Z,1506350922.551 [ComponentRegistry](DEBUG): Component "Rowe_600LCM" handled in its own thread. 2017-09-25T14:48:42.553Z,1506350922.553 [Rowe_600LCM ThreadHandler](DEBUG): Created PCaller Thread at 40A254E0 2017-09-25T14:48:42.553Z,1506350922.553 [Rowe_600LCM ThreadHandler](INFO): Protected caller Thread ID is 855 2017-09-25T14:48:44.347Z,1506350924.347 [BPC1] Loaded 2017-09-25T14:48:44.348Z,1506350924.348 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2017-09-25T14:48:44.348Z,1506350924.348 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2017-09-25T14:48:44.349Z,1506350924.349 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2017-09-25T14:48:44.468Z,1506350924.468 [BuoyancyServo] Loaded 2017-09-25T14:48:44.468Z,1506350924.468 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2017-09-25T14:48:44.481Z,1506350924.481 [ElevatorServo] Loaded 2017-09-25T14:48:44.481Z,1506350924.481 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2017-09-25T14:48:44.493Z,1506350924.493 [MassServo] Loaded 2017-09-25T14:48:44.493Z,1506350924.493 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2017-09-25T14:48:44.505Z,1506350924.505 [RudderServo] Loaded 2017-09-25T14:48:44.505Z,1506350924.505 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2017-09-25T14:48:44.517Z,1506350924.517 [ThrusterServo] Loaded 2017-09-25T14:48:44.517Z,1506350924.517 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread. 2017-09-25T14:48:44.517Z,1506350924.517 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2017-09-25T14:48:44.518Z,1506350924.518 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2017-09-25T14:48:44.646Z,1506350924.646 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2017-09-25T14:48:44.647Z,1506350924.647 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2017-09-25T14:48:44.687Z,1506350924.687 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2017-09-25T14:48:44.690Z,1506350924.690 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2017-09-25T14:48:44.691Z,1506350924.691 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2017-09-25T14:48:44.698Z,1506350924.698 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2017-09-25T14:48:44.699Z,1506350924.699 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40AD64E0 2017-09-25T14:48:44.700Z,1506350924.700 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 856 2017-09-25T14:48:44.704Z,1506350924.704 [Supervisor](INFO): Main Thread ID is 764 2017-09-25T14:48:44.704Z,1506350924.704 [Supervisor](DEBUG): Running supervisor. 2017-09-25T14:48:44.705Z,1506350924.705 [CommandLine ThreadHandler](INFO): Handler Thread ID is 857 2017-09-25T14:48:44.708Z,1506350924.708 [controlThread ThreadHandler](INFO): Handler Thread ID is 858 2017-09-25T14:48:44.708Z,1506350924.708 [controlThread](DEBUG): Initializing ControlThread 2017-09-25T14:48:44.709Z,1506350924.709 [SBIT](INFO): Initialize SBIT Component. 2017-09-25T14:48:44.710Z,1506350924.710 [SBIT](IMPORTANT): git: 2017-04-25-53-gcaea116 2017-09-25T14:48:44.710Z,1506350924.710 [SBIT](INFO): git hash: caea116986ae94020af0fb1f22ca68d0c0be9268 2017-09-25T14:48:44.712Z,1506350924.712 [SBIT](INFO): Kernel Reporting Different Release From Configuration. Kernel Expected: 2.6.27.8 Kernel Reported: 2.6.27.8-00011-g2bc81df-dirty 2017-09-25T14:48:44.712Z,1506350924.712 [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-09-25T14:48:44.713Z,1506350924.713 [SBIT](INFO): Beginning SBIT in 71.000000 seconds. 2017-09-25T14:48:44.714Z,1506350924.714 [IBIT](INFO): Initialize IBIT Component. 2017-09-25T14:48:44.715Z,1506350924.715 [CBIT](DEBUG): Initialize CBIT Component. 2017-09-25T14:48:44.715Z,1506350924.715 [CBIT](FAULT): LAST RESTART WAS UNINTENTIONAL. 2017-09-25T14:48:44.715Z,1506350924.715 [CBIT](INFO): Last reboot was NOT due to watchdog timer. 2017-09-25T14:48:44.716Z,1506350924.716 [logger ThreadHandler](INFO): Handler Thread ID is 859 2017-09-25T14:48:44.742Z,1506350924.742 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 860 2017-09-25T14:48:44.743Z,1506350924.743 [CTD_Seabird](INFO): Initializing 2017-09-25T14:48:44.787Z,1506350924.787 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 862 2017-09-25T14:48:44.789Z,1506350924.789 [WetLabsBB2FL](INFO): Powering down 2017-09-25T14:48:44.798Z,1506350924.798 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2017-09-25T14:48:44.801Z,1506350924.801 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2017-09-25T14:48:44.802Z,1506350924.802 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2017-09-25T14:48:44.802Z,1506350924.802 [BackSeatDriver](DEBUG): Initialize BackSeatDriver Component. 2017-09-25T14:48:44.886Z,1506350924.886 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 863 2017-09-25T14:48:44.892Z,1506350924.892 [Radio_Surface](INFO): Powering up 2017-09-25T14:48:45.034Z,1506350925.034 [CTD_Seabird](INFO): Stopping potential previous instance(s) of CTD_Seabird LCM interface 2017-09-25T14:48:45.034Z,1506350925.034 [CTD_Seabird](INFO): Powering down 2017-09-25T14:48:45.043Z,1506350925.043 [Rowe_600LCM ThreadHandler](INFO): Handler Thread ID is 864 2017-09-25T14:48:45.044Z,1506350925.044 [Rowe_600LCM](INFO): Initializing 2017-09-25T14:48:45.045Z,1506350925.045 [Rowe_600LCM](INFO): Checking LCM 2017-09-25T14:48:45.051Z,1506350925.051 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 865 2017-09-25T14:48:45.157Z,1506350925.157 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000 2017-09-25T14:48:45.157Z,1506350925.157 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000 2017-09-25T14:48:45.157Z,1506350925.157 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000 2017-09-25T14:48:45.158Z,1506350925.158 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000 2017-09-25T14:48:45.158Z,1506350925.158 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000 2017-09-25T14:48:45.158Z,1506350925.158 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000 2017-09-25T14:48:45.158Z,1506350925.158 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000 2017-09-25T14:48:45.158Z,1506350925.158 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000 2017-09-25T14:48:45.159Z,1506350925.159 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000 2017-09-25T14:48:45.159Z,1506350925.159 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000 2017-09-25T14:48:45.159Z,1506350925.159 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000 2017-09-25T14:48:45.159Z,1506350925.159 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000 2017-09-25T14:48:45.159Z,1506350925.159 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000 2017-09-25T14:48:45.160Z,1506350925.160 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000 2017-09-25T14:48:45.160Z,1506350925.160 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000 2017-09-25T14:48:45.160Z,1506350925.160 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000 2017-09-25T14:48:45.595Z,1506350925.595 [Rowe_600LCM](INFO): LCM OK 2017-09-25T14:48:45.595Z,1506350925.595 [Rowe_600LCM](INFO): Powering up 2017-09-25T14:48:46.090Z,1506350926.090 [LoopControl](DEBUG): Initialize LoopControlComponent. 2017-09-25T14:48:46.090Z,1506350926.090 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2017-09-25T14:48:46.091Z,1506350926.091 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2017-09-25T14:48:46.091Z,1506350926.091 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2017-09-25T14:48:46.092Z,1506350926.092 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator. 2017-09-25T14:48:46.092Z,1506350926.092 [VerticalTemperatureHomogeneityIndexCalculator](DEBUG): (re)initializing 2017-09-25T14:48:46.093Z,1506350926.093 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2017-09-25T14:48:46.094Z,1506350926.094 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component. 2017-09-25T14:48:46.095Z,1506350926.095 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s. 2017-09-25T14:48:46.095Z,1506350926.095 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s. 2017-09-25T14:48:46.096Z,1506350926.096 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2017-09-25T14:48:46.096Z,1506350926.096 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s. 2017-09-25T14:48:46.097Z,1506350926.097 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s. 2017-09-25T14:48:46.097Z,1506350926.097 [DeadReckonWithRespectToSeafloor](DEBUG): Initializing DeadReckonWithRespectToSeafloor component. 2017-09-25T14:48:46.098Z,1506350926.098 [DeadReckonWithRespectToSeafloor](INFO): Will consider orientation measurement stale after 120s. 2017-09-25T14:48:46.098Z,1506350926.098 [DeadReckonWithRespectToSeafloor](INFO): Will consider velocity measurement stale after 20s. 2017-09-25T14:48:46.099Z,1506350926.099 [NavChart](DEBUG): Initialize NavChart Navigation. 2017-09-25T14:48:46.099Z,1506350926.099 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2017-09-25T14:48:46.112Z,1506350926.112 [MissionManager](INFO): Loading Mission: Missions/Startup.xml 2017-09-25T14:48:46.161Z,1506350926.161 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2017-09-25T14:48:46.187Z,1506350926.187 [MissionManager](DEBUG): 2017-09-25T14:48:46.200Z,1506350926.200 [MissionManager](INFO): Loading Mission: Missions/Default.xml 2017-09-25T14:48:46.259Z,1506350926.259 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min 2017-09-25T14:48:46.260Z,1506350926.260 [Default:A.Wait](DEBUG): Construct Wait. 2017-09-25T14:48:46.261Z,1506350926.261 [Default:B.GoToSurface](DEBUG): Construct GoToSurface. 2017-09-25T14:48:46.292Z,1506350926.292 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2017-09-25T14:48:46.310Z,1506350926.310 [Default:CheckIn:C.Wait](DEBUG): Construct Wait. 2017-09-25T14:48:46.316Z,1506350926.316 [Default:E.Execute](DEBUG): Construct Execute. 2017-09-25T14:48:46.335Z,1506350926.335 [MissionManager](DEBUG): 0 Wait a moment to see if the scheduler starts a new mission before starting to actually run Default. 13 Burn 300 Dropped weight due to communications timeout. 5 Default mission has been running for Restarting logs and Default mission. restart logs 2017-09-25T14:48:46.349Z,1506350926.349 [controlThread](DEBUG): Component order: CycleStarter,Aanderaa_O2,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,BackSeatDriver,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter, 2017-09-25T14:48:46.410Z,1506350926.411 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2017-09-25T14:48:46.434Z,1506350926.434 [Depth_Keller](ERROR): Pressure reading out of range: 1727.332275 decibar 2017-09-25T14:48:46.596Z,1506350926.596 [DepthRateCalculator](ERROR): Depth measurement is not active 2017-09-25T14:48:46.687Z,1506350926.687 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2017-09-25T14:48:46.688Z,1506350926.688 [DeadReckonUsingMultipleVelocitySources](DEBUG): All data for platform velocity is invalid. 2017-09-25T14:48:46.887Z,1506350926.887 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-09-25T14:48:46.909Z,1506350926.909 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2017-09-25T14:48:46.931Z,1506350926.931 [DeadReckonWithRespectToSeafloor](DEBUG): Starting up and don't have orientation data yet. 2017-09-25T14:48:47.157Z,1506350927.157 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2017-09-25T14:48:47.158Z,1506350927.158 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2017-09-25T14:48:47.165Z,1506350927.165 [ElevatorServo](DEBUG): Initializing EZServoServo. 2017-09-25T14:48:47.166Z,1506350927.166 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2017-09-25T14:48:47.208Z,1506350927.208 [MassServo](DEBUG): Initializing EZServoServo. 2017-09-25T14:48:47.214Z,1506350927.214 [MassServo](DEBUG): Initializing MassServo. 2017-09-25T14:48:47.220Z,1506350927.220 [RudderServo](DEBUG): Initializing EZServoServo. 2017-09-25T14:48:47.226Z,1506350927.226 [RudderServo](DEBUG): Initializing RudderServo. 2017-09-25T14:48:47.239Z,1506350927.239 [ThrusterServo](DEBUG): Initializing EZServoServo. 2017-09-25T14:48:47.246Z,1506350927.246 [ThrusterServo](DEBUG): Initializing ThrusterServo. 2017-09-25T14:48:47.609Z,1506350927.609 [DropWeight](CRITICAL): DROP WEIGHT MISSING. 2017-09-25T14:48:47.609Z,1506350927.609 [DropWeight] Hardware Fault, FailCount= 1 2017-09-25T14:48:47.609Z,1506350927.609 [DropWeight](ERROR): Hardware Fault 2017-09-25T14:48:47.618Z,1506350927.618 [NAL9602](INFO): Powering up NAL9602 2017-09-25T14:48:47.703Z,1506350927.703 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2017-09-25T14:48:47.704Z,1506350927.704 [DeadReckonUsingMultipleVelocitySources](DEBUG): All data for platform velocity is invalid. 2017-09-25T14:48:47.705Z,1506350927.705 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-09-25T14:48:47.706Z,1506350927.706 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2017-09-25T14:48:47.719Z,1506350927.719 [DeadReckonWithRespectToSeafloor](DEBUG): Starting up and don't have orientation data yet. 2017-09-25T14:48:48.229Z,1506350928.229 [CommandLine](FAULT): Scheduling is paused 2017-09-25T14:48:48.229Z,1506350928.229 [CBIT](INFO): Critical error at 20170925T144847 2017-09-25T14:48:48.230Z,1506350928.230 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals 2017-09-25T14:48:48.232Z,1506350928.232 [CBIT](ERROR): Hardware Fault in component: DropWeight 2017-09-25T14:48:48.233Z,1506350928.233 [CBIT](CRITICAL): Hardware Fault in component: DropWeight 2017-09-25T14:48:48.324Z,1506350928.324 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2017-09-25T14:48:48.324Z,1506350928.324 [DeadReckonUsingMultipleVelocitySources](DEBUG): All data for platform velocity is invalid. 2017-09-25T14:48:48.325Z,1506350928.325 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-09-25T14:48:48.326Z,1506350928.326 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2017-09-25T14:48:48.327Z,1506350928.327 [DeadReckonWithRespectToSeafloor](DEBUG): Starting up and don't have orientation data yet. 2017-09-25T14:48:48.444Z,1506350928.444 [CBIT](INFO): Critical error at 20170925T144848 2017-09-25T14:48:48.684Z,1506350928.684 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2017-09-25T14:48:48.684Z,1506350928.684 [DeadReckonUsingMultipleVelocitySources](DEBUG): All data for platform velocity is invalid. 2017-09-25T14:48:48.685Z,1506350928.685 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-09-25T14:48:48.692Z,1506350928.692 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2017-09-25T14:48:48.693Z,1506350928.693 [DeadReckonWithRespectToSeafloor](DEBUG): Starting up and don't have orientation data yet. 2017-09-25T14:48:49.096Z,1506350929.096 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2017-09-25T14:48:49.096Z,1506350929.096 [DeadReckonUsingMultipleVelocitySources](DEBUG): All data for platform velocity is invalid. 2017-09-25T14:48:49.097Z,1506350929.097 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-09-25T14:48:49.098Z,1506350929.098 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2017-09-25T14:48:49.099Z,1506350929.099 [DeadReckonWithRespectToSeafloor](DEBUG): Starting up and don't have orientation data yet. 2017-09-25T14:48:49.442Z,1506350929.442 [Aanderaa_O2](INFO): Powering down 2017-09-25T14:48:49.566Z,1506350929.566 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2017-09-25T14:48:49.566Z,1506350929.566 [DeadReckonUsingMultipleVelocitySources](DEBUG): All data for platform velocity is invalid. 2017-09-25T14:48:49.567Z,1506350929.567 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-09-25T14:48:49.568Z,1506350929.568 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2017-09-25T14:48:49.569Z,1506350929.569 [DeadReckonWithRespectToSeafloor](DEBUG): Starting up and don't have orientation data yet. 2017-09-25T14:48:49.582Z,1506350929.582 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of Rowe LCM interface 2017-09-25T14:48:49.677Z,1506350929.677 [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-09-25T14:48:49.679Z,1506350929.679 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.bottom_track 2017-09-25T14:48:49.680Z,1506350929.680 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.vehicle_water_velocity 2017-09-25T14:48:49.681Z,1506350929.681 [Rowe_600LCM](INFO): LCM subscribed to channel:rowe_dvl.rowe 2017-09-25T14:48:49.990Z,1506350929.990 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2017-09-25T14:48:49.990Z,1506350929.990 [DeadReckonUsingMultipleVelocitySources](DEBUG): All data for platform velocity is invalid. 2017-09-25T14:48:49.992Z,1506350929.992 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-09-25T14:48:49.992Z,1506350929.992 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2017-09-25T14:48:49.993Z,1506350929.993 [DeadReckonWithRespectToSeafloor](DEBUG): Starting up and don't have orientation data yet. 2017-09-25T14:48:50.391Z,1506350930.391 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2017-09-25T14:48:50.391Z,1506350930.391 [DeadReckonUsingMultipleVelocitySources](DEBUG): All data for platform velocity is invalid. 2017-09-25T14:48:50.392Z,1506350930.392 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-09-25T14:48:50.393Z,1506350930.393 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2017-09-25T14:48:50.394Z,1506350930.394 [DeadReckonWithRespectToSeafloor](DEBUG): Starting up and don't have orientation data yet. 2017-09-25T14:48:51.013Z,1506350931.013 [DeadReckonUsingMultipleVelocitySources](DEBUG): All data for platform velocity is invalid. 2017-09-25T14:48:51.014Z,1506350931.014 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-09-25T14:48:51.468Z,1506350931.468 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-09-25T14:48:51.847Z,1506350931.847 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-09-25T14:48:52.245Z,1506350932.245 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-09-25T14:48:52.642Z,1506350932.642 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-09-25T14:48:53.026Z,1506350933.026 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-09-25T14:48:53.439Z,1506350933.439 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-09-25T14:48:53.839Z,1506350933.839 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-09-25T14:48:54.286Z,1506350934.286 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-09-25T14:48:54.692Z,1506350934.692 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-09-25T14:48:55.044Z,1506350935.044 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-09-25T14:48:55.435Z,1506350935.435 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-09-25T14:48:55.843Z,1506350935.843 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-09-25T14:48:56.291Z,1506350936.291 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-09-25T14:48:56.636Z,1506350936.636 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-09-25T14:48:57.031Z,1506350937.031 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-09-25T14:48:57.432Z,1506350937.432 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-09-25T14:48:57.821Z,1506350937.821 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-09-25T14:48:58.260Z,1506350938.260 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-09-25T14:48:58.581Z,1506350938.581 [NAL9602](INFO): NAL9602 initialized 2017-09-25T14:48:58.639Z,1506350938.639 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-09-25T14:48:59.041Z,1506350939.041 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-09-25T14:48:59.488Z,1506350939.488 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-09-25T14:48:59.880Z,1506350939.880 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-09-25T14:49:00.379Z,1506350940.379 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-09-25T14:49:00.638Z,1506350940.638 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-09-25T14:49:01.082Z,1506350941.082 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-09-25T14:49:01.436Z,1506350941.436 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-09-25T14:49:01.896Z,1506350941.896 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-09-25T14:49:02.305Z,1506350942.305 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-09-25T14:49:02.680Z,1506350942.680 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-09-25T14:49:03.030Z,1506350943.030 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-09-25T14:49:03.430Z,1506350943.430 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-09-25T14:49:03.841Z,1506350943.841 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-09-25T14:49:04.254Z,1506350944.254 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-09-25T14:49:04.671Z,1506350944.671 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-09-25T14:49:05.036Z,1506350945.036 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-09-25T14:49:05.449Z,1506350945.449 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-09-25T14:49:05.853Z,1506350945.853 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-09-25T14:49:06.230Z,1506350946.230 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-09-25T14:49:06.643Z,1506350946.643 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-09-25T14:49:07.079Z,1506350947.079 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-09-25T14:49:07.471Z,1506350947.471 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-09-25T14:49:07.829Z,1506350947.829 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ =