2019-02-16T16:38:54.957Z,1550335134.957 [Supervisor](DEBUG): Initializing supervisor. 2019-02-16T16:38:54.960Z,1550335134.960 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2019-02-16T16:38:54.961Z,1550335134.961 [SyncHandler](INFO): Protected caller Thread ID is 1512 2019-02-16T16:38:54.961Z,1550335134.961 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2019-02-16T16:38:54.962Z,1550335134.962 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2019-02-16T16:38:54.962Z,1550335134.962 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 1513 2019-02-16T16:38:54.965Z,1550335134.965 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2019-02-16T16:38:54.977Z,1550335134.977 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2019-02-16T16:38:54.979Z,1550335134.979 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2019-02-16T16:38:54.980Z,1550335134.980 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 1514 2019-02-16T16:38:54.981Z,1550335134.981 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2019-02-16T16:38:54.982Z,1550335134.982 [logger ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2019-02-16T16:38:54.982Z,1550335134.982 [logger ThreadHandler](INFO): Protected caller Thread ID is 1515 2019-02-16T16:38:54.985Z,1550335134.985 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2019-02-16T16:38:54.985Z,1550335134.985 [Supervisor](INFO): Looking for Config files in directory: Config/ 2019-02-16T16:38:54.987Z,1550335134.987 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2019-02-16T16:38:55.083Z,1550335135.083 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2019-02-16T16:38:55.084Z,1550335135.084 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2019-02-16T16:38:55.287Z,1550335135.287 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2019-02-16T16:38:55.288Z,1550335135.288 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2019-02-16T16:38:55.428Z,1550335135.428 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2019-02-16T16:38:55.428Z,1550335135.428 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2019-02-16T16:38:55.912Z,1550335135.912 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2019-02-16T16:38:55.912Z,1550335135.912 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2019-02-16T16:38:56.370Z,1550335136.370 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2019-02-16T16:38:56.371Z,1550335136.371 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2019-02-16T16:38:57.020Z,1550335137.020 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2019-02-16T16:38:57.021Z,1550335137.021 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2019-02-16T16:38:57.338Z,1550335137.338 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2019-02-16T16:38:57.339Z,1550335137.339 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2019-02-16T16:38:57.702Z,1550335137.702 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2019-02-16T16:38:57.703Z,1550335137.703 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2019-02-16T16:38:58.104Z,1550335138.104 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2019-02-16T16:38:58.104Z,1550335138.104 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2019-02-16T16:38:58.257Z,1550335138.257 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2019-02-16T16:38:58.258Z,1550335138.258 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2019-02-16T16:38:58.368Z,1550335138.368 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2019-02-16T16:38:58.368Z,1550335138.368 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2019-02-16T16:38:58.450Z,1550335138.450 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2019-02-16T16:38:58.554Z,1550335138.554 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample 2019-02-16T16:38:58.555Z,1550335138.555 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2019-02-16T16:38:58.759Z,1550335138.759 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2019-02-16T16:38:58.759Z,1550335138.759 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2019-02-16T16:38:58.972Z,1550335138.972 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2019-02-16T16:38:58.974Z,1550335138.974 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-makai/ 2019-02-16T16:38:58.975Z,1550335138.975 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/secure.cfg 2019-02-16T16:38:59.060Z,1550335139.060 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Battery.cfg 2019-02-16T16:38:59.297Z,1550335139.297 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2019-02-16T16:38:59.297Z,1550335139.297 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Navigation.cfg 2019-02-16T16:38:59.395Z,1550335139.395 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Sensor.cfg 2019-02-16T16:38:59.560Z,1550335139.560 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/vehicle.cfg 2019-02-16T16:38:59.773Z,1550335139.773 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Simulator.cfg 2019-02-16T16:38:59.859Z,1550335139.859 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Servo.cfg 2019-02-16T16:38:59.959Z,1550335139.959 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Control.cfg 2019-02-16T16:39:00.054Z,1550335140.054 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Science.cfg 2019-02-16T16:39:00.210Z,1550335140.210 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/logger.cfg 2019-02-16T16:39:00.317Z,1550335140.317 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/BIT.cfg 2019-02-16T16:39:00.417Z,1550335140.417 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-makai/root/ 2019-02-16T16:39:00.418Z,1550335140.418 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg 2019-02-16T16:39:00.421Z,1550335140.421 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2019-02-16T16:39:00.522Z,1550335140.522 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2019-02-16T16:39:00.523Z,1550335140.523 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2019-02-16T16:39:00.648Z,1550335140.648 [BuoyancyServo] Loaded 2019-02-16T16:39:00.649Z,1550335140.649 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2019-02-16T16:39:00.664Z,1550335140.664 [ElevatorServo] Loaded 2019-02-16T16:39:00.664Z,1550335140.664 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2019-02-16T16:39:00.679Z,1550335140.679 [MassServo] Loaded 2019-02-16T16:39:00.679Z,1550335140.679 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2019-02-16T16:39:00.695Z,1550335140.695 [RudderServo] Loaded 2019-02-16T16:39:00.695Z,1550335140.695 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2019-02-16T16:39:00.709Z,1550335140.709 [ThrusterServo] Loaded 2019-02-16T16:39:00.709Z,1550335140.709 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread. 2019-02-16T16:39:00.710Z,1550335140.710 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2019-02-16T16:39:00.710Z,1550335140.710 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2019-02-16T16:39:00.842Z,1550335140.842 [SBIT](DEBUG): Construct Startup Built In Test. 2019-02-16T16:39:00.871Z,1550335140.871 [SBIT] Loaded 2019-02-16T16:39:00.871Z,1550335140.871 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2019-02-16T16:39:00.872Z,1550335140.872 [IBIT](DEBUG): Construct Initiated Built In Test. 2019-02-16T16:39:00.901Z,1550335140.901 [IBIT] Loaded 2019-02-16T16:39:00.901Z,1550335140.901 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2019-02-16T16:39:00.904Z,1550335140.904 [CBIT](DEBUG): Construct Continuous Built In Test. 2019-02-16T16:39:01.296Z,1550335141.296 [CBIT] Loaded 2019-02-16T16:39:01.296Z,1550335141.296 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2019-02-16T16:39:01.297Z,1550335141.297 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2019-02-16T16:39:01.297Z,1550335141.297 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2019-02-16T16:39:01.474Z,1550335141.474 [Aanderaa_O2] Loaded 2019-02-16T16:39:01.474Z,1550335141.474 [ComponentRegistry](DEBUG): SyncComponent "Aanderaa_O2" handled in the control thread. 2019-02-16T16:39:01.484Z,1550335141.484 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_density 2019-02-16T16:39:01.489Z,1550335141.489 [CTD_Seabird](INFO): created writer for : sea_water_density 2019-02-16T16:39:01.491Z,1550335141.491 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): depth 2019-02-16T16:39:01.495Z,1550335141.495 [CTD_Seabird](INFO): created writer for : depth 2019-02-16T16:39:01.496Z,1550335141.496 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_pressure 2019-02-16T16:39:01.501Z,1550335141.501 [CTD_Seabird](INFO): created writer for : sea_water_pressure 2019-02-16T16:39:01.502Z,1550335141.502 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_salinity 2019-02-16T16:39:01.507Z,1550335141.507 [CTD_Seabird](INFO): created writer for : sea_water_salinity 2019-02-16T16:39:01.507Z,1550335141.507 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_temperature 2019-02-16T16:39:01.513Z,1550335141.513 [CTD_Seabird](INFO): created writer for : sea_water_temperature 2019-02-16T16:39:01.514Z,1550335141.514 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_electrical_conductivity 2019-02-16T16:39:01.519Z,1550335141.519 [CTD_Seabird](INFO): created writer for : sea_water_electrical_conductivity 2019-02-16T16:39:01.520Z,1550335141.520 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): speed_of_sound_in_sea_water 2019-02-16T16:39:01.525Z,1550335141.525 [CTD_Seabird](INFO): created writer for : speed_of_sound_in_sea_water 2019-02-16T16:39:01.552Z,1550335141.552 [CTD_Seabird] Loaded 2019-02-16T16:39:01.552Z,1550335141.552 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread. 2019-02-16T16:39:01.553Z,1550335141.553 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 4062F4E0 2019-02-16T16:39:01.553Z,1550335141.553 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 1594 2019-02-16T16:39:01.575Z,1550335141.575 [ESPComponent] Loaded 2019-02-16T16:39:01.575Z,1550335141.575 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread. 2019-02-16T16:39:01.589Z,1550335141.589 [PAR_Licor] Loaded 2019-02-16T16:39:01.590Z,1550335141.590 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread. 2019-02-16T16:39:01.638Z,1550335141.638 [WetLabsBB2FL] Loaded 2019-02-16T16:39:01.638Z,1550335141.638 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread. 2019-02-16T16:39:01.639Z,1550335141.639 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 4065F4E0 2019-02-16T16:39:01.640Z,1550335141.640 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 1595 2019-02-16T16:39:01.640Z,1550335141.640 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2019-02-16T16:39:01.641Z,1550335141.641 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2019-02-16T16:39:01.800Z,1550335141.800 [DepthRateCalculator] Loaded 2019-02-16T16:39:01.801Z,1550335141.801 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2019-02-16T16:39:01.826Z,1550335141.826 [PitchRateCalculator] Loaded 2019-02-16T16:39:01.827Z,1550335141.827 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2019-02-16T16:39:01.883Z,1550335141.883 [SpeedCalculator] Loaded 2019-02-16T16:39:01.883Z,1550335141.883 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2019-02-16T16:39:01.979Z,1550335141.979 [TempGradientCalculator] Loaded 2019-02-16T16:39:01.979Z,1550335141.979 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread. 2019-02-16T16:39:02.029Z,1550335142.029 [YawRateCalculator] Loaded 2019-02-16T16:39:02.029Z,1550335142.029 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2019-02-16T16:39:02.121Z,1550335142.121 [ElevatorOffsetCalculator] Loaded 2019-02-16T16:39:02.121Z,1550335142.121 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread. 2019-02-16T16:39:02.122Z,1550335142.122 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2019-02-16T16:39:02.123Z,1550335142.123 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2019-02-16T16:39:02.221Z,1550335142.221 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2019-02-16T16:39:02.221Z,1550335142.221 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2019-02-16T16:39:02.473Z,1550335142.473 [DeadReckonUsingMultipleVelocitySources] Loaded 2019-02-16T16:39:02.473Z,1550335142.473 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2019-02-16T16:39:02.533Z,1550335142.533 [DeadReckonUsingSpeedCalculator] Loaded 2019-02-16T16:39:02.534Z,1550335142.534 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread. 2019-02-16T16:39:02.660Z,1550335142.660 [DeadReckonWithRespectToSeafloor] Loaded 2019-02-16T16:39:02.661Z,1550335142.661 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonWithRespectToSeafloor" handled in the control thread. 2019-02-16T16:39:02.677Z,1550335142.677 [NavChart] Loaded 2019-02-16T16:39:02.677Z,1550335142.677 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2019-02-16T16:39:02.681Z,1550335142.681 [UniversalFixResidualReporter] Loaded 2019-02-16T16:39:02.682Z,1550335142.682 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2019-02-16T16:39:02.682Z,1550335142.682 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2019-02-16T16:39:02.683Z,1550335142.683 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2019-02-16T16:39:02.972Z,1550335142.972 [AcousticModem_Benthos_ATM900] Loaded 2019-02-16T16:39:02.972Z,1550335142.972 [ComponentRegistry](DEBUG): SyncComponent "AcousticModem_Benthos_ATM900" handled in the control thread. 2019-02-16T16:39:03.045Z,1550335143.045 [DataOverHttps] Loaded 2019-02-16T16:39:03.046Z,1550335143.046 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread. 2019-02-16T16:39:03.047Z,1550335143.047 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 409274E0 2019-02-16T16:39:03.047Z,1550335143.047 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 1596 2019-02-16T16:39:03.060Z,1550335143.060 [Depth_Keller] Loaded 2019-02-16T16:39:03.061Z,1550335143.061 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2019-02-16T16:39:03.152Z,1550335143.152 [NAL9602] Loaded 2019-02-16T16:39:03.152Z,1550335143.152 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2019-02-16T16:39:03.157Z,1550335143.157 [Onboard] Loaded 2019-02-16T16:39:03.158Z,1550335143.158 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread. 2019-02-16T16:39:03.161Z,1550335143.161 [Radio_Surface] Loaded 2019-02-16T16:39:03.161Z,1550335143.161 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2019-02-16T16:39:03.162Z,1550335143.162 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 409574E0 2019-02-16T16:39:03.163Z,1550335143.163 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 1597 2019-02-16T16:39:03.210Z,1550335143.210 [PNI_TCM] Loaded 2019-02-16T16:39:03.210Z,1550335143.210 [ComponentRegistry](DEBUG): SyncComponent "PNI_TCM" handled in the control thread. 2019-02-16T16:39:03.271Z,1550335143.271 [Rowe_600LCM] Loaded 2019-02-16T16:39:03.271Z,1550335143.271 [ComponentRegistry](DEBUG): Component "Rowe_600LCM" handled in its own thread. 2019-02-16T16:39:03.272Z,1550335143.272 [Rowe_600LCM ThreadHandler](DEBUG): Created PCaller Thread at 409874E0 2019-02-16T16:39:03.272Z,1550335143.272 [Rowe_600LCM ThreadHandler](INFO): Protected caller Thread ID is 1598 2019-02-16T16:39:04.919Z,1550335144.919 [BPC1] Loaded 2019-02-16T16:39:04.919Z,1550335144.919 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2019-02-16T16:39:04.919Z,1550335144.919 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2019-02-16T16:39:04.920Z,1550335144.920 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2019-02-16T16:39:04.985Z,1550335144.985 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2019-02-16T16:39:04.985Z,1550335144.985 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2019-02-16T16:39:05.053Z,1550335145.053 [VerticalControl](DEBUG): Construct VerticalControl. 2019-02-16T16:39:05.139Z,1550335145.139 [VerticalControl] Loaded 2019-02-16T16:39:05.139Z,1550335145.139 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2019-02-16T16:39:05.140Z,1550335145.140 [HorizontalControl](DEBUG): Construct HorizontalControl. 2019-02-16T16:39:05.198Z,1550335145.198 [HorizontalControl] Loaded 2019-02-16T16:39:05.198Z,1550335145.198 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2019-02-16T16:39:05.199Z,1550335145.199 [SpeedControl](DEBUG): Construct SpeedControl. 2019-02-16T16:39:05.200Z,1550335145.200 [SpeedControl] Loaded 2019-02-16T16:39:05.201Z,1550335145.201 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2019-02-16T16:39:05.201Z,1550335145.201 [LoopControl](DEBUG): Construct LoopControl. 2019-02-16T16:39:05.202Z,1550335145.202 [LoopControl] Loaded 2019-02-16T16:39:05.202Z,1550335145.202 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2019-02-16T16:39:05.203Z,1550335145.203 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2019-02-16T16:39:05.203Z,1550335145.203 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2019-02-16T16:39:05.216Z,1550335145.216 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2019-02-16T16:39:05.217Z,1550335145.217 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2019-02-16T16:39:05.451Z,1550335145.451 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2019-02-16T16:39:05.454Z,1550335145.454 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2019-02-16T16:39:05.455Z,1550335145.455 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2019-02-16T16:39:05.462Z,1550335145.462 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2019-02-16T16:39:05.463Z,1550335145.463 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40AA94E0 2019-02-16T16:39:05.464Z,1550335145.464 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 1599 2019-02-16T16:39:05.468Z,1550335145.468 [Supervisor](INFO): Main Thread ID is 807 2019-02-16T16:39:05.468Z,1550335145.468 [Supervisor](DEBUG): Running supervisor. 2019-02-16T16:39:05.469Z,1550335145.469 [CommandLine ThreadHandler](INFO): Handler Thread ID is 1600 2019-02-16T16:39:05.471Z,1550335145.471 [controlThread ThreadHandler](INFO): Handler Thread ID is 1601 2019-02-16T16:39:05.472Z,1550335145.472 [controlThread](DEBUG): Initializing ControlThread 2019-02-16T16:39:05.474Z,1550335145.474 [SBIT](INFO): Initialize SBIT Component. 2019-02-16T16:39:05.474Z,1550335145.474 [SBIT](IMPORTANT): git: 2019-02-11-18-g088f29c 2019-02-16T16:39:05.474Z,1550335145.474 [SBIT](INFO): git hash: 088f29c08f1651a006237423a6ffed1cbba6c6ba 2019-02-16T16:39:05.475Z,1550335145.475 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2019-02-16T16:39:05.476Z,1550335145.476 [SBIT](INFO): Kernel Reporting Different Version From Configuration. Kernel Expected: #2 PREEMPT Thu Jan 11 20:13:48 PST 2018 Kernel Reported: #1 PREEMPT Tue Dec 18 21:19:28 PST 2018 2019-02-16T16:39:05.477Z,1550335145.477 [SBIT](INFO): Beginning SBIT in 24.000000 seconds. 2019-02-16T16:39:05.478Z,1550335145.478 [IBIT](INFO): Initialize IBIT Component. 2019-02-16T16:39:05.479Z,1550335145.479 [CBIT](DEBUG): Initialize CBIT Component. 2019-02-16T16:39:05.479Z,1550335145.479 [logger ThreadHandler](INFO): Handler Thread ID is 1602 2019-02-16T16:39:05.490Z,1550335145.490 [CBIT](DEBUG): Initialized mux pins. 2019-02-16T16:39:05.490Z,1550335145.490 [CBIT](DEBUG): Initializing the watchdog timer. 2019-02-16T16:39:05.498Z,1550335145.498 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 1603 2019-02-16T16:39:05.499Z,1550335145.499 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2019-02-16T16:39:05.503Z,1550335145.503 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20 2019-02-16T16:39:05.504Z,1550335145.504 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 1605 2019-02-16T16:39:05.505Z,1550335145.505 [WetLabsBB2FL](INFO): Powering down 2019-02-16T16:39:05.514Z,1550335145.514 [CBIT](INFO): Last reboot was NOT due to watchdog timer. 2019-02-16T16:39:05.514Z,1550335145.514 [CBIT](DEBUG): Initializing heartbeat. 2019-02-16T16:39:05.554Z,1550335145.554 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 1606 2019-02-16T16:39:05.555Z,1550335145.555 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2019-02-16T16:39:05.586Z,1550335145.586 [CBIT](DEBUG): Deactivating GF circuits. 2019-02-16T16:39:05.586Z,1550335145.586 [CBIT](DEBUG): Deactivating emergency mode. 2019-02-16T16:39:05.587Z,1550335145.587 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 1607 2019-02-16T16:39:05.614Z,1550335145.614 [Rowe_600LCM ThreadHandler](INFO): Handler Thread ID is 1608 2019-02-16T16:39:05.615Z,1550335145.615 [Rowe_600LCM](INFO): Initializing 2019-02-16T16:39:05.626Z,1550335145.626 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2019-02-16T16:39:05.627Z,1550335145.627 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2019-02-16T16:39:05.627Z,1550335145.627 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2019-02-16T16:39:05.627Z,1550335145.627 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator. 2019-02-16T16:39:05.628Z,1550335145.628 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2019-02-16T16:39:05.628Z,1550335145.628 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator. 2019-02-16T16:39:05.629Z,1550335145.629 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2019-02-16T16:39:05.632Z,1550335145.632 [Rowe_600LCM](INFO): Powering up 2019-02-16T16:39:05.633Z,1550335145.633 [NavChart](DEBUG): Initialize NavChart Navigation. 2019-02-16T16:39:05.633Z,1550335145.633 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2019-02-16T16:39:05.640Z,1550335145.640 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2019-02-16T16:39:05.641Z,1550335145.641 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2019-02-16T16:39:05.650Z,1550335145.650 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2019-02-16T16:39:05.651Z,1550335145.651 [LoopControl](DEBUG): Initialize LoopControlComponent. 2019-02-16T16:39:05.652Z,1550335145.652 [MissionManager](INFO): Loading Mission: Missions/Startup.xml 2019-02-16T16:39:05.671Z,1550335145.671 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 1609 2019-02-16T16:39:05.677Z,1550335145.677 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000 2019-02-16T16:39:05.677Z,1550335145.677 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000 2019-02-16T16:39:05.677Z,1550335145.677 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000 2019-02-16T16:39:05.678Z,1550335145.678 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000 2019-02-16T16:39:05.678Z,1550335145.678 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000 2019-02-16T16:39:05.678Z,1550335145.678 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000 2019-02-16T16:39:05.678Z,1550335145.678 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000 2019-02-16T16:39:05.679Z,1550335145.679 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000 2019-02-16T16:39:05.679Z,1550335145.679 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000 2019-02-16T16:39:05.679Z,1550335145.679 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000 2019-02-16T16:39:05.679Z,1550335145.679 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000 2019-02-16T16:39:05.679Z,1550335145.679 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000 2019-02-16T16:39:05.680Z,1550335145.680 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000 2019-02-16T16:39:05.680Z,1550335145.680 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000 2019-02-16T16:39:05.680Z,1550335145.680 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000 2019-02-16T16:39:05.680Z,1550335145.680 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000 2019-02-16T16:39:05.719Z,1550335145.719 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2019-02-16T16:39:05.759Z,1550335145.759 [MissionManager](DEBUG): 2019-02-16T16:39:05.759Z,1550335145.759 [MissionManager](INFO): Loading Mission: Missions/Default.xml 2019-02-16T16:39:05.876Z,1550335145.876 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min 2019-02-16T16:39:05.877Z,1550335145.877 [Default:A.Wait](DEBUG): Construct Wait. 2019-02-16T16:39:05.879Z,1550335145.879 [Default:B.GoToSurface](DEBUG): Construct GoToSurface. 2019-02-16T16:39:05.949Z,1550335145.949 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2019-02-16T16:39:05.983Z,1550335145.983 [Default:CheckIn:C.Wait](DEBUG): Construct Wait. 2019-02-16T16:39:05.990Z,1550335145.990 [Radio_Surface](INFO): Powering up 2019-02-16T16:39:05.996Z,1550335145.996 [Default:E.Execute](DEBUG): Construct Execute. 2019-02-16T16:39:06.020Z,1550335146.020 [MissionManager](DEBUG): 0 Wait a moment to see if the scheduler starts a new mission before starting to actually run Default. 13 Burn on Dropped weight due to communications timeout. 5 Default mission has been running for Restarting logs and Default mission. restart logs 2019-02-16T16:39:06.025Z,1550335146.025 [controlThread](DEBUG): Component order: CycleStarter,Aanderaa_O2,ESPComponent,PAR_Licor,AcousticModem_Benthos_ATM900,Depth_Keller,NAL9602,Onboard,PNI_TCM,BPC1,PAR_Licor,Depth_Keller,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,DeadReckonUsingSpeedCalculator,DeadReckonWithRespectToSeafloor,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter, 2019-02-16T16:39:06.096Z,1550335146.096 [ESPComponent](INFO): powering down ESP 2019-02-16T16:39:06.549Z,1550335146.549 [AcousticModem_Benthos_ATM900](INFO): Powering up 2019-02-16T16:39:06.549Z,1550335146.549 [AcousticModem_Benthos_ATM900](DEBUG): Initializing AcousticModem_Benthos_ATM900. 2019-02-16T16:39:07.283Z,1550335147.283 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2019-02-16T16:39:07.289Z,1550335147.289 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2019-02-16T16:39:07.335Z,1550335147.335 [ElevatorServo](DEBUG): Initializing EZServoServo. 2019-02-16T16:39:07.347Z,1550335147.347 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2019-02-16T16:39:07.366Z,1550335147.366 [MassServo](DEBUG): Initializing EZServoServo. 2019-02-16T16:39:07.386Z,1550335147.386 [MassServo](DEBUG): Initializing MassServo. 2019-02-16T16:39:07.417Z,1550335147.417 [RudderServo](DEBUG): Initializing EZServoServo. 2019-02-16T16:39:07.434Z,1550335147.434 [RudderServo](DEBUG): Initializing RudderServo. 2019-02-16T16:39:07.444Z,1550335147.444 [ThrusterServo](DEBUG): Initializing EZServoServo. 2019-02-16T16:39:07.454Z,1550335147.454 [ThrusterServo](DEBUG): Initializing ThrusterServo. 2019-02-16T16:39:10.116Z,1550335150.116 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of Rowe LCM interface 2019-02-16T16:39:10.337Z,1550335150.337 [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 9600 >& /dev/null & 2019-02-16T16:39:11.370Z,1550335151.370 [Aanderaa_O2](INFO): Powering down 2019-02-16T16:39:12.535Z,1550335152.535 [CTD_Seabird](ERROR): Device message queue exceeded the allowed limit. 2019-02-16T16:39:13.839Z,1550335153.839 [AcousticModem_Benthos_ATM900](DEBUG): 2019-02-16T16:39:15.456Z,1550335155.456 [AcousticModem_Benthos_ATM900](DEBUG): Teledyne Benthos ATM-900 Series OEM w/burn wire 2019-02-16T16:39:15.457Z,1550335155.457 [AcousticModem_Benthos_ATM900](DEBUG): MF Frequency Band 2019-02-16T16:39:15.457Z,1550335155.457 [AcousticModem_Benthos_ATM900](DEBUG): Standard version 8.6.3 2019-02-16T16:39:15.458Z,1550335155.458 [AcousticModem_Benthos_ATM900](DEBUG): Feb 12 2019 07:12:06 2019-02-16T16:39:15.568Z,1550335155.568 [CBIT](CRITICAL): Environmental Failure. Press:14.864825 PSI. Humidity:28%. Temp:26 C. ABORTING MISSION 2019-02-16T16:39:15.568Z,1550335155.568 [Supervisor](INFO): Stop Mission called by CBIT::monitorEnvironmentals 2019-02-16T16:39:15.859Z,1550335155.859 [AcousticModem_Benthos_ATM900](DEBUG): WARNING: battery low 2019-02-16T16:39:16.096Z,1550335156.096 [CommandLine](FAULT): Scheduling is paused 2019-02-16T16:39:16.097Z,1550335156.097 [CBIT](INFO): Critical error at 20190216T163915 2019-02-16T16:39:16.667Z,1550335156.667 [AcousticModem_Benthos_ATM900](INFO): entering command mode 2019-02-16T16:39:17.071Z,1550335157.071 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment 2019-02-16T16:39:17.071Z,1550335157.071 [AcousticModem_Benthos_ATM900](DEBUG): read user prompt 1: user:1> 2019-02-16T16:39:17.072Z,1550335157.072 [AcousticModem_Benthos_ATM900](INFO): command mode acknowledged 2019-02-16T16:39:17.475Z,1550335157.475 [AcousticModem_Benthos_ATM900](INFO): setting local address to 3 2019-02-16T16:39:17.879Z,1550335157.879 [AcousticModem_Benthos_ATM900](DEBUG): checking for local address setting acknowledgment 2019-02-16T16:39:17.880Z,1550335157.880 [AcousticModem_Benthos_ATM900](INFO): set local address to 3 2019-02-16T16:39:18.284Z,1550335158.284 [AcousticModem_Benthos_ATM900](DEBUG): read user prompt 2: user:2> 2019-02-16T16:39:30.104Z,1550335170.104 [SBIT](IMPORTANT): Beginning Startup BIT 2019-02-16T16:39:30.116Z,1550335170.116 [CBIT](IMPORTANT): Beginning ground fault scan 2019-02-16T16:39:33.383Z,1550335173.383 [NAL9602](INFO): Powering up NAL9602 2019-02-16T16:39:41.184Z,1550335181.184 [CBIT](IMPORTANT): No ground fault detected mA: CHAN A0 (Batt): -0.010038 CHAN A1 (24V): -0.015483 CHAN A2 (12V): -0.005778 CHAN A3 (5V): -0.002925 CHAN B0 (3.3V): -0.001860 CHAN B1 (3.15aV): -0.001249 CHAN B2 (3.15bV): -0.001093 CHAN B3 (GND): -0.000491 OPEN: 0.004700 Full Scale Calc: 4.765 mA, -1.589 mA 2019-02-16T16:39:44.299Z,1550335184.299 [NAL9602](INFO): NAL9602 initialized 2019-02-16T16:39:45.117Z,1550335185.117 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:39:50.363Z,1550335190.363 [CommandLine](IMPORTANT): got command report touch Radio_Surface.radio_surface_power 2019-02-16T16:40:18.248Z,1550335218.248 [CommandLine](IMPORTANT): got command get Radio_Surface.radio_surface_power 2019-02-16T16:40:18.249Z,1550335218.249 [CommandLine](IMPORTANT): Radio_Surface.radio_surface_power 1 enum 2019-02-16T16:40:23.423Z,1550335223.423 [SBIT](IMPORTANT): SBIT PASSED 2019-02-16T16:40:23.468Z,1550335223.468 [CommandLine](IMPORTANT): got command configSet list 2019-02-16T16:40:23.468Z,1550335223.468 [CommandLine](IMPORTANT): Listing configuration overrides from Data/persisted.cfg 2019-02-16T16:40:23.469Z,1550335223.469 [CommandLine](IMPORTANT): DropWeight.loadAtStartup=0 bool; 2019-02-16T16:40:23.830Z,1550335223.830 [MissionManager](IMPORTANT): Started mission Startup 2019-02-16T16:40:23.830Z,1550335223.830 [Startup] Running Loop=1 2019-02-16T16:40:23.831Z,1550335223.831 [Startup](DEBUG): Aggregate::initialize Startup 2019-02-16T16:40:23.831Z,1550335223.831 [Startup:A.GoToSurface] Running Loop=1 2019-02-16T16:40:23.831Z,1550335223.831 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2019-02-16T16:40:23.831Z,1550335223.831 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2019-02-16T16:40:23.832Z,1550335223.832 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2019-02-16T16:40:23.832Z,1550335223.832 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2019-02-16T16:40:23.833Z,1550335223.833 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2019-02-16T16:40:23.833Z,1550335223.833 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2019-02-16T16:40:23.840Z,1550335223.840 [Startup:StartupSatComms] Running Loop=1 2019-02-16T16:40:23.840Z,1550335223.840 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms 2019-02-16T16:40:23.840Z,1550335223.840 [Startup:StartupSatComms:A] Running Loop=1 2019-02-16T16:40:24.223Z,1550335224.223 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix 2019-02-16T16:40:42.308Z,1550335242.308 [CommandLine](IMPORTANT): got command configSet DataOverHttps.verbosity 3.000000 count 2019-02-16T16:40:42.526Z,1550335242.526 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:40:42.930Z,1550335242.930 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:40:43.334Z,1550335243.334 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:40:43.738Z,1550335243.738 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:40:44.142Z,1550335244.142 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:40:44.546Z,1550335244.546 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:40:44.950Z,1550335244.950 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:40:45.354Z,1550335245.354 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:40:45.758Z,1550335245.758 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:40:46.162Z,1550335246.162 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:40:46.566Z,1550335246.566 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:40:46.970Z,1550335246.970 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:40:47.374Z,1550335247.374 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:40:47.778Z,1550335247.778 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:40:48.182Z,1550335248.182 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:40:48.586Z,1550335248.586 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:40:48.990Z,1550335248.990 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:40:49.394Z,1550335249.394 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:40:49.798Z,1550335249.798 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:40:50.202Z,1550335250.202 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:40:50.606Z,1550335250.606 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:40:51.010Z,1550335251.010 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:40:51.414Z,1550335251.414 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:40:51.818Z,1550335251.818 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:40:52.222Z,1550335252.222 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:40:52.626Z,1550335252.626 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:40:53.030Z,1550335253.030 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:40:53.434Z,1550335253.434 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:40:53.838Z,1550335253.838 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:40:54.242Z,1550335254.242 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:40:54.646Z,1550335254.646 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:40:55.050Z,1550335255.050 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:40:55.454Z,1550335255.454 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:40:55.858Z,1550335255.858 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:40:56.262Z,1550335256.262 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:40:56.666Z,1550335256.666 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:40:57.070Z,1550335257.070 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:40:57.474Z,1550335257.474 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:40:57.878Z,1550335257.878 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:40:58.283Z,1550335258.283 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:40:58.686Z,1550335258.686 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:40:59.090Z,1550335259.090 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:40:59.495Z,1550335259.495 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:40:59.898Z,1550335259.898 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:41:00.302Z,1550335260.302 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:41:00.706Z,1550335260.706 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:41:01.110Z,1550335261.110 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:41:01.514Z,1550335261.514 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:41:01.919Z,1550335261.919 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:41:02.322Z,1550335262.322 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:41:02.726Z,1550335262.726 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:41:03.130Z,1550335263.130 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:41:03.534Z,1550335263.534 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:41:03.938Z,1550335263.938 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:41:04.342Z,1550335264.342 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:41:04.746Z,1550335264.746 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:41:05.150Z,1550335265.150 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:41:05.554Z,1550335265.554 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:41:05.878Z,1550335265.878 [Rowe_600LCM](FAULT): Did not receive valid device response within the specified allowable sample time. 2019-02-16T16:41:05.878Z,1550335265.878 [Rowe_600LCM] Communications Fault, FailCount= 1 2019-02-16T16:41:05.878Z,1550335265.878 [Rowe_600LCM](ERROR): Communications Fault 2019-02-16T16:41:05.958Z,1550335265.958 [DataOverHttps](INFO): data state is TCP_CONNECT 2019-02-16T16:41:06.250Z,1550335266.250 [CBIT](ERROR): Communications Fault in component: Rowe_600LCM 2019-02-16T16:41:06.282Z,1550335266.282 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of roweadcp LCM interface 2019-02-16T16:41:06.363Z,1550335266.363 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:41:06.432Z,1550335266.432 [Rowe_600LCM](INFO): Powering down 2019-02-16T16:41:06.766Z,1550335266.766 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:41:07.170Z,1550335267.170 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:41:07.574Z,1550335267.574 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:41:07.849Z,1550335267.849 [CBIT](INFO): Clearing failed state for component Rowe_600LCM 2019-02-16T16:41:07.849Z,1550335267.849 [Rowe_600LCM] No Fault, FailCount= 1 2019-02-16T16:41:07.978Z,1550335267.978 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:41:08.046Z,1550335268.046 [Rowe_600LCM](INFO): Initializing 2019-02-16T16:41:08.047Z,1550335268.047 [Rowe_600LCM](INFO): Powering up 2019-02-16T16:41:08.382Z,1550335268.382 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:41:08.786Z,1550335268.786 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:41:09.190Z,1550335269.190 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:41:09.594Z,1550335269.594 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:41:09.998Z,1550335269.998 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:41:10.402Z,1550335270.402 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:41:10.806Z,1550335270.806 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:41:11.210Z,1550335271.210 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:41:11.614Z,1550335271.614 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:41:12.018Z,1550335272.018 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:41:12.252Z,1550335272.252 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of Rowe LCM interface 2019-02-16T16:41:12.423Z,1550335272.423 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:41:12.457Z,1550335272.457 [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 9600 >& /dev/null & 2019-02-16T16:41:12.826Z,1550335272.826 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:41:13.230Z,1550335273.230 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:41:13.635Z,1550335273.635 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:41:14.038Z,1550335274.038 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:41:14.442Z,1550335274.442 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:41:14.846Z,1550335274.846 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:41:15.250Z,1550335275.250 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:41:15.654Z,1550335275.654 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:41:16.058Z,1550335276.058 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:41:16.462Z,1550335276.462 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:41:16.866Z,1550335276.866 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:41:17.270Z,1550335277.270 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:41:17.676Z,1550335277.676 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:41:18.078Z,1550335278.078 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:41:18.482Z,1550335278.482 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:41:18.886Z,1550335278.886 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:41:19.290Z,1550335279.290 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:41:19.694Z,1550335279.694 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:41:20.098Z,1550335280.098 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:41:20.502Z,1550335280.502 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:41:20.906Z,1550335280.906 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:41:21.310Z,1550335281.310 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:41:21.714Z,1550335281.714 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:41:22.118Z,1550335282.118 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:41:22.522Z,1550335282.522 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:41:22.926Z,1550335282.926 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:41:23.331Z,1550335283.331 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:41:23.734Z,1550335283.734 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:41:24.062Z,1550335284.062 [Startup:StartupSatComms:A](INFO): Timed out from 2019-02-16T16:40:23.8Z 2019-02-16T16:41:24.062Z,1550335284.062 [Startup:StartupSatComms:A] Stopped 2019-02-16T16:41:24.062Z,1550335284.062 [Startup:StartupSatComms:B] Running Loop=1 2019-02-16T16:41:24.138Z,1550335284.138 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:41:24.403Z,1550335284.403 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications 2019-02-16T16:41:24.542Z,1550335284.542 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:41:24.946Z,1550335284.946 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:41:25.350Z,1550335285.350 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:41:25.754Z,1550335285.754 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:41:26.158Z,1550335286.158 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:41:26.562Z,1550335286.562 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:41:26.967Z,1550335286.967 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:41:27.370Z,1550335287.370 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:41:27.774Z,1550335287.774 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:41:28.178Z,1550335288.178 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:41:28.582Z,1550335288.582 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:41:28.986Z,1550335288.986 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:41:29.390Z,1550335289.390 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:41:29.794Z,1550335289.794 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:41:30.198Z,1550335290.198 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:41:30.602Z,1550335290.602 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:41:31.006Z,1550335291.006 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:41:31.410Z,1550335291.410 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:41:31.814Z,1550335291.814 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:41:32.221Z,1550335292.221 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:41:32.622Z,1550335292.622 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:41:33.026Z,1550335293.026 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:41:33.430Z,1550335293.430 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:41:33.834Z,1550335293.834 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:41:34.238Z,1550335294.238 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:41:34.642Z,1550335294.642 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:41:35.046Z,1550335295.046 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:41:35.450Z,1550335295.450 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:41:35.854Z,1550335295.854 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:41:36.258Z,1550335296.258 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:41:36.662Z,1550335296.662 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:41:37.066Z,1550335297.066 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:41:37.470Z,1550335297.470 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:41:37.886Z,1550335297.886 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:41:38.302Z,1550335298.302 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:41:38.719Z,1550335298.719 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:41:39.122Z,1550335299.122 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:41:39.526Z,1550335299.526 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:41:39.930Z,1550335299.930 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:41:40.335Z,1550335300.335 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:41:40.738Z,1550335300.738 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:41:41.142Z,1550335301.142 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:41:41.547Z,1550335301.547 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:41:41.950Z,1550335301.950 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:41:42.358Z,1550335302.358 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:41:42.759Z,1550335302.759 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:41:43.162Z,1550335303.162 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:41:43.566Z,1550335303.566 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:41:43.971Z,1550335303.971 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:41:44.374Z,1550335304.374 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:41:44.778Z,1550335304.778 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:41:45.183Z,1550335305.183 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:41:45.598Z,1550335305.598 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:41:46.004Z,1550335306.004 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:41:46.406Z,1550335306.406 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:41:46.810Z,1550335306.810 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:41:47.214Z,1550335307.214 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:41:47.618Z,1550335307.618 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:41:48.022Z,1550335308.022 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:41:48.426Z,1550335308.426 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:41:48.830Z,1550335308.830 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:41:49.236Z,1550335309.236 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:41:49.638Z,1550335309.638 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:41:50.042Z,1550335310.042 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:41:50.446Z,1550335310.446 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:41:50.850Z,1550335310.850 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:41:51.254Z,1550335311.254 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:41:51.658Z,1550335311.658 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:41:52.062Z,1550335312.062 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:41:52.468Z,1550335312.468 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:41:52.870Z,1550335312.870 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:41:53.274Z,1550335313.274 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:41:53.678Z,1550335313.678 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:41:54.082Z,1550335314.082 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:41:54.486Z,1550335314.486 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:41:54.890Z,1550335314.890 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:41:55.294Z,1550335315.294 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:41:55.700Z,1550335315.700 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:41:56.102Z,1550335316.102 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:41:56.506Z,1550335316.506 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:41:56.910Z,1550335316.910 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:41:57.314Z,1550335317.314 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:41:57.718Z,1550335317.718 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:41:58.122Z,1550335318.122 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:41:58.526Z,1550335318.526 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:41:58.946Z,1550335318.946 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:41:59.350Z,1550335319.350 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:41:59.754Z,1550335319.754 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:42:00.158Z,1550335320.158 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:42:00.562Z,1550335320.562 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:42:00.966Z,1550335320.966 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:42:01.370Z,1550335321.370 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:42:01.774Z,1550335321.774 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:42:02.178Z,1550335322.178 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:42:02.582Z,1550335322.582 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:42:02.986Z,1550335322.986 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:42:03.390Z,1550335323.390 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:42:03.794Z,1550335323.794 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:42:04.198Z,1550335324.198 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:42:04.602Z,1550335324.602 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:42:05.006Z,1550335325.006 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:42:05.410Z,1550335325.410 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:42:05.681Z,1550335325.681 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1 2019-02-16T16:42:05.681Z,1550335325.681 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2019-02-16T16:42:05.682Z,1550335325.682 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 1 2019-02-16T16:42:05.682Z,1550335325.682 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2019-02-16T16:42:05.684Z,1550335325.684 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1 2019-02-16T16:42:05.684Z,1550335325.684 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2019-02-16T16:42:05.696Z,1550335325.696 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2019-02-16T16:42:05.697Z,1550335325.697 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2019-02-16T16:42:05.697Z,1550335325.697 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2019-02-16T16:42:05.814Z,1550335325.814 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:42:06.099Z,1550335326.099 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2019-02-16T16:42:06.099Z,1550335326.099 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1 2019-02-16T16:42:06.100Z,1550335326.100 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2019-02-16T16:42:06.100Z,1550335326.100 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 1 2019-02-16T16:42:06.100Z,1550335326.100 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2019-02-16T16:42:06.100Z,1550335326.100 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1 2019-02-16T16:42:06.218Z,1550335326.218 [DataOverHttps](INFO): data state is TCP_CONNECT 2019-02-16T16:42:06.503Z,1550335326.503 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2019-02-16T16:42:06.622Z,1550335326.622 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:42:07.026Z,1550335327.026 [DataOverHttps](INFO): data state is SSL_CONNECTING 2019-02-16T16:42:07.430Z,1550335327.430 [DataOverHttps](INFO): data state is SSL_CONNECTING 2019-02-16T16:42:07.834Z,1550335327.834 [DataOverHttps](INFO): data state is SSL_CONNECTING 2019-02-16T16:42:08.238Z,1550335328.238 [DataOverHttps](INFO): data state is SSL_CONNECTING 2019-02-16T16:42:11.798Z,1550335331.798 [DataOverHttps](INFO): data state is SSL_CONNECTING 2019-02-16T16:42:12.198Z,1550335332.198 [DataOverHttps](INFO): data state is SSL_CONNECTING 2019-02-16T16:42:12.201Z,1550335332.201 [DataOverHttps](IMPORTANT): dataWrite() sendFilename_: , busy: 1 2019-02-16T16:42:12.201Z,1550335332.201 [DataOverHttps](IMPORTANT): dataWriting 208 bytes: POST /TethysDash/dataLink HTTP/1.1 User-Agent: LRAUV Host: 134.89.2.23:443 Accept: */* Content-Type: application/x-www-form-urlencoded Content-Length: 42 imei=300234060751590&imeiPassword=Hde%603X 2019-02-16T16:42:12.203Z,1550335332.203 [DataOverHttps](IMPORTANT): dataWriting with SSL WROTE 208 bytes: POST /TethysDash/dataLink HTTP/1.1 User-Agent: LRAUV Host: 134.89.2.23:443 Accept: */* Content-Type: application/x-www-form-urlencoded Content-Length: 42 imei=300234060751590&imeiPassword=Hde%603X 2019-02-16T16:42:12.603Z,1550335332.603 [DataOverHttps](INFO): data state is DATA_READ 2019-02-16T16:42:12.604Z,1550335332.604 [DataOverHttps](INFO): dataread() @740 received: 211 2019-02-16T16:42:13.006Z,1550335333.006 [DataOverHttps](INFO): data state is DATA_READ 2019-02-16T16:42:13.007Z,1550335333.007 [DataOverHttps](INFO): dataread() @740 received: 24 2019-02-16T16:42:13.013Z,1550335333.013 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004773 2019-02-16T16:42:13.410Z,1550335333.410 [DataOverHttps](INFO): platform communications requested and available 2019-02-16T16:42:13.537Z,1550335333.537 [DataOverHttps](INFO): queued: Logs/20190216T162912/Courier0004.lzma 2019-02-16T16:42:13.537Z,1550335333.537 [DataOverHttps](INFO): data state is TCP_CONNECT 2019-02-16T16:42:13.814Z,1550335333.814 [DataOverHttps](INFO): platform communications requested and available 2019-02-16T16:42:13.814Z,1550335333.814 [DataOverHttps](INFO): queued: Logs/20190216T162912/Courier0004.lzma 2019-02-16T16:42:13.815Z,1550335333.815 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:42:14.218Z,1550335334.218 [DataOverHttps](INFO): platform communications requested and available 2019-02-16T16:42:14.218Z,1550335334.218 [DataOverHttps](INFO): queued: Logs/20190216T162912/Courier0004.lzma 2019-02-16T16:42:14.219Z,1550335334.219 [DataOverHttps](INFO): data state is SSL_CONNECTING 2019-02-16T16:42:14.622Z,1550335334.622 [DataOverHttps](INFO): platform communications requested and available 2019-02-16T16:42:14.622Z,1550335334.622 [DataOverHttps](INFO): queued: Logs/20190216T162912/Courier0004.lzma 2019-02-16T16:42:14.623Z,1550335334.623 [DataOverHttps](INFO): data state is SSL_CONNECTING 2019-02-16T16:42:15.026Z,1550335335.026 [DataOverHttps](INFO): platform communications requested and available 2019-02-16T16:42:15.027Z,1550335335.027 [DataOverHttps](INFO): queued: Logs/20190216T162912/Courier0004.lzma 2019-02-16T16:42:15.027Z,1550335335.027 [DataOverHttps](INFO): data state is SSL_CONNECTING 2019-02-16T16:42:18.666Z,1550335338.666 [DataOverHttps](INFO): platform communications requested and available 2019-02-16T16:42:18.667Z,1550335338.667 [DataOverHttps](INFO): queued: Logs/20190216T162912/Courier0004.lzma 2019-02-16T16:42:18.667Z,1550335338.667 [DataOverHttps](INFO): data state is SSL_CONNECTING 2019-02-16T16:42:18.669Z,1550335338.669 [DataOverHttps](IMPORTANT): dataWrite() sendFilename_: Logs/20190216T162912/Courier0004.lzma, busy: 0 2019-02-16T16:42:18.670Z,1550335338.670 [DataOverHttps](INFO): Sending 25 bytes from file Logs/20190216T162912/Courier0004.lzma 2019-02-16T16:42:18.671Z,1550335338.671 [DataOverHttps](IMPORTANT): dataWriting 345 bytes: POST /TethysDash/dataLink HTTP/1.1 User-Agent: LRAUV Host: 134.89.2.23:443 Accept: */* Content-Type: application/x-www-form-urlencoded Content-Length: 178 imei=300234060751590&imeiPassword=Hde%603X&filename=Logs/20190216T162912/Courier0004.lzma&fileSize=25&file=%5d%00%00%04%00%08%00%00%00%00%00%00%00%00%15%1d%80%03%0cVi%be%d8%f0%00 2019-02-16T16:42:18.672Z,1550335338.672 [DataOverHttps](IMPORTANT): dataWriting with SSL WROTE 345 bytes: POST /TethysDash/dataLink HTTP/1.1 User-Agent: LRAUV Host: 134.89.2.23:443 Accept: */* Content-Type: application/x-www-form-urlencoded Content-Length: 178 imei=300234060751590&imeiPassword=Hde%603X&filename=Logs/20190216T162912/Courier0004.lzma&fileSize=25&file=%5d%00%00%04%00%08%00%00%00%00%00%00%00%00%15%1d%80%03%0cVi%be%d8%f0%00 2019-02-16T16:42:19.070Z,1550335339.070 [DataOverHttps](INFO): platform communications requested and available 2019-02-16T16:42:19.071Z,1550335339.071 [DataOverHttps](INFO): queued: Logs/20190216T162912/Courier0004.lzma 2019-02-16T16:42:19.071Z,1550335339.071 [DataOverHttps](INFO): data state is DATA_READ 2019-02-16T16:42:19.072Z,1550335339.072 [DataOverHttps](INFO): dataread() @740 received: 211 2019-02-16T16:42:19.474Z,1550335339.474 [DataOverHttps](INFO): platform communications requested and available 2019-02-16T16:42:19.475Z,1550335339.475 [DataOverHttps](INFO): queued: Logs/20190216T162912/Courier0004.lzma 2019-02-16T16:42:19.475Z,1550335339.475 [DataOverHttps](INFO): data state is DATA_READ 2019-02-16T16:42:19.476Z,1550335339.476 [DataOverHttps](INFO): dataread() @740 received: 88 2019-02-16T16:42:19.476Z,1550335339.476 [DataOverHttps](INFO): Moved sent file to Logs/20190216T162912/Courier0004.lzma.bak 2019-02-16T16:42:19.477Z,1550335339.477 [DataOverHttps](INFO): SBD MOMSN=9993340 2019-02-16T16:42:19.878Z,1550335339.878 [DataOverHttps](INFO): platform communications requested and available 2019-02-16T16:42:20.044Z,1550335340.044 [DataOverHttps](INFO): queued: Logs/20190216T162912/Courier0007.lzma 2019-02-16T16:42:20.044Z,1550335340.044 [DataOverHttps](INFO): data state is TCP_CONNECT 2019-02-16T16:42:20.282Z,1550335340.282 [DataOverHttps](INFO): platform communications requested and available 2019-02-16T16:42:20.282Z,1550335340.282 [DataOverHttps](INFO): queued: Logs/20190216T162912/Courier0007.lzma 2019-02-16T16:42:20.283Z,1550335340.283 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:42:20.686Z,1550335340.686 [DataOverHttps](INFO): platform communications requested and available 2019-02-16T16:42:20.687Z,1550335340.687 [DataOverHttps](INFO): queued: Logs/20190216T162912/Courier0007.lzma 2019-02-16T16:42:20.687Z,1550335340.687 [DataOverHttps](INFO): data state is SSL_CONNECTING 2019-02-16T16:42:21.090Z,1550335341.090 [DataOverHttps](INFO): platform communications requested and available 2019-02-16T16:42:21.090Z,1550335341.090 [DataOverHttps](INFO): queued: Logs/20190216T162912/Courier0007.lzma 2019-02-16T16:42:21.091Z,1550335341.091 [DataOverHttps](INFO): data state is SSL_CONNECTING 2019-02-16T16:42:24.292Z,1550335344.292 [Startup:StartupSatComms:B](INFO): Timed out from 2019-02-16T16:41:24.1Z 2019-02-16T16:42:24.292Z,1550335344.292 [Startup:StartupSatComms:B] Stopped 2019-02-16T16:42:24.292Z,1550335344.292 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms 2019-02-16T16:42:24.292Z,1550335344.292 [Startup:StartupSatComms] Stopped 2019-02-16T16:42:24.292Z,1550335344.292 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms 2019-02-16T16:42:24.293Z,1550335344.293 [Startup](INFO): Completed Startup 2019-02-16T16:42:24.293Z,1550335344.293 [MissionManager](INFO): Startup is completed. 2019-02-16T16:42:24.293Z,1550335344.293 [MissionManager](INFO): Uninitializing Mission Startup 2019-02-16T16:42:24.293Z,1550335344.293 [Startup] Stopped 2019-02-16T16:42:24.293Z,1550335344.293 [Startup](DEBUG): Aggregate::uninitialize Startup 2019-02-16T16:42:24.293Z,1550335344.293 [Startup:A.GoToSurface] Stopped 2019-02-16T16:42:24.294Z,1550335344.294 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2019-02-16T16:42:24.705Z,1550335344.705 [MissionManager](IMPORTANT): Started mission Default 2019-02-16T16:42:24.706Z,1550335344.706 [Default] Running Loop=1 2019-02-16T16:42:24.710Z,1550335344.710 [Default](DEBUG): Aggregate::initialize Default 2019-02-16T16:42:24.710Z,1550335344.710 [Default:B.GoToSurface] Running Loop=1 2019-02-16T16:42:24.710Z,1550335344.710 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2019-02-16T16:42:24.710Z,1550335344.710 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2019-02-16T16:42:24.711Z,1550335344.711 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2019-02-16T16:42:24.711Z,1550335344.711 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2019-02-16T16:42:24.711Z,1550335344.711 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2019-02-16T16:42:24.712Z,1550335344.712 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2019-02-16T16:42:24.712Z,1550335344.712 [Default:A.Wait] Running Loop=1 2019-02-16T16:42:24.712Z,1550335344.712 [Default:A.Wait](DEBUG): Initialize Wait Component. 2019-02-16T16:42:24.862Z,1550335344.862 [DataOverHttps](INFO): data state is SSL_CONNECTING 2019-02-16T16:42:25.266Z,1550335345.266 [DataOverHttps](INFO): data state is SSL_CONNECTING 2019-02-16T16:42:25.268Z,1550335345.268 [DataOverHttps](IMPORTANT): dataWrite() sendFilename_: Logs/20190216T162912/Courier0007.lzma, busy: 1 2019-02-16T16:42:25.269Z,1550335345.269 [DataOverHttps](IMPORTANT): dataWriting 208 bytes: POST /TethysDash/dataLink HTTP/1.1 User-Agent: LRAUV Host: 134.89.2.23:443 Accept: */* Content-Type: application/x-www-form-urlencoded Content-Length: 42 imei=300234060751590&imeiPassword=Hde%603X 2019-02-16T16:42:25.270Z,1550335345.270 [DataOverHttps](IMPORTANT): dataWriting with SSL WROTE 208 bytes: POST /TethysDash/dataLink HTTP/1.1 User-Agent: LRAUV Host: 134.89.2.23:443 Accept: */* Content-Type: application/x-www-form-urlencoded Content-Length: 42 imei=300234060751590&imeiPassword=Hde%603X 2019-02-16T16:42:25.670Z,1550335345.670 [DataOverHttps](INFO): data state is DATA_READ 2019-02-16T16:42:25.671Z,1550335345.671 [DataOverHttps](INFO): dataread() @740 received: 211 2019-02-16T16:42:26.074Z,1550335346.074 [DataOverHttps](INFO): data state is DATA_READ 2019-02-16T16:42:26.075Z,1550335346.075 [DataOverHttps](INFO): dataread() @740 received: 24 2019-02-16T16:42:26.478Z,1550335346.478 [DataOverHttps](INFO): data state is TCP_CONNECT 2019-02-16T16:42:26.882Z,1550335346.882 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:42:27.286Z,1550335347.286 [DataOverHttps](INFO): data state is SSL_CONNECTING 2019-02-16T16:42:27.690Z,1550335347.690 [DataOverHttps](INFO): data state is SSL_CONNECTING 2019-02-16T16:42:28.094Z,1550335348.094 [DataOverHttps](INFO): data state is SSL_CONNECTING 2019-02-16T16:42:28.498Z,1550335348.498 [DataOverHttps](INFO): data state is SSL_CONNECTING 2019-02-16T16:42:32.082Z,1550335352.082 [DataOverHttps](INFO): data state is SSL_CONNECTING 2019-02-16T16:42:32.482Z,1550335352.482 [DataOverHttps](INFO): data state is SSL_CONNECTING 2019-02-16T16:42:32.484Z,1550335352.484 [DataOverHttps](IMPORTANT): dataWrite() sendFilename_: Logs/20190216T162912/Courier0007.lzma, busy: 0 2019-02-16T16:42:32.486Z,1550335352.486 [DataOverHttps](INFO): Sending 25 bytes from file Logs/20190216T162912/Courier0007.lzma 2019-02-16T16:42:32.486Z,1550335352.486 [DataOverHttps](IMPORTANT): dataWriting 345 bytes: POST /TethysDash/dataLink HTTP/1.1 User-Agent: LRAUV Host: 134.89.2.23:443 Accept: */* Content-Type: application/x-www-form-urlencoded Content-Length: 178 imei=300234060751590&imeiPassword=Hde%603X&filename=Logs/20190216T162912/Courier0007.lzma&fileSize=25&file=%5d%00%00%04%00%08%00%00%00%00%00%00%00%00%15%1d%80%03%0cVi%be%d8%f0%00 2019-02-16T16:42:32.488Z,1550335352.488 [DataOverHttps](IMPORTANT): dataWriting with SSL WROTE 345 bytes: POST /TethysDash/dataLink HTTP/1.1 User-Agent: LRAUV Host: 134.89.2.23:443 Accept: */* Content-Type: application/x-www-form-urlencoded Content-Length: 178 imei=300234060751590&imeiPassword=Hde%603X&filename=Logs/20190216T162912/Courier0007.lzma&fileSize=25&file=%5d%00%00%04%00%08%00%00%00%00%00%00%00%00%15%1d%80%03%0cVi%be%d8%f0%00 2019-02-16T16:42:32.886Z,1550335352.886 [DataOverHttps](INFO): data state is DATA_READ 2019-02-16T16:42:32.887Z,1550335352.887 [DataOverHttps](INFO): dataread() @740 received: 211 2019-02-16T16:42:33.290Z,1550335353.290 [DataOverHttps](INFO): data state is DATA_READ 2019-02-16T16:42:33.291Z,1550335353.291 [DataOverHttps](INFO): dataread() @740 received: 88 2019-02-16T16:42:33.292Z,1550335353.292 [DataOverHttps](INFO): Moved sent file to Logs/20190216T162912/Courier0007.lzma.bak 2019-02-16T16:42:33.292Z,1550335353.292 [DataOverHttps](INFO): SBD MOMSN=9993342 2019-02-16T16:42:33.694Z,1550335353.694 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:42:34.098Z,1550335354.098 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:42:34.502Z,1550335354.502 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:42:34.906Z,1550335354.906 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:42:35.310Z,1550335355.310 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:42:35.714Z,1550335355.714 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:42:36.118Z,1550335356.118 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:42:36.522Z,1550335356.522 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:42:36.926Z,1550335356.926 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:42:37.331Z,1550335357.331 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:42:37.734Z,1550335357.734 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:42:38.024Z,1550335358.024 [Default:A.Wait](INFO): Done Waiting. 2019-02-16T16:42:38.024Z,1550335358.024 [Default:A.Wait] Stopped 2019-02-16T16:42:38.024Z,1550335358.024 [Default:A.Wait](DEBUG): Uninitialize Wait Component. 2019-02-16T16:42:38.138Z,1550335358.138 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:42:38.452Z,1550335358.452 [Default:CheckIn] Running Loop=1 2019-02-16T16:42:38.452Z,1550335358.452 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2019-02-16T16:42:38.452Z,1550335358.452 [Default:CheckIn:Read_GPS] Running Loop=1 2019-02-16T16:42:38.542Z,1550335358.542 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:42:38.812Z,1550335358.812 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix 2019-02-16T16:42:38.946Z,1550335358.946 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:42:39.350Z,1550335359.350 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:42:39.755Z,1550335359.755 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:42:40.158Z,1550335360.158 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:42:40.562Z,1550335360.562 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:42:40.966Z,1550335360.966 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:42:41.370Z,1550335361.370 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:42:41.774Z,1550335361.774 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:42:42.178Z,1550335362.178 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:42:42.582Z,1550335362.582 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:42:42.986Z,1550335362.986 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:42:43.390Z,1550335363.390 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:42:43.794Z,1550335363.794 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:42:44.198Z,1550335364.198 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:42:44.602Z,1550335364.602 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:42:45.006Z,1550335365.006 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:42:45.410Z,1550335365.410 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:42:45.814Z,1550335365.814 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:42:46.218Z,1550335366.218 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:42:46.622Z,1550335366.622 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:42:47.026Z,1550335367.026 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:42:47.430Z,1550335367.430 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:42:47.835Z,1550335367.835 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:42:48.238Z,1550335368.238 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:42:48.642Z,1550335368.642 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:42:49.046Z,1550335369.046 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:42:49.450Z,1550335369.450 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:42:49.854Z,1550335369.854 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:42:50.258Z,1550335370.258 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:42:50.662Z,1550335370.662 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:42:51.066Z,1550335371.066 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:42:51.470Z,1550335371.470 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:42:51.874Z,1550335371.874 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:42:52.278Z,1550335372.278 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:42:52.682Z,1550335372.682 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:42:53.086Z,1550335373.086 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:42:53.490Z,1550335373.490 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:42:53.894Z,1550335373.894 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:42:54.298Z,1550335374.298 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:42:54.702Z,1550335374.702 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:42:55.106Z,1550335375.106 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:42:55.510Z,1550335375.510 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:42:55.914Z,1550335375.914 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:42:56.318Z,1550335376.318 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:42:56.722Z,1550335376.722 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:42:57.126Z,1550335377.126 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:42:57.530Z,1550335377.530 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:42:57.934Z,1550335377.934 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:42:58.338Z,1550335378.338 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:42:58.742Z,1550335378.742 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:42:59.146Z,1550335379.146 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:42:59.550Z,1550335379.550 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:42:59.954Z,1550335379.954 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:43:00.358Z,1550335380.358 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:43:00.762Z,1550335380.762 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:43:01.166Z,1550335381.166 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:43:01.570Z,1550335381.570 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:43:01.976Z,1550335381.976 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:43:02.378Z,1550335382.378 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:43:02.782Z,1550335382.782 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:43:03.186Z,1550335383.186 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:43:03.590Z,1550335383.590 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:43:03.994Z,1550335383.994 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:43:04.398Z,1550335384.398 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:43:04.802Z,1550335384.802 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:43:05.206Z,1550335385.206 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:43:05.610Z,1550335385.610 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:43:06.014Z,1550335386.014 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:43:06.418Z,1550335386.418 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:43:06.822Z,1550335386.822 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:43:07.226Z,1550335387.226 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:43:07.630Z,1550335387.630 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:43:08.034Z,1550335388.034 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:43:08.438Z,1550335388.438 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:43:08.718Z,1550335388.718 [Rowe_600LCM](FAULT): Did not receive valid device response within the specified allowable sample time. 2019-02-16T16:43:08.718Z,1550335388.718 [Rowe_600LCM] Communications Fault, FailCount= 2 2019-02-16T16:43:08.718Z,1550335388.718 [Rowe_600LCM](ERROR): Communications Fault 2019-02-16T16:43:08.842Z,1550335388.842 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:43:09.122Z,1550335389.122 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of roweadcp LCM interface 2019-02-16T16:43:09.247Z,1550335389.247 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:43:09.308Z,1550335389.308 [CBIT](ERROR): Communications Fault in component: Rowe_600LCM 2019-02-16T16:43:09.341Z,1550335389.341 [Rowe_600LCM](INFO): Powering down 2019-02-16T16:43:09.650Z,1550335389.650 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:43:10.054Z,1550335390.054 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:43:10.458Z,1550335390.458 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:43:10.760Z,1550335390.760 [CBIT](INFO): Clearing failed state for component Rowe_600LCM 2019-02-16T16:43:10.760Z,1550335390.760 [Rowe_600LCM] No Fault, FailCount= 2 2019-02-16T16:43:10.862Z,1550335390.862 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:43:10.954Z,1550335390.954 [Rowe_600LCM](INFO): Initializing 2019-02-16T16:43:10.955Z,1550335390.955 [Rowe_600LCM](INFO): Powering up 2019-02-16T16:43:11.266Z,1550335391.266 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:43:11.670Z,1550335391.670 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:43:12.074Z,1550335392.074 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:43:12.478Z,1550335392.478 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:43:12.883Z,1550335392.883 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:43:13.286Z,1550335393.286 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:43:13.690Z,1550335393.690 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:43:14.095Z,1550335394.095 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:43:14.498Z,1550335394.498 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:43:14.902Z,1550335394.902 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:43:15.093Z,1550335395.093 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of Rowe LCM interface 2019-02-16T16:43:15.237Z,1550335395.237 [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 9600 >& /dev/null & 2019-02-16T16:43:15.307Z,1550335395.307 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:43:15.710Z,1550335395.710 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:43:16.114Z,1550335396.114 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:43:16.519Z,1550335396.519 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:43:16.922Z,1550335396.922 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:43:17.326Z,1550335397.326 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:43:17.730Z,1550335397.730 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:43:18.134Z,1550335398.134 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:43:18.538Z,1550335398.538 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:43:18.942Z,1550335398.942 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:43:19.346Z,1550335399.346 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:43:19.750Z,1550335399.750 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:43:20.154Z,1550335400.154 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:43:20.558Z,1550335400.558 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:43:20.962Z,1550335400.962 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:43:21.366Z,1550335401.366 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:43:21.770Z,1550335401.770 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:43:22.175Z,1550335402.175 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:43:22.578Z,1550335402.578 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:43:22.982Z,1550335402.982 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:43:23.386Z,1550335403.386 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:43:23.790Z,1550335403.790 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:43:24.194Z,1550335404.194 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:43:24.598Z,1550335404.598 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:43:25.002Z,1550335405.002 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:43:25.406Z,1550335405.406 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:43:25.810Z,1550335405.810 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:43:26.214Z,1550335406.214 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:43:26.618Z,1550335406.618 [DataOverHttps](INFO): data state is TCP_CONNECT 2019-02-16T16:43:27.022Z,1550335407.022 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:43:27.426Z,1550335407.426 [DataOverHttps](INFO): data state is SSL_CONNECTING 2019-02-16T16:43:27.830Z,1550335407.830 [DataOverHttps](INFO): data state is SSL_CONNECTING 2019-02-16T16:43:28.234Z,1550335408.234 [DataOverHttps](INFO): data state is SSL_CONNECTING 2019-02-16T16:43:28.638Z,1550335408.638 [DataOverHttps](INFO): data state is SSL_CONNECTING 2019-02-16T16:43:29.042Z,1550335409.042 [DataOverHttps](INFO): data state is SSL_CONNECTING 2019-02-16T16:43:29.446Z,1550335409.446 [DataOverHttps](INFO): data state is SSL_CONNECTING 2019-02-16T16:43:29.850Z,1550335409.850 [DataOverHttps](INFO): data state is SSL_CONNECTING 2019-02-16T16:43:30.254Z,1550335410.254 [DataOverHttps](INFO): data state is SSL_CONNECTING 2019-02-16T16:43:31.911Z,1550335411.911 [CommandLine](IMPORTANT): got command maintain sensor Depth_Keller.depth 3.000000 meter 2019-02-16T16:43:31.913Z,1550335411.913 [ComponentRegistry](DEBUG): SyncComponent "Maintain_Depth_Keller.depth" handled in the control thread. 2019-02-16T16:43:32.173Z,1550335412.173 [controlThread](DEBUG): Component order: CycleStarter,Aanderaa_O2,ESPComponent,PAR_Licor,AcousticModem_Benthos_ATM900,Depth_Keller,NAL9602,Onboard,PNI_TCM,BPC1,PAR_Licor,Depth_Keller,Maintain_Depth_Keller.depth,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,DeadReckonUsingSpeedCalculator,DeadReckonWithRespectToSeafloor,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter, 2019-02-16T16:43:32.994Z,1550335412.994 [ElevatorOffsetCalculator](INFO): New estimator for commanded vars: speed 1.00 m/s, pitch 30.00 deg, mass-position -13.00 mm (1 active estimators). 2019-02-16T16:43:33.126Z,1550335413.126 [Radio_Surface](INFO): Powering down 2019-02-16T16:43:33.638Z,1550335413.638 [Reporter](INFO): Radio_Surface.radio_surface_power no_value 2019-02-16T16:43:34.177Z,1550335414.177 [DataOverHttps](INFO): data state is SSL_CONNECTING 2019-02-16T16:43:34.578Z,1550335414.578 [DataOverHttps](INFO): data state is SSL_CONNECTING 2019-02-16T16:43:34.982Z,1550335414.982 [DataOverHttps](INFO): data state is SSL_CONNECTING 2019-02-16T16:43:35.386Z,1550335415.386 [DataOverHttps](INFO): data state is SSL_CONNECTING 2019-02-16T16:43:35.790Z,1550335415.790 [DataOverHttps](INFO): data state is SSL_CONNECTING 2019-02-16T16:43:36.194Z,1550335416.194 [DataOverHttps](INFO): data state is SSL_CONNECTING 2019-02-16T16:43:36.598Z,1550335416.598 [DataOverHttps](INFO): data state is SSL_CONNECTING 2019-02-16T16:43:37.002Z,1550335417.002 [DataOverHttps](INFO): data state is SSL_CONNECTING 2019-02-16T16:43:37.406Z,1550335417.406 [DataOverHttps](INFO): data state is SSL_CONNECTING 2019-02-16T16:43:37.810Z,1550335417.810 [DataOverHttps](INFO): data state is SSL_CONNECTING 2019-02-16T16:43:38.214Z,1550335418.214 [DataOverHttps](INFO): data state is SSL_CONNECTING 2019-02-16T16:43:38.618Z,1550335418.618 [DataOverHttps](INFO): data state is SSL_CONNECTING 2019-02-16T16:43:39.022Z,1550335419.022 [DataOverHttps](INFO): data state is SSL_CONNECTING 2019-02-16T16:43:39.426Z,1550335419.426 [DataOverHttps](INFO): data state is SSL_CONNECTING 2019-02-16T16:43:39.830Z,1550335419.830 [DataOverHttps](INFO): data state is SSL_CONNECTING 2019-02-16T16:43:40.235Z,1550335420.235 [DataOverHttps](INFO): data state is SSL_CONNECTING 2019-02-16T16:43:40.638Z,1550335420.638 [DataOverHttps](INFO): data state is SSL_CONNECTING 2019-02-16T16:43:41.042Z,1550335421.042 [DataOverHttps](INFO): data state is SSL_CONNECTING 2019-02-16T16:43:41.446Z,1550335421.446 [DataOverHttps](INFO): data state is SSL_CONNECTING 2019-02-16T16:43:41.850Z,1550335421.850 [DataOverHttps](INFO): data state is SSL_CONNECTING 2019-02-16T16:43:42.254Z,1550335422.254 [DataOverHttps](INFO): data state is SSL_CONNECTING 2019-02-16T16:43:42.658Z,1550335422.658 [DataOverHttps](INFO): data state is SSL_CONNECTING 2019-02-16T16:43:43.062Z,1550335423.062 [DataOverHttps](INFO): data state is SSL_CONNECTING 2019-02-16T16:43:43.466Z,1550335423.466 [DataOverHttps](INFO): data state is SSL_CONNECTING 2019-02-16T16:43:43.870Z,1550335423.870 [DataOverHttps](INFO): data state is SSL_CONNECTING 2019-02-16T16:43:44.274Z,1550335424.274 [DataOverHttps](INFO): data state is SSL_CONNECTING 2019-02-16T16:43:44.678Z,1550335424.678 [DataOverHttps](INFO): data state is SSL_CONNECTING 2019-02-16T16:43:45.083Z,1550335425.083 [DataOverHttps](INFO): data state is SSL_CONNECTING 2019-02-16T16:43:45.246Z,1550335425.246 [Radio_Surface](INFO): Powering up 2019-02-16T16:43:45.486Z,1550335425.486 [DataOverHttps](INFO): data state is SSL_CONNECTING 2019-02-16T16:43:45.890Z,1550335425.890 [DataOverHttps](INFO): data state is SSL_CONNECTING 2019-02-16T16:43:46.294Z,1550335426.294 [DataOverHttps](INFO): data state is SSL_CONNECTING 2019-02-16T16:43:46.698Z,1550335426.698 [DataOverHttps](INFO): data state is SSL_CONNECTING 2019-02-16T16:43:47.102Z,1550335427.102 [DataOverHttps](INFO): data state is SSL_CONNECTING 2019-02-16T16:43:47.506Z,1550335427.506 [DataOverHttps](INFO): data state is SSL_CONNECTING 2019-02-16T16:43:47.910Z,1550335427.910 [DataOverHttps](INFO): data state is SSL_CONNECTING 2019-02-16T16:43:48.314Z,1550335428.314 [DataOverHttps](INFO): data state is SSL_CONNECTING 2019-02-16T16:43:48.718Z,1550335428.718 [DataOverHttps](INFO): data state is SSL_CONNECTING 2019-02-16T16:43:49.122Z,1550335429.122 [DataOverHttps](INFO): data state is SSL_CONNECTING 2019-02-16T16:43:49.526Z,1550335429.526 [DataOverHttps](INFO): data state is SSL_CONNECTING 2019-02-16T16:43:49.930Z,1550335429.930 [DataOverHttps](INFO): data state is SSL_CONNECTING 2019-02-16T16:43:50.334Z,1550335430.334 [DataOverHttps](INFO): data state is SSL_CONNECTING 2019-02-16T16:43:50.635Z,1550335430.635 [Reporter](INFO): Radio_Surface.radio_surface_power 1 enum 2019-02-16T16:43:50.738Z,1550335430.738 [DataOverHttps](INFO): data state is SSL_CONNECTING 2019-02-16T16:43:51.142Z,1550335431.142 [DataOverHttps](INFO): data state is SSL_CONNECTING 2019-02-16T16:43:51.306Z,1550335431.306 [Radio_Surface](INFO): Powering down 2019-02-16T16:43:51.349Z,1550335431.349 [Reporter](INFO): Radio_Surface.radio_surface_power no_value 2019-02-16T16:43:51.546Z,1550335431.546 [DataOverHttps](INFO): data state is SSL_CONNECTING 2019-02-16T16:43:51.950Z,1550335431.950 [DataOverHttps](INFO): data state is SSL_CONNECTING 2019-02-16T16:43:52.354Z,1550335432.354 [DataOverHttps](INFO): data state is SSL_CONNECTING 2019-02-16T16:43:52.758Z,1550335432.758 [DataOverHttps](INFO): data state is SSL_CONNECTING 2019-02-16T16:43:53.162Z,1550335433.162 [DataOverHttps](INFO): data state is SSL_CONNECTING 2019-02-16T16:43:53.566Z,1550335433.566 [DataOverHttps](INFO): data state is SSL_CONNECTING 2019-02-16T16:43:53.970Z,1550335433.970 [DataOverHttps](INFO): data state is SSL_CONNECTING 2019-02-16T16:43:54.374Z,1550335434.374 [DataOverHttps](INFO): data state is SSL_CONNECTING 2019-02-16T16:43:54.778Z,1550335434.778 [DataOverHttps](INFO): data state is SSL_CONNECTING 2019-02-16T16:43:55.182Z,1550335435.182 [DataOverHttps](INFO): data state is SSL_CONNECTING 2019-02-16T16:43:55.586Z,1550335435.586 [DataOverHttps](INFO): data state is SSL_CONNECTING 2019-02-16T16:43:55.990Z,1550335435.990 [DataOverHttps](INFO): data state is SSL_CONNECTING 2019-02-16T16:43:56.394Z,1550335436.394 [DataOverHttps](INFO): data state is SSL_CONNECTING 2019-02-16T16:43:56.798Z,1550335436.798 [DataOverHttps](INFO): data state is SSL_CONNECTING 2019-02-16T16:43:57.202Z,1550335437.202 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:43:57.606Z,1550335437.606 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:43:57.770Z,1550335437.770 [Radio_Surface](INFO): Powering up 2019-02-16T16:43:58.010Z,1550335438.010 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:43:58.414Z,1550335438.414 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:43:58.818Z,1550335438.818 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:43:59.222Z,1550335439.222 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:43:59.626Z,1550335439.626 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:44:00.030Z,1550335440.030 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:44:00.434Z,1550335440.434 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:44:00.838Z,1550335440.838 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:44:01.242Z,1550335441.242 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:44:01.646Z,1550335441.646 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:44:02.050Z,1550335442.050 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:44:02.454Z,1550335442.454 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:44:02.858Z,1550335442.858 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:44:03.067Z,1550335443.067 [Reporter](INFO): Radio_Surface.radio_surface_power 1 enum 2019-02-16T16:44:03.262Z,1550335443.262 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:44:03.666Z,1550335443.666 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:44:03.831Z,1550335443.831 [Radio_Surface](INFO): Powering down 2019-02-16T16:44:03.856Z,1550335443.856 [Reporter](INFO): Radio_Surface.radio_surface_power no_value 2019-02-16T16:44:04.070Z,1550335444.070 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:44:04.474Z,1550335444.474 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:44:04.878Z,1550335444.878 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:44:05.282Z,1550335445.282 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:44:05.686Z,1550335445.686 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:44:06.090Z,1550335446.090 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:44:06.494Z,1550335446.494 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:44:06.898Z,1550335446.898 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:44:07.302Z,1550335447.302 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:44:07.706Z,1550335447.706 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:44:08.110Z,1550335448.110 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:44:08.514Z,1550335448.514 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:44:08.919Z,1550335448.919 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:44:09.322Z,1550335449.322 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:44:09.726Z,1550335449.726 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:44:09.890Z,1550335449.890 [Radio_Surface](INFO): Powering up 2019-02-16T16:44:10.130Z,1550335450.130 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:44:10.534Z,1550335450.534 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:44:10.938Z,1550335450.938 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:44:11.342Z,1550335451.342 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:44:11.746Z,1550335451.746 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:44:12.150Z,1550335452.150 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:44:12.554Z,1550335452.554 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:44:12.958Z,1550335452.958 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:44:13.362Z,1550335453.362 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:44:13.766Z,1550335453.766 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:44:13.895Z,1550335453.895 [CommandLine](IMPORTANT): got command maintain sensor Depth_Keller.depth 3.000000 meter 2019-02-16T16:44:14.170Z,1550335454.170 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:44:14.574Z,1550335454.574 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:44:14.978Z,1550335454.978 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:44:15.179Z,1550335455.179 [Reporter](INFO): Radio_Surface.radio_surface_power 1 enum 2019-02-16T16:44:15.383Z,1550335455.383 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:44:15.786Z,1550335455.786 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:44:15.950Z,1550335455.950 [Radio_Surface](INFO): Powering down 2019-02-16T16:44:16.015Z,1550335456.015 [Reporter](INFO): Radio_Surface.radio_surface_power no_value 2019-02-16T16:44:16.190Z,1550335456.190 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:44:16.595Z,1550335456.595 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:44:16.998Z,1550335456.998 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:44:17.402Z,1550335457.402 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:44:17.807Z,1550335457.807 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:44:18.210Z,1550335458.210 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:44:18.614Z,1550335458.614 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:44:19.019Z,1550335459.019 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:44:19.422Z,1550335459.422 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:44:19.826Z,1550335459.826 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:44:20.230Z,1550335460.230 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:44:20.634Z,1550335460.634 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:44:21.038Z,1550335461.038 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:44:21.442Z,1550335461.442 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:44:21.846Z,1550335461.846 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:44:22.010Z,1550335462.010 [Radio_Surface](INFO): Powering up 2019-02-16T16:44:22.250Z,1550335462.250 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:44:22.654Z,1550335462.654 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:44:23.058Z,1550335463.058 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:44:23.462Z,1550335463.462 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:44:23.866Z,1550335463.866 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:44:24.270Z,1550335464.270 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:44:24.674Z,1550335464.674 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:44:25.078Z,1550335465.078 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:44:25.482Z,1550335465.482 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:44:25.886Z,1550335465.886 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:44:26.290Z,1550335466.290 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:44:26.694Z,1550335466.694 [DataOverHttps](INFO): data state is TCP_CONNECT 2019-02-16T16:44:27.098Z,1550335467.098 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:44:27.284Z,1550335467.284 [Reporter](INFO): Radio_Surface.radio_surface_power 1 enum 2019-02-16T16:44:27.502Z,1550335467.502 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:44:27.906Z,1550335467.906 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:44:28.071Z,1550335468.071 [Radio_Surface](INFO): Powering down 2019-02-16T16:44:28.099Z,1550335468.099 [Reporter](INFO): Radio_Surface.radio_surface_power no_value 2019-02-16T16:44:28.310Z,1550335468.310 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:44:28.714Z,1550335468.714 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:44:29.118Z,1550335469.118 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:44:29.522Z,1550335469.522 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:44:29.926Z,1550335469.926 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:44:30.331Z,1550335470.331 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:44:30.734Z,1550335470.734 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:44:31.138Z,1550335471.138 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:44:31.542Z,1550335471.542 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:44:31.946Z,1550335471.946 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:44:32.350Z,1550335472.350 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:44:32.754Z,1550335472.754 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:44:33.159Z,1550335473.159 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:44:33.562Z,1550335473.562 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:44:33.967Z,1550335473.967 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:44:34.370Z,1550335474.370 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:44:34.534Z,1550335474.534 [Radio_Surface](INFO): Powering up 2019-02-16T16:44:34.774Z,1550335474.774 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:44:35.178Z,1550335475.178 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:44:35.582Z,1550335475.582 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:44:35.986Z,1550335475.986 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:44:36.390Z,1550335476.390 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:44:36.794Z,1550335476.794 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:44:37.198Z,1550335477.198 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:44:37.602Z,1550335477.602 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:44:38.006Z,1550335478.006 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:44:38.410Z,1550335478.410 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:44:38.814Z,1550335478.814 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:44:39.218Z,1550335479.218 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:44:39.622Z,1550335479.622 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:44:39.811Z,1550335479.811 [Reporter](INFO): Radio_Surface.radio_surface_power 1 enum 2019-02-16T16:44:40.026Z,1550335480.026 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:44:40.430Z,1550335480.430 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:44:40.594Z,1550335480.594 [Radio_Surface](INFO): Powering down 2019-02-16T16:44:40.619Z,1550335480.619 [Reporter](INFO): Radio_Surface.radio_surface_power no_value 2019-02-16T16:44:40.834Z,1550335480.834 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:44:41.238Z,1550335481.238 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:44:41.642Z,1550335481.642 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:44:42.046Z,1550335482.046 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:44:42.450Z,1550335482.450 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:44:42.854Z,1550335482.854 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:44:43.258Z,1550335483.258 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:44:43.662Z,1550335483.662 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:44:44.066Z,1550335484.066 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:44:44.470Z,1550335484.470 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:44:44.874Z,1550335484.874 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:44:45.278Z,1550335485.278 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:44:45.682Z,1550335485.682 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:44:46.086Z,1550335486.086 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:44:46.490Z,1550335486.490 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:44:46.654Z,1550335486.654 [Radio_Surface](INFO): Powering up 2019-02-16T16:44:46.894Z,1550335486.894 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:44:47.298Z,1550335487.298 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:44:47.702Z,1550335487.702 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:44:47.803Z,1550335487.803 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2019-02-16T16:44:48.106Z,1550335488.106 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:44:48.510Z,1550335488.510 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:44:48.622Z,1550335488.622 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:44:48.914Z,1550335488.914 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:44:49.318Z,1550335489.318 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:44:49.722Z,1550335489.722 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:44:50.126Z,1550335490.126 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:44:50.530Z,1550335490.530 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:44:50.934Z,1550335490.934 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:44:51.338Z,1550335491.338 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:44:51.742Z,1550335491.742 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:44:51.951Z,1550335491.951 [Reporter](INFO): Radio_Surface.radio_surface_power 1 enum 2019-02-16T16:44:52.146Z,1550335492.146 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:44:52.550Z,1550335492.550 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:44:52.954Z,1550335492.954 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:44:53.118Z,1550335493.118 [Radio_Surface](INFO): Powering down 2019-02-16T16:44:53.151Z,1550335493.151 [Reporter](INFO): Radio_Surface.radio_surface_power no_value 2019-02-16T16:44:53.358Z,1550335493.358 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:44:53.483Z,1550335493.483 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:44:53.762Z,1550335493.762 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:44:54.166Z,1550335494.166 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:44:54.570Z,1550335494.570 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:44:54.974Z,1550335494.974 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:44:55.378Z,1550335495.378 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:44:55.782Z,1550335495.782 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:44:56.186Z,1550335496.186 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:44:56.298Z,1550335496.298 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:44:56.590Z,1550335496.590 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:44:56.994Z,1550335496.994 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:44:56.994Z,1550335496.994 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-02-16T16:44:57.398Z,1550335497.398 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:44:57.802Z,1550335497.802 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:44:58.206Z,1550335498.206 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:44:58.318Z,1550335498.318 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:44:58.610Z,1550335498.610 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:44:59.014Z,1550335499.014 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:44:59.418Z,1550335499.418 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:44:59.822Z,1550335499.822 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:45:00.226Z,1550335500.226 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:45:00.358Z,1550335500.358 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:45:00.630Z,1550335500.630 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:45:01.034Z,1550335501.034 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:45:01.438Z,1550335501.438 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:45:01.842Z,1550335501.842 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:45:02.246Z,1550335502.246 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:45:02.362Z,1550335502.362 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:45:02.650Z,1550335502.650 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:45:03.054Z,1550335503.054 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:45:03.459Z,1550335503.459 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:45:03.862Z,1550335503.862 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:45:04.266Z,1550335504.266 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:45:04.430Z,1550335504.430 [Radio_Surface](INFO): Powering up 2019-02-16T16:45:04.671Z,1550335504.671 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:45:05.074Z,1550335505.074 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:45:05.478Z,1550335505.478 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:45:05.590Z,1550335505.590 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:45:05.883Z,1550335505.883 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:45:06.286Z,1550335506.286 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:45:06.690Z,1550335506.690 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:45:06.837Z,1550335506.837 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2 2019-02-16T16:45:06.837Z,1550335506.837 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2019-02-16T16:45:06.840Z,1550335506.840 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 2 2019-02-16T16:45:06.840Z,1550335506.840 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2019-02-16T16:45:06.841Z,1550335506.841 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 2 2019-02-16T16:45:06.841Z,1550335506.841 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2019-02-16T16:45:06.883Z,1550335506.883 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2019-02-16T16:45:06.883Z,1550335506.883 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2019-02-16T16:45:06.883Z,1550335506.883 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2019-02-16T16:45:07.095Z,1550335507.095 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:45:07.270Z,1550335507.270 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2019-02-16T16:45:07.271Z,1550335507.271 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2 2019-02-16T16:45:07.271Z,1550335507.271 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2019-02-16T16:45:07.271Z,1550335507.271 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 2 2019-02-16T16:45:07.272Z,1550335507.272 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2019-02-16T16:45:07.272Z,1550335507.272 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 2 2019-02-16T16:45:07.498Z,1550335507.498 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:45:07.643Z,1550335507.643 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2019-02-16T16:45:07.902Z,1550335507.902 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:45:08.306Z,1550335508.306 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:45:08.418Z,1550335508.418 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:45:08.710Z,1550335508.710 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:45:09.114Z,1550335509.114 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:45:09.518Z,1550335509.518 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:45:09.699Z,1550335509.699 [Reporter](INFO): Radio_Surface.radio_surface_power 1 enum 2019-02-16T16:45:09.923Z,1550335509.923 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:45:10.326Z,1550335510.326 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:45:10.490Z,1550335510.490 [Radio_Surface](INFO): Powering down 2019-02-16T16:45:10.515Z,1550335510.515 [Reporter](INFO): Radio_Surface.radio_surface_power no_value 2019-02-16T16:45:10.730Z,1550335510.730 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:45:11.134Z,1550335511.134 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:45:11.490Z,1550335511.490 [Rowe_600LCM](FAULT): Did not receive valid device response within the specified allowable sample time. 2019-02-16T16:45:11.490Z,1550335511.490 [Rowe_600LCM] Communications Fault, FailCount= 3 2019-02-16T16:45:11.490Z,1550335511.490 [Rowe_600LCM](ERROR): Communications Fault 2019-02-16T16:45:11.538Z,1550335511.538 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:45:11.662Z,1550335511.662 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:45:11.750Z,1550335511.750 [CBIT](ERROR): Communications Fault in component: Rowe_600LCM 2019-02-16T16:45:11.894Z,1550335511.894 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of roweadcp LCM interface 2019-02-16T16:45:11.943Z,1550335511.943 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:45:11.997Z,1550335511.997 [Rowe_600LCM](INFO): Powering down 2019-02-16T16:45:12.346Z,1550335512.346 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:45:12.750Z,1550335512.750 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:45:13.154Z,1550335513.154 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:45:13.339Z,1550335513.339 [CBIT](INFO): Clearing failed state for component Rowe_600LCM 2019-02-16T16:45:13.339Z,1550335513.339 [Rowe_600LCM] No Fault, FailCount= 3 2019-02-16T16:45:13.558Z,1550335513.558 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:45:13.610Z,1550335513.610 [Rowe_600LCM](INFO): Initializing 2019-02-16T16:45:13.611Z,1550335513.611 [Rowe_600LCM](INFO): Powering up 2019-02-16T16:45:13.962Z,1550335513.962 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:45:14.366Z,1550335514.366 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:45:14.482Z,1550335514.482 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:45:14.770Z,1550335514.770 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:45:15.174Z,1550335515.174 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:45:15.578Z,1550335515.578 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:45:15.982Z,1550335515.982 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:45:16.386Z,1550335516.386 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:45:16.550Z,1550335516.550 [Radio_Surface](INFO): Powering up 2019-02-16T16:45:16.790Z,1550335516.790 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:45:17.194Z,1550335517.194 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:45:17.598Z,1550335517.598 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:45:17.714Z,1550335517.714 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:45:17.848Z,1550335517.848 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of Rowe LCM interface 2019-02-16T16:45:17.941Z,1550335517.941 [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 9600 >& /dev/null & 2019-02-16T16:45:18.003Z,1550335518.003 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:45:18.406Z,1550335518.406 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:45:18.810Z,1550335518.810 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:45:19.214Z,1550335519.214 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:45:19.618Z,1550335519.618 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:45:20.022Z,1550335520.022 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:45:20.426Z,1550335520.426 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:45:20.542Z,1550335520.542 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:45:20.830Z,1550335520.830 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:45:21.234Z,1550335521.234 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:45:21.638Z,1550335521.638 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:45:21.843Z,1550335521.843 [Reporter](INFO): Radio_Surface.radio_surface_power 1 enum 2019-02-16T16:45:22.042Z,1550335522.042 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:45:22.446Z,1550335522.446 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:45:22.618Z,1550335522.618 [Radio_Surface](INFO): Powering down 2019-02-16T16:45:22.635Z,1550335522.635 [Reporter](INFO): Radio_Surface.radio_surface_power no_value 2019-02-16T16:45:22.850Z,1550335522.850 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:45:23.254Z,1550335523.254 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:45:23.370Z,1550335523.370 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:45:23.658Z,1550335523.658 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:45:24.063Z,1550335524.063 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:45:24.466Z,1550335524.466 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:45:24.870Z,1550335524.870 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:45:25.274Z,1550335525.274 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:45:25.398Z,1550335525.398 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:45:25.679Z,1550335525.679 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:45:26.082Z,1550335526.082 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:45:26.486Z,1550335526.486 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:45:26.890Z,1550335526.890 [DataOverHttps](INFO): data state is TCP_CONNECT 2019-02-16T16:45:27.294Z,1550335527.294 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:45:27.414Z,1550335527.414 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:45:27.698Z,1550335527.698 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:45:28.102Z,1550335528.102 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:45:28.506Z,1550335528.506 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:45:28.678Z,1550335528.678 [Radio_Surface](INFO): Powering up 2019-02-16T16:45:28.910Z,1550335528.910 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:45:29.314Z,1550335529.314 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:45:29.718Z,1550335529.718 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:45:30.122Z,1550335530.122 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:45:30.526Z,1550335530.526 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:45:30.642Z,1550335530.642 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:45:30.930Z,1550335530.930 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:45:31.334Z,1550335531.334 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:45:31.738Z,1550335531.738 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:45:32.142Z,1550335532.142 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:45:32.546Z,1550335532.546 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:45:32.950Z,1550335532.950 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:45:33.354Z,1550335533.354 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:45:33.355Z,1550335533.355 [DataOverHttps](INFO): setting unavailable, lastComms_.elapsed()=180.063339 2019-02-16T16:45:33.466Z,1550335533.466 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:45:33.758Z,1550335533.758 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:45:33.975Z,1550335533.975 [Reporter](INFO): Radio_Surface.radio_surface_power 1 enum 2019-02-16T16:45:34.162Z,1550335534.162 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:45:34.566Z,1550335534.566 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:45:34.970Z,1550335534.970 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:45:35.143Z,1550335535.143 [Radio_Surface](INFO): Powering down 2019-02-16T16:45:35.148Z,1550335535.148 [Reporter](INFO): Radio_Surface.radio_surface_power no_value 2019-02-16T16:45:35.374Z,1550335535.374 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:45:35.778Z,1550335535.778 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:45:36.182Z,1550335536.182 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:45:36.586Z,1550335536.586 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:45:36.698Z,1550335536.698 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:45:36.990Z,1550335536.990 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:45:37.394Z,1550335537.394 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:45:37.798Z,1550335537.798 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:45:38.202Z,1550335538.202 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:45:38.606Z,1550335538.606 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:45:39.010Z,1550335539.010 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:45:39.414Z,1550335539.414 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:45:39.526Z,1550335539.526 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:45:39.818Z,1550335539.818 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:45:40.222Z,1550335540.222 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:45:40.626Z,1550335540.626 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:45:41.030Z,1550335541.030 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:45:41.203Z,1550335541.203 [Radio_Surface](INFO): Powering up 2019-02-16T16:45:41.434Z,1550335541.434 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:45:41.838Z,1550335541.838 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:45:42.242Z,1550335542.242 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:45:42.646Z,1550335542.646 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:45:42.766Z,1550335542.766 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:45:43.050Z,1550335543.050 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:45:43.454Z,1550335543.454 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:45:43.858Z,1550335543.858 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:45:44.262Z,1550335544.262 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:45:44.666Z,1550335544.666 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:45:45.070Z,1550335545.070 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:45:45.474Z,1550335545.474 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:45:45.594Z,1550335545.594 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:45:45.878Z,1550335545.878 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:45:46.282Z,1550335546.282 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:45:46.495Z,1550335546.495 [Reporter](INFO): Radio_Surface.radio_surface_power 1 enum 2019-02-16T16:45:46.686Z,1550335546.686 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:45:47.090Z,1550335547.090 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:45:47.278Z,1550335547.278 [Radio_Surface](INFO): Powering down 2019-02-16T16:45:47.494Z,1550335547.494 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:45:47.511Z,1550335547.511 [CommandLine](IMPORTANT): got command maintain clear 2019-02-16T16:45:47.685Z,1550335547.685 [Reporter](INFO): Radio_Surface.radio_surface_power no_value 2019-02-16T16:45:47.692Z,1550335547.692 [controlThread](DEBUG): Component order: CycleStarter,Aanderaa_O2,ESPComponent,PAR_Licor,AcousticModem_Benthos_ATM900,Depth_Keller,NAL9602,Onboard,PNI_TCM,BPC1,PAR_Licor,Depth_Keller,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,DeadReckonUsingSpeedCalculator,DeadReckonWithRespectToSeafloor,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter, 2019-02-16T16:45:47.898Z,1550335547.898 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:45:48.302Z,1550335548.302 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:45:48.426Z,1550335548.426 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:45:48.706Z,1550335548.706 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:45:49.110Z,1550335549.110 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:45:49.514Z,1550335549.514 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:45:49.918Z,1550335549.918 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:45:50.323Z,1550335550.323 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:45:50.526Z,1550335550.526 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:45:50.726Z,1550335550.726 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:45:51.130Z,1550335551.130 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:45:51.535Z,1550335551.535 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:45:51.938Z,1550335551.938 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:45:52.342Z,1550335552.342 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:45:52.747Z,1550335552.747 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:45:53.150Z,1550335553.150 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:45:53.338Z,1550335553.338 [Radio_Surface](INFO): Powering up 2019-02-16T16:45:53.554Z,1550335553.554 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:45:53.758Z,1550335553.758 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:45:53.959Z,1550335553.959 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:45:54.362Z,1550335554.362 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:45:54.766Z,1550335554.766 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:45:55.173Z,1550335555.173 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:45:55.574Z,1550335555.574 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:45:55.978Z,1550335555.978 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:45:56.382Z,1550335556.382 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:45:56.582Z,1550335556.582 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:45:56.786Z,1550335556.786 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:45:57.190Z,1550335557.190 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:45:57.594Z,1550335557.594 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:45:57.998Z,1550335557.998 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:45:58.404Z,1550335558.404 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:45:58.700Z,1550335558.700 [Reporter](INFO): Radio_Surface.radio_surface_power 1 enum 2019-02-16T16:45:58.806Z,1550335558.806 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:45:59.210Z,1550335559.210 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:45:59.414Z,1550335559.414 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:45:59.614Z,1550335559.614 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:46:00.018Z,1550335560.018 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:46:00.422Z,1550335560.422 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:46:00.826Z,1550335560.826 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:46:01.230Z,1550335561.230 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:46:01.446Z,1550335561.446 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:46:01.635Z,1550335561.635 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:46:02.038Z,1550335562.038 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:46:02.442Z,1550335562.442 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:46:02.846Z,1550335562.846 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:46:03.250Z,1550335563.250 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:46:03.454Z,1550335563.454 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:46:03.654Z,1550335563.654 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:46:04.058Z,1550335564.058 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:46:04.462Z,1550335564.462 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:46:04.866Z,1550335564.866 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:46:05.270Z,1550335565.270 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:46:05.674Z,1550335565.674 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:46:06.078Z,1550335566.078 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:46:06.482Z,1550335566.482 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:46:06.678Z,1550335566.678 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:46:06.886Z,1550335566.886 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:46:07.290Z,1550335567.290 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:46:07.694Z,1550335567.694 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:46:08.099Z,1550335568.099 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:46:08.502Z,1550335568.502 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:46:08.906Z,1550335568.906 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:46:09.310Z,1550335569.310 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:46:09.506Z,1550335569.506 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:46:09.714Z,1550335569.714 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:46:10.118Z,1550335570.118 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:46:10.522Z,1550335570.522 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:46:10.926Z,1550335570.926 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:46:11.332Z,1550335571.332 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:46:11.734Z,1550335571.734 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:46:12.138Z,1550335572.138 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:46:12.542Z,1550335572.542 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:46:12.738Z,1550335572.738 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:46:12.946Z,1550335572.946 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:46:13.350Z,1550335573.350 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:46:13.754Z,1550335573.754 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:46:14.158Z,1550335574.158 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:46:14.562Z,1550335574.562 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:46:14.966Z,1550335574.966 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:46:15.370Z,1550335575.370 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:46:15.566Z,1550335575.566 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:46:15.774Z,1550335575.774 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:46:16.178Z,1550335576.178 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:46:16.582Z,1550335576.582 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:46:16.987Z,1550335576.987 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:46:17.390Z,1550335577.390 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:46:17.794Z,1550335577.794 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:46:18.198Z,1550335578.198 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:46:18.602Z,1550335578.602 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:46:18.806Z,1550335578.806 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:46:19.006Z,1550335579.006 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:46:19.410Z,1550335579.410 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:46:19.814Z,1550335579.814 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:46:20.218Z,1550335580.218 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:46:20.622Z,1550335580.622 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:46:21.028Z,1550335581.028 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:46:21.430Z,1550335581.430 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:46:21.634Z,1550335581.634 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:46:21.834Z,1550335581.834 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:46:22.238Z,1550335582.238 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:46:22.642Z,1550335582.642 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:46:23.046Z,1550335583.046 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:46:23.450Z,1550335583.450 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:46:23.854Z,1550335583.854 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:46:24.259Z,1550335584.259 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:46:24.462Z,1550335584.462 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:46:24.662Z,1550335584.662 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:46:25.066Z,1550335585.066 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:46:25.470Z,1550335585.470 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:46:25.874Z,1550335585.874 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:46:26.278Z,1550335586.278 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:46:26.482Z,1550335586.482 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:46:26.682Z,1550335586.682 [DataOverHttps](INFO): data state is DISCONNECTED 2019-02-16T16:46:27.086Z,1550335587.086 [DataOverHttps](INFO): data state is TCP_CONNECT 2019-02-16T16:46:27.490Z,1550335587.490 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:46:27.894Z,1550335587.894 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:46:28.298Z,1550335588.298 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:46:28.498Z,1550335588.498 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:46:28.702Z,1550335588.702 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:46:29.106Z,1550335589.106 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:46:29.510Z,1550335589.510 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:46:29.914Z,1550335589.914 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:46:30.318Z,1550335590.318 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:46:30.722Z,1550335590.722 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:46:31.128Z,1550335591.128 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:46:31.530Z,1550335591.530 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:46:31.726Z,1550335591.726 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:46:31.934Z,1550335591.934 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:46:32.339Z,1550335592.339 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:46:32.742Z,1550335592.742 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:46:33.146Z,1550335593.146 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:46:33.550Z,1550335593.550 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:46:33.954Z,1550335593.954 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:46:34.359Z,1550335594.359 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:46:34.554Z,1550335594.554 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:46:34.762Z,1550335594.762 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:46:35.166Z,1550335595.166 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:46:35.570Z,1550335595.570 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:46:35.974Z,1550335595.974 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:46:36.378Z,1550335596.378 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:46:36.782Z,1550335596.782 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:46:37.186Z,1550335597.186 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:46:37.591Z,1550335597.591 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:46:37.786Z,1550335597.786 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:46:37.994Z,1550335597.994 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:46:38.398Z,1550335598.398 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:46:38.805Z,1550335598.805 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:46:39.206Z,1550335599.206 [DataOverHttps](INFO): data state is TCP_CONNECTING 2019-02-16T16:46:39.248Z,1550335599.248 [CommandLine](IMPORTANT): got command configSet DataOverHttps.verbosity 0.000000 count 2019-02-16T16:46:40.622Z,1550335600.622 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:46:43.850Z,1550335603.850 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:46:46.682Z,1550335606.682 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:46:49.506Z,1550335609.506 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:46:51.530Z,1550335611.530 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:46:54.762Z,1550335614.762 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:46:57.386Z,1550335617.386 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-02-16T16:46:57.582Z,1550335617.582 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:47:00.822Z,1550335620.822 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:47:03.651Z,1550335623.651 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:47:06.882Z,1550335626.882 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:47:09.710Z,1550335629.710 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:47:12.538Z,1550335632.538 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:47:14.186Z,1550335634.186 [Rowe_600LCM](FAULT): Did not receive valid device response within the specified allowable sample time. 2019-02-16T16:47:14.186Z,1550335634.186 [Rowe_600LCM] Communications Fault, FailCount= 4 2019-02-16T16:47:14.186Z,1550335634.186 [Rowe_600LCM](ERROR): Communications Fault 2019-02-16T16:47:14.215Z,1550335634.215 [CBIT](ERROR): Communications Fault in component: Rowe_600LCM 2019-02-16T16:47:14.558Z,1550335634.558 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:47:14.590Z,1550335634.590 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of roweadcp LCM interface 2019-02-16T16:47:14.741Z,1550335634.741 [Rowe_600LCM](INFO): Powering down 2019-02-16T16:47:16.206Z,1550335636.206 [CBIT](INFO): Clearing failed state for component Rowe_600LCM 2019-02-16T16:47:16.206Z,1550335636.206 [Rowe_600LCM] No Fault, FailCount= 4 2019-02-16T16:47:16.358Z,1550335636.358 [Rowe_600LCM](INFO): Initializing 2019-02-16T16:47:16.359Z,1550335636.359 [Rowe_600LCM](INFO): Powering up 2019-02-16T16:47:16.578Z,1550335636.578 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:47:19.810Z,1550335639.810 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:47:20.481Z,1550335640.481 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of Rowe LCM interface 2019-02-16T16:47:20.555Z,1550335640.555 [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 9600 >& /dev/null & 2019-02-16T16:47:22.642Z,1550335642.642 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:47:25.874Z,1550335645.874 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:47:28.690Z,1550335648.690 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:47:31.930Z,1550335651.930 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:47:34.754Z,1550335654.754 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:47:37.578Z,1550335657.578 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:47:38.819Z,1550335658.819 [Default:CheckIn:Read_GPS](INFO): Timed out from 2019-02-16T16:42:38.5Z 2019-02-16T16:47:38.819Z,1550335658.819 [Default:CheckIn:Read_GPS] Stopped 2019-02-16T16:47:38.819Z,1550335658.819 [Default:CheckIn:Read_Iridium] Running Loop=1 2019-02-16T16:47:39.230Z,1550335659.230 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications 2019-02-16T16:47:39.606Z,1550335659.606 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:47:57.582Z,1550335677.582 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-02-16T16:48:07.907Z,1550335687.907 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3 2019-02-16T16:48:07.907Z,1550335687.907 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2019-02-16T16:48:07.909Z,1550335687.909 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 3 2019-02-16T16:48:07.909Z,1550335687.909 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2019-02-16T16:48:07.910Z,1550335687.910 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 3 2019-02-16T16:48:07.910Z,1550335687.910 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2019-02-16T16:48:07.923Z,1550335687.923 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2019-02-16T16:48:07.923Z,1550335687.923 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2019-02-16T16:48:07.923Z,1550335687.923 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2019-02-16T16:48:08.328Z,1550335688.328 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2019-02-16T16:48:08.328Z,1550335688.328 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3 2019-02-16T16:48:08.328Z,1550335688.328 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2019-02-16T16:48:08.329Z,1550335688.329 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 3 2019-02-16T16:48:08.329Z,1550335688.329 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2019-02-16T16:48:08.329Z,1550335688.329 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 3 2019-02-16T16:48:08.717Z,1550335688.717 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2019-02-16T16:48:10.700Z,1550335690.700 [NAL9602](ERROR): Queried for signal strength and failed to receive proper response. 2019-02-16T16:48:10.774Z,1550335690.774 [NAL9602](ERROR): received: +CSQ:0 OK 2019-02-16T16:48:10.774Z,1550335690.774 [NAL9602] Data Fault, FailCount= 1 2019-02-16T16:48:10.774Z,1550335690.774 [NAL9602](ERROR): Data Fault 2019-02-16T16:48:10.877Z,1550335690.877 [CBIT](ERROR): Data Fault in component: NAL9602 2019-02-16T16:48:11.100Z,1550335691.100 [NAL9602](INFO): Powering down 2019-02-16T16:48:11.963Z,1550335691.963 [CBIT](INFO): Clearing failed state for component NAL9602 2019-02-16T16:48:11.963Z,1550335691.963 [NAL9602] No Fault, FailCount= 1 2019-02-16T16:48:33.082Z,1550335713.082 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.003217 2019-02-16T16:48:39.138Z,1550335719.138 [DataOverHttps](INFO): Sending 142 bytes from file Logs/20190216T163854/Courier0000.lzma 2019-02-16T16:48:39.944Z,1550335719.944 [DataOverHttps](INFO): Moved sent file to Logs/20190216T163854/Courier0000.lzma.bak 2019-02-16T16:48:39.944Z,1550335719.944 [DataOverHttps](INFO): SBD MOMSN=9993344 2019-02-16T16:48:41.400Z,1550335721.400 [NAL9602](INFO): Powering up NAL9602 2019-02-16T16:48:52.307Z,1550335732.307 [NAL9602](INFO): NAL9602 initialized 2019-02-16T16:48:52.473Z,1550335732.473 [DataOverHttps](INFO): Sending 25 bytes from file Logs/20190216T163854/Courier0004.lzma 2019-02-16T16:48:53.130Z,1550335733.130 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:48:53.279Z,1550335733.279 [DataOverHttps](INFO): Moved sent file to Logs/20190216T163854/Courier0004.lzma.bak 2019-02-16T16:48:53.280Z,1550335733.280 [DataOverHttps](INFO): SBD MOMSN=9993348 2019-02-16T16:48:55.954Z,1550335735.954 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:48:59.194Z,1550335739.194 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:49:02.014Z,1550335742.014 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:49:05.249Z,1550335745.249 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:49:05.466Z,1550335745.466 [DataOverHttps](INFO): Sending 120 bytes from file Logs/20190216T153819/Express0014.lzma 2019-02-16T16:49:06.272Z,1550335746.272 [DataOverHttps](INFO): Moved sent file to Logs/20190216T153819/Express0014.lzma.bak 2019-02-16T16:49:06.272Z,1550335746.272 [DataOverHttps](INFO): SBD MOMSN=9993350 2019-02-16T16:49:08.074Z,1550335748.074 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:49:10.902Z,1550335750.902 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:49:12.926Z,1550335752.926 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:49:16.154Z,1550335756.154 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:49:16.814Z,1550335756.814 [Rowe_600LCM](FAULT): Did not receive valid device response within the specified allowable sample time. 2019-02-16T16:49:16.814Z,1550335756.814 [Rowe_600LCM] Communications Fault, FailCount= 5 2019-02-16T16:49:16.814Z,1550335756.814 [Rowe_600LCM](ERROR): Communications Fault 2019-02-16T16:49:17.053Z,1550335757.053 [CBIT](ERROR): Communications Fault in component: Rowe_600LCM 2019-02-16T16:49:17.062Z,1550335757.062 [CBIT](FAULT): Communications Fault in component: Rowe_600LCM 2019-02-16T16:49:17.218Z,1550335757.218 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of roweadcp LCM interface 2019-02-16T16:49:17.456Z,1550335757.456 [Rowe_600LCM](INFO): Powering down 2019-02-16T16:49:18.991Z,1550335758.991 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:49:19.571Z,1550335759.571 [DataOverHttps](INFO): Sending 819 bytes from file Logs/20190216T161436/Express0001.lzma 2019-02-16T16:49:20.376Z,1550335760.376 [DataOverHttps](INFO): Moved sent file to Logs/20190216T161436/Express0001.lzma.bak 2019-02-16T16:49:20.376Z,1550335760.376 [DataOverHttps](INFO): SBD MOMSN=9993354 2019-02-16T16:49:22.223Z,1550335762.223 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:49:25.050Z,1550335765.050 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:49:28.282Z,1550335768.282 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:49:31.102Z,1550335771.102 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:49:33.225Z,1550335773.225 [DataOverHttps](INFO): Sending 79 bytes from file Logs/20190216T161436/Express0005.lzma 2019-02-16T16:49:33.934Z,1550335773.934 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:49:34.031Z,1550335774.031 [DataOverHttps](INFO): Moved sent file to Logs/20190216T161436/Express0005.lzma.bak 2019-02-16T16:49:34.032Z,1550335774.032 [DataOverHttps](INFO): SBD MOMSN=9993373 2019-02-16T16:49:35.950Z,1550335775.950 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:49:37.978Z,1550335777.978 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:49:41.202Z,1550335781.202 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:49:44.030Z,1550335784.030 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:49:47.116Z,1550335787.116 [DataOverHttps](INFO): Sending 773 bytes from file Logs/20190216T161737/Express0001.lzma 2019-02-16T16:49:47.263Z,1550335787.263 [NAL9602](FAULT): GPS failed to acquire within timeout. 2019-02-16T16:49:47.263Z,1550335787.263 [NAL9602] Data Fault, FailCount= 2 2019-02-16T16:49:47.263Z,1550335787.263 [NAL9602](ERROR): Data Fault 2019-02-16T16:49:47.336Z,1550335787.336 [CBIT](ERROR): Data Fault in component: NAL9602 2019-02-16T16:49:47.663Z,1550335787.663 [NAL9602](INFO): Powering down 2019-02-16T16:49:47.920Z,1550335787.920 [DataOverHttps](INFO): Moved sent file to Logs/20190216T161737/Express0001.lzma.bak 2019-02-16T16:49:47.921Z,1550335787.921 [DataOverHttps](INFO): SBD MOMSN=9993376 2019-02-16T16:49:48.539Z,1550335788.539 [CBIT](INFO): Clearing failed state for component NAL9602 2019-02-16T16:49:48.539Z,1550335788.539 [NAL9602] No Fault, FailCount= 2 2019-02-16T16:49:59.555Z,1550335799.555 [DataOverHttps](INFO): Sending 855 bytes from file Logs/20190216T161737/Express0005.lzma 2019-02-16T16:50:00.360Z,1550335800.360 [DataOverHttps](INFO): Moved sent file to Logs/20190216T161737/Express0005.lzma.bak 2019-02-16T16:50:00.360Z,1550335800.360 [DataOverHttps](INFO): SBD MOMSN=9993394 2019-02-16T16:50:11.989Z,1550335811.989 [DataOverHttps](INFO): Sending 78 bytes from file Logs/20190216T161737/Express0008.lzma 2019-02-16T16:50:12.796Z,1550335812.796 [DataOverHttps](INFO): Moved sent file to Logs/20190216T161737/Express0008.lzma.bak 2019-02-16T16:50:12.796Z,1550335812.796 [DataOverHttps](INFO): SBD MOMSN=9993416 2019-02-16T16:50:17.955Z,1550335817.955 [NAL9602](INFO): Powering up NAL9602 2019-02-16T16:50:25.263Z,1550335825.263 [DataOverHttps](INFO): Sending 856 bytes from file Logs/20190216T162912/Express0001.lzma 2019-02-16T16:50:26.068Z,1550335826.068 [DataOverHttps](INFO): Moved sent file to Logs/20190216T162912/Express0001.lzma.bak 2019-02-16T16:50:26.068Z,1550335826.068 [DataOverHttps](INFO): SBD MOMSN=9993419 2019-02-16T16:50:28.863Z,1550335828.863 [NAL9602](INFO): NAL9602 initialized 2019-02-16T16:50:29.682Z,1550335829.682 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:50:32.510Z,1550335832.510 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:50:35.742Z,1550335835.742 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:50:38.586Z,1550335838.586 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:50:38.651Z,1550335838.651 [DataOverHttps](INFO): Sending 683 bytes from file Logs/20190216T162912/Express0005.lzma 2019-02-16T16:50:39.455Z,1550335839.455 [DataOverHttps](INFO): Moved sent file to Logs/20190216T162912/Express0005.lzma.bak 2019-02-16T16:50:39.456Z,1550335839.456 [DataOverHttps](INFO): SBD MOMSN=9993440 2019-02-16T16:50:41.810Z,1550335841.810 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:50:44.630Z,1550335844.630 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:50:47.466Z,1550335847.466 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:50:49.478Z,1550335849.478 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:50:52.469Z,1550335852.469 [DataOverHttps](INFO): Sending 79 bytes from file Logs/20190216T162912/Express0008.lzma 2019-02-16T16:50:52.714Z,1550335852.714 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:50:53.275Z,1550335853.275 [DataOverHttps](INFO): Moved sent file to Logs/20190216T162912/Express0008.lzma.bak 2019-02-16T16:50:53.276Z,1550335853.276 [DataOverHttps](INFO): SBD MOMSN=9993462 2019-02-16T16:50:55.538Z,1550335855.538 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:50:58.774Z,1550335858.774 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:51:01.598Z,1550335861.598 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:51:04.830Z,1550335864.830 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:51:05.363Z,1550335865.363 [DataOverHttps](INFO): Sending 808 bytes from file Logs/20190216T163854/Express0001.lzma 2019-02-16T16:51:06.167Z,1550335866.167 [DataOverHttps](INFO): Moved sent file to Logs/20190216T163854/Express0001.lzma.bak 2019-02-16T16:51:06.168Z,1550335866.168 [DataOverHttps](INFO): SBD MOMSN=9993465 2019-02-16T16:51:07.663Z,1550335867.663 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:51:08.907Z,1550335868.907 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4 2019-02-16T16:51:08.907Z,1550335868.907 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2019-02-16T16:51:08.909Z,1550335868.909 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 4 2019-02-16T16:51:08.909Z,1550335868.909 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2019-02-16T16:51:08.914Z,1550335868.914 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 4 2019-02-16T16:51:08.914Z,1550335868.914 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2019-02-16T16:51:08.939Z,1550335868.939 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2019-02-16T16:51:08.939Z,1550335868.939 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2019-02-16T16:51:08.939Z,1550335868.939 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2019-02-16T16:51:09.455Z,1550335869.455 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2019-02-16T16:51:09.455Z,1550335869.455 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4 2019-02-16T16:51:09.455Z,1550335869.455 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2019-02-16T16:51:09.455Z,1550335869.455 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 4 2019-02-16T16:51:09.456Z,1550335869.456 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2019-02-16T16:51:09.456Z,1550335869.456 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 4 2019-02-16T16:51:09.741Z,1550335869.741 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2019-02-16T16:51:10.486Z,1550335870.486 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:51:12.514Z,1550335872.514 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:51:14.534Z,1550335874.534 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:51:17.758Z,1550335877.758 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:51:20.119Z,1550335880.119 [DataOverHttps](INFO): Sending 766 bytes from file Logs/20190216T163854/Express0005.lzma 2019-02-16T16:51:20.622Z,1550335880.622 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:51:20.924Z,1550335880.924 [DataOverHttps](INFO): Moved sent file to Logs/20190216T163854/Express0005.lzma.bak 2019-02-16T16:51:20.924Z,1550335880.924 [DataOverHttps](INFO): SBD MOMSN=9993484 2019-02-16T16:51:21.829Z,1550335881.829 [Default:CheckIn:Read_Iridium] Stopped 2019-02-16T16:51:21.829Z,1550335881.829 [Default:CheckIn:C.Wait] Running Loop=1 2019-02-16T16:51:21.829Z,1550335881.829 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2019-02-16T16:51:23.818Z,1550335883.818 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:51:26.646Z,1550335886.646 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:51:29.926Z,1550335889.926 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:51:32.714Z,1550335892.714 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:51:35.534Z,1550335895.534 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:51:37.554Z,1550335897.554 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:51:40.790Z,1550335900.790 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:51:43.619Z,1550335903.619 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:51:46.850Z,1550335906.850 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:51:49.674Z,1550335909.674 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:51:52.906Z,1550335912.906 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:51:55.742Z,1550335915.742 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:51:58.570Z,1550335918.570 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:52:00.587Z,1550335920.587 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:52:03.814Z,1550335923.814 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:52:06.646Z,1550335926.646 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:52:09.874Z,1550335929.874 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:52:12.710Z,1550335932.710 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:52:15.938Z,1550335935.938 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:52:18.767Z,1550335938.767 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:52:21.598Z,1550335941.598 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:52:23.610Z,1550335943.610 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:52:25.630Z,1550335945.630 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:52:28.870Z,1550335948.870 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:52:31.702Z,1550335951.702 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:52:34.922Z,1550335954.922 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:52:37.750Z,1550335957.750 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:52:40.987Z,1550335960.987 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:52:43.815Z,1550335963.815 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:52:46.638Z,1550335966.638 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:52:48.662Z,1550335968.662 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:52:51.898Z,1550335971.898 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:52:54.726Z,1550335974.726 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:52:57.958Z,1550335977.958 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:53:00.778Z,1550335980.778 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:53:04.018Z,1550335984.018 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:53:06.838Z,1550335986.838 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:53:09.674Z,1550335989.674 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:53:11.694Z,1550335991.694 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:53:13.706Z,1550335993.706 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:53:16.943Z,1550335996.943 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:53:19.770Z,1550335999.770 [NAL9602](DEBUG): Fix Requested 2019-02-16T16:53:19.887Z,1550335999.887 [CommandLine](IMPORTANT): got command restart application 2019-02-16T16:53:20.893Z,1550336000.893 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2019-02-16T16:53:20.893Z,1550336000.893 [CommandLine ThreadHandler](INFO): Thread cancelled. 2019-02-16T16:53:20.914Z,1550336000.914 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2019-02-16T16:53:20.914Z,1550336000.914 [CommandLine ThreadHandler](INFO): Thread cancelled. 2019-02-16T16:53:20.915Z,1550336000.915 [CommandLine](INFO): Join timeout helper Thread ID is 1667 2019-02-16T16:53:20.915Z,1550336000.915 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2019-02-16T16:53:20.915Z,1550336000.915 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2019-02-16T16:53:20.916Z,1550336000.916 [NavChartDb](INFO): Join timeout helper Thread ID is 1668 2019-02-16T16:53:20.930Z,1550336000.930 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2019-02-16T16:53:20.930Z,1550336000.930 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2019-02-16T16:53:20.934Z,1550336000.934 [ComponentRegistry](INFO): Shutting down Rowe_600LCM ThreadHandler 2019-02-16T16:53:20.934Z,1550336000.934 [Rowe_600LCM ThreadHandler](INFO): Thread cancelled. 2019-02-16T16:53:20.934Z,1550336000.934 [Rowe_600LCM](INFO): Join timeout helper Thread ID is 1669 2019-02-16T16:53:21.150Z,1550336001.150 [Rowe_600LCM ThreadHandler](INFO): Uninitializing protected caller thread. 2019-02-16T16:53:21.150Z,1550336001.150 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of roweadcp LCM interface 2019-02-16T16:53:21.261Z,1550336001.261 [Rowe_600LCM](INFO): Powering down 2019-02-16T16:53:21.262Z,1550336001.262 [Rowe_600LCM ThreadHandler](INFO): Thread cancelled. 2019-02-16T16:53:21.270Z,1550336001.270 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2019-02-16T16:53:21.270Z,1550336001.270 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2019-02-16T16:53:21.271Z,1550336001.271 [Radio_Surface](INFO): Join timeout helper Thread ID is 1671 2019-02-16T16:53:21.386Z,1550336001.386 [Radio_Surface](INFO): Powering down 2019-02-16T16:53:21.387Z,1550336001.387 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2019-02-16T16:53:21.388Z,1550336001.388 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2019-02-16T16:53:21.394Z,1550336001.394 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler 2019-02-16T16:53:21.394Z,1550336001.394 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2019-02-16T16:53:21.395Z,1550336001.395 [DataOverHttps](INFO): Join timeout helper Thread ID is 1672 2019-02-16T16:53:21.470Z,1550336001.470 [Reporter](INFO): Radio_Surface.radio_surface_power no_value 2019-02-16T16:53:21.614Z,1550336001.614 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread. 2019-02-16T16:53:21.614Z,1550336001.614 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2019-02-16T16:53:21.631Z,1550336001.631 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler 2019-02-16T16:53:21.631Z,1550336001.631 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2019-02-16T16:53:21.631Z,1550336001.631 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 1673 2019-02-16T16:53:21.902Z,1550336001.902 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread. 2019-02-16T16:53:21.902Z,1550336001.902 [WetLabsBB2FL](INFO): Powering down 2019-02-16T16:53:21.903Z,1550336001.903 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2019-02-16T16:53:21.919Z,1550336001.919 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler 2019-02-16T16:53:21.919Z,1550336001.919 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2019-02-16T16:53:21.919Z,1550336001.919 [CTD_Seabird](INFO): Join timeout helper Thread ID is 1674 2019-02-16T16:53:22.134Z,1550336002.134 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread. 2019-02-16T16:53:22.135Z,1550336002.135 [CTD_Seabird](INFO): Powering down 2019-02-16T16:53:22.146Z,1550336002.146 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2019-02-16T16:53:22.167Z,1550336002.167 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2019-02-16T16:53:22.167Z,1550336002.167 [logger ThreadHandler](INFO): Thread cancelled. 2019-02-16T16:53:22.167Z,1550336002.167 [logger](INFO): Join timeout helper Thread ID is 1675 2019-02-16T16:53:22.218Z,1550336002.218 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2019-02-16T16:53:22.218Z,1550336002.218 [logger ThreadHandler](INFO): Thread cancelled. 2019-02-16T16:53:22.223Z,1550336002.223 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2019-02-16T16:53:22.223Z,1550336002.223 [CommandLine ThreadHandler](INFO): Thread cancelled. 2019-02-16T16:53:22.223Z,1550336002.223 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2019-02-16T16:53:22.223Z,1550336002.223 [controlThread ThreadHandler](INFO): Thread cancelled. 2019-02-16T16:53:22.224Z,1550336002.224 [controlThread](INFO): Join timeout helper Thread ID is 1676 2019-02-16T16:53:22.245Z,1550336002.245 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2019-02-16T16:53:22.245Z,1550336002.245 [controlThread](DEBUG): Uninitializing ControlThread 2019-02-16T16:53:22.246Z,1550336002.246 [Aanderaa_O2](INFO): Powering down 2019-02-16T16:53:22.248Z,1550336002.248 [AcousticModem_Benthos_ATM900](INFO): Powering down 2019-02-16T16:53:22.367Z,1550336002.367 [NAL9602](INFO): Powering down 2019-02-16T16:53:22.368Z,1550336002.368 [PNI_TCM](INFO): Powering down 2019-02-16T16:53:22.455Z,1550336002.455 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator. 2019-02-16T16:53:22.456Z,1550336002.456 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator. 2019-02-16T16:53:22.457Z,1550336002.457 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2019-02-16T16:53:22.458Z,1550336002.458 [MissionManager](INFO): Uninitializing Mission Default 2019-02-16T16:53:22.458Z,1550336002.458 [Default] Stopped 2019-02-16T16:53:22.458Z,1550336002.458 [Default](DEBUG): Aggregate::uninitialize Default 2019-02-16T16:53:22.458Z,1550336002.458 [Default:B.GoToSurface] Stopped 2019-02-16T16:53:22.458Z,1550336002.458 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2019-02-16T16:53:22.458Z,1550336002.458 [Default:CheckIn] Stopped 2019-02-16T16:53:22.458Z,1550336002.458 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2019-02-16T16:53:22.458Z,1550336002.458 [Default:CheckIn:C.Wait] Stopped 2019-02-16T16:53:22.458Z,1550336002.458 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2019-02-16T16:53:22.461Z,1550336002.461 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2019-02-16T16:53:22.462Z,1550336002.462 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2019-02-16T16:53:22.462Z,1550336002.462 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2019-02-16T16:53:22.463Z,1550336002.463 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2019-02-16T16:53:22.463Z,1550336002.463 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2019-02-16T16:53:22.463Z,1550336002.463 [BuoyancyServo](INFO): Powering down 2019-02-16T16:53:22.478Z,1550336002.478 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2019-02-16T16:53:22.478Z,1550336002.478 [ElevatorServo](INFO): Powering down 2019-02-16T16:53:22.479Z,1550336002.479 [MassServo](DEBUG): Uninitialize Mass Servo. 2019-02-16T16:53:22.479Z,1550336002.479 [MassServo](INFO): Powering down 2019-02-16T16:53:22.480Z,1550336002.480 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2019-02-16T16:53:22.480Z,1550336002.480 [RudderServo](INFO): Powering down 2019-02-16T16:53:22.481Z,1550336002.481 [ThrusterServo](DEBUG): Uninitialize Thruster Servo. 2019-02-16T16:53:22.481Z,1550336002.481 [ThrusterServo](INFO): Powering down 2019-02-16T16:53:22.482Z,1550336002.482 [SBIT](DEBUG): Uninitialize SBIT Component. 2019-02-16T16:53:22.483Z,1550336002.483 [IBIT](DEBUG): Uninitialize IBIT Component. 2019-02-16T16:53:22.483Z,1550336002.483 [CBIT](DEBUG): Uninitialize CBIT Component. 2019-02-16T16:53:22.483Z,1550336002.483 [CBIT](DEBUG): Powering off loads. 2019-02-16T16:53:22.494Z,1550336002.494 [CBIT](DEBUG): Disabling WDT. 2019-02-16T16:53:22.506Z,1550336002.506 [CBIT](DEBUG): Opening all GF detection circuits. 2019-02-16T16:53:22.507Z,1550336002.507 [controlThread ThreadHandler](INFO): Thread cancelled. 2019-02-16T16:53:22.566Z,1550336002.566 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2019-02-16T16:53:22.572Z,1550336002.572 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2019-02-16T16:53:22.651Z,1550336002.651 [Rowe_600LCM ThreadHandler](INFO): Thread cancelled. 2019-02-16T16:53:22.656Z,1550336002.656 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2019-02-16T16:53:22.661Z,1550336002.661 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2019-02-16T16:53:22.708Z,1550336002.708 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2019-02-16T16:53:22.770Z,1550336002.770 [logger ThreadHandler](INFO): Thread cancelled.