2018-01-12T20:40:41.753Z,1515789641.753 [Supervisor](DEBUG): Initializing supervisor. 2018-01-12T20:40:41.755Z,1515789641.755 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2018-01-12T20:40:41.756Z,1515789641.756 [SyncHandler](INFO): Protected caller Thread ID is 459 2018-01-12T20:40:41.756Z,1515789641.756 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2018-01-12T20:40:41.757Z,1515789641.757 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2018-01-12T20:40:41.758Z,1515789641.758 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 460 2018-01-12T20:40:41.760Z,1515789641.760 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2018-01-12T20:40:41.771Z,1515789641.771 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2018-01-12T20:40:41.772Z,1515789641.772 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2018-01-12T20:40:41.773Z,1515789641.773 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 461 2018-01-12T20:40:41.773Z,1515789641.773 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2018-01-12T20:40:41.774Z,1515789641.774 [logger ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2018-01-12T20:40:41.775Z,1515789641.775 [logger ThreadHandler](INFO): Protected caller Thread ID is 462 2018-01-12T20:40:41.777Z,1515789641.777 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2018-01-12T20:40:41.777Z,1515789641.777 [Supervisor](INFO): Looking for Config files in directory: Config/ 2018-01-12T20:40:41.778Z,1515789641.778 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2018-01-12T20:40:41.948Z,1515789641.948 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2018-01-12T20:40:41.949Z,1515789641.949 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2018-01-12T20:40:42.078Z,1515789642.078 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2018-01-12T20:40:42.079Z,1515789642.079 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2018-01-12T20:40:42.376Z,1515789642.376 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2018-01-12T20:40:42.377Z,1515789642.377 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2018-01-12T20:40:42.503Z,1515789642.503 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2018-01-12T20:40:42.504Z,1515789642.504 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2018-01-12T20:40:42.582Z,1515789642.582 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2018-01-12T20:40:42.764Z,1515789642.764 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2018-01-12T20:40:42.764Z,1515789642.764 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2018-01-12T20:40:42.858Z,1515789642.858 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample 2018-01-12T20:40:42.859Z,1515789642.859 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2018-01-12T20:40:43.157Z,1515789643.157 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2018-01-12T20:40:43.158Z,1515789643.158 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2018-01-12T20:40:43.475Z,1515789643.475 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2018-01-12T20:40:43.476Z,1515789643.476 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2018-01-12T20:40:43.746Z,1515789643.746 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2018-01-12T20:40:43.746Z,1515789643.746 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2018-01-12T20:40:44.205Z,1515789644.205 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2018-01-12T20:40:44.206Z,1515789644.206 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2018-01-12T20:40:44.400Z,1515789644.400 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2018-01-12T20:40:44.401Z,1515789644.401 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2018-01-12T20:40:44.495Z,1515789644.495 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2018-01-12T20:40:44.495Z,1515789644.495 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2018-01-12T20:40:44.923Z,1515789644.923 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2018-01-12T20:40:44.923Z,1515789644.923 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2018-01-12T20:40:45.025Z,1515789645.025 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2018-01-12T20:40:45.027Z,1515789645.027 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-aku/ 2018-01-12T20:40:45.028Z,1515789645.028 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/Battery.cfg 2018-01-12T20:40:45.248Z,1515789645.248 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2018-01-12T20:40:45.249Z,1515789645.249 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/BIT.cfg 2018-01-12T20:40:45.342Z,1515789645.342 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/Navigation.cfg 2018-01-12T20:40:45.440Z,1515789645.440 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/Control.cfg 2018-01-12T20:40:45.533Z,1515789645.533 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/Simulator.cfg 2018-01-12T20:40:45.615Z,1515789645.615 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/Science.cfg 2018-01-12T20:40:45.757Z,1515789645.757 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/Sensor.cfg 2018-01-12T20:40:45.912Z,1515789645.912 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/Servo.cfg 2018-01-12T20:40:46.014Z,1515789646.014 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/logger.cfg 2018-01-12T20:40:46.106Z,1515789646.106 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/secure.cfg 2018-01-12T20:40:46.186Z,1515789646.186 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/vehicle.cfg 2018-01-12T20:40:46.339Z,1515789646.339 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg 2018-01-12T20:40:46.346Z,1515789646.346 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2018-01-12T20:40:46.470Z,1515789646.470 [SBIT](DEBUG): Construct Startup Built In Test. 2018-01-12T20:40:46.499Z,1515789646.499 [SBIT] Loaded 2018-01-12T20:40:46.499Z,1515789646.499 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2018-01-12T20:40:46.500Z,1515789646.500 [IBIT](DEBUG): Construct Initiated Built In Test. 2018-01-12T20:40:46.526Z,1515789646.526 [IBIT] Loaded 2018-01-12T20:40:46.526Z,1515789646.526 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2018-01-12T20:40:46.530Z,1515789646.530 [CBIT](DEBUG): Construct Continuous Built In Test. 2018-01-12T20:40:46.679Z,1515789646.679 [CBIT] Loaded 2018-01-12T20:40:46.680Z,1515789646.680 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2018-01-12T20:40:46.680Z,1515789646.680 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2018-01-12T20:40:46.681Z,1515789646.681 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2018-01-12T20:40:46.757Z,1515789646.757 [VerticalControl](DEBUG): Construct VerticalControl. 2018-01-12T20:40:46.852Z,1515789646.852 [VerticalControl] Loaded 2018-01-12T20:40:46.852Z,1515789646.852 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2018-01-12T20:40:46.853Z,1515789646.853 [HorizontalControl](DEBUG): Construct HorizontalControl. 2018-01-12T20:40:46.911Z,1515789646.911 [HorizontalControl] Loaded 2018-01-12T20:40:46.911Z,1515789646.911 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2018-01-12T20:40:46.912Z,1515789646.912 [SpeedControl](DEBUG): Construct SpeedControl. 2018-01-12T20:40:46.917Z,1515789646.917 [SpeedControl] Loaded 2018-01-12T20:40:46.918Z,1515789646.918 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2018-01-12T20:40:46.918Z,1515789646.918 [LoopControl](DEBUG): Construct LoopControl. 2018-01-12T20:40:46.919Z,1515789646.919 [LoopControl] Loaded 2018-01-12T20:40:46.919Z,1515789646.919 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2018-01-12T20:40:46.920Z,1515789646.920 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2018-01-12T20:40:46.920Z,1515789646.920 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2018-01-12T20:40:46.960Z,1515789646.960 [DepthRateCalculator] Loaded 2018-01-12T20:40:46.960Z,1515789646.960 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2018-01-12T20:40:46.965Z,1515789646.965 [PitchRateCalculator] Loaded 2018-01-12T20:40:46.966Z,1515789646.966 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2018-01-12T20:40:46.981Z,1515789646.981 [SpeedCalculator] Loaded 2018-01-12T20:40:46.982Z,1515789646.982 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2018-01-12T20:40:47.002Z,1515789647.002 [TempGradientCalculator] Loaded 2018-01-12T20:40:47.002Z,1515789647.002 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread. 2018-01-12T20:40:47.017Z,1515789647.017 [VerticalTemperatureHomogeneityIndexCalculator] Loaded 2018-01-12T20:40:47.017Z,1515789647.017 [ComponentRegistry](DEBUG): SyncComponent "VerticalTemperatureHomogeneityIndexCalculator" handled in the control thread. 2018-01-12T20:40:47.022Z,1515789647.022 [YawRateCalculator] Loaded 2018-01-12T20:40:47.022Z,1515789647.022 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2018-01-12T20:40:47.023Z,1515789647.023 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2018-01-12T20:40:47.023Z,1515789647.023 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2018-01-12T20:40:47.105Z,1515789647.105 [StratificationFrontDetector](INFO): threshold set to: 0.399988 degC 2018-01-12T20:40:47.105Z,1515789647.105 [StratificationFrontDetector](DEBUG): (re)initializing 2018-01-12T20:40:47.105Z,1515789647.105 [StratificationFrontDetector] Loaded 2018-01-12T20:40:47.105Z,1515789647.105 [ComponentRegistry](DEBUG): SyncComponent "StratificationFrontDetector" handled in the control thread. 2018-01-12T20:40:47.106Z,1515789647.106 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2018-01-12T20:40:47.107Z,1515789647.107 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2018-01-12T20:40:47.332Z,1515789647.332 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2018-01-12T20:40:47.333Z,1515789647.333 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2018-01-12T20:40:47.436Z,1515789647.436 [DeadReckonUsingMultipleVelocitySources] Loaded 2018-01-12T20:40:47.436Z,1515789647.436 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2018-01-12T20:40:47.488Z,1515789647.488 [DeadReckonUsingSpeedCalculator] Loaded 2018-01-12T20:40:47.488Z,1515789647.488 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread. 2018-01-12T20:40:47.541Z,1515789647.541 [DeadReckonWithRespectToSeafloor] Loaded 2018-01-12T20:40:47.541Z,1515789647.541 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonWithRespectToSeafloor" handled in the control thread. 2018-01-12T20:40:47.556Z,1515789647.556 [NavChart] Loaded 2018-01-12T20:40:47.557Z,1515789647.557 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2018-01-12T20:40:47.560Z,1515789647.560 [UniversalFixResidualReporter] Loaded 2018-01-12T20:40:47.561Z,1515789647.561 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2018-01-12T20:40:47.561Z,1515789647.561 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2018-01-12T20:40:47.562Z,1515789647.562 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2018-01-12T20:40:51.213Z,1515789651.213 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2018-01-12T20:40:51.213Z,1515789651.213 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2018-01-12T20:41:23.988Z,1515789683.988 [Aanderaa_O2] Loaded 2018-01-12T20:41:23.988Z,1515789683.988 [ComponentRegistry](DEBUG): SyncComponent "Aanderaa_O2" handled in the control thread. 2018-01-12T20:41:24.033Z,1515789684.033 [CTD_Seabird] Loaded 2018-01-12T20:41:24.034Z,1515789684.034 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread. 2018-01-12T20:41:24.035Z,1515789684.035 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 406D34E0 2018-01-12T20:41:24.035Z,1515789684.035 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 542 2018-01-12T20:41:24.051Z,1515789684.051 [ESPComponent] Loaded 2018-01-12T20:41:24.051Z,1515789684.051 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread. 2018-01-12T20:41:24.065Z,1515789684.065 [PAR_Licor] Loaded 2018-01-12T20:41:24.065Z,1515789684.065 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread. 2018-01-12T20:41:24.113Z,1515789684.113 [WetLabsBB2FL] Loaded 2018-01-12T20:41:24.113Z,1515789684.113 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread. 2018-01-12T20:41:24.114Z,1515789684.114 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 407034E0 2018-01-12T20:41:24.114Z,1515789684.114 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 543 2018-01-12T20:41:24.156Z,1515789684.156 [WetLabsSeaOWL_UV_A] Loaded 2018-01-12T20:41:24.157Z,1515789684.157 [ComponentRegistry](DEBUG): Component "WetLabsSeaOWL_UV_A" handled in its own thread. 2018-01-12T20:41:24.158Z,1515789684.158 [WetLabsSeaOWL_UV_A ThreadHandler](DEBUG): Created PCaller Thread at 407334E0 2018-01-12T20:41:24.158Z,1515789684.158 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Protected caller Thread ID is 544 2018-01-12T20:41:24.158Z,1515789684.158 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2018-01-12T20:41:24.159Z,1515789684.159 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2018-01-12T20:41:24.407Z,1515789684.407 [DataOverHttps] Loaded 2018-01-12T20:41:24.408Z,1515789684.408 [ComponentRegistry](DEBUG): SyncComponent "DataOverHttps" handled in the control thread. 2018-01-12T20:41:24.420Z,1515789684.420 [Depth_Keller] Loaded 2018-01-12T20:41:24.420Z,1515789684.420 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2018-01-12T20:41:24.508Z,1515789684.508 [NAL9602] Loaded 2018-01-12T20:41:24.508Z,1515789684.508 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2018-01-12T20:41:24.514Z,1515789684.514 [Onboard] Loaded 2018-01-12T20:41:24.514Z,1515789684.514 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread. 2018-01-12T20:41:24.521Z,1515789684.521 [Radio_Surface] Loaded 2018-01-12T20:41:24.521Z,1515789684.521 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2018-01-12T20:41:24.522Z,1515789684.522 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 409774E0 2018-01-12T20:41:24.523Z,1515789684.523 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 545 2018-01-12T20:41:24.641Z,1515789684.641 [DAT] Loaded 2018-01-12T20:41:24.641Z,1515789684.641 [ComponentRegistry](DEBUG): SyncComponent "DAT" handled in the control thread. 2018-01-12T20:41:24.687Z,1515789684.687 [PNI_TCM] Loaded 2018-01-12T20:41:24.687Z,1515789684.687 [ComponentRegistry](DEBUG): SyncComponent "PNI_TCM" handled in the control thread. 2018-01-12T20:41:26.444Z,1515789686.444 [BPC1] Loaded 2018-01-12T20:41:26.445Z,1515789686.445 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2018-01-12T20:41:26.445Z,1515789686.445 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2018-01-12T20:41:26.446Z,1515789686.446 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2018-01-12T20:41:26.540Z,1515789686.540 [BuoyancyServo] Loaded 2018-01-12T20:41:26.540Z,1515789686.540 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2018-01-12T20:41:26.551Z,1515789686.551 [ElevatorServo] Loaded 2018-01-12T20:41:26.552Z,1515789686.552 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2018-01-12T20:41:26.562Z,1515789686.562 [MassServo] Loaded 2018-01-12T20:41:26.562Z,1515789686.562 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2018-01-12T20:41:26.573Z,1515789686.573 [RudderServo] Loaded 2018-01-12T20:41:26.574Z,1515789686.574 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2018-01-12T20:41:26.584Z,1515789686.584 [ThrusterServo] Loaded 2018-01-12T20:41:26.584Z,1515789686.584 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread. 2018-01-12T20:41:26.585Z,1515789686.585 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2018-01-12T20:41:26.585Z,1515789686.585 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2018-01-12T20:41:26.680Z,1515789686.680 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2018-01-12T20:41:26.681Z,1515789686.681 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2018-01-12T20:41:26.704Z,1515789686.704 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2018-01-12T20:41:26.708Z,1515789686.708 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2018-01-12T20:41:26.709Z,1515789686.709 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2018-01-12T20:41:26.715Z,1515789686.715 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2018-01-12T20:41:26.716Z,1515789686.716 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40A1E4E0 2018-01-12T20:41:26.717Z,1515789686.717 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 546 2018-01-12T20:41:26.721Z,1515789686.721 [Supervisor](INFO): Main Thread ID is 458 2018-01-12T20:41:26.721Z,1515789686.721 [Supervisor](DEBUG): Running supervisor. 2018-01-12T20:41:26.722Z,1515789686.722 [CommandLine ThreadHandler](INFO): Handler Thread ID is 547 2018-01-12T20:41:26.725Z,1515789686.725 [controlThread ThreadHandler](INFO): Handler Thread ID is 548 2018-01-12T20:41:26.725Z,1515789686.725 [controlThread](DEBUG): Initializing ControlThread 2018-01-12T20:41:26.726Z,1515789686.726 [SBIT](INFO): Initialize SBIT Component. 2018-01-12T20:41:26.726Z,1515789686.726 [SBIT](IMPORTANT): git: 2017-12-12-6-g934df05 2018-01-12T20:41:26.727Z,1515789686.727 [SBIT](INFO): git hash: 934df0507d0d0c68d703bd95bfaa4c08b3d83462 2018-01-12T20:41:26.727Z,1515789686.727 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2018-01-12T20:41:26.728Z,1515789686.728 [SBIT](INFO): Kernel Reporting Different Version From Configuration. Kernel Expected: #639 PREEMPT Wed Mar 12 12:53:33 PDT 2014 Kernel Reported: #2 PREEMPT Thu Jan 11 20:13:48 PST 2018 2018-01-12T20:41:26.729Z,1515789686.729 [SBIT](INFO): Beginning SBIT in 79.000000 seconds. 2018-01-12T20:41:26.730Z,1515789686.730 [IBIT](INFO): Initialize IBIT Component. 2018-01-12T20:41:26.731Z,1515789686.731 [CBIT](DEBUG): Initialize CBIT Component. 2018-01-12T20:41:26.731Z,1515789686.731 [CBIT](INFO): Last reboot was NOT due to watchdog timer. 2018-01-12T20:41:26.732Z,1515789686.732 [logger ThreadHandler](INFO): Handler Thread ID is 549 2018-01-12T20:41:26.757Z,1515789686.757 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 550 2018-01-12T20:41:26.758Z,1515789686.758 [CTD_Seabird](INFO): Initializing 2018-01-12T20:41:26.797Z,1515789686.797 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 552 2018-01-12T20:41:26.799Z,1515789686.799 [WetLabsBB2FL](INFO): Powering down 2018-01-12T20:41:26.813Z,1515789686.813 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2018-01-12T20:41:26.815Z,1515789686.815 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2018-01-12T20:41:26.816Z,1515789686.816 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2018-01-12T20:41:26.817Z,1515789686.817 [LoopControl](DEBUG): Initialize LoopControlComponent. 2018-01-12T20:41:26.817Z,1515789686.817 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2018-01-12T20:41:26.817Z,1515789686.817 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2018-01-12T20:41:26.818Z,1515789686.818 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2018-01-12T20:41:26.818Z,1515789686.818 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator. 2018-01-12T20:41:26.819Z,1515789686.819 [VerticalTemperatureHomogeneityIndexCalculator](DEBUG): (re)initializing 2018-01-12T20:41:26.819Z,1515789686.819 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2018-01-12T20:41:26.820Z,1515789686.820 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component. 2018-01-12T20:41:26.821Z,1515789686.821 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s. 2018-01-12T20:41:26.822Z,1515789686.822 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s. 2018-01-12T20:41:26.822Z,1515789686.822 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2018-01-12T20:41:26.823Z,1515789686.823 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s. 2018-01-12T20:41:26.823Z,1515789686.823 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s. 2018-01-12T20:41:26.823Z,1515789686.823 [DeadReckonWithRespectToSeafloor](DEBUG): Initializing DeadReckonWithRespectToSeafloor component. 2018-01-12T20:41:26.824Z,1515789686.824 [DeadReckonWithRespectToSeafloor](INFO): Will consider orientation measurement stale after 120s. 2018-01-12T20:41:26.824Z,1515789686.824 [DeadReckonWithRespectToSeafloor](INFO): Will consider velocity measurement stale after 20s. 2018-01-12T20:41:26.825Z,1515789686.825 [NavChart](DEBUG): Initialize NavChart Navigation. 2018-01-12T20:41:26.825Z,1515789686.825 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2018-01-12T20:41:26.848Z,1515789686.848 [MissionManager](INFO): Loading Mission: Missions/Startup.xml 2018-01-12T20:41:26.858Z,1515789686.858 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Handler Thread ID is 553 2018-01-12T20:41:26.873Z,1515789686.873 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 554 2018-01-12T20:41:26.879Z,1515789686.879 [Radio_Surface](INFO): Powering up 2018-01-12T20:41:26.897Z,1515789686.897 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 555 2018-01-12T20:41:26.901Z,1515789686.901 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000 2018-01-12T20:41:26.901Z,1515789686.901 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000 2018-01-12T20:41:26.901Z,1515789686.901 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000 2018-01-12T20:41:26.901Z,1515789686.901 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000 2018-01-12T20:41:26.902Z,1515789686.902 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000 2018-01-12T20:41:26.902Z,1515789686.902 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000 2018-01-12T20:41:26.902Z,1515789686.902 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000 2018-01-12T20:41:26.902Z,1515789686.902 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000 2018-01-12T20:41:26.902Z,1515789686.902 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000 2018-01-12T20:41:26.903Z,1515789686.903 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000 2018-01-12T20:41:26.903Z,1515789686.903 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000 2018-01-12T20:41:26.903Z,1515789686.903 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000 2018-01-12T20:41:26.903Z,1515789686.903 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000 2018-01-12T20:41:26.903Z,1515789686.903 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000 2018-01-12T20:41:26.903Z,1515789686.903 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000 2018-01-12T20:41:26.904Z,1515789686.904 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000 2018-01-12T20:41:26.922Z,1515789686.922 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2018-01-12T20:41:26.977Z,1515789686.977 [MissionManager](DEBUG): 2018-01-12T20:41:26.977Z,1515789686.977 [MissionManager](INFO): Loading Mission: Missions/Default.xml 2018-01-12T20:41:27.067Z,1515789687.067 [CTD_Seabird](INFO): Stopping potential previous instance(s) of CTD_Seabird LCM interface 2018-01-12T20:41:27.067Z,1515789687.067 [CTD_Seabird](INFO): Powering down 2018-01-12T20:41:27.093Z,1515789687.093 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min 2018-01-12T20:41:27.094Z,1515789687.094 [Default:A.Wait](DEBUG): Construct Wait. 2018-01-12T20:41:27.095Z,1515789687.095 [Default:B.GoToSurface](DEBUG): Construct GoToSurface. 2018-01-12T20:41:27.129Z,1515789687.129 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2018-01-12T20:41:27.131Z,1515789687.131 [Default:CheckIn:C.Wait](DEBUG): Construct Wait. 2018-01-12T20:41:27.136Z,1515789687.136 [Default:E.Execute](DEBUG): Construct Execute. 2018-01-12T20:41:27.152Z,1515789687.152 [MissionManager](DEBUG): 0 Wait a moment to see if the scheduler starts a new mission before starting to actually run Default. 13 Burn 300 Dropped weight due to communications timeout. 5 Default mission has been running for Restarting logs and Default mission. restart logs 2018-01-12T20:41:27.157Z,1515789687.157 [controlThread](DEBUG): Component order: CycleStarter,Aanderaa_O2,ESPComponent,PAR_Licor,DataOverHttps,Depth_Keller,NAL9602,Onboard,DAT,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, 2018-01-12T20:41:27.211Z,1515789687.211 [ESPComponent](INFO): powering down ESP 2018-01-12T20:41:27.551Z,1515789687.551 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2018-01-12T20:41:27.576Z,1515789687.576 [Depth_Keller](ERROR): Pressure reading out of range: 1546.657349 decibar 2018-01-12T20:41:27.648Z,1515789687.648 [DAT](INFO): Powering up 2018-01-12T20:41:27.649Z,1515789687.649 [DAT](DEBUG): Initializing DAT. 2018-01-12T20:41:27.829Z,1515789687.829 [DepthRateCalculator](ERROR): Depth measurement is not active 2018-01-12T20:41:27.929Z,1515789687.929 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2018-01-12T20:41:27.930Z,1515789687.930 [DeadReckonUsingMultipleVelocitySources](DEBUG): All data for platform velocity is invalid. 2018-01-12T20:41:27.933Z,1515789687.933 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-12T20:41:27.954Z,1515789687.954 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-01-12T20:41:27.960Z,1515789687.960 [DeadReckonWithRespectToSeafloor](DEBUG): Starting up and don't have orientation data yet. 2018-01-12T20:41:28.077Z,1515789688.077 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2018-01-12T20:41:28.085Z,1515789688.085 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2018-01-12T20:41:28.099Z,1515789688.099 [ElevatorServo](DEBUG): Initializing EZServoServo. 2018-01-12T20:41:28.105Z,1515789688.105 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2018-01-12T20:41:28.112Z,1515789688.112 [MassServo](DEBUG): Initializing EZServoServo. 2018-01-12T20:41:28.133Z,1515789688.133 [MassServo](DEBUG): Initializing MassServo. 2018-01-12T20:41:28.139Z,1515789688.139 [RudderServo](DEBUG): Initializing EZServoServo. 2018-01-12T20:41:28.145Z,1515789688.145 [RudderServo](DEBUG): Initializing RudderServo. 2018-01-12T20:41:28.162Z,1515789688.162 [ThrusterServo](DEBUG): Initializing EZServoServo. 2018-01-12T20:41:28.169Z,1515789688.169 [ThrusterServo](DEBUG): Initializing ThrusterServo. 2018-01-12T20:41:28.496Z,1515789688.496 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2018-01-12T20:41:28.496Z,1515789688.496 [DeadReckonUsingMultipleVelocitySources](DEBUG): All data for platform velocity is invalid. 2018-01-12T20:41:28.497Z,1515789688.497 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-12T20:41:28.513Z,1515789688.513 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-01-12T20:41:28.514Z,1515789688.514 [DeadReckonWithRespectToSeafloor](DEBUG): Starting up and don't have orientation data yet. 2018-01-12T20:41:37.245Z,1515789697.245 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2018-01-12T20:41:37.245Z,1515789697.245 [DeadReckonUsingMultipleVelocitySources](DEBUG): All data for platform velocity is invalid. 2018-01-12T20:41:37.246Z,1515789697.246 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-12T20:41:37.247Z,1515789697.247 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-01-12T20:41:37.248Z,1515789697.248 [DeadReckonWithRespectToSeafloor](DEBUG): Starting up and don't have orientation data yet. 2018-01-12T20:41:37.640Z,1515789697.640 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2018-01-12T20:41:37.640Z,1515789697.640 [DeadReckonUsingMultipleVelocitySources](DEBUG): All data for platform velocity is invalid. 2018-01-12T20:41:37.641Z,1515789697.641 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-12T20:41:37.642Z,1515789697.642 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-01-12T20:41:37.643Z,1515789697.643 [DeadReckonWithRespectToSeafloor](DEBUG): Starting up and don't have orientation data yet. 2018-01-12T20:41:38.052Z,1515789698.052 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2018-01-12T20:41:38.052Z,1515789698.052 [DeadReckonUsingMultipleVelocitySources](DEBUG): All data for platform velocity is invalid. 2018-01-12T20:41:38.065Z,1515789698.065 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-12T20:41:38.066Z,1515789698.066 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-01-12T20:41:38.067Z,1515789698.067 [DeadReckonWithRespectToSeafloor](DEBUG): Starting up and don't have orientation data yet. 2018-01-12T20:41:38.477Z,1515789698.477 [Aanderaa_O2](INFO): Powering down 2018-01-12T20:41:38.582Z,1515789698.582 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2018-01-12T20:41:38.583Z,1515789698.583 [DeadReckonUsingMultipleVelocitySources](DEBUG): All data for platform velocity is invalid. 2018-01-12T20:41:38.584Z,1515789698.584 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-12T20:41:38.585Z,1515789698.585 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-01-12T20:41:38.586Z,1515789698.586 [DeadReckonWithRespectToSeafloor](DEBUG): Starting up and don't have orientation data yet. 2018-01-12T20:41:38.766Z,1515789698.766 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.003886 2018-01-12T20:41:38.812Z,1515789698.812 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2018-01-12T20:41:38.812Z,1515789698.812 [DeadReckonUsingMultipleVelocitySources](DEBUG): All data for platform velocity is invalid. 2018-01-12T20:41:38.822Z,1515789698.822 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-12T20:41:38.822Z,1515789698.822 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-01-12T20:41:38.823Z,1515789698.823 [DeadReckonWithRespectToSeafloor](DEBUG): Starting up and don't have orientation data yet. 2018-01-12T20:41:39.262Z,1515789699.262 [DeadReckonUsingMultipleVelocitySources](DEBUG): All data for platform velocity is invalid. 2018-01-12T20:41:39.263Z,1515789699.263 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-12T20:41:39.593Z,1515789699.593 [DAT](DEBUG): Teledyne Benthos DAT-900 Series MF Frequency Band Directional Acoustic Transponder version 8.10.9 Jan 3 2000 20:43:24 WARNING: battery low Features enabled [Bearing] CONNECT 2018-01-12T20:41:39.593Z,1515789699.593 [DAT](INFO): Got CONNECT 2018-01-12T20:41:39.605Z,1515789699.605 [DAT](INFO): entering command mode 2018-01-12T20:41:39.679Z,1515789699.679 [DeadReckonUsingMultipleVelocitySources](DEBUG): All data for platform velocity is invalid. 2018-01-12T20:41:39.680Z,1515789699.680 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-12T20:41:39.993Z,1515789699.993 [DAT](DEBUG): checking for command mode acknowledgment 2018-01-12T20:41:40.074Z,1515789700.074 [DeadReckonUsingMultipleVelocitySources](DEBUG): All data for platform velocity is invalid. 2018-01-12T20:41:40.075Z,1515789700.075 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-12T20:41:40.534Z,1515789700.534 [DAT](DEBUG): checking for command mode acknowledgment 2018-01-12T20:41:40.575Z,1515789700.575 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-12T20:41:40.924Z,1515789700.924 [DAT](DEBUG): checking for command mode acknowledgment 2018-01-12T20:41:40.924Z,1515789700.924 [DAT](DEBUG): read user prompt 1: user:1> 2018-01-12T20:41:40.924Z,1515789700.924 [DAT](INFO): command mode acknowledged 2018-01-12T20:41:40.948Z,1515789700.948 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-12T20:41:41.323Z,1515789701.323 [DAT](INFO): setting local address to 2 2018-01-12T20:41:41.410Z,1515789701.410 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-12T20:41:41.723Z,1515789701.723 [DAT](DEBUG): checking for local address setting acknowledgment 2018-01-12T20:41:41.723Z,1515789701.723 [DAT](INFO): set local address to 2 2018-01-12T20:41:41.748Z,1515789701.748 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-12T20:41:42.122Z,1515789702.122 [DAT](DEBUG): read user prompt 2: user:2> 2018-01-12T20:41:42.208Z,1515789702.208 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-12T20:41:42.547Z,1515789702.547 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-12T20:41:43.007Z,1515789703.007 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-12T20:41:43.351Z,1515789703.351 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-12T20:41:43.778Z,1515789703.778 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-12T20:41:44.152Z,1515789704.152 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-12T20:41:44.561Z,1515789704.561 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-12T20:41:45.004Z,1515789705.004 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-12T20:41:45.351Z,1515789705.351 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-12T20:41:45.805Z,1515789705.805 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-12T20:41:46.151Z,1515789706.151 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-12T20:41:46.571Z,1515789706.571 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-12T20:41:46.964Z,1515789706.964 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-12T20:41:47.369Z,1515789707.369 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-12T20:41:47.755Z,1515789707.755 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-12T20:41:48.155Z,1515789708.155 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-12T20:41:48.592Z,1515789708.592 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-12T20:41:48.999Z,1515789708.999 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-12T20:41:49.416Z,1515789709.416 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-12T20:41:49.747Z,1515789709.747 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-12T20:41:50.181Z,1515789710.181 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-12T20:41:50.547Z,1515789710.547 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-12T20:41:50.959Z,1515789710.959 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-12T20:41:51.351Z,1515789711.351 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-12T20:41:51.751Z,1515789711.751 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-12T20:41:52.200Z,1515789712.200 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-12T20:41:52.597Z,1515789712.597 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-12T20:41:52.963Z,1515789712.963 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-12T20:41:53.372Z,1515789713.372 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-12T20:41:53.780Z,1515789713.780 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-12T20:41:54.193Z,1515789714.193 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-12T20:41:54.538Z,1515789714.538 [NAL9602](INFO): Powering up NAL9602 2018-01-12T20:41:54.674Z,1515789714.674 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-12T20:41:54.955Z,1515789714.955 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-12T20:41:55.353Z,1515789715.353 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-12T20:41:55.759Z,1515789715.759 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-12T20:41:56.151Z,1515789716.151 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-12T20:41:56.585Z,1515789716.585 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-12T20:41:56.838Z,1515789716.838 [CommandLine](IMPORTANT): got command get PNI_TCM.platform_magnetic_orientation degree 2018-01-12T20:41:56.839Z,1515789716.839 [CommandLine](IMPORTANT): PNI_TCM.platform_magnetic_orientation 250.210238 arcdeg 2018-01-12T20:41:56.959Z,1515789716.959 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-12T20:41:57.347Z,1515789717.347 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-12T20:41:57.747Z,1515789717.747 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-12T20:41:58.151Z,1515789718.151 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-12T20:41:58.552Z,1515789718.552 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-12T20:41:58.951Z,1515789718.951 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-12T20:41:59.351Z,1515789719.351 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-12T20:41:59.758Z,1515789719.758 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-12T20:42:00.190Z,1515789720.190 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-12T20:42:00.547Z,1515789720.547 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-12T20:42:01.007Z,1515789721.007 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-12T20:42:01.362Z,1515789721.362 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-12T20:42:01.797Z,1515789721.797 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-12T20:42:02.195Z,1515789722.195 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-12T20:42:02.557Z,1515789722.557 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-12T20:42:02.975Z,1515789722.975 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-12T20:42:03.360Z,1515789723.360 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-12T20:42:03.772Z,1515789723.772 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-12T20:42:04.163Z,1515789724.163 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-12T20:42:04.546Z,1515789724.546 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-12T20:42:04.979Z,1515789724.979 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-12T20:42:05.006Z,1515789725.006 [CommandLine](IMPORTANT): got command quit 2018-01-12T20:42:05.391Z,1515789725.391 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-12T20:42:05.718Z,1515789725.718 [NAL9602](INFO): NAL9602 initialized 2018-01-12T20:42:05.786Z,1515789725.786 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-12T20:42:06.009Z,1515789726.009 [Supervisor](INFO): Stop Mission called by Supervisor::terminate 2018-01-12T20:42:06.012Z,1515789726.012 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2018-01-12T20:42:06.012Z,1515789726.012 [CommandLine ThreadHandler](INFO): Thread cancelled. 2018-01-12T20:42:06.121Z,1515789726.121 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2018-01-12T20:42:06.121Z,1515789726.121 [CommandLine ThreadHandler](INFO): Thread cancelled. 2018-01-12T20:42:06.122Z,1515789726.122 [CommandLine](INFO): Join timeout helper Thread ID is 565 2018-01-12T20:42:06.133Z,1515789726.133 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2018-01-12T20:42:06.133Z,1515789726.133 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2018-01-12T20:42:06.135Z,1515789726.135 [NavChartDb](INFO): Join timeout helper Thread ID is 566 2018-01-12T20:42:06.226Z,1515789726.226 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-12T20:42:06.283Z,1515789726.283 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2018-01-12T20:42:06.284Z,1515789726.284 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2018-01-12T20:42:06.289Z,1515789726.289 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2018-01-12T20:42:06.289Z,1515789726.289 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2018-01-12T20:42:06.289Z,1515789726.289 [Radio_Surface](INFO): Join timeout helper Thread ID is 567 2018-01-12T20:42:06.509Z,1515789726.509 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2018-01-12T20:42:06.509Z,1515789726.509 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2018-01-12T20:42:06.521Z,1515789726.521 [ComponentRegistry](INFO): Shutting down WetLabsSeaOWL_UV_A ThreadHandler 2018-01-12T20:42:06.521Z,1515789726.521 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Thread cancelled. 2018-01-12T20:42:06.521Z,1515789726.521 [WetLabsSeaOWL_UV_A](INFO): Join timeout helper Thread ID is 568 2018-01-12T20:42:06.566Z,1515789726.566 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-12T20:42:06.619Z,1515789726.619 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Uninitializing protected caller thread. 2018-01-12T20:42:06.620Z,1515789726.620 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Thread cancelled. 2018-01-12T20:42:06.629Z,1515789726.629 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler 2018-01-12T20:42:06.629Z,1515789726.629 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2018-01-12T20:42:06.629Z,1515789726.629 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 569 2018-01-12T20:42:06.853Z,1515789726.853 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread. 2018-01-12T20:42:06.853Z,1515789726.853 [WetLabsBB2FL](INFO): Powering down 2018-01-12T20:42:06.854Z,1515789726.854 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2018-01-12T20:42:06.874Z,1515789726.874 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler 2018-01-12T20:42:06.874Z,1515789726.874 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2018-01-12T20:42:06.874Z,1515789726.874 [CTD_Seabird](INFO): Join timeout helper Thread ID is 570 2018-01-12T20:42:06.967Z,1515789726.967 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2018-01-12T20:42:07.101Z,1515789727.101 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread. 2018-01-12T20:42:07.187Z,1515789727.187 [CTD_Seabird](INFO): Stopping potential previous instance(s) of CTD_Seabird LCM interface 2018-01-12T20:42:07.187Z,1515789727.187 [CTD_Seabird](INFO): Powering down 2018-01-12T20:42:07.188Z,1515789727.188 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2018-01-12T20:42:07.194Z,1515789727.194 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2018-01-12T20:42:07.194Z,1515789727.194 [logger ThreadHandler](INFO): Thread cancelled. 2018-01-12T20:42:07.194Z,1515789727.194 [logger](INFO): Join timeout helper Thread ID is 572 2018-01-12T20:42:07.225Z,1515789727.225 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2018-01-12T20:42:07.225Z,1515789727.225 [logger ThreadHandler](INFO): Thread cancelled. 2018-01-12T20:42:07.234Z,1515789727.234 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2018-01-12T20:42:07.234Z,1515789727.234 [CommandLine ThreadHandler](INFO): Thread cancelled. 2018-01-12T20:42:07.234Z,1515789727.234 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2018-01-12T20:42:07.234Z,1515789727.234 [controlThread ThreadHandler](INFO): Thread cancelled. 2018-01-12T20:42:07.235Z,1515789727.235 [controlThread](INFO): Join timeout helper Thread ID is 573 2018-01-12T20:42:07.293Z,1515789727.293 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2018-01-12T20:42:07.293Z,1515789727.293 [controlThread](DEBUG): Uninitializing ControlThread 2018-01-12T20:42:07.294Z,1515789727.294 [Aanderaa_O2](INFO): Powering down 2018-01-12T20:42:07.297Z,1515789727.297 [NAL9602](INFO): Powering down 2018-01-12T20:42:07.308Z,1515789727.308 [DAT](INFO): Powering down 2018-01-12T20:42:07.429Z,1515789727.429 [PNI_TCM](INFO): Powering down 2018-01-12T20:42:07.518Z,1515789727.518 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2018-01-12T20:42:07.520Z,1515789727.520 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2018-01-12T20:42:07.520Z,1515789727.520 [MissionManager](INFO): Uninitializing Mission Default 2018-01-12T20:42:07.523Z,1515789727.523 [MissionManager](INFO): Uninitializing Mission Startup 2018-01-12T20:42:07.524Z,1515789727.524 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2018-01-12T20:42:07.525Z,1515789727.525 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2018-01-12T20:42:07.525Z,1515789727.525 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2018-01-12T20:42:07.525Z,1515789727.525 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2018-01-12T20:42:07.526Z,1515789727.526 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2018-01-12T20:42:07.526Z,1515789727.526 [BuoyancyServo](INFO): Powering down 2018-01-12T20:42:07.541Z,1515789727.541 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2018-01-12T20:42:07.541Z,1515789727.541 [ElevatorServo](INFO): Powering down 2018-01-12T20:42:07.560Z,1515789727.560 [MassServo](DEBUG): Uninitialize Mass Servo. 2018-01-12T20:42:07.560Z,1515789727.560 [MassServo](INFO): Powering down 2018-01-12T20:42:07.561Z,1515789727.561 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2018-01-12T20:42:07.561Z,1515789727.561 [RudderServo](INFO): Powering down 2018-01-12T20:42:07.562Z,1515789727.562 [ThrusterServo](DEBUG): Uninitialize Thruster Servo. 2018-01-12T20:42:07.562Z,1515789727.562 [ThrusterServo](INFO): Powering down 2018-01-12T20:42:07.563Z,1515789727.563 [SBIT](DEBUG): Uninitialize SBIT Component. 2018-01-12T20:42:07.564Z,1515789727.564 [IBIT](DEBUG): Uninitialize IBIT Component. 2018-01-12T20:42:07.564Z,1515789727.564 [CBIT](DEBUG): Uninitialize CBIT Component. 2018-01-12T20:42:07.565Z,1515789727.565 [controlThread ThreadHandler](INFO): Thread cancelled. 2018-01-12T20:42:07.624Z,1515789727.624 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Thread cancelled. 2018-01-12T20:42:07.628Z,1515789727.628 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2018-01-12T20:42:07.633Z,1515789727.633 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2018-01-12T20:42:07.698Z,1515789727.698 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2018-01-12T20:42:07.973Z,1515789727.973 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2018-01-12T20:42:08.014Z,1515789728.014 [logger ThreadHandler](INFO): Thread cancelled.